{"level":"warn","ts":"2026-05-14T14:22:16.413941Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-14T14:22:16.414022Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.129: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.129:2380","--initial-cluster=instance=https://199.204.45.129:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.129:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.129:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-14T14:22:16.414084Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-14T14:22:16.414097Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-05-14T14:22:16.414115Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-14T14:22:16.414694Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"]} {"level":"info","ts":"2026-05-14T14:22:16.414764Z","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.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.129:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-14T14:22:16.421379Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.418787ms"} {"level":"info","ts":"2026-05-14T14:22:16.427588Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3cec112083e8d3ff","cluster-id":"3f68255a3b440659"} {"level":"info","ts":"2026-05-14T14:22:16.427683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=()"} {"level":"info","ts":"2026-05-14T14:22:16.427703Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 0"} {"level":"info","ts":"2026-05-14T14:22:16.427716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3cec112083e8d3ff [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-14T14:22:16.427729Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 1"} {"level":"info","ts":"2026-05-14T14:22:16.427766Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"warn","ts":"2026-05-14T14:22:16.434476Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-14T14:22:16.436102Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-14T14:22:16.437763Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-14T14:22:16.439592Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3cec112083e8d3ff","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-14T14:22:16.439709Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-14T14:22:16.43982Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-14T14:22:16.439831Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-14T14:22:16.440888Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3cec112083e8d3ff","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-14T14:22:16.441292Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"info","ts":"2026-05-14T14:22:16.44147Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","added-peer-id":"3cec112083e8d3ff","added-peer-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-05-14T14:22:16.44736Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-14T14:22:16.447537Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-05-14T14:22:16.447568Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3cec112083e8d3ff","initial-advertise-peer-urls":["https://199.204.45.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-14T14:22:16.447581Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-05-14T14:22:16.447609Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-14T14:22:16.827958Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff is starting a new election at term 1"} {"level":"info","ts":"2026-05-14T14:22:16.828017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became pre-candidate at term 1"} {"level":"info","ts":"2026-05-14T14:22:16.828051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgPreVoteResp from 3cec112083e8d3ff at term 1"} {"level":"info","ts":"2026-05-14T14:22:16.828071Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became candidate at term 2"} {"level":"info","ts":"2026-05-14T14:22:16.828087Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgVoteResp from 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-05-14T14:22:16.828106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became leader at term 2"} {"level":"info","ts":"2026-05-14T14:22:16.828127Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3cec112083e8d3ff elected leader 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-05-14T14:22:16.829514Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-14T14:22:16.829725Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-14T14:22:16.829708Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3cec112083e8d3ff","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.129:2379]}","request-path":"/0/members/3cec112083e8d3ff/attributes","cluster-id":"3f68255a3b440659","publish-timeout":"7s"} {"level":"info","ts":"2026-05-14T14:22:16.829753Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-14T14:22:16.829932Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-14T14:22:16.829993Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-14T14:22:16.830922Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","cluster-version":"3.5"} {"level":"info","ts":"2026-05-14T14:22:16.831004Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-14T14:22:16.831048Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-14T14:22:16.833368Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.129:2379"} {"level":"info","ts":"2026-05-14T14:22:16.836016Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-14T14:22:19.337018Z","caller":"traceutil/trace.go:171","msg":"trace[1027173351] transaction","detail":"{read_only:false; response_revision:74; number_of_response:1; }","duration":"100.653536ms","start":"2026-05-14T14:22:19.236317Z","end":"2026-05-14T14:22:19.33697Z","steps":["trace[1027173351] 'process raft request' (duration: 100.446644ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:19.528799Z","caller":"traceutil/trace.go:171","msg":"trace[1716763532] transaction","detail":"{read_only:false; response_revision:77; number_of_response:1; }","duration":"148.132435ms","start":"2026-05-14T14:22:19.380627Z","end":"2026-05-14T14:22:19.528759Z","steps":["trace[1716763532] 'process raft request' (duration: 62.863527ms)","trace[1716763532] 'compare' (duration: 85.083286ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T14:22:20.061168Z","caller":"traceutil/trace.go:171","msg":"trace[626820810] transaction","detail":"{read_only:false; response_revision:83; number_of_response:1; }","duration":"312.253641ms","start":"2026-05-14T14:22:19.748882Z","end":"2026-05-14T14:22:20.061136Z","steps":["trace[626820810] 'process raft request' (duration: 225.630473ms)","trace[626820810] 'compare' (duration: 86.457296ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T14:22:20.061769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:19.748851Z","time spent":"312.409043ms","remote":"127.0.0.1:51324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2012,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-14T14:22:20.24155Z","caller":"traceutil/trace.go:171","msg":"trace[727142891] transaction","detail":"{read_only:false; response_revision:86; number_of_response:1; }","duration":"123.539225ms","start":"2026-05-14T14:22:20.117979Z","end":"2026-05-14T14:22:20.241518Z","steps":["trace[727142891] 'process raft request' (duration: 65.097766ms)","trace[727142891] 'compare' (duration: 58.285847ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T14:22:20.801133Z","caller":"traceutil/trace.go:171","msg":"trace[52404718] linearizableReadLoop","detail":"{readStateIndex:99; appliedIndex:98; }","duration":"403.560031ms","start":"2026-05-14T14:22:20.397546Z","end":"2026-05-14T14:22:20.801106Z","steps":["trace[52404718] 'read index received' (duration: 391.345556ms)","trace[52404718] 'applied index is now lower than readState.Index' (duration: 12.213225ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T14:22:20.801292Z","caller":"traceutil/trace.go:171","msg":"trace[2002791435] transaction","detail":"{read_only:false; response_revision:95; number_of_response:1; }","duration":"410.618953ms","start":"2026-05-14T14:22:20.390605Z","end":"2026-05-14T14:22:20.801224Z","steps":["trace[2002791435] 'process raft request' (duration: 398.348188ms)","trace[2002791435] 'compare' (duration: 12.019603ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T14:22:20.801371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.782833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-05-14T14:22:20.801459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:20.39059Z","time spent":"410.803265ms","remote":"127.0.0.1:51324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":799,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-14T14:22:20.801613Z","caller":"traceutil/trace.go:171","msg":"trace[1257640706] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:95; }","duration":"403.953175ms","start":"2026-05-14T14:22:20.397529Z","end":"2026-05-14T14:22:20.801482Z","steps":["trace[1257640706] 'agreement among raft nodes before linearized reading' (duration: 403.704013ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:20.801666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:20.39746Z","time spent":"404.195138ms","remote":"127.0.0.1:51252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-14T14:22:21.815934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.064285ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-14T14:22:21.816064Z","caller":"traceutil/trace.go:171","msg":"trace[1292084709] linearizableReadLoop","detail":"{readStateIndex:120; appliedIndex:119; }","duration":"469.635612ms","start":"2026-05-14T14:22:21.346407Z","end":"2026-05-14T14:22:21.816043Z","steps":["trace[1292084709] 'read index received' (duration: 114.124802ms)","trace[1292084709] 'applied index is now lower than readState.Index' (duration: 355.50901ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T14:22:21.816107Z","caller":"traceutil/trace.go:171","msg":"trace[2076696970] transaction","detail":"{read_only:false; response_revision:116; number_of_response:1; }","duration":"620.114884ms","start":"2026-05-14T14:22:21.195967Z","end":"2026-05-14T14:22:21.816081Z","steps":["trace[2076696970] 'process raft request' (duration: 264.616885ms)","trace[2076696970] 'compare' (duration: 354.827673ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T14:22:21.816226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:21.195951Z","time spent":"620.212105ms","remote":"127.0.0.1:51324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":867,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-14T14:22:21.816427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.004746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-14T14:22:21.816527Z","caller":"traceutil/trace.go:171","msg":"trace[655118966] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:116; }","duration":"470.151288ms","start":"2026-05-14T14:22:21.346359Z","end":"2026-05-14T14:22:21.81651Z","steps":["trace[655118966] 'agreement among raft nodes before linearized reading' (duration: 469.977576ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:21.816576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:21.346338Z","time spent":"470.223728ms","remote":"127.0.0.1:50934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-14T14:22:21.816675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.625903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-14T14:22:21.816755Z","caller":"traceutil/trace.go:171","msg":"trace[1290753482] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:116; }","duration":"259.761895ms","start":"2026-05-14T14:22:21.556971Z","end":"2026-05-14T14:22:21.816733Z","steps":["trace[1290753482] 'agreement among raft nodes before linearized reading' (duration: 259.635204ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:21.978062Z","caller":"traceutil/trace.go:171","msg":"trace[762550068] transaction","detail":"{read_only:false; response_revision:119; number_of_response:1; }","duration":"124.595048ms","start":"2026-05-14T14:22:21.85344Z","end":"2026-05-14T14:22:21.978035Z","steps":["trace[762550068] 'process raft request' (duration: 124.415627ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:21.978147Z","caller":"traceutil/trace.go:171","msg":"trace[808240406] transaction","detail":"{read_only:false; response_revision:118; number_of_response:1; }","duration":"156.913368ms","start":"2026-05-14T14:22:21.821202Z","end":"2026-05-14T14:22:21.978116Z","steps":["trace[808240406] 'process raft request' (duration: 143.145988ms)","trace[808240406] 'compare' (duration: 13.346926ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T14:22:22.842105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.646598ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-14T14:22:22.842511Z","caller":"traceutil/trace.go:171","msg":"trace[1275656483] transaction","detail":"{read_only:false; response_revision:134; number_of_response:1; }","duration":"212.212668ms","start":"2026-05-14T14:22:22.630279Z","end":"2026-05-14T14:22:22.842492Z","steps":["trace[1275656483] 'process raft request' (duration: 211.940266ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:22.842609Z","caller":"traceutil/trace.go:171","msg":"trace[234927736] transaction","detail":"{read_only:false; response_revision:133; number_of_response:1; }","duration":"288.781274ms","start":"2026-05-14T14:22:22.553808Z","end":"2026-05-14T14:22:22.842589Z","steps":["trace[234927736] 'process raft request' (duration: 118.584511ms)","trace[234927736] 'compare' (duration: 169.446246ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T14:22:23.125092Z","caller":"traceutil/trace.go:171","msg":"trace[547400562] transaction","detail":"{read_only:false; response_revision:136; number_of_response:1; }","duration":"277.98117ms","start":"2026-05-14T14:22:22.847079Z","end":"2026-05-14T14:22:23.12506Z","steps":["trace[547400562] 'process raft request' (duration: 207.52934ms)","trace[547400562] 'compare' (duration: 70.306069ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T14:22:23.82567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"600.714155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:ttl-after-finished-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T14:22:23.825759Z","caller":"traceutil/trace.go:171","msg":"trace[34390767] range","detail":"{range_begin:/registry/clusterroles/system:controller:ttl-after-finished-controller; range_end:; response_count:0; response_revision:140; }","duration":"600.871146ms","start":"2026-05-14T14:22:23.224869Z","end":"2026-05-14T14:22:23.82574Z","steps":["trace[34390767] 'range keys from in-memory index tree' (duration: 600.633174ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:23.825763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.136853ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-05-14T14:22:23.825835Z","caller":"traceutil/trace.go:171","msg":"trace[1913544900] linearizableReadLoop","detail":"{readStateIndex:145; appliedIndex:144; }","duration":"380.115371ms","start":"2026-05-14T14:22:23.445711Z","end":"2026-05-14T14:22:23.825827Z","steps":["trace[1913544900] 'read index received' (duration: 236.845227ms)","trace[1913544900] 'applied index is now lower than readState.Index' (duration: 143.269464ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T14:22:23.825881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.172281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T14:22:23.825899Z","caller":"traceutil/trace.go:171","msg":"trace[1355698394] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:140; }","duration":"380.231222ms","start":"2026-05-14T14:22:23.445662Z","end":"2026-05-14T14:22:23.825893Z","steps":["trace[1355698394] 'agreement among raft nodes before linearized reading' (duration: 380.196452ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:23.825916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:23.445636Z","time spent":"380.275343ms","remote":"127.0.0.1:50934","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-05-14T14:22:23.825928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:23.305794Z","time spent":"520.123092ms","remote":"127.0.0.1:51004","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-14T14:22:23.8258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:23.224851Z","time spent":"600.941216ms","remote":"127.0.0.1:51324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/system:controller:ttl-after-finished-controller\" "} {"level":"info","ts":"2026-05-14T14:22:24.029617Z","caller":"traceutil/trace.go:171","msg":"trace[1885566881] transaction","detail":"{read_only:false; response_revision:143; number_of_response:1; }","duration":"117.380512ms","start":"2026-05-14T14:22:23.912204Z","end":"2026-05-14T14:22:24.029584Z","steps":["trace[1885566881] 'process raft request' (duration: 117.331772ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:24.029692Z","caller":"traceutil/trace.go:171","msg":"trace[1926147641] transaction","detail":"{read_only:false; response_revision:142; number_of_response:1; }","duration":"199.59713ms","start":"2026-05-14T14:22:23.83006Z","end":"2026-05-14T14:22:24.029657Z","steps":["trace[1926147641] 'process raft request' (duration: 124.431394ms)","trace[1926147641] 'compare' (duration: 74.888823ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T14:22:24.029776Z","caller":"traceutil/trace.go:171","msg":"trace[1373297383] linearizableReadLoop","detail":"{readStateIndex:147; appliedIndex:145; }","duration":"183.323806ms","start":"2026-05-14T14:22:23.846422Z","end":"2026-05-14T14:22:24.029746Z","steps":["trace[1373297383] 'read index received' (duration: 60.896703ms)","trace[1373297383] 'applied index is now lower than readState.Index' (duration: 122.424233ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T14:22:24.030035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.59865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T14:22:24.030074Z","caller":"traceutil/trace.go:171","msg":"trace[1670816048] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:143; }","duration":"183.69207ms","start":"2026-05-14T14:22:23.846372Z","end":"2026-05-14T14:22:24.030064Z","steps":["trace[1670816048] 'agreement among raft nodes before linearized reading' (duration: 183.531479ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:24.296068Z","caller":"traceutil/trace.go:171","msg":"trace[1455135230] transaction","detail":"{read_only:false; response_revision:146; number_of_response:1; }","duration":"260.888477ms","start":"2026-05-14T14:22:24.035151Z","end":"2026-05-14T14:22:24.29604Z","steps":["trace[1455135230] 'process raft request' (duration: 260.820076ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:24.29624Z","caller":"traceutil/trace.go:171","msg":"trace[1181804696] transaction","detail":"{read_only:false; response_revision:145; number_of_response:1; }","duration":"261.743715ms","start":"2026-05-14T14:22:24.034364Z","end":"2026-05-14T14:22:24.296107Z","steps":["trace[1181804696] 'process raft request' (duration: 261.462023ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:24.530744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.801983ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-14T14:22:24.530913Z","caller":"traceutil/trace.go:171","msg":"trace[903155347] linearizableReadLoop","detail":"{readStateIndex:154; appliedIndex:153; }","duration":"178.219377ms","start":"2026-05-14T14:22:24.352669Z","end":"2026-05-14T14:22:24.530888Z","steps":["trace[903155347] 'read index received' (duration: 29.113712ms)","trace[903155347] 'applied index is now lower than readState.Index' (duration: 149.103955ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T14:22:24.530986Z","caller":"traceutil/trace.go:171","msg":"trace[2023607069] transaction","detail":"{read_only:false; response_revision:149; number_of_response:1; }","duration":"179.582052ms","start":"2026-05-14T14:22:24.351348Z","end":"2026-05-14T14:22:24.53093Z","steps":["trace[2023607069] 'process raft request' (duration: 30.480296ms)","trace[2023607069] 'compare' (duration: 148.56308ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T14:22:24.531204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.397799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:monitoring\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T14:22:24.531252Z","caller":"traceutil/trace.go:171","msg":"trace[969497344] range","detail":"{range_begin:/registry/clusterrolebindings/system:monitoring; range_end:; response_count:0; response_revision:149; }","duration":"178.612122ms","start":"2026-05-14T14:22:24.352627Z","end":"2026-05-14T14:22:24.531239Z","steps":["trace[969497344] 'agreement among raft nodes before linearized reading' (duration: 178.364159ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:24.549915Z","caller":"traceutil/trace.go:171","msg":"trace[1855334076] transaction","detail":"{read_only:false; response_revision:150; number_of_response:1; }","duration":"109.823462ms","start":"2026-05-14T14:22:24.440068Z","end":"2026-05-14T14:22:24.549891Z","steps":["trace[1855334076] 'process raft request' (duration: 109.63471ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:24.550319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.728501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T14:22:24.550379Z","caller":"traceutil/trace.go:171","msg":"trace[605076970] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:150; }","duration":"104.814502ms","start":"2026-05-14T14:22:24.44555Z","end":"2026-05-14T14:22:24.550364Z","steps":["trace[605076970] 'agreement among raft nodes before linearized reading' (duration: 104.449148ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:24.921815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.896877ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-14T14:22:24.921965Z","caller":"traceutil/trace.go:171","msg":"trace[29583880] transaction","detail":"{read_only:false; response_revision:151; number_of_response:1; }","duration":"387.415355ms","start":"2026-05-14T14:22:24.534512Z","end":"2026-05-14T14:22:24.921927Z","steps":["trace[29583880] 'process raft request' (duration: 111.326526ms)","trace[29583880] 'compare' (duration: 275.715045ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T14:22:24.922132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:24.534479Z","time spent":"387.562617ms","remote":"127.0.0.1:51328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":679,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-14T14:22:24.922191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.514236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18af748f0bc6f860\" ","response":"range_response_count:1 size:657"} {"level":"info","ts":"2026-05-14T14:22:24.922255Z","caller":"traceutil/trace.go:171","msg":"trace[1327589338] range","detail":"{range_begin:/registry/events/default/instance.18af748f0bc6f860; range_end:; response_count:1; response_revision:151; }","duration":"387.620077ms","start":"2026-05-14T14:22:24.534614Z","end":"2026-05-14T14:22:24.922234Z","steps":["trace[1327589338] 'agreement among raft nodes before linearized reading' (duration: 387.435935ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:24.92232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:24.534599Z","time spent":"387.695048ms","remote":"127.0.0.1:51004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":679,"request content":"key:\"/registry/events/default/instance.18af748f0bc6f860\" "} {"level":"info","ts":"2026-05-14T14:22:24.922444Z","caller":"traceutil/trace.go:171","msg":"trace[1297146431] linearizableReadLoop","detail":"{readStateIndex:156; appliedIndex:155; }","duration":"372.054802ms","start":"2026-05-14T14:22:24.549853Z","end":"2026-05-14T14:22:24.921908Z","steps":["trace[1297146431] 'read index received' (duration: 96.017703ms)","trace[1297146431] 'applied index is now lower than readState.Index' (duration: 276.035859ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T14:22:25.143428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.23492ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T14:22:25.143594Z","caller":"traceutil/trace.go:171","msg":"trace[1992586874] linearizableReadLoop","detail":"{readStateIndex:159; appliedIndex:156; }","duration":"198.159741ms","start":"2026-05-14T14:22:24.945418Z","end":"2026-05-14T14:22:25.143578Z","steps":["trace[1992586874] 'read index received' (duration: 25.233103ms)","trace[1992586874] 'applied index is now lower than readState.Index' (duration: 172.925608ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T14:22:25.143678Z","caller":"traceutil/trace.go:171","msg":"trace[751307756] transaction","detail":"{read_only:false; response_revision:154; number_of_response:1; }","duration":"215.964619ms","start":"2026-05-14T14:22:24.927705Z","end":"2026-05-14T14:22:25.14367Z","steps":["trace[751307756] 'process raft request' (duration: 215.807547ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:25.143776Z","caller":"traceutil/trace.go:171","msg":"trace[1262492663] transaction","detail":"{read_only:false; response_revision:153; number_of_response:1; }","duration":"216.193071ms","start":"2026-05-14T14:22:24.927555Z","end":"2026-05-14T14:22:25.143748Z","steps":["trace[1262492663] 'process raft request' (duration: 114.417576ms)","trace[1262492663] 'compare' (duration: 101.134429ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T14:22:25.143917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.494624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T14:22:25.143959Z","caller":"traceutil/trace.go:171","msg":"trace[1876691165] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:154; }","duration":"198.557834ms","start":"2026-05-14T14:22:24.94539Z","end":"2026-05-14T14:22:25.143947Z","steps":["trace[1876691165] 'agreement among raft nodes before linearized reading' (duration: 198.480274ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:25.144003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.15503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18af748f0bc72d4e\" ","response":"range_response_count:1 size:653"} {"level":"info","ts":"2026-05-14T14:22:25.144044Z","caller":"traceutil/trace.go:171","msg":"trace[1978353722] range","detail":"{range_begin:/registry/events/default/instance.18af748f0bc72d4e; range_end:; response_count:1; response_revision:154; }","duration":"170.23942ms","start":"2026-05-14T14:22:24.973794Z","end":"2026-05-14T14:22:25.144033Z","steps":["trace[1978353722] 'agreement among raft nodes before linearized reading' (duration: 170.152049ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:27.180902Z","caller":"traceutil/trace.go:171","msg":"trace[281286482] transaction","detail":"{read_only:false; response_revision:259; number_of_response:1; }","duration":"456.706369ms","start":"2026-05-14T14:22:26.724172Z","end":"2026-05-14T14:22:27.180878Z","steps":["trace[281286482] 'process raft request' (duration: 456.529748ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:27.181028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:26.724156Z","time spent":"456.81649ms","remote":"127.0.0.1:51036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1342,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-14T14:22:28.321338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.038244595s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T14:22:28.321476Z","caller":"traceutil/trace.go:171","msg":"trace[1131856483] transaction","detail":"{read_only:false; response_revision:262; number_of_response:1; }","duration":"1.040365696s","start":"2026-05-14T14:22:27.281099Z","end":"2026-05-14T14:22:28.321465Z","steps":["trace[1131856483] 'process raft request' (duration: 1.040314665s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:28.321507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:27.281065Z","time spent":"1.040430856s","remote":"127.0.0.1:51316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-14T14:22:28.321674Z","caller":"traceutil/trace.go:171","msg":"trace[110205076] transaction","detail":"{read_only:false; response_revision:261; number_of_response:1; }","duration":"1.136667178s","start":"2026-05-14T14:22:27.185001Z","end":"2026-05-14T14:22:28.321668Z","steps":["trace[110205076] 'process raft request' (duration: 98.0227ms)","trace[110205076] 'compare' (duration: 1.037623187s)"],"step_count":2} {"level":"warn","ts":"2026-05-14T14:22:28.321699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:27.184988Z","time spent":"1.136698038s","remote":"127.0.0.1:51252","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-05-14T14:22:28.321753Z","caller":"traceutil/trace.go:171","msg":"trace[2124701858] linearizableReadLoop","detail":"{readStateIndex:267; appliedIndex:265; }","duration":"1.11665326s","start":"2026-05-14T14:22:27.205094Z","end":"2026-05-14T14:22:28.321747Z","steps":["trace[2124701858] 'read index received' (duration: 70.850751ms)","trace[2124701858] 'applied index is now lower than readState.Index' (duration: 1.045801889s)"],"step_count":2} {"level":"warn","ts":"2026-05-14T14:22:28.321864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.116775291s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T14:22:28.32188Z","caller":"traceutil/trace.go:171","msg":"trace[1571905738] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:262; }","duration":"1.116847132s","start":"2026-05-14T14:22:27.205026Z","end":"2026-05-14T14:22:28.321873Z","steps":["trace[1571905738] 'agreement among raft nodes before linearized reading' (duration: 1.116817091s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:28.321896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:27.205014Z","time spent":"1.116877852s","remote":"127.0.0.1:51252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-14T14:22:28.322031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.988355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-14T14:22:28.322141Z","caller":"traceutil/trace.go:171","msg":"trace[223458154] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:262; }","duration":"231.123456ms","start":"2026-05-14T14:22:28.090978Z","end":"2026-05-14T14:22:28.322101Z","steps":["trace[223458154] 'agreement among raft nodes before linearized reading' (duration: 230.971064ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:28.322597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.121386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T14:22:28.32263Z","caller":"traceutil/trace.go:171","msg":"trace[2112537059] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:262; }","duration":"104.194876ms","start":"2026-05-14T14:22:28.218428Z","end":"2026-05-14T14:22:28.322623Z","steps":["trace[2112537059] 'agreement among raft nodes before linearized reading' (duration: 104.141655ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:30.44452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.461902884s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-14T14:22:30.444654Z","caller":"traceutil/trace.go:171","msg":"trace[19893848] transaction","detail":"{read_only:false; response_revision:263; number_of_response:1; }","duration":"2.118450018s","start":"2026-05-14T14:22:28.326167Z","end":"2026-05-14T14:22:30.444617Z","steps":["trace[19893848] 'process raft request' (duration: 656.378103ms)","trace[19893848] 'compare' (duration: 1.46154009s)"],"step_count":2} {"level":"warn","ts":"2026-05-14T14:22:30.444701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:28.326146Z","time spent":"2.118537489s","remote":"127.0.0.1:51252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-14T14:22:30.494709Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.511993353s","expected-duration":"1s"} {"level":"info","ts":"2026-05-14T14:22:30.495256Z","caller":"traceutil/trace.go:171","msg":"trace[1709566540] transaction","detail":"{read_only:false; response_revision:266; number_of_response:1; }","duration":"2.004356481s","start":"2026-05-14T14:22:28.490882Z","end":"2026-05-14T14:22:30.495238Z","steps":["trace[1709566540] 'process raft request' (duration: 2.00424659s)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:30.495255Z","caller":"traceutil/trace.go:171","msg":"trace[1153760095] transaction","detail":"{read_only:false; response_revision:265; number_of_response:1; }","duration":"2.166110584s","start":"2026-05-14T14:22:28.329113Z","end":"2026-05-14T14:22:30.495224Z","steps":["trace[1153760095] 'process raft request' (duration: 2.165957262s)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:30.495365Z","caller":"traceutil/trace.go:171","msg":"trace[140622387] transaction","detail":"{read_only:false; response_revision:264; number_of_response:1; }","duration":"2.16769637s","start":"2026-05-14T14:22:28.327642Z","end":"2026-05-14T14:22:30.495338Z","steps":["trace[140622387] 'process raft request' (duration: 2.167298146s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:30.495425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:28.490858Z","time spent":"2.004471632s","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3460,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T14:22:30.495427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:28.329105Z","time spent":"2.166232385s","remote":"127.0.0.1:51252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T14:22:30.495498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:28.327628Z","time spent":"2.167797131s","remote":"127.0.0.1:51252","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-05-14T14:22:30.495673Z","caller":"traceutil/trace.go:171","msg":"trace[80854408] linearizableReadLoop","detail":"{readStateIndex:272; appliedIndex:268; }","duration":"1.668939509s","start":"2026-05-14T14:22:28.826706Z","end":"2026-05-14T14:22:30.495646Z","steps":["trace[80854408] 'read index received' (duration: 155.990096ms)","trace[80854408] 'applied index is now lower than readState.Index' (duration: 1.512947513s)"],"step_count":2} {"level":"info","ts":"2026-05-14T14:22:30.495845Z","caller":"traceutil/trace.go:171","msg":"trace[539280542] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"1.590659977s","start":"2026-05-14T14:22:28.905169Z","end":"2026-05-14T14:22:30.495829Z","steps":["trace[539280542] 'process raft request' (duration: 1.590001661s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:30.495928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.669222661s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3474"} {"level":"info","ts":"2026-05-14T14:22:30.49599Z","caller":"traceutil/trace.go:171","msg":"trace[80268918] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:267; }","duration":"1.669317482s","start":"2026-05-14T14:22:28.826657Z","end":"2026-05-14T14:22:30.495975Z","steps":["trace[80268918] 'agreement among raft nodes before linearized reading' (duration: 1.669201681s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:30.496039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:28.826638Z","time spent":"1.669390142s","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3496,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-05-14T14:22:30.496151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:28.905128Z","time spent":"1.59080882s","remote":"127.0.0.1:51252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T14:22:30.500977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.933938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-14T14:22:30.501089Z","caller":"traceutil/trace.go:171","msg":"trace[430556541] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:268; }","duration":"172.099751ms","start":"2026-05-14T14:22:30.32896Z","end":"2026-05-14T14:22:30.50106Z","steps":["trace[430556541] 'agreement among raft nodes before linearized reading' (duration: 171.813868ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:34.730452Z","caller":"traceutil/trace.go:171","msg":"trace[1800229634] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"222.931703ms","start":"2026-05-14T14:22:34.507489Z","end":"2026-05-14T14:22:34.730421Z","steps":["trace[1800229634] 'process raft request' (duration: 222.246116ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:34.743777Z","caller":"traceutil/trace.go:171","msg":"trace[1956706468] linearizableReadLoop","detail":"{readStateIndex:368; appliedIndex:366; }","duration":"225.305246ms","start":"2026-05-14T14:22:34.518438Z","end":"2026-05-14T14:22:34.743743Z","steps":["trace[1956706468] 'read index received' (duration: 211.278151ms)","trace[1956706468] 'applied index is now lower than readState.Index' (duration: 14.025795ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T14:22:34.743862Z","caller":"traceutil/trace.go:171","msg":"trace[1122395500] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"231.972949ms","start":"2026-05-14T14:22:34.511859Z","end":"2026-05-14T14:22:34.743832Z","steps":["trace[1122395500] 'process raft request' (duration: 231.725867ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:34.744008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.552748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T14:22:34.744095Z","caller":"traceutil/trace.go:171","msg":"trace[1746046685] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/attachdetach-controller; range_end:; response_count:0; response_revision:352; }","duration":"225.674549ms","start":"2026-05-14T14:22:34.518399Z","end":"2026-05-14T14:22:34.744074Z","steps":["trace[1746046685] 'agreement among raft nodes before linearized reading' (duration: 225.497467ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:34.744028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.176584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-14T14:22:34.74443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.646529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-14T14:22:34.744486Z","caller":"traceutil/trace.go:171","msg":"trace[1786546028] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:352; }","duration":"199.72428ms","start":"2026-05-14T14:22:34.544747Z","end":"2026-05-14T14:22:34.744471Z","steps":["trace[1786546028] 'agreement among raft nodes before linearized reading' (duration: 199.619598ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:34.744518Z","caller":"traceutil/trace.go:171","msg":"trace[1818688185] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:352; }","duration":"200.550037ms","start":"2026-05-14T14:22:34.543782Z","end":"2026-05-14T14:22:34.744332Z","steps":["trace[1818688185] 'agreement among raft nodes before linearized reading' (duration: 200.168504ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:35.055422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.50546ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T14:22:35.055647Z","caller":"traceutil/trace.go:171","msg":"trace[8532881] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"301.750999ms","start":"2026-05-14T14:22:34.75388Z","end":"2026-05-14T14:22:35.055631Z","steps":["trace[8532881] 'process raft request' (duration: 301.692808ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:35.055712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:34.753874Z","time spent":"301.811359ms","remote":"127.0.0.1:51158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7096,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T14:22:35.055731Z","caller":"traceutil/trace.go:171","msg":"trace[1725476149] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"305.090631ms","start":"2026-05-14T14:22:34.75059Z","end":"2026-05-14T14:22:35.05568Z","steps":["trace[1725476149] 'process raft request' (duration: 304.92832ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:35.055935Z","caller":"traceutil/trace.go:171","msg":"trace[304914715] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"306.851798ms","start":"2026-05-14T14:22:34.74903Z","end":"2026-05-14T14:22:35.055882Z","steps":["trace[304914715] 'process raft request' (duration: 168.803633ms)","trace[304914715] 'compare' (duration: 137.359579ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T14:22:35.056015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:34.750577Z","time spent":"305.297753ms","remote":"127.0.0.1:51190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":197,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-14T14:22:35.056232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:34.749019Z","time spent":"307.09994ms","remote":"127.0.0.1:51252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T14:22:35.685161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.107951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"warn","ts":"2026-05-14T14:22:35.685231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.229203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-05-14T14:22:35.685265Z","caller":"traceutil/trace.go:171","msg":"trace[1791167160] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:375; }","duration":"166.275702ms","start":"2026-05-14T14:22:35.51897Z","end":"2026-05-14T14:22:35.685246Z","steps":["trace[1791167160] 'range keys from in-memory index tree' (duration: 165.945499ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:35.685341Z","caller":"traceutil/trace.go:171","msg":"trace[559660313] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:375; }","duration":"116.400585ms","start":"2026-05-14T14:22:35.568914Z","end":"2026-05-14T14:22:35.685315Z","steps":["trace[559660313] 'range keys from in-memory index tree' (duration: 116.094192ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:36.009434Z","caller":"traceutil/trace.go:171","msg":"trace[2008897883] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"316.791753ms","start":"2026-05-14T14:22:35.692611Z","end":"2026-05-14T14:22:36.009402Z","steps":["trace[2008897883] 'process raft request' (duration: 316.536481ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:36.009555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.529046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-05-14T14:22:36.009607Z","caller":"traceutil/trace.go:171","msg":"trace[1746060068] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:378; }","duration":"304.634617ms","start":"2026-05-14T14:22:35.704959Z","end":"2026-05-14T14:22:36.009593Z","steps":["trace[1746060068] 'agreement among raft nodes before linearized reading' (duration: 304.524126ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:36.009643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:35.704923Z","time spent":"304.712588ms","remote":"127.0.0.1:51352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":686,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-05-14T14:22:36.009674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:35.692588Z","time spent":"316.991645ms","remote":"127.0.0.1:51036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2163,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T14:22:36.009403Z","caller":"traceutil/trace.go:171","msg":"trace[88458589] linearizableReadLoop","detail":"{readStateIndex:394; appliedIndex:391; }","duration":"304.377455ms","start":"2026-05-14T14:22:35.705Z","end":"2026-05-14T14:22:36.009377Z","steps":["trace[88458589] 'read index received' (duration: 27.910868ms)","trace[88458589] 'applied index is now lower than readState.Index' (duration: 276.465547ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T14:22:36.009795Z","caller":"traceutil/trace.go:171","msg":"trace[1524563876] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"316.075047ms","start":"2026-05-14T14:22:35.693698Z","end":"2026-05-14T14:22:36.009773Z","steps":["trace[1524563876] 'process raft request' (duration: 315.631783ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:36.00989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:35.693687Z","time spent":"316.147307ms","remote":"127.0.0.1:51436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2150,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-14T14:22:36.3254Z","caller":"traceutil/trace.go:171","msg":"trace[1416733536] linearizableReadLoop","detail":"{readStateIndex:395; appliedIndex:394; }","duration":"315.633393ms","start":"2026-05-14T14:22:36.009737Z","end":"2026-05-14T14:22:36.32537Z","steps":["trace[1416733536] 'read index received' (duration: 315.38398ms)","trace[1416733536] 'applied index is now lower than readState.Index' (duration: 248.203µs)"],"step_count":2} {"level":"info","ts":"2026-05-14T14:22:36.325506Z","caller":"traceutil/trace.go:171","msg":"trace[267252773] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"588.977589ms","start":"2026-05-14T14:22:35.736478Z","end":"2026-05-14T14:22:36.325456Z","steps":["trace[267252773] 'process raft request' (duration: 588.699857ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:36.325605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.735072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-05-14T14:22:36.325674Z","caller":"traceutil/trace.go:171","msg":"trace[925670286] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:379; }","duration":"506.958264ms","start":"2026-05-14T14:22:35.8187Z","end":"2026-05-14T14:22:36.325658Z","steps":["trace[925670286] 'agreement among raft nodes before linearized reading' (duration: 506.759682ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:36.325732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:35.81868Z","time spent":"507.028495ms","remote":"127.0.0.1:51190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":217,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"warn","ts":"2026-05-14T14:22:36.325726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:35.736424Z","time spent":"589.214651ms","remote":"127.0.0.1:51190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":172,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-14T14:22:36.325845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.824051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-14T14:22:36.325894Z","caller":"traceutil/trace.go:171","msg":"trace[1027078763] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:379; }","duration":"606.918811ms","start":"2026-05-14T14:22:35.718964Z","end":"2026-05-14T14:22:36.325882Z","steps":["trace[1027078763] 'agreement among raft nodes before linearized reading' (duration: 606.561188ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:36.325938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:35.718951Z","time spent":"606.978852ms","remote":"127.0.0.1:51190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"warn","ts":"2026-05-14T14:22:36.326062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.231865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-05-14T14:22:36.326258Z","caller":"traceutil/trace.go:171","msg":"trace[1120336959] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:379; }","duration":"557.532149ms","start":"2026-05-14T14:22:35.768697Z","end":"2026-05-14T14:22:36.32623Z","steps":["trace[1120336959] 'agreement among raft nodes before linearized reading' (duration: 556.910393ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:36.326439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:35.768684Z","time spent":"557.70873ms","remote":"127.0.0.1:51190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":225,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"info","ts":"2026-05-14T14:22:36.342102Z","caller":"traceutil/trace.go:171","msg":"trace[1990834419] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"325.591967ms","start":"2026-05-14T14:22:36.016489Z","end":"2026-05-14T14:22:36.342081Z","steps":["trace[1990834419] 'process raft request' (duration: 325.411095ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:36.342314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:36.016459Z","time spent":"325.760299ms","remote":"127.0.0.1:51158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3378,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-14T14:22:36.342119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.558605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4369"} {"level":"info","ts":"2026-05-14T14:22:36.342468Z","caller":"traceutil/trace.go:171","msg":"trace[369093578] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:380; }","duration":"328.95712ms","start":"2026-05-14T14:22:36.013479Z","end":"2026-05-14T14:22:36.342437Z","steps":["trace[369093578] 'agreement among raft nodes before linearized reading' (duration: 328.521945ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:36.342535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:36.013442Z","time spent":"329.0766ms","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4391,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-05-14T14:22:36.565482Z","caller":"traceutil/trace.go:171","msg":"trace[936942681] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"212.306606ms","start":"2026-05-14T14:22:36.353152Z","end":"2026-05-14T14:22:36.565459Z","steps":["trace[936942681] 'process raft request' (duration: 212.116174ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:36.565883Z","caller":"traceutil/trace.go:171","msg":"trace[2142719480] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"212.510328ms","start":"2026-05-14T14:22:36.353329Z","end":"2026-05-14T14:22:36.565839Z","steps":["trace[2142719480] 'process raft request' (duration: 212.088364ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:36.56588Z","caller":"traceutil/trace.go:171","msg":"trace[1351084542] linearizableReadLoop","detail":"{readStateIndex:402; appliedIndex:396; }","duration":"222.399602ms","start":"2026-05-14T14:22:36.343418Z","end":"2026-05-14T14:22:36.565818Z","steps":["trace[1351084542] 'read index received' (duration: 55.687211ms)","trace[1351084542] 'applied index is now lower than readState.Index' (duration: 166.710751ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T14:22:36.566132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.687395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T14:22:36.566202Z","caller":"traceutil/trace.go:171","msg":"trace[333294580] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:387; }","duration":"222.820267ms","start":"2026-05-14T14:22:36.343365Z","end":"2026-05-14T14:22:36.566185Z","steps":["trace[333294580] 'agreement among raft nodes before linearized reading' (duration: 222.582095ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:37.150489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.848395ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-14T14:22:37.150769Z","caller":"traceutil/trace.go:171","msg":"trace[103348891] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"746.604268ms","start":"2026-05-14T14:22:36.404109Z","end":"2026-05-14T14:22:37.150713Z","steps":["trace[103348891] 'process raft request' (duration: 511.454541ms)","trace[103348891] 'compare' (duration: 234.688513ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T14:22:37.150837Z","caller":"traceutil/trace.go:171","msg":"trace[1153257689] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"745.945202ms","start":"2026-05-14T14:22:36.404839Z","end":"2026-05-14T14:22:37.150784Z","steps":["trace[1153257689] 'process raft request' (duration: 745.828981ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:37.150939Z","caller":"traceutil/trace.go:171","msg":"trace[1653042116] linearizableReadLoop","detail":"{readStateIndex:408; appliedIndex:404; }","duration":"584.974736ms","start":"2026-05-14T14:22:36.565957Z","end":"2026-05-14T14:22:37.150932Z","steps":["trace[1653042116] 'read index received' (duration: 349.602746ms)","trace[1653042116] 'applied index is now lower than readState.Index' (duration: 235.37118ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T14:22:37.150986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:36.404088Z","time spent":"746.78916ms","remote":"127.0.0.1:51190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":164,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-14T14:22:37.150939Z","caller":"traceutil/trace.go:171","msg":"trace[2037672424] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"746.088824ms","start":"2026-05-14T14:22:36.404762Z","end":"2026-05-14T14:22:37.150851Z","steps":["trace[2037672424] 'process raft request' (duration: 745.823531ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:37.151096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:36.40483Z","time spent":"746.141714ms","remote":"127.0.0.1:51004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-14T14:22:37.151139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.470792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T14:22:37.151193Z","caller":"traceutil/trace.go:171","msg":"trace[807368831] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:392; }","duration":"670.581833ms","start":"2026-05-14T14:22:36.480602Z","end":"2026-05-14T14:22:37.151184Z","steps":["trace[807368831] 'agreement among raft nodes before linearized reading' (duration: 670.451432ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:37.151238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:36.480577Z","time spent":"670.642733ms","remote":"127.0.0.1:51252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-14T14:22:37.151301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.489844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2901"} {"level":"info","ts":"2026-05-14T14:22:37.151416Z","caller":"traceutil/trace.go:171","msg":"trace[1913719892] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:392; }","duration":"578.662196ms","start":"2026-05-14T14:22:36.572729Z","end":"2026-05-14T14:22:37.151391Z","steps":["trace[1913719892] 'agreement among raft nodes before linearized reading' (duration: 578.383063ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:37.151474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:36.57271Z","time spent":"578.753767ms","remote":"127.0.0.1:51420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":2923,"request content":"key:\"/registry/daemonsets/kube-system/kube-proxy\" "} {"level":"info","ts":"2026-05-14T14:22:37.150909Z","caller":"traceutil/trace.go:171","msg":"trace[1667364272] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"744.73361ms","start":"2026-05-14T14:22:36.406161Z","end":"2026-05-14T14:22:37.150894Z","steps":["trace[1667364272] 'process raft request' (duration: 744.560829ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:37.151624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.417294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-14T14:22:37.151684Z","caller":"traceutil/trace.go:171","msg":"trace[251151608] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:392; }","duration":"359.538756ms","start":"2026-05-14T14:22:36.792131Z","end":"2026-05-14T14:22:37.15167Z","steps":["trace[251151608] 'agreement among raft nodes before linearized reading' (duration: 359.369774ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:37.151699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:36.406154Z","time spent":"745.498008ms","remote":"127.0.0.1:51158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3527,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-14T14:22:37.151729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:36.792103Z","time spent":"359.615766ms","remote":"127.0.0.1:51252","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-05-14T14:22:37.151747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.232042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-14T14:22:37.151905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:36.404755Z","time spent":"746.837461ms","remote":"127.0.0.1:51004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":654,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-14T14:22:37.152076Z","caller":"traceutil/trace.go:171","msg":"trace[531200914] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"583.894146ms","start":"2026-05-14T14:22:36.56697Z","end":"2026-05-14T14:22:37.150864Z","steps":["trace[531200914] 'process raft request' (duration: 583.790895ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:37.152158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:36.566939Z","time spent":"585.166638ms","remote":"127.0.0.1:50950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T14:22:37.152525Z","caller":"traceutil/trace.go:171","msg":"trace[2025870947] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:392; }","duration":"404.06967ms","start":"2026-05-14T14:22:36.748443Z","end":"2026-05-14T14:22:37.152513Z","steps":["trace[2025870947] 'agreement among raft nodes before linearized reading' (duration: 403.183881ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:37.152567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:36.748411Z","time spent":"404.14773ms","remote":"127.0.0.1:51252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-14T14:22:41.514457Z","caller":"traceutil/trace.go:171","msg":"trace[600662570] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"272.69254ms","start":"2026-05-14T14:22:41.241739Z","end":"2026-05-14T14:22:41.514432Z","steps":["trace[600662570] 'process raft request' (duration: 272.495818ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:41.58033Z","caller":"traceutil/trace.go:171","msg":"trace[2131740043] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"338.291257ms","start":"2026-05-14T14:22:41.242008Z","end":"2026-05-14T14:22:41.580299Z","steps":["trace[2131740043] 'process raft request' (duration: 338.010634ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:41.581402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:41.241981Z","time spent":"338.815181ms","remote":"127.0.0.1:51252","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-05-14T14:22:41.613606Z","caller":"traceutil/trace.go:171","msg":"trace[1886554110] linearizableReadLoop","detail":"{readStateIndex:440; appliedIndex:438; }","duration":"371.150595ms","start":"2026-05-14T14:22:41.24243Z","end":"2026-05-14T14:22:41.613581Z","steps":["trace[1886554110] 'read index received' (duration: 271.706881ms)","trace[1886554110] 'applied index is now lower than readState.Index' (duration: 99.442414ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T14:22:41.613778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.312926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-05-14T14:22:41.613879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.914226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-14T14:22:41.613918Z","caller":"traceutil/trace.go:171","msg":"trace[1679284152] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:422; }","duration":"316.003607ms","start":"2026-05-14T14:22:41.297901Z","end":"2026-05-14T14:22:41.613904Z","steps":["trace[1679284152] 'agreement among raft nodes before linearized reading' (duration: 315.949386ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:41.613964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:41.29787Z","time spent":"316.086537ms","remote":"127.0.0.1:51252","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-05-14T14:22:41.613778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.324656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-14T14:22:41.614124Z","caller":"traceutil/trace.go:171","msg":"trace[636139968] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:422; }","duration":"371.602809ms","start":"2026-05-14T14:22:41.242404Z","end":"2026-05-14T14:22:41.614007Z","steps":["trace[636139968] 'agreement among raft nodes before linearized reading' (duration: 371.280876ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:41.613958Z","caller":"traceutil/trace.go:171","msg":"trace[1044349673] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:422; }","duration":"371.480308ms","start":"2026-05-14T14:22:41.242412Z","end":"2026-05-14T14:22:41.613892Z","steps":["trace[1044349673] 'agreement among raft nodes before linearized reading' (duration: 371.308646ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:41.614667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:41.242399Z","time spent":"372.193804ms","remote":"127.0.0.1:51252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-14T14:22:41.61496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:22:41.242398Z","time spent":"371.899792ms","remote":"127.0.0.1:51252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-14T14:22:45.586455Z","caller":"traceutil/trace.go:171","msg":"trace[1627229322] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"121.635359ms","start":"2026-05-14T14:22:45.464796Z","end":"2026-05-14T14:22:45.586432Z","steps":["trace[1627229322] 'process raft request' (duration: 121.491448ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:45.761296Z","caller":"traceutil/trace.go:171","msg":"trace[1094186511] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"111.896798ms","start":"2026-05-14T14:22:45.64938Z","end":"2026-05-14T14:22:45.761277Z","steps":["trace[1094186511] 'process raft request' (duration: 85.772636ms)","trace[1094186511] 'compare' (duration: 26.015391ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T14:22:45.767442Z","caller":"traceutil/trace.go:171","msg":"trace[608678298] transaction","detail":"{read_only:false; response_revision:438; number_of_response:1; }","duration":"118.025295ms","start":"2026-05-14T14:22:45.649381Z","end":"2026-05-14T14:22:45.767406Z","steps":["trace[608678298] 'process raft request' (duration: 117.923284ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:45.767452Z","caller":"traceutil/trace.go:171","msg":"trace[274645998] transaction","detail":"{read_only:false; response_revision:439; number_of_response:1; }","duration":"117.985685ms","start":"2026-05-14T14:22:45.649439Z","end":"2026-05-14T14:22:45.767425Z","steps":["trace[274645998] 'process raft request' (duration: 117.900345ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:45.767596Z","caller":"traceutil/trace.go:171","msg":"trace[1658847814] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"118.204027ms","start":"2026-05-14T14:22:45.64938Z","end":"2026-05-14T14:22:45.767584Z","steps":["trace[1658847814] 'process raft request' (duration: 117.859044ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:22:46.026585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.626976ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T14:22:46.026694Z","caller":"traceutil/trace.go:171","msg":"trace[1640209661] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"187.369349ms","start":"2026-05-14T14:22:45.839304Z","end":"2026-05-14T14:22:46.026674Z","steps":["trace[1640209661] 'process raft request' (duration: 49.561981ms)","trace[1640209661] 'compare' (duration: 137.527276ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T14:22:46.110581Z","caller":"traceutil/trace.go:171","msg":"trace[853347435] transaction","detail":"{read_only:false; number_of_response:1; response_revision:451; }","duration":"248.938948ms","start":"2026-05-14T14:22:45.861622Z","end":"2026-05-14T14:22:46.110561Z","steps":["trace[853347435] 'process raft request' (duration: 248.795307ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:46.110812Z","caller":"traceutil/trace.go:171","msg":"trace[1310445482] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"248.112091ms","start":"2026-05-14T14:22:45.862691Z","end":"2026-05-14T14:22:46.110803Z","steps":["trace[1310445482] 'process raft request' (duration: 247.830638ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:46.110976Z","caller":"traceutil/trace.go:171","msg":"trace[357967915] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"247.452424ms","start":"2026-05-14T14:22:45.863492Z","end":"2026-05-14T14:22:46.110944Z","steps":["trace[357967915] 'process raft request' (duration: 247.306213ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:46.257231Z","caller":"traceutil/trace.go:171","msg":"trace[1794985513] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"225.271785ms","start":"2026-05-14T14:22:46.031929Z","end":"2026-05-14T14:22:46.257201Z","steps":["trace[1794985513] 'process raft request' (duration: 177.661994ms)","trace[1794985513] 'compare' (duration: 47.343909ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T14:22:46.2573Z","caller":"traceutil/trace.go:171","msg":"trace[553484547] transaction","detail":"{read_only:false; response_revision:456; number_of_response:1; }","duration":"224.095385ms","start":"2026-05-14T14:22:46.033172Z","end":"2026-05-14T14:22:46.257267Z","steps":["trace[553484547] 'process raft request' (duration: 224.002834ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:46.257359Z","caller":"traceutil/trace.go:171","msg":"trace[1152653182] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"225.414886ms","start":"2026-05-14T14:22:46.031927Z","end":"2026-05-14T14:22:46.257342Z","steps":["trace[1152653182] 'process raft request' (duration: 225.183074ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:46.265504Z","caller":"traceutil/trace.go:171","msg":"trace[588790270] transaction","detail":"{read_only:false; response_revision:457; number_of_response:1; }","duration":"149.582205ms","start":"2026-05-14T14:22:46.115896Z","end":"2026-05-14T14:22:46.265478Z","steps":["trace[588790270] 'process raft request' (duration: 149.384323ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:46.265605Z","caller":"traceutil/trace.go:171","msg":"trace[505136921] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"147.656977ms","start":"2026-05-14T14:22:46.117929Z","end":"2026-05-14T14:22:46.265586Z","steps":["trace[505136921] 'process raft request' (duration: 147.455525ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:59.671213Z","caller":"traceutil/trace.go:171","msg":"trace[891132391] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"201.266311ms","start":"2026-05-14T14:22:59.469923Z","end":"2026-05-14T14:22:59.671189Z","steps":["trace[891132391] 'process raft request' (duration: 201.130406ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:59.679799Z","caller":"traceutil/trace.go:171","msg":"trace[744272916] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"196.858464ms","start":"2026-05-14T14:22:59.482913Z","end":"2026-05-14T14:22:59.679772Z","steps":["trace[744272916] 'process raft request' (duration: 196.764321ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:59.679798Z","caller":"traceutil/trace.go:171","msg":"trace[1008860837] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"201.389175ms","start":"2026-05-14T14:22:59.478367Z","end":"2026-05-14T14:22:59.679756Z","steps":["trace[1008860837] 'process raft request' (duration: 201.25981ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:59.679946Z","caller":"traceutil/trace.go:171","msg":"trace[647587427] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"194.184804ms","start":"2026-05-14T14:22:59.485751Z","end":"2026-05-14T14:22:59.679935Z","steps":["trace[647587427] 'process raft request' (duration: 193.967375ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:59.680023Z","caller":"traceutil/trace.go:171","msg":"trace[1129841190] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"190.750224ms","start":"2026-05-14T14:22:59.489262Z","end":"2026-05-14T14:22:59.680012Z","steps":["trace[1129841190] 'process raft request' (duration: 190.551506ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:59.680061Z","caller":"traceutil/trace.go:171","msg":"trace[258444436] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"203.665742ms","start":"2026-05-14T14:22:59.476063Z","end":"2026-05-14T14:22:59.679729Z","steps":["trace[258444436] 'process raft request' (duration: 203.447374ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:59.680098Z","caller":"traceutil/trace.go:171","msg":"trace[426540289] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"189.954783ms","start":"2026-05-14T14:22:59.490136Z","end":"2026-05-14T14:22:59.680091Z","steps":["trace[426540289] 'process raft request' (duration: 189.719675ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:59.680062Z","caller":"traceutil/trace.go:171","msg":"trace[1841098905] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"190.758815ms","start":"2026-05-14T14:22:59.489227Z","end":"2026-05-14T14:22:59.679986Z","steps":["trace[1841098905] 'process raft request' (duration: 190.543136ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:59.68022Z","caller":"traceutil/trace.go:171","msg":"trace[71974057] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"174.857563ms","start":"2026-05-14T14:22:59.505313Z","end":"2026-05-14T14:22:59.68017Z","steps":["trace[71974057] 'process raft request' (duration: 174.718388ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:59.680279Z","caller":"traceutil/trace.go:171","msg":"trace[116297947] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"159.969891ms","start":"2026-05-14T14:22:59.520266Z","end":"2026-05-14T14:22:59.680235Z","steps":["trace[116297947] 'process raft request' (duration: 159.833216ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:22:59.680396Z","caller":"traceutil/trace.go:171","msg":"trace[278967837] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"142.47929ms","start":"2026-05-14T14:22:59.537902Z","end":"2026-05-14T14:22:59.680381Z","steps":["trace[278967837] 'process raft request' (duration: 142.296834ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:23:01.794022Z","caller":"traceutil/trace.go:171","msg":"trace[731846176] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"315.276167ms","start":"2026-05-14T14:23:01.478723Z","end":"2026-05-14T14:23:01.793999Z","steps":["trace[731846176] 'process raft request' (duration: 315.09498ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:01.794246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:23:01.478705Z","time spent":"315.442563ms","remote":"127.0.0.1:51252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T14:23:02.451195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.460583ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-14T14:23:02.451561Z","caller":"traceutil/trace.go:171","msg":"trace[1859221006] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:636; }","duration":"604.113151ms","start":"2026-05-14T14:23:01.84735Z","end":"2026-05-14T14:23:02.451463Z","steps":["trace[1859221006] 'read index received' (duration: 108.351596ms)","trace[1859221006] 'applied index is now lower than readState.Index' (duration: 495.756014ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T14:23:02.451686Z","caller":"traceutil/trace.go:171","msg":"trace[649365675] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"179.356761ms","start":"2026-05-14T14:23:02.272284Z","end":"2026-05-14T14:23:02.45164Z","steps":["trace[649365675] 'process raft request' (duration: 179.139243ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:02.451895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.696841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-14T14:23:02.45186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.482505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-14T14:23:02.451937Z","caller":"traceutil/trace.go:171","msg":"trace[1455122917] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:609; }","duration":"578.786944ms","start":"2026-05-14T14:23:01.873137Z","end":"2026-05-14T14:23:02.451924Z","steps":["trace[1455122917] 'agreement among raft nodes before linearized reading' (duration: 578.562596ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:02.451967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:23:01.873095Z","time spent":"578.866747ms","remote":"127.0.0.1:51252","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-05-14T14:23:02.451965Z","caller":"traceutil/trace.go:171","msg":"trace[979122591] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:608; }","duration":"604.605669ms","start":"2026-05-14T14:23:01.847335Z","end":"2026-05-14T14:23:02.451941Z","steps":["trace[979122591] 'agreement among raft nodes before linearized reading' (duration: 604.218865ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:02.452014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:23:01.847273Z","time spent":"604.730543ms","remote":"127.0.0.1:51252","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-05-14T14:23:02.452167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.512672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T14:23:02.452205Z","caller":"traceutil/trace.go:171","msg":"trace[74995367] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:609; }","duration":"210.582183ms","start":"2026-05-14T14:23:02.241614Z","end":"2026-05-14T14:23:02.452196Z","steps":["trace[74995367] 'agreement among raft nodes before linearized reading' (duration: 210.49651ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:02.452426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.551082ms","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-05-14T14:23:02.452515Z","caller":"traceutil/trace.go:171","msg":"trace[745672711] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:609; }","duration":"216.77337ms","start":"2026-05-14T14:23:02.235721Z","end":"2026-05-14T14:23:02.452495Z","steps":["trace[745672711] 'agreement among raft nodes before linearized reading' (duration: 216.382406ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:02.452373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.592756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-14T14:23:02.452674Z","caller":"traceutil/trace.go:171","msg":"trace[1066545515] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:609; }","duration":"476.914688ms","start":"2026-05-14T14:23:01.975726Z","end":"2026-05-14T14:23:02.452641Z","steps":["trace[1066545515] 'agreement among raft nodes before linearized reading' (duration: 476.363378ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:02.452767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:23:01.975715Z","time spent":"477.038772ms","remote":"127.0.0.1:51252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-14T14:23:06.196865Z","caller":"traceutil/trace.go:171","msg":"trace[3748376] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:663; }","duration":"236.545508ms","start":"2026-05-14T14:23:05.960299Z","end":"2026-05-14T14:23:06.196844Z","steps":["trace[3748376] 'read index received' (duration: 235.72364ms)","trace[3748376] 'applied index is now lower than readState.Index' (duration: 820.888µs)"],"step_count":2} {"level":"info","ts":"2026-05-14T14:23:06.196938Z","caller":"traceutil/trace.go:171","msg":"trace[715376615] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"239.421451ms","start":"2026-05-14T14:23:05.957493Z","end":"2026-05-14T14:23:06.196914Z","steps":["trace[715376615] 'process raft request' (duration: 238.849471ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:06.19711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.773556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T14:23:06.197235Z","caller":"traceutil/trace.go:171","msg":"trace[1021007460] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:635; }","duration":"236.940332ms","start":"2026-05-14T14:23:05.960274Z","end":"2026-05-14T14:23:06.197214Z","steps":["trace[1021007460] 'agreement among raft nodes before linearized reading' (duration: 236.645092ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:06.197225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.426885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T14:23:06.197372Z","caller":"traceutil/trace.go:171","msg":"trace[1786971297] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:635; }","duration":"236.640462ms","start":"2026-05-14T14:23:05.960706Z","end":"2026-05-14T14:23:06.197347Z","steps":["trace[1786971297] 'agreement among raft nodes before linearized reading' (duration: 236.367192ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:06.197086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.768937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T14:23:06.197931Z","caller":"traceutil/trace.go:171","msg":"trace[2139415329] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:635; }","duration":"237.620907ms","start":"2026-05-14T14:23:05.960285Z","end":"2026-05-14T14:23:06.197906Z","steps":["trace[2139415329] 'agreement among raft nodes before linearized reading' (duration: 236.693894ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:23:06.377831Z","caller":"traceutil/trace.go:171","msg":"trace[457961490] linearizableReadLoop","detail":"{readStateIndex:665; appliedIndex:664; }","duration":"105.873746ms","start":"2026-05-14T14:23:06.271926Z","end":"2026-05-14T14:23:06.3778Z","steps":["trace[457961490] 'read index received' (duration: 105.727331ms)","trace[457961490] 'applied index is now lower than readState.Index' (duration: 144.895µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T14:23:06.378046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.090423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T14:23:06.377971Z","caller":"traceutil/trace.go:171","msg":"trace[782221729] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"119.267716ms","start":"2026-05-14T14:23:06.258674Z","end":"2026-05-14T14:23:06.377941Z","steps":["trace[782221729] 'process raft request' (duration: 118.926084ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:23:06.378107Z","caller":"traceutil/trace.go:171","msg":"trace[676564720] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:636; }","duration":"106.214028ms","start":"2026-05-14T14:23:06.271876Z","end":"2026-05-14T14:23:06.37809Z","steps":["trace[676564720] 'agreement among raft nodes before linearized reading' (duration: 106.072433ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:06.3843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.241599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T14:23:06.384359Z","caller":"traceutil/trace.go:171","msg":"trace[1358550589] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:636; }","duration":"112.326863ms","start":"2026-05-14T14:23:06.272018Z","end":"2026-05-14T14:23:06.384345Z","steps":["trace[1358550589] 'agreement among raft nodes before linearized reading' (duration: 112.194408ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:06.384837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.930279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T14:23:06.384928Z","caller":"traceutil/trace.go:171","msg":"trace[2048782340] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:636; }","duration":"112.175868ms","start":"2026-05-14T14:23:06.272737Z","end":"2026-05-14T14:23:06.384913Z","steps":["trace[2048782340] 'agreement among raft nodes before linearized reading' (duration: 111.452462ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:06.733442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.145836ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T14:23:06.73356Z","caller":"traceutil/trace.go:171","msg":"trace[1825906198] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:666; }","duration":"342.873595ms","start":"2026-05-14T14:23:06.390662Z","end":"2026-05-14T14:23:06.733536Z","steps":["trace[1825906198] 'read index received' (duration: 75.583143ms)","trace[1825906198] 'applied index is now lower than readState.Index' (duration: 267.289362ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T14:23:06.733569Z","caller":"traceutil/trace.go:171","msg":"trace[436082446] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"344.429009ms","start":"2026-05-14T14:23:06.389109Z","end":"2026-05-14T14:23:06.733538Z","steps":["trace[436082446] 'process raft request' (duration: 77.090116ms)","trace[436082446] 'compare' (duration: 266.924649ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T14:23:06.733758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.55667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T14:23:06.733789Z","caller":"traceutil/trace.go:171","msg":"trace[1114144933] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:637; }","duration":"310.625313ms","start":"2026-05-14T14:23:06.423156Z","end":"2026-05-14T14:23:06.733781Z","steps":["trace[1114144933] 'agreement among raft nodes before linearized reading' (duration: 310.495728ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:06.733776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.846635ms","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":"warn","ts":"2026-05-14T14:23:06.733807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:23:06.423141Z","time spent":"310.662274ms","remote":"127.0.0.1:47860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-05-14T14:23:06.7338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:23:06.389093Z","time spent":"344.608736ms","remote":"127.0.0.1:50950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T14:23:06.733815Z","caller":"traceutil/trace.go:171","msg":"trace[1563757062] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:637; }","duration":"205.941598ms","start":"2026-05-14T14:23:06.527865Z","end":"2026-05-14T14:23:06.733807Z","steps":["trace[1563757062] 'agreement among raft nodes before linearized reading' (duration: 205.785173ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:06.733878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.165145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-14T14:23:06.73393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.914121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-14T14:23:06.733869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.300849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-14T14:23:06.734013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.231229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-14T14:23:06.734011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.967811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T14:23:06.73403Z","caller":"traceutil/trace.go:171","msg":"trace[818523024] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:637; }","duration":"310.2848ms","start":"2026-05-14T14:23:06.423742Z","end":"2026-05-14T14:23:06.734026Z","steps":["trace[818523024] 'agreement among raft nodes before linearized reading' (duration: 310.244759ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:06.734045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:23:06.423692Z","time spent":"310.349893ms","remote":"127.0.0.1:47860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-05-14T14:23:06.734045Z","caller":"traceutil/trace.go:171","msg":"trace[712887600] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:637; }","duration":"286.510236ms","start":"2026-05-14T14:23:06.447515Z","end":"2026-05-14T14:23:06.734025Z","steps":["trace[712887600] 'agreement among raft nodes before linearized reading' (duration: 286.222156ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:06.734065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.851592ms","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":"info","ts":"2026-05-14T14:23:06.734094Z","caller":"traceutil/trace.go:171","msg":"trace[1583570793] 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:637; }","duration":"173.897933ms","start":"2026-05-14T14:23:06.560188Z","end":"2026-05-14T14:23:06.734086Z","steps":["trace[1583570793] 'agreement among raft nodes before linearized reading' (duration: 173.836971ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:06.734103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.221361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-14T14:23:06.734129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.935698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-14T14:23:06.734134Z","caller":"traceutil/trace.go:171","msg":"trace[832867679] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:637; }","duration":"230.301773ms","start":"2026-05-14T14:23:06.503825Z","end":"2026-05-14T14:23:06.734127Z","steps":["trace[832867679] 'agreement among raft nodes before linearized reading' (duration: 230.251091ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:23:06.734146Z","caller":"traceutil/trace.go:171","msg":"trace[374659027] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:637; }","duration":"254.984399ms","start":"2026-05-14T14:23:06.479158Z","end":"2026-05-14T14:23:06.734142Z","steps":["trace[374659027] 'agreement among raft nodes before linearized reading' (duration: 254.921597ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:06.734189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.306935ms","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-05-14T14:23:06.734246Z","caller":"traceutil/trace.go:171","msg":"trace[1699695430] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:637; }","duration":"191.440419ms","start":"2026-05-14T14:23:06.542783Z","end":"2026-05-14T14:23:06.734223Z","steps":["trace[1699695430] 'agreement among raft nodes before linearized reading' (duration: 191.320045ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:06.734271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.554554ms","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-05-14T14:23:06.734295Z","caller":"traceutil/trace.go:171","msg":"trace[1470982060] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:637; }","duration":"191.613175ms","start":"2026-05-14T14:23:06.54267Z","end":"2026-05-14T14:23:06.734283Z","steps":["trace[1470982060] 'agreement among raft nodes before linearized reading' (duration: 191.587054ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:06.73435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.530681ms","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-05-14T14:23:06.734432Z","caller":"traceutil/trace.go:171","msg":"trace[1314760076] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:637; }","duration":"230.631004ms","start":"2026-05-14T14:23:06.503771Z","end":"2026-05-14T14:23:06.734402Z","steps":["trace[1314760076] 'agreement among raft nodes before linearized reading' (duration: 230.536601ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:23:06.733954Z","caller":"traceutil/trace.go:171","msg":"trace[985383963] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:637; }","duration":"286.965022ms","start":"2026-05-14T14:23:06.446982Z","end":"2026-05-14T14:23:06.733947Z","steps":["trace[985383963] 'agreement among raft nodes before linearized reading' (duration: 286.934861ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:06.734547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.889826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-14T14:23:06.734542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.841907ms","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-05-14T14:23:06.734566Z","caller":"traceutil/trace.go:171","msg":"trace[371085370] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:637; }","duration":"256.949539ms","start":"2026-05-14T14:23:06.477612Z","end":"2026-05-14T14:23:06.734561Z","steps":["trace[371085370] 'agreement among raft nodes before linearized reading' (duration: 256.896727ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:23:06.734572Z","caller":"traceutil/trace.go:171","msg":"trace[100894964] 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:637; }","duration":"174.911939ms","start":"2026-05-14T14:23:06.559654Z","end":"2026-05-14T14:23:06.734566Z","steps":["trace[100894964] 'agreement among raft nodes before linearized reading' (duration: 174.863727ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:23:06.734055Z","caller":"traceutil/trace.go:171","msg":"trace[1943817605] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:637; }","duration":"230.046225ms","start":"2026-05-14T14:23:06.503994Z","end":"2026-05-14T14:23:06.73404Z","steps":["trace[1943817605] 'agreement among raft nodes before linearized reading' (duration: 229.985663ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:06.734648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.677703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-14T14:23:06.734373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.524022ms","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-05-14T14:23:06.734689Z","caller":"traceutil/trace.go:171","msg":"trace[668022969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:637; }","duration":"245.729825ms","start":"2026-05-14T14:23:06.488947Z","end":"2026-05-14T14:23:06.734677Z","steps":["trace[668022969] 'agreement among raft nodes before linearized reading' (duration: 245.626861ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:23:06.734692Z","caller":"traceutil/trace.go:171","msg":"trace[116437727] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:637; }","duration":"191.866474ms","start":"2026-05-14T14:23:06.542817Z","end":"2026-05-14T14:23:06.734683Z","steps":["trace[116437727] 'agreement among raft nodes before linearized reading' (duration: 191.543923ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:06.733955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.158936ms","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-05-14T14:23:06.73546Z","caller":"traceutil/trace.go:171","msg":"trace[62647880] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:637; }","duration":"207.667719ms","start":"2026-05-14T14:23:06.527766Z","end":"2026-05-14T14:23:06.735433Z","steps":["trace[62647880] 'agreement among raft nodes before linearized reading' (duration: 206.162796ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:06.733975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.248382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T14:23:06.735567Z","caller":"traceutil/trace.go:171","msg":"trace[720873936] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:637; }","duration":"288.855689ms","start":"2026-05-14T14:23:06.446704Z","end":"2026-05-14T14:23:06.735559Z","steps":["trace[720873936] 'agreement among raft nodes before linearized reading' (duration: 287.259663ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:23:06.733988Z","caller":"traceutil/trace.go:171","msg":"trace[27080862] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:637; }","duration":"343.284979ms","start":"2026-05-14T14:23:06.390652Z","end":"2026-05-14T14:23:06.733937Z","steps":["trace[27080862] 'agreement among raft nodes before linearized reading' (duration: 342.968748ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:06.735657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:23:06.390581Z","time spent":"345.064981ms","remote":"127.0.0.1:51216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-05-14T14:23:06.733899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.473206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-14T14:23:06.735736Z","caller":"traceutil/trace.go:171","msg":"trace[1455181031] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:637; }","duration":"255.327032ms","start":"2026-05-14T14:23:06.480402Z","end":"2026-05-14T14:23:06.735729Z","steps":["trace[1455181031] 'agreement among raft nodes before linearized reading' (duration: 253.28537ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:06.7351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.343435ms","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-05-14T14:23:06.735782Z","caller":"traceutil/trace.go:171","msg":"trace[1351365145] 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:637; }","duration":"176.137562ms","start":"2026-05-14T14:23:06.559632Z","end":"2026-05-14T14:23:06.735769Z","steps":["trace[1351365145] 'agreement among raft nodes before linearized reading' (duration: 174.719333ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:23:06.864441Z","caller":"traceutil/trace.go:171","msg":"trace[1962271323] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"123.101851ms","start":"2026-05-14T14:23:06.741281Z","end":"2026-05-14T14:23:06.864383Z","steps":["trace[1962271323] 'process raft request' (duration: 111.869656ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:23:06.865185Z","caller":"traceutil/trace.go:171","msg":"trace[18518923] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"122.995337ms","start":"2026-05-14T14:23:06.742158Z","end":"2026-05-14T14:23:06.865153Z","steps":["trace[18518923] 'process raft request' (duration: 119.794634ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:23:06.865614Z","caller":"traceutil/trace.go:171","msg":"trace[936000852] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"116.591572ms","start":"2026-05-14T14:23:06.748993Z","end":"2026-05-14T14:23:06.865584Z","steps":["trace[936000852] 'process raft request' (duration: 116.137236ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:23:06.865869Z","caller":"traceutil/trace.go:171","msg":"trace[1385780971] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"123.136392ms","start":"2026-05-14T14:23:06.742711Z","end":"2026-05-14T14:23:06.865848Z","steps":["trace[1385780971] 'process raft request' (duration: 122.21938ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:07.744432Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276102350832627817,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-14T14:23:08.244765Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276102350832627817,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-14T14:23:08.745181Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276102350832627817,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-14T14:23:08.879128Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.728086113s","expected-duration":"1s"} {"level":"info","ts":"2026-05-14T14:23:08.880082Z","caller":"traceutil/trace.go:171","msg":"trace[186932966] linearizableReadLoop","detail":"{readStateIndex:673; appliedIndex:672; }","duration":"1.636511902s","start":"2026-05-14T14:23:07.243542Z","end":"2026-05-14T14:23:08.880054Z","steps":["trace[186932966] 'read index received' (duration: 1.635731455s)","trace[186932966] 'applied index is now lower than readState.Index' (duration: 779.547µs)"],"step_count":2} {"level":"info","ts":"2026-05-14T14:23:08.880199Z","caller":"traceutil/trace.go:171","msg":"trace[1880556709] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"1.729932487s","start":"2026-05-14T14:23:07.150232Z","end":"2026-05-14T14:23:08.880165Z","steps":["trace[1880556709] 'process raft request' (duration: 1.729305265s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:08.880282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.636681477s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T14:23:08.880327Z","caller":"traceutil/trace.go:171","msg":"trace[1064840938] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:643; }","duration":"1.636815012s","start":"2026-05-14T14:23:07.243499Z","end":"2026-05-14T14:23:08.880314Z","steps":["trace[1064840938] 'agreement among raft nodes before linearized reading' (duration: 1.636683877s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:08.880363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:23:07.243481Z","time spent":"1.636873524s","remote":"127.0.0.1:50934","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-05-14T14:23:08.880375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:23:07.150215Z","time spent":"1.730077972s","remote":"127.0.0.1:51022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T14:23:14.062068Z","caller":"traceutil/trace.go:171","msg":"trace[154048603] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"147.216887ms","start":"2026-05-14T14:23:13.914824Z","end":"2026-05-14T14:23:14.062041Z","steps":["trace[154048603] 'process raft request' (duration: 146.991289ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:23:14.087267Z","caller":"traceutil/trace.go:171","msg":"trace[216904119] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"172.047121ms","start":"2026-05-14T14:23:13.915202Z","end":"2026-05-14T14:23:14.087249Z","steps":["trace[216904119] 'process raft request' (duration: 162.75538ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:23:23.179459Z","caller":"traceutil/trace.go:171","msg":"trace[1067607685] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"129.81214ms","start":"2026-05-14T14:23:23.049629Z","end":"2026-05-14T14:23:23.179441Z","steps":["trace[1067607685] 'process raft request' (duration: 121.997177ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:23:23.24307Z","caller":"traceutil/trace.go:171","msg":"trace[1392245277] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"192.882174ms","start":"2026-05-14T14:23:23.050165Z","end":"2026-05-14T14:23:23.243047Z","steps":["trace[1392245277] 'process raft request' (duration: 192.72035ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:23:23.243234Z","caller":"traceutil/trace.go:171","msg":"trace[1282505997] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"191.846563ms","start":"2026-05-14T14:23:23.051367Z","end":"2026-05-14T14:23:23.243213Z","steps":["trace[1282505997] 'process raft request' (duration: 191.641077ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:25.557492Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276102350832628137,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-14T14:23:26.058131Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276102350832628137,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-14T14:23:26.195977Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.141738962s","expected-duration":"1s"} {"level":"info","ts":"2026-05-14T14:23:26.196416Z","caller":"traceutil/trace.go:171","msg":"trace[315999824] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"1.142271637s","start":"2026-05-14T14:23:25.05412Z","end":"2026-05-14T14:23:26.196392Z","steps":["trace[315999824] 'process raft request' (duration: 1.142084002s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:26.196554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:23:25.054087Z","time spent":"1.142393481s","remote":"127.0.0.1:51252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T14:23:26.206026Z","caller":"traceutil/trace.go:171","msg":"trace[167612307] linearizableReadLoop","detail":"{readStateIndex:846; appliedIndex:845; }","duration":"1.148561949s","start":"2026-05-14T14:23:25.057441Z","end":"2026-05-14T14:23:26.206003Z","steps":["trace[167612307] 'read index received' (duration: 1.139055073s)","trace[167612307] 'applied index is now lower than readState.Index' (duration: 9.505906ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T14:23:26.206121Z","caller":"traceutil/trace.go:171","msg":"trace[627509032] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"379.727369ms","start":"2026-05-14T14:23:25.826384Z","end":"2026-05-14T14:23:26.206112Z","steps":["trace[627509032] 'process raft request' (duration: 379.498092ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:26.206237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:23:25.826356Z","time spent":"379.795161ms","remote":"127.0.0.1:51216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T14:23:26.206409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"959.728977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-05-14T14:23:26.206439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"959.789989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-05-14T14:23:26.20641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"893.787502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-14T14:23:26.206461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.149009561s","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":"info","ts":"2026-05-14T14:23:26.206487Z","caller":"traceutil/trace.go:171","msg":"trace[344134245] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:811; }","duration":"959.803749ms","start":"2026-05-14T14:23:25.246655Z","end":"2026-05-14T14:23:26.206459Z","steps":["trace[344134245] 'agreement among raft nodes before linearized reading' (duration: 959.682365ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:23:26.206527Z","caller":"traceutil/trace.go:171","msg":"trace[654170305] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:811; }","duration":"1.149084343s","start":"2026-05-14T14:23:25.057424Z","end":"2026-05-14T14:23:26.206508Z","steps":["trace[654170305] 'agreement among raft nodes before linearized reading' (duration: 1.14896958s)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:23:26.206532Z","caller":"traceutil/trace.go:171","msg":"trace[1475431412] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:811; }","duration":"893.956157ms","start":"2026-05-14T14:23:25.312553Z","end":"2026-05-14T14:23:26.206509Z","steps":["trace[1475431412] 'agreement among raft nodes before linearized reading' (duration: 893.757302ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:23:26.206473Z","caller":"traceutil/trace.go:171","msg":"trace[1887130] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:811; }","duration":"959.84229ms","start":"2026-05-14T14:23:25.246623Z","end":"2026-05-14T14:23:26.206465Z","steps":["trace[1887130] 'agreement among raft nodes before linearized reading' (duration: 959.729957ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:26.206595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:23:25.057364Z","time spent":"1.149199017s","remote":"127.0.0.1:51086","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-05-14T14:23:26.206611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:23:25.246611Z","time spent":"959.993505ms","remote":"127.0.0.1:51252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-14T14:23:26.206607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:23:25.312533Z","time spent":"894.05654ms","remote":"127.0.0.1:51100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":27,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-05-14T14:23:26.206647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:23:25.246652Z","time spent":"959.938774ms","remote":"127.0.0.1:51252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-14T14:23:26.20676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.024159347s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-14T14:23:26.206815Z","caller":"traceutil/trace.go:171","msg":"trace[1129047616] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:811; }","duration":"1.02424318s","start":"2026-05-14T14:23:25.182561Z","end":"2026-05-14T14:23:26.206804Z","steps":["trace[1129047616] 'agreement among raft nodes before linearized reading' (duration: 1.023647473s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:23:26.206869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T14:23:25.182515Z","time spent":"1.024344312s","remote":"127.0.0.1:51252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-14T14:24:04.485605Z","caller":"traceutil/trace.go:171","msg":"trace[2087515863] linearizableReadLoop","detail":"{readStateIndex:1114; appliedIndex:1113; }","duration":"101.963803ms","start":"2026-05-14T14:24:04.383618Z","end":"2026-05-14T14:24:04.485581Z","steps":["trace[2087515863] 'read index received' (duration: 101.724207ms)","trace[2087515863] 'applied index is now lower than readState.Index' (duration: 238.526µs)"],"step_count":2} {"level":"info","ts":"2026-05-14T14:24:04.485688Z","caller":"traceutil/trace.go:171","msg":"trace[976167557] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"109.551555ms","start":"2026-05-14T14:24:04.376101Z","end":"2026-05-14T14:24:04.485652Z","steps":["trace[976167557] 'process raft request' (duration: 109.31463ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:24:04.485845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.264559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-14T14:24:04.486723Z","caller":"traceutil/trace.go:171","msg":"trace[427401109] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1069; }","duration":"103.21652ms","start":"2026-05-14T14:24:04.38349Z","end":"2026-05-14T14:24:04.486706Z","steps":["trace[427401109] 'agreement among raft nodes before linearized reading' (duration: 102.231329ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:24:13.695883Z","caller":"traceutil/trace.go:171","msg":"trace[1546754308] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"100.922716ms","start":"2026-05-14T14:24:13.594917Z","end":"2026-05-14T14:24:13.695839Z","steps":["trace[1546754308] 'process raft request' (duration: 100.738133ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:24:15.256793Z","caller":"traceutil/trace.go:171","msg":"trace[881053400] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"130.778749ms","start":"2026-05-14T14:24:15.125968Z","end":"2026-05-14T14:24:15.256747Z","steps":["trace[881053400] 'process raft request' (duration: 130.516294ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:24:37.039822Z","caller":"traceutil/trace.go:171","msg":"trace[862124498] linearizableReadLoop","detail":"{readStateIndex:1229; appliedIndex:1228; }","duration":"168.42067ms","start":"2026-05-14T14:24:36.871353Z","end":"2026-05-14T14:24:37.039774Z","steps":["trace[862124498] 'read index received' (duration: 167.86075ms)","trace[862124498] 'applied index is now lower than readState.Index' (duration: 557.519µs)"],"step_count":2} {"level":"info","ts":"2026-05-14T14:24:37.040145Z","caller":"traceutil/trace.go:171","msg":"trace[693650806] transaction","detail":"{read_only:false; response_revision:1177; number_of_response:1; }","duration":"169.386048ms","start":"2026-05-14T14:24:36.870727Z","end":"2026-05-14T14:24:37.040113Z","steps":["trace[693650806] 'process raft request' (duration: 168.575123ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:24:37.040787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.402737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-14T14:24:37.040929Z","caller":"traceutil/trace.go:171","msg":"trace[829162129] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1177; }","duration":"169.576011ms","start":"2026-05-14T14:24:36.871331Z","end":"2026-05-14T14:24:37.040907Z","steps":["trace[829162129] 'agreement among raft nodes before linearized reading' (duration: 168.712435ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:24:57.115925Z","caller":"traceutil/trace.go:171","msg":"trace[2006888662] linearizableReadLoop","detail":"{readStateIndex:1297; appliedIndex:1296; }","duration":"110.461261ms","start":"2026-05-14T14:24:57.005432Z","end":"2026-05-14T14:24:57.115893Z","steps":["trace[2006888662] 'read index received' (duration: 110.201546ms)","trace[2006888662] 'applied index is now lower than readState.Index' (duration: 258.215µs)"],"step_count":2} {"level":"info","ts":"2026-05-14T14:24:57.115982Z","caller":"traceutil/trace.go:171","msg":"trace[1464492769] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"114.523136ms","start":"2026-05-14T14:24:57.001421Z","end":"2026-05-14T14:24:57.115944Z","steps":["trace[1464492769] 'process raft request' (duration: 114.293233ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:24:57.116141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.697095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-14T14:24:57.116222Z","caller":"traceutil/trace.go:171","msg":"trace[328523912] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1241; }","duration":"110.794627ms","start":"2026-05-14T14:24:57.005413Z","end":"2026-05-14T14:24:57.116208Z","steps":["trace[328523912] 'agreement among raft nodes before linearized reading' (duration: 110.598433ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:24:59.73331Z","caller":"traceutil/trace.go:171","msg":"trace[1777691705] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"145.570112ms","start":"2026-05-14T14:24:59.587716Z","end":"2026-05-14T14:24:59.733286Z","steps":["trace[1777691705] 'process raft request' (duration: 145.41557ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:25:13.466094Z","caller":"traceutil/trace.go:171","msg":"trace[1686618441] linearizableReadLoop","detail":"{readStateIndex:1385; appliedIndex:1384; }","duration":"227.882052ms","start":"2026-05-14T14:25:13.238192Z","end":"2026-05-14T14:25:13.466074Z","steps":["trace[1686618441] 'read index received' (duration: 227.705819ms)","trace[1686618441] 'applied index is now lower than readState.Index' (duration: 175.203µs)"],"step_count":2} {"level":"info","ts":"2026-05-14T14:25:13.466213Z","caller":"traceutil/trace.go:171","msg":"trace[945570723] transaction","detail":"{read_only:false; response_revision:1325; number_of_response:1; }","duration":"279.508954ms","start":"2026-05-14T14:25:13.186693Z","end":"2026-05-14T14:25:13.466202Z","steps":["trace[945570723] 'process raft request' (duration: 279.223339ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:25:13.466488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.191955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T14:25:13.466591Z","caller":"traceutil/trace.go:171","msg":"trace[505659125] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1325; }","duration":"222.428138ms","start":"2026-05-14T14:25:13.244139Z","end":"2026-05-14T14:25:13.466567Z","steps":["trace[505659125] 'agreement among raft nodes before linearized reading' (duration: 222.192265ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:25:13.466701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.686908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-14T14:25:13.466739Z","caller":"traceutil/trace.go:171","msg":"trace[1577030923] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1325; }","duration":"101.76451ms","start":"2026-05-14T14:25:13.364965Z","end":"2026-05-14T14:25:13.46673Z","steps":["trace[1577030923] 'agreement among raft nodes before linearized reading' (duration: 101.622158ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:25:13.466807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.559432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-14T14:25:13.466876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.692905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-14T14:25:13.466877Z","caller":"traceutil/trace.go:171","msg":"trace[615292640] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1325; }","duration":"102.698914ms","start":"2026-05-14T14:25:13.36416Z","end":"2026-05-14T14:25:13.466858Z","steps":["trace[615292640] 'agreement among raft nodes before linearized reading' (duration: 102.44907ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:25:13.466904Z","caller":"traceutil/trace.go:171","msg":"trace[1336249404] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1325; }","duration":"228.760635ms","start":"2026-05-14T14:25:13.238134Z","end":"2026-05-14T14:25:13.466895Z","steps":["trace[1336249404] 'agreement among raft nodes before linearized reading' (duration: 228.674284ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T14:25:13.466967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.623202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-14T14:25:13.467018Z","caller":"traceutil/trace.go:171","msg":"trace[584461252] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1325; }","duration":"207.696733ms","start":"2026-05-14T14:25:13.259307Z","end":"2026-05-14T14:25:13.467004Z","steps":["trace[584461252] 'agreement among raft nodes before linearized reading' (duration: 207.50486ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:25:13.646088Z","caller":"traceutil/trace.go:171","msg":"trace[1747962951] transaction","detail":"{read_only:false; response_revision:1326; number_of_response:1; }","duration":"174.095238ms","start":"2026-05-14T14:25:13.471969Z","end":"2026-05-14T14:25:13.646064Z","steps":["trace[1747962951] 'process raft request' (duration: 158.877195ms)","trace[1747962951] 'compare' (duration: 15.119632ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T14:25:13.658332Z","caller":"traceutil/trace.go:171","msg":"trace[2113266095] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"186.170993ms","start":"2026-05-14T14:25:13.472139Z","end":"2026-05-14T14:25:13.65831Z","steps":["trace[2113266095] 'process raft request' (duration: 186.116792ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:25:13.658371Z","caller":"traceutil/trace.go:171","msg":"trace[1574169377] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"186.216904ms","start":"2026-05-14T14:25:13.472136Z","end":"2026-05-14T14:25:13.658353Z","steps":["trace[1574169377] 'process raft request' (duration: 186.022581ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T14:25:13.65856Z","caller":"traceutil/trace.go:171","msg":"trace[408780981] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"186.287405ms","start":"2026-05-14T14:25:13.472264Z","end":"2026-05-14T14:25:13.658552Z","steps":["trace[408780981] 'process raft request' (duration: 186.01752ms)"],"step_count":1}