{"level":"warn","ts":"2026-06-17T03:45:29.246161Z","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-17T03:45:29.246298Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.72:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.72:2380","--initial-cluster=instance=https://199.204.45.72:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.72:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.72:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-17T03:45:29.246397Z","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-17T03:45:29.246415Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-06-17T03:45:29.246439Z","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-17T03:45:29.247328Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"]} {"level":"info","ts":"2026-06-17T03:45:29.247422Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.72:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-17T03:45:29.25199Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.249708ms"} {"level":"info","ts":"2026-06-17T03:45:29.25943Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"50e03cebfd94cbba","cluster-id":"120c03c1d5b80f94"} {"level":"info","ts":"2026-06-17T03:45:29.259532Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=()"} {"level":"info","ts":"2026-06-17T03:45:29.259564Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 0"} {"level":"info","ts":"2026-06-17T03:45:29.259584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 50e03cebfd94cbba [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-17T03:45:29.259681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 1"} {"level":"info","ts":"2026-06-17T03:45:29.259738Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"warn","ts":"2026-06-17T03:45:29.266605Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-17T03:45:29.268585Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-17T03:45:29.270492Z","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-17T03:45:29.272694Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"50e03cebfd94cbba","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-17T03:45:29.274743Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"50e03cebfd94cbba","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-17T03:45:29.274948Z","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-17T03:45:29.27504Z","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-17T03:45:29.275066Z","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-17T03:45:29.275937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"info","ts":"2026-06-17T03:45:29.276129Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","added-peer-id":"50e03cebfd94cbba","added-peer-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-06-17T03:45:29.27971Z","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-17T03:45:29.279841Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-06-17T03:45:29.279889Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-06-17T03:45:29.279914Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"50e03cebfd94cbba","initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-17T03:45:29.279949Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-17T03:45:29.560995Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba is starting a new election at term 1"} {"level":"info","ts":"2026-06-17T03:45:29.561131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became pre-candidate at term 1"} {"level":"info","ts":"2026-06-17T03:45:29.561248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgPreVoteResp from 50e03cebfd94cbba at term 1"} {"level":"info","ts":"2026-06-17T03:45:29.561323Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became candidate at term 2"} {"level":"info","ts":"2026-06-17T03:45:29.561343Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgVoteResp from 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-06-17T03:45:29.561396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became leader at term 2"} {"level":"info","ts":"2026-06-17T03:45:29.56142Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 50e03cebfd94cbba elected leader 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-06-17T03:45:29.562306Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-17T03:45:29.563212Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"50e03cebfd94cbba","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.72:2379]}","request-path":"/0/members/50e03cebfd94cbba/attributes","cluster-id":"120c03c1d5b80f94","publish-timeout":"7s"} {"level":"info","ts":"2026-06-17T03:45:29.563227Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-17T03:45:29.56335Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-17T03:45:29.563975Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-17T03:45:29.564057Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-17T03:45:29.564076Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","cluster-version":"3.5"} {"level":"info","ts":"2026-06-17T03:45:29.56422Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-17T03:45:29.564282Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-17T03:45:29.568313Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-17T03:45:29.569993Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.72:2379"} {"level":"info","ts":"2026-06-17T03:45:32.49001Z","caller":"traceutil/trace.go:171","msg":"trace[915715597] transaction","detail":"{read_only:false; response_revision:107; number_of_response:1; }","duration":"127.022636ms","start":"2026-06-17T03:45:32.362964Z","end":"2026-06-17T03:45:32.489987Z","steps":["trace[915715597] 'process raft request' (duration: 121.933911ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:45:32.901906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.616963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:endpointslicemirroring-controller\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-17T03:45:32.901999Z","caller":"traceutil/trace.go:171","msg":"trace[637352759] range","detail":"{range_begin:/registry/clusterroles/system:controller:endpointslicemirroring-controller; range_end:; response_count:0; response_revision:112; }","duration":"310.766864ms","start":"2026-06-17T03:45:32.59121Z","end":"2026-06-17T03:45:32.901977Z","steps":["trace[637352759] 'range keys from in-memory index tree' (duration: 310.517342ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:45:32.902035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:45:32.591192Z","time spent":"310.835616ms","remote":"127.0.0.1:48596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/system:controller:endpointslicemirroring-controller\" "} {"level":"info","ts":"2026-06-17T03:45:33.123866Z","caller":"traceutil/trace.go:171","msg":"trace[1634298561] transaction","detail":"{read_only:false; response_revision:116; number_of_response:1; }","duration":"146.074757ms","start":"2026-06-17T03:45:32.977761Z","end":"2026-06-17T03:45:33.123836Z","steps":["trace[1634298561] 'process raft request' (duration: 49.116964ms)","trace[1634298561] 'compare' (duration: 96.831392ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T03:45:33.294086Z","caller":"traceutil/trace.go:171","msg":"trace[1035220602] transaction","detail":"{read_only:false; response_revision:119; number_of_response:1; }","duration":"120.424939ms","start":"2026-06-17T03:45:33.173633Z","end":"2026-06-17T03:45:33.294058Z","steps":["trace[1035220602] 'process raft request' (duration: 57.9742ms)","trace[1035220602] 'compare' (duration: 62.185177ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T03:45:39.380307Z","caller":"traceutil/trace.go:171","msg":"trace[1501382341] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"153.625027ms","start":"2026-06-17T03:45:39.226643Z","end":"2026-06-17T03:45:39.380268Z","steps":["trace[1501382341] 'process raft request' (duration: 153.368495ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:45:39.380428Z","caller":"traceutil/trace.go:171","msg":"trace[1584697740] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"153.666827ms","start":"2026-06-17T03:45:39.226737Z","end":"2026-06-17T03:45:39.380404Z","steps":["trace[1584697740] 'process raft request' (duration: 153.412285ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:45:39.380674Z","caller":"traceutil/trace.go:171","msg":"trace[542328601] transaction","detail":"{read_only:false; response_revision:324; number_of_response:1; }","duration":"152.191696ms","start":"2026-06-17T03:45:39.228471Z","end":"2026-06-17T03:45:39.380662Z","steps":["trace[542328601] 'process raft request' (duration: 151.744812ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:45:39.380648Z","caller":"traceutil/trace.go:171","msg":"trace[1591118572] linearizableReadLoop","detail":"{readStateIndex:334; appliedIndex:331; }","duration":"124.648873ms","start":"2026-06-17T03:45:39.255953Z","end":"2026-06-17T03:45:39.380602Z","steps":["trace[1591118572] 'read index received' (duration: 123.994717ms)","trace[1591118572] 'applied index is now lower than readState.Index' (duration: 651.696µs)"],"step_count":2} {"level":"warn","ts":"2026-06-17T03:45:39.380832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.860015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-06-17T03:45:39.380916Z","caller":"traceutil/trace.go:171","msg":"trace[420686448] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:324; }","duration":"124.998406ms","start":"2026-06-17T03:45:39.255906Z","end":"2026-06-17T03:45:39.380904Z","steps":["trace[420686448] 'agreement among raft nodes before linearized reading' (duration: 124.794724ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:45:39.545699Z","caller":"traceutil/trace.go:171","msg":"trace[579597937] transaction","detail":"{read_only:false; response_revision:330; number_of_response:1; }","duration":"102.765649ms","start":"2026-06-17T03:45:39.442904Z","end":"2026-06-17T03:45:39.545669Z","steps":["trace[579597937] 'process raft request' (duration: 44.062722ms)","trace[579597937] 'compare' (duration: 58.555295ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T03:45:39.550711Z","caller":"traceutil/trace.go:171","msg":"trace[799987491] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"103.152722ms","start":"2026-06-17T03:45:39.447498Z","end":"2026-06-17T03:45:39.550651Z","steps":["trace[799987491] 'process raft request' (duration: 102.98536ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:45:39.551543Z","caller":"traceutil/trace.go:171","msg":"trace[872618755] transaction","detail":"{read_only:false; response_revision:331; number_of_response:1; }","duration":"105.463391ms","start":"2026-06-17T03:45:39.445248Z","end":"2026-06-17T03:45:39.550711Z","steps":["trace[872618755] 'process raft request' (duration: 105.069108ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:45:39.711113Z","caller":"traceutil/trace.go:171","msg":"trace[835652766] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"133.490769ms","start":"2026-06-17T03:45:39.577602Z","end":"2026-06-17T03:45:39.711092Z","steps":["trace[835652766] 'process raft request' (duration: 133.420788ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:45:39.711371Z","caller":"traceutil/trace.go:171","msg":"trace[1991298749] transaction","detail":"{read_only:false; response_revision:338; number_of_response:1; }","duration":"136.897307ms","start":"2026-06-17T03:45:39.574464Z","end":"2026-06-17T03:45:39.711362Z","steps":["trace[1991298749] 'process raft request' (duration: 135.083392ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:45:39.749348Z","caller":"traceutil/trace.go:171","msg":"trace[1074848820] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"117.387742ms","start":"2026-06-17T03:45:39.631934Z","end":"2026-06-17T03:45:39.749321Z","steps":["trace[1074848820] 'process raft request' (duration: 117.223451ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:45:39.749619Z","caller":"traceutil/trace.go:171","msg":"trace[567677402] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"114.595639ms","start":"2026-06-17T03:45:39.63501Z","end":"2026-06-17T03:45:39.749605Z","steps":["trace[567677402] 'process raft request' (duration: 114.301786ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:45:39.74976Z","caller":"traceutil/trace.go:171","msg":"trace[584770728] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"115.823909ms","start":"2026-06-17T03:45:39.633905Z","end":"2026-06-17T03:45:39.749729Z","steps":["trace[584770728] 'process raft request' (duration: 115.367425ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:45:40.20063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.746428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4368"} {"level":"info","ts":"2026-06-17T03:45:40.200734Z","caller":"traceutil/trace.go:171","msg":"trace[165862321] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:346; }","duration":"180.8963ms","start":"2026-06-17T03:45:40.019818Z","end":"2026-06-17T03:45:40.200714Z","steps":["trace[165862321] 'range keys from in-memory index tree' (duration: 180.614128ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:45:40.20073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.186878ms","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-17T03:45:40.200819Z","caller":"traceutil/trace.go:171","msg":"trace[849299670] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:346; }","duration":"171.32448ms","start":"2026-06-17T03:45:40.02947Z","end":"2026-06-17T03:45:40.200795Z","steps":["trace[849299670] 'range keys from in-memory index tree' (duration: 171.077638ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:45:40.572482Z","caller":"traceutil/trace.go:171","msg":"trace[471051330] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"366.963093ms","start":"2026-06-17T03:45:40.205486Z","end":"2026-06-17T03:45:40.572449Z","steps":["trace[471051330] 'process raft request' (duration: 366.771092ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:45:40.573168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:45:40.205464Z","time spent":"367.177505ms","remote":"127.0.0.1:48504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T03:45:41.422857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.158156ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-06-17T03:45:41.423051Z","caller":"traceutil/trace.go:171","msg":"trace[326978685] linearizableReadLoop","detail":"{readStateIndex:359; appliedIndex:356; }","duration":"928.633591ms","start":"2026-06-17T03:45:40.494401Z","end":"2026-06-17T03:45:41.423035Z","steps":["trace[326978685] 'read index received' (duration: 77.989015ms)","trace[326978685] 'applied index is now lower than readState.Index' (duration: 850.643746ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T03:45:41.423126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:45:40.240922Z","time spent":"1.182201381s","remote":"127.0.0.1:48740","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-17T03:45:41.423297Z","caller":"traceutil/trace.go:171","msg":"trace[1512488126] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"1.171479782s","start":"2026-06-17T03:45:40.251808Z","end":"2026-06-17T03:45:41.423287Z","steps":["trace[1512488126] 'process raft request' (duration: 1.171137189s)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:45:41.423359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:45:40.251788Z","time spent":"1.171532052s","remote":"127.0.0.1:48332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-17T03:45:41.42364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"929.224146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-6zv8c\" ","response":"range_response_count:1 size:4462"} {"level":"info","ts":"2026-06-17T03:45:41.423714Z","caller":"traceutil/trace.go:171","msg":"trace[1627499887] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-6zv8c; range_end:; response_count:1; response_revision:348; }","duration":"929.345287ms","start":"2026-06-17T03:45:40.494352Z","end":"2026-06-17T03:45:41.423697Z","steps":["trace[1627499887] 'agreement among raft nodes before linearized reading' (duration: 929.164636ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:45:41.423755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:45:40.494333Z","time spent":"929.414548ms","remote":"127.0.0.1:48430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":4484,"request content":"key:\"/registry/pods/kube-system/kube-proxy-6zv8c\" "} {"level":"info","ts":"2026-06-17T03:45:41.711821Z","caller":"traceutil/trace.go:171","msg":"trace[221414069] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"286.881816ms","start":"2026-06-17T03:45:41.424908Z","end":"2026-06-17T03:45:41.71179Z","steps":["trace[221414069] 'process raft request' (duration: 233.897744ms)","trace[221414069] 'compare' (duration: 52.827231ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T03:45:41.713064Z","caller":"traceutil/trace.go:171","msg":"trace[1468947151] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"283.203295ms","start":"2026-06-17T03:45:41.42984Z","end":"2026-06-17T03:45:41.713043Z","steps":["trace[1468947151] 'process raft request' (duration: 283.054344ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:45:41.713342Z","caller":"traceutil/trace.go:171","msg":"trace[369316224] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"283.224945ms","start":"2026-06-17T03:45:41.430095Z","end":"2026-06-17T03:45:41.71332Z","steps":["trace[369316224] 'process raft request' (duration: 282.897212ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:45:41.713672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.099572ms","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-17T03:45:41.713709Z","caller":"traceutil/trace.go:171","msg":"trace[2086474141] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:352; }","duration":"139.186052ms","start":"2026-06-17T03:45:41.574512Z","end":"2026-06-17T03:45:41.713698Z","steps":["trace[2086474141] 'agreement among raft nodes before linearized reading' (duration: 139.091732ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:45:41.713907Z","caller":"traceutil/trace.go:171","msg":"trace[1699286034] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"189.626324ms","start":"2026-06-17T03:45:41.523887Z","end":"2026-06-17T03:45:41.713513Z","steps":["trace[1699286034] 'process raft request' (duration: 189.331961ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:45:41.71362Z","caller":"traceutil/trace.go:171","msg":"trace[1638883349] linearizableReadLoop","detail":"{readStateIndex:363; appliedIndex:359; }","duration":"138.89755ms","start":"2026-06-17T03:45:41.574567Z","end":"2026-06-17T03:45:41.713464Z","steps":["trace[1638883349] 'read index received' (duration: 84.251664ms)","trace[1638883349] 'applied index is now lower than readState.Index' (duration: 54.644496ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T03:45:42.631297Z","caller":"traceutil/trace.go:171","msg":"trace[1663018213] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"123.221613ms","start":"2026-06-17T03:45:42.508034Z","end":"2026-06-17T03:45:42.631255Z","steps":["trace[1663018213] 'process raft request' (duration: 122.968101ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:45:42.821872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.265973ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-17T03:45:42.821986Z","caller":"traceutil/trace.go:171","msg":"trace[1587088118] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"185.927563ms","start":"2026-06-17T03:45:42.636039Z","end":"2026-06-17T03:45:42.821966Z","steps":["trace[1587088118] 'process raft request' (duration: 26.475039ms)","trace[1587088118] 'compare' (duration: 159.129332ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T03:45:43.646461Z","caller":"traceutil/trace.go:171","msg":"trace[1161191009] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"137.541426ms","start":"2026-06-17T03:45:43.508891Z","end":"2026-06-17T03:45:43.646432Z","steps":["trace[1161191009] 'process raft request' (duration: 114.445315ms)","trace[1161191009] 'compare' (duration: 22.94996ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T03:45:44.1051Z","caller":"traceutil/trace.go:171","msg":"trace[1806724022] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"381.597655ms","start":"2026-06-17T03:45:43.723474Z","end":"2026-06-17T03:45:44.105071Z","steps":["trace[1806724022] 'process raft request' (duration: 381.431914ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:45:44.105287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:45:43.723443Z","time spent":"381.768117ms","remote":"127.0.0.1:48504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T03:45:44.134319Z","caller":"traceutil/trace.go:171","msg":"trace[170424741] linearizableReadLoop","detail":"{readStateIndex:374; appliedIndex:372; }","duration":"337.453399ms","start":"2026-06-17T03:45:43.796844Z","end":"2026-06-17T03:45:44.134297Z","steps":["trace[170424741] 'read index received' (duration: 308.009288ms)","trace[170424741] 'applied index is now lower than readState.Index' (duration: 29.443131ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T03:45:44.134431Z","caller":"traceutil/trace.go:171","msg":"trace[1340579768] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"406.909913ms","start":"2026-06-17T03:45:43.727473Z","end":"2026-06-17T03:45:44.134382Z","steps":["trace[1340579768] 'process raft request' (duration: 406.700401ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:45:44.134464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.60425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-17T03:45:44.134504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.06779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.72\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-06-17T03:45:44.134622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:45:43.727455Z","time spent":"407.066504ms","remote":"127.0.0.1:48504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T03:45:44.134635Z","caller":"traceutil/trace.go:171","msg":"trace[2034943392] range","detail":"{range_begin:/registry/masterleases/199.204.45.72; range_end:; response_count:1; response_revision:363; }","duration":"295.274862ms","start":"2026-06-17T03:45:43.839342Z","end":"2026-06-17T03:45:44.134617Z","steps":["trace[2034943392] 'agreement among raft nodes before linearized reading' (duration: 295.0764ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:45:44.134529Z","caller":"traceutil/trace.go:171","msg":"trace[1100008276] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:363; }","duration":"337.723972ms","start":"2026-06-17T03:45:43.79679Z","end":"2026-06-17T03:45:44.134514Z","steps":["trace[1100008276] 'agreement among raft nodes before linearized reading' (duration: 337.591301ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:45:44.135018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:45:43.796767Z","time spent":"338.236616ms","remote":"127.0.0.1:48504","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-17T03:45:44.404091Z","caller":"traceutil/trace.go:171","msg":"trace[1889644788] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"265.233167ms","start":"2026-06-17T03:45:44.13883Z","end":"2026-06-17T03:45:44.404063Z","steps":["trace[1889644788] 'process raft request' (duration: 265.056086ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:45:44.449586Z","caller":"traceutil/trace.go:171","msg":"trace[1539468354] linearizableReadLoop","detail":"{readStateIndex:377; appliedIndex:375; }","duration":"125.965134ms","start":"2026-06-17T03:45:44.3236Z","end":"2026-06-17T03:45:44.449565Z","steps":["trace[1539468354] 'read index received' (duration: 80.302219ms)","trace[1539468354] 'applied index is now lower than readState.Index' (duration: 45.661695ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T03:45:44.449806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.189246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T03:45:44.449878Z","caller":"traceutil/trace.go:171","msg":"trace[104818288] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:365; }","duration":"126.318468ms","start":"2026-06-17T03:45:44.323542Z","end":"2026-06-17T03:45:44.449861Z","steps":["trace[104818288] 'agreement among raft nodes before linearized reading' (duration: 126.113516ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:45:44.450057Z","caller":"traceutil/trace.go:171","msg":"trace[1347013432] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"142.812343ms","start":"2026-06-17T03:45:44.307223Z","end":"2026-06-17T03:45:44.450035Z","steps":["trace[1347013432] 'process raft request' (duration: 139.887669ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:45:46.745502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.639365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T03:45:46.745625Z","caller":"traceutil/trace.go:171","msg":"trace[1993195532] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:370; }","duration":"421.803916ms","start":"2026-06-17T03:45:46.323795Z","end":"2026-06-17T03:45:46.745599Z","steps":["trace[1993195532] 'range keys from in-memory index tree' (duration: 421.525324ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:45:46.745672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.526209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4321"} {"level":"warn","ts":"2026-06-17T03:45:46.745687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:45:46.323778Z","time spent":"421.892556ms","remote":"127.0.0.1:48276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-17T03:45:46.745713Z","caller":"traceutil/trace.go:171","msg":"trace[1416393505] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:370; }","duration":"237.59625ms","start":"2026-06-17T03:45:46.508098Z","end":"2026-06-17T03:45:46.745694Z","steps":["trace[1416393505] 'range keys from in-memory index tree' (duration: 237.412758ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:45:46.746504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.646892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-17T03:45:46.746649Z","caller":"traceutil/trace.go:171","msg":"trace[1413567112] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:370; }","duration":"338.379878ms","start":"2026-06-17T03:45:46.408234Z","end":"2026-06-17T03:45:46.746614Z","steps":["trace[1413567112] 'range keys from in-memory index tree' (duration: 337.522061ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:45:46.746762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:45:46.408218Z","time spent":"338.523299ms","remote":"127.0.0.1:48504","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-17T03:45:48.42842Z","caller":"traceutil/trace.go:171","msg":"trace[39700029] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"306.339094ms","start":"2026-06-17T03:45:48.122062Z","end":"2026-06-17T03:45:48.428401Z","steps":["trace[39700029] 'process raft request' (duration: 306.170422ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:45:48.428538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:45:48.122038Z","time spent":"306.441304ms","remote":"127.0.0.1:48504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T03:45:48.428864Z","caller":"traceutil/trace.go:171","msg":"trace[558638606] linearizableReadLoop","detail":"{readStateIndex:386; appliedIndex:386; }","duration":"282.717904ms","start":"2026-06-17T03:45:48.146138Z","end":"2026-06-17T03:45:48.428856Z","steps":["trace[558638606] 'read index received' (duration: 282.714734ms)","trace[558638606] 'applied index is now lower than readState.Index' (duration: 2.78µs)"],"step_count":2} {"level":"warn","ts":"2026-06-17T03:45:48.42891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.784005ms","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-17T03:45:48.428929Z","caller":"traceutil/trace.go:171","msg":"trace[929232327] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:374; }","duration":"282.853445ms","start":"2026-06-17T03:45:48.146069Z","end":"2026-06-17T03:45:48.428923Z","steps":["trace[929232327] 'agreement among raft nodes before linearized reading' (duration: 282.816994ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:45:54.175353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:45:53.841256Z","time spent":"334.093591ms","remote":"127.0.0.1:48310","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-17T03:45:54.372931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.536338ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-17T03:45:54.373104Z","caller":"traceutil/trace.go:171","msg":"trace[1851027281] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"196.592079ms","start":"2026-06-17T03:45:54.176476Z","end":"2026-06-17T03:45:54.373068Z","steps":["trace[1851027281] 'process raft request' (duration: 36.843089ms)","trace[1851027281] 'compare' (duration: 159.431257ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T03:45:55.299655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.077099ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-17T03:45:55.300002Z","caller":"traceutil/trace.go:171","msg":"trace[1387128023] linearizableReadLoop","detail":"{readStateIndex:402; appliedIndex:401; }","duration":"843.017279ms","start":"2026-06-17T03:45:54.456946Z","end":"2026-06-17T03:45:55.299963Z","steps":["trace[1387128023] 'read index received' (duration: 142.403645ms)","trace[1387128023] 'applied index is now lower than readState.Index' (duration: 700.611974ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T03:45:55.30006Z","caller":"traceutil/trace.go:171","msg":"trace[33277135] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"844.050806ms","start":"2026-06-17T03:45:54.455972Z","end":"2026-06-17T03:45:55.300023Z","steps":["trace[33277135] 'process raft request' (duration: 143.341182ms)","trace[33277135] 'compare' (duration: 699.878928ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T03:45:55.300147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"843.19512ms","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-17T03:45:55.300503Z","caller":"traceutil/trace.go:171","msg":"trace[602535391] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:388; }","duration":"843.576543ms","start":"2026-06-17T03:45:54.456914Z","end":"2026-06-17T03:45:55.300491Z","steps":["trace[602535391] 'agreement among raft nodes before linearized reading' (duration: 843.18756ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:45:55.300543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:45:54.456901Z","time spent":"843.634293ms","remote":"127.0.0.1:48504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-17T03:45:55.300321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.687128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-17T03:45:55.300666Z","caller":"traceutil/trace.go:171","msg":"trace[1870042989] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:388; }","duration":"442.04282ms","start":"2026-06-17T03:45:54.858589Z","end":"2026-06-17T03:45:55.300632Z","steps":["trace[1870042989] 'agreement among raft nodes before linearized reading' (duration: 441.707008ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:45:55.300356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.093869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-17T03:45:55.300754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:45:54.858567Z","time spent":"442.155061ms","remote":"127.0.0.1:48504","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-17T03:45:55.300771Z","caller":"traceutil/trace.go:171","msg":"trace[362376607] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:388; }","duration":"415.527523ms","start":"2026-06-17T03:45:54.885225Z","end":"2026-06-17T03:45:55.300752Z","steps":["trace[362376607] 'agreement among raft nodes before linearized reading' (duration: 415.11341ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:45:55.300832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:45:54.885209Z","time spent":"415.602604ms","remote":"127.0.0.1:48504","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-17T03:45:55.30157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:45:54.455929Z","time spent":"844.50634ms","remote":"127.0.0.1:48504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T03:45:55.517638Z","caller":"traceutil/trace.go:171","msg":"trace[114006591] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"212.651777ms","start":"2026-06-17T03:45:55.304921Z","end":"2026-06-17T03:45:55.517573Z","steps":["trace[114006591] 'process raft request' (duration: 211.624659ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:45:55.517783Z","caller":"traceutil/trace.go:171","msg":"trace[1589780396] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"212.709258ms","start":"2026-06-17T03:45:55.305047Z","end":"2026-06-17T03:45:55.517756Z","steps":["trace[1589780396] 'process raft request' (duration: 212.469866ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:45:55.518101Z","caller":"traceutil/trace.go:171","msg":"trace[373266891] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"212.599407ms","start":"2026-06-17T03:45:55.304953Z","end":"2026-06-17T03:45:55.517553Z","steps":["trace[373266891] 'process raft request' (duration: 212.505706ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:01.495383Z","caller":"traceutil/trace.go:171","msg":"trace[1166277421] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"142.353155ms","start":"2026-06-17T03:46:01.353005Z","end":"2026-06-17T03:46:01.495358Z","steps":["trace[1166277421] 'process raft request' (duration: 142.177474ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:01.74521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.539629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-17T03:46:01.745292Z","caller":"traceutil/trace.go:171","msg":"trace[683668751] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:431; }","duration":"192.658927ms","start":"2026-06-17T03:46:01.552613Z","end":"2026-06-17T03:46:01.745272Z","steps":["trace[683668751] 'range keys from in-memory index tree' (duration: 192.454884ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:01.7453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.028384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-17T03:46:01.745336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.954134ms","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-17T03:46:01.745383Z","caller":"traceutil/trace.go:171","msg":"trace[671442508] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:431; }","duration":"196.203204ms","start":"2026-06-17T03:46:01.549159Z","end":"2026-06-17T03:46:01.745362Z","steps":["trace[671442508] 'range keys from in-memory index tree' (duration: 195.900466ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:01.745411Z","caller":"traceutil/trace.go:171","msg":"trace[2113575770] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:431; }","duration":"193.079481ms","start":"2026-06-17T03:46:01.552314Z","end":"2026-06-17T03:46:01.745393Z","steps":["trace[2113575770] 'range keys from in-memory index tree' (duration: 192.871999ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:02.040917Z","caller":"traceutil/trace.go:171","msg":"trace[2078316973] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"291.109956ms","start":"2026-06-17T03:46:01.749788Z","end":"2026-06-17T03:46:02.040898Z","steps":["trace[2078316973] 'process raft request' (duration: 291.046353ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:02.041048Z","caller":"traceutil/trace.go:171","msg":"trace[1845739145] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"291.323839ms","start":"2026-06-17T03:46:01.749716Z","end":"2026-06-17T03:46:02.04104Z","steps":["trace[1845739145] 'process raft request' (duration: 247.58885ms)","trace[1845739145] 'compare' (duration: 43.368597ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T03:46:02.636742Z","caller":"traceutil/trace.go:171","msg":"trace[126245246] linearizableReadLoop","detail":"{readStateIndex:451; appliedIndex:450; }","duration":"313.370796ms","start":"2026-06-17T03:46:02.323348Z","end":"2026-06-17T03:46:02.636719Z","steps":["trace[126245246] 'read index received' (duration: 313.210787ms)","trace[126245246] 'applied index is now lower than readState.Index' (duration: 159.189µs)"],"step_count":2} {"level":"warn","ts":"2026-06-17T03:46:02.636868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.503804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T03:46:02.636901Z","caller":"traceutil/trace.go:171","msg":"trace[2079448747] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:435; }","duration":"313.576738ms","start":"2026-06-17T03:46:02.323313Z","end":"2026-06-17T03:46:02.63689Z","steps":["trace[2079448747] 'agreement among raft nodes before linearized reading' (duration: 313.492933ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:02.636934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:02.323298Z","time spent":"313.628421ms","remote":"127.0.0.1:48290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-17T03:46:02.637279Z","caller":"traceutil/trace.go:171","msg":"trace[264584381] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"385.141967ms","start":"2026-06-17T03:46:02.252121Z","end":"2026-06-17T03:46:02.637263Z","steps":["trace[264584381] 'process raft request' (duration: 384.494439ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:02.637379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:02.252096Z","time spent":"385.222371ms","remote":"127.0.0.1:48504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T03:46:12.039583Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220567380733805,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-17T03:46:12.473482Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.031525607s","expected-duration":"1s"} {"level":"info","ts":"2026-06-17T03:46:12.497883Z","caller":"traceutil/trace.go:171","msg":"trace[893596431] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"1.056017546s","start":"2026-06-17T03:46:11.441839Z","end":"2026-06-17T03:46:12.497857Z","steps":["trace[893596431] 'process raft request' (duration: 1.032158099s)","trace[893596431] 'compare' (duration: 23.496348ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T03:46:12.498021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:11.441823Z","time spent":"1.056126522s","remote":"127.0.0.1:48320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31111,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T03:46:12.798272Z","caller":"traceutil/trace.go:171","msg":"trace[1011910468] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"1.352986188s","start":"2026-06-17T03:46:11.445255Z","end":"2026-06-17T03:46:12.798241Z","steps":["trace[1011910468] 'process raft request' (duration: 1.260553147s)","trace[1011910468] 'compare' (duration: 92.146217ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T03:46:12.798494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:11.445219Z","time spent":"1.353132506s","remote":"127.0.0.1:48320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29452,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T03:46:12.798732Z","caller":"traceutil/trace.go:171","msg":"trace[1897018295] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"284.273611ms","start":"2026-06-17T03:46:12.514438Z","end":"2026-06-17T03:46:12.798712Z","steps":["trace[1897018295] 'process raft request' (duration: 284.146635ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:12.798813Z","caller":"traceutil/trace.go:171","msg":"trace[2042774186] linearizableReadLoop","detail":"{readStateIndex:543; appliedIndex:540; }","duration":"1.260050145s","start":"2026-06-17T03:46:11.538745Z","end":"2026-06-17T03:46:12.798795Z","steps":["trace[2042774186] 'read index received' (duration: 935.119414ms)","trace[2042774186] 'applied index is now lower than readState.Index' (duration: 324.929131ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T03:46:12.798959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.260213303s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-17T03:46:12.799028Z","caller":"traceutil/trace.go:171","msg":"trace[1740066218] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:523; }","duration":"1.260284757s","start":"2026-06-17T03:46:11.538728Z","end":"2026-06-17T03:46:12.799013Z","steps":["trace[1740066218] 'agreement among raft nodes before linearized reading' (duration: 1.260167071s)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:12.799082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:11.538644Z","time spent":"1.260425504s","remote":"127.0.0.1:48504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-17T03:46:12.799326Z","caller":"traceutil/trace.go:171","msg":"trace[110641784] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"1.296945702s","start":"2026-06-17T03:46:11.50234Z","end":"2026-06-17T03:46:12.799286Z","steps":["trace[110641784] 'process raft request' (duration: 1.295824754s)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:12.79943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:11.502319Z","time spent":"1.297067449s","remote":"127.0.0.1:48320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-17T03:46:12.815651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"958.977824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-17T03:46:12.815748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.887234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T03:46:12.815784Z","caller":"traceutil/trace.go:171","msg":"trace[1846394729] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:524; }","duration":"491.941967ms","start":"2026-06-17T03:46:12.323829Z","end":"2026-06-17T03:46:12.815771Z","steps":["trace[1846394729] 'agreement among raft nodes before linearized reading' (duration: 491.905515ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:12.815811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:12.323814Z","time spent":"491.99149ms","remote":"127.0.0.1:48290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-17T03:46:12.815844Z","caller":"traceutil/trace.go:171","msg":"trace[1608092841] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:524; }","duration":"959.197595ms","start":"2026-06-17T03:46:11.856589Z","end":"2026-06-17T03:46:12.815787Z","steps":["trace[1608092841] 'agreement among raft nodes before linearized reading' (duration: 958.90288ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:12.815933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:11.856566Z","time spent":"959.339052ms","remote":"127.0.0.1:48504","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-17T03:46:12.815985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"735.063824ms","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-17T03:46:12.816011Z","caller":"traceutil/trace.go:171","msg":"trace[26796950] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:524; }","duration":"735.122696ms","start":"2026-06-17T03:46:12.080882Z","end":"2026-06-17T03:46:12.816004Z","steps":["trace[26796950] 'agreement among raft nodes before linearized reading' (duration: 735.081504ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:12.816033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:12.080863Z","time spent":"735.164749ms","remote":"127.0.0.1:48504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-17T03:46:12.815698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"734.714175ms","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-17T03:46:12.816167Z","caller":"traceutil/trace.go:171","msg":"trace[488311066] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:524; }","duration":"735.212841ms","start":"2026-06-17T03:46:12.080947Z","end":"2026-06-17T03:46:12.81616Z","steps":["trace[488311066] 'agreement among raft nodes before linearized reading' (duration: 734.706485ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:12.816189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:12.080942Z","time spent":"735.240712ms","remote":"127.0.0.1:48504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-17T03:46:15.554856Z","caller":"traceutil/trace.go:171","msg":"trace[1858010371] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"120.112301ms","start":"2026-06-17T03:46:15.434718Z","end":"2026-06-17T03:46:15.554831Z","steps":["trace[1858010371] 'process raft request' (duration: 119.982524ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:18.796302Z","caller":"traceutil/trace.go:171","msg":"trace[1801651874] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:609; }","duration":"473.695213ms","start":"2026-06-17T03:46:18.322549Z","end":"2026-06-17T03:46:18.796245Z","steps":["trace[1801651874] 'read index received' (duration: 460.102682ms)","trace[1801651874] 'applied index is now lower than readState.Index' (duration: 13.591021ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T03:46:18.796465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.871592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T03:46:18.796498Z","caller":"traceutil/trace.go:171","msg":"trace[1095487121] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:588; }","duration":"473.989637ms","start":"2026-06-17T03:46:18.322498Z","end":"2026-06-17T03:46:18.796487Z","steps":["trace[1095487121] 'agreement among raft nodes before linearized reading' (duration: 473.880192ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:18.796529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:18.322476Z","time spent":"474.0461ms","remote":"127.0.0.1:48290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-17T03:46:18.796696Z","caller":"traceutil/trace.go:171","msg":"trace[1565046110] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"726.816775ms","start":"2026-06-17T03:46:18.069862Z","end":"2026-06-17T03:46:18.796679Z","steps":["trace[1565046110] 'process raft request' (duration: 713.816732ms)","trace[1565046110] 'marshal mvccpb.KeyValue' {req_type:put; key:/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1; req_size:1036221; } (duration: 10.993497ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T03:46:18.796776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:18.069809Z","time spent":"726.90859ms","remote":"127.0.0.1:48348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036225,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T03:46:19.871761Z","caller":"traceutil/trace.go:171","msg":"trace[546084587] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"278.805011ms","start":"2026-06-17T03:46:19.592935Z","end":"2026-06-17T03:46:19.87174Z","steps":["trace[546084587] 'read index received' (duration: 278.15384ms)","trace[546084587] 'applied index is now lower than readState.Index' (duration: 650.551µs)"],"step_count":2} {"level":"warn","ts":"2026-06-17T03:46:19.87193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.975669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-84jbr\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-17T03:46:19.871962Z","caller":"traceutil/trace.go:171","msg":"trace[1265617850] range","detail":"{range_begin:/registry/pods/kube-system/cilium-84jbr; range_end:; response_count:1; response_revision:597; }","duration":"279.062833ms","start":"2026-06-17T03:46:19.592891Z","end":"2026-06-17T03:46:19.871954Z","steps":["trace[1265617850] 'agreement among raft nodes before linearized reading' (duration: 278.928577ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:19.872014Z","caller":"traceutil/trace.go:171","msg":"trace[1508887217] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"562.579768ms","start":"2026-06-17T03:46:19.309367Z","end":"2026-06-17T03:46:19.871947Z","steps":["trace[1508887217] 'process raft request' (duration: 561.900575ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:19.87219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:19.309345Z","time spent":"562.750836ms","remote":"127.0.0.1:48348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T03:46:20.823375Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220567380733966,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-17T03:46:20.918812Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.031141477s","expected-duration":"1s"} {"level":"info","ts":"2026-06-17T03:46:20.919183Z","caller":"traceutil/trace.go:171","msg":"trace[180104257] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"1.031620249s","start":"2026-06-17T03:46:19.887535Z","end":"2026-06-17T03:46:20.919155Z","steps":["trace[180104257] 'process raft request' (duration: 1.031463071s)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:20.919335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:19.887516Z","time spent":"1.031744095s","remote":"127.0.0.1:48430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T03:46:20.927342Z","caller":"traceutil/trace.go:171","msg":"trace[1120270776] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:620; }","duration":"604.034886ms","start":"2026-06-17T03:46:20.323292Z","end":"2026-06-17T03:46:20.927327Z","steps":["trace[1120270776] 'read index received' (duration: 595.759288ms)","trace[1120270776] 'applied index is now lower than readState.Index' (duration: 8.274878ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T03:46:20.927417Z","caller":"traceutil/trace.go:171","msg":"trace[2096258476] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"999.814627ms","start":"2026-06-17T03:46:19.927566Z","end":"2026-06-17T03:46:20.927381Z","steps":["trace[2096258476] 'process raft request' (duration: 999.683771ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:20.927523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.176722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-17T03:46:20.927563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:19.92754Z","time spent":"999.944763ms","remote":"127.0.0.1:48604","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-17T03:46:20.927585Z","caller":"traceutil/trace.go:171","msg":"trace[2051202778] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:599; }","duration":"604.276126ms","start":"2026-06-17T03:46:20.323278Z","end":"2026-06-17T03:46:20.927554Z","steps":["trace[2051202778] 'agreement among raft nodes before linearized reading' (duration: 604.14201ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:20.927629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:20.323227Z","time spent":"604.379472ms","remote":"127.0.0.1:48290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-17T03:46:22.484181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.470824967s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-17T03:46:22.484709Z","caller":"traceutil/trace.go:171","msg":"trace[1728873185] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:622; }","duration":"1.547092276s","start":"2026-06-17T03:46:20.937569Z","end":"2026-06-17T03:46:22.484661Z","steps":["trace[1728873185] 'read index received' (duration: 75.696213ms)","trace[1728873185] 'applied index is now lower than readState.Index' (duration: 1.47133136s)"],"step_count":2} {"level":"info","ts":"2026-06-17T03:46:22.48499Z","caller":"traceutil/trace.go:171","msg":"trace[357364331] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"1.553840241s","start":"2026-06-17T03:46:20.931128Z","end":"2026-06-17T03:46:22.484968Z","steps":["trace[357364331] 'process raft request' (duration: 1.553238734s)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:22.485033Z","caller":"traceutil/trace.go:171","msg":"trace[676361312] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"1.553956357s","start":"2026-06-17T03:46:20.93103Z","end":"2026-06-17T03:46:22.484987Z","steps":["trace[676361312] 'process raft request' (duration: 82.221429ms)","trace[676361312] 'compare' (duration: 1.470038321s)"],"step_count":2} {"level":"warn","ts":"2026-06-17T03:46:22.48508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:20.931107Z","time spent":"1.553919845s","remote":"127.0.0.1:48504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T03:46:22.485161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:20.931015Z","time spent":"1.554068713s","remote":"127.0.0.1:48504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T03:46:22.485838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.162261136s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T03:46:22.485878Z","caller":"traceutil/trace.go:171","msg":"trace[982063621] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"1.554235419s","start":"2026-06-17T03:46:20.931619Z","end":"2026-06-17T03:46:22.485855Z","steps":["trace[982063621] 'process raft request' (duration: 1.552927519s)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:22.485944Z","caller":"traceutil/trace.go:171","msg":"trace[475952498] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:603; }","duration":"1.162384031s","start":"2026-06-17T03:46:21.323515Z","end":"2026-06-17T03:46:22.485899Z","steps":["trace[475952498] 'agreement among raft nodes before linearized reading' (duration: 1.161972542s)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:22.485966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:20.931611Z","time spent":"1.554300803s","remote":"127.0.0.1:48504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T03:46:22.48596Z","caller":"traceutil/trace.go:171","msg":"trace[2139834499] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"1.554722472s","start":"2026-06-17T03:46:20.931204Z","end":"2026-06-17T03:46:22.485927Z","steps":["trace[2139834499] 'process raft request' (duration: 1.553278236s)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:22.486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:21.323498Z","time spent":"1.162487556s","remote":"127.0.0.1:48290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-17T03:46:22.486063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:20.931196Z","time spent":"1.554809996s","remote":"127.0.0.1:48504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T03:46:22.486387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.548807635s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T03:46:22.486443Z","caller":"traceutil/trace.go:171","msg":"trace[374403062] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:603; }","duration":"1.548863907s","start":"2026-06-17T03:46:20.93755Z","end":"2026-06-17T03:46:22.486414Z","steps":["trace[374403062] 'agreement among raft nodes before linearized reading' (duration: 1.548632696s)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:22.486524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:20.937541Z","time spent":"1.54892994s","remote":"127.0.0.1:48730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":27,"request content":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" "} {"level":"info","ts":"2026-06-17T03:46:23.532626Z","caller":"traceutil/trace.go:171","msg":"trace[859234516] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"661.561673ms","start":"2026-06-17T03:46:22.871036Z","end":"2026-06-17T03:46:23.532598Z","steps":["trace[859234516] 'process raft request' (duration: 660.943715ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:23.532808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:22.871006Z","time spent":"661.707189ms","remote":"127.0.0.1:48348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T03:46:23.541617Z","caller":"traceutil/trace.go:171","msg":"trace[459673587] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"632.104509ms","start":"2026-06-17T03:46:22.909491Z","end":"2026-06-17T03:46:23.541596Z","steps":["trace[459673587] 'process raft request' (duration: 632.000404ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:23.541739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:22.90947Z","time spent":"632.204344ms","remote":"127.0.0.1:48504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T03:46:35.080412Z","caller":"traceutil/trace.go:171","msg":"trace[1549078300] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"382.30699ms","start":"2026-06-17T03:46:34.698081Z","end":"2026-06-17T03:46:35.080388Z","steps":["trace[1549078300] 'process raft request' (duration: 381.909614ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:35.080886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:34.698071Z","time spent":"382.426634ms","remote":"127.0.0.1:48422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":779,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T03:46:35.086079Z","caller":"traceutil/trace.go:171","msg":"trace[627026334] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"387.720894ms","start":"2026-06-17T03:46:34.698338Z","end":"2026-06-17T03:46:35.086059Z","steps":["trace[627026334] 'process raft request' (duration: 387.474034ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:35.086155Z","caller":"traceutil/trace.go:171","msg":"trace[974667463] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"385.729644ms","start":"2026-06-17T03:46:34.700393Z","end":"2026-06-17T03:46:35.086122Z","steps":["trace[974667463] 'process raft request' (duration: 385.519526ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:35.086175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:34.698319Z","time spent":"387.811788ms","remote":"127.0.0.1:48516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1288,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T03:46:35.086287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:34.700384Z","time spent":"385.829418ms","remote":"127.0.0.1:48430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4850,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T03:46:37.744305Z","caller":"traceutil/trace.go:171","msg":"trace[1932353702] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"116.660774ms","start":"2026-06-17T03:46:37.627613Z","end":"2026-06-17T03:46:37.744274Z","steps":["trace[1932353702] 'process raft request' (duration: 116.409424ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:38.708276Z","caller":"traceutil/trace.go:171","msg":"trace[2082611111] linearizableReadLoop","detail":"{readStateIndex:794; appliedIndex:793; }","duration":"210.979366ms","start":"2026-06-17T03:46:38.497272Z","end":"2026-06-17T03:46:38.708251Z","steps":["trace[2082611111] 'read index received' (duration: 210.819339ms)","trace[2082611111] 'applied index is now lower than readState.Index' (duration: 159.177µs)"],"step_count":2} {"level":"info","ts":"2026-06-17T03:46:38.708375Z","caller":"traceutil/trace.go:171","msg":"trace[1389767713] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"955.974032ms","start":"2026-06-17T03:46:37.752367Z","end":"2026-06-17T03:46:38.708341Z","steps":["trace[1389767713] 'process raft request' (duration: 955.778925ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:38.708448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.155212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T03:46:38.708537Z","caller":"traceutil/trace.go:171","msg":"trace[606945867] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:766; }","duration":"211.280887ms","start":"2026-06-17T03:46:38.497232Z","end":"2026-06-17T03:46:38.708512Z","steps":["trace[606945867] 'agreement among raft nodes before linearized reading' (duration: 211.122071ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:38.708551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:37.752339Z","time spent":"956.111027ms","remote":"127.0.0.1:48430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4024,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T03:46:38.70872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.356389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T03:46:38.708817Z","caller":"traceutil/trace.go:171","msg":"trace[984267474] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:766; }","duration":"211.542227ms","start":"2026-06-17T03:46:38.497263Z","end":"2026-06-17T03:46:38.708805Z","steps":["trace[984267474] 'agreement among raft nodes before linearized reading' (duration: 211.37221ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:38.708874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.852918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T03:46:38.708921Z","caller":"traceutil/trace.go:171","msg":"trace[1755689663] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:766; }","duration":"127.90161ms","start":"2026-06-17T03:46:38.581008Z","end":"2026-06-17T03:46:38.70891Z","steps":["trace[1755689663] 'agreement among raft nodes before linearized reading' (duration: 127.835257ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:38.709124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.719861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-17T03:46:38.70919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.720972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T03:46:38.709197Z","caller":"traceutil/trace.go:171","msg":"trace[1326399755] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:766; }","duration":"154.841945ms","start":"2026-06-17T03:46:38.554337Z","end":"2026-06-17T03:46:38.709179Z","steps":["trace[1326399755] 'agreement among raft nodes before linearized reading' (duration: 154.727641ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:38.709243Z","caller":"traceutil/trace.go:171","msg":"trace[1339788471] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:766; }","duration":"127.791815ms","start":"2026-06-17T03:46:38.581437Z","end":"2026-06-17T03:46:38.709229Z","steps":["trace[1339788471] 'agreement among raft nodes before linearized reading' (duration: 127.725223ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:38.709131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.426588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-17T03:46:38.709417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.449681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-17T03:46:38.709451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.411476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T03:46:38.709498Z","caller":"traceutil/trace.go:171","msg":"trace[901562043] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:766; }","duration":"110.467179ms","start":"2026-06-17T03:46:38.599021Z","end":"2026-06-17T03:46:38.709488Z","steps":["trace[901562043] 'agreement among raft nodes before linearized reading' (duration: 110.404267ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:38.709493Z","caller":"traceutil/trace.go:171","msg":"trace[1004412461] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:766; }","duration":"128.561145ms","start":"2026-06-17T03:46:38.580913Z","end":"2026-06-17T03:46:38.709474Z","steps":["trace[1004412461] 'agreement among raft nodes before linearized reading' (duration: 128.43613ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:38.709539Z","caller":"traceutil/trace.go:171","msg":"trace[519682119] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:766; }","duration":"110.786152ms","start":"2026-06-17T03:46:38.598659Z","end":"2026-06-17T03:46:38.709445Z","steps":["trace[519682119] 'agreement among raft nodes before linearized reading' (duration: 110.434128ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:38.708725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.889386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T03:46:38.709964Z","caller":"traceutil/trace.go:171","msg":"trace[686574522] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:766; }","duration":"111.127695ms","start":"2026-06-17T03:46:38.598816Z","end":"2026-06-17T03:46:38.709944Z","steps":["trace[686574522] 'agreement among raft nodes before linearized reading' (duration: 109.878037ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:38.709648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.323447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T03:46:38.710041Z","caller":"traceutil/trace.go:171","msg":"trace[1148625256] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:766; }","duration":"212.731673ms","start":"2026-06-17T03:46:38.497293Z","end":"2026-06-17T03:46:38.710025Z","steps":["trace[1148625256] 'agreement among raft nodes before linearized reading' (duration: 212.326847ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:40.954301Z","caller":"traceutil/trace.go:171","msg":"trace[2088037808] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"226.533384ms","start":"2026-06-17T03:46:40.727747Z","end":"2026-06-17T03:46:40.954281Z","steps":["trace[2088037808] 'process raft request' (duration: 226.370538ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:40.954783Z","caller":"traceutil/trace.go:171","msg":"trace[415246550] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"226.272494ms","start":"2026-06-17T03:46:40.728458Z","end":"2026-06-17T03:46:40.954731Z","steps":["trace[415246550] 'process raft request' (duration: 226.098597ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:40.955005Z","caller":"traceutil/trace.go:171","msg":"trace[948504236] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"226.637298ms","start":"2026-06-17T03:46:40.728356Z","end":"2026-06-17T03:46:40.954993Z","steps":["trace[948504236] 'process raft request' (duration: 225.880749ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:40.994802Z","caller":"traceutil/trace.go:171","msg":"trace[812988201] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"257.095314ms","start":"2026-06-17T03:46:40.737685Z","end":"2026-06-17T03:46:40.99478Z","steps":["trace[812988201] 'process raft request' (duration: 256.961649ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:51.046409Z","caller":"traceutil/trace.go:171","msg":"trace[424288381] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"177.835652ms","start":"2026-06-17T03:46:50.868554Z","end":"2026-06-17T03:46:51.046389Z","steps":["trace[424288381] 'process raft request' (duration: 143.99248ms)","trace[424288381] 'compare' (duration: 33.656476ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T03:46:51.046409Z","caller":"traceutil/trace.go:171","msg":"trace[1596581677] linearizableReadLoop","detail":"{readStateIndex:943; appliedIndex:941; }","duration":"133.047577ms","start":"2026-06-17T03:46:50.913344Z","end":"2026-06-17T03:46:51.046391Z","steps":["trace[1596581677] 'read index received' (duration: 99.185925ms)","trace[1596581677] 'applied index is now lower than readState.Index' (duration: 33.860792ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T03:46:51.046585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.151205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/local-path-provisioner-679c578f5-vzfhd\" ","response":"range_response_count:1 size:2650"} {"level":"info","ts":"2026-06-17T03:46:51.046645Z","caller":"traceutil/trace.go:171","msg":"trace[840355142] range","detail":"{range_begin:/registry/pods/local-path-storage/local-path-provisioner-679c578f5-vzfhd; range_end:; response_count:1; response_revision:912; }","duration":"176.252438ms","start":"2026-06-17T03:46:50.870374Z","end":"2026-06-17T03:46:51.046627Z","steps":["trace[840355142] 'agreement among raft nodes before linearized reading' (duration: 176.043721ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:51.046785Z","caller":"traceutil/trace.go:171","msg":"trace[1435243922] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"176.272889ms","start":"2026-06-17T03:46:50.870497Z","end":"2026-06-17T03:46:51.04677Z","steps":["trace[1435243922] 'process raft request' (duration: 175.832994ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:51.468308Z","caller":"traceutil/trace.go:171","msg":"trace[1454634633] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"104.183064ms","start":"2026-06-17T03:46:51.364102Z","end":"2026-06-17T03:46:51.468285Z","steps":["trace[1454634633] 'process raft request' (duration: 104.053489ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:51.630297Z","caller":"traceutil/trace.go:171","msg":"trace[1078154076] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"154.930726ms","start":"2026-06-17T03:46:51.475183Z","end":"2026-06-17T03:46:51.630114Z","steps":["trace[1078154076] 'process raft request' (duration: 78.174606ms)","trace[1078154076] 'compare' (duration: 76.632356ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T03:46:52.753003Z","caller":"traceutil/trace.go:171","msg":"trace[803109270] transaction","detail":"{read_only:false; response_revision:924; number_of_response:1; }","duration":"229.379893ms","start":"2026-06-17T03:46:52.523593Z","end":"2026-06-17T03:46:52.752973Z","steps":["trace[803109270] 'process raft request' (duration: 139.125898ms)","trace[803109270] 'compare' (duration: 90.12668ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T03:46:52.852402Z","caller":"traceutil/trace.go:171","msg":"trace[1520379536] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"325.408481ms","start":"2026-06-17T03:46:52.526948Z","end":"2026-06-17T03:46:52.852356Z","steps":["trace[1520379536] 'process raft request' (duration: 325.252295ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:52.852457Z","caller":"traceutil/trace.go:171","msg":"trace[1065159451] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"328.589886ms","start":"2026-06-17T03:46:52.523839Z","end":"2026-06-17T03:46:52.852429Z","steps":["trace[1065159451] 'process raft request' (duration: 328.231174ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:52.852803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:52.523821Z","time spent":"328.880726ms","remote":"127.0.0.1:48422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1104,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T03:46:52.8526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:52.526931Z","time spent":"325.556455ms","remote":"127.0.0.1:48696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5192,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T03:46:53.07127Z","caller":"traceutil/trace.go:171","msg":"trace[1765274922] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"213.869123ms","start":"2026-06-17T03:46:52.857381Z","end":"2026-06-17T03:46:53.07125Z","steps":["trace[1765274922] 'process raft request' (duration: 213.714088ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:53.448439Z","caller":"traceutil/trace.go:171","msg":"trace[1083994392] linearizableReadLoop","detail":"{readStateIndex:959; appliedIndex:957; }","duration":"393.046593ms","start":"2026-06-17T03:46:53.055369Z","end":"2026-06-17T03:46:53.448416Z","steps":["trace[1083994392] 'read index received' (duration: 15.853784ms)","trace[1083994392] 'applied index is now lower than readState.Index' (duration: 377.191899ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T03:46:53.448537Z","caller":"traceutil/trace.go:171","msg":"trace[305979108] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"588.01095ms","start":"2026-06-17T03:46:52.860487Z","end":"2026-06-17T03:46:53.448498Z","steps":["trace[305979108] 'process raft request' (duration: 587.787173ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:53.448714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:52.860465Z","time spent":"588.165144ms","remote":"127.0.0.1:48676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5626,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T03:46:53.44881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.430147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-06-17T03:46:53.448881Z","caller":"traceutil/trace.go:171","msg":"trace[181569665] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:928; }","duration":"393.53476ms","start":"2026-06-17T03:46:53.055328Z","end":"2026-06-17T03:46:53.448863Z","steps":["trace[181569665] 'agreement among raft nodes before linearized reading' (duration: 393.21513ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:53.448944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:53.055311Z","time spent":"393.620542ms","remote":"127.0.0.1:48504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-17T03:46:53.45225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.702279ms","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-17T03:46:53.452361Z","caller":"traceutil/trace.go:171","msg":"trace[1157740446] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"341.25085ms","start":"2026-06-17T03:46:53.11103Z","end":"2026-06-17T03:46:53.452281Z","steps":["trace[1157740446] 'process raft request' (duration: 340.871938ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:53.45243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.399758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-17T03:46:53.452477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.908696ms","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-17T03:46:53.452478Z","caller":"traceutil/trace.go:171","msg":"trace[2021444776] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:929; }","duration":"128.489751ms","start":"2026-06-17T03:46:53.323974Z","end":"2026-06-17T03:46:53.452463Z","steps":["trace[2021444776] 'agreement among raft nodes before linearized reading' (duration: 128.427049ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:53.452508Z","caller":"traceutil/trace.go:171","msg":"trace[1329014359] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:929; }","duration":"378.968878ms","start":"2026-06-17T03:46:53.073531Z","end":"2026-06-17T03:46:53.4525Z","steps":["trace[1329014359] 'agreement among raft nodes before linearized reading' (duration: 378.878785ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:53.452526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:53.073518Z","time spent":"379.004169ms","remote":"127.0.0.1:48504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-17T03:46:53.452514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:53.111005Z","time spent":"341.437236ms","remote":"127.0.0.1:48504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T03:46:53.452592Z","caller":"traceutil/trace.go:171","msg":"trace[1245041303] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:929; }","duration":"378.918347ms","start":"2026-06-17T03:46:53.073501Z","end":"2026-06-17T03:46:53.452419Z","steps":["trace[1245041303] 'agreement among raft nodes before linearized reading' (duration: 378.610097ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:53.452683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:46:53.073489Z","time spent":"379.178425ms","remote":"127.0.0.1:48504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-17T03:46:53.596753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.625001ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-17T03:46:53.596863Z","caller":"traceutil/trace.go:171","msg":"trace[1730356832] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"139.386972ms","start":"2026-06-17T03:46:53.457453Z","end":"2026-06-17T03:46:53.59684Z","steps":["trace[1730356832] 'process raft request' (duration: 21.606055ms)","trace[1730356832] 'compare' (duration: 117.523618ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T03:46:53.623407Z","caller":"traceutil/trace.go:171","msg":"trace[502534722] transaction","detail":"{read_only:false; response_revision:932; number_of_response:1; }","duration":"165.741604ms","start":"2026-06-17T03:46:53.457628Z","end":"2026-06-17T03:46:53.62337Z","steps":["trace[502534722] 'process raft request' (duration: 165.673801ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:53.623495Z","caller":"traceutil/trace.go:171","msg":"trace[194816874] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"165.963751ms","start":"2026-06-17T03:46:53.457475Z","end":"2026-06-17T03:46:53.623439Z","steps":["trace[194816874] 'process raft request' (duration: 165.673281ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:46:53.999744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.593871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.72\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-17T03:46:53.999804Z","caller":"traceutil/trace.go:171","msg":"trace[2077636208] range","detail":"{range_begin:/registry/masterleases/199.204.45.72; range_end:; response_count:1; response_revision:932; }","duration":"156.709785ms","start":"2026-06-17T03:46:53.843082Z","end":"2026-06-17T03:46:53.999791Z","steps":["trace[2077636208] 'range keys from in-memory index tree' (duration: 156.451566ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:54.291777Z","caller":"traceutil/trace.go:171","msg":"trace[18869182] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"123.479886ms","start":"2026-06-17T03:46:54.168275Z","end":"2026-06-17T03:46:54.291755Z","steps":["trace[18869182] 'process raft request' (duration: 121.799361ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:54.433891Z","caller":"traceutil/trace.go:171","msg":"trace[1349983514] transaction","detail":"{read_only:false; response_revision:937; number_of_response:1; }","duration":"254.448649ms","start":"2026-06-17T03:46:54.179416Z","end":"2026-06-17T03:46:54.433864Z","steps":["trace[1349983514] 'process raft request' (duration: 254.015644ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:46:54.456923Z","caller":"traceutil/trace.go:171","msg":"trace[1261359287] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"158.467573ms","start":"2026-06-17T03:46:54.298429Z","end":"2026-06-17T03:46:54.456897Z","steps":["trace[1261359287] 'process raft request' (duration: 158.334519ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:47:07.298392Z","caller":"traceutil/trace.go:171","msg":"trace[852748148] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"155.990508ms","start":"2026-06-17T03:47:07.142381Z","end":"2026-06-17T03:47:07.298371Z","steps":["trace[852748148] 'process raft request' (duration: 155.867494ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:47:07.446754Z","caller":"traceutil/trace.go:171","msg":"trace[682408283] transaction","detail":"{read_only:false; response_revision:987; number_of_response:1; }","duration":"302.369146ms","start":"2026-06-17T03:47:07.144336Z","end":"2026-06-17T03:47:07.446705Z","steps":["trace[682408283] 'process raft request' (duration: 243.786982ms)","trace[682408283] 'compare' (duration: 58.267074ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T03:47:07.446705Z","caller":"traceutil/trace.go:171","msg":"trace[946813579] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"254.247026ms","start":"2026-06-17T03:47:07.1924Z","end":"2026-06-17T03:47:07.446647Z","steps":["trace[946813579] 'process raft request' (duration: 254.179204ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:47:07.446904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:47:07.144322Z","time spent":"302.50508ms","remote":"127.0.0.1:48504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T03:47:07.833777Z","caller":"traceutil/trace.go:171","msg":"trace[1475616251] linearizableReadLoop","detail":"{readStateIndex:1025; appliedIndex:1024; }","duration":"115.49434ms","start":"2026-06-17T03:47:07.718257Z","end":"2026-06-17T03:47:07.833751Z","steps":["trace[1475616251] 'read index received' (duration: 50.566621ms)","trace[1475616251] 'applied index is now lower than readState.Index' (duration: 64.926779ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T03:47:07.833929Z","caller":"traceutil/trace.go:171","msg":"trace[149101639] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"133.854004ms","start":"2026-06-17T03:47:07.700036Z","end":"2026-06-17T03:47:07.83389Z","steps":["trace[149101639] 'process raft request' (duration: 68.866723ms)","trace[149101639] 'compare' (duration: 64.722503ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T03:47:07.834063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.744348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-17T03:47:07.83423Z","caller":"traceutil/trace.go:171","msg":"trace[212103469] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:991; }","duration":"116.006915ms","start":"2026-06-17T03:47:07.718206Z","end":"2026-06-17T03:47:07.834213Z","steps":["trace[212103469] 'agreement among raft nodes before linearized reading' (duration: 115.695646ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:47:12.270495Z","caller":"traceutil/trace.go:171","msg":"trace[1952084036] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"104.145832ms","start":"2026-06-17T03:47:12.166327Z","end":"2026-06-17T03:47:12.270473Z","steps":["trace[1952084036] 'process raft request' (duration: 104.004308ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:47:40.707526Z","caller":"traceutil/trace.go:171","msg":"trace[151786118] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"136.956165ms","start":"2026-06-17T03:47:40.570541Z","end":"2026-06-17T03:47:40.707497Z","steps":["trace[151786118] 'process raft request' (duration: 136.73394ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:47:46.106461Z","caller":"traceutil/trace.go:171","msg":"trace[816373900] transaction","detail":"{read_only:false; response_revision:1119; number_of_response:1; }","duration":"138.972824ms","start":"2026-06-17T03:47:45.967457Z","end":"2026-06-17T03:47:46.10643Z","steps":["trace[816373900] 'process raft request' (duration: 79.591378ms)","trace[816373900] 'compare' (duration: 59.259524ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T03:47:46.398484Z","caller":"traceutil/trace.go:171","msg":"trace[1574950524] transaction","detail":"{read_only:false; response_revision:1121; number_of_response:1; }","duration":"103.953412ms","start":"2026-06-17T03:47:46.2945Z","end":"2026-06-17T03:47:46.398453Z","steps":["trace[1574950524] 'process raft request' (duration: 61.986493ms)","trace[1574950524] 'compare' (duration: 41.771545ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T03:47:58.406533Z","caller":"traceutil/trace.go:171","msg":"trace[716819753] linearizableReadLoop","detail":"{readStateIndex:1203; appliedIndex:1202; }","duration":"110.68267ms","start":"2026-06-17T03:47:58.295823Z","end":"2026-06-17T03:47:58.406506Z","steps":["trace[716819753] 'read index received' (duration: 110.546037ms)","trace[716819753] 'applied index is now lower than readState.Index' (duration: 135.493µs)"],"step_count":2} {"level":"warn","ts":"2026-06-17T03:47:58.406895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.043717ms","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-17T03:47:58.406958Z","caller":"traceutil/trace.go:171","msg":"trace[334580646] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1159; }","duration":"111.150819ms","start":"2026-06-17T03:47:58.295789Z","end":"2026-06-17T03:47:58.40694Z","steps":["trace[334580646] 'agreement among raft nodes before linearized reading' (duration: 110.849903ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:47:58.407128Z","caller":"traceutil/trace.go:171","msg":"trace[583902173] transaction","detail":"{read_only:false; response_revision:1159; number_of_response:1; }","duration":"138.670214ms","start":"2026-06-17T03:47:58.268378Z","end":"2026-06-17T03:47:58.407048Z","steps":["trace[583902173] 'process raft request' (duration: 137.925709ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:48:23.611751Z","caller":"traceutil/trace.go:171","msg":"trace[1106741811] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"145.457997ms","start":"2026-06-17T03:48:23.466276Z","end":"2026-06-17T03:48:23.611734Z","steps":["trace[1106741811] 'process raft request' (duration: 145.318855ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:48:23.976189Z","caller":"traceutil/trace.go:171","msg":"trace[561964961] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"101.178699ms","start":"2026-06-17T03:48:23.874984Z","end":"2026-06-17T03:48:23.976162Z","steps":["trace[561964961] 'process raft request' (duration: 69.457325ms)","trace[561964961] 'compare' (duration: 31.605272ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T03:48:26.557034Z","caller":"traceutil/trace.go:171","msg":"trace[1621606206] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"191.216968ms","start":"2026-06-17T03:48:26.365792Z","end":"2026-06-17T03:48:26.557009Z","steps":["trace[1621606206] 'process raft request' (duration: 191.037445ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T03:48:33.61082Z","caller":"traceutil/trace.go:171","msg":"trace[1112410249] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"498.492462ms","start":"2026-06-17T03:48:33.112305Z","end":"2026-06-17T03:48:33.610797Z","steps":["trace[1112410249] 'process raft request' (duration: 498.302229ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T03:48:33.610985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T03:48:33.112288Z","time spent":"498.609144ms","remote":"127.0.0.1:48504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"}