{"level":"warn","ts":"2026-04-20T02:04:55.890198Z","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:04:55.890308Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.72: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.72:2380","--initial-cluster=instance=https://199.204.45.72:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.72:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.72: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:04:55.890428Z","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:04:55.890451Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-04-20T02:04:55.890507Z","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:04:55.891191Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"]} {"level":"info","ts":"2026-04-20T02:04:55.891266Z","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.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.72: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:04:55.89674Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.195176ms"} {"level":"info","ts":"2026-04-20T02:04:55.902234Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"50e03cebfd94cbba","cluster-id":"120c03c1d5b80f94"} {"level":"info","ts":"2026-04-20T02:04:55.902305Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T02:04:55.902333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 0"} {"level":"info","ts":"2026-04-20T02:04:55.902351Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 50e03cebfd94cbba [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T02:04:55.902361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 1"} {"level":"info","ts":"2026-04-20T02:04:55.902403Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"warn","ts":"2026-04-20T02:04:55.913977Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T02:04:55.915366Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T02:04:55.916444Z","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:04:55.918713Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"50e03cebfd94cbba","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T02:04:55.920038Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"50e03cebfd94cbba","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T02:04:55.920124Z","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:04:55.920223Z","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:04:55.920288Z","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:04:55.923608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"info","ts":"2026-04-20T02:04:55.923803Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","added-peer-id":"50e03cebfd94cbba","added-peer-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-04-20T02:04:55.925635Z","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:04:55.925816Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-04-20T02:04:55.925854Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-04-20T02:04:55.925925Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"50e03cebfd94cbba","initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T02:04:55.925976Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T02:04:56.802682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T02:04:56.802724Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T02:04:56.802746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgPreVoteResp from 50e03cebfd94cbba at term 1"} {"level":"info","ts":"2026-04-20T02:04:56.80276Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became candidate at term 2"} {"level":"info","ts":"2026-04-20T02:04:56.802765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgVoteResp from 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-04-20T02:04:56.802773Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became leader at term 2"} {"level":"info","ts":"2026-04-20T02:04:56.80278Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 50e03cebfd94cbba elected leader 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-04-20T02:04:56.803508Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"50e03cebfd94cbba","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.72:2379]}","request-path":"/0/members/50e03cebfd94cbba/attributes","cluster-id":"120c03c1d5b80f94","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T02:04:56.803606Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T02:04:56.803565Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T02:04:56.803758Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T02:04:56.803896Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T02:04:56.804159Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T02:04:56.806938Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.72:2379"} {"level":"info","ts":"2026-04-20T02:04:56.807308Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T02:04:56.807456Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T02:04:56.807522Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T02:04:56.807544Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-20T02:04:59.337494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.001873ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-20T02:04:59.33761Z","caller":"traceutil/trace.go:171","msg":"trace[549481757] linearizableReadLoop","detail":"{readStateIndex:90; appliedIndex:89; }","duration":"171.191973ms","start":"2026-04-20T02:04:59.166401Z","end":"2026-04-20T02:04:59.337593Z","steps":["trace[549481757] 'read index received' (duration: 65.502674ms)","trace[549481757] 'applied index is now lower than readState.Index' (duration: 105.688139ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:04:59.337699Z","caller":"traceutil/trace.go:171","msg":"trace[144502328] transaction","detail":"{read_only:false; response_revision:86; number_of_response:1; }","duration":"199.226474ms","start":"2026-04-20T02:04:59.138442Z","end":"2026-04-20T02:04:59.337668Z","steps":["trace[144502328] 'process raft request' (duration: 93.543995ms)","trace[144502328] 'compare' (duration: 104.87158ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:04:59.337851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.449419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:04:59.337886Z","caller":"traceutil/trace.go:171","msg":"trace[1014461487] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:86; }","duration":"171.537931ms","start":"2026-04-20T02:04:59.166336Z","end":"2026-04-20T02:04:59.337874Z","steps":["trace[1014461487] 'agreement among raft nodes before linearized reading' (duration: 171.308956ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:04.406846Z","caller":"traceutil/trace.go:171","msg":"trace[557418911] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"114.675712ms","start":"2026-04-20T02:05:04.292126Z","end":"2026-04-20T02:05:04.406802Z","steps":["trace[557418911] 'process raft request' (duration: 111.158523ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:05.058299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.599033ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-20T02:05:05.058389Z","caller":"traceutil/trace.go:171","msg":"trace[180701263] linearizableReadLoop","detail":"{readStateIndex:305; appliedIndex:304; }","duration":"550.797369ms","start":"2026-04-20T02:05:04.507576Z","end":"2026-04-20T02:05:05.058374Z","steps":["trace[180701263] 'read index received' (duration: 151.906749ms)","trace[180701263] 'applied index is now lower than readState.Index' (duration: 398.88983ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:05:05.058488Z","caller":"traceutil/trace.go:171","msg":"trace[171806862] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"637.03155ms","start":"2026-04-20T02:05:04.421368Z","end":"2026-04-20T02:05:05.0584Z","steps":["trace[171806862] 'process raft request' (duration: 238.271893ms)","trace[171806862] 'compare' (duration: 398.45365ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:05:05.05871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:04.421357Z","time spent":"637.278346ms","remote":"127.0.0.1:33524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":192,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T02:05:05.058557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.621826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-20T02:05:05.058741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.078095ms","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:05:05.058879Z","caller":"traceutil/trace.go:171","msg":"trace[1384377791] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:295; }","duration":"551.316631ms","start":"2026-04-20T02:05:04.507532Z","end":"2026-04-20T02:05:05.058848Z","steps":["trace[1384377791] 'agreement among raft nodes before linearized reading' (duration: 550.919782ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:05.058801Z","caller":"traceutil/trace.go:171","msg":"trace[298192719] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:295; }","duration":"108.890631ms","start":"2026-04-20T02:05:04.949891Z","end":"2026-04-20T02:05:05.058781Z","steps":["trace[298192719] 'agreement among raft nodes before linearized reading' (duration: 108.553004ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:05.058956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:04.507512Z","time spent":"551.432753ms","remote":"127.0.0.1:33558","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-04-20T02:05:05.593788Z","caller":"traceutil/trace.go:171","msg":"trace[1186473057] linearizableReadLoop","detail":"{readStateIndex:307; appliedIndex:306; }","duration":"527.049444ms","start":"2026-04-20T02:05:05.066711Z","end":"2026-04-20T02:05:05.593761Z","steps":["trace[1186473057] 'read index received' (duration: 55.364906ms)","trace[1186473057] 'applied index is now lower than readState.Index' (duration: 471.683528ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:05:05.593945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.214428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-20T02:05:05.593917Z","caller":"traceutil/trace.go:171","msg":"trace[169777693] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"529.148462ms","start":"2026-04-20T02:05:05.06471Z","end":"2026-04-20T02:05:05.593859Z","steps":["trace[169777693] 'process raft request' (duration: 528.840585ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:05.593987Z","caller":"traceutil/trace.go:171","msg":"trace[1892097832] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:297; }","duration":"527.271669ms","start":"2026-04-20T02:05:05.066698Z","end":"2026-04-20T02:05:05.59397Z","steps":["trace[1892097832] 'agreement among raft nodes before linearized reading' (duration: 527.179567ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:05.594042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:05.06666Z","time spent":"527.374002ms","remote":"127.0.0.1:33448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-20T02:05:05.594581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:05.064678Z","time spent":"529.364517ms","remote":"127.0.0.1:33558","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-04-20T02:05:06.475996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.448699ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-20T02:05:06.476106Z","caller":"traceutil/trace.go:171","msg":"trace[1305306639] linearizableReadLoop","detail":"{readStateIndex:308; appliedIndex:307; }","duration":"865.917071ms","start":"2026-04-20T02:05:05.610172Z","end":"2026-04-20T02:05:06.476089Z","steps":["trace[1305306639] 'read index received' (duration: 467.34952ms)","trace[1305306639] 'applied index is now lower than readState.Index' (duration: 398.566511ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:05:06.476554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.326091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6961"} {"level":"info","ts":"2026-04-20T02:05:06.476636Z","caller":"traceutil/trace.go:171","msg":"trace[1739830942] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:298; }","duration":"615.460584ms","start":"2026-04-20T02:05:05.861159Z","end":"2026-04-20T02:05:06.47662Z","steps":["trace[1739830942] 'agreement among raft nodes before linearized reading' (duration: 615.234429ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:06.476595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"866.377031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T02:05:06.476738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.173484ms","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-04-20T02:05:06.47677Z","caller":"traceutil/trace.go:171","msg":"trace[1040277116] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:298; }","duration":"866.616857ms","start":"2026-04-20T02:05:05.610126Z","end":"2026-04-20T02:05:06.476743Z","steps":["trace[1040277116] 'agreement among raft nodes before linearized reading' (duration: 866.168117ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:06.47677Z","caller":"traceutil/trace.go:171","msg":"trace[1789188565] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:298; }","duration":"251.232725ms","start":"2026-04-20T02:05:06.225527Z","end":"2026-04-20T02:05:06.476759Z","steps":["trace[1789188565] 'agreement among raft nodes before linearized reading' (duration: 251.182214ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:06.476783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.583503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-20T02:05:06.476852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:05.61011Z","time spent":"866.731439ms","remote":"127.0.0.1:33324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-20T02:05:06.476878Z","caller":"traceutil/trace.go:171","msg":"trace[1190969193] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"870.291339ms","start":"2026-04-20T02:05:05.606568Z","end":"2026-04-20T02:05:06.476859Z","steps":["trace[1190969193] 'process raft request' (duration: 470.90116ms)","trace[1190969193] 'compare' (duration: 398.268875ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:05:06.476883Z","caller":"traceutil/trace.go:171","msg":"trace[971289268] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:298; }","duration":"215.727886ms","start":"2026-04-20T02:05:06.261128Z","end":"2026-04-20T02:05:06.476856Z","steps":["trace[971289268] 'agreement among raft nodes before linearized reading' (duration: 215.532422ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:06.476952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:05.606545Z","time spent":"870.374861ms","remote":"127.0.0.1:33524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":192,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T02:05:06.47668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:05.861141Z","time spent":"615.530465ms","remote":"127.0.0.1:33506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":6983,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"info","ts":"2026-04-20T02:05:06.811496Z","caller":"traceutil/trace.go:171","msg":"trace[459518935] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"328.103476ms","start":"2026-04-20T02:05:06.48335Z","end":"2026-04-20T02:05:06.811453Z","steps":["trace[459518935] 'process raft request' (duration: 288.37075ms)","trace[459518935] 'compare' (duration: 39.45594ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:05:06.811784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:06.48333Z","time spent":"328.286651ms","remote":"127.0.0.1:33558","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-04-20T02:05:06.815806Z","caller":"traceutil/trace.go:171","msg":"trace[2068008259] linearizableReadLoop","detail":"{readStateIndex:310; appliedIndex:308; }","duration":"331.298787ms","start":"2026-04-20T02:05:06.484464Z","end":"2026-04-20T02:05:06.815763Z","steps":["trace[2068008259] 'read index received' (duration: 287.324427ms)","trace[2068008259] 'applied index is now lower than readState.Index' (duration: 43.97332ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:05:06.816014Z","caller":"traceutil/trace.go:171","msg":"trace[1573183203] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"331.769908ms","start":"2026-04-20T02:05:06.484202Z","end":"2026-04-20T02:05:06.815972Z","steps":["trace[1573183203] 'process raft request' (duration: 331.078703ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:06.816257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:06.484168Z","time spent":"331.944902ms","remote":"127.0.0.1:33558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:05:06.816144Z","caller":"traceutil/trace.go:171","msg":"trace[839172169] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"330.251603ms","start":"2026-04-20T02:05:06.485704Z","end":"2026-04-20T02:05:06.815955Z","steps":["trace[839172169] 'process raft request' (duration: 329.979557ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:06.816552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:06.485694Z","time spent":"330.725615ms","remote":"127.0.0.1:33506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6946,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:05:06.816632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.405842ms","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:06.816674Z","caller":"traceutil/trace.go:171","msg":"trace[991029603] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:301; }","duration":"125.480294ms","start":"2026-04-20T02:05:06.691181Z","end":"2026-04-20T02:05:06.816661Z","steps":["trace[991029603] 'agreement among raft nodes before linearized reading' (duration: 125.410432ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:06.816771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.267169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-20T02:05:06.816884Z","caller":"traceutil/trace.go:171","msg":"trace[1462084156] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:301; }","duration":"332.428963ms","start":"2026-04-20T02:05:06.484427Z","end":"2026-04-20T02:05:06.816855Z","steps":["trace[1462084156] 'agreement among raft nodes before linearized reading' (duration: 332.188057ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:06.816955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:06.484417Z","time spent":"332.523985ms","remote":"127.0.0.1:33448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-20T02:05:15.768308Z","caller":"traceutil/trace.go:171","msg":"trace[1755992873] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"111.735815ms","start":"2026-04-20T02:05:15.656549Z","end":"2026-04-20T02:05:15.768284Z","steps":["trace[1755992873] 'process raft request' (duration: 111.603612ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:27.415444Z","caller":"traceutil/trace.go:171","msg":"trace[555553956] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"213.266271ms","start":"2026-04-20T02:05:27.202152Z","end":"2026-04-20T02:05:27.415418Z","steps":["trace[555553956] 'process raft request' (duration: 213.104148ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:27.422109Z","caller":"traceutil/trace.go:171","msg":"trace[1438202684] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"184.169646ms","start":"2026-04-20T02:05:27.237924Z","end":"2026-04-20T02:05:27.422094Z","steps":["trace[1438202684] 'process raft request' (duration: 183.782197ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:27.42216Z","caller":"traceutil/trace.go:171","msg":"trace[468288958] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"164.993324ms","start":"2026-04-20T02:05:27.257131Z","end":"2026-04-20T02:05:27.422125Z","steps":["trace[468288958] 'process raft request' (duration: 164.700587ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:27.422196Z","caller":"traceutil/trace.go:171","msg":"trace[622882736] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"158.688422ms","start":"2026-04-20T02:05:27.263459Z","end":"2026-04-20T02:05:27.422148Z","steps":["trace[622882736] 'process raft request' (duration: 158.424766ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:27.422312Z","caller":"traceutil/trace.go:171","msg":"trace[219645755] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"217.144648ms","start":"2026-04-20T02:05:27.205159Z","end":"2026-04-20T02:05:27.422303Z","steps":["trace[219645755] 'process raft request' (duration: 216.35589ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:27.42234Z","caller":"traceutil/trace.go:171","msg":"trace[388880151] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"179.395418ms","start":"2026-04-20T02:05:27.242935Z","end":"2026-04-20T02:05:27.42233Z","steps":["trace[388880151] 'process raft request' (duration: 178.818425ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:27.422197Z","caller":"traceutil/trace.go:171","msg":"trace[450636463] linearizableReadLoop","detail":"{readStateIndex:491; appliedIndex:488; }","duration":"184.453312ms","start":"2026-04-20T02:05:27.237718Z","end":"2026-04-20T02:05:27.422172Z","steps":["trace[450636463] 'read index received' (duration: 177.843604ms)","trace[450636463] 'applied index is now lower than readState.Index' (duration: 6.608488ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:05:27.422408Z","caller":"traceutil/trace.go:171","msg":"trace[527459901] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"174.869386ms","start":"2026-04-20T02:05:27.247528Z","end":"2026-04-20T02:05:27.422398Z","steps":["trace[527459901] 'process raft request' (duration: 174.259782ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:27.422438Z","caller":"traceutil/trace.go:171","msg":"trace[1943367404] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"208.602995ms","start":"2026-04-20T02:05:27.213827Z","end":"2026-04-20T02:05:27.42243Z","steps":["trace[1943367404] 'process raft request' (duration: 207.793777ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:27.422401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.658956ms","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:27.422451Z","caller":"traceutil/trace.go:171","msg":"trace[1930631307] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"128.901482ms","start":"2026-04-20T02:05:27.293535Z","end":"2026-04-20T02:05:27.422436Z","steps":["trace[1930631307] 'process raft request' (duration: 128.465652ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:27.42248Z","caller":"traceutil/trace.go:171","msg":"trace[679659905] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:482; }","duration":"184.798519ms","start":"2026-04-20T02:05:27.237669Z","end":"2026-04-20T02:05:27.422467Z","steps":["trace[679659905] 'agreement among raft nodes before linearized reading' (duration: 184.580774ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:27.422505Z","caller":"traceutil/trace.go:171","msg":"trace[748674223] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"192.761939ms","start":"2026-04-20T02:05:27.229737Z","end":"2026-04-20T02:05:27.422499Z","steps":["trace[748674223] 'process raft request' (duration: 191.93029ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:27.422442Z","caller":"traceutil/trace.go:171","msg":"trace[820067236] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"143.650893ms","start":"2026-04-20T02:05:27.278778Z","end":"2026-04-20T02:05:27.422429Z","steps":["trace[820067236] 'process raft request' (duration: 143.157662ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:27.818463Z","caller":"traceutil/trace.go:171","msg":"trace[1260857101] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"238.968209ms","start":"2026-04-20T02:05:27.579469Z","end":"2026-04-20T02:05:27.818437Z","steps":["trace[1260857101] 'process raft request' (duration: 238.677923ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:27.832184Z","caller":"traceutil/trace.go:171","msg":"trace[239970643] linearizableReadLoop","detail":"{readStateIndex:530; appliedIndex:527; }","duration":"142.233392ms","start":"2026-04-20T02:05:27.689931Z","end":"2026-04-20T02:05:27.832164Z","steps":["trace[239970643] 'read index received' (duration: 128.192485ms)","trace[239970643] 'applied index is now lower than readState.Index' (duration: 14.040047ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:05:27.832346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.395155ms","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:27.832378Z","caller":"traceutil/trace.go:171","msg":"trace[1872034458] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:511; }","duration":"142.443766ms","start":"2026-04-20T02:05:27.689925Z","end":"2026-04-20T02:05:27.832369Z","steps":["trace[1872034458] 'agreement among raft nodes before linearized reading' (duration: 142.314393ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:27.832328Z","caller":"traceutil/trace.go:171","msg":"trace[695009714] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"238.53413ms","start":"2026-04-20T02:05:27.593769Z","end":"2026-04-20T02:05:27.832303Z","steps":["trace[695009714] 'process raft request' (duration: 237.844584ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:27.832372Z","caller":"traceutil/trace.go:171","msg":"trace[1054459409] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"234.840036ms","start":"2026-04-20T02:05:27.59751Z","end":"2026-04-20T02:05:27.83235Z","steps":["trace[1054459409] 'process raft request' (duration: 234.57999ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:34.317146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.369717ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T02:05:34.317278Z","caller":"traceutil/trace.go:171","msg":"trace[1512139115] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"376.7483ms","start":"2026-04-20T02:05:33.940511Z","end":"2026-04-20T02:05:34.317259Z","steps":["trace[1512139115] 'process raft request' (duration: 177.173918ms)","trace[1512139115] 'compare' (duration: 199.244284ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:05:34.317368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:33.940502Z","time spent":"376.837751ms","remote":"127.0.0.1:33506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:05:35.036422Z","caller":"traceutil/trace.go:171","msg":"trace[843347014] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:602; }","duration":"343.889931ms","start":"2026-04-20T02:05:34.692502Z","end":"2026-04-20T02:05:35.036392Z","steps":["trace[843347014] 'read index received' (duration: 341.436806ms)","trace[843347014] 'applied index is now lower than readState.Index' (duration: 2.451555ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:05:35.036626Z","caller":"traceutil/trace.go:171","msg":"trace[813401385] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"984.367007ms","start":"2026-04-20T02:05:34.052243Z","end":"2026-04-20T02:05:35.03661Z","steps":["trace[813401385] 'process raft request' (duration: 982.419933ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:35.036765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:34.052213Z","time spent":"984.4531ms","remote":"127.0.0.1:33432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:05:35.037149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.612827ms","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:35.037256Z","caller":"traceutil/trace.go:171","msg":"trace[1739090875] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:583; }","duration":"344.770261ms","start":"2026-04-20T02:05:34.692456Z","end":"2026-04-20T02:05:35.037227Z","steps":["trace[1739090875] 'agreement among raft nodes before linearized reading' (duration: 344.564606ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:35.037369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:34.692436Z","time spent":"344.921014ms","remote":"127.0.0.1:33324","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-04-20T02:05:36.426084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.285094497s","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:36.426225Z","caller":"traceutil/trace.go:171","msg":"trace[2119192152] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:583; }","duration":"1.285241921s","start":"2026-04-20T02:05:35.140959Z","end":"2026-04-20T02:05:36.4262Z","steps":["trace[2119192152] 'range keys from in-memory index tree' (duration: 1.285078017s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:36.42684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.005188846s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T02:05:36.427061Z","caller":"traceutil/trace.go:171","msg":"trace[1990318294] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"1.384637868s","start":"2026-04-20T02:05:35.042386Z","end":"2026-04-20T02:05:36.427023Z","steps":["trace[1990318294] 'process raft request' (duration: 378.624463ms)","trace[1990318294] 'compare' (duration: 1.004831769s)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:05:36.427117Z","caller":"traceutil/trace.go:171","msg":"trace[2006567354] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"1.383532762s","start":"2026-04-20T02:05:35.043551Z","end":"2026-04-20T02:05:36.427084Z","steps":["trace[2006567354] 'process raft request' (duration: 1.383382399s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:36.427235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:35.043532Z","time spent":"1.383644575s","remote":"127.0.0.1:33558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:05:36.42727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:35.042363Z","time spent":"1.384809291s","remote":"127.0.0.1:33558","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-04-20T02:05:36.427246Z","caller":"traceutil/trace.go:171","msg":"trace[874894785] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"1.333011526s","start":"2026-04-20T02:05:35.094211Z","end":"2026-04-20T02:05:36.427223Z","steps":["trace[874894785] 'process raft request' (duration: 1.33278568s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:36.427442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:35.094187Z","time spent":"1.333231812s","remote":"127.0.0.1:33550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T02:05:36.958092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.930292ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-20T02:05:36.958197Z","caller":"traceutil/trace.go:171","msg":"trace[1879005815] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:603; }","duration":"1.472903165s","start":"2026-04-20T02:05:35.485276Z","end":"2026-04-20T02:05:36.958179Z","steps":["trace[1879005815] 'read index received' (duration: 69.70687ms)","trace[1879005815] 'applied index is now lower than readState.Index' (duration: 1.403194645s)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:05:36.958335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.313419ms","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:36.958373Z","caller":"traceutil/trace.go:171","msg":"trace[1526722774] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:586; }","duration":"268.397961ms","start":"2026-04-20T02:05:36.689965Z","end":"2026-04-20T02:05:36.958363Z","steps":["trace[1526722774] 'agreement among raft nodes before linearized reading' (duration: 268.34085ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:36.958432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.47313824s","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:05:36.95851Z","caller":"traceutil/trace.go:171","msg":"trace[534986074] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:586; }","duration":"1.473287233s","start":"2026-04-20T02:05:35.485206Z","end":"2026-04-20T02:05:36.958493Z","steps":["trace[534986074] 'agreement among raft nodes before linearized reading' (duration: 1.473044458s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:36.958556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:35.48517Z","time spent":"1.473374415s","remote":"127.0.0.1:33558","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":"warn","ts":"2026-04-20T02:05:36.958611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.807164ms","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:36.958648Z","caller":"traceutil/trace.go:171","msg":"trace[1445922914] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:586; }","duration":"389.875716ms","start":"2026-04-20T02:05:36.568764Z","end":"2026-04-20T02:05:36.95864Z","steps":["trace[1445922914] 'agreement among raft nodes before linearized reading' (duration: 389.821984ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:36.958677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:36.568721Z","time spent":"389.949107ms","remote":"127.0.0.1:33324","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-04-20T02:05:36.958842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.550715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-04-20T02:05:36.958924Z","caller":"traceutil/trace.go:171","msg":"trace[79542700] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:586; }","duration":"527.630667ms","start":"2026-04-20T02:05:36.431283Z","end":"2026-04-20T02:05:36.958914Z","steps":["trace[79542700] 'agreement among raft nodes before linearized reading' (duration: 527.521434ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:36.959542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"967.605981ms","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:05:36.959612Z","caller":"traceutil/trace.go:171","msg":"trace[793967587] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:586; }","duration":"967.713734ms","start":"2026-04-20T02:05:35.991879Z","end":"2026-04-20T02:05:36.959592Z","steps":["trace[793967587] 'agreement among raft nodes before linearized reading' (duration: 966.392483ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:36.958957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:36.431231Z","time spent":"527.716748ms","remote":"127.0.0.1:33524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-04-20T02:05:36.959659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:35.991858Z","time spent":"967.789355ms","remote":"127.0.0.1:33558","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-04-20T02:05:38.40253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.353144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T02:05:38.402608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.08053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:05:38.402684Z","caller":"traceutil/trace.go:171","msg":"trace[949290062] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:598; }","duration":"301.548159ms","start":"2026-04-20T02:05:38.10111Z","end":"2026-04-20T02:05:38.402658Z","steps":["trace[949290062] 'range keys from in-memory index tree' (duration: 301.218821ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:38.402751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.021158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T02:05:38.402788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:38.101094Z","time spent":"301.666171ms","remote":"127.0.0.1:60078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-20T02:05:38.4028Z","caller":"traceutil/trace.go:171","msg":"trace[198188225] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:598; }","duration":"270.098281ms","start":"2026-04-20T02:05:38.132689Z","end":"2026-04-20T02:05:38.402787Z","steps":["trace[198188225] 'range keys from in-memory index tree' (duration: 269.951267ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:38.402853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:05:38.402938Z","caller":"traceutil/trace.go:171","msg":"trace[776121661] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:598; }","duration":"239.085123ms","start":"2026-04-20T02:05:38.163834Z","end":"2026-04-20T02:05:38.402919Z","steps":["trace[776121661] 'count revisions from in-memory index tree' (duration: 238.92726ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:38.402716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.822053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T02:05:38.403014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.057942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:05:38.403074Z","caller":"traceutil/trace.go:171","msg":"trace[1714893942] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:598; }","duration":"301.200701ms","start":"2026-04-20T02:05:38.101857Z","end":"2026-04-20T02:05:38.403057Z","steps":["trace[1714893942] 'range keys from in-memory index tree' (duration: 300.786891ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:38.403091Z","caller":"traceutil/trace.go:171","msg":"trace[408260807] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:598; }","duration":"239.267907ms","start":"2026-04-20T02:05:38.1638Z","end":"2026-04-20T02:05:38.403068Z","steps":["trace[408260807] 'range keys from in-memory index tree' (duration: 238.98688ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:38.403159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.631691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:05:38.403197Z","caller":"traceutil/trace.go:171","msg":"trace[1306938027] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:598; }","duration":"238.685693ms","start":"2026-04-20T02:05:38.164501Z","end":"2026-04-20T02:05:38.403187Z","steps":["trace[1306938027] 'range keys from in-memory index tree' (duration: 238.611991ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:38.403138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:38.101849Z","time spent":"301.267632ms","remote":"127.0.0.1:60078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-20T02:05:38.403295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.109177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:05:38.403335Z","caller":"traceutil/trace.go:171","msg":"trace[905614688] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:598; }","duration":"185.164929ms","start":"2026-04-20T02:05:38.218158Z","end":"2026-04-20T02:05:38.403323Z","steps":["trace[905614688] 'range keys from in-memory index tree' (duration: 185.025446ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:38.403251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.191752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:05:38.403456Z","caller":"traceutil/trace.go:171","msg":"trace[1712396512] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:598; }","duration":"270.722465ms","start":"2026-04-20T02:05:38.132689Z","end":"2026-04-20T02:05:38.403411Z","steps":["trace[1712396512] 'count revisions from in-memory index tree' (duration: 270.110341ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:38.403537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.237953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T02:05:38.403572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.96224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:05:38.40359Z","caller":"traceutil/trace.go:171","msg":"trace[1433600382] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:598; }","duration":"186.502059ms","start":"2026-04-20T02:05:38.217074Z","end":"2026-04-20T02:05:38.403576Z","steps":["trace[1433600382] 'count revisions from in-memory index tree' (duration: 186.12373ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:38.403622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.416246ms","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:05:38.403624Z","caller":"traceutil/trace.go:171","msg":"trace[541491027] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:598; }","duration":"215.050891ms","start":"2026-04-20T02:05:38.188558Z","end":"2026-04-20T02:05:38.403609Z","steps":["trace[541491027] 'range keys from in-memory index tree' (duration: 214.902118ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:38.403665Z","caller":"traceutil/trace.go:171","msg":"trace[1791531868] 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:598; }","duration":"170.474868ms","start":"2026-04-20T02:05:38.23318Z","end":"2026-04-20T02:05:38.403655Z","steps":["trace[1791531868] 'count revisions from in-memory index tree' (duration: 170.378356ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:38.40371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.768154ms","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\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:05:38.403775Z","caller":"traceutil/trace.go:171","msg":"trace[1794694529] 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:598; }","duration":"170.858246ms","start":"2026-04-20T02:05:38.232903Z","end":"2026-04-20T02:05:38.403761Z","steps":["trace[1794694529] 'range keys from in-memory index tree' (duration: 170.710833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:38.403849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.57566ms","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\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T02:05:38.403487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.283654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:05:38.40394Z","caller":"traceutil/trace.go:171","msg":"trace[1377799778] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:598; }","duration":"186.758235ms","start":"2026-04-20T02:05:38.217166Z","end":"2026-04-20T02:05:38.403924Z","steps":["trace[1377799778] 'range keys from in-memory index tree' (duration: 186.180521ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:38.40389Z","caller":"traceutil/trace.go:171","msg":"trace[1218968936] 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:598; }","duration":"170.646371ms","start":"2026-04-20T02:05:38.233234Z","end":"2026-04-20T02:05:38.40388Z","steps":["trace[1218968936] 'range keys from in-memory index tree' (duration: 170.489948ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:38.40421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.003861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:05:38.404273Z","caller":"traceutil/trace.go:171","msg":"trace[1520988054] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:598; }","duration":"303.121483ms","start":"2026-04-20T02:05:38.101137Z","end":"2026-04-20T02:05:38.404258Z","steps":["trace[1520988054] 'count revisions from in-memory index tree' (duration: 302.95236ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:38.402727Z","caller":"traceutil/trace.go:171","msg":"trace[319953155] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:598; }","duration":"214.236233ms","start":"2026-04-20T02:05:38.188476Z","end":"2026-04-20T02:05:38.402712Z","steps":["trace[319953155] 'count revisions from in-memory index tree' (duration: 214.042559ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:38.404316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:38.101117Z","time spent":"303.184484ms","remote":"127.0.0.1:60078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-20T02:05:42.346673Z","caller":"traceutil/trace.go:171","msg":"trace[526119293] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"149.68564ms","start":"2026-04-20T02:05:42.196959Z","end":"2026-04-20T02:05:42.346645Z","steps":["trace[526119293] 'process raft request' (duration: 149.477065ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:50.923768Z","caller":"traceutil/trace.go:171","msg":"trace[1208322621] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"300.441143ms","start":"2026-04-20T02:05:50.623298Z","end":"2026-04-20T02:05:50.923739Z","steps":["trace[1208322621] 'process raft request' (duration: 300.280159ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:50.923972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:50.623267Z","time spent":"300.593857ms","remote":"127.0.0.1:33558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:05:53.426993Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219282968994903,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-20T02:05:53.548421Z","caller":"traceutil/trace.go:171","msg":"trace[2030157755] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"633.267325ms","start":"2026-04-20T02:05:52.915131Z","end":"2026-04-20T02:05:53.548398Z","steps":["trace[2030157755] 'process raft request' (duration: 633.086001ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:53.548605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:52.9151Z","time spent":"633.412308ms","remote":"127.0.0.1:33558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:05:53.548631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.979671ms","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:05:53.548695Z","caller":"traceutil/trace.go:171","msg":"trace[520297736] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:748; }","duration":"622.087094ms","start":"2026-04-20T02:05:52.926588Z","end":"2026-04-20T02:05:53.548675Z","steps":["trace[520297736] 'agreement among raft nodes before linearized reading' (duration: 621.90004ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:53.548725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:52.926572Z","time spent":"622.147585ms","remote":"127.0.0.1:33558","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":"info","ts":"2026-04-20T02:05:53.549067Z","caller":"traceutil/trace.go:171","msg":"trace[100720022] linearizableReadLoop","detail":"{readStateIndex:774; appliedIndex:773; }","duration":"621.722906ms","start":"2026-04-20T02:05:52.92663Z","end":"2026-04-20T02:05:53.548353Z","steps":["trace[100720022] 'read index received' (duration: 621.522581ms)","trace[100720022] 'applied index is now lower than readState.Index' (duration: 199.425µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:05:53.549372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.032376ms","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:53.549419Z","caller":"traceutil/trace.go:171","msg":"trace[2080413750] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:748; }","duration":"504.114178ms","start":"2026-04-20T02:05:53.045293Z","end":"2026-04-20T02:05:53.549407Z","steps":["trace[2080413750] 'agreement among raft nodes before linearized reading' (duration: 503.980455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:53.54945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:53.045282Z","time spent":"504.160739ms","remote":"127.0.0.1:33558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-20T02:05:53.549544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.225578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-575hc\" ","response":"range_response_count:1 size:3964"} {"level":"warn","ts":"2026-04-20T02:05:53.54955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.420433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-20T02:05:53.549581Z","caller":"traceutil/trace.go:171","msg":"trace[1446393434] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-575hc; range_end:; response_count:1; response_revision:748; }","duration":"511.593687ms","start":"2026-04-20T02:05:53.037975Z","end":"2026-04-20T02:05:53.549569Z","steps":["trace[1446393434] 'agreement among raft nodes before linearized reading' (duration: 511.169306ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:53.549583Z","caller":"traceutil/trace.go:171","msg":"trace[1704971258] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:748; }","duration":"511.480244ms","start":"2026-04-20T02:05:53.038093Z","end":"2026-04-20T02:05:53.549573Z","steps":["trace[1704971258] 'agreement among raft nodes before linearized reading' (duration: 511.353191ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:53.549615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:53.037957Z","time spent":"511.651467ms","remote":"127.0.0.1:33506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3986,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-575hc\" "} {"level":"warn","ts":"2026-04-20T02:05:53.549635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:53.038074Z","time spent":"511.554016ms","remote":"127.0.0.1:33558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-20T02:05:53.777213Z","caller":"traceutil/trace.go:171","msg":"trace[1191893175] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"223.825848ms","start":"2026-04-20T02:05:53.553343Z","end":"2026-04-20T02:05:53.777168Z","steps":["trace[1191893175] 'process raft request' (duration: 213.484545ms)","trace[1191893175] 'compare' (duration: 10.101558ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:05:53.780536Z","caller":"traceutil/trace.go:171","msg":"trace[1579100982] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"225.249439ms","start":"2026-04-20T02:05:53.555261Z","end":"2026-04-20T02:05:53.780511Z","steps":["trace[1579100982] 'process raft request' (duration: 225.112296ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:53.781034Z","caller":"traceutil/trace.go:171","msg":"trace[1307333948] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"222.716373ms","start":"2026-04-20T02:05:53.558299Z","end":"2026-04-20T02:05:53.781016Z","steps":["trace[1307333948] 'process raft request' (duration: 222.434446ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:53.781169Z","caller":"traceutil/trace.go:171","msg":"trace[1417963595] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"225.675479ms","start":"2026-04-20T02:05:53.555265Z","end":"2026-04-20T02:05:53.78094Z","steps":["trace[1417963595] 'process raft request' (duration: 225.198378ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:28.092007Z","caller":"traceutil/trace.go:171","msg":"trace[1846163990] linearizableReadLoop","detail":"{readStateIndex:998; appliedIndex:997; }","duration":"159.846295ms","start":"2026-04-20T02:06:27.932136Z","end":"2026-04-20T02:06:28.091982Z","steps":["trace[1846163990] 'read index received' (duration: 159.63315ms)","trace[1846163990] 'applied index is now lower than readState.Index' (duration: 212.125µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:06:28.092274Z","caller":"traceutil/trace.go:171","msg":"trace[565357570] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"166.989035ms","start":"2026-04-20T02:06:27.925272Z","end":"2026-04-20T02:06:28.092261Z","steps":["trace[565357570] 'process raft request' (duration: 166.558066ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:28.092621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.434278ms","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:06:28.092669Z","caller":"traceutil/trace.go:171","msg":"trace[1873652945] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:963; }","duration":"160.545811ms","start":"2026-04-20T02:06:27.932111Z","end":"2026-04-20T02:06:28.092656Z","steps":["trace[1873652945] 'agreement among raft nodes before linearized reading' (duration: 160.362417ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:28.092903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.289813ms","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:28.093006Z","caller":"traceutil/trace.go:171","msg":"trace[829084068] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:963; }","duration":"159.418026ms","start":"2026-04-20T02:06:27.933545Z","end":"2026-04-20T02:06:28.092963Z","steps":["trace[829084068] 'agreement among raft nodes before linearized reading' (duration: 159.156749ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:28.093006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.458116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T02:06:28.093047Z","caller":"traceutil/trace.go:171","msg":"trace[463396462] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:963; }","duration":"146.526167ms","start":"2026-04-20T02:06:27.946511Z","end":"2026-04-20T02:06:28.093037Z","steps":["trace[463396462] 'agreement among raft nodes before linearized reading' (duration: 146.460186ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:28.652246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.104798ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T02:06:28.652384Z","caller":"traceutil/trace.go:171","msg":"trace[741634370] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"553.097556ms","start":"2026-04-20T02:06:28.099266Z","end":"2026-04-20T02:06:28.652364Z","steps":["trace[741634370] 'process raft request' (duration: 48.777544ms)","trace[741634370] 'compare' (duration: 503.880773ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:06:28.652446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:28.099255Z","time spent":"553.162208ms","remote":"127.0.0.1:33558","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-04-20T02:06:29.180175Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219282968995367,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T02:06:29.313118Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.08194412s","expected-duration":"1s"} {"level":"info","ts":"2026-04-20T02:06:29.31354Z","caller":"traceutil/trace.go:171","msg":"trace[1861730529] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"1.082497702s","start":"2026-04-20T02:06:28.231017Z","end":"2026-04-20T02:06:29.313515Z","steps":["trace[1861730529] 'process raft request' (duration: 1.082362999s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:29.313661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:28.230993Z","time spent":"1.082597314s","remote":"127.0.0.1:33558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:06:29.313788Z","caller":"traceutil/trace.go:171","msg":"trace[1438465723] linearizableReadLoop","detail":"{readStateIndex:1001; appliedIndex:1001; }","duration":"633.885519ms","start":"2026-04-20T02:06:28.679892Z","end":"2026-04-20T02:06:29.313778Z","steps":["trace[1438465723] 'read index received' (duration: 633.880309ms)","trace[1438465723] 'applied index is now lower than readState.Index' (duration: 4.02µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:06:29.314013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"634.119934ms","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-04-20T02:06:29.314041Z","caller":"traceutil/trace.go:171","msg":"trace[347686393] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:966; }","duration":"634.187926ms","start":"2026-04-20T02:06:28.679846Z","end":"2026-04-20T02:06:29.314034Z","steps":["trace[347686393] 'agreement among raft nodes before linearized reading' (duration: 634.001572ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:29.314065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:28.679827Z","time spent":"634.233576ms","remote":"127.0.0.1:33558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-20T02:06:29.314396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.695554ms","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:06:29.31453Z","caller":"traceutil/trace.go:171","msg":"trace[261093405] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:966; }","duration":"616.911789ms","start":"2026-04-20T02:06:28.697584Z","end":"2026-04-20T02:06:29.314495Z","steps":["trace[261093405] 'agreement among raft nodes before linearized reading' (duration: 616.407997ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:29.314606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:28.697567Z","time spent":"617.025772ms","remote":"127.0.0.1:33558","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":"warn","ts":"2026-04-20T02:06:29.547408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.87535ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T02:06:29.547678Z","caller":"traceutil/trace.go:171","msg":"trace[1816580668] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"227.841312ms","start":"2026-04-20T02:06:29.319812Z","end":"2026-04-20T02:06:29.547653Z","steps":["trace[1816580668] 'process raft request' (duration: 227.74114ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:29.548102Z","caller":"traceutil/trace.go:171","msg":"trace[353871258] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"229.57841ms","start":"2026-04-20T02:06:29.318087Z","end":"2026-04-20T02:06:29.547665Z","steps":["trace[353871258] 'process raft request' (duration: 35.327162ms)","trace[353871258] 'compare' (duration: 193.661545ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:06:51.908354Z","caller":"traceutil/trace.go:171","msg":"trace[1142897793] linearizableReadLoop","detail":"{readStateIndex:1080; appliedIndex:1079; }","duration":"263.891639ms","start":"2026-04-20T02:06:51.644443Z","end":"2026-04-20T02:06:51.908334Z","steps":["trace[1142897793] 'read index received' (duration: 263.755316ms)","trace[1142897793] 'applied index is now lower than readState.Index' (duration: 135.543µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:06:51.908453Z","caller":"traceutil/trace.go:171","msg":"trace[1592645441] transaction","detail":"{read_only:false; response_revision:1040; number_of_response:1; }","duration":"532.232379ms","start":"2026-04-20T02:06:51.376213Z","end":"2026-04-20T02:06:51.908445Z","steps":["trace[1592645441] 'process raft request' (duration: 531.987683ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:51.908541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:51.376188Z","time spent":"532.2862ms","remote":"127.0.0.1:33558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:06:51.908768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.463067ms","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:06:51.908873Z","caller":"traceutil/trace.go:171","msg":"trace[1047518236] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1040; }","duration":"262.611721ms","start":"2026-04-20T02:06:51.646238Z","end":"2026-04-20T02:06:51.908849Z","steps":["trace[1047518236] 'agreement among raft nodes before linearized reading' (duration: 262.372826ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:51.908885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.447561ms","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-04-20T02:06:51.908924Z","caller":"traceutil/trace.go:171","msg":"trace[1351664767] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1040; }","duration":"264.523603ms","start":"2026-04-20T02:06:51.644394Z","end":"2026-04-20T02:06:51.908917Z","steps":["trace[1351664767] 'agreement among raft nodes before linearized reading' (duration: 264.416191ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:51.909163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.783818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:06:51.909287Z","caller":"traceutil/trace.go:171","msg":"trace[1424535681] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1040; }","duration":"222.939671ms","start":"2026-04-20T02:06:51.686322Z","end":"2026-04-20T02:06:51.909262Z","steps":["trace[1424535681] 'agreement among raft nodes before linearized reading' (duration: 222.685995ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:52.082878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.25813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:06:52.083128Z","caller":"traceutil/trace.go:171","msg":"trace[1662848589] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1040; }","duration":"170.554847ms","start":"2026-04-20T02:06:51.91255Z","end":"2026-04-20T02:06:52.083105Z","steps":["trace[1662848589] 'range keys from in-memory index tree' (duration: 170.180787ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:52.116757Z","caller":"traceutil/trace.go:171","msg":"trace[945391819] transaction","detail":"{read_only:false; response_revision:1041; number_of_response:1; }","duration":"203.201938ms","start":"2026-04-20T02:06:51.913534Z","end":"2026-04-20T02:06:52.116736Z","steps":["trace[945391819] 'process raft request' (duration: 203.062955ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:52.129539Z","caller":"traceutil/trace.go:171","msg":"trace[1767722041] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"215.78505ms","start":"2026-04-20T02:06:51.913743Z","end":"2026-04-20T02:06:52.129528Z","steps":["trace[1767722041] 'process raft request' (duration: 215.691648ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:54.489775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.735922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T02:06:54.489894Z","caller":"traceutil/trace.go:171","msg":"trace[2121118247] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1048; }","duration":"249.834694ms","start":"2026-04-20T02:06:54.239996Z","end":"2026-04-20T02:06:54.489831Z","steps":["trace[2121118247] 'count revisions from in-memory index tree' (duration: 249.66739ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:54.489974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.085177ms","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:06:54.490058Z","caller":"traceutil/trace.go:171","msg":"trace[1534078926] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1048; }","duration":"216.22735ms","start":"2026-04-20T02:06:54.273811Z","end":"2026-04-20T02:06:54.490038Z","steps":["trace[1534078926] 'range keys from in-memory index tree' (duration: 215.912523ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:54.489759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.005013ms","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-04-20T02:06:54.491059Z","caller":"traceutil/trace.go:171","msg":"trace[1553004727] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1048; }","duration":"212.16473ms","start":"2026-04-20T02:06:54.278696Z","end":"2026-04-20T02:06:54.490861Z","steps":["trace[1553004727] 'range keys from in-memory index tree' (duration: 210.827139ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:55.221774Z","caller":"traceutil/trace.go:171","msg":"trace[536156055] linearizableReadLoop","detail":"{readStateIndex:1092; appliedIndex:1091; }","duration":"177.703127ms","start":"2026-04-20T02:06:55.044041Z","end":"2026-04-20T02:06:55.221744Z","steps":["trace[536156055] 'read index received' (duration: 177.616945ms)","trace[536156055] 'applied index is now lower than readState.Index' (duration: 84.972µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:06:55.221949Z","caller":"traceutil/trace.go:171","msg":"trace[1677445632] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"181.571514ms","start":"2026-04-20T02:06:55.0403Z","end":"2026-04-20T02:06:55.221871Z","steps":["trace[1677445632] 'process raft request' (duration: 181.281267ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:55.2221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.879001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:06:55.222393Z","caller":"traceutil/trace.go:171","msg":"trace[411659652] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1052; }","duration":"178.349351ms","start":"2026-04-20T02:06:55.044025Z","end":"2026-04-20T02:06:55.222375Z","steps":["trace[411659652] 'agreement among raft nodes before linearized reading' (duration: 177.830019ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:55.454669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.659175ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-20T02:06:55.454788Z","caller":"traceutil/trace.go:171","msg":"trace[69619885] linearizableReadLoop","detail":"{readStateIndex:1093; appliedIndex:1092; }","duration":"230.538521ms","start":"2026-04-20T02:06:55.224229Z","end":"2026-04-20T02:06:55.454768Z","steps":["trace[69619885] 'read index received' (duration: 11.669601ms)","trace[69619885] 'applied index is now lower than readState.Index' (duration: 218.86705ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:06:55.454885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.646083ms","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":"info","ts":"2026-04-20T02:06:55.454922Z","caller":"traceutil/trace.go:171","msg":"trace[773607274] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1052; }","duration":"230.739366ms","start":"2026-04-20T02:06:55.224172Z","end":"2026-04-20T02:06:55.454911Z","steps":["trace[773607274] 'agreement among raft nodes before linearized reading' (duration: 230.649314ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:07:06.206089Z","caller":"traceutil/trace.go:171","msg":"trace[1268221800] linearizableReadLoop","detail":"{readStateIndex:1182; appliedIndex:1181; }","duration":"174.85622ms","start":"2026-04-20T02:07:06.031215Z","end":"2026-04-20T02:07:06.206071Z","steps":["trace[1268221800] 'read index received' (duration: 174.661006ms)","trace[1268221800] 'applied index is now lower than readState.Index' (duration: 194.604µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:07:06.206149Z","caller":"traceutil/trace.go:171","msg":"trace[1529229603] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"236.707428ms","start":"2026-04-20T02:07:05.969408Z","end":"2026-04-20T02:07:06.206116Z","steps":["trace[1529229603] 'process raft request' (duration: 236.543105ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:06.206248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.998423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T02:07:06.20634Z","caller":"traceutil/trace.go:171","msg":"trace[1940023285] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1137; }","duration":"175.141786ms","start":"2026-04-20T02:07:06.031177Z","end":"2026-04-20T02:07:06.206319Z","steps":["trace[1940023285] 'agreement among raft nodes before linearized reading' (duration: 174.966852ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:07:20.528717Z","caller":"traceutil/trace.go:171","msg":"trace[741214756] transaction","detail":"{read_only:false; response_revision:1185; number_of_response:1; }","duration":"148.685643ms","start":"2026-04-20T02:07:20.380012Z","end":"2026-04-20T02:07:20.528698Z","steps":["trace[741214756] 'process raft request' (duration: 148.663253ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:07:20.528915Z","caller":"traceutil/trace.go:171","msg":"trace[1171114938] transaction","detail":"{read_only:false; response_revision:1184; number_of_response:1; }","duration":"148.866278ms","start":"2026-04-20T02:07:20.380017Z","end":"2026-04-20T02:07:20.528883Z","steps":["trace[1171114938] 'process raft request' (duration: 148.567371ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:07:20.999684Z","caller":"traceutil/trace.go:171","msg":"trace[1811629926] transaction","detail":"{read_only:false; response_revision:1187; number_of_response:1; }","duration":"297.566621ms","start":"2026-04-20T02:07:20.70209Z","end":"2026-04-20T02:07:20.999656Z","steps":["trace[1811629926] 'process raft request' (duration: 297.410237ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:25.884348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"744.252494ms","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:07:25.884433Z","caller":"traceutil/trace.go:171","msg":"trace[1393336679] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1219; }","duration":"744.350026ms","start":"2026-04-20T02:07:25.140071Z","end":"2026-04-20T02:07:25.884421Z","steps":["trace[1393336679] 'range keys from in-memory index tree' (duration: 744.239333ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:25.884441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"873.403183ms","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-04-20T02:07:25.884523Z","caller":"traceutil/trace.go:171","msg":"trace[1056893358] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1219; }","duration":"873.562126ms","start":"2026-04-20T02:07:25.010941Z","end":"2026-04-20T02:07:25.884504Z","steps":["trace[1056893358] 'range keys from in-memory index tree' (duration: 873.211158ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:25.884556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"830.482016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T02:07:25.884563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:07:25.010914Z","time spent":"873.639728ms","remote":"127.0.0.1:33558","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-04-20T02:07:25.884577Z","caller":"traceutil/trace.go:171","msg":"trace[78274227] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1219; }","duration":"830.542717ms","start":"2026-04-20T02:07:25.054025Z","end":"2026-04-20T02:07:25.884568Z","steps":["trace[78274227] 'count revisions from in-memory index tree' (duration: 830.370973ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:25.884602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:07:25.054005Z","time spent":"830.589808ms","remote":"127.0.0.1:33464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"warn","ts":"2026-04-20T02:07:25.884709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"845.749046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-20T02:07:25.884794Z","caller":"traceutil/trace.go:171","msg":"trace[1319700282] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1219; }","duration":"845.88803ms","start":"2026-04-20T02:07:25.038888Z","end":"2026-04-20T02:07:25.884776Z","steps":["trace[1319700282] 'range keys from in-memory index tree' (duration: 845.547382ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:25.884856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:07:25.038867Z","time spent":"845.965601ms","remote":"127.0.0.1:33558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-20T02:07:26.061126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.003266ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-20T02:07:26.061365Z","caller":"traceutil/trace.go:171","msg":"trace[187063877] linearizableReadLoop","detail":"{readStateIndex:1268; appliedIndex:1267; }","duration":"798.508383ms","start":"2026-04-20T02:07:25.262824Z","end":"2026-04-20T02:07:26.061332Z","steps":["trace[187063877] 'read index received' (duration: 296.267382ms)","trace[187063877] 'applied index is now lower than readState.Index' (duration: 502.237591ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:07:26.061419Z","caller":"traceutil/trace.go:171","msg":"trace[766336936] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"425.249545ms","start":"2026-04-20T02:07:25.636147Z","end":"2026-04-20T02:07:26.061396Z","steps":["trace[766336936] 'process raft request' (duration: 425.060631ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:07:26.061402Z","caller":"traceutil/trace.go:171","msg":"trace[1899548200] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"173.755462ms","start":"2026-04-20T02:07:25.887624Z","end":"2026-04-20T02:07:26.06138Z","steps":["trace[1899548200] 'process raft request' (duration: 173.67692ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:26.061555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:07:25.636123Z","time spent":"425.356358ms","remote":"127.0.0.1:33558","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-04-20T02:07:26.061641Z","caller":"traceutil/trace.go:171","msg":"trace[1485537695] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"169.368554ms","start":"2026-04-20T02:07:25.892235Z","end":"2026-04-20T02:07:26.061603Z","steps":["trace[1485537695] 'process raft request' (duration: 169.121268ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:26.061702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.099682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:07:26.061744Z","caller":"traceutil/trace.go:171","msg":"trace[812050957] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1222; }","duration":"337.185054ms","start":"2026-04-20T02:07:25.724546Z","end":"2026-04-20T02:07:26.061732Z","steps":["trace[812050957] 'agreement among raft nodes before linearized reading' (duration: 337.131362ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:26.061766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.244493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T02:07:26.061785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:07:25.724515Z","time spent":"337.260526ms","remote":"127.0.0.1:59960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-20T02:07:26.061837Z","caller":"traceutil/trace.go:171","msg":"trace[1114223032] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1222; }","duration":"371.361535ms","start":"2026-04-20T02:07:25.690457Z","end":"2026-04-20T02:07:26.061819Z","steps":["trace[1114223032] 'agreement among raft nodes before linearized reading' (duration: 371.254433ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:26.06186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"799.019616ms","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":"warn","ts":"2026-04-20T02:07:26.06188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:07:25.690437Z","time spent":"371.435288ms","remote":"127.0.0.1:33324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-20T02:07:26.061902Z","caller":"traceutil/trace.go:171","msg":"trace[2096955303] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1222; }","duration":"799.113667ms","start":"2026-04-20T02:07:25.262776Z","end":"2026-04-20T02:07:26.06189Z","steps":["trace[2096955303] 'agreement among raft nodes before linearized reading' (duration: 798.657026ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:26.061945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:07:25.262757Z","time spent":"799.177419ms","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"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:26.061652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.175619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:07:26.062095Z","caller":"traceutil/trace.go:171","msg":"trace[918658790] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1222; }","duration":"655.680711ms","start":"2026-04-20T02:07:25.406403Z","end":"2026-04-20T02:07:26.062084Z","steps":["trace[918658790] 'agreement among raft nodes before linearized reading' (duration: 655.149259ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:26.062141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:07:25.406379Z","time spent":"655.749712ms","remote":"127.0.0.1:60036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"info","ts":"2026-04-20T02:07:27.175019Z","caller":"traceutil/trace.go:171","msg":"trace[745662890] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"434.326029ms","start":"2026-04-20T02:07:26.740664Z","end":"2026-04-20T02:07:27.17499Z","steps":["trace[745662890] 'process raft request' (duration: 434.144325ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:27.175228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:07:26.740648Z","time spent":"434.453881ms","remote":"127.0.0.1:33558","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-04-20T02:07:28.178537Z","caller":"traceutil/trace.go:171","msg":"trace[1969659278] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"106.380831ms","start":"2026-04-20T02:07:28.072133Z","end":"2026-04-20T02:07:28.178514Z","steps":["trace[1969659278] 'process raft request' (duration: 106.252418ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:07:29.004252Z","caller":"traceutil/trace.go:171","msg":"trace[1649791231] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"342.458461ms","start":"2026-04-20T02:07:28.661773Z","end":"2026-04-20T02:07:29.004232Z","steps":["trace[1649791231] 'process raft request' (duration: 342.302028ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:29.004397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:07:28.661756Z","time spent":"342.563863ms","remote":"127.0.0.1:33558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:07:29.040221Z","caller":"traceutil/trace.go:171","msg":"trace[1761541453] linearizableReadLoop","detail":"{readStateIndex:1287; appliedIndex:1285; }","duration":"349.541089ms","start":"2026-04-20T02:07:28.690651Z","end":"2026-04-20T02:07:29.040192Z","steps":["trace[1761541453] 'read index received' (duration: 313.411664ms)","trace[1761541453] 'applied index is now lower than readState.Index' (duration: 36.128175ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:07:29.040417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.742463ms","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:29.040477Z","caller":"traceutil/trace.go:171","msg":"trace[16451813] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1238; }","duration":"349.842606ms","start":"2026-04-20T02:07:28.69062Z","end":"2026-04-20T02:07:29.040463Z","steps":["trace[16451813] 'agreement among raft nodes before linearized reading' (duration: 349.693633ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:29.040507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:07:28.690603Z","time spent":"349.899467ms","remote":"127.0.0.1:33324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-20T02:07:29.040449Z","caller":"traceutil/trace.go:171","msg":"trace[608102279] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"378.403262ms","start":"2026-04-20T02:07:28.661986Z","end":"2026-04-20T02:07:29.040389Z","steps":["trace[608102279] 'process raft request' (duration: 378.048505ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:29.040844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:07:28.661968Z","time spent":"378.649037ms","remote":"127.0.0.1:33558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:07:29.526182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.19881ms","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:07:29.526258Z","caller":"traceutil/trace.go:171","msg":"trace[1423474929] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1238; }","duration":"344.344263ms","start":"2026-04-20T02:07:29.181897Z","end":"2026-04-20T02:07:29.526241Z","steps":["trace[1423474929] 'range keys from in-memory index tree' (duration: 344.020495ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:29.52645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:07:29.181876Z","time spent":"344.437014ms","remote":"127.0.0.1:33558","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":"warn","ts":"2026-04-20T02:07:38.567791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.560274ms","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-04-20T02:07:38.567895Z","caller":"traceutil/trace.go:171","msg":"trace[1996184637] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1305; }","duration":"355.692576ms","start":"2026-04-20T02:07:38.212178Z","end":"2026-04-20T02:07:38.56787Z","steps":["trace[1996184637] 'range keys from in-memory index tree' (duration: 355.424181ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:38.567951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:07:38.212167Z","time spent":"355.768878ms","remote":"127.0.0.1:33558","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":"warn","ts":"2026-04-20T02:07:38.567791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"705.600424ms","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":"warn","ts":"2026-04-20T02:07:38.568017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.565735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-20T02:07:38.568098Z","caller":"traceutil/trace.go:171","msg":"trace[885957358] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1305; }","duration":"360.707609ms","start":"2026-04-20T02:07:38.207367Z","end":"2026-04-20T02:07:38.568075Z","steps":["trace[885957358] 'range keys from in-memory index tree' (duration: 359.908431ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:38.568149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:07:38.207346Z","time spent":"360.78478ms","remote":"127.0.0.1:33558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-20T02:07:38.568103Z","caller":"traceutil/trace.go:171","msg":"trace[1899885617] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1305; }","duration":"705.914371ms","start":"2026-04-20T02:07:37.862131Z","end":"2026-04-20T02:07:38.568046Z","steps":["trace[1899885617] 'range keys from in-memory index tree' (duration: 705.481832ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:38.568254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:07:37.862109Z","time spent":"706.103516ms","remote":"127.0.0.1:33558","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":"info","ts":"2026-04-20T02:07:38.691266Z","caller":"traceutil/trace.go:171","msg":"trace[1718699767] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"117.5693ms","start":"2026-04-20T02:07:38.573669Z","end":"2026-04-20T02:07:38.691238Z","steps":["trace[1718699767] 'process raft request' (duration: 117.421627ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:07:38.691727Z","caller":"traceutil/trace.go:171","msg":"trace[1677222097] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"117.549549ms","start":"2026-04-20T02:07:38.574134Z","end":"2026-04-20T02:07:38.691684Z","steps":["trace[1677222097] 'process raft request' (duration: 117.057878ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:07:38.691915Z","caller":"traceutil/trace.go:171","msg":"trace[1555162089] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"118.893359ms","start":"2026-04-20T02:07:38.572988Z","end":"2026-04-20T02:07:38.691881Z","steps":["trace[1555162089] 'process raft request' (duration: 112.298843ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:10:47.848754Z","caller":"traceutil/trace.go:171","msg":"trace[231585694] transaction","detail":"{read_only:false; response_revision:2205; number_of_response:1; }","duration":"109.561038ms","start":"2026-04-20T02:10:47.739171Z","end":"2026-04-20T02:10:47.848732Z","steps":["trace[231585694] 'process raft request' (duration: 109.419845ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:10:47.867082Z","caller":"traceutil/trace.go:171","msg":"trace[961029085] transaction","detail":"{read_only:false; response_revision:2206; number_of_response:1; }","duration":"124.761338ms","start":"2026-04-20T02:10:47.742283Z","end":"2026-04-20T02:10:47.867044Z","steps":["trace[961029085] 'process raft request' (duration: 124.626995ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:10:48.028287Z","caller":"traceutil/trace.go:171","msg":"trace[204444933] transaction","detail":"{read_only:false; response_revision:2207; number_of_response:1; }","duration":"156.954694ms","start":"2026-04-20T02:10:47.871285Z","end":"2026-04-20T02:10:48.028239Z","steps":["trace[204444933] 'process raft request' (duration: 84.682865ms)","trace[204444933] 'compare' (duration: 71.990832ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:10:48.028406Z","caller":"traceutil/trace.go:171","msg":"trace[1207826090] transaction","detail":"{read_only:false; response_revision:2208; number_of_response:1; }","duration":"155.118223ms","start":"2026-04-20T02:10:47.873262Z","end":"2026-04-20T02:10:48.02838Z","steps":["trace[1207826090] 'process raft request' (duration: 154.895578ms)"],"step_count":1}