{"level":"warn","ts":"2026-04-15T12:12:07.063214Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-15T12:12:07.063352Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.11: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.19.213.11:2380","--initial-cluster=instance=https://199.19.213.11:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.11:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.11:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-15T12:12:07.063426Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-15T12:12:07.063437Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.11:2380"]} {"level":"info","ts":"2026-04-15T12:12:07.063456Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-15T12:12:07.064093Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.11:2379"]} {"level":"info","ts":"2026-04-15T12:12:07.064169Z","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.19.213.11:2380"],"listen-peer-urls":["https://199.19.213.11:2380"],"advertise-client-urls":["https://199.19.213.11:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.11:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.11:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-15T12:12:07.093403Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"25.153198ms"} {"level":"info","ts":"2026-04-15T12:12:07.438484Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ce8ad90e35537ee3","cluster-id":"3c17b62c6529d987"} {"level":"info","ts":"2026-04-15T12:12:07.438619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 switched to configuration voters=()"} {"level":"info","ts":"2026-04-15T12:12:07.438673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 became follower at term 0"} {"level":"info","ts":"2026-04-15T12:12:07.438689Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ce8ad90e35537ee3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-15T12:12:07.438699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 became follower at term 1"} {"level":"info","ts":"2026-04-15T12:12:07.438769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 switched to configuration voters=(14882946573646659299)"} {"level":"warn","ts":"2026-04-15T12:12:07.576832Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-15T12:12:07.660799Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-15T12:12:07.722686Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-15T12:12:07.814897Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ce8ad90e35537ee3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-15T12:12:07.815622Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ce8ad90e35537ee3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-15T12:12:07.816295Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-15T12:12:07.81642Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-15T12:12:07.816444Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-15T12:12:07.8204Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-15T12:12:07.820448Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.11:2380"} {"level":"info","ts":"2026-04-15T12:12:07.820529Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.11:2380"} {"level":"info","ts":"2026-04-15T12:12:07.820796Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-15T12:12:07.820743Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ce8ad90e35537ee3","initial-advertise-peer-urls":["https://199.19.213.11:2380"],"listen-peer-urls":["https://199.19.213.11:2380"],"advertise-client-urls":["https://199.19.213.11:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.11:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-15T12:12:07.872248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 switched to configuration voters=(14882946573646659299)"} {"level":"info","ts":"2026-04-15T12:12:07.872636Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3c17b62c6529d987","local-member-id":"ce8ad90e35537ee3","added-peer-id":"ce8ad90e35537ee3","added-peer-peer-urls":["https://199.19.213.11:2380"]} {"level":"info","ts":"2026-04-15T12:12:08.763687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 is starting a new election at term 1"} {"level":"info","ts":"2026-04-15T12:12:08.763754Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-15T12:12:08.76381Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 received MsgPreVoteResp from ce8ad90e35537ee3 at term 1"} {"level":"info","ts":"2026-04-15T12:12:08.763846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 became candidate at term 2"} {"level":"info","ts":"2026-04-15T12:12:08.763856Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 received MsgVoteResp from ce8ad90e35537ee3 at term 2"} {"level":"info","ts":"2026-04-15T12:12:08.763871Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 became leader at term 2"} {"level":"info","ts":"2026-04-15T12:12:08.763884Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ce8ad90e35537ee3 elected leader ce8ad90e35537ee3 at term 2"} {"level":"info","ts":"2026-04-15T12:12:08.767567Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ce8ad90e35537ee3","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.11:2379]}","request-path":"/0/members/ce8ad90e35537ee3/attributes","cluster-id":"3c17b62c6529d987","publish-timeout":"7s"} {"level":"info","ts":"2026-04-15T12:12:08.767598Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-15T12:12:08.767637Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-15T12:12:08.767796Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T12:12:08.767894Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-15T12:12:08.767977Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-15T12:12:08.768967Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3c17b62c6529d987","local-member-id":"ce8ad90e35537ee3","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T12:12:08.769078Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T12:12:08.769115Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T12:12:08.772683Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-15T12:12:08.772993Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.11:2379"} {"level":"info","ts":"2026-04-15T12:12:10.512921Z","caller":"traceutil/trace.go:171","msg":"trace[181781461] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"198.009337ms","start":"2026-04-15T12:12:10.314876Z","end":"2026-04-15T12:12:10.512885Z","steps":["trace[181781461] 'process raft request' (duration: 180.283167ms)","trace[181781461] 'compare' (duration: 17.330347ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T12:12:10.513122Z","caller":"traceutil/trace.go:171","msg":"trace[2130856438] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"197.24255ms","start":"2026-04-15T12:12:10.315842Z","end":"2026-04-15T12:12:10.513085Z","steps":["trace[2130856438] 'process raft request' (duration: 197.036388ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:12:10.513134Z","caller":"traceutil/trace.go:171","msg":"trace[661192979] transaction","detail":"{read_only:false; number_of_response:0; response_revision:13; }","duration":"197.949367ms","start":"2026-04-15T12:12:10.315113Z","end":"2026-04-15T12:12:10.513062Z","steps":["trace[661192979] 'process raft request' (duration: 197.662824ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:12:10.513383Z","caller":"traceutil/trace.go:171","msg":"trace[815752441] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"197.719955ms","start":"2026-04-15T12:12:10.315652Z","end":"2026-04-15T12:12:10.513372Z","steps":["trace[815752441] 'process raft request' (duration: 197.15876ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:12:10.513457Z","caller":"traceutil/trace.go:171","msg":"trace[670778791] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"196.893037ms","start":"2026-04-15T12:12:10.316555Z","end":"2026-04-15T12:12:10.513448Z","steps":["trace[670778791] 'process raft request' (duration: 196.352382ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:12:10.513533Z","caller":"traceutil/trace.go:171","msg":"trace[219243043] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"196.889478ms","start":"2026-04-15T12:12:10.316627Z","end":"2026-04-15T12:12:10.513517Z","steps":["trace[219243043] 'process raft request' (duration: 196.311942ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:12:10.513547Z","caller":"traceutil/trace.go:171","msg":"trace[331763351] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"195.828197ms","start":"2026-04-15T12:12:10.31767Z","end":"2026-04-15T12:12:10.513498Z","steps":["trace[331763351] 'process raft request' (duration: 195.303231ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:12:10.513694Z","caller":"traceutil/trace.go:171","msg":"trace[1401283913] linearizableReadLoop","detail":"{readStateIndex:23; appliedIndex:15; }","duration":"164.863849ms","start":"2026-04-15T12:12:10.34881Z","end":"2026-04-15T12:12:10.513674Z","steps":["trace[1401283913] 'read index received' (duration: 146.35924ms)","trace[1401283913] 'applied index is now lower than readState.Index' (duration: 18.502509ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T12:12:10.513843Z","caller":"traceutil/trace.go:171","msg":"trace[332126994] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"193.527026ms","start":"2026-04-15T12:12:10.320177Z","end":"2026-04-15T12:12:10.513704Z","steps":["trace[332126994] 'process raft request' (duration: 193.139061ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:10.514223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.327266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-04-15T12:12:10.514266Z","caller":"traceutil/trace.go:171","msg":"trace[1312199484] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"104.518928ms","start":"2026-04-15T12:12:10.409737Z","end":"2026-04-15T12:12:10.514255Z","steps":["trace[1312199484] 'agreement among raft nodes before linearized reading' (duration: 104.295196ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:10.514293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.85106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-04-15T12:12:10.514278Z","caller":"traceutil/trace.go:171","msg":"trace[1735224961] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"161.484086ms","start":"2026-04-15T12:12:10.352754Z","end":"2026-04-15T12:12:10.514238Z","steps":["trace[1735224961] 'process raft request' (duration: 160.79808ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:12:10.514388Z","caller":"traceutil/trace.go:171","msg":"trace[1163887098] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"189.94674ms","start":"2026-04-15T12:12:10.324423Z","end":"2026-04-15T12:12:10.51437Z","steps":["trace[1163887098] 'agreement among raft nodes before linearized reading' (duration: 189.364915ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:10.514199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.976877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-15T12:12:10.514537Z","caller":"traceutil/trace.go:171","msg":"trace[1606535901] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:20; }","duration":"201.398681ms","start":"2026-04-15T12:12:10.313128Z","end":"2026-04-15T12:12:10.514527Z","steps":["trace[1606535901] 'agreement among raft nodes before linearized reading' (duration: 200.683704ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:10.514997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.381731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3490"} {"level":"info","ts":"2026-04-15T12:12:10.515059Z","caller":"traceutil/trace.go:171","msg":"trace[1496152460] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:20; }","duration":"200.465823ms","start":"2026-04-15T12:12:10.314573Z","end":"2026-04-15T12:12:10.515039Z","steps":["trace[1496152460] 'agreement among raft nodes before linearized reading' (duration: 199.254501ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:10.514357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.083178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-frqz9\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-04-15T12:12:10.515229Z","caller":"traceutil/trace.go:171","msg":"trace[321184285] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-frqz9; range_end:; response_count:1; response_revision:20; }","duration":"201.972476ms","start":"2026-04-15T12:12:10.313227Z","end":"2026-04-15T12:12:10.515199Z","steps":["trace[321184285] 'agreement among raft nodes before linearized reading' (duration: 200.611773ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:12:10.707869Z","caller":"traceutil/trace.go:171","msg":"trace[1371505896] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"187.693549ms","start":"2026-04-15T12:12:10.520139Z","end":"2026-04-15T12:12:10.707833Z","steps":["trace[1371505896] 'process raft request' (duration: 100.587179ms)","trace[1371505896] 'compare' (duration: 86.938178ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T12:12:10.708829Z","caller":"traceutil/trace.go:171","msg":"trace[1212209278] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"188.185723ms","start":"2026-04-15T12:12:10.5206Z","end":"2026-04-15T12:12:10.708786Z","steps":["trace[1212209278] 'process raft request' (duration: 187.976921ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:12:10.70895Z","caller":"traceutil/trace.go:171","msg":"trace[1522606386] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"188.081413ms","start":"2026-04-15T12:12:10.520823Z","end":"2026-04-15T12:12:10.708905Z","steps":["trace[1522606386] 'process raft request' (duration: 187.923631ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:12:10.709043Z","caller":"traceutil/trace.go:171","msg":"trace[1102589317] linearizableReadLoop","detail":"{readStateIndex:35; appliedIndex:24; }","duration":"184.285565ms","start":"2026-04-15T12:12:10.524725Z","end":"2026-04-15T12:12:10.70901Z","steps":["trace[1102589317] 'read index received' (duration: 96.153866ms)","trace[1102589317] 'applied index is now lower than readState.Index' (duration: 88.130359ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T12:12:10.7092Z","caller":"traceutil/trace.go:171","msg":"trace[1842562237] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"188.193313ms","start":"2026-04-15T12:12:10.520998Z","end":"2026-04-15T12:12:10.709192Z","steps":["trace[1842562237] 'process raft request' (duration: 187.786749ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:12:10.70925Z","caller":"traceutil/trace.go:171","msg":"trace[1193176279] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"187.148543ms","start":"2026-04-15T12:12:10.522089Z","end":"2026-04-15T12:12:10.709238Z","steps":["trace[1193176279] 'process raft request' (duration: 186.801859ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:12:10.709502Z","caller":"traceutil/trace.go:171","msg":"trace[1484443066] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"187.203863ms","start":"2026-04-15T12:12:10.522286Z","end":"2026-04-15T12:12:10.70949Z","steps":["trace[1484443066] 'process raft request' (duration: 186.633418ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:12:10.709528Z","caller":"traceutil/trace.go:171","msg":"trace[543599163] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"188.134313ms","start":"2026-04-15T12:12:10.521381Z","end":"2026-04-15T12:12:10.709516Z","steps":["trace[543599163] 'process raft request' (duration: 187.430587ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:12:10.709683Z","caller":"traceutil/trace.go:171","msg":"trace[1427780901] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"187.331166ms","start":"2026-04-15T12:12:10.522341Z","end":"2026-04-15T12:12:10.709672Z","steps":["trace[1427780901] 'process raft request' (duration: 186.607068ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:10.709808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.624468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-15T12:12:10.709871Z","caller":"traceutil/trace.go:171","msg":"trace[1147467832] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:31; }","duration":"134.746609ms","start":"2026-04-15T12:12:10.575107Z","end":"2026-04-15T12:12:10.709854Z","steps":["trace[1147467832] 'agreement among raft nodes before linearized reading' (duration: 134.588248ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:12:10.710127Z","caller":"traceutil/trace.go:171","msg":"trace[1972171843] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"187.407406ms","start":"2026-04-15T12:12:10.522697Z","end":"2026-04-15T12:12:10.710105Z","steps":["trace[1972171843] 'process raft request' (duration: 186.277624ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:12:10.709147Z","caller":"traceutil/trace.go:171","msg":"trace[1459499823] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"187.565807ms","start":"2026-04-15T12:12:10.5215Z","end":"2026-04-15T12:12:10.709065Z","steps":["trace[1459499823] 'process raft request' (duration: 187.360845ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:12:10.710271Z","caller":"traceutil/trace.go:171","msg":"trace[1587274806] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"189.423566ms","start":"2026-04-15T12:12:10.520819Z","end":"2026-04-15T12:12:10.710243Z","steps":["trace[1587274806] 'process raft request' (duration: 187.891021ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:10.71035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.591439ms","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":"warn","ts":"2026-04-15T12:12:10.710337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.465438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-15T12:12:10.710411Z","caller":"traceutil/trace.go:171","msg":"trace[2119538760] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:31; }","duration":"185.686149ms","start":"2026-04-15T12:12:10.524707Z","end":"2026-04-15T12:12:10.710393Z","steps":["trace[2119538760] 'agreement among raft nodes before linearized reading' (duration: 185.571468ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:12:10.710424Z","caller":"traceutil/trace.go:171","msg":"trace[606524743] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:31; }","duration":"131.548868ms","start":"2026-04-15T12:12:10.578858Z","end":"2026-04-15T12:12:10.710407Z","steps":["trace[606524743] 'agreement among raft nodes before linearized reading' (duration: 131.446098ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:12:11.558084Z","caller":"traceutil/trace.go:171","msg":"trace[1845260292] transaction","detail":"{read_only:false; response_revision:146; number_of_response:1; }","duration":"109.222105ms","start":"2026-04-15T12:12:11.44883Z","end":"2026-04-15T12:12:11.558052Z","steps":["trace[1845260292] 'process raft request' (duration: 43.87557ms)","trace[1845260292] 'compare' (duration: 65.163343ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T12:12:12.197322Z","caller":"traceutil/trace.go:171","msg":"trace[1661234242] transaction","detail":"{read_only:false; response_revision:167; number_of_response:1; }","duration":"152.866533ms","start":"2026-04-15T12:12:12.044414Z","end":"2026-04-15T12:12:12.19728Z","steps":["trace[1661234242] 'process raft request' (duration: 98.501186ms)","trace[1661234242] 'compare' (duration: 54.043093ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T12:12:12.670384Z","caller":"traceutil/trace.go:171","msg":"trace[923444382] transaction","detail":"{read_only:false; response_revision:183; number_of_response:1; }","duration":"177.477196ms","start":"2026-04-15T12:12:12.492876Z","end":"2026-04-15T12:12:12.670353Z","steps":["trace[923444382] 'process raft request' (duration: 97.780579ms)","trace[923444382] 'compare' (duration: 79.557586ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T12:12:24.795619Z","caller":"traceutil/trace.go:171","msg":"trace[2003902199] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"197.061797ms","start":"2026-04-15T12:12:24.598526Z","end":"2026-04-15T12:12:24.795588Z","steps":["trace[2003902199] 'process raft request' (duration: 196.881025ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:12:30.86468Z","caller":"traceutil/trace.go:171","msg":"trace[1603167467] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"746.639315ms","start":"2026-04-15T12:12:30.118011Z","end":"2026-04-15T12:12:30.864651Z","steps":["trace[1603167467] 'process raft request' (duration: 746.421323ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:30.865439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:30.117995Z","time spent":"746.779566ms","remote":"127.0.0.1:40138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T12:12:31.15599Z","caller":"traceutil/trace.go:171","msg":"trace[1972018995] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"283.979902ms","start":"2026-04-15T12:12:30.871983Z","end":"2026-04-15T12:12:31.155963Z","steps":["trace[1972018995] 'process raft request' (duration: 283.68809ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:12:31.156102Z","caller":"traceutil/trace.go:171","msg":"trace[1827115311] linearizableReadLoop","detail":"{readStateIndex:466; appliedIndex:464; }","duration":"133.930348ms","start":"2026-04-15T12:12:31.022144Z","end":"2026-04-15T12:12:31.156075Z","steps":["trace[1827115311] 'read index received' (duration: 101.661792ms)","trace[1827115311] 'applied index is now lower than readState.Index' (duration: 32.267416ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T12:12:31.156296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.123581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-15T12:12:31.156353Z","caller":"traceutil/trace.go:171","msg":"trace[672513997] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:453; }","duration":"134.255361ms","start":"2026-04-15T12:12:31.022081Z","end":"2026-04-15T12:12:31.156337Z","steps":["trace[672513997] 'agreement among raft nodes before linearized reading' (duration: 134.14305ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:12:31.15604Z","caller":"traceutil/trace.go:171","msg":"trace[1508961040] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"285.734387ms","start":"2026-04-15T12:12:30.870259Z","end":"2026-04-15T12:12:31.155994Z","steps":["trace[1508961040] 'process raft request' (duration: 253.524482ms)","trace[1508961040] 'compare' (duration: 31.55987ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T12:12:43.469056Z","caller":"traceutil/trace.go:171","msg":"trace[445244378] linearizableReadLoop","detail":"{readStateIndex:529; appliedIndex:528; }","duration":"257.589624ms","start":"2026-04-15T12:12:43.211432Z","end":"2026-04-15T12:12:43.469022Z","steps":["trace[445244378] 'read index received' (duration: 257.387135ms)","trace[445244378] 'applied index is now lower than readState.Index' (duration: 200.449µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T12:12:43.469504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.038434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-15T12:12:43.469804Z","caller":"traceutil/trace.go:171","msg":"trace[177465222] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:512; }","duration":"258.41583ms","start":"2026-04-15T12:12:43.211368Z","end":"2026-04-15T12:12:43.469784Z","steps":["trace[177465222] 'agreement among raft nodes before linearized reading' (duration: 257.933089ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:43.969799Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9143324914828159879,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-15T12:12:44.179467Z","caller":"traceutil/trace.go:171","msg":"trace[532785502] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"880.334209ms","start":"2026-04-15T12:12:43.2991Z","end":"2026-04-15T12:12:44.179434Z","steps":["trace[532785502] 'process raft request' (duration: 879.987714ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:12:44.179603Z","caller":"traceutil/trace.go:171","msg":"trace[1994231934] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"880.393332ms","start":"2026-04-15T12:12:43.299183Z","end":"2026-04-15T12:12:44.179576Z","steps":["trace[1994231934] 'process raft request' (duration: 880.142241ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:44.179624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:43.299072Z","time spent":"880.476625ms","remote":"127.0.0.1:39886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T12:12:44.179695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:43.299145Z","time spent":"880.507017ms","remote":"127.0.0.1:39886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T12:12:44.180892Z","caller":"traceutil/trace.go:171","msg":"trace[1870239753] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"869.266777ms","start":"2026-04-15T12:12:43.311554Z","end":"2026-04-15T12:12:44.18082Z","steps":["trace[1870239753] 'process raft request' (duration: 868.821758ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:12:44.180925Z","caller":"traceutil/trace.go:171","msg":"trace[490212753] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"862.580688ms","start":"2026-04-15T12:12:43.318296Z","end":"2026-04-15T12:12:44.180877Z","steps":["trace[490212753] 'process raft request' (duration: 862.133529ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:12:44.180997Z","caller":"traceutil/trace.go:171","msg":"trace[1628872384] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"854.677896ms","start":"2026-04-15T12:12:43.326309Z","end":"2026-04-15T12:12:44.180987Z","steps":["trace[1628872384] 'process raft request' (duration: 854.31169ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:44.181078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:43.326285Z","time spent":"854.746739ms","remote":"127.0.0.1:39886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T12:12:44.181119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:43.318268Z","time spent":"862.749857ms","remote":"127.0.0.1:39886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T12:12:44.181133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:43.311524Z","time spent":"869.494457ms","remote":"127.0.0.1:39886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T12:12:44.181321Z","caller":"traceutil/trace.go:171","msg":"trace[703078003] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"846.799406ms","start":"2026-04-15T12:12:43.334512Z","end":"2026-04-15T12:12:44.181311Z","steps":["trace[703078003] 'process raft request' (duration: 846.162799ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:44.181373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:43.334485Z","time spent":"846.863519ms","remote":"127.0.0.1:39886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T12:12:44.180937Z","caller":"traceutil/trace.go:171","msg":"trace[1096189300] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"861.783123ms","start":"2026-04-15T12:12:43.319132Z","end":"2026-04-15T12:12:44.180915Z","steps":["trace[1096189300] 'process raft request' (duration: 861.412687ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:44.181462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:43.319105Z","time spent":"862.340218ms","remote":"127.0.0.1:39886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T12:12:44.181463Z","caller":"traceutil/trace.go:171","msg":"trace[1765983795] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"882.106278ms","start":"2026-04-15T12:12:43.299334Z","end":"2026-04-15T12:12:44.18144Z","steps":["trace[1765983795] 'process raft request' (duration: 880.511167ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:44.181538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:43.2993Z","time spent":"882.202032ms","remote":"127.0.0.1:39886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T12:12:44.18202Z","caller":"traceutil/trace.go:171","msg":"trace[1975834515] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"835.529014ms","start":"2026-04-15T12:12:43.346476Z","end":"2026-04-15T12:12:44.182005Z","steps":["trace[1975834515] 'process raft request' (duration: 834.258208ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:44.182086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:43.346452Z","time spent":"835.604157ms","remote":"127.0.0.1:39886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T12:12:44.182473Z","caller":"traceutil/trace.go:171","msg":"trace[224625258] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"798.707635ms","start":"2026-04-15T12:12:43.383749Z","end":"2026-04-15T12:12:44.182457Z","steps":["trace[224625258] 'process raft request' (duration: 798.622162ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:44.182556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:43.383712Z","time spent":"798.805449ms","remote":"127.0.0.1:39886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T12:12:44.182562Z","caller":"traceutil/trace.go:171","msg":"trace[1349101904] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"825.588121ms","start":"2026-04-15T12:12:43.356939Z","end":"2026-04-15T12:12:44.182527Z","steps":["trace[1349101904] 'process raft request' (duration: 825.259077ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:44.182719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:43.356914Z","time spent":"825.726557ms","remote":"127.0.0.1:39886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T12:12:44.199795Z","caller":"traceutil/trace.go:171","msg":"trace[2057337830] linearizableReadLoop","detail":"{readStateIndex:543; appliedIndex:529; }","duration":"730.083562ms","start":"2026-04-15T12:12:43.469685Z","end":"2026-04-15T12:12:44.199769Z","steps":["trace[2057337830] 'read index received' (duration: 709.463165ms)","trace[2057337830] 'applied index is now lower than readState.Index' (duration: 20.618567ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T12:12:44.199915Z","caller":"traceutil/trace.go:171","msg":"trace[1246298660] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"728.198989ms","start":"2026-04-15T12:12:43.471701Z","end":"2026-04-15T12:12:44.1999Z","steps":["trace[1246298660] 'process raft request' (duration: 727.690915ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:44.200029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:43.471673Z","time spent":"728.266781ms","remote":"127.0.0.1:39872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T12:12:44.200385Z","caller":"traceutil/trace.go:171","msg":"trace[1818193146] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"723.802163ms","start":"2026-04-15T12:12:43.476571Z","end":"2026-04-15T12:12:44.200374Z","steps":["trace[1818193146] 'process raft request' (duration: 722.956415ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:44.200453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:43.47656Z","time spent":"723.855315ms","remote":"127.0.0.1:40138","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-04-15T12:12:44.200789Z","caller":"traceutil/trace.go:171","msg":"trace[1142085915] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"715.412649ms","start":"2026-04-15T12:12:43.485365Z","end":"2026-04-15T12:12:44.200778Z","steps":["trace[1142085915] 'process raft request' (duration: 714.31268ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:44.200844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:43.48534Z","time spent":"715.474373ms","remote":"127.0.0.1:39886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T12:12:44.201009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"983.601305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-15T12:12:44.201053Z","caller":"traceutil/trace.go:171","msg":"trace[262460885] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:526; }","duration":"983.695419ms","start":"2026-04-15T12:12:43.217347Z","end":"2026-04-15T12:12:44.201042Z","steps":["trace[262460885] 'agreement among raft nodes before linearized reading' (duration: 983.620205ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:44.201085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:43.217313Z","time spent":"983.764202ms","remote":"127.0.0.1:40138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-15T12:12:44.201234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"986.230862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-15T12:12:44.20127Z","caller":"traceutil/trace.go:171","msg":"trace[378953213] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:526; }","duration":"986.325235ms","start":"2026-04-15T12:12:43.214936Z","end":"2026-04-15T12:12:44.201261Z","steps":["trace[378953213] 'agreement among raft nodes before linearized reading' (duration: 986.266663ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:44.201303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:43.2149Z","time spent":"986.396839ms","remote":"127.0.0.1:40138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-15T12:12:44.216862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.499828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T12:12:44.216946Z","caller":"traceutil/trace.go:171","msg":"trace[1631320081] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:532; }","duration":"104.645905ms","start":"2026-04-15T12:12:44.112281Z","end":"2026-04-15T12:12:44.216927Z","steps":["trace[1631320081] 'agreement among raft nodes before linearized reading' (duration: 104.493198ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:51.175323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.286837ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-15T12:12:51.175442Z","caller":"traceutil/trace.go:171","msg":"trace[385156229] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:646; }","duration":"107.263591ms","start":"2026-04-15T12:12:51.068161Z","end":"2026-04-15T12:12:51.175425Z","steps":["trace[385156229] 'read index received' (duration: 84.373µs)","trace[385156229] 'applied index is now lower than readState.Index' (duration: 107.177888ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T12:12:51.175701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.543524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-15T12:12:51.175757Z","caller":"traceutil/trace.go:171","msg":"trace[1595768255] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:623; }","duration":"107.639098ms","start":"2026-04-15T12:12:51.068107Z","end":"2026-04-15T12:12:51.175746Z","steps":["trace[1595768255] 'agreement among raft nodes before linearized reading' (duration: 107.365117ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:12:51.175729Z","caller":"traceutil/trace.go:171","msg":"trace[502150392] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"561.4983ms","start":"2026-04-15T12:12:50.614177Z","end":"2026-04-15T12:12:51.175675Z","steps":["trace[502150392] 'process raft request' (duration: 235.474443ms)","trace[502150392] 'compare' (duration: 325.161782ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T12:12:51.175997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:50.614147Z","time spent":"561.71638ms","remote":"127.0.0.1:40410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T12:12:52.152046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"861.314688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-xrvxv\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-04-15T12:12:52.152615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.514236ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-15T12:12:52.152807Z","caller":"traceutil/trace.go:171","msg":"trace[713663180] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"697.31226ms","start":"2026-04-15T12:12:51.455461Z","end":"2026-04-15T12:12:52.152773Z","steps":["trace[713663180] 'process raft request' (duration: 15.499361ms)","trace[713663180] 'compare' (duration: 681.362171ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T12:12:52.152895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:51.455437Z","time spent":"697.419014ms","remote":"127.0.0.1:40138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T12:12:52.153272Z","caller":"traceutil/trace.go:171","msg":"trace[1433920364] range","detail":"{range_begin:/registry/pods/kube-system/cilium-xrvxv; range_end:; response_count:1; response_revision:624; }","duration":"862.032688ms","start":"2026-04-15T12:12:51.290494Z","end":"2026-04-15T12:12:52.152527Z","steps":["trace[1433920364] 'range keys from in-memory index tree' (duration: 861.166643ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:52.153539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:51.29047Z","time spent":"863.050339ms","remote":"127.0.0.1:40042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-xrvxv\" "} {"level":"info","ts":"2026-04-15T12:12:52.154349Z","caller":"traceutil/trace.go:171","msg":"trace[2099494835] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"470.861289ms","start":"2026-04-15T12:12:51.683464Z","end":"2026-04-15T12:12:52.154325Z","steps":["trace[2099494835] 'process raft request' (duration: 470.036227ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:52.154642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:51.68344Z","time spent":"471.010535ms","remote":"127.0.0.1:39946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T12:12:52.751865Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9143324914828160123,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-15T12:12:53.252702Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9143324914828160123,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-15T12:12:53.340188Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.174421765s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-15T12:12:53.798938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.286991ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-15T12:12:53.799231Z","caller":"traceutil/trace.go:171","msg":"trace[1721116410] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:650; }","duration":"1.54825937s","start":"2026-04-15T12:12:52.250951Z","end":"2026-04-15T12:12:53.79921Z","steps":["trace[1721116410] 'read index received' (duration: 1.089448438s)","trace[1721116410] 'applied index is now lower than readState.Index' (duration: 458.809962ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T12:12:53.799354Z","caller":"traceutil/trace.go:171","msg":"trace[1461064557] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"1.576487565s","start":"2026-04-15T12:12:52.222854Z","end":"2026-04-15T12:12:53.799342Z","steps":["trace[1461064557] 'process raft request' (duration: 1.576282417s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:53.799428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:52.222785Z","time spent":"1.57660455s","remote":"127.0.0.1:40112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T12:12:53.799439Z","caller":"traceutil/trace.go:171","msg":"trace[1751753203] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"1.633756148s","start":"2026-04-15T12:12:52.165641Z","end":"2026-04-15T12:12:53.799397Z","steps":["trace[1751753203] 'process raft request' (duration: 1.174865433s)","trace[1751753203] 'compare' (duration: 458.122955ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T12:12:53.799619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:52.165618Z","time spent":"1.633898164s","remote":"127.0.0.1:40042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T12:12:53.79968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.530958022s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-15T12:12:53.799757Z","caller":"traceutil/trace.go:171","msg":"trace[950753421] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:628; }","duration":"1.531077307s","start":"2026-04-15T12:12:52.268656Z","end":"2026-04-15T12:12:53.799734Z","steps":["trace[950753421] 'agreement among raft nodes before linearized reading' (duration: 1.530823647s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:53.799811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:52.268632Z","time spent":"1.531166711s","remote":"127.0.0.1:40138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-15T12:12:53.799961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"689.452566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T12:12:53.800039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.549096373s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-15T12:12:53.800066Z","caller":"traceutil/trace.go:171","msg":"trace[572583120] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:628; }","duration":"689.686035ms","start":"2026-04-15T12:12:53.110352Z","end":"2026-04-15T12:12:53.800038Z","steps":["trace[572583120] 'agreement among raft nodes before linearized reading' (duration: 689.407284ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:12:53.800099Z","caller":"traceutil/trace.go:171","msg":"trace[45313654] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:628; }","duration":"1.549202146s","start":"2026-04-15T12:12:52.250883Z","end":"2026-04-15T12:12:53.800085Z","steps":["trace[45313654] 'agreement among raft nodes before linearized reading' (duration: 1.549071191s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:53.800115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:53.110315Z","time spent":"689.793069ms","remote":"127.0.0.1:47742","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-04-15T12:12:53.800138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:52.250856Z","time spent":"1.54927533s","remote":"127.0.0.1:40138","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-04-15T12:12:53.800043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.531229974s","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-04-15T12:12:53.800228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.420179ms","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-04-15T12:12:53.800239Z","caller":"traceutil/trace.go:171","msg":"trace[1466389245] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:628; }","duration":"1.531465603s","start":"2026-04-15T12:12:52.268763Z","end":"2026-04-15T12:12:53.800229Z","steps":["trace[1466389245] 'agreement among raft nodes before linearized reading' (duration: 1.53114061s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:53.800275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:52.268747Z","time spent":"1.531520404s","remote":"127.0.0.1:40138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-15T12:12:53.800278Z","caller":"traceutil/trace.go:171","msg":"trace[218702316] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:628; }","duration":"531.543424ms","start":"2026-04-15T12:12:53.268719Z","end":"2026-04-15T12:12:53.800262Z","steps":["trace[218702316] 'agreement among raft nodes before linearized reading' (duration: 531.381688ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:53.799965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.977112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.11\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-15T12:12:53.800438Z","caller":"traceutil/trace.go:171","msg":"trace[1017005017] range","detail":"{range_begin:/registry/masterleases/199.19.213.11; range_end:; response_count:1; response_revision:628; }","duration":"618.65763ms","start":"2026-04-15T12:12:53.181724Z","end":"2026-04-15T12:12:53.800382Z","steps":["trace[1017005017] 'agreement among raft nodes before linearized reading' (duration: 617.761704ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:53.801101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:53.181696Z","time spent":"619.385629ms","remote":"127.0.0.1:39872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.19.213.11\" "} {"level":"warn","ts":"2026-04-15T12:12:53.800319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:53.26866Z","time spent":"531.647518ms","remote":"127.0.0.1:40138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-15T12:12:55.903954Z","caller":"traceutil/trace.go:171","msg":"trace[1017090093] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"318.997014ms","start":"2026-04-15T12:12:55.584934Z","end":"2026-04-15T12:12:55.903931Z","steps":["trace[1017090093] 'process raft request' (duration: 318.837568ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:12:55.904115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:12:55.584902Z","time spent":"319.119049ms","remote":"127.0.0.1:39886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T12:12:55.907342Z","caller":"traceutil/trace.go:171","msg":"trace[1742600110] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"152.383571ms","start":"2026-04-15T12:12:55.754933Z","end":"2026-04-15T12:12:55.907316Z","steps":["trace[1742600110] 'process raft request' (duration: 152.031897ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:12:55.90807Z","caller":"traceutil/trace.go:171","msg":"trace[1557528315] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"123.974655ms","start":"2026-04-15T12:12:55.784085Z","end":"2026-04-15T12:12:55.908059Z","steps":["trace[1557528315] 'process raft request' (duration: 123.014218ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:13:09.855432Z","caller":"traceutil/trace.go:171","msg":"trace[460879460] linearizableReadLoop","detail":"{readStateIndex:819; appliedIndex:818; }","duration":"428.181829ms","start":"2026-04-15T12:13:09.427219Z","end":"2026-04-15T12:13:09.855401Z","steps":["trace[460879460] 'read index received' (duration: 419.121444ms)","trace[460879460] 'applied index is now lower than readState.Index' (duration: 9.058475ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T12:13:09.855743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.489609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-ctn2h\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-04-15T12:13:09.855861Z","caller":"traceutil/trace.go:171","msg":"trace[828558982] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-ctn2h; range_end:; response_count:1; response_revision:789; }","duration":"428.636634ms","start":"2026-04-15T12:13:09.427175Z","end":"2026-04-15T12:13:09.855811Z","steps":["trace[828558982] 'agreement among raft nodes before linearized reading' (duration: 428.364435ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:13:09.855901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:13:09.427156Z","time spent":"428.737828ms","remote":"127.0.0.1:40042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-ctn2h\" "} {"level":"warn","ts":"2026-04-15T12:13:09.856048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.621949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-15T12:13:09.85612Z","caller":"traceutil/trace.go:171","msg":"trace[678496378] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:789; }","duration":"361.029342ms","start":"2026-04-15T12:13:09.495072Z","end":"2026-04-15T12:13:09.856102Z","steps":["trace[678496378] 'agreement among raft nodes before linearized reading' (duration: 360.517325ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:13:09.856333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:13:09.495044Z","time spent":"361.146176ms","remote":"127.0.0.1:40138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-15T12:15:21.287931Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9143324914828161922,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-15T12:15:21.788209Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9143324914828161922,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-15T12:15:22.268832Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.575406793s","expected-duration":"1s"} {"level":"info","ts":"2026-04-15T12:15:22.269334Z","caller":"traceutil/trace.go:171","msg":"trace[262354959] transaction","detail":"{read_only:false; response_revision:1398; number_of_response:1; }","duration":"1.575975291s","start":"2026-04-15T12:15:20.693322Z","end":"2026-04-15T12:15:22.269297Z","steps":["trace[262354959] 'process raft request' (duration: 1.575795798s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:15:22.269545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:15:20.693308Z","time spent":"1.576136223s","remote":"127.0.0.1:40138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T12:15:22.273767Z","caller":"traceutil/trace.go:171","msg":"trace[1855679904] linearizableReadLoop","detail":"{readStateIndex:1460; appliedIndex:1458; }","duration":"1.486904632s","start":"2026-04-15T12:15:20.786836Z","end":"2026-04-15T12:15:22.273741Z","steps":["trace[1855679904] 'read index received' (duration: 1.482392206s)","trace[1855679904] 'applied index is now lower than readState.Index' (duration: 4.511276ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T12:15:22.273841Z","caller":"traceutil/trace.go:171","msg":"trace[427452025] transaction","detail":"{read_only:false; response_revision:1399; number_of_response:1; }","duration":"1.097564865s","start":"2026-04-15T12:15:21.17623Z","end":"2026-04-15T12:15:22.273795Z","steps":["trace[427452025] 'process raft request' (duration: 1.097344792s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:15:22.274086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:15:21.176174Z","time spent":"1.097791078s","remote":"127.0.0.1:40138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T12:15:22.274133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.487289868s","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-04-15T12:15:22.274172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.483278108s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-15T12:15:22.274199Z","caller":"traceutil/trace.go:171","msg":"trace[815271335] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1399; }","duration":"1.487401679s","start":"2026-04-15T12:15:20.78678Z","end":"2026-04-15T12:15:22.274181Z","steps":["trace[815271335] 'agreement among raft nodes before linearized reading' (duration: 1.487150015s)"],"step_count":1} {"level":"info","ts":"2026-04-15T12:15:22.27421Z","caller":"traceutil/trace.go:171","msg":"trace[2013622883] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1399; }","duration":"1.48338208s","start":"2026-04-15T12:15:20.790819Z","end":"2026-04-15T12:15:22.274201Z","steps":["trace[2013622883] 'agreement among raft nodes before linearized reading' (duration: 1.483189427s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:15:22.274206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.479608623s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-15T12:15:22.27424Z","caller":"traceutil/trace.go:171","msg":"trace[1113912563] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1399; }","duration":"1.479666944s","start":"2026-04-15T12:15:20.794564Z","end":"2026-04-15T12:15:22.274231Z","steps":["trace[1113912563] 'agreement among raft nodes before linearized reading' (duration: 1.479571323s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:15:22.274238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:15:20.786758Z","time spent":"1.48747352s","remote":"127.0.0.1:40138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-15T12:15:22.274259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:15:20.790808Z","time spent":"1.483439471s","remote":"127.0.0.1:40138","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-04-15T12:15:22.274264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:15:20.79455Z","time spent":"1.479710035s","remote":"127.0.0.1:40138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-15T12:15:22.274123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.975039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T12:15:22.274298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.476409176s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-15T12:15:22.274411Z","caller":"traceutil/trace.go:171","msg":"trace[1040756475] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1399; }","duration":"1.476571259s","start":"2026-04-15T12:15:20.797818Z","end":"2026-04-15T12:15:22.274389Z","steps":["trace[1040756475] 'agreement among raft nodes before linearized reading' (duration: 1.476255054s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:15:22.274461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:15:20.797807Z","time spent":"1.47664491s","remote":"127.0.0.1:40138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-15T12:15:22.274419Z","caller":"traceutil/trace.go:171","msg":"trace[1670943286] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1399; }","duration":"165.331784ms","start":"2026-04-15T12:15:22.109027Z","end":"2026-04-15T12:15:22.274359Z","steps":["trace[1670943286] 'agreement among raft nodes before linearized reading' (duration: 165.00571ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:15:22.694807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.888094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-15T12:15:22.694931Z","caller":"traceutil/trace.go:171","msg":"trace[1127168145] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1403; }","duration":"232.093867ms","start":"2026-04-15T12:15:22.462811Z","end":"2026-04-15T12:15:22.694905Z","steps":["trace[1127168145] 'count revisions from in-memory index tree' (duration: 231.719541ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:15:24.792529Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9143324914828161945,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-15T12:15:25.292786Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9143324914828161945,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-15T12:15:25.762153Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.484066078s","expected-duration":"1s"} {"level":"info","ts":"2026-04-15T12:15:25.763019Z","caller":"traceutil/trace.go:171","msg":"trace[1453080181] transaction","detail":"{read_only:false; response_revision:1405; number_of_response:1; }","duration":"1.485006441s","start":"2026-04-15T12:15:24.277981Z","end":"2026-04-15T12:15:25.762987Z","steps":["trace[1453080181] 'process raft request' (duration: 1.484797068s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:15:25.763219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:15:24.277965Z","time spent":"1.485150484s","remote":"127.0.0.1:40138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T12:15:25.765992Z","caller":"traceutil/trace.go:171","msg":"trace[92048455] linearizableReadLoop","detail":"{readStateIndex:1468; appliedIndex:1466; }","duration":"1.474364185s","start":"2026-04-15T12:15:24.291592Z","end":"2026-04-15T12:15:25.765956Z","steps":["trace[92048455] 'read index received' (duration: 1.471167699s)","trace[92048455] 'applied index is now lower than readState.Index' (duration: 3.194746ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T12:15:25.7665Z","caller":"traceutil/trace.go:171","msg":"trace[25165066] transaction","detail":"{read_only:false; response_revision:1406; number_of_response:1; }","duration":"1.485010592s","start":"2026-04-15T12:15:24.281465Z","end":"2026-04-15T12:15:25.766476Z","steps":["trace[25165066] 'process raft request' (duration: 1.484012217s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:15:25.766542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.878325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T12:15:25.766666Z","caller":"traceutil/trace.go:171","msg":"trace[2004850655] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1406; }","duration":"660.071858ms","start":"2026-04-15T12:15:25.106584Z","end":"2026-04-15T12:15:25.766656Z","steps":["trace[2004850655] 'agreement among raft nodes before linearized reading' (duration: 659.891565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:15:25.766676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:15:24.281432Z","time spent":"1.485134044s","remote":"127.0.0.1:40138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T12:15:25.766672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.475014205s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-15T12:15:25.766879Z","caller":"traceutil/trace.go:171","msg":"trace[898326847] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1406; }","duration":"1.475292929s","start":"2026-04-15T12:15:24.291513Z","end":"2026-04-15T12:15:25.766806Z","steps":["trace[898326847] 'agreement among raft nodes before linearized reading' (duration: 1.474888232s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:15:25.766892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.469753377s","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-04-15T12:15:25.766994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:15:24.291485Z","time spent":"1.475436301s","remote":"127.0.0.1:40138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-15T12:15:25.767047Z","caller":"traceutil/trace.go:171","msg":"trace[148230824] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1406; }","duration":"1.469975241s","start":"2026-04-15T12:15:24.297049Z","end":"2026-04-15T12:15:25.767025Z","steps":["trace[148230824] 'agreement among raft nodes before linearized reading' (duration: 1.469419873s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:15:25.766779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:15:25.106557Z","time spent":"660.21477ms","remote":"127.0.0.1:47742","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-04-15T12:15:25.767192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.469358682s","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-04-15T12:15:25.767177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:15:24.297038Z","time spent":"1.470128163s","remote":"127.0.0.1:40138","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":"info","ts":"2026-04-15T12:15:25.767228Z","caller":"traceutil/trace.go:171","msg":"trace[964098057] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1406; }","duration":"1.469426713s","start":"2026-04-15T12:15:24.297789Z","end":"2026-04-15T12:15:25.767216Z","steps":["trace[964098057] 'agreement among raft nodes before linearized reading' (duration: 1.469281331s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:15:25.767408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:15:24.297778Z","time spent":"1.469616625s","remote":"127.0.0.1:40138","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-04-15T12:15:25.767198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.469258031s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-15T12:15:25.767493Z","caller":"traceutil/trace.go:171","msg":"trace[1723392103] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1406; }","duration":"1.469627876s","start":"2026-04-15T12:15:24.297855Z","end":"2026-04-15T12:15:25.767483Z","steps":["trace[1723392103] 'agreement among raft nodes before linearized reading' (duration: 1.469112158s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T12:15:25.767608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T12:15:24.297834Z","time spent":"1.469764047s","remote":"127.0.0.1:40138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}