{"level":"warn","ts":"2026-05-10T03:59:20.359813Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-10T03:59:20.359895Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.57: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.57:2380","--initial-cluster=instance=https://199.204.45.57:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.57:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.57:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-10T03:59:20.359954Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-10T03:59:20.359965Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-05-10T03:59:20.359982Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-10T03:59:20.360579Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"]} {"level":"info","ts":"2026-05-10T03:59:20.360648Z","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.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.57:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-10T03:59:20.483359Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"118.596912ms"} {"level":"info","ts":"2026-05-10T03:59:20.605735Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b6478f0ac5aeb8e1","cluster-id":"6c58cff80d4a5b62"} {"level":"info","ts":"2026-05-10T03:59:20.605829Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=()"} {"level":"info","ts":"2026-05-10T03:59:20.605848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 0"} {"level":"info","ts":"2026-05-10T03:59:20.605856Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b6478f0ac5aeb8e1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-10T03:59:20.605865Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 1"} {"level":"info","ts":"2026-05-10T03:59:20.605896Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"warn","ts":"2026-05-10T03:59:20.637263Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-10T03:59:20.65626Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-10T03:59:20.677047Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-10T03:59:20.691311Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b6478f0ac5aeb8e1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-10T03:59:20.691888Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b6478f0ac5aeb8e1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-10T03:59:20.692234Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-10T03:59:20.692505Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-10T03:59:20.69253Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-10T03:59:20.693166Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"info","ts":"2026-05-10T03:59:20.704284Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","added-peer-id":"b6478f0ac5aeb8e1","added-peer-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-05-10T03:59:20.706728Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-10T03:59:20.706945Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-05-10T03:59:20.707007Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-05-10T03:59:20.707258Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b6478f0ac5aeb8e1","initial-advertise-peer-urls":["https://199.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-10T03:59:20.707299Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-10T03:59:20.706971Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 is starting a new election at term 1"} {"level":"info","ts":"2026-05-10T03:59:20.708157Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-10T03:59:20.708265Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgPreVoteResp from b6478f0ac5aeb8e1 at term 1"} {"level":"info","ts":"2026-05-10T03:59:20.70836Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became candidate at term 2"} {"level":"info","ts":"2026-05-10T03:59:20.708441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgVoteResp from b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-05-10T03:59:20.708512Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became leader at term 2"} {"level":"info","ts":"2026-05-10T03:59:20.708534Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b6478f0ac5aeb8e1 elected leader b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-05-10T03:59:20.709237Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-10T03:59:20.710067Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-10T03:59:20.710068Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b6478f0ac5aeb8e1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.57:2379]}","request-path":"/0/members/b6478f0ac5aeb8e1/attributes","cluster-id":"6c58cff80d4a5b62","publish-timeout":"7s"} {"level":"info","ts":"2026-05-10T03:59:20.710084Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-10T03:59:20.710352Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-10T03:59:20.710429Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-10T03:59:20.712573Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.57:2379"} {"level":"info","ts":"2026-05-10T03:59:20.712726Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","cluster-version":"3.5"} {"level":"info","ts":"2026-05-10T03:59:20.713142Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-10T03:59:20.713172Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-10T03:59:20.714272Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-10T03:59:22.555621Z","caller":"traceutil/trace.go:171","msg":"trace[1908099020] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"114.968743ms","start":"2026-05-10T03:59:22.440599Z","end":"2026-05-10T03:59:22.555567Z","steps":["trace[1908099020] 'process raft request' (duration: 114.810622ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:22.555673Z","caller":"traceutil/trace.go:171","msg":"trace[1999889038] transaction","detail":"{read_only:false; number_of_response:0; response_revision:6; }","duration":"114.857972ms","start":"2026-05-10T03:59:22.440783Z","end":"2026-05-10T03:59:22.555641Z","steps":["trace[1999889038] 'process raft request' (duration: 114.711711ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:22.555774Z","caller":"traceutil/trace.go:171","msg":"trace[1534075059] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"113.568803ms","start":"2026-05-10T03:59:22.442166Z","end":"2026-05-10T03:59:22.555735Z","steps":["trace[1534075059] 'process raft request' (duration: 113.354982ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:22.556153Z","caller":"traceutil/trace.go:171","msg":"trace[2015051205] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"113.441511ms","start":"2026-05-10T03:59:22.442692Z","end":"2026-05-10T03:59:22.556133Z","steps":["trace[2015051205] 'process raft request' (duration: 112.925207ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:22.557228Z","caller":"traceutil/trace.go:171","msg":"trace[832244331] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"113.25806ms","start":"2026-05-10T03:59:22.443957Z","end":"2026-05-10T03:59:22.557215Z","steps":["trace[832244331] 'process raft request' (duration: 111.739809ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:22.557801Z","caller":"traceutil/trace.go:171","msg":"trace[1279513698] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"113.030889ms","start":"2026-05-10T03:59:22.444729Z","end":"2026-05-10T03:59:22.55776Z","steps":["trace[1279513698] 'process raft request' (duration: 112.880818ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:22.557952Z","caller":"traceutil/trace.go:171","msg":"trace[185234120] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"112.570046ms","start":"2026-05-10T03:59:22.445348Z","end":"2026-05-10T03:59:22.557918Z","steps":["trace[185234120] 'process raft request' (duration: 112.284694ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:22.558102Z","caller":"traceutil/trace.go:171","msg":"trace[1946109987] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"113.591783ms","start":"2026-05-10T03:59:22.444497Z","end":"2026-05-10T03:59:22.558088Z","steps":["trace[1946109987] 'process raft request' (duration: 111.613918ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:22.558301Z","caller":"traceutil/trace.go:171","msg":"trace[967629107] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"113.746014ms","start":"2026-05-10T03:59:22.444544Z","end":"2026-05-10T03:59:22.55829Z","steps":["trace[967629107] 'process raft request' (duration: 113.027998ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:22.559333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.038356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-10T03:59:22.559521Z","caller":"traceutil/trace.go:171","msg":"trace[1884766599] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:13; }","duration":"106.232628ms","start":"2026-05-10T03:59:22.453208Z","end":"2026-05-10T03:59:22.55944Z","steps":["trace[1884766599] 'agreement among raft nodes before linearized reading' (duration: 106.030956ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:22.716283Z","caller":"traceutil/trace.go:171","msg":"trace[525859361] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"153.112638ms","start":"2026-05-10T03:59:22.563102Z","end":"2026-05-10T03:59:22.716215Z","steps":["trace[525859361] 'process raft request' (duration: 100.485093ms)","trace[525859361] 'compare' (duration: 52.322363ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:59:22.716429Z","caller":"traceutil/trace.go:171","msg":"trace[631385600] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"152.518824ms","start":"2026-05-10T03:59:22.563885Z","end":"2026-05-10T03:59:22.716404Z","steps":["trace[631385600] 'process raft request' (duration: 152.263242ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:22.716686Z","caller":"traceutil/trace.go:171","msg":"trace[460968167] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"152.770786ms","start":"2026-05-10T03:59:22.563906Z","end":"2026-05-10T03:59:22.716677Z","steps":["trace[460968167] 'process raft request' (duration: 152.529124ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:22.716804Z","caller":"traceutil/trace.go:171","msg":"trace[1268021276] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"149.960344ms","start":"2026-05-10T03:59:22.566826Z","end":"2026-05-10T03:59:22.716786Z","steps":["trace[1268021276] 'process raft request' (duration: 149.761543ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:22.716799Z","caller":"traceutil/trace.go:171","msg":"trace[821516453] linearizableReadLoop","detail":"{readStateIndex:22; appliedIndex:17; }","duration":"152.431243ms","start":"2026-05-10T03:59:22.564339Z","end":"2026-05-10T03:59:22.716771Z","steps":["trace[821516453] 'read index received' (duration: 51.483236ms)","trace[821516453] 'applied index is now lower than readState.Index' (duration: 100.946447ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:59:22.716955Z","caller":"traceutil/trace.go:171","msg":"trace[1540949938] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"151.130784ms","start":"2026-05-10T03:59:22.565813Z","end":"2026-05-10T03:59:22.716944Z","steps":["trace[1540949938] 'process raft request' (duration: 150.698081ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:22.717003Z","caller":"traceutil/trace.go:171","msg":"trace[636271715] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"150.223807ms","start":"2026-05-10T03:59:22.566771Z","end":"2026-05-10T03:59:22.716995Z","steps":["trace[636271715] 'process raft request' (duration: 149.777364ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:22.717004Z","caller":"traceutil/trace.go:171","msg":"trace[383864718] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"150.129856ms","start":"2026-05-10T03:59:22.566856Z","end":"2026-05-10T03:59:22.716986Z","steps":["trace[383864718] 'process raft request' (duration: 149.768393ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:22.717166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.748115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3490"} {"level":"info","ts":"2026-05-10T03:59:22.717237Z","caller":"traceutil/trace.go:171","msg":"trace[1775755618] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:23; }","duration":"152.921527ms","start":"2026-05-10T03:59:22.564297Z","end":"2026-05-10T03:59:22.717219Z","steps":["trace[1775755618] 'agreement among raft nodes before linearized reading' (duration: 152.647424ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:22.71754Z","caller":"traceutil/trace.go:171","msg":"trace[1294513658] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"146.606729ms","start":"2026-05-10T03:59:22.570315Z","end":"2026-05-10T03:59:22.716922Z","steps":["trace[1294513658] 'process raft request' (duration: 146.365208ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:22.72485Z","caller":"traceutil/trace.go:171","msg":"trace[1613919034] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"105.445561ms","start":"2026-05-10T03:59:22.619388Z","end":"2026-05-10T03:59:22.724834Z","steps":["trace[1613919034] 'process raft request' (duration: 105.30049ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:22.724847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.249657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-10T03:59:22.724887Z","caller":"traceutil/trace.go:171","msg":"trace[344285734] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"105.518971ms","start":"2026-05-10T03:59:22.619311Z","end":"2026-05-10T03:59:22.72483Z","steps":["trace[344285734] 'process raft request' (duration: 105.288399ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:22.724936Z","caller":"traceutil/trace.go:171","msg":"trace[823269662] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:25; }","duration":"158.376657ms","start":"2026-05-10T03:59:22.566538Z","end":"2026-05-10T03:59:22.724915Z","steps":["trace[823269662] 'agreement among raft nodes before linearized reading' (duration: 158.198946ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:22.725032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.123771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-10T03:59:22.725156Z","caller":"traceutil/trace.go:171","msg":"trace[783097852] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:25; }","duration":"112.336023ms","start":"2026-05-10T03:59:22.612807Z","end":"2026-05-10T03:59:22.725143Z","steps":["trace[783097852] 'agreement among raft nodes before linearized reading' (duration: 112.072921ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:24.503593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.225254ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-10T03:59:24.50375Z","caller":"traceutil/trace.go:171","msg":"trace[1625603432] transaction","detail":"{read_only:false; response_revision:207; number_of_response:1; }","duration":"174.627933ms","start":"2026-05-10T03:59:24.329082Z","end":"2026-05-10T03:59:24.50371Z","steps":["trace[1625603432] 'process raft request' (duration: 47.496762ms)","trace[1625603432] 'compare' (duration: 126.088383ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:59:24.81303Z","caller":"traceutil/trace.go:171","msg":"trace[603966135] transaction","detail":"{read_only:false; response_revision:218; number_of_response:1; }","duration":"124.695094ms","start":"2026-05-10T03:59:24.688309Z","end":"2026-05-10T03:59:24.813004Z","steps":["trace[603966135] 'process raft request' (duration: 101.634172ms)","trace[603966135] 'compare' (duration: 22.913841ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:59:24.968147Z","caller":"traceutil/trace.go:171","msg":"trace[727085955] transaction","detail":"{read_only:false; response_revision:220; number_of_response:1; }","duration":"101.24819ms","start":"2026-05-10T03:59:24.866876Z","end":"2026-05-10T03:59:24.968125Z","steps":["trace[727085955] 'process raft request' (duration: 90.911723ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:25.234681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.101295ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-10T03:59:25.234816Z","caller":"traceutil/trace.go:171","msg":"trace[1310407643] transaction","detail":"{read_only:false; response_revision:226; number_of_response:1; }","duration":"165.488117ms","start":"2026-05-10T03:59:25.069307Z","end":"2026-05-10T03:59:25.234795Z","steps":["trace[1310407643] 'compare' (duration: 160.937604ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:26.102058Z","caller":"traceutil/trace.go:171","msg":"trace[98289257] transaction","detail":"{read_only:false; response_revision:243; number_of_response:1; }","duration":"236.554757ms","start":"2026-05-10T03:59:25.865455Z","end":"2026-05-10T03:59:26.10201Z","steps":["trace[98289257] 'process raft request' (duration: 221.597817ms)","trace[98289257] 'compare' (duration: 14.723158ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:59:27.857387Z","caller":"traceutil/trace.go:171","msg":"trace[2026853719] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"273.105724ms","start":"2026-05-10T03:59:27.584179Z","end":"2026-05-10T03:59:27.857285Z","steps":["trace[2026853719] 'process raft request' (duration: 272.918423ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:28.313336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.184347ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-10T03:59:28.313448Z","caller":"traceutil/trace.go:171","msg":"trace[750496461] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"329.24784ms","start":"2026-05-10T03:59:27.984181Z","end":"2026-05-10T03:59:28.313428Z","steps":["trace[750496461] 'process raft request' (duration: 157.892882ms)","trace[750496461] 'compare' (duration: 170.982565ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T03:59:28.313503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:27.984167Z","time spent":"329.31584ms","remote":"127.0.0.1:40162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":400,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-10T03:59:28.322352Z","caller":"traceutil/trace.go:171","msg":"trace[631424178] transaction","detail":"{read_only:false; number_of_response:0; response_revision:297; }","duration":"295.865587ms","start":"2026-05-10T03:59:28.026453Z","end":"2026-05-10T03:59:28.322319Z","steps":["trace[631424178] 'process raft request' (duration: 295.761216ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:28.322395Z","caller":"traceutil/trace.go:171","msg":"trace[1012064198] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"296.579902ms","start":"2026-05-10T03:59:28.025792Z","end":"2026-05-10T03:59:28.322372Z","steps":["trace[1012064198] 'process raft request' (duration: 296.30096ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:28.32243Z","caller":"traceutil/trace.go:171","msg":"trace[528151485] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"282.813183ms","start":"2026-05-10T03:59:28.039583Z","end":"2026-05-10T03:59:28.322396Z","steps":["trace[528151485] 'process raft request' (duration: 282.672162ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:28.322534Z","caller":"traceutil/trace.go:171","msg":"trace[1200682973] linearizableReadLoop","detail":"{readStateIndex:304; appliedIndex:301; }","duration":"289.477141ms","start":"2026-05-10T03:59:28.033028Z","end":"2026-05-10T03:59:28.322505Z","steps":["trace[1200682973] 'read index received' (duration: 109.063988ms)","trace[1200682973] 'applied index is now lower than readState.Index' (duration: 180.412003ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:59:28.322668Z","caller":"traceutil/trace.go:171","msg":"trace[626206808] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"283.007535ms","start":"2026-05-10T03:59:28.039648Z","end":"2026-05-10T03:59:28.322656Z","steps":["trace[626206808] 'process raft request' (duration: 282.650712ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:28.322776Z","caller":"traceutil/trace.go:171","msg":"trace[1074996345] transaction","detail":"{read_only:false; number_of_response:0; response_revision:299; }","duration":"281.386564ms","start":"2026-05-10T03:59:28.041379Z","end":"2026-05-10T03:59:28.322766Z","steps":["trace[1074996345] 'process raft request' (duration: 281.05645ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:28.322805Z","caller":"traceutil/trace.go:171","msg":"trace[1653730147] transaction","detail":"{read_only:false; number_of_response:0; response_revision:299; }","duration":"283.050635ms","start":"2026-05-10T03:59:28.039744Z","end":"2026-05-10T03:59:28.322795Z","steps":["trace[1653730147] 'process raft request' (duration: 282.600281ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:28.3229Z","caller":"traceutil/trace.go:171","msg":"trace[1517072507] transaction","detail":"{read_only:false; number_of_response:0; response_revision:299; }","duration":"282.989935ms","start":"2026-05-10T03:59:28.039898Z","end":"2026-05-10T03:59:28.322888Z","steps":["trace[1517072507] 'process raft request' (duration: 282.51496ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:28.322912Z","caller":"traceutil/trace.go:171","msg":"trace[1447039814] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"238.894927ms","start":"2026-05-10T03:59:28.084006Z","end":"2026-05-10T03:59:28.322901Z","steps":["trace[1447039814] 'process raft request' (duration: 238.450323ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:28.32302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.982335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-05-10T03:59:28.323075Z","caller":"traceutil/trace.go:171","msg":"trace[2001198802] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:300; }","duration":"290.043316ms","start":"2026-05-10T03:59:28.033011Z","end":"2026-05-10T03:59:28.323054Z","steps":["trace[2001198802] 'agreement among raft nodes before linearized reading' (duration: 289.895465ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:28.515419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.707667ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-10T03:59:28.515636Z","caller":"traceutil/trace.go:171","msg":"trace[483952036] linearizableReadLoop","detail":"{readStateIndex:314; appliedIndex:312; }","duration":"143.306945ms","start":"2026-05-10T03:59:28.37231Z","end":"2026-05-10T03:59:28.515617Z","steps":["trace[483952036] 'read index received' (duration: 42.172435ms)","trace[483952036] 'applied index is now lower than readState.Index' (duration: 101.13339ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:59:28.51572Z","caller":"traceutil/trace.go:171","msg":"trace[616994063] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"161.586597ms","start":"2026-05-10T03:59:28.354118Z","end":"2026-05-10T03:59:28.515705Z","steps":["trace[616994063] 'process raft request' (duration: 60.335706ms)","trace[616994063] 'compare' (duration: 100.562256ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T03:59:28.515882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.558668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4016"} {"level":"info","ts":"2026-05-10T03:59:28.515954Z","caller":"traceutil/trace.go:171","msg":"trace[199200606] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:304; }","duration":"143.680999ms","start":"2026-05-10T03:59:28.372257Z","end":"2026-05-10T03:59:28.515938Z","steps":["trace[199200606] 'agreement among raft nodes before linearized reading' (duration: 143.503666ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:28.515827Z","caller":"traceutil/trace.go:171","msg":"trace[1993613898] transaction","detail":"{read_only:false; response_revision:304; number_of_response:1; }","duration":"155.490453ms","start":"2026-05-10T03:59:28.360257Z","end":"2026-05-10T03:59:28.515748Z","steps":["trace[1993613898] 'process raft request' (duration: 155.298572ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:28.522311Z","caller":"traceutil/trace.go:171","msg":"trace[270616871] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"148.424872ms","start":"2026-05-10T03:59:28.37387Z","end":"2026-05-10T03:59:28.522295Z","steps":["trace[270616871] 'process raft request' (duration: 148.300751ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:28.522429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.472703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/expand-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T03:59:28.52253Z","caller":"traceutil/trace.go:171","msg":"trace[1050162628] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/expand-controller; range_end:; response_count:0; response_revision:305; }","duration":"148.649134ms","start":"2026-05-10T03:59:28.373862Z","end":"2026-05-10T03:59:28.522511Z","steps":["trace[1050162628] 'agreement among raft nodes before linearized reading' (duration: 148.423042ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:28.720001Z","caller":"traceutil/trace.go:171","msg":"trace[947722764] linearizableReadLoop","detail":"{readStateIndex:320; appliedIndex:319; }","duration":"124.734731ms","start":"2026-05-10T03:59:28.59524Z","end":"2026-05-10T03:59:28.719975Z","steps":["trace[947722764] 'read index received' (duration: 116.404581ms)","trace[947722764] 'applied index is now lower than readState.Index' (duration: 8.32888ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:59:28.720134Z","caller":"traceutil/trace.go:171","msg":"trace[1451985941] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"126.105301ms","start":"2026-05-10T03:59:28.594017Z","end":"2026-05-10T03:59:28.720122Z","steps":["trace[1451985941] 'process raft request' (duration: 117.64036ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:28.720344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.086163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-10T03:59:28.720431Z","caller":"traceutil/trace.go:171","msg":"trace[1126065404] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:310; }","duration":"125.220845ms","start":"2026-05-10T03:59:28.595191Z","end":"2026-05-10T03:59:28.720412Z","steps":["trace[1126065404] 'agreement among raft nodes before linearized reading' (duration: 125.018863ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:28.935873Z","caller":"traceutil/trace.go:171","msg":"trace[537354795] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"122.824137ms","start":"2026-05-10T03:59:28.81302Z","end":"2026-05-10T03:59:28.935844Z","steps":["trace[537354795] 'process raft request' (duration: 122.747026ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:28.935878Z","caller":"traceutil/trace.go:171","msg":"trace[445281083] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"130.919325ms","start":"2026-05-10T03:59:28.80492Z","end":"2026-05-10T03:59:28.935839Z","steps":["trace[445281083] 'process raft request' (duration: 35.081483ms)","trace[445281083] 'compare' (duration: 95.644661ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T03:59:29.418357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.235587ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-10T03:59:29.418533Z","caller":"traceutil/trace.go:171","msg":"trace[920447014] linearizableReadLoop","detail":"{readStateIndex:334; appliedIndex:331; }","duration":"263.321802ms","start":"2026-05-10T03:59:29.155202Z","end":"2026-05-10T03:59:29.418524Z","steps":["trace[920447014] 'read index received' (duration: 161.920704ms)","trace[920447014] 'applied index is now lower than readState.Index' (duration: 101.400328ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:59:29.418522Z","caller":"traceutil/trace.go:171","msg":"trace[1938116888] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"320.050739ms","start":"2026-05-10T03:59:29.098453Z","end":"2026-05-10T03:59:29.418504Z","steps":["trace[1938116888] 'process raft request' (duration: 218.606961ms)","trace[1938116888] 'compare' (duration: 101.083586ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T03:59:29.418599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.394292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T03:59:29.418581Z","caller":"traceutil/trace.go:171","msg":"trace[382907742] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"319.761417ms","start":"2026-05-10T03:59:29.098797Z","end":"2026-05-10T03:59:29.418559Z","steps":["trace[382907742] 'process raft request' (duration: 319.635156ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:29.418598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:29.098435Z","time spent":"320.13534ms","remote":"127.0.0.1:40078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T03:59:29.41862Z","caller":"traceutil/trace.go:171","msg":"trace[1227956883] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-controller; range_end:; response_count:0; response_revision:324; }","duration":"263.448292ms","start":"2026-05-10T03:59:29.155164Z","end":"2026-05-10T03:59:29.418612Z","steps":["trace[1227956883] 'agreement among raft nodes before linearized reading' (duration: 263.394762ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:29.418681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:29.098787Z","time spent":"319.838727ms","remote":"127.0.0.1:40078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T03:59:29.418783Z","caller":"traceutil/trace.go:171","msg":"trace[1141184328] transaction","detail":"{read_only:false; response_revision:324; number_of_response:1; }","duration":"310.967633ms","start":"2026-05-10T03:59:29.107807Z","end":"2026-05-10T03:59:29.418775Z","steps":["trace[1141184328] 'process raft request' (duration: 310.672101ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:29.418818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:29.107785Z","time spent":"311.007943ms","remote":"127.0.0.1:39994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6736,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T03:59:29.616909Z","caller":"traceutil/trace.go:171","msg":"trace[1191358688] linearizableReadLoop","detail":"{readStateIndex:336; appliedIndex:335; }","duration":"178.588483ms","start":"2026-05-10T03:59:29.438295Z","end":"2026-05-10T03:59:29.616884Z","steps":["trace[1191358688] 'read index received' (duration: 140.409618ms)","trace[1191358688] 'applied index is now lower than readState.Index' (duration: 38.177965ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T03:59:29.617002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.686183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-05-10T03:59:29.617022Z","caller":"traceutil/trace.go:171","msg":"trace[563265319] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:326; }","duration":"178.748754ms","start":"2026-05-10T03:59:29.438267Z","end":"2026-05-10T03:59:29.617016Z","steps":["trace[563265319] 'agreement among raft nodes before linearized reading' (duration: 178.688093ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:29.617178Z","caller":"traceutil/trace.go:171","msg":"trace[905485445] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"190.443677ms","start":"2026-05-10T03:59:29.426696Z","end":"2026-05-10T03:59:29.617139Z","steps":["trace[905485445] 'process raft request' (duration: 151.993181ms)","trace[905485445] 'compare' (duration: 38.073853ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:59:29.824413Z","caller":"traceutil/trace.go:171","msg":"trace[1512312790] linearizableReadLoop","detail":"{readStateIndex:338; appliedIndex:337; }","duration":"190.006725ms","start":"2026-05-10T03:59:29.634376Z","end":"2026-05-10T03:59:29.824383Z","steps":["trace[1512312790] 'read index received' (duration: 108.52421ms)","trace[1512312790] 'applied index is now lower than readState.Index' (duration: 81.481375ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T03:59:29.824584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.190456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-05-10T03:59:29.82462Z","caller":"traceutil/trace.go:171","msg":"trace[1685009259] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:328; }","duration":"190.280897ms","start":"2026-05-10T03:59:29.634328Z","end":"2026-05-10T03:59:29.824609Z","steps":["trace[1685009259] 'agreement among raft nodes before linearized reading' (duration: 190.153216ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:29.824689Z","caller":"traceutil/trace.go:171","msg":"trace[365379339] transaction","detail":"{read_only:false; response_revision:328; number_of_response:1; }","duration":"199.231331ms","start":"2026-05-10T03:59:29.625384Z","end":"2026-05-10T03:59:29.824615Z","steps":["trace[365379339] 'process raft request' (duration: 117.512174ms)","trace[365379339] 'compare' (duration: 81.363604ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T03:59:30.185971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.509316ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-10T03:59:30.186158Z","caller":"traceutil/trace.go:171","msg":"trace[1710397962] transaction","detail":"{read_only:false; response_revision:330; number_of_response:1; }","duration":"321.757234ms","start":"2026-05-10T03:59:29.864384Z","end":"2026-05-10T03:59:30.186141Z","steps":["trace[1710397962] 'process raft request' (duration: 321.693414ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:30.18622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:29.864357Z","time spent":"321.836064ms","remote":"127.0.0.1:40016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":194,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-10T03:59:30.186201Z","caller":"traceutil/trace.go:171","msg":"trace[450747649] transaction","detail":"{read_only:false; response_revision:329; number_of_response:1; }","duration":"352.892827ms","start":"2026-05-10T03:59:29.833268Z","end":"2026-05-10T03:59:30.186161Z","steps":["trace[450747649] 'process raft request' (duration: 199.112549ms)","trace[450747649] 'compare' (duration: 153.362695ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T03:59:30.186389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:29.833256Z","time spent":"353.027908ms","remote":"127.0.0.1:39994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5139,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T03:59:30.407218Z","caller":"traceutil/trace.go:171","msg":"trace[1204018777] linearizableReadLoop","detail":"{readStateIndex:342; appliedIndex:341; }","duration":"202.093174ms","start":"2026-05-10T03:59:30.205103Z","end":"2026-05-10T03:59:30.407196Z","steps":["trace[1204018777] 'read index received' (duration: 115.612836ms)","trace[1204018777] 'applied index is now lower than readState.Index' (duration: 86.479178ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T03:59:30.407375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.239945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" ","response":"range_response_count:1 size:205"} {"level":"info","ts":"2026-05-10T03:59:30.407416Z","caller":"traceutil/trace.go:171","msg":"trace[1338209841] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:1; response_revision:332; }","duration":"202.321626ms","start":"2026-05-10T03:59:30.205085Z","end":"2026-05-10T03:59:30.407407Z","steps":["trace[1338209841] 'agreement among raft nodes before linearized reading' (duration: 202.189355ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:30.407725Z","caller":"traceutil/trace.go:171","msg":"trace[1090412970] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"210.033861ms","start":"2026-05-10T03:59:30.197674Z","end":"2026-05-10T03:59:30.407708Z","steps":["trace[1090412970] 'process raft request' (duration: 123.10238ms)","trace[1090412970] 'compare' (duration: 86.302666ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T03:59:30.652878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.12471ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-10T03:59:30.652944Z","caller":"traceutil/trace.go:171","msg":"trace[1176506763] linearizableReadLoop","detail":"{readStateIndex:344; appliedIndex:343; }","duration":"133.090971ms","start":"2026-05-10T03:59:30.519841Z","end":"2026-05-10T03:59:30.652932Z","steps":["trace[1176506763] 'read index received' (duration: 23.82798ms)","trace[1176506763] 'applied index is now lower than readState.Index' (duration: 109.261921ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T03:59:30.653038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.190341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-10T03:59:30.653062Z","caller":"traceutil/trace.go:171","msg":"trace[129272284] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:334; }","duration":"133.246641ms","start":"2026-05-10T03:59:30.519809Z","end":"2026-05-10T03:59:30.653056Z","steps":["trace[129272284] 'agreement among raft nodes before linearized reading' (duration: 133.164421ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:30.653195Z","caller":"traceutil/trace.go:171","msg":"trace[802292844] transaction","detail":"{read_only:false; response_revision:334; number_of_response:1; }","duration":"161.881155ms","start":"2026-05-10T03:59:30.491305Z","end":"2026-05-10T03:59:30.653187Z","steps":["trace[802292844] 'process raft request' (duration: 52.397793ms)","trace[802292844] 'compare' (duration: 109.054449ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:59:31.107739Z","caller":"traceutil/trace.go:171","msg":"trace[1151660039] linearizableReadLoop","detail":"{readStateIndex:353; appliedIndex:351; }","duration":"173.811458ms","start":"2026-05-10T03:59:30.933903Z","end":"2026-05-10T03:59:31.107714Z","steps":["trace[1151660039] 'read index received' (duration: 142.173002ms)","trace[1151660039] 'applied index is now lower than readState.Index' (duration: 31.637076ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:59:31.107962Z","caller":"traceutil/trace.go:171","msg":"trace[248152471] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"202.322471ms","start":"2026-05-10T03:59:30.905596Z","end":"2026-05-10T03:59:31.107918Z","steps":["trace[248152471] 'process raft request' (duration: 202.035209ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:31.108025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.10603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-05-10T03:59:31.108156Z","caller":"traceutil/trace.go:171","msg":"trace[2111212397] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:343; }","duration":"174.277681ms","start":"2026-05-10T03:59:30.933863Z","end":"2026-05-10T03:59:31.108141Z","steps":["trace[2111212397] 'agreement among raft nodes before linearized reading' (duration: 174.097459ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:31.108195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.431753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-05-10T03:59:31.107844Z","caller":"traceutil/trace.go:171","msg":"trace[811903729] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"203.958183ms","start":"2026-05-10T03:59:30.903849Z","end":"2026-05-10T03:59:31.107807Z","steps":["trace[811903729] 'process raft request' (duration: 172.309738ms)","trace[811903729] 'compare' (duration: 31.333233ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:59:31.108282Z","caller":"traceutil/trace.go:171","msg":"trace[1011019976] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:343; }","duration":"111.529193ms","start":"2026-05-10T03:59:30.996729Z","end":"2026-05-10T03:59:31.108258Z","steps":["trace[1011019976] 'agreement among raft nodes before linearized reading' (duration: 111.364532ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:31.401335Z","caller":"traceutil/trace.go:171","msg":"trace[1349589310] linearizableReadLoop","detail":"{readStateIndex:359; appliedIndex:354; }","duration":"268.516598ms","start":"2026-05-10T03:59:31.132792Z","end":"2026-05-10T03:59:31.401308Z","steps":["trace[1349589310] 'read index received' (duration: 36.309968ms)","trace[1349589310] 'applied index is now lower than readState.Index' (duration: 232.20538ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:59:31.401413Z","caller":"traceutil/trace.go:171","msg":"trace[1314560658] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"281.184338ms","start":"2026-05-10T03:59:31.120205Z","end":"2026-05-10T03:59:31.401389Z","steps":["trace[1314560658] 'process raft request' (duration: 280.971266ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:31.401414Z","caller":"traceutil/trace.go:171","msg":"trace[695848725] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"280.639014ms","start":"2026-05-10T03:59:31.120744Z","end":"2026-05-10T03:59:31.401383Z","steps":["trace[695848725] 'process raft request' (duration: 280.490553ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:31.401628Z","caller":"traceutil/trace.go:171","msg":"trace[228121153] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"282.674138ms","start":"2026-05-10T03:59:31.118942Z","end":"2026-05-10T03:59:31.401616Z","steps":["trace[228121153] 'process raft request' (duration: 282.170133ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:31.40175Z","caller":"traceutil/trace.go:171","msg":"trace[599444868] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"279.145953ms","start":"2026-05-10T03:59:31.12255Z","end":"2026-05-10T03:59:31.401696Z","steps":["trace[599444868] 'process raft request' (duration: 278.72274ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:31.401771Z","caller":"traceutil/trace.go:171","msg":"trace[1358348742] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"282.816639ms","start":"2026-05-10T03:59:31.118864Z","end":"2026-05-10T03:59:31.40168Z","steps":["trace[1358348742] 'process raft request' (duration: 270.878953ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:31.401983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.167782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-05-10T03:59:31.402045Z","caller":"traceutil/trace.go:171","msg":"trace[2023930698] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:349; }","duration":"269.258292ms","start":"2026-05-10T03:59:31.132768Z","end":"2026-05-10T03:59:31.402027Z","steps":["trace[2023930698] 'agreement among raft nodes before linearized reading' (duration: 269.032691ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:31.406954Z","caller":"traceutil/trace.go:171","msg":"trace[1757553498] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"232.27975ms","start":"2026-05-10T03:59:31.174647Z","end":"2026-05-10T03:59:31.406926Z","steps":["trace[1757553498] 'process raft request' (duration: 232.159989ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:31.407246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.171949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-05-10T03:59:31.407758Z","caller":"traceutil/trace.go:171","msg":"trace[1515577280] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:350; }","duration":"174.716922ms","start":"2026-05-10T03:59:31.233027Z","end":"2026-05-10T03:59:31.407744Z","steps":["trace[1515577280] 'agreement among raft nodes before linearized reading' (duration: 174.165318ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:31.407315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.997342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-10T03:59:31.407924Z","caller":"traceutil/trace.go:171","msg":"trace[665574369] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:350; }","duration":"124.621236ms","start":"2026-05-10T03:59:31.283284Z","end":"2026-05-10T03:59:31.407905Z","steps":["trace[665574369] 'agreement among raft nodes before linearized reading' (duration: 123.997712ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:31.407356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.575225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-05-10T03:59:31.408045Z","caller":"traceutil/trace.go:171","msg":"trace[2077282784] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:350; }","duration":"225.26949ms","start":"2026-05-10T03:59:31.182757Z","end":"2026-05-10T03:59:31.408027Z","steps":["trace[2077282784] 'agreement among raft nodes before linearized reading' (duration: 224.579735ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:31.72221Z","caller":"traceutil/trace.go:171","msg":"trace[1330939713] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"174.4893ms","start":"2026-05-10T03:59:31.547687Z","end":"2026-05-10T03:59:31.722176Z","steps":["trace[1330939713] 'process raft request' (duration: 174.319698ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:31.72224Z","caller":"traceutil/trace.go:171","msg":"trace[1202683887] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"172.156943ms","start":"2026-05-10T03:59:31.550049Z","end":"2026-05-10T03:59:31.722206Z","steps":["trace[1202683887] 'process raft request' (duration: 172.110992ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:31.722391Z","caller":"traceutil/trace.go:171","msg":"trace[1765418111] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"175.081643ms","start":"2026-05-10T03:59:31.547181Z","end":"2026-05-10T03:59:31.722263Z","steps":["trace[1765418111] 'process raft request' (duration: 167.444629ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:31.722707Z","caller":"traceutil/trace.go:171","msg":"trace[1816889017] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"174.207467ms","start":"2026-05-10T03:59:31.548486Z","end":"2026-05-10T03:59:31.722694Z","steps":["trace[1816889017] 'process raft request' (duration: 173.579403ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:31.722779Z","caller":"traceutil/trace.go:171","msg":"trace[1428064380] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"173.834435ms","start":"2026-05-10T03:59:31.548919Z","end":"2026-05-10T03:59:31.722753Z","steps":["trace[1428064380] 'process raft request' (duration: 173.1974ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:33.81064Z","caller":"traceutil/trace.go:171","msg":"trace[1910182537] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"170.522249ms","start":"2026-05-10T03:59:33.640089Z","end":"2026-05-10T03:59:33.810611Z","steps":["trace[1910182537] 'process raft request' (duration: 170.346988ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:34.024465Z","caller":"traceutil/trace.go:171","msg":"trace[202468543] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"105.19761ms","start":"2026-05-10T03:59:33.919205Z","end":"2026-05-10T03:59:34.024402Z","steps":["trace[202468543] 'process raft request' (duration: 105.008058ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:34.653627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.036586ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-10T03:59:34.654133Z","caller":"traceutil/trace.go:171","msg":"trace[1259903629] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"616.037848ms","start":"2026-05-10T03:59:34.038079Z","end":"2026-05-10T03:59:34.654117Z","steps":["trace[1259903629] 'process raft request' (duration: 344.452909ms)","trace[1259903629] 'compare' (duration: 270.880924ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T03:59:34.654204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:34.038054Z","time spent":"616.109329ms","remote":"127.0.0.1:39994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6736,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T03:59:34.923091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.854445ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-10T03:59:34.923287Z","caller":"traceutil/trace.go:171","msg":"trace[1910097172] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"172.811308ms","start":"2026-05-10T03:59:34.750458Z","end":"2026-05-10T03:59:34.923269Z","steps":["trace[1910097172] 'process raft request' (duration: 172.748988ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:34.923437Z","caller":"traceutil/trace.go:171","msg":"trace[332415728] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"259.992378ms","start":"2026-05-10T03:59:34.663393Z","end":"2026-05-10T03:59:34.923385Z","steps":["trace[332415728] 'process raft request' (duration: 128.72453ms)","trace[332415728] 'compare' (duration: 130.721515ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:59:34.923546Z","caller":"traceutil/trace.go:171","msg":"trace[1555335349] linearizableReadLoop","detail":"{readStateIndex:411; appliedIndex:410; }","duration":"231.684001ms","start":"2026-05-10T03:59:34.691824Z","end":"2026-05-10T03:59:34.923508Z","steps":["trace[1555335349] 'read index received' (duration: 100.310102ms)","trace[1555335349] 'applied index is now lower than readState.Index' (duration: 131.370549ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T03:59:34.923948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.087174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-10T03:59:34.924134Z","caller":"traceutil/trace.go:171","msg":"trace[425901025] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:402; }","duration":"232.243535ms","start":"2026-05-10T03:59:34.691785Z","end":"2026-05-10T03:59:34.924028Z","steps":["trace[425901025] 'agreement among raft nodes before linearized reading' (duration: 231.891392ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:45.595554Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322102964465443292,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-10T03:59:45.903777Z","caller":"traceutil/trace.go:171","msg":"trace[1502765078] linearizableReadLoop","detail":"{readStateIndex:478; appliedIndex:477; }","duration":"809.184045ms","start":"2026-05-10T03:59:45.094571Z","end":"2026-05-10T03:59:45.903755Z","steps":["trace[1502765078] 'read index received' (duration: 808.991967ms)","trace[1502765078] 'applied index is now lower than readState.Index' (duration: 190.958µs)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:59:45.903851Z","caller":"traceutil/trace.go:171","msg":"trace[515878056] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"849.191991ms","start":"2026-05-10T03:59:45.054617Z","end":"2026-05-10T03:59:45.903809Z","steps":["trace[515878056] 'process raft request' (duration: 848.999214ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:45.903946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.94801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T03:59:45.903987Z","caller":"traceutil/trace.go:171","msg":"trace[2124346113] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:463; }","duration":"586.028314ms","start":"2026-05-10T03:59:45.317943Z","end":"2026-05-10T03:59:45.903971Z","steps":["trace[2124346113] 'agreement among raft nodes before linearized reading' (duration: 585.95627ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:45.904019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:45.31792Z","time spent":"586.091876ms","remote":"127.0.0.1:39824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-10T03:59:45.904046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:45.054576Z","time spent":"849.36968ms","remote":"127.0.0.1:40078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T03:59:45.904032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"809.427017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-10T03:59:45.904066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.938753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-10T03:59:45.904148Z","caller":"traceutil/trace.go:171","msg":"trace[1869240288] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:463; }","duration":"809.585023ms","start":"2026-05-10T03:59:45.094538Z","end":"2026-05-10T03:59:45.904123Z","steps":["trace[1869240288] 'agreement among raft nodes before linearized reading' (duration: 809.360183ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:45.904176Z","caller":"traceutil/trace.go:171","msg":"trace[1268785792] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:463; }","duration":"124.162002ms","start":"2026-05-10T03:59:45.779997Z","end":"2026-05-10T03:59:45.904159Z","steps":["trace[1268785792] 'agreement among raft nodes before linearized reading' (duration: 123.919761ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:45.904218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:45.094523Z","time spent":"809.669585ms","remote":"127.0.0.1:40078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-10T03:59:45.904245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.828278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-10T03:59:45.904276Z","caller":"traceutil/trace.go:171","msg":"trace[358418681] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:463; }","duration":"199.905221ms","start":"2026-05-10T03:59:45.704362Z","end":"2026-05-10T03:59:45.904267Z","steps":["trace[358418681] 'agreement among raft nodes before linearized reading' (duration: 199.846749ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:45.904581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.053271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-10T03:59:45.90464Z","caller":"traceutil/trace.go:171","msg":"trace[75321781] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:1; response_revision:463; }","duration":"238.162626ms","start":"2026-05-10T03:59:45.666461Z","end":"2026-05-10T03:59:45.904624Z","steps":["trace[75321781] 'agreement among raft nodes before linearized reading' (duration: 237.838263ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:46.319327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:45.905587Z","time spent":"413.734522ms","remote":"127.0.0.1:39840","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-10T03:59:46.343338Z","caller":"traceutil/trace.go:171","msg":"trace[1645494769] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"431.677719ms","start":"2026-05-10T03:59:45.911641Z","end":"2026-05-10T03:59:46.343319Z","steps":["trace[1645494769] 'process raft request' (duration: 431.501712ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:46.343459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:45.911623Z","time spent":"431.772893ms","remote":"127.0.0.1:40078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T03:59:46.343611Z","caller":"traceutil/trace.go:171","msg":"trace[777509334] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"431.876638ms","start":"2026-05-10T03:59:45.911727Z","end":"2026-05-10T03:59:46.343604Z","steps":["trace[777509334] 'process raft request' (duration: 431.536724ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:46.343663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:45.91172Z","time spent":"431.921279ms","remote":"127.0.0.1:40078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T03:59:46.343781Z","caller":"traceutil/trace.go:171","msg":"trace[1382915394] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"431.997893ms","start":"2026-05-10T03:59:45.911776Z","end":"2026-05-10T03:59:46.343774Z","steps":["trace[1382915394] 'process raft request' (duration: 431.802135ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:46.343819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:45.911769Z","time spent":"432.030304ms","remote":"127.0.0.1:40078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T03:59:56.127093Z","caller":"traceutil/trace.go:171","msg":"trace[1681984625] linearizableReadLoop","detail":"{readStateIndex:539; appliedIndex:538; }","duration":"103.145755ms","start":"2026-05-10T03:59:56.023923Z","end":"2026-05-10T03:59:56.127069Z","steps":["trace[1681984625] 'read index received' (duration: 102.987869ms)","trace[1681984625] 'applied index is now lower than readState.Index' (duration: 157.096µs)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:59:56.127132Z","caller":"traceutil/trace.go:171","msg":"trace[1495624368] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"150.429777ms","start":"2026-05-10T03:59:55.976683Z","end":"2026-05-10T03:59:56.127113Z","steps":["trace[1495624368] 'process raft request' (duration: 150.246961ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:56.127225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.271589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T03:59:56.127259Z","caller":"traceutil/trace.go:171","msg":"trace[2081344224] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:521; }","duration":"103.328311ms","start":"2026-05-10T03:59:56.02392Z","end":"2026-05-10T03:59:56.127248Z","steps":["trace[2081344224] 'agreement among raft nodes before linearized reading' (duration: 103.247468ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:57.762641Z","caller":"traceutil/trace.go:171","msg":"trace[1013059697] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"991.162513ms","start":"2026-05-10T03:59:56.771443Z","end":"2026-05-10T03:59:57.762605Z","steps":["trace[1013059697] 'process raft request' (duration: 989.998642ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:57.762823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:56.77142Z","time spent":"991.314199ms","remote":"127.0.0.1:39862","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80688,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T03:59:57.769252Z","caller":"traceutil/trace.go:171","msg":"trace[1930080631] transaction","detail":"{read_only:false; number_of_response:1; response_revision:575; }","duration":"964.025292ms","start":"2026-05-10T03:59:56.805194Z","end":"2026-05-10T03:59:57.769219Z","steps":["trace[1930080631] 'process raft request' (duration: 963.869727ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:57.769275Z","caller":"traceutil/trace.go:171","msg":"trace[488214257] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"966.954615ms","start":"2026-05-10T03:59:56.802284Z","end":"2026-05-10T03:59:57.769238Z","steps":["trace[488214257] 'process raft request' (duration: 966.574161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:57.769664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:56.802251Z","time spent":"967.317758ms","remote":"127.0.0.1:39862","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-10T03:59:57.769419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:56.805184Z","time spent":"964.151156ms","remote":"127.0.0.1:39862","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97,"response count":0,"response size":150531,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T04:00:04.298223Z","caller":"traceutil/trace.go:171","msg":"trace[997318249] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:653; }","duration":"259.999818ms","start":"2026-05-10T04:00:04.038193Z","end":"2026-05-10T04:00:04.298193Z","steps":["trace[997318249] 'read index received' (duration: 259.177921ms)","trace[997318249] 'applied index is now lower than readState.Index' (duration: 821.047µs)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:00:04.298325Z","caller":"traceutil/trace.go:171","msg":"trace[1828270463] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"383.596056ms","start":"2026-05-10T04:00:03.914694Z","end":"2026-05-10T04:00:04.29829Z","steps":["trace[1828270463] 'process raft request' (duration: 382.932234ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:00:04.298546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.339975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-10T04:00:04.298635Z","caller":"traceutil/trace.go:171","msg":"trace[989983712] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:633; }","duration":"134.537371ms","start":"2026-05-10T04:00:04.164047Z","end":"2026-05-10T04:00:04.298585Z","steps":["trace[989983712] 'agreement among raft nodes before linearized reading' (duration: 134.289363ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:00:04.29871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:00:03.914668Z","time spent":"383.869735ms","remote":"127.0.0.1:39898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T04:00:04.298745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.477664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-qrmbn\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-05-10T04:00:04.298895Z","caller":"traceutil/trace.go:171","msg":"trace[460825303] range","detail":"{range_begin:/registry/pods/kube-system/cilium-qrmbn; range_end:; response_count:1; response_revision:633; }","duration":"260.734792ms","start":"2026-05-10T04:00:04.038135Z","end":"2026-05-10T04:00:04.29887Z","steps":["trace[460825303] 'agreement among raft nodes before linearized reading' (duration: 260.188255ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:00:04.610226Z","caller":"traceutil/trace.go:171","msg":"trace[755676443] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:654; }","duration":"295.59369ms","start":"2026-05-10T04:00:04.314592Z","end":"2026-05-10T04:00:04.610185Z","steps":["trace[755676443] 'read index received' (duration: 19.824131ms)","trace[755676443] 'applied index is now lower than readState.Index' (duration: 275.767519ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:00:04.61026Z","caller":"traceutil/trace.go:171","msg":"trace[433235430] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"298.742722ms","start":"2026-05-10T04:00:04.311484Z","end":"2026-05-10T04:00:04.610226Z","steps":["trace[433235430] 'process raft request' (duration: 217.239596ms)","trace[433235430] 'compare' (duration: 81.036251ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:00:04.610527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.91ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T04:00:04.610574Z","caller":"traceutil/trace.go:171","msg":"trace[1955964615] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"295.989953ms","start":"2026-05-10T04:00:04.31457Z","end":"2026-05-10T04:00:04.61056Z","steps":["trace[1955964615] 'agreement among raft nodes before linearized reading' (duration: 295.768676ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:00:04.901948Z","caller":"traceutil/trace.go:171","msg":"trace[543562769] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:656; }","duration":"291.61215ms","start":"2026-05-10T04:00:04.61031Z","end":"2026-05-10T04:00:04.901922Z","steps":["trace[543562769] 'read index received' (duration: 273.555537ms)","trace[543562769] 'applied index is now lower than readState.Index' (duration: 18.055503ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:00:04.901998Z","caller":"traceutil/trace.go:171","msg":"trace[1169036880] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"542.361401ms","start":"2026-05-10T04:00:04.359578Z","end":"2026-05-10T04:00:04.901939Z","steps":["trace[1169036880] 'process raft request' (duration: 524.227675ms)","trace[1169036880] 'compare' (duration: 17.903218ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:00:04.902098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.53528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-10T04:00:04.902122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:00:04.359553Z","time spent":"542.511995ms","remote":"127.0.0.1:40046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-10T04:00:04.902157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.629535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-10T04:00:04.902094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.411288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-10T04:00:04.902177Z","caller":"traceutil/trace.go:171","msg":"trace[100259592] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:636; }","duration":"403.642634ms","start":"2026-05-10T04:00:04.498515Z","end":"2026-05-10T04:00:04.902158Z","steps":["trace[100259592] 'agreement among raft nodes before linearized reading' (duration: 403.459738ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:00:04.902193Z","caller":"traceutil/trace.go:171","msg":"trace[799911120] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:636; }","duration":"408.718268ms","start":"2026-05-10T04:00:04.493465Z","end":"2026-05-10T04:00:04.902183Z","steps":["trace[799911120] 'agreement among raft nodes before linearized reading' (duration: 408.549472ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:00:04.902208Z","caller":"traceutil/trace.go:171","msg":"trace[573937915] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:636; }","duration":"404.561943ms","start":"2026-05-10T04:00:04.497631Z","end":"2026-05-10T04:00:04.902193Z","steps":["trace[573937915] 'agreement among raft nodes before linearized reading' (duration: 404.385287ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:00:04.902222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:00:04.4985Z","time spent":"403.714756ms","remote":"127.0.0.1:40078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-10T04:00:04.902231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:00:04.493444Z","time spent":"408.77885ms","remote":"127.0.0.1:40078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-10T04:00:04.902241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:00:04.497614Z","time spent":"404.618975ms","remote":"127.0.0.1:40078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-10T04:00:05.818718Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322102964465443685,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-10T04:00:06.124616Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.126370484s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-10T04:00:07.14281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"770.26855ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T04:00:07.143289Z","caller":"traceutil/trace.go:171","msg":"trace[862812471] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:641; }","duration":"770.771836ms","start":"2026-05-10T04:00:06.372497Z","end":"2026-05-10T04:00:07.143269Z","steps":["trace[862812471] 'range keys from in-memory index tree' (duration: 770.24784ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:00:07.143933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.018572037s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-10T04:00:07.144262Z","caller":"traceutil/trace.go:171","msg":"trace[1892191060] linearizableReadLoop","detail":"{readStateIndex:665; appliedIndex:662; }","duration":"1.826635227s","start":"2026-05-10T04:00:05.317604Z","end":"2026-05-10T04:00:07.14424Z","steps":["trace[1892191060] 'read index received' (duration: 807.212532ms)","trace[1892191060] 'applied index is now lower than readState.Index' (duration: 1.019421445s)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:00:07.144477Z","caller":"traceutil/trace.go:171","msg":"trace[1238339867] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"2.156016829s","start":"2026-05-10T04:00:04.988447Z","end":"2026-05-10T04:00:07.144464Z","steps":["trace[1238339867] 'process raft request' (duration: 2.155672217s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:00:07.14456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:00:04.988432Z","time spent":"2.15608457s","remote":"127.0.0.1:39994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T04:00:07.144728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.827129572s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T04:00:07.144764Z","caller":"traceutil/trace.go:171","msg":"trace[1506594970] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:644; }","duration":"1.827199794s","start":"2026-05-10T04:00:05.317554Z","end":"2026-05-10T04:00:07.144754Z","steps":["trace[1506594970] 'agreement among raft nodes before linearized reading' (duration: 1.827142062s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:00:07.144792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:00:05.317529Z","time spent":"1.827257466s","remote":"127.0.0.1:39824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-10T04:00:07.1449Z","caller":"traceutil/trace.go:171","msg":"trace[1850461962] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"2.157179655s","start":"2026-05-10T04:00:04.987675Z","end":"2026-05-10T04:00:07.144855Z","steps":["trace[1850461962] 'process raft request' (duration: 1.137198973s)","trace[1850461962] 'compare' (duration: 1.018392412s)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:00:07.144989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.477156916s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-10T04:00:07.145021Z","caller":"traceutil/trace.go:171","msg":"trace[377956909] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:1; response_revision:644; }","duration":"1.477187827s","start":"2026-05-10T04:00:05.667824Z","end":"2026-05-10T04:00:07.145012Z","steps":["trace[377956909] 'agreement among raft nodes before linearized reading' (duration: 1.477131355s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:00:07.145056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:00:05.667759Z","time spent":"1.47729066s","remote":"127.0.0.1:39840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.57\" "} {"level":"warn","ts":"2026-05-10T04:00:07.1452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:00:04.987659Z","time spent":"2.15734428s","remote":"127.0.0.1:40046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T04:00:07.145243Z","caller":"traceutil/trace.go:171","msg":"trace[1296865896] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"2.157428623s","start":"2026-05-10T04:00:04.987784Z","end":"2026-05-10T04:00:07.145212Z","steps":["trace[1296865896] 'process raft request' (duration: 2.156255846s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:00:07.145366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.5638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-10T04:00:07.145403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:00:04.98776Z","time spent":"2.157569387s","remote":"127.0.0.1:39882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-10T04:00:07.145506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.980294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-10T04:00:07.14554Z","caller":"traceutil/trace.go:171","msg":"trace[1119651614] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:644; }","duration":"214.074677ms","start":"2026-05-10T04:00:06.931458Z","end":"2026-05-10T04:00:07.145532Z","steps":["trace[1119651614] 'agreement among raft nodes before linearized reading' (duration: 213.984054ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:00:07.145286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.55956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-10T04:00:07.145934Z","caller":"traceutil/trace.go:171","msg":"trace[941028647] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:644; }","duration":"207.22319ms","start":"2026-05-10T04:00:06.938692Z","end":"2026-05-10T04:00:07.145915Z","steps":["trace[941028647] 'agreement among raft nodes before linearized reading' (duration: 206.510388ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:00:07.145977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"751.234916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-10T04:00:07.146013Z","caller":"traceutil/trace.go:171","msg":"trace[774528397] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:644; }","duration":"751.308858ms","start":"2026-05-10T04:00:06.394695Z","end":"2026-05-10T04:00:07.146004Z","steps":["trace[774528397] 'agreement among raft nodes before linearized reading' (duration: 751.203365ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:00:07.14604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:00:06.394673Z","time spent":"751.36107ms","remote":"127.0.0.1:40078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-10T04:00:07.145414Z","caller":"traceutil/trace.go:171","msg":"trace[259275823] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:644; }","duration":"207.627683ms","start":"2026-05-10T04:00:06.937774Z","end":"2026-05-10T04:00:07.145402Z","steps":["trace[259275823] 'agreement among raft nodes before linearized reading' (duration: 207.53364ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:00:07.288082Z","caller":"traceutil/trace.go:171","msg":"trace[957874566] linearizableReadLoop","detail":"{readStateIndex:670; appliedIndex:666; }","duration":"132.177638ms","start":"2026-05-10T04:00:07.155882Z","end":"2026-05-10T04:00:07.28806Z","steps":["trace[957874566] 'read index received' (duration: 21.330287ms)","trace[957874566] 'applied index is now lower than readState.Index' (duration: 110.845551ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:00:07.288222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.322203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T04:00:07.288261Z","caller":"traceutil/trace.go:171","msg":"trace[653830953] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:648; }","duration":"132.397865ms","start":"2026-05-10T04:00:07.155853Z","end":"2026-05-10T04:00:07.288251Z","steps":["trace[653830953] 'agreement among raft nodes before linearized reading' (duration: 132.302022ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:00:07.288443Z","caller":"traceutil/trace.go:171","msg":"trace[1520890906] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"137.65887ms","start":"2026-05-10T04:00:07.150765Z","end":"2026-05-10T04:00:07.288424Z","steps":["trace[1520890906] 'process raft request' (duration: 137.224266ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:00:07.288513Z","caller":"traceutil/trace.go:171","msg":"trace[2145765515] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"137.308649ms","start":"2026-05-10T04:00:07.151182Z","end":"2026-05-10T04:00:07.288491Z","steps":["trace[2145765515] 'process raft request' (duration: 136.842544ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:00:07.288576Z","caller":"traceutil/trace.go:171","msg":"trace[35493356] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"137.780574ms","start":"2026-05-10T04:00:07.150716Z","end":"2026-05-10T04:00:07.288497Z","steps":["trace[35493356] 'process raft request' (duration: 137.226187ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:00:07.288913Z","caller":"traceutil/trace.go:171","msg":"trace[1798616226] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"138.627789ms","start":"2026-05-10T04:00:07.150267Z","end":"2026-05-10T04:00:07.288895Z","steps":["trace[1798616226] 'process raft request' (duration: 136.728769ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:00:07.290123Z","caller":"traceutil/trace.go:171","msg":"trace[968024468] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"111.856582ms","start":"2026-05-10T04:00:07.178256Z","end":"2026-05-10T04:00:07.290112Z","steps":["trace[968024468] 'process raft request' (duration: 111.79809ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:00:09.597508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.899213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-10T04:00:09.597586Z","caller":"traceutil/trace.go:171","msg":"trace[922740659] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:658; }","duration":"303.010976ms","start":"2026-05-10T04:00:09.294556Z","end":"2026-05-10T04:00:09.597567Z","steps":["trace[922740659] 'range keys from in-memory index tree' (duration: 302.757619ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:00:09.597634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:00:09.29455Z","time spent":"303.075669ms","remote":"127.0.0.1:40078","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-05-10T04:00:09.597683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.285845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-10T04:00:09.597729Z","caller":"traceutil/trace.go:171","msg":"trace[1415508813] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:658; }","duration":"303.384208ms","start":"2026-05-10T04:00:09.294334Z","end":"2026-05-10T04:00:09.597718Z","steps":["trace[1415508813] 'range keys from in-memory index tree' (duration: 303.088029ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:00:09.597752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:00:09.29431Z","time spent":"303.43749ms","remote":"127.0.0.1:40078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-10T04:00:09.597693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.253604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-10T04:00:09.597828Z","caller":"traceutil/trace.go:171","msg":"trace[621210114] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:658; }","duration":"303.46226ms","start":"2026-05-10T04:00:09.294326Z","end":"2026-05-10T04:00:09.597788Z","steps":["trace[621210114] 'range keys from in-memory index tree' (duration: 302.978376ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:00:09.597863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.480891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-10T04:00:09.597885Z","caller":"traceutil/trace.go:171","msg":"trace[943856500] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:658; }","duration":"303.544303ms","start":"2026-05-10T04:00:09.294334Z","end":"2026-05-10T04:00:09.597878Z","steps":["trace[943856500] 'range keys from in-memory index tree' (duration: 303.361697ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:00:09.597888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:00:09.294295Z","time spent":"303.580604ms","remote":"127.0.0.1:40078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-10T04:00:09.597898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:00:09.29431Z","time spent":"303.584664ms","remote":"127.0.0.1:40078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-10T04:00:23.818271Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322102964465443996,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-10T04:00:24.319545Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322102964465443996,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-10T04:00:24.459887Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.294396893s","expected-duration":"1s"} {"level":"info","ts":"2026-05-10T04:00:24.460327Z","caller":"traceutil/trace.go:171","msg":"trace[1185603025] linearizableReadLoop","detail":"{readStateIndex:827; appliedIndex:826; }","duration":"1.14298446s","start":"2026-05-10T04:00:23.317319Z","end":"2026-05-10T04:00:24.460303Z","steps":["trace[1185603025] 'read index received' (duration: 1.142851217s)","trace[1185603025] 'applied index is now lower than readState.Index' (duration: 132.223µs)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:00:24.460483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.143143855s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T04:00:24.460524Z","caller":"traceutil/trace.go:171","msg":"trace[650758293] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:801; }","duration":"1.143246368s","start":"2026-05-10T04:00:23.317268Z","end":"2026-05-10T04:00:24.460514Z","steps":["trace[650758293] 'agreement among raft nodes before linearized reading' (duration: 1.143154515s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:00:24.460565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:00:23.317246Z","time spent":"1.143311839s","remote":"127.0.0.1:39824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-10T04:00:24.460467Z","caller":"traceutil/trace.go:171","msg":"trace[717043061] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"1.295086063s","start":"2026-05-10T04:00:23.165287Z","end":"2026-05-10T04:00:24.460373Z","steps":["trace[717043061] 'process raft request' (duration: 1.294854627s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:00:24.460767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:00:23.16525Z","time spent":"1.295405971s","remote":"127.0.0.1:39994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T04:00:24.461772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"784.829444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-10T04:00:24.461814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.075448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-10T04:00:24.461848Z","caller":"traceutil/trace.go:171","msg":"trace[417368618] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:802; }","duration":"784.942937ms","start":"2026-05-10T04:00:23.676886Z","end":"2026-05-10T04:00:24.461829Z","steps":["trace[417368618] 'agreement among raft nodes before linearized reading' (duration: 784.735171ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:00:24.461879Z","caller":"traceutil/trace.go:171","msg":"trace[226261797] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:802; }","duration":"432.19039ms","start":"2026-05-10T04:00:24.029672Z","end":"2026-05-10T04:00:24.461862Z","steps":["trace[226261797] 'agreement among raft nodes before linearized reading' (duration: 431.998075ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:00:24.461906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:00:23.676853Z","time spent":"785.037119ms","remote":"127.0.0.1:40078","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-05-10T04:00:24.461918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:00:24.029639Z","time spent":"432.271093ms","remote":"127.0.0.1:40078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-10T04:00:24.462183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"758.442941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-10T04:00:24.462247Z","caller":"traceutil/trace.go:171","msg":"trace[1800940014] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:802; }","duration":"758.524594ms","start":"2026-05-10T04:00:23.703695Z","end":"2026-05-10T04:00:24.462219Z","steps":["trace[1800940014] 'agreement among raft nodes before linearized reading' (duration: 758.403901ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:00:24.462282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:00:23.70367Z","time spent":"758.605056ms","remote":"127.0.0.1:40078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-10T04:00:24.462561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"752.453874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-10T04:00:24.46259Z","caller":"traceutil/trace.go:171","msg":"trace[28882815] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:802; }","duration":"752.503875ms","start":"2026-05-10T04:00:23.710078Z","end":"2026-05-10T04:00:24.462582Z","steps":["trace[28882815] 'agreement among raft nodes before linearized reading' (duration: 752.430983ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:00:24.462615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:00:23.710067Z","time spent":"752.542667ms","remote":"127.0.0.1:40078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-10T04:00:24.462906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"753.685426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-10T04:00:24.462974Z","caller":"traceutil/trace.go:171","msg":"trace[899182701] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:802; }","duration":"753.766139ms","start":"2026-05-10T04:00:23.709192Z","end":"2026-05-10T04:00:24.462958Z","steps":["trace[899182701] 'agreement among raft nodes before linearized reading' (duration: 752.896275ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:00:24.463007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:00:23.709186Z","time spent":"753.8131ms","remote":"127.0.0.1:40078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-10T04:02:09.492108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.938434ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-10T04:02:09.492291Z","caller":"traceutil/trace.go:171","msg":"trace[1216153390] linearizableReadLoop","detail":"{readStateIndex:1362; appliedIndex:1361; }","duration":"175.247063ms","start":"2026-05-10T04:02:09.317023Z","end":"2026-05-10T04:02:09.492271Z","steps":["trace[1216153390] 'read index received' (duration: 81.901µs)","trace[1216153390] 'applied index is now lower than readState.Index' (duration: 175.163652ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:02:09.492372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.360405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T04:02:09.4924Z","caller":"traceutil/trace.go:171","msg":"trace[1505235389] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1312; }","duration":"175.425266ms","start":"2026-05-10T04:02:09.316965Z","end":"2026-05-10T04:02:09.49239Z","steps":["trace[1505235389] 'agreement among raft nodes before linearized reading' (duration: 175.370555ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:02:09.492371Z","caller":"traceutil/trace.go:171","msg":"trace[139990440] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"409.502211ms","start":"2026-05-10T04:02:09.082832Z","end":"2026-05-10T04:02:09.492335Z","steps":["trace[139990440] 'process raft request' (duration: 80.232853ms)","trace[139990440] 'compare' (duration: 328.751782ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:02:09.492708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:02:09.082811Z","time spent":"409.732685ms","remote":"127.0.0.1:40078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T04:02:53.625434Z","caller":"traceutil/trace.go:171","msg":"trace[2038585966] transaction","detail":"{read_only:false; response_revision:1467; number_of_response:1; }","duration":"145.289563ms","start":"2026-05-10T04:02:53.480105Z","end":"2026-05-10T04:02:53.625395Z","steps":["trace[2038585966] 'process raft request' (duration: 144.504904ms)"],"step_count":1}