{"level":"warn","ts":"2026-03-04T01:23:26.227231Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-04T01:23:26.22734Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.116: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.116:2380","--initial-cluster=instance=https://199.204.45.116:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.116:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.116: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-03-04T01:23:26.227408Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-04T01:23:26.227426Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-03-04T01:23:26.227536Z","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-03-04T01:23:26.228712Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"]} {"level":"info","ts":"2026-03-04T01:23:26.228865Z","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.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.116: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-03-04T01:23:26.233237Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.916272ms"} {"level":"info","ts":"2026-03-04T01:23:26.241456Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5caa70ef1dd6dc04","cluster-id":"45afccab143d2c82"} {"level":"info","ts":"2026-03-04T01:23:26.241537Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=()"} {"level":"info","ts":"2026-03-04T01:23:26.241566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 0"} {"level":"info","ts":"2026-03-04T01:23:26.241584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5caa70ef1dd6dc04 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-04T01:23:26.241604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 1"} {"level":"info","ts":"2026-03-04T01:23:26.241651Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"warn","ts":"2026-03-04T01:23:26.249172Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-04T01:23:26.250853Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-04T01:23:26.252992Z","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-03-04T01:23:26.262114Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5caa70ef1dd6dc04","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-04T01:23:26.26223Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5caa70ef1dd6dc04","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-04T01:23:26.262409Z","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-03-04T01:23:26.262448Z","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-03-04T01:23:26.262457Z","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-03-04T01:23:26.265055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"info","ts":"2026-03-04T01:23:26.265165Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","added-peer-id":"5caa70ef1dd6dc04","added-peer-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-03-04T01:23:26.269367Z","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-03-04T01:23:26.269514Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5caa70ef1dd6dc04","initial-advertise-peer-urls":["https://199.204.45.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-04T01:23:26.269533Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-04T01:23:26.269591Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-03-04T01:23:26.269597Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-03-04T01:23:27.042459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 is starting a new election at term 1"} {"level":"info","ts":"2026-03-04T01:23:27.04252Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became pre-candidate at term 1"} {"level":"info","ts":"2026-03-04T01:23:27.042543Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgPreVoteResp from 5caa70ef1dd6dc04 at term 1"} {"level":"info","ts":"2026-03-04T01:23:27.042563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became candidate at term 2"} {"level":"info","ts":"2026-03-04T01:23:27.042575Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgVoteResp from 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-03-04T01:23:27.042611Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became leader at term 2"} {"level":"info","ts":"2026-03-04T01:23:27.042625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5caa70ef1dd6dc04 elected leader 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-03-04T01:23:27.043749Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-04T01:23:27.044587Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-04T01:23:27.044585Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5caa70ef1dd6dc04","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.116:2379]}","request-path":"/0/members/5caa70ef1dd6dc04/attributes","cluster-id":"45afccab143d2c82","publish-timeout":"7s"} {"level":"info","ts":"2026-03-04T01:23:27.044802Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-04T01:23:27.045223Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","cluster-version":"3.5"} {"level":"info","ts":"2026-03-04T01:23:27.04523Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-04T01:23:27.045339Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-04T01:23:27.045343Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-04T01:23:27.045377Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-04T01:23:27.048239Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.116:2379"} {"level":"info","ts":"2026-03-04T01:23:27.048554Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-04T01:23:35.973127Z","caller":"traceutil/trace.go:171","msg":"trace[1055564963] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"171.035073ms","start":"2026-03-04T01:23:35.802066Z","end":"2026-03-04T01:23:35.973101Z","steps":["trace[1055564963] 'process raft request' (duration: 170.88736ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:23:44.963119Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853968895650276749,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-04T01:23:45.209592Z","caller":"traceutil/trace.go:171","msg":"trace[1986083868] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"747.864895ms","start":"2026-03-04T01:23:44.46171Z","end":"2026-03-04T01:23:45.209575Z","steps":["trace[1986083868] 'process raft request' (duration: 747.769582ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:23:45.209935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:23:44.461669Z","time spent":"747.975677ms","remote":"127.0.0.1:42650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-04T01:23:45.588969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.574906ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-04T01:23:45.589156Z","caller":"traceutil/trace.go:171","msg":"trace[643923449] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"1.124578671s","start":"2026-03-04T01:23:44.464529Z","end":"2026-03-04T01:23:45.589108Z","steps":["trace[643923449] 'process raft request' (duration: 970.656066ms)","trace[643923449] 'compare' (duration: 153.457712ms)"],"step_count":2} {"level":"info","ts":"2026-03-04T01:23:45.589198Z","caller":"traceutil/trace.go:171","msg":"trace[1843758579] linearizableReadLoop","detail":"{readStateIndex:422; appliedIndex:421; }","duration":"1.126609462s","start":"2026-03-04T01:23:44.46257Z","end":"2026-03-04T01:23:45.58918Z","steps":["trace[1843758579] 'read index received' (duration: 746.998641ms)","trace[1843758579] 'applied index is now lower than readState.Index' (duration: 379.609221ms)"],"step_count":2} {"level":"warn","ts":"2026-03-04T01:23:45.589307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:23:44.464507Z","time spent":"1.124718654s","remote":"127.0.0.1:42650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-04T01:23:45.590486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.127912196s","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-03-04T01:23:45.590542Z","caller":"traceutil/trace.go:171","msg":"trace[380367918] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:410; }","duration":"1.127988259s","start":"2026-03-04T01:23:44.462537Z","end":"2026-03-04T01:23:45.590526Z","steps":["trace[380367918] 'agreement among raft nodes before linearized reading' (duration: 1.126711245s)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:23:45.590585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:23:44.462526Z","time spent":"1.12804889s","remote":"127.0.0.1:42650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-03-04T01:23:55.810871Z","caller":"traceutil/trace.go:171","msg":"trace[1649044835] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"102.949749ms","start":"2026-03-04T01:23:55.707889Z","end":"2026-03-04T01:23:55.810839Z","steps":["trace[1649044835] 'process raft request' (duration: 102.633781ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:24:01.884736Z","caller":"traceutil/trace.go:171","msg":"trace[834595525] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"141.732595ms","start":"2026-03-04T01:24:01.742957Z","end":"2026-03-04T01:24:01.884689Z","steps":["trace[834595525] 'process raft request' (duration: 141.481929ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:24:02.255644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.886901ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-04T01:24:02.255798Z","caller":"traceutil/trace.go:171","msg":"trace[460047800] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"366.198819ms","start":"2026-03-04T01:24:01.889575Z","end":"2026-03-04T01:24:02.255773Z","steps":["trace[460047800] 'process raft request' (duration: 193.054391ms)","trace[460047800] 'compare' (duration: 172.648295ms)"],"step_count":2} {"level":"warn","ts":"2026-03-04T01:24:02.255888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:01.889548Z","time spent":"366.304752ms","remote":"127.0.0.1:42650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-04T01:24:03.094711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"732.41429ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-04T01:24:03.09511Z","caller":"traceutil/trace.go:171","msg":"trace[805153632] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"1.191450152s","start":"2026-03-04T01:24:01.903639Z","end":"2026-03-04T01:24:03.095089Z","steps":["trace[805153632] 'process raft request' (duration: 1.191214446s)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:24:03.09518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:01.903615Z","time spent":"1.191531865s","remote":"127.0.0.1:42566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-04T01:24:03.095323Z","caller":"traceutil/trace.go:171","msg":"trace[26984992] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"1.204820553s","start":"2026-03-04T01:24:01.890456Z","end":"2026-03-04T01:24:03.095276Z","steps":["trace[26984992] 'process raft request' (duration: 471.736866ms)","trace[26984992] 'compare' (duration: 732.245485ms)"],"step_count":2} {"level":"warn","ts":"2026-03-04T01:24:03.095823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:01.890434Z","time spent":"1.204985797s","remote":"127.0.0.1:42650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-04T01:24:03.148388Z","caller":"traceutil/trace.go:171","msg":"trace[820399682] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"813.102394ms","start":"2026-03-04T01:24:02.335253Z","end":"2026-03-04T01:24:03.148356Z","steps":["trace[820399682] 'process raft request' (duration: 812.92781ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:24:03.148662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:02.33521Z","time spent":"813.288009ms","remote":"127.0.0.1:42650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-04T01:24:03.70849Z","caller":"traceutil/trace.go:171","msg":"trace[160929035] linearizableReadLoop","detail":"{readStateIndex:506; appliedIndex:505; }","duration":"420.582965ms","start":"2026-03-04T01:24:03.28788Z","end":"2026-03-04T01:24:03.708463Z","steps":["trace[160929035] 'read index received' (duration: 420.366559ms)","trace[160929035] 'applied index is now lower than readState.Index' (duration: 215.576µs)"],"step_count":2} {"level":"warn","ts":"2026-03-04T01:24:03.708855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.952954ms","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-03-04T01:24:03.709049Z","caller":"traceutil/trace.go:171","msg":"trace[1078858976] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:490; }","duration":"421.180301ms","start":"2026-03-04T01:24:03.287823Z","end":"2026-03-04T01:24:03.709003Z","steps":["trace[1078858976] 'agreement among raft nodes before linearized reading' (duration: 420.898673ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:24:03.709197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:03.287809Z","time spent":"421.367835ms","remote":"127.0.0.1:42650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-03-04T01:24:03.709335Z","caller":"traceutil/trace.go:171","msg":"trace[134899553] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"1.336349281s","start":"2026-03-04T01:24:02.372964Z","end":"2026-03-04T01:24:03.709314Z","steps":["trace[134899553] 'process raft request' (duration: 1.335350655s)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:24:03.7095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:02.372942Z","time spent":"1.336473424s","remote":"127.0.0.1:42552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4745,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-04T01:24:05.343533Z","caller":"traceutil/trace.go:171","msg":"trace[1641315166] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"265.758497ms","start":"2026-03-04T01:24:05.077727Z","end":"2026-03-04T01:24:05.343485Z","steps":["trace[1641315166] 'process raft request' (duration: 255.22746ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:24:05.343589Z","caller":"traceutil/trace.go:171","msg":"trace[748887296] linearizableReadLoop","detail":"{readStateIndex:521; appliedIndex:520; }","duration":"242.406616ms","start":"2026-03-04T01:24:05.101155Z","end":"2026-03-04T01:24:05.343562Z","steps":["trace[748887296] 'read index received' (duration: 231.823897ms)","trace[748887296] 'applied index is now lower than readState.Index' (duration: 10.581009ms)"],"step_count":2} {"level":"warn","ts":"2026-03-04T01:24:05.346582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.397094ms","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-03-04T01:24:05.346769Z","caller":"traceutil/trace.go:171","msg":"trace[280952179] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:505; }","duration":"245.618389ms","start":"2026-03-04T01:24:05.10113Z","end":"2026-03-04T01:24:05.346749Z","steps":["trace[280952179] 'agreement among raft nodes before linearized reading' (duration: 242.520068ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:24:17.992968Z","caller":"traceutil/trace.go:171","msg":"trace[879907571] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"106.417929ms","start":"2026-03-04T01:24:17.886523Z","end":"2026-03-04T01:24:17.992941Z","steps":["trace[879907571] 'process raft request' (duration: 106.258304ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:24:22.731374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.147557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-03-04T01:24:22.731472Z","caller":"traceutil/trace.go:171","msg":"trace[1446946345] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:675; }","duration":"546.320801ms","start":"2026-03-04T01:24:22.185128Z","end":"2026-03-04T01:24:22.731449Z","steps":["trace[1446946345] 'range keys from in-memory index tree' (duration: 545.929392ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:24:22.73151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:22.185105Z","time spent":"546.397563ms","remote":"127.0.0.1:42650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-03-04T01:24:22.731534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.461156ms","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-03-04T01:24:22.731618Z","caller":"traceutil/trace.go:171","msg":"trace[1934120137] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:675; }","duration":"382.570709ms","start":"2026-03-04T01:24:22.349033Z","end":"2026-03-04T01:24:22.731603Z","steps":["trace[1934120137] 'range keys from in-memory index tree' (duration: 382.301721ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:24:22.731645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:22.348973Z","time spent":"382.665171ms","remote":"127.0.0.1:42650","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-03-04T01:24:23.303295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.428871ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-04T01:24:23.303426Z","caller":"traceutil/trace.go:171","msg":"trace[365031166] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"568.119042ms","start":"2026-03-04T01:24:22.735284Z","end":"2026-03-04T01:24:23.303404Z","steps":["trace[365031166] 'process raft request' (duration: 205.484266ms)","trace[365031166] 'compare' (duration: 362.077422ms)"],"step_count":2} {"level":"warn","ts":"2026-03-04T01:24:23.303492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:22.735256Z","time spent":"568.205995ms","remote":"127.0.0.1:42650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-04T01:24:29.688178Z","caller":"traceutil/trace.go:171","msg":"trace[1131231916] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"155.829266ms","start":"2026-03-04T01:24:29.532296Z","end":"2026-03-04T01:24:29.688125Z","steps":["trace[1131231916] 'process raft request' (duration: 155.627231ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:24:43.863069Z","caller":"traceutil/trace.go:171","msg":"trace[1383269391] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"109.408705ms","start":"2026-03-04T01:24:43.753625Z","end":"2026-03-04T01:24:43.863033Z","steps":["trace[1383269391] 'process raft request' (duration: 109.23336ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:24:45.553651Z","caller":"traceutil/trace.go:171","msg":"trace[464207838] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"120.103897ms","start":"2026-03-04T01:24:45.433523Z","end":"2026-03-04T01:24:45.553627Z","steps":["trace[464207838] 'process raft request' (duration: 119.952983ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:24:49.675526Z","caller":"traceutil/trace.go:171","msg":"trace[862293255] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"103.330415ms","start":"2026-03-04T01:24:49.572166Z","end":"2026-03-04T01:24:49.675496Z","steps":["trace[862293255] 'process raft request' (duration: 103.10676ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:24:50.211631Z","caller":"traceutil/trace.go:171","msg":"trace[916141760] linearizableReadLoop","detail":"{readStateIndex:785; appliedIndex:784; }","duration":"233.746353ms","start":"2026-03-04T01:24:49.97785Z","end":"2026-03-04T01:24:50.211596Z","steps":["trace[916141760] 'read index received' (duration: 189.767337ms)","trace[916141760] 'applied index is now lower than readState.Index' (duration: 43.977436ms)"],"step_count":2} {"level":"warn","ts":"2026-03-04T01:24:50.211904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.01654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-04T01:24:50.211946Z","caller":"traceutil/trace.go:171","msg":"trace[1500615165] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:757; }","duration":"234.130663ms","start":"2026-03-04T01:24:49.977805Z","end":"2026-03-04T01:24:50.211936Z","steps":["trace[1500615165] 'agreement among raft nodes before linearized reading' (duration: 233.966748ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:24:51.846472Z","caller":"traceutil/trace.go:171","msg":"trace[1956104616] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"110.603437ms","start":"2026-03-04T01:24:51.735841Z","end":"2026-03-04T01:24:51.846444Z","steps":["trace[1956104616] 'process raft request' (duration: 110.393732ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:24:52.195948Z","caller":"traceutil/trace.go:171","msg":"trace[1664481623] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"197.367428ms","start":"2026-03-04T01:24:51.998554Z","end":"2026-03-04T01:24:52.195921Z","steps":["trace[1664481623] 'process raft request' (duration: 115.842345ms)","trace[1664481623] 'compare' (duration: 81.397639ms)"],"step_count":2} {"level":"info","ts":"2026-03-04T01:24:52.379295Z","caller":"traceutil/trace.go:171","msg":"trace[2035294154] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"102.01806ms","start":"2026-03-04T01:24:52.277239Z","end":"2026-03-04T01:24:52.379257Z","steps":["trace[2035294154] 'process raft request' (duration: 59.809291ms)","trace[2035294154] 'compare' (duration: 42.042185ms)"],"step_count":2} {"level":"info","ts":"2026-03-04T01:24:54.003543Z","caller":"traceutil/trace.go:171","msg":"trace[1483049521] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"148.872892ms","start":"2026-03-04T01:24:53.854639Z","end":"2026-03-04T01:24:54.003512Z","steps":["trace[1483049521] 'process raft request' (duration: 148.620466ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:24:54.446452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.189883ms","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-03-04T01:24:54.44685Z","caller":"traceutil/trace.go:171","msg":"trace[1106567220] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:768; }","duration":"245.636276ms","start":"2026-03-04T01:24:54.201163Z","end":"2026-03-04T01:24:54.446799Z","steps":["trace[1106567220] 'range keys from in-memory index tree' (duration: 244.896206ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:24:54.446722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.420787ms","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-03-04T01:24:54.447078Z","caller":"traceutil/trace.go:171","msg":"trace[979918941] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:768; }","duration":"348.829758ms","start":"2026-03-04T01:24:54.098232Z","end":"2026-03-04T01:24:54.447062Z","steps":["trace[979918941] 'range keys from in-memory index tree' (duration: 348.211821ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:24:54.447138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:54.098199Z","time spent":"348.91986ms","remote":"127.0.0.1:42650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-03-04T01:24:55.068507Z","caller":"traceutil/trace.go:171","msg":"trace[905772292] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"616.72802ms","start":"2026-03-04T01:24:54.451758Z","end":"2026-03-04T01:24:55.068486Z","steps":["trace[905772292] 'process raft request' (duration: 616.557694ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:24:55.068673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:54.451735Z","time spent":"616.838062ms","remote":"127.0.0.1:42650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-04T01:24:55.08039Z","caller":"traceutil/trace.go:171","msg":"trace[1435212072] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"628.442997ms","start":"2026-03-04T01:24:54.451798Z","end":"2026-03-04T01:24:55.080241Z","steps":["trace[1435212072] 'process raft request' (duration: 628.073438ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:24:55.080698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:54.451767Z","time spent":"628.745424ms","remote":"127.0.0.1:42650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-04T01:24:55.081025Z","caller":"traceutil/trace.go:171","msg":"trace[2120250641] linearizableReadLoop","detail":"{readStateIndex:799; appliedIndex:796; }","duration":"440.380754ms","start":"2026-03-04T01:24:54.640608Z","end":"2026-03-04T01:24:55.080989Z","steps":["trace[2120250641] 'read index received' (duration: 427.786123ms)","trace[2120250641] 'applied index is now lower than readState.Index' (duration: 12.591631ms)"],"step_count":2} {"level":"info","ts":"2026-03-04T01:24:55.081142Z","caller":"traceutil/trace.go:171","msg":"trace[1179951908] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"629.240628ms","start":"2026-03-04T01:24:54.45187Z","end":"2026-03-04T01:24:55.081111Z","steps":["trace[1179951908] 'process raft request' (duration: 628.215971ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:24:55.081203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.581241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-04T01:24:55.081246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:54.451841Z","time spent":"629.35243ms","remote":"127.0.0.1:42650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-04T01:24:55.081259Z","caller":"traceutil/trace.go:171","msg":"trace[1019199526] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:771; }","duration":"440.697604ms","start":"2026-03-04T01:24:54.640543Z","end":"2026-03-04T01:24:55.08124Z","steps":["trace[1019199526] 'agreement among raft nodes before linearized reading' (duration: 440.55907ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:24:55.081311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:54.640504Z","time spent":"440.795046ms","remote":"127.0.0.1:42368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-04T01:24:55.327076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.79939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-03-04T01:24:55.327185Z","caller":"traceutil/trace.go:171","msg":"trace[2004766583] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:771; }","duration":"116.971394ms","start":"2026-03-04T01:24:55.210191Z","end":"2026-03-04T01:24:55.327163Z","steps":["trace[2004766583] 'range keys from in-memory index tree' (duration: 116.493342ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:25:07.486537Z","caller":"traceutil/trace.go:171","msg":"trace[2006166329] linearizableReadLoop","detail":"{readStateIndex:886; appliedIndex:885; }","duration":"334.572883ms","start":"2026-03-04T01:25:07.151939Z","end":"2026-03-04T01:25:07.486512Z","steps":["trace[2006166329] 'read index received' (duration: 334.42495ms)","trace[2006166329] 'applied index is now lower than readState.Index' (duration: 146.713µs)"],"step_count":2} {"level":"info","ts":"2026-03-04T01:25:07.486613Z","caller":"traceutil/trace.go:171","msg":"trace[6874085] transaction","detail":"{read_only:false; response_revision:853; number_of_response:1; }","duration":"339.681028ms","start":"2026-03-04T01:25:07.146886Z","end":"2026-03-04T01:25:07.486567Z","steps":["trace[6874085] 'process raft request' (duration: 339.470882ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:25:07.486773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.80274ms","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-03-04T01:25:07.486799Z","caller":"traceutil/trace.go:171","msg":"trace[844781650] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:853; }","duration":"334.867661ms","start":"2026-03-04T01:25:07.151924Z","end":"2026-03-04T01:25:07.486791Z","steps":["trace[844781650] 'agreement among raft nodes before linearized reading' (duration: 334.732057ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:25:07.486824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:25:07.151915Z","time spent":"334.903343ms","remote":"127.0.0.1:42650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-03-04T01:25:07.486831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:25:07.146859Z","time spent":"339.853242ms","remote":"127.0.0.1:42650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-04T01:25:07.48693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.632832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-03-04T01:25:07.487014Z","caller":"traceutil/trace.go:171","msg":"trace[458280824] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:853; }","duration":"332.770905ms","start":"2026-03-04T01:25:07.154219Z","end":"2026-03-04T01:25:07.48699Z","steps":["trace[458280824] 'agreement among raft nodes before linearized reading' (duration: 332.5743ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:25:07.487079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:25:07.15418Z","time spent":"332.869338ms","remote":"127.0.0.1:42650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-03-04T01:25:24.417893Z","caller":"traceutil/trace.go:171","msg":"trace[1804329830] transaction","detail":"{read_only:false; response_revision:922; number_of_response:1; }","duration":"213.814799ms","start":"2026-03-04T01:25:24.204042Z","end":"2026-03-04T01:25:24.417856Z","steps":["trace[1804329830] 'process raft request' (duration: 213.666105ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:25:24.652966Z","caller":"traceutil/trace.go:171","msg":"trace[531589627] transaction","detail":"{read_only:false; response_revision:923; number_of_response:1; }","duration":"197.698295ms","start":"2026-03-04T01:25:24.455196Z","end":"2026-03-04T01:25:24.652894Z","steps":["trace[531589627] 'process raft request' (duration: 159.966023ms)","trace[531589627] 'compare' (duration: 37.443095ms)"],"step_count":2} {"level":"warn","ts":"2026-03-04T01:25:25.254693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.350632ms","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":"info","ts":"2026-03-04T01:25:25.254785Z","caller":"traceutil/trace.go:171","msg":"trace[968262624] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:925; }","duration":"134.510055ms","start":"2026-03-04T01:25:25.120257Z","end":"2026-03-04T01:25:25.254767Z","steps":["trace[968262624] 'range keys from in-memory index tree' (duration: 134.257819ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:25:25.335572Z","caller":"traceutil/trace.go:171","msg":"trace[234572952] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"207.883433ms","start":"2026-03-04T01:25:25.127667Z","end":"2026-03-04T01:25:25.335551Z","steps":["trace[234572952] 'process raft request' (duration: 207.740529ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:25:25.704734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.145146ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-04T01:25:25.705067Z","caller":"traceutil/trace.go:171","msg":"trace[1958486667] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"445.91363ms","start":"2026-03-04T01:25:25.25913Z","end":"2026-03-04T01:25:25.705044Z","steps":["trace[1958486667] 'process raft request' (duration: 244.332892ms)","trace[1958486667] 'compare' (duration: 200.790357ms)"],"step_count":2} {"level":"warn","ts":"2026-03-04T01:25:25.705168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:25:25.259105Z","time spent":"446.009991ms","remote":"127.0.0.1:42650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":457,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-04T01:25:25.705282Z","caller":"traceutil/trace.go:171","msg":"trace[38753123] linearizableReadLoop","detail":"{readStateIndex:963; appliedIndex:961; }","duration":"405.940329ms","start":"2026-03-04T01:25:25.299312Z","end":"2026-03-04T01:25:25.705252Z","steps":["trace[38753123] 'read index received' (duration: 36.122739ms)","trace[38753123] 'applied index is now lower than readState.Index' (duration: 369.81478ms)"],"step_count":2} {"level":"info","ts":"2026-03-04T01:25:25.70535Z","caller":"traceutil/trace.go:171","msg":"trace[1985270381] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"365.28517ms","start":"2026-03-04T01:25:25.340034Z","end":"2026-03-04T01:25:25.705319Z","steps":["trace[1985270381] 'process raft request' (duration: 365.076974ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:25:25.70552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:25:25.340013Z","time spent":"365.415123ms","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":835,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-04T01:25:25.862074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.720458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-04T01:25:25.862083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.851623ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-03-04T01:25:25.862196Z","caller":"traceutil/trace.go:171","msg":"trace[1100189840] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:928; }","duration":"562.875943ms","start":"2026-03-04T01:25:25.299268Z","end":"2026-03-04T01:25:25.862144Z","steps":["trace[1100189840] 'agreement among raft nodes before linearized reading' (duration: 406.077182ms)","trace[1100189840] 'count revisions from in-memory index tree' (duration: 156.647087ms)"],"step_count":2} {"level":"warn","ts":"2026-03-04T01:25:25.862273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:25:25.299253Z","time spent":"563.004257ms","remote":"127.0.0.1:42500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":27,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"info","ts":"2026-03-04T01:25:25.86244Z","caller":"traceutil/trace.go:171","msg":"trace[1195555427] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"151.45632ms","start":"2026-03-04T01:25:25.710967Z","end":"2026-03-04T01:25:25.862423Z","steps":["trace[1195555427] 'process raft request' (duration: 151.321897ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:25:25.862457Z","caller":"traceutil/trace.go:171","msg":"trace[1905522149] linearizableReadLoop","detail":"{readStateIndex:965; appliedIndex:964; }","duration":"157.079968ms","start":"2026-03-04T01:25:25.705352Z","end":"2026-03-04T01:25:25.862432Z","steps":["trace[1905522149] 'read index received' (duration: 46.321µs)","trace[1905522149] 'applied index is now lower than readState.Index' (duration: 157.027907ms)"],"step_count":2} {"level":"warn","ts":"2026-03-04T01:25:25.862774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.889617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-03-04T01:25:25.862759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.770122ms","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-03-04T01:25:25.862814Z","caller":"traceutil/trace.go:171","msg":"trace[1873239603] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:929; }","duration":"271.930718ms","start":"2026-03-04T01:25:25.590871Z","end":"2026-03-04T01:25:25.862802Z","steps":["trace[1873239603] 'agreement among raft nodes before linearized reading' (duration: 271.737152ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:25:25.862853Z","caller":"traceutil/trace.go:171","msg":"trace[1348985929] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:929; }","duration":"271.959598ms","start":"2026-03-04T01:25:25.590871Z","end":"2026-03-04T01:25:25.862831Z","steps":["trace[1348985929] 'agreement among raft nodes before linearized reading' (duration: 271.573388ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:25:25.862948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.944553ms","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-03-04T01:25:25.862971Z","caller":"traceutil/trace.go:171","msg":"trace[905555286] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:929; }","duration":"268.002394ms","start":"2026-03-04T01:25:25.594962Z","end":"2026-03-04T01:25:25.862964Z","steps":["trace[905555286] 'agreement among raft nodes before linearized reading' (duration: 267.86364ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:25:25.862962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.626664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-04T01:25:25.863063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.831012ms","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-03-04T01:25:25.863103Z","caller":"traceutil/trace.go:171","msg":"trace[1700326310] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:929; }","duration":"288.906894ms","start":"2026-03-04T01:25:25.574185Z","end":"2026-03-04T01:25:25.863092Z","steps":["trace[1700326310] 'agreement among raft nodes before linearized reading' (duration: 288.812361ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:25:25.863117Z","caller":"traceutil/trace.go:171","msg":"trace[1821400866] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:929; }","duration":"536.8529ms","start":"2026-03-04T01:25:25.326237Z","end":"2026-03-04T01:25:25.86309Z","steps":["trace[1821400866] 'agreement among raft nodes before linearized reading' (duration: 536.609204ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:25:25.863184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:25:25.326213Z","time spent":"536.956042ms","remote":"127.0.0.1:42594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-03-04T01:25:25.863614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.159628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"} {"level":"info","ts":"2026-03-04T01:25:25.863701Z","caller":"traceutil/trace.go:171","msg":"trace[425437450] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:929; }","duration":"155.314602ms","start":"2026-03-04T01:25:25.708358Z","end":"2026-03-04T01:25:25.863673Z","steps":["trace[425437450] 'agreement among raft nodes before linearized reading' (duration: 154.682456ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:25:26.026979Z","caller":"traceutil/trace.go:171","msg":"trace[757033397] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"158.28011ms","start":"2026-03-04T01:25:25.868646Z","end":"2026-03-04T01:25:26.026926Z","steps":["trace[757033397] 'process raft request' (duration: 158.018083ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:25:26.048031Z","caller":"traceutil/trace.go:171","msg":"trace[1406724903] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"179.046327ms","start":"2026-03-04T01:25:25.868958Z","end":"2026-03-04T01:25:26.048004Z","steps":["trace[1406724903] 'process raft request' (duration: 178.78597ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:25:26.04803Z","caller":"traceutil/trace.go:171","msg":"trace[1005060279] transaction","detail":"{read_only:false; response_revision:932; number_of_response:1; }","duration":"178.973625ms","start":"2026-03-04T01:25:25.86903Z","end":"2026-03-04T01:25:26.048003Z","steps":["trace[1005060279] 'process raft request' (duration: 178.873972ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:25:26.048309Z","caller":"traceutil/trace.go:171","msg":"trace[1360359573] transaction","detail":"{read_only:false; response_revision:934; number_of_response:1; }","duration":"178.710188ms","start":"2026-03-04T01:25:25.869579Z","end":"2026-03-04T01:25:26.048289Z","steps":["trace[1360359573] 'process raft request' (duration: 178.607914ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:25:26.048416Z","caller":"traceutil/trace.go:171","msg":"trace[408757453] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"179.293632ms","start":"2026-03-04T01:25:25.869063Z","end":"2026-03-04T01:25:26.048356Z","steps":["trace[408757453] 'process raft request' (duration: 178.882961ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:25:26.561299Z","caller":"traceutil/trace.go:171","msg":"trace[455960464] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"124.749279ms","start":"2026-03-04T01:25:26.436527Z","end":"2026-03-04T01:25:26.561276Z","steps":["trace[455960464] 'process raft request' (duration: 124.596855ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:25:38.288999Z","caller":"traceutil/trace.go:171","msg":"trace[1078658065] linearizableReadLoop","detail":"{readStateIndex:1042; appliedIndex:1041; }","duration":"184.234882ms","start":"2026-03-04T01:25:38.104748Z","end":"2026-03-04T01:25:38.288983Z","steps":["trace[1078658065] 'read index received' (duration: 184.13115ms)","trace[1078658065] 'applied index is now lower than readState.Index' (duration: 103.002µs)"],"step_count":2} {"level":"info","ts":"2026-03-04T01:25:38.289166Z","caller":"traceutil/trace.go:171","msg":"trace[744687487] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"201.28463ms","start":"2026-03-04T01:25:38.087834Z","end":"2026-03-04T01:25:38.289119Z","steps":["trace[744687487] 'process raft request' (duration: 201.034374ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:25:38.28921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.458098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-03-04T01:25:38.289242Z","caller":"traceutil/trace.go:171","msg":"trace[1888180709] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1003; }","duration":"184.795167ms","start":"2026-03-04T01:25:38.104437Z","end":"2026-03-04T01:25:38.289233Z","steps":["trace[1888180709] 'agreement among raft nodes before linearized reading' (duration: 184.654733ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:25:38.289327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.898673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-03-04T01:25:38.289384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.711084ms","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-03-04T01:25:38.289406Z","caller":"traceutil/trace.go:171","msg":"trace[1816622595] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1003; }","duration":"176.743935ms","start":"2026-03-04T01:25:38.112656Z","end":"2026-03-04T01:25:38.2894Z","steps":["trace[1816622595] 'agreement among raft nodes before linearized reading' (duration: 176.684413ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:25:38.289401Z","caller":"traceutil/trace.go:171","msg":"trace[385807262] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1003; }","duration":"184.007225ms","start":"2026-03-04T01:25:38.105377Z","end":"2026-03-04T01:25:38.289385Z","steps":["trace[385807262] 'agreement among raft nodes before linearized reading' (duration: 183.78832ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:25:39.052458Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853968895650278069,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-04T01:25:39.158619Z","caller":"traceutil/trace.go:171","msg":"trace[1861131687] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"862.885938ms","start":"2026-03-04T01:25:38.295706Z","end":"2026-03-04T01:25:39.158592Z","steps":["trace[1861131687] 'process raft request' (duration: 862.799936ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:25:39.158659Z","caller":"traceutil/trace.go:171","msg":"trace[85861326] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"863.062953ms","start":"2026-03-04T01:25:38.295558Z","end":"2026-03-04T01:25:39.158621Z","steps":["trace[85861326] 'process raft request' (duration: 862.759335ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:25:39.158783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:25:38.295671Z","time spent":"863.027361ms","remote":"127.0.0.1:42650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":518,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-04T01:25:39.158809Z","caller":"traceutil/trace.go:171","msg":"trace[1492055506] linearizableReadLoop","detail":"{readStateIndex:1046; appliedIndex:1043; }","duration":"616.873762ms","start":"2026-03-04T01:25:38.541887Z","end":"2026-03-04T01:25:39.158761Z","steps":["trace[1492055506] 'read index received' (duration: 616.323727ms)","trace[1492055506] 'applied index is now lower than readState.Index' (duration: 546.355µs)"],"step_count":2} {"level":"info","ts":"2026-03-04T01:25:39.158923Z","caller":"traceutil/trace.go:171","msg":"trace[90353597] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"862.102697ms","start":"2026-03-04T01:25:38.296806Z","end":"2026-03-04T01:25:39.158908Z","steps":["trace[90353597] 'process raft request' (duration: 861.743618ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:25:39.159054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:25:38.296789Z","time spent":"862.173549ms","remote":"127.0.0.1:42650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-04T01:25:39.159079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.200242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-03-04T01:25:39.15912Z","caller":"traceutil/trace.go:171","msg":"trace[1533548528] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1007; }","duration":"617.288804ms","start":"2026-03-04T01:25:38.54182Z","end":"2026-03-04T01:25:39.159108Z","steps":["trace[1533548528] 'agreement among raft nodes before linearized reading' (duration: 617.15719ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:25:39.159164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:25:38.541792Z","time spent":"617.363576ms","remote":"127.0.0.1:42650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-03-04T01:25:39.159229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.872894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-04T01:25:39.159225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.130481ms","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-03-04T01:25:39.159266Z","caller":"traceutil/trace.go:171","msg":"trace[1795433771] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1007; }","duration":"344.908645ms","start":"2026-03-04T01:25:38.814347Z","end":"2026-03-04T01:25:39.159256Z","steps":["trace[1795433771] 'agreement among raft nodes before linearized reading' (duration: 344.849024ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:25:39.15929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:25:38.814262Z","time spent":"345.022788ms","remote":"127.0.0.1:42674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":27,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"info","ts":"2026-03-04T01:25:39.159285Z","caller":"traceutil/trace.go:171","msg":"trace[1089523243] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1007; }","duration":"536.250184ms","start":"2026-03-04T01:25:38.623017Z","end":"2026-03-04T01:25:39.159267Z","steps":["trace[1089523243] 'agreement among raft nodes before linearized reading' (duration: 535.990377ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:25:39.159359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:25:38.62299Z","time spent":"536.332546ms","remote":"127.0.0.1:42650","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-03-04T01:25:39.159405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:25:38.295533Z","time spent":"863.810433ms","remote":"127.0.0.1:42650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-04T01:25:39.159437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.861244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-04T01:25:39.159539Z","caller":"traceutil/trace.go:171","msg":"trace[974033870] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1007; }","duration":"517.018128ms","start":"2026-03-04T01:25:38.642495Z","end":"2026-03-04T01:25:39.159513Z","steps":["trace[974033870] 'agreement among raft nodes before linearized reading' (duration: 516.794552ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T01:25:39.159591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:25:38.642473Z","time spent":"517.10942ms","remote":"127.0.0.1:42368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-04T01:25:39.160707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.986316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-04T01:25:39.160753Z","caller":"traceutil/trace.go:171","msg":"trace[975404264] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1007; }","duration":"217.423274ms","start":"2026-03-04T01:25:38.943318Z","end":"2026-03-04T01:25:39.160742Z","steps":["trace[975404264] 'agreement among raft nodes before linearized reading' (duration: 215.820282ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T01:28:11.362476Z","caller":"traceutil/trace.go:171","msg":"trace[1248933267] transaction","detail":"{read_only:false; response_revision:1629; number_of_response:1; }","duration":"139.152766ms","start":"2026-03-04T01:28:11.22328Z","end":"2026-03-04T01:28:11.362433Z","steps":["trace[1248933267] 'process raft request' (duration: 77.981945ms)","trace[1248933267] 'compare' (duration: 61.013927ms)"],"step_count":2} {"level":"info","ts":"2026-03-04T01:28:12.388929Z","caller":"traceutil/trace.go:171","msg":"trace[1307077427] transaction","detail":"{read_only:false; response_revision:1634; number_of_response:1; }","duration":"160.403604ms","start":"2026-03-04T01:28:12.228305Z","end":"2026-03-04T01:28:12.388709Z","steps":["trace[1307077427] 'process raft request' (duration: 118.113391ms)","trace[1307077427] 'compare' (duration: 42.139479ms)"],"step_count":2}