{"level":"warn","ts":"2026-06-10T02:44:19.770437Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-10T02:44:19.770529Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.242: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.242:2380","--initial-cluster=instance=https://199.204.45.242:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.242:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.242:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-10T02:44:19.770605Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-10T02:44:19.770623Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.242:2380"]} {"level":"info","ts":"2026-06-10T02:44:19.770647Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-10T02:44:19.771433Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"]} {"level":"info","ts":"2026-06-10T02:44:19.771532Z","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":16,"max-cpu-available":16,"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.242:2380"],"listen-peer-urls":["https://199.204.45.242:2380"],"advertise-client-urls":["https://199.204.45.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.242:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-10T02:44:19.774591Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.710785ms"} {"level":"info","ts":"2026-06-10T02:44:19.779665Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b844c110b9783e73","cluster-id":"49dc9693ccd466a9"} {"level":"info","ts":"2026-06-10T02:44:19.779719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=()"} {"level":"info","ts":"2026-06-10T02:44:19.779735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became follower at term 0"} {"level":"info","ts":"2026-06-10T02:44:19.779745Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b844c110b9783e73 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-10T02:44:19.779753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became follower at term 1"} {"level":"info","ts":"2026-06-10T02:44:19.779779Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=(13277949878970367603)"} {"level":"warn","ts":"2026-06-10T02:44:19.784313Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-10T02:44:19.786244Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-10T02:44:19.787549Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-10T02:44:19.790359Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b844c110b9783e73","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-10T02:44:19.791196Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b844c110b9783e73","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-10T02:44:19.791216Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-10T02:44:19.791281Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-10T02:44:19.791292Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-10T02:44:19.793104Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=(13277949878970367603)"} {"level":"info","ts":"2026-06-10T02:44:19.793362Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"49dc9693ccd466a9","local-member-id":"b844c110b9783e73","added-peer-id":"b844c110b9783e73","added-peer-peer-urls":["https://199.204.45.242:2380"]} {"level":"info","ts":"2026-06-10T02:44:19.796045Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-10T02:44:19.796615Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b844c110b9783e73","initial-advertise-peer-urls":["https://199.204.45.242:2380"],"listen-peer-urls":["https://199.204.45.242:2380"],"advertise-client-urls":["https://199.204.45.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-10T02:44:19.796667Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-10T02:44:19.797451Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.242:2380"} {"level":"info","ts":"2026-06-10T02:44:19.797508Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.242:2380"} {"level":"info","ts":"2026-06-10T02:44:20.080477Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 is starting a new election at term 1"} {"level":"info","ts":"2026-06-10T02:44:20.080537Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-10T02:44:20.08056Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 received MsgPreVoteResp from b844c110b9783e73 at term 1"} {"level":"info","ts":"2026-06-10T02:44:20.080602Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became candidate at term 2"} {"level":"info","ts":"2026-06-10T02:44:20.080615Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 received MsgVoteResp from b844c110b9783e73 at term 2"} {"level":"info","ts":"2026-06-10T02:44:20.080631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became leader at term 2"} {"level":"info","ts":"2026-06-10T02:44:20.08065Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b844c110b9783e73 elected leader b844c110b9783e73 at term 2"} {"level":"info","ts":"2026-06-10T02:44:20.081923Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b844c110b9783e73","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.242:2379]}","request-path":"/0/members/b844c110b9783e73/attributes","cluster-id":"49dc9693ccd466a9","publish-timeout":"7s"} {"level":"info","ts":"2026-06-10T02:44:20.081949Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T02:44:20.08193Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T02:44:20.082272Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-10T02:44:20.082332Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-10T02:44:20.085222Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-10T02:44:20.085488Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.242:2379"} {"level":"info","ts":"2026-06-10T02:44:20.091538Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T02:44:20.092234Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"49dc9693ccd466a9","local-member-id":"b844c110b9783e73","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T02:44:20.092324Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T02:44:20.092355Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T02:44:39.341677Z","caller":"traceutil/trace.go:171","msg":"trace[1541682619] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"227.578357ms","start":"2026-06-10T02:44:39.114073Z","end":"2026-06-10T02:44:39.341651Z","steps":["trace[1541682619] 'process raft request' (duration: 227.366801ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:44:56.829Z","caller":"traceutil/trace.go:171","msg":"trace[1319523969] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"106.531786ms","start":"2026-06-10T02:44:56.722415Z","end":"2026-06-10T02:44:56.828947Z","steps":["trace[1319523969] 'process raft request' (duration: 106.244067ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:44:57.191573Z","caller":"traceutil/trace.go:171","msg":"trace[1714083591] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"130.543979ms","start":"2026-06-10T02:44:57.060997Z","end":"2026-06-10T02:44:57.191541Z","steps":["trace[1714083591] 'process raft request' (duration: 130.329514ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:44:57.191564Z","caller":"traceutil/trace.go:171","msg":"trace[516026163] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"133.337258ms","start":"2026-06-10T02:44:57.058155Z","end":"2026-06-10T02:44:57.191492Z","steps":["trace[516026163] 'process raft request' (duration: 133.100761ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:44:57.19167Z","caller":"traceutil/trace.go:171","msg":"trace[371216710] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"128.108164ms","start":"2026-06-10T02:44:57.063549Z","end":"2026-06-10T02:44:57.191657Z","steps":["trace[371216710] 'process raft request' (duration: 127.838896ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:44:57.191586Z","caller":"traceutil/trace.go:171","msg":"trace[750741933] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"140.178757ms","start":"2026-06-10T02:44:57.05128Z","end":"2026-06-10T02:44:57.191459Z","steps":["trace[750741933] 'process raft request' (duration: 139.810217ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:44:57.191907Z","caller":"traceutil/trace.go:171","msg":"trace[1849986578] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"125.427319ms","start":"2026-06-10T02:44:57.066438Z","end":"2026-06-10T02:44:57.191866Z","steps":["trace[1849986578] 'process raft request' (duration: 125.022338ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:44:57.19207Z","caller":"traceutil/trace.go:171","msg":"trace[1339858218] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"123.898237ms","start":"2026-06-10T02:44:57.068164Z","end":"2026-06-10T02:44:57.192062Z","steps":["trace[1339858218] 'process raft request' (duration: 123.710622ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:44:57.192294Z","caller":"traceutil/trace.go:171","msg":"trace[131199981] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"123.880935ms","start":"2026-06-10T02:44:57.068355Z","end":"2026-06-10T02:44:57.192236Z","steps":["trace[131199981] 'process raft request' (duration: 123.598828ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:44:57.192326Z","caller":"traceutil/trace.go:171","msg":"trace[611707004] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"115.903435ms","start":"2026-06-10T02:44:57.076417Z","end":"2026-06-10T02:44:57.19232Z","steps":["trace[611707004] 'process raft request' (duration: 115.73442ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:44:57.192669Z","caller":"traceutil/trace.go:171","msg":"trace[1354598195] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"100.624664ms","start":"2026-06-10T02:44:57.091791Z","end":"2026-06-10T02:44:57.192416Z","steps":["trace[1354598195] 'process raft request' (duration: 100.453538ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:45:02.919194Z","caller":"traceutil/trace.go:171","msg":"trace[286308039] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"129.85116ms","start":"2026-06-10T02:45:02.789304Z","end":"2026-06-10T02:45:02.919155Z","steps":["trace[286308039] 'read index received' (duration: 129.540243ms)","trace[286308039] 'applied index is now lower than readState.Index' (duration: 309.587µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:45:02.919257Z","caller":"traceutil/trace.go:171","msg":"trace[160856601] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"220.432946ms","start":"2026-06-10T02:45:02.698796Z","end":"2026-06-10T02:45:02.919229Z","steps":["trace[160856601] 'process raft request' (duration: 220.124277ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:45:02.919424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.089237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T02:45:02.919743Z","caller":"traceutil/trace.go:171","msg":"trace[1404984649] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"130.369446ms","start":"2026-06-10T02:45:02.789248Z","end":"2026-06-10T02:45:02.919618Z","steps":["trace[1404984649] 'agreement among raft nodes before linearized reading' (duration: 130.055037ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:45:03.486169Z","caller":"traceutil/trace.go:171","msg":"trace[2105414485] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:656; }","duration":"138.033528ms","start":"2026-06-10T02:45:03.348107Z","end":"2026-06-10T02:45:03.48614Z","steps":["trace[2105414485] 'read index received' (duration: 137.974627ms)","trace[2105414485] 'applied index is now lower than readState.Index' (duration: 57.111µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:45:03.486409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.296114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-5qg5s\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-10T02:45:03.486444Z","caller":"traceutil/trace.go:171","msg":"trace[1242467738] range","detail":"{range_begin:/registry/pods/kube-system/cilium-5qg5s; range_end:; response_count:1; response_revision:636; }","duration":"138.401877ms","start":"2026-06-10T02:45:03.348031Z","end":"2026-06-10T02:45:03.486432Z","steps":["trace[1242467738] 'agreement among raft nodes before linearized reading' (duration: 138.215142ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:45:03.614221Z","caller":"traceutil/trace.go:171","msg":"trace[825102021] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"234.856335ms","start":"2026-06-10T02:45:03.379326Z","end":"2026-06-10T02:45:03.614182Z","steps":["trace[825102021] 'process raft request' (duration: 234.021862ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:45:04.628772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"711.559839ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T02:45:04.629059Z","caller":"traceutil/trace.go:171","msg":"trace[1243385107] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"1.141611022s","start":"2026-06-10T02:45:03.487405Z","end":"2026-06-10T02:45:04.629016Z","steps":["trace[1243385107] 'process raft request' (duration: 428.682435ms)","trace[1243385107] 'compare' (duration: 711.206889ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:45:04.629195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:45:03.487377Z","time spent":"1.141752165s","remote":"127.0.0.1:33946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T02:45:04.629242Z","caller":"traceutil/trace.go:171","msg":"trace[702832746] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"1.127214114s","start":"2026-06-10T02:45:03.501969Z","end":"2026-06-10T02:45:04.629183Z","steps":["trace[702832746] 'process raft request' (duration: 1.126926045s)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:45:04.629409Z","caller":"traceutil/trace.go:171","msg":"trace[1328975149] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:657; }","duration":"1.086376643s","start":"2026-06-10T02:45:03.54296Z","end":"2026-06-10T02:45:04.629337Z","steps":["trace[1328975149] 'read index received' (duration: 70.116149ms)","trace[1328975149] 'applied index is now lower than readState.Index' (duration: 1.016255634s)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:45:04.629442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:45:03.50194Z","time spent":"1.127399809s","remote":"127.0.0.1:34094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T02:45:04.629614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.086639631s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-10T02:45:04.629689Z","caller":"traceutil/trace.go:171","msg":"trace[397596306] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:639; }","duration":"1.086775295s","start":"2026-06-10T02:45:03.542894Z","end":"2026-06-10T02:45:04.62967Z","steps":["trace[397596306] 'agreement among raft nodes before linearized reading' (duration: 1.08658201s)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:45:04.629717Z","caller":"traceutil/trace.go:171","msg":"trace[423049884] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"956.486212ms","start":"2026-06-10T02:45:03.673195Z","end":"2026-06-10T02:45:04.629682Z","steps":["trace[423049884] 'process raft request' (duration: 955.911496ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:45:04.62973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:45:03.542868Z","time spent":"1.086853418s","remote":"127.0.0.1:34160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-10T02:45:04.629795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"776.71578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-10T02:45:04.629822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.923809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-10T02:45:04.629842Z","caller":"traceutil/trace.go:171","msg":"trace[1000639863] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:640; }","duration":"776.785583ms","start":"2026-06-10T02:45:03.853043Z","end":"2026-06-10T02:45:04.629829Z","steps":["trace[1000639863] 'agreement among raft nodes before linearized reading' (duration: 776.665119ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:45:04.629874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:45:03.85302Z","time spent":"776.847133ms","remote":"127.0.0.1:34160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-10T02:45:04.629875Z","caller":"traceutil/trace.go:171","msg":"trace[1161095902] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:640; }","duration":"729.013631ms","start":"2026-06-10T02:45:03.900847Z","end":"2026-06-10T02:45:04.629861Z","steps":["trace[1161095902] 'agreement among raft nodes before linearized reading' (duration: 728.844297ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:45:04.629681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"842.077548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T02:45:04.62991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:45:03.673168Z","time spent":"956.585984ms","remote":"127.0.0.1:34416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T02:45:04.629919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:45:03.900823Z","time spent":"729.085723ms","remote":"127.0.0.1:34160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-10T02:45:04.630078Z","caller":"traceutil/trace.go:171","msg":"trace[1198315369] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:640; }","duration":"842.383536ms","start":"2026-06-10T02:45:03.787548Z","end":"2026-06-10T02:45:04.629932Z","steps":["trace[1198315369] 'agreement among raft nodes before linearized reading' (duration: 842.070418ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:45:04.630165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:45:03.787524Z","time spent":"842.621563ms","remote":"127.0.0.1:33920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-10T02:45:05.150971Z","caller":"traceutil/trace.go:171","msg":"trace[1913082219] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"514.465158ms","start":"2026-06-10T02:45:04.636469Z","end":"2026-06-10T02:45:05.150934Z","steps":["trace[1913082219] 'process raft request' (duration: 459.632811ms)","trace[1913082219] 'compare' (duration: 53.893971ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:45:05.151201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:45:04.636445Z","time spent":"514.645443ms","remote":"127.0.0.1:34160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T02:45:05.151187Z","caller":"traceutil/trace.go:171","msg":"trace[2144243300] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"514.503199ms","start":"2026-06-10T02:45:04.636654Z","end":"2026-06-10T02:45:05.151158Z","steps":["trace[2144243300] 'process raft request' (duration: 514.013365ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:45:05.151354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:45:04.636638Z","time spent":"514.617512ms","remote":"127.0.0.1:34160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T02:45:05.151552Z","caller":"traceutil/trace.go:171","msg":"trace[838983936] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:661; }","duration":"513.050849ms","start":"2026-06-10T02:45:04.63846Z","end":"2026-06-10T02:45:05.151511Z","steps":["trace[838983936] 'read index received' (duration: 457.809811ms)","trace[838983936] 'applied index is now lower than readState.Index' (duration: 55.239398ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:45:05.151598Z","caller":"traceutil/trace.go:171","msg":"trace[910589784] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"514.848649ms","start":"2026-06-10T02:45:04.636728Z","end":"2026-06-10T02:45:05.151576Z","steps":["trace[910589784] 'process raft request' (duration: 514.397776ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:45:05.151731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:45:04.636712Z","time spent":"514.94067ms","remote":"127.0.0.1:34160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T02:45:05.15176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.275635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-10T02:45:05.151808Z","caller":"traceutil/trace.go:171","msg":"trace[1068586164] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:643; }","duration":"513.364708ms","start":"2026-06-10T02:45:04.638432Z","end":"2026-06-10T02:45:05.151796Z","steps":["trace[1068586164] 'agreement among raft nodes before linearized reading' (duration: 513.258765ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:45:05.151811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.697933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-10T02:45:05.151844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:45:04.638418Z","time spent":"513.417739ms","remote":"127.0.0.1:34174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"info","ts":"2026-06-10T02:45:05.151857Z","caller":"traceutil/trace.go:171","msg":"trace[641589114] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:643; }","duration":"169.778945ms","start":"2026-06-10T02:45:04.982067Z","end":"2026-06-10T02:45:05.151846Z","steps":["trace[641589114] 'agreement among raft nodes before linearized reading' (duration: 169.643341ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:45:05.151892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.555427ms","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":"info","ts":"2026-06-10T02:45:05.152048Z","caller":"traceutil/trace.go:171","msg":"trace[1669564441] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:643; }","duration":"507.815714ms","start":"2026-06-10T02:45:04.644185Z","end":"2026-06-10T02:45:05.152001Z","steps":["trace[1669564441] 'agreement among raft nodes before linearized reading' (duration: 507.527496ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:45:05.15214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:45:04.64418Z","time spent":"507.945848ms","remote":"127.0.0.1:34138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-06-10T02:45:05.152008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.879923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T02:45:05.152321Z","caller":"traceutil/trace.go:171","msg":"trace[1306724080] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:643; }","duration":"364.235393ms","start":"2026-06-10T02:45:04.788063Z","end":"2026-06-10T02:45:05.152298Z","steps":["trace[1306724080] 'agreement among raft nodes before linearized reading' (duration: 363.859273ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:45:05.152386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:45:04.788041Z","time spent":"364.333716ms","remote":"127.0.0.1:33920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-10T02:45:06.734303Z","caller":"traceutil/trace.go:171","msg":"trace[1156504110] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"153.024022ms","start":"2026-06-10T02:45:06.581257Z","end":"2026-06-10T02:45:06.734281Z","steps":["trace[1156504110] 'process raft request' (duration: 152.886737ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:45:20.33141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.190094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T02:45:20.33153Z","caller":"traceutil/trace.go:171","msg":"trace[468333820] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:800; }","duration":"542.353029ms","start":"2026-06-10T02:45:19.789151Z","end":"2026-06-10T02:45:20.331504Z","steps":["trace[468333820] 'range keys from in-memory index tree' (duration: 542.109681ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:45:20.331581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:45:19.789126Z","time spent":"542.442241ms","remote":"127.0.0.1:33920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-10T02:45:47.658436Z","caller":"traceutil/trace.go:171","msg":"trace[1433164528] linearizableReadLoop","detail":"{readStateIndex:1227; appliedIndex:1226; }","duration":"252.499043ms","start":"2026-06-10T02:45:47.405911Z","end":"2026-06-10T02:45:47.65841Z","steps":["trace[1433164528] 'read index received' (duration: 252.312188ms)","trace[1433164528] 'applied index is now lower than readState.Index' (duration: 185.785µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:45:47.658491Z","caller":"traceutil/trace.go:171","msg":"trace[1353391366] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"529.36933ms","start":"2026-06-10T02:45:47.129083Z","end":"2026-06-10T02:45:47.658452Z","steps":["trace[1353391366] 'process raft request' (duration: 529.157894ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:45:47.65865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:45:47.129059Z","time spent":"529.509854ms","remote":"127.0.0.1:34160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T02:45:47.658698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.76835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-10T02:45:47.658738Z","caller":"traceutil/trace.go:171","msg":"trace[1913205741] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1196; }","duration":"252.885313ms","start":"2026-06-10T02:45:47.405839Z","end":"2026-06-10T02:45:47.658725Z","steps":["trace[1913205741] 'agreement among raft nodes before linearized reading' (duration: 252.725779ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:45:47.65885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.246959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-10T02:45:47.658946Z","caller":"traceutil/trace.go:171","msg":"trace[193367992] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1196; }","duration":"251.382082ms","start":"2026-06-10T02:45:47.407544Z","end":"2026-06-10T02:45:47.658926Z","steps":["trace[193367992] 'agreement among raft nodes before linearized reading' (duration: 251.119425ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:45:47.659001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.617252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-10T02:45:47.659157Z","caller":"traceutil/trace.go:171","msg":"trace[689104719] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1196; }","duration":"245.831237ms","start":"2026-06-10T02:45:47.413298Z","end":"2026-06-10T02:45:47.65913Z","steps":["trace[689104719] 'agreement among raft nodes before linearized reading' (duration: 245.433807ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:45:47.659543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.815951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-10T02:45:47.659684Z","caller":"traceutil/trace.go:171","msg":"trace[354837672] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1196; }","duration":"244.985265ms","start":"2026-06-10T02:45:47.414674Z","end":"2026-06-10T02:45:47.659659Z","steps":["trace[354837672] 'agreement among raft nodes before linearized reading' (duration: 244.578214ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:46:10.005401Z","caller":"traceutil/trace.go:171","msg":"trace[1467720543] linearizableReadLoop","detail":"{readStateIndex:1494; appliedIndex:1493; }","duration":"199.428406ms","start":"2026-06-10T02:46:09.805947Z","end":"2026-06-10T02:46:10.005375Z","steps":["trace[1467720543] 'read index received' (duration: 199.20062ms)","trace[1467720543] 'applied index is now lower than readState.Index' (duration: 226.836µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:46:10.005523Z","caller":"traceutil/trace.go:171","msg":"trace[157113779] transaction","detail":"{read_only:false; response_revision:1454; number_of_response:1; }","duration":"199.676472ms","start":"2026-06-10T02:46:09.805812Z","end":"2026-06-10T02:46:10.005489Z","steps":["trace[157113779] 'process raft request' (duration: 199.397395ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:46:10.005656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.609551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-10T02:46:10.005704Z","caller":"traceutil/trace.go:171","msg":"trace[1377413759] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1454; }","duration":"199.717883ms","start":"2026-06-10T02:46:09.805975Z","end":"2026-06-10T02:46:10.005692Z","steps":["trace[1377413759] 'agreement among raft nodes before linearized reading' (duration: 199.553219ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:46:10.005742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.759245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-10T02:46:10.005782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.262712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-10T02:46:10.005866Z","caller":"traceutil/trace.go:171","msg":"trace[191507621] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1454; }","duration":"199.917389ms","start":"2026-06-10T02:46:09.805916Z","end":"2026-06-10T02:46:10.005833Z","steps":["trace[191507621] 'agreement among raft nodes before linearized reading' (duration: 199.608131ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:46:10.005866Z","caller":"traceutil/trace.go:171","msg":"trace[1148020698] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1454; }","duration":"199.368945ms","start":"2026-06-10T02:46:09.806475Z","end":"2026-06-10T02:46:10.005844Z","steps":["trace[1148020698] 'agreement among raft nodes before linearized reading' (duration: 199.159949ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:46:10.147076Z","caller":"traceutil/trace.go:171","msg":"trace[50421750] transaction","detail":"{read_only:false; response_revision:1456; number_of_response:1; }","duration":"136.41932ms","start":"2026-06-10T02:46:10.010574Z","end":"2026-06-10T02:46:10.146993Z","steps":["trace[50421750] 'process raft request' (duration: 121.886229ms)","trace[50421750] 'compare' (duration: 14.202112ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:46:10.147081Z","caller":"traceutil/trace.go:171","msg":"trace[1873504627] transaction","detail":"{read_only:false; response_revision:1457; number_of_response:1; }","duration":"136.331947ms","start":"2026-06-10T02:46:10.010718Z","end":"2026-06-10T02:46:10.14705Z","steps":["trace[1873504627] 'process raft request' (duration: 136.179602ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:46:36.274614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.333983ms","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-06-10T02:46:36.274705Z","caller":"traceutil/trace.go:171","msg":"trace[941511709] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1880; }","duration":"142.465116ms","start":"2026-06-10T02:46:36.132222Z","end":"2026-06-10T02:46:36.274687Z","steps":["trace[941511709] 'range keys from in-memory index tree' (duration: 142.178798ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:46:36.274755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.658663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-10T02:46:36.274836Z","caller":"traceutil/trace.go:171","msg":"trace[285895032] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1880; }","duration":"137.797697ms","start":"2026-06-10T02:46:36.137021Z","end":"2026-06-10T02:46:36.274819Z","steps":["trace[285895032] 'range keys from in-memory index tree' (duration: 137.427937ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:46:36.472703Z","caller":"traceutil/trace.go:171","msg":"trace[1464278388] linearizableReadLoop","detail":"{readStateIndex:1952; appliedIndex:1951; }","duration":"118.828695ms","start":"2026-06-10T02:46:36.353843Z","end":"2026-06-10T02:46:36.472672Z","steps":["trace[1464278388] 'read index received' (duration: 38.84295ms)","trace[1464278388] 'applied index is now lower than readState.Index' (duration: 79.984485ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:46:36.472774Z","caller":"traceutil/trace.go:171","msg":"trace[557447707] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"147.450414ms","start":"2026-06-10T02:46:36.325273Z","end":"2026-06-10T02:46:36.472724Z","steps":["trace[557447707] 'process raft request' (duration: 67.393088ms)","trace[557447707] 'compare' (duration: 79.818959ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:46:36.472849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.984288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T02:46:36.472899Z","caller":"traceutil/trace.go:171","msg":"trace[725388414] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1885; }","duration":"119.094272ms","start":"2026-06-10T02:46:36.353794Z","end":"2026-06-10T02:46:36.472888Z","steps":["trace[725388414] 'agreement among raft nodes before linearized reading' (duration: 118.99293ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:46:37.096847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.592955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T02:46:37.09693Z","caller":"traceutil/trace.go:171","msg":"trace[935003614] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1885; }","duration":"308.737529ms","start":"2026-06-10T02:46:36.788174Z","end":"2026-06-10T02:46:37.096911Z","steps":["trace[935003614] 'range keys from in-memory index tree' (duration: 308.480312ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:46:37.096974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:46:36.788145Z","time spent":"308.821511ms","remote":"127.0.0.1:33928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-10T02:46:37.096995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.389948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-10T02:46:37.097107Z","caller":"traceutil/trace.go:171","msg":"trace[619783080] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1885; }","duration":"505.533802ms","start":"2026-06-10T02:46:36.591529Z","end":"2026-06-10T02:46:37.097063Z","steps":["trace[619783080] 'range keys from in-memory index tree' (duration: 505.188552ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:46:37.097197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:46:36.591485Z","time spent":"505.697027ms","remote":"127.0.0.1:49438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-10T02:46:37.097644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.476949ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T02:46:37.097752Z","caller":"traceutil/trace.go:171","msg":"trace[1438459201] linearizableReadLoop","detail":"{readStateIndex:1953; appliedIndex:1952; }","duration":"294.879256ms","start":"2026-06-10T02:46:36.802855Z","end":"2026-06-10T02:46:37.097734Z","steps":["trace[1438459201] 'read index received' (duration: 178.081898ms)","trace[1438459201] 'applied index is now lower than readState.Index' (duration: 116.795788ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:46:37.098047Z","caller":"traceutil/trace.go:171","msg":"trace[436186269] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"303.063091ms","start":"2026-06-10T02:46:36.794961Z","end":"2026-06-10T02:46:37.098024Z","steps":["trace[436186269] 'process raft request' (duration: 186.099088ms)","trace[436186269] 'compare' (duration: 116.005307ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:46:37.098168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:46:36.794928Z","time spent":"303.177816ms","remote":"127.0.0.1:34160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T02:46:37.098199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.340709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-faa3ce23-d780-4c20-9650-485d76b2bc50\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-10T02:46:37.09827Z","caller":"traceutil/trace.go:171","msg":"trace[286906608] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-faa3ce23-d780-4c20-9650-485d76b2bc50; range_end:; response_count:1; response_revision:1886; }","duration":"295.513004ms","start":"2026-06-10T02:46:36.802739Z","end":"2026-06-10T02:46:37.098252Z","steps":["trace[286906608] 'agreement among raft nodes before linearized reading' (duration: 295.309369ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:46:37.098302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.741423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-faa3ce23-d780-4c20-9650-485d76b2bc50\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-10T02:46:37.0984Z","caller":"traceutil/trace.go:171","msg":"trace[488613172] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-faa3ce23-d780-4c20-9650-485d76b2bc50; range_end:; response_count:1; response_revision:1886; }","duration":"236.907678ms","start":"2026-06-10T02:46:36.861466Z","end":"2026-06-10T02:46:37.098374Z","steps":["trace[488613172] 'agreement among raft nodes before linearized reading' (duration: 236.60088ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:46:37.098698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.866579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-10T02:46:37.098756Z","caller":"traceutil/trace.go:171","msg":"trace[991115114] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1886; }","duration":"269.258921ms","start":"2026-06-10T02:46:36.829483Z","end":"2026-06-10T02:46:37.098742Z","steps":["trace[991115114] 'agreement among raft nodes before linearized reading' (duration: 268.543911ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:46:37.559279Z","caller":"traceutil/trace.go:171","msg":"trace[821674183] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"455.797461ms","start":"2026-06-10T02:46:37.103455Z","end":"2026-06-10T02:46:37.559253Z","steps":["trace[821674183] 'process raft request' (duration: 418.024831ms)","trace[821674183] 'compare' (duration: 36.652099ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:46:37.55977Z","caller":"traceutil/trace.go:171","msg":"trace[1208070284] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"433.727441ms","start":"2026-06-10T02:46:37.126013Z","end":"2026-06-10T02:46:37.55974Z","steps":["trace[1208070284] 'process raft request' (duration: 433.471085ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:46:37.559798Z","caller":"traceutil/trace.go:171","msg":"trace[1571986453] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"453.396824ms","start":"2026-06-10T02:46:37.106367Z","end":"2026-06-10T02:46:37.559764Z","steps":["trace[1571986453] 'process raft request' (duration: 452.824418ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:46:37.560017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:46:37.125996Z","time spent":"433.865616ms","remote":"127.0.0.1:34160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T02:46:37.560074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:46:37.106359Z","time spent":"453.538148ms","remote":"127.0.0.1:34094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T02:46:37.560054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:46:37.103429Z","time spent":"455.932094ms","remote":"127.0.0.1:34160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T02:46:52.755686Z","caller":"traceutil/trace.go:171","msg":"trace[712251394] linearizableReadLoop","detail":"{readStateIndex:2081; appliedIndex:2080; }","duration":"380.96267ms","start":"2026-06-10T02:46:52.374689Z","end":"2026-06-10T02:46:52.755652Z","steps":["trace[712251394] 'read index received' (duration: 380.818295ms)","trace[712251394] 'applied index is now lower than readState.Index' (duration: 142.805µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:46:52.75582Z","caller":"traceutil/trace.go:171","msg":"trace[83286173] transaction","detail":"{read_only:false; response_revision:2010; number_of_response:1; }","duration":"382.150002ms","start":"2026-06-10T02:46:52.373633Z","end":"2026-06-10T02:46:52.755783Z","steps":["trace[83286173] 'process raft request' (duration: 381.815563ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:46:52.756003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.283868ms","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-06-10T02:46:52.756031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:46:52.373613Z","time spent":"382.298115ms","remote":"127.0.0.1:34160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T02:46:52.756068Z","caller":"traceutil/trace.go:171","msg":"trace[2147165375] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2010; }","duration":"381.407771ms","start":"2026-06-10T02:46:52.374644Z","end":"2026-06-10T02:46:52.756052Z","steps":["trace[2147165375] 'agreement among raft nodes before linearized reading' (duration: 381.186975ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:46:52.756123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:46:52.374617Z","time spent":"381.494033ms","remote":"127.0.0.1:34160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-10T02:46:52.757471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.03757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T02:46:52.757504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.779459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-10T02:46:52.75759Z","caller":"traceutil/trace.go:171","msg":"trace[1404724835] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2011; }","duration":"382.904943ms","start":"2026-06-10T02:46:52.374668Z","end":"2026-06-10T02:46:52.757573Z","steps":["trace[1404724835] 'agreement among raft nodes before linearized reading' (duration: 382.692887ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:46:52.757636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:46:52.374646Z","time spent":"382.981785ms","remote":"127.0.0.1:34160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-10T02:46:52.757646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.249103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-10T02:46:52.757735Z","caller":"traceutil/trace.go:171","msg":"trace[2029810396] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2011; }","duration":"379.368225ms","start":"2026-06-10T02:46:52.378348Z","end":"2026-06-10T02:46:52.757716Z","steps":["trace[2029810396] 'agreement among raft nodes before linearized reading' (duration: 379.17206ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:46:52.757775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:46:52.378336Z","time spent":"379.430786ms","remote":"127.0.0.1:34160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-10T02:46:52.75761Z","caller":"traceutil/trace.go:171","msg":"trace[1260572183] transaction","detail":"{read_only:false; response_revision:2011; number_of_response:1; }","duration":"229.901766ms","start":"2026-06-10T02:46:52.527589Z","end":"2026-06-10T02:46:52.757491Z","steps":["trace[1260572183] 'process raft request' (duration: 229.68016ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:46:52.757555Z","caller":"traceutil/trace.go:171","msg":"trace[1047790345] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:2011; }","duration":"328.178514ms","start":"2026-06-10T02:46:52.429354Z","end":"2026-06-10T02:46:52.757532Z","steps":["trace[1047790345] 'agreement among raft nodes before linearized reading' (duration: 328.04458ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:46:52.758706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:46:52.429336Z","time spent":"329.313125ms","remote":"127.0.0.1:34208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"info","ts":"2026-06-10T02:47:21.129166Z","caller":"traceutil/trace.go:171","msg":"trace[1770175905] linearizableReadLoop","detail":"{readStateIndex:2250; appliedIndex:2249; }","duration":"193.735398ms","start":"2026-06-10T02:47:20.935408Z","end":"2026-06-10T02:47:21.129143Z","steps":["trace[1770175905] 'read index received' (duration: 193.546372ms)","trace[1770175905] 'applied index is now lower than readState.Index' (duration: 187.796µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:47:21.12925Z","caller":"traceutil/trace.go:171","msg":"trace[1859923651] transaction","detail":"{read_only:false; response_revision:2173; number_of_response:1; }","duration":"259.002396ms","start":"2026-06-10T02:47:20.870215Z","end":"2026-06-10T02:47:21.129217Z","steps":["trace[1859923651] 'process raft request' (duration: 258.753269ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:47:21.129411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.981424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-10T02:47:21.129451Z","caller":"traceutil/trace.go:171","msg":"trace[1073392861] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2173; }","duration":"194.072337ms","start":"2026-06-10T02:47:20.935368Z","end":"2026-06-10T02:47:21.12944Z","steps":["trace[1073392861] 'agreement among raft nodes before linearized reading' (duration: 193.906643ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:47:21.129626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.834294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-10T02:47:21.129693Z","caller":"traceutil/trace.go:171","msg":"trace[1248244755] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2173; }","duration":"159.941547ms","start":"2026-06-10T02:47:20.969736Z","end":"2026-06-10T02:47:21.129677Z","steps":["trace[1248244755] 'agreement among raft nodes before linearized reading' (duration: 159.748682ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:47:21.129722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.587307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-10T02:47:21.129749Z","caller":"traceutil/trace.go:171","msg":"trace[664103803] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2173; }","duration":"159.631227ms","start":"2026-06-10T02:47:20.970109Z","end":"2026-06-10T02:47:21.129741Z","steps":["trace[664103803] 'agreement among raft nodes before linearized reading' (duration: 159.556175ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:47:21.129638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.02723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-10T02:47:21.129808Z","caller":"traceutil/trace.go:171","msg":"trace[447053826] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2173; }","duration":"155.219897ms","start":"2026-06-10T02:47:20.974566Z","end":"2026-06-10T02:47:21.129786Z","steps":["trace[447053826] 'agreement among raft nodes before linearized reading' (duration: 155.011912ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:47:21.314817Z","caller":"traceutil/trace.go:171","msg":"trace[1449365186] transaction","detail":"{read_only:false; response_revision:2176; number_of_response:1; }","duration":"181.287045ms","start":"2026-06-10T02:47:21.133511Z","end":"2026-06-10T02:47:21.314798Z","steps":["trace[1449365186] 'process raft request' (duration: 181.238553ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:47:21.314922Z","caller":"traceutil/trace.go:171","msg":"trace[1414693244] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"181.591463ms","start":"2026-06-10T02:47:21.133293Z","end":"2026-06-10T02:47:21.314884Z","steps":["trace[1414693244] 'process raft request' (duration: 139.04105ms)","trace[1414693244] 'compare' (duration: 42.252355ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:47:21.314926Z","caller":"traceutil/trace.go:171","msg":"trace[241785968] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"181.526051ms","start":"2026-06-10T02:47:21.133366Z","end":"2026-06-10T02:47:21.314892Z","steps":["trace[241785968] 'process raft request' (duration: 181.353256ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:47:21.315174Z","caller":"traceutil/trace.go:171","msg":"trace[1934974235] transaction","detail":"{read_only:false; response_revision:2177; number_of_response:1; }","duration":"180.533983ms","start":"2026-06-10T02:47:21.134623Z","end":"2026-06-10T02:47:21.315157Z","steps":["trace[1934974235] 'process raft request' (duration: 180.152093ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:47:27.273149Z","caller":"traceutil/trace.go:171","msg":"trace[1454294102] transaction","detail":"{read_only:false; response_revision:2205; number_of_response:1; }","duration":"124.955253ms","start":"2026-06-10T02:47:27.148162Z","end":"2026-06-10T02:47:27.273117Z","steps":["trace[1454294102] 'process raft request' (duration: 124.720146ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:47:27.647435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.191791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-10T02:47:27.647531Z","caller":"traceutil/trace.go:171","msg":"trace[610405699] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2210; }","duration":"112.335595ms","start":"2026-06-10T02:47:27.53516Z","end":"2026-06-10T02:47:27.647495Z","steps":["trace[610405699] 'range keys from in-memory index tree' (duration: 111.995976ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:47:27.938742Z","caller":"traceutil/trace.go:171","msg":"trace[975041743] linearizableReadLoop","detail":"{readStateIndex:2290; appliedIndex:2289; }","duration":"122.980559ms","start":"2026-06-10T02:47:27.815742Z","end":"2026-06-10T02:47:27.938723Z","steps":["trace[975041743] 'read index received' (duration: 122.905156ms)","trace[975041743] 'applied index is now lower than readState.Index' (duration: 74.753µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:47:27.938804Z","caller":"traceutil/trace.go:171","msg":"trace[19265470] transaction","detail":"{read_only:false; response_revision:2211; number_of_response:1; }","duration":"125.437315ms","start":"2026-06-10T02:47:27.813343Z","end":"2026-06-10T02:47:27.938781Z","steps":["trace[19265470] 'process raft request' (duration: 125.25222ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:47:27.939062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.255146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-10T02:47:27.939157Z","caller":"traceutil/trace.go:171","msg":"trace[1473335588] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2211; }","duration":"123.41771ms","start":"2026-06-10T02:47:27.815719Z","end":"2026-06-10T02:47:27.939136Z","steps":["trace[1473335588] 'agreement among raft nodes before linearized reading' (duration: 123.098291ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:47:28.194305Z","caller":"traceutil/trace.go:171","msg":"trace[979928292] transaction","detail":"{read_only:false; response_revision:2212; number_of_response:1; }","duration":"342.157697ms","start":"2026-06-10T02:47:27.85212Z","end":"2026-06-10T02:47:28.194278Z","steps":["trace[979928292] 'process raft request' (duration: 322.966108ms)","trace[979928292] 'compare' (duration: 18.707315ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:47:28.194473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:47:27.852089Z","time spent":"342.296261ms","remote":"127.0.0.1:34160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T02:47:28.194628Z","caller":"traceutil/trace.go:171","msg":"trace[408512040] transaction","detail":"{read_only:false; response_revision:2213; number_of_response:1; }","duration":"251.475189ms","start":"2026-06-10T02:47:27.94313Z","end":"2026-06-10T02:47:28.194605Z","steps":["trace[408512040] 'process raft request' (duration: 251.075157ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:47:29.479586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"763.038363ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-10T02:47:29.47972Z","caller":"traceutil/trace.go:171","msg":"trace[1352948667] linearizableReadLoop","detail":"{readStateIndex:2294; appliedIndex:2293; }","duration":"824.842646ms","start":"2026-06-10T02:47:28.654859Z","end":"2026-06-10T02:47:29.479702Z","steps":["trace[1352948667] 'read index received' (duration: 61.71157ms)","trace[1352948667] 'applied index is now lower than readState.Index' (duration: 763.129516ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:47:29.480188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"825.316678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-10T02:47:29.480237Z","caller":"traceutil/trace.go:171","msg":"trace[1783548269] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2214; }","duration":"825.435282ms","start":"2026-06-10T02:47:28.654787Z","end":"2026-06-10T02:47:29.480222Z","steps":["trace[1783548269] 'agreement among raft nodes before linearized reading' (duration: 825.255867ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:47:29.480272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:47:28.654765Z","time spent":"825.498384ms","remote":"127.0.0.1:49438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-06-10T02:47:29.678351Z","caller":"traceutil/trace.go:171","msg":"trace[981157732] transaction","detail":"{read_only:false; response_revision:2215; number_of_response:1; }","duration":"412.603488ms","start":"2026-06-10T02:47:29.265699Z","end":"2026-06-10T02:47:29.678303Z","steps":["trace[981157732] 'process raft request' (duration: 412.172306ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:47:29.67867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:47:29.26567Z","time spent":"412.897097ms","remote":"127.0.0.1:34080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8572,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T02:47:29.804612Z","caller":"traceutil/trace.go:171","msg":"trace[1500940845] transaction","detail":"{read_only:false; response_revision:2217; number_of_response:1; }","duration":"433.170854ms","start":"2026-06-10T02:47:29.37141Z","end":"2026-06-10T02:47:29.804581Z","steps":["trace[1500940845] 'process raft request' (duration: 433.073051ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:47:29.80478Z","caller":"traceutil/trace.go:171","msg":"trace[306671174] linearizableReadLoop","detail":"{readStateIndex:2297; appliedIndex:2294; }","duration":"324.999334ms","start":"2026-06-10T02:47:29.479749Z","end":"2026-06-10T02:47:29.804748Z","steps":["trace[306671174] 'read index received' (duration: 198.302013ms)","trace[306671174] 'applied index is now lower than readState.Index' (duration: 126.695831ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:47:29.804825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:47:29.37138Z","time spent":"433.32958ms","remote":"127.0.0.1:34160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T02:47:29.804624Z","caller":"traceutil/trace.go:171","msg":"trace[1897892558] transaction","detail":"{read_only:false; response_revision:2216; number_of_response:1; }","duration":"526.69919ms","start":"2026-06-10T02:47:29.277888Z","end":"2026-06-10T02:47:29.804587Z","steps":["trace[1897892558] 'process raft request' (duration: 526.360091ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:47:29.805025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"810.569922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18b7984a6b956c4a\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-06-10T02:47:29.805073Z","caller":"traceutil/trace.go:171","msg":"trace[1894111696] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18b7984a6b956c4a; range_end:; response_count:1; response_revision:2218; }","duration":"810.663216ms","start":"2026-06-10T02:47:28.994394Z","end":"2026-06-10T02:47:29.805057Z","steps":["trace[1894111696] 'agreement among raft nodes before linearized reading' (duration: 810.490591ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:47:29.805087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.636783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T02:47:29.80519Z","caller":"traceutil/trace.go:171","msg":"trace[1475101699] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:2218; }","duration":"239.796217ms","start":"2026-06-10T02:47:29.565372Z","end":"2026-06-10T02:47:29.805168Z","steps":["trace[1475101699] 'agreement among raft nodes before linearized reading' (duration: 239.616002ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:47:29.805222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.457277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-10T02:47:29.805258Z","caller":"traceutil/trace.go:171","msg":"trace[1616527809] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2218; }","duration":"378.568321ms","start":"2026-06-10T02:47:29.426681Z","end":"2026-06-10T02:47:29.805249Z","steps":["trace[1616527809] 'agreement among raft nodes before linearized reading' (duration: 378.475279ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:47:29.805274Z","caller":"traceutil/trace.go:171","msg":"trace[884111642] transaction","detail":"{read_only:false; response_revision:2218; number_of_response:1; }","duration":"237.652368ms","start":"2026-06-10T02:47:29.567599Z","end":"2026-06-10T02:47:29.805251Z","steps":["trace[884111642] 'process raft request' (duration: 236.933978ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:47:29.80529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:47:29.426654Z","time spent":"378.630022ms","remote":"127.0.0.1:34160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-10T02:47:29.805335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.363877ms","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-06-10T02:47:29.805117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:47:28.994379Z","time spent":"810.728437ms","remote":"127.0.0.1:33978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":869,"request content":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18b7984a6b956c4a\" "} {"level":"info","ts":"2026-06-10T02:47:29.805394Z","caller":"traceutil/trace.go:171","msg":"trace[1706371261] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2218; }","duration":"377.44895ms","start":"2026-06-10T02:47:29.427932Z","end":"2026-06-10T02:47:29.805381Z","steps":["trace[1706371261] 'agreement among raft nodes before linearized reading' (duration: 377.262824ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:47:29.805438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:47:29.427922Z","time spent":"377.507291ms","remote":"127.0.0.1:34160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-10T02:47:29.805072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.640265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-10T02:47:29.805485Z","caller":"traceutil/trace.go:171","msg":"trace[969729653] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2218; }","duration":"378.108767ms","start":"2026-06-10T02:47:29.427362Z","end":"2026-06-10T02:47:29.805471Z","steps":["trace[969729653] 'agreement among raft nodes before linearized reading' (duration: 377.422028ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:47:29.805532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:47:29.427334Z","time spent":"378.18782ms","remote":"127.0.0.1:34160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-10T02:47:29.805503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.150489178s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T02:47:29.805593Z","caller":"traceutil/trace.go:171","msg":"trace[91613851] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:2218; }","duration":"1.150660603s","start":"2026-06-10T02:47:28.654911Z","end":"2026-06-10T02:47:29.805571Z","steps":["trace[91613851] 'agreement among raft nodes before linearized reading' (duration: 1.150469208s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:47:29.805648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:47:28.654889Z","time spent":"1.150746465s","remote":"127.0.0.1:49666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":30,"request content":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true "} {"level":"warn","ts":"2026-06-10T02:47:29.805061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:47:29.277869Z","time spent":"527.04029ms","remote":"127.0.0.1:34160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T02:47:29.805214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.600441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-10T02:47:29.805964Z","caller":"traceutil/trace.go:171","msg":"trace[1014848806] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2218; }","duration":"379.406593ms","start":"2026-06-10T02:47:29.426539Z","end":"2026-06-10T02:47:29.805945Z","steps":["trace[1014848806] 'agreement among raft nodes before linearized reading' (duration: 378.257561ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:47:29.806026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:47:29.426515Z","time spent":"379.484736ms","remote":"127.0.0.1:34160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-10T02:48:18.277687Z","caller":"traceutil/trace.go:171","msg":"trace[635206405] transaction","detail":"{read_only:false; response_revision:2653; number_of_response:1; }","duration":"172.920761ms","start":"2026-06-10T02:48:18.104732Z","end":"2026-06-10T02:48:18.277653Z","steps":["trace[635206405] 'process raft request' (duration: 137.666507ms)","trace[635206405] 'compare' (duration: 35.09933ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:48:19.045307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.328241ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-10T02:48:19.045461Z","caller":"traceutil/trace.go:171","msg":"trace[317083054] linearizableReadLoop","detail":"{readStateIndex:2752; appliedIndex:2751; }","duration":"349.517153ms","start":"2026-06-10T02:48:18.695919Z","end":"2026-06-10T02:48:19.045436Z","steps":["trace[317083054] 'read index received' (duration: 77.761µs)","trace[317083054] 'applied index is now lower than readState.Index' (duration: 349.437522ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:48:19.045811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.402049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T02:48:19.045891Z","caller":"traceutil/trace.go:171","msg":"trace[898848390] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2655; }","duration":"345.536243ms","start":"2026-06-10T02:48:18.700335Z","end":"2026-06-10T02:48:19.045871Z","steps":["trace[898848390] 'agreement among raft nodes before linearized reading' (duration: 345.386109ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:48:19.04593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:48:18.700313Z","time spent":"345.608557ms","remote":"127.0.0.1:60542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-10T02:48:19.046418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.469119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T02:48:19.046779Z","caller":"traceutil/trace.go:171","msg":"trace[571227633] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2655; }","duration":"350.846289ms","start":"2026-06-10T02:48:18.695905Z","end":"2026-06-10T02:48:19.046751Z","steps":["trace[571227633] 'agreement among raft nodes before linearized reading' (duration: 350.414547ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:48:19.046845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:48:18.695849Z","time spent":"350.972395ms","remote":"127.0.0.1:49430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"info","ts":"2026-06-10T02:48:52.36502Z","caller":"traceutil/trace.go:171","msg":"trace[1519975450] transaction","detail":"{read_only:false; response_revision:2853; number_of_response:1; }","duration":"277.7932ms","start":"2026-06-10T02:48:52.0872Z","end":"2026-06-10T02:48:52.364993Z","steps":["trace[1519975450] 'process raft request' (duration: 277.635005ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:48:52.43196Z","caller":"traceutil/trace.go:171","msg":"trace[1358452819] linearizableReadLoop","detail":"{readStateIndex:2958; appliedIndex:2956; }","duration":"146.154781ms","start":"2026-06-10T02:48:52.285783Z","end":"2026-06-10T02:48:52.431938Z","steps":["trace[1358452819] 'read index received' (duration: 79.157078ms)","trace[1358452819] 'applied index is now lower than readState.Index' (duration: 66.996803ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:48:52.43221Z","caller":"traceutil/trace.go:171","msg":"trace[690819071] transaction","detail":"{read_only:false; response_revision:2854; number_of_response:1; }","duration":"325.196491ms","start":"2026-06-10T02:48:52.106959Z","end":"2026-06-10T02:48:52.432155Z","steps":["trace[690819071] 'process raft request' (duration: 320.776759ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:48:52.432413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:48:52.106934Z","time spent":"325.374026ms","remote":"127.0.0.1:34160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T02:48:52.432405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.600833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-10T02:48:52.432481Z","caller":"traceutil/trace.go:171","msg":"trace[1757705435] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2854; }","duration":"146.728866ms","start":"2026-06-10T02:48:52.285733Z","end":"2026-06-10T02:48:52.432462Z","steps":["trace[1757705435] 'agreement among raft nodes before linearized reading' (duration: 146.444129ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:48:53.013395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.702461ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T02:48:53.013638Z","caller":"traceutil/trace.go:171","msg":"trace[29973755] transaction","detail":"{read_only:false; response_revision:2857; number_of_response:1; }","duration":"574.960486ms","start":"2026-06-10T02:48:52.438652Z","end":"2026-06-10T02:48:53.013612Z","steps":["trace[29973755] 'process raft request' (duration: 285.934936ms)","trace[29973755] 'compare' (duration: 287.963611ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:48:53.01375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:48:52.438633Z","time spent":"575.058249ms","remote":"127.0.0.1:34160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T02:48:53.013792Z","caller":"traceutil/trace.go:171","msg":"trace[2118318525] transaction","detail":"{read_only:false; response_revision:2858; number_of_response:1; }","duration":"574.948107ms","start":"2026-06-10T02:48:52.438833Z","end":"2026-06-10T02:48:53.013781Z","steps":["trace[2118318525] 'process raft request' (duration: 574.67905ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:48:53.013735Z","caller":"traceutil/trace.go:171","msg":"trace[1234532786] transaction","detail":"{read_only:false; response_revision:2859; number_of_response:1; }","duration":"574.463662ms","start":"2026-06-10T02:48:52.439228Z","end":"2026-06-10T02:48:53.013692Z","steps":["trace[1234532786] 'process raft request' (duration: 574.400841ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:48:53.013866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:48:52.43922Z","time spent":"574.627928ms","remote":"127.0.0.1:34160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T02:48:53.013883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:48:52.438824Z","time spent":"575.009909ms","remote":"127.0.0.1:34160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T02:48:53.015724Z","caller":"traceutil/trace.go:171","msg":"trace[54023226] linearizableReadLoop","detail":"{readStateIndex:2964; appliedIndex:2960; }","duration":"510.652449ms","start":"2026-06-10T02:48:52.50505Z","end":"2026-06-10T02:48:53.015702Z","steps":["trace[54023226] 'read index received' (duration: 219.644674ms)","trace[54023226] 'applied index is now lower than readState.Index' (duration: 291.006675ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:48:53.015931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.029026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T02:48:53.015973Z","caller":"traceutil/trace.go:171","msg":"trace[570194712] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2860; }","duration":"227.109869ms","start":"2026-06-10T02:48:52.788851Z","end":"2026-06-10T02:48:53.015961Z","steps":["trace[570194712] 'agreement among raft nodes before linearized reading' (duration: 227.022646ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:48:53.015963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.629179ms","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":"warn","ts":"2026-06-10T02:48:53.015956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.887126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-06-10T02:48:53.016005Z","caller":"traceutil/trace.go:171","msg":"trace[1156858627] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2860; }","duration":"378.727022ms","start":"2026-06-10T02:48:52.637267Z","end":"2026-06-10T02:48:53.015994Z","steps":["trace[1156858627] 'agreement among raft nodes before linearized reading' (duration: 378.573997ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:48:53.016022Z","caller":"traceutil/trace.go:171","msg":"trace[1601637266] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2860; }","duration":"510.997048ms","start":"2026-06-10T02:48:52.505012Z","end":"2026-06-10T02:48:53.016009Z","steps":["trace[1601637266] 'agreement among raft nodes before linearized reading' (duration: 510.809403ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:48:53.016042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:48:52.637236Z","time spent":"378.798222ms","remote":"127.0.0.1:34160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-10T02:48:53.016065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:48:52.504962Z","time spent":"511.093171ms","remote":"127.0.0.1:34102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1392,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"info","ts":"2026-06-10T02:48:53.016303Z","caller":"traceutil/trace.go:171","msg":"trace[684134136] transaction","detail":"{read_only:false; response_revision:2860; number_of_response:1; }","duration":"512.16575ms","start":"2026-06-10T02:48:52.5036Z","end":"2026-06-10T02:48:53.015766Z","steps":["trace[684134136] 'process raft request' (duration: 511.962815ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:48:53.016417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:48:52.503566Z","time spent":"512.783258ms","remote":"127.0.0.1:34160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T02:48:53.443364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.485174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.242\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-10T02:48:53.443534Z","caller":"traceutil/trace.go:171","msg":"trace[413830974] range","detail":"{range_begin:/registry/masterleases/199.204.45.242; range_end:; response_count:1; response_revision:2861; }","duration":"187.70768ms","start":"2026-06-10T02:48:53.255803Z","end":"2026-06-10T02:48:53.443511Z","steps":["trace[413830974] 'range keys from in-memory index tree' (duration: 187.278388ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:48:58.764526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.616978ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-10T02:50:52.775368Z","caller":"traceutil/trace.go:171","msg":"trace[251313500] transaction","detail":"{read_only:false; response_revision:3653; number_of_response:1; }","duration":"112.329578ms","start":"2026-06-10T02:50:52.663001Z","end":"2026-06-10T02:50:52.77533Z","steps":["trace[251313500] 'process raft request' (duration: 111.973399ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:51:29.152222Z","caller":"traceutil/trace.go:171","msg":"trace[236619726] transaction","detail":"{read_only:false; response_revision:3871; number_of_response:1; }","duration":"176.111409ms","start":"2026-06-10T02:51:28.976083Z","end":"2026-06-10T02:51:29.152195Z","steps":["trace[236619726] 'process raft request' (duration: 175.909094ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:51:29.159854Z","caller":"traceutil/trace.go:171","msg":"trace[520671967] transaction","detail":"{read_only:false; response_revision:3872; number_of_response:1; }","duration":"182.912425ms","start":"2026-06-10T02:51:28.976918Z","end":"2026-06-10T02:51:29.159831Z","steps":["trace[520671967] 'process raft request' (duration: 182.760131ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:51:29.160085Z","caller":"traceutil/trace.go:171","msg":"trace[472413390] linearizableReadLoop","detail":"{readStateIndex:4015; appliedIndex:4012; }","duration":"112.787255ms","start":"2026-06-10T02:51:29.047254Z","end":"2026-06-10T02:51:29.160041Z","steps":["trace[472413390] 'read index received' (duration: 104.729204ms)","trace[472413390] 'applied index is now lower than readState.Index' (duration: 8.055411ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:51:29.16013Z","caller":"traceutil/trace.go:171","msg":"trace[230625469] transaction","detail":"{read_only:false; response_revision:3873; number_of_response:1; }","duration":"182.172335ms","start":"2026-06-10T02:51:28.977945Z","end":"2026-06-10T02:51:29.160118Z","steps":["trace[230625469] 'process raft request' (duration: 181.849156ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:51:29.160383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.118934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/secretgen-controller\" ","response":"range_response_count:1 size:384"} {"level":"info","ts":"2026-06-10T02:51:29.160471Z","caller":"traceutil/trace.go:171","msg":"trace[1795177980] range","detail":"{range_begin:/registry/namespaces/secretgen-controller; range_end:; response_count:1; response_revision:3873; }","duration":"113.264199ms","start":"2026-06-10T02:51:29.047185Z","end":"2026-06-10T02:51:29.16045Z","steps":["trace[1795177980] 'agreement among raft nodes before linearized reading' (duration: 113.039473ms)"],"step_count":1}