{"level":"warn","ts":"2026-05-05T22:10:41.333378Z","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-05T22:10:41.333462Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.222: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.222:2380","--initial-cluster=instance=https://199.204.45.222:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.222:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.222: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-05T22:10:41.333531Z","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-05T22:10:41.333542Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-05-05T22:10:41.333565Z","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-05T22:10:41.334178Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"]} {"level":"info","ts":"2026-05-05T22:10:41.334257Z","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.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.222: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-05T22:10:41.339597Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.121319ms"} {"level":"info","ts":"2026-05-05T22:10:41.346044Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"380f6760faea5f9e","cluster-id":"b87e8aca83a17eab"} {"level":"info","ts":"2026-05-05T22:10:41.346115Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=()"} {"level":"info","ts":"2026-05-05T22:10:41.346142Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 0"} {"level":"info","ts":"2026-05-05T22:10:41.346156Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 380f6760faea5f9e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-05T22:10:41.346172Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 1"} {"level":"info","ts":"2026-05-05T22:10:41.346213Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"warn","ts":"2026-05-05T22:10:41.357097Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-05T22:10:41.358464Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-05T22:10:41.359538Z","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-05T22:10:41.361523Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"380f6760faea5f9e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-05T22:10:41.362246Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"380f6760faea5f9e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-05T22:10:41.362369Z","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-05T22:10:41.362403Z","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-05T22:10:41.362413Z","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-05T22:10:41.364628Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"info","ts":"2026-05-05T22:10:41.364825Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","added-peer-id":"380f6760faea5f9e","added-peer-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-05-05T22:10:41.367299Z","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-05T22:10:41.367464Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-05-05T22:10:41.367503Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-05-05T22:10:41.368286Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"380f6760faea5f9e","initial-advertise-peer-urls":["https://199.204.45.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-05T22:10:41.36832Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-05T22:10:41.747002Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e is starting a new election at term 1"} {"level":"info","ts":"2026-05-05T22:10:41.747102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became pre-candidate at term 1"} {"level":"info","ts":"2026-05-05T22:10:41.747149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgPreVoteResp from 380f6760faea5f9e at term 1"} {"level":"info","ts":"2026-05-05T22:10:41.747168Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became candidate at term 2"} {"level":"info","ts":"2026-05-05T22:10:41.74718Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgVoteResp from 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-05-05T22:10:41.747218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became leader at term 2"} {"level":"info","ts":"2026-05-05T22:10:41.747238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 380f6760faea5f9e elected leader 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-05-05T22:10:41.748253Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"380f6760faea5f9e","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.222:2379]}","request-path":"/0/members/380f6760faea5f9e/attributes","cluster-id":"b87e8aca83a17eab","publish-timeout":"7s"} {"level":"info","ts":"2026-05-05T22:10:41.748332Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T22:10:41.748355Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T22:10:41.748427Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T22:10:41.748663Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-05T22:10:41.748686Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-05T22:10:41.74947Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T22:10:41.749573Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T22:10:41.74961Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T22:10:41.750979Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-05T22:10:41.751839Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.222:2379"} {"level":"info","ts":"2026-05-05T22:10:43.458685Z","caller":"traceutil/trace.go:171","msg":"trace[389839805] linearizableReadLoop","detail":"{readStateIndex:66; appliedIndex:65; }","duration":"146.778477ms","start":"2026-05-05T22:10:43.31187Z","end":"2026-05-05T22:10:43.458649Z","steps":["trace[389839805] 'read index received' (duration: 81.697856ms)","trace[389839805] 'applied index is now lower than readState.Index' (duration: 65.079661ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:10:43.458826Z","caller":"traceutil/trace.go:171","msg":"trace[1284600331] transaction","detail":"{read_only:false; response_revision:62; number_of_response:1; }","duration":"146.755927ms","start":"2026-05-05T22:10:43.312053Z","end":"2026-05-05T22:10:43.458809Z","steps":["trace[1284600331] 'process raft request' (duration: 146.556085ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:43.458807Z","caller":"traceutil/trace.go:171","msg":"trace[296268324] transaction","detail":"{read_only:false; response_revision:61; number_of_response:1; }","duration":"148.202631ms","start":"2026-05-05T22:10:43.310565Z","end":"2026-05-05T22:10:43.458767Z","steps":["trace[296268324] 'process raft request' (duration: 82.904438ms)","trace[296268324] 'compare' (duration: 65.005571ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:10:43.459594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.688316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18accae59d1c5a04\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-05-05T22:10:43.459719Z","caller":"traceutil/trace.go:171","msg":"trace[1711836829] range","detail":"{range_begin:/registry/events/default/instance.18accae59d1c5a04; range_end:; response_count:1; response_revision:62; }","duration":"147.847488ms","start":"2026-05-05T22:10:43.311847Z","end":"2026-05-05T22:10:43.459695Z","steps":["trace[1711836829] 'agreement among raft nodes before linearized reading' (duration: 146.927398ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:43.705968Z","caller":"traceutil/trace.go:171","msg":"trace[982560631] linearizableReadLoop","detail":"{readStateIndex:70; appliedIndex:68; }","duration":"229.685165ms","start":"2026-05-05T22:10:43.476241Z","end":"2026-05-05T22:10:43.705926Z","steps":["trace[982560631] 'read index received' (duration: 137.686311ms)","trace[982560631] 'applied index is now lower than readState.Index' (duration: 91.997894ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:10:43.706001Z","caller":"traceutil/trace.go:171","msg":"trace[926472806] transaction","detail":"{read_only:false; response_revision:64; number_of_response:1; }","duration":"242.98625ms","start":"2026-05-05T22:10:43.462978Z","end":"2026-05-05T22:10:43.705965Z","steps":["trace[926472806] 'process raft request' (duration: 151.000687ms)","trace[926472806] 'compare' (duration: 91.74357ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:10:43.706079Z","caller":"traceutil/trace.go:171","msg":"trace[2004294786] transaction","detail":"{read_only:false; response_revision:65; number_of_response:1; }","duration":"242.893399ms","start":"2026-05-05T22:10:43.463176Z","end":"2026-05-05T22:10:43.70607Z","steps":["trace[2004294786] 'process raft request' (duration: 242.692717ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:10:43.706338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.049408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18accae59d1c69d6\" ","response":"range_response_count:1 size:648"} {"level":"info","ts":"2026-05-05T22:10:43.706395Z","caller":"traceutil/trace.go:171","msg":"trace[1673663257] range","detail":"{range_begin:/registry/events/default/instance.18accae59d1c69d6; range_end:; response_count:1; response_revision:65; }","duration":"230.181509ms","start":"2026-05-05T22:10:43.476202Z","end":"2026-05-05T22:10:43.706383Z","steps":["trace[1673663257] 'agreement among raft nodes before linearized reading' (duration: 229.913317ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:10:44.081432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.087507ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-05-05T22:10:44.081637Z","caller":"traceutil/trace.go:171","msg":"trace[1195324553] transaction","detail":"{read_only:false; response_revision:69; number_of_response:1; }","duration":"289.698131ms","start":"2026-05-05T22:10:43.791918Z","end":"2026-05-05T22:10:44.081616Z","steps":["trace[1195324553] 'process raft request' (duration: 54.805295ms)","trace[1195324553] 'compare' (duration: 233.954256ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:10:44.108625Z","caller":"traceutil/trace.go:171","msg":"trace[35553029] transaction","detail":"{read_only:false; response_revision:71; number_of_response:1; }","duration":"314.818652ms","start":"2026-05-05T22:10:43.79379Z","end":"2026-05-05T22:10:44.108608Z","steps":["trace[35553029] 'process raft request' (duration: 314.767801ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:10:44.108787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:10:43.793768Z","time spent":"314.963963ms","remote":"127.0.0.1:38576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1120,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T22:10:44.108727Z","caller":"traceutil/trace.go:171","msg":"trace[2135575231] transaction","detail":"{read_only:false; response_revision:70; number_of_response:1; }","duration":"315.131874ms","start":"2026-05-05T22:10:43.793508Z","end":"2026-05-05T22:10:44.10864Z","steps":["trace[2135575231] 'process raft request' (duration: 314.940342ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:10:44.108882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.512718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-05T22:10:44.109179Z","caller":"traceutil/trace.go:171","msg":"trace[1817648794] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:71; }","duration":"153.886261ms","start":"2026-05-05T22:10:43.955259Z","end":"2026-05-05T22:10:44.109146Z","steps":["trace[1817648794] 'agreement among raft nodes before linearized reading' (duration: 153.446717ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:10:44.109239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:10:43.793495Z","time spent":"315.565558ms","remote":"127.0.0.1:38582","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":565,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T22:10:44.108651Z","caller":"traceutil/trace.go:171","msg":"trace[417718465] linearizableReadLoop","detail":"{readStateIndex:76; appliedIndex:76; }","duration":"153.311546ms","start":"2026-05-05T22:10:43.955309Z","end":"2026-05-05T22:10:44.10862Z","steps":["trace[417718465] 'read index received' (duration: 153.300686ms)","trace[417718465] 'applied index is now lower than readState.Index' (duration: 8.34µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:10:44.109504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.107194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-05T22:10:44.109576Z","caller":"traceutil/trace.go:171","msg":"trace[332876013] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:71; }","duration":"154.194744ms","start":"2026-05-05T22:10:43.955345Z","end":"2026-05-05T22:10:44.109539Z","steps":["trace[332876013] 'agreement among raft nodes before linearized reading' (duration: 154.121943ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:10:44.109589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.740559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-05T22:10:44.109696Z","caller":"traceutil/trace.go:171","msg":"trace[8335526] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:71; }","duration":"139.87164ms","start":"2026-05-05T22:10:43.969793Z","end":"2026-05-05T22:10:44.109665Z","steps":["trace[8335526] 'agreement among raft nodes before linearized reading' (duration: 139.687789ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:10:44.608394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.003307ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-05-05T22:10:44.60862Z","caller":"traceutil/trace.go:171","msg":"trace[748718531] transaction","detail":"{read_only:false; response_revision:89; number_of_response:1; }","duration":"329.478464ms","start":"2026-05-05T22:10:44.27912Z","end":"2026-05-05T22:10:44.608599Z","steps":["trace[748718531] 'process raft request' (duration: 329.405864ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:44.608679Z","caller":"traceutil/trace.go:171","msg":"trace[681961226] transaction","detail":"{read_only:false; response_revision:88; number_of_response:1; }","duration":"330.173501ms","start":"2026-05-05T22:10:44.278459Z","end":"2026-05-05T22:10:44.608632Z","steps":["trace[681961226] 'process raft request' (duration: 216.81838ms)","trace[681961226] 'compare' (duration: 112.828466ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:10:44.60871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:10:44.279106Z","time spent":"329.569945ms","remote":"127.0.0.1:38500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":621,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T22:10:44.60889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:10:44.278446Z","time spent":"330.326642ms","remote":"127.0.0.1:38238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":638,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T22:10:45.012047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.259536ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-05-05T22:10:45.012223Z","caller":"traceutil/trace.go:171","msg":"trace[2045331607] linearizableReadLoop","detail":"{readStateIndex:97; appliedIndex:96; }","duration":"319.963224ms","start":"2026-05-05T22:10:44.69224Z","end":"2026-05-05T22:10:45.012203Z","steps":["trace[2045331607] 'read index received' (duration: 38.504856ms)","trace[2045331607] 'applied index is now lower than readState.Index' (duration: 281.456478ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:10:45.012305Z","caller":"traceutil/trace.go:171","msg":"trace[1573384661] transaction","detail":"{read_only:false; response_revision:92; number_of_response:1; }","duration":"322.168704ms","start":"2026-05-05T22:10:44.690082Z","end":"2026-05-05T22:10:45.012251Z","steps":["trace[1573384661] 'process raft request' (duration: 40.586615ms)","trace[1573384661] 'compare' (duration: 281.005354ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:10:45.012438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.188336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:public-info-viewer\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-05T22:10:45.012503Z","caller":"traceutil/trace.go:171","msg":"trace[148566259] range","detail":"{range_begin:/registry/clusterroles/system:public-info-viewer; range_end:; response_count:0; response_revision:92; }","duration":"320.259066ms","start":"2026-05-05T22:10:44.692209Z","end":"2026-05-05T22:10:45.012468Z","steps":["trace[148566259] 'agreement among raft nodes before linearized reading' (duration: 320.077225ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:10:45.012525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:10:44.690067Z","time spent":"322.343086ms","remote":"127.0.0.1:38238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":642,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T22:10:45.012625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:10:44.692192Z","time spent":"320.415177ms","remote":"127.0.0.1:38500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/system:public-info-viewer\" "} {"level":"info","ts":"2026-05-05T22:10:49.171038Z","caller":"traceutil/trace.go:171","msg":"trace[720894202] transaction","detail":"{read_only:false; number_of_response:0; response_revision:304; }","duration":"108.838081ms","start":"2026-05-05T22:10:49.06218Z","end":"2026-05-05T22:10:49.171018Z","steps":["trace[720894202] 'process raft request' (duration: 108.76472ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:49.304647Z","caller":"traceutil/trace.go:171","msg":"trace[2023823139] linearizableReadLoop","detail":"{readStateIndex:313; appliedIndex:312; }","duration":"132.515418ms","start":"2026-05-05T22:10:49.172095Z","end":"2026-05-05T22:10:49.30461Z","steps":["trace[2023823139] 'read index received' (duration: 132.205706ms)","trace[2023823139] 'applied index is now lower than readState.Index' (duration: 308.272µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:10:49.304931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.829303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"} {"level":"warn","ts":"2026-05-05T22:10:49.304921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.77418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7111"} {"level":"info","ts":"2026-05-05T22:10:49.305005Z","caller":"traceutil/trace.go:171","msg":"trace[409570797] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:305; }","duration":"130.983694ms","start":"2026-05-05T22:10:49.174004Z","end":"2026-05-05T22:10:49.304987Z","steps":["trace[409570797] 'agreement among raft nodes before linearized reading' (duration: 130.797393ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:49.305025Z","caller":"traceutil/trace.go:171","msg":"trace[1407471697] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:305; }","duration":"132.961472ms","start":"2026-05-05T22:10:49.172042Z","end":"2026-05-05T22:10:49.305004Z","steps":["trace[1407471697] 'agreement among raft nodes before linearized reading' (duration: 132.74278ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:49.305244Z","caller":"traceutil/trace.go:171","msg":"trace[1078845983] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"227.496508ms","start":"2026-05-05T22:10:49.077252Z","end":"2026-05-05T22:10:49.304748Z","steps":["trace[1078845983] 'process raft request' (duration: 227.141405ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:50.347108Z","caller":"traceutil/trace.go:171","msg":"trace[1089320395] linearizableReadLoop","detail":"{readStateIndex:331; appliedIndex:330; }","duration":"162.940809ms","start":"2026-05-05T22:10:50.184147Z","end":"2026-05-05T22:10:50.347087Z","steps":["trace[1089320395] 'read index received' (duration: 162.697377ms)","trace[1089320395] 'applied index is now lower than readState.Index' (duration: 242.282µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:10:50.347237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.07353ms","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-05T22:10:50.347263Z","caller":"traceutil/trace.go:171","msg":"trace[1700222417] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:323; }","duration":"163.15043ms","start":"2026-05-05T22:10:50.184105Z","end":"2026-05-05T22:10:50.347256Z","steps":["trace[1700222417] 'agreement among raft nodes before linearized reading' (duration: 163.066739ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:50.347152Z","caller":"traceutil/trace.go:171","msg":"trace[706535110] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"171.764295ms","start":"2026-05-05T22:10:50.175354Z","end":"2026-05-05T22:10:50.347118Z","steps":["trace[706535110] 'process raft request' (duration: 171.592753ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:51.815947Z","caller":"traceutil/trace.go:171","msg":"trace[1454004374] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"141.049847ms","start":"2026-05-05T22:10:51.674862Z","end":"2026-05-05T22:10:51.815912Z","steps":["trace[1454004374] 'process raft request' (duration: 140.853235ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:52.095775Z","caller":"traceutil/trace.go:171","msg":"trace[905861959] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"121.267749ms","start":"2026-05-05T22:10:51.974478Z","end":"2026-05-05T22:10:52.095746Z","steps":["trace[905861959] 'process raft request' (duration: 37.305009ms)","trace[905861959] 'compare' (duration: 83.480126ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:10:52.299159Z","caller":"traceutil/trace.go:171","msg":"trace[30937130] transaction","detail":"{read_only:false; response_revision:337; number_of_response:1; }","duration":"124.12144ms","start":"2026-05-05T22:10:52.175006Z","end":"2026-05-05T22:10:52.299127Z","steps":["trace[30937130] 'process raft request' (duration: 99.424731ms)","trace[30937130] 'compare' (duration: 23.815572ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:10:52.684921Z","caller":"traceutil/trace.go:171","msg":"trace[812347616] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"182.601246ms","start":"2026-05-05T22:10:52.502288Z","end":"2026-05-05T22:10:52.684889Z","steps":["trace[812347616] 'process raft request' (duration: 104.042961ms)","trace[812347616] 'compare' (duration: 78.366184ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:10:52.696816Z","caller":"traceutil/trace.go:171","msg":"trace[960973356] linearizableReadLoop","detail":"{readStateIndex:350; appliedIndex:347; }","duration":"172.172677ms","start":"2026-05-05T22:10:52.524627Z","end":"2026-05-05T22:10:52.6968Z","steps":["trace[960973356] 'read index received' (duration: 81.64672ms)","trace[960973356] 'applied index is now lower than readState.Index' (duration: 90.524747ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:10:52.696911Z","caller":"traceutil/trace.go:171","msg":"trace[415831287] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"193.988402ms","start":"2026-05-05T22:10:52.502892Z","end":"2026-05-05T22:10:52.696881Z","steps":["trace[415831287] 'process raft request' (duration: 193.779071ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:10:52.696979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.340239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-05-05T22:10:52.696893Z","caller":"traceutil/trace.go:171","msg":"trace[1238919470] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"194.104823ms","start":"2026-05-05T22:10:52.502764Z","end":"2026-05-05T22:10:52.696869Z","steps":["trace[1238919470] 'process raft request' (duration: 193.803331ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:52.697019Z","caller":"traceutil/trace.go:171","msg":"trace[1762055227] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:342; }","duration":"172.414069ms","start":"2026-05-05T22:10:52.524592Z","end":"2026-05-05T22:10:52.697006Z","steps":["trace[1762055227] 'agreement among raft nodes before linearized reading' (duration: 172.313899ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:10:52.697144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.131193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-05T22:10:52.697279Z","caller":"traceutil/trace.go:171","msg":"trace[707098463] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:342; }","duration":"123.308334ms","start":"2026-05-05T22:10:52.57394Z","end":"2026-05-05T22:10:52.697249Z","steps":["trace[707098463] 'agreement among raft nodes before linearized reading' (duration: 123.037882ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:10:52.995978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.474199ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T22:10:52.996148Z","caller":"traceutil/trace.go:171","msg":"trace[76522229] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"291.991422ms","start":"2026-05-05T22:10:52.704133Z","end":"2026-05-05T22:10:52.996124Z","steps":["trace[76522229] 'process raft request' (duration: 111.281361ms)","trace[76522229] 'compare' (duration: 180.335198ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:10:52.996432Z","caller":"traceutil/trace.go:171","msg":"trace[1781871307] linearizableReadLoop","detail":"{readStateIndex:352; appliedIndex:350; }","duration":"272.439806ms","start":"2026-05-05T22:10:52.723964Z","end":"2026-05-05T22:10:52.996404Z","steps":["trace[1781871307] 'read index received' (duration: 91.555314ms)","trace[1781871307] 'applied index is now lower than readState.Index' (duration: 180.882122ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:10:52.996476Z","caller":"traceutil/trace.go:171","msg":"trace[743936184] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"290.64201ms","start":"2026-05-05T22:10:52.705822Z","end":"2026-05-05T22:10:52.996464Z","steps":["trace[743936184] 'process raft request' (duration: 290.256007ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:10:52.996621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.701724ms","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-05T22:10:52.996715Z","caller":"traceutil/trace.go:171","msg":"trace[1040880651] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:344; }","duration":"222.828426ms","start":"2026-05-05T22:10:52.773873Z","end":"2026-05-05T22:10:52.996701Z","steps":["trace[1040880651] 'agreement among raft nodes before linearized reading' (duration: 222.689625ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:10:52.996729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.660558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-05-05T22:10:52.996794Z","caller":"traceutil/trace.go:171","msg":"trace[1999279879] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:344; }","duration":"272.86594ms","start":"2026-05-05T22:10:52.723913Z","end":"2026-05-05T22:10:52.996779Z","steps":["trace[1999279879] 'agreement among raft nodes before linearized reading' (duration: 272.631808ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:10:52.996866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.803871ms","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-05T22:10:52.996894Z","caller":"traceutil/trace.go:171","msg":"trace[1944011823] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:344; }","duration":"121.862691ms","start":"2026-05-05T22:10:52.875024Z","end":"2026-05-05T22:10:52.996887Z","steps":["trace[1944011823] 'agreement among raft nodes before linearized reading' (duration: 121.82077ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:10:52.996952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.870364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-05-05T22:10:52.99697Z","caller":"traceutil/trace.go:171","msg":"trace[1048648977] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:344; }","duration":"172.935214ms","start":"2026-05-05T22:10:52.82403Z","end":"2026-05-05T22:10:52.996965Z","steps":["trace[1048648977] 'agreement among raft nodes before linearized reading' (duration: 172.905094ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:10:53.335531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.59737ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T22:10:53.335842Z","caller":"traceutil/trace.go:171","msg":"trace[2024570394] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"330.547399ms","start":"2026-05-05T22:10:53.005264Z","end":"2026-05-05T22:10:53.335811Z","steps":["trace[2024570394] 'process raft request' (duration: 209.204693ms)","trace[2024570394] 'compare' (duration: 120.348318ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:10:53.336018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:10:53.005241Z","time spent":"330.70651ms","remote":"127.0.0.1:38500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T22:10:53.340469Z","caller":"traceutil/trace.go:171","msg":"trace[667037557] linearizableReadLoop","detail":"{readStateIndex:355; appliedIndex:352; }","duration":"315.049409ms","start":"2026-05-05T22:10:53.025372Z","end":"2026-05-05T22:10:53.340421Z","steps":["trace[667037557] 'read index received' (duration: 189.099784ms)","trace[667037557] 'applied index is now lower than readState.Index' (duration: 125.948395ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:10:53.340572Z","caller":"traceutil/trace.go:171","msg":"trace[383580805] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"333.915936ms","start":"2026-05-05T22:10:53.006647Z","end":"2026-05-05T22:10:53.340562Z","steps":["trace[383580805] 'process raft request' (duration: 329.252497ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:53.340822Z","caller":"traceutil/trace.go:171","msg":"trace[73335245] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"332.522285ms","start":"2026-05-05T22:10:53.008287Z","end":"2026-05-05T22:10:53.340809Z","steps":["trace[73335245] 'process raft request' (duration: 332.076072ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:10:53.341025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.656104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-05-05T22:10:53.34107Z","caller":"traceutil/trace.go:171","msg":"trace[532916550] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:347; }","duration":"315.729865ms","start":"2026-05-05T22:10:53.025324Z","end":"2026-05-05T22:10:53.341054Z","steps":["trace[532916550] 'agreement among raft nodes before linearized reading' (duration: 315.363292ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:10:53.341092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:10:53.025303Z","time spent":"315.782355ms","remote":"127.0.0.1:38360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":241,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "} {"level":"warn","ts":"2026-05-05T22:10:53.341522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.052922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"warn","ts":"2026-05-05T22:10:53.341592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.200218ms","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-05T22:10:53.341634Z","caller":"traceutil/trace.go:171","msg":"trace[771789620] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:347; }","duration":"267.278598ms","start":"2026-05-05T22:10:53.074343Z","end":"2026-05-05T22:10:53.341622Z","steps":["trace[771789620] 'agreement among raft nodes before linearized reading' (duration: 266.417431ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:53.3417Z","caller":"traceutil/trace.go:171","msg":"trace[1187585857] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:347; }","duration":"116.191673ms","start":"2026-05-05T22:10:53.225421Z","end":"2026-05-05T22:10:53.341613Z","steps":["trace[1187585857] 'agreement among raft nodes before linearized reading' (duration: 116.057872ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:10:53.341987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.33145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-05-05T22:10:53.342021Z","caller":"traceutil/trace.go:171","msg":"trace[2027640004] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:347; }","duration":"217.40827ms","start":"2026-05-05T22:10:53.1246Z","end":"2026-05-05T22:10:53.342008Z","steps":["trace[2027640004] 'agreement among raft nodes before linearized reading' (duration: 217.35281ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:10:53.342132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.643483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-05T22:10:53.342161Z","caller":"traceutil/trace.go:171","msg":"trace[432089552] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:347; }","duration":"167.667873ms","start":"2026-05-05T22:10:53.174482Z","end":"2026-05-05T22:10:53.34215Z","steps":["trace[432089552] 'agreement among raft nodes before linearized reading' (duration: 167.629233ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:10:53.342396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:10:53.006629Z","time spent":"333.970308ms","remote":"127.0.0.1:38238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":649,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T22:10:53.342531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:10:53.008278Z","time spent":"332.577116ms","remote":"127.0.0.1:38326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4306,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T22:10:53.474999Z","caller":"traceutil/trace.go:171","msg":"trace[656165641] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"125.814895ms","start":"2026-05-05T22:10:53.349139Z","end":"2026-05-05T22:10:53.474954Z","steps":["trace[656165641] 'process raft request' (duration: 111.851028ms)","trace[656165641] 'compare' (duration: 13.721505ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:10:53.475221Z","caller":"traceutil/trace.go:171","msg":"trace[1235597083] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"123.631547ms","start":"2026-05-05T22:10:53.351553Z","end":"2026-05-05T22:10:53.475185Z","steps":["trace[1235597083] 'process raft request' (duration: 123.459265ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:53.475542Z","caller":"traceutil/trace.go:171","msg":"trace[727848324] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"125.739694ms","start":"2026-05-05T22:10:53.349687Z","end":"2026-05-05T22:10:53.475427Z","steps":["trace[727848324] 'process raft request' (duration: 125.19554ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:53.475334Z","caller":"traceutil/trace.go:171","msg":"trace[679296119] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"123.348323ms","start":"2026-05-05T22:10:53.351956Z","end":"2026-05-05T22:10:53.475304Z","steps":["trace[679296119] 'process raft request' (duration: 123.110712ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:53.475424Z","caller":"traceutil/trace.go:171","msg":"trace[960196130] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"122.359886ms","start":"2026-05-05T22:10:53.353052Z","end":"2026-05-05T22:10:53.475412Z","steps":["trace[960196130] 'process raft request' (duration: 122.113214ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:53.475699Z","caller":"traceutil/trace.go:171","msg":"trace[875097691] linearizableReadLoop","detail":"{readStateIndex:362; appliedIndex:355; }","duration":"101.277168ms","start":"2026-05-05T22:10:53.374393Z","end":"2026-05-05T22:10:53.475671Z","steps":["trace[875097691] 'read index received' (duration: 45.016867ms)","trace[875097691] 'applied index is now lower than readState.Index' (duration: 56.258691ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:10:53.475843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.43335ms","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-05T22:10:53.478713Z","caller":"traceutil/trace.go:171","msg":"trace[1367699206] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:356; }","duration":"104.335204ms","start":"2026-05-05T22:10:53.374342Z","end":"2026-05-05T22:10:53.478677Z","steps":["trace[1367699206] 'agreement among raft nodes before linearized reading' (duration: 101.40425ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:53.475379Z","caller":"traceutil/trace.go:171","msg":"trace[1648342859] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"124.306491ms","start":"2026-05-05T22:10:53.350871Z","end":"2026-05-05T22:10:53.475178Z","steps":["trace[1648342859] 'process raft request' (duration: 124.07207ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:53.659878Z","caller":"traceutil/trace.go:171","msg":"trace[827110570] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"103.548598ms","start":"2026-05-05T22:10:53.556302Z","end":"2026-05-05T22:10:53.65985Z","steps":["trace[827110570] 'process raft request' (duration: 43.326123ms)","trace[827110570] 'compare' (duration: 59.940292ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:10:53.659992Z","caller":"traceutil/trace.go:171","msg":"trace[951911279] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"102.536359ms","start":"2026-05-05T22:10:53.557415Z","end":"2026-05-05T22:10:53.659952Z","steps":["trace[951911279] 'process raft request' (duration: 102.404728ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:53.660017Z","caller":"traceutil/trace.go:171","msg":"trace[1311057707] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"102.54814ms","start":"2026-05-05T22:10:53.557446Z","end":"2026-05-05T22:10:53.659994Z","steps":["trace[1311057707] 'process raft request' (duration: 102.410509ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:53.660337Z","caller":"traceutil/trace.go:171","msg":"trace[852060216] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"103.572578ms","start":"2026-05-05T22:10:53.55675Z","end":"2026-05-05T22:10:53.660323Z","steps":["trace[852060216] 'process raft request' (duration: 103.016173ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:53.660379Z","caller":"traceutil/trace.go:171","msg":"trace[43175980] linearizableReadLoop","detail":"{readStateIndex:373; appliedIndex:371; }","duration":"103.673559ms","start":"2026-05-05T22:10:53.556689Z","end":"2026-05-05T22:10:53.660363Z","steps":["trace[43175980] 'read index received' (duration: 1.1765ms)","trace[43175980] 'applied index is now lower than readState.Index' (duration: 102.495629ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:10:53.660767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.054792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-05T22:10:53.660853Z","caller":"traceutil/trace.go:171","msg":"trace[202633232] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:370; }","duration":"104.199503ms","start":"2026-05-05T22:10:53.556636Z","end":"2026-05-05T22:10:53.660836Z","steps":["trace[202633232] 'agreement among raft nodes before linearized reading' (duration: 103.767059ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:53.839961Z","caller":"traceutil/trace.go:171","msg":"trace[302497335] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"117.861307ms","start":"2026-05-05T22:10:53.722069Z","end":"2026-05-05T22:10:53.83993Z","steps":["trace[302497335] 'process raft request' (duration: 41.312966ms)","trace[302497335] 'compare' (duration: 76.40929ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:10:53.876524Z","caller":"traceutil/trace.go:171","msg":"trace[1047044805] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"123.547716ms","start":"2026-05-05T22:10:53.752932Z","end":"2026-05-05T22:10:53.87648Z","steps":["trace[1047044805] 'process raft request' (duration: 123.411214ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:53.876555Z","caller":"traceutil/trace.go:171","msg":"trace[452569143] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"122.800839ms","start":"2026-05-05T22:10:53.753727Z","end":"2026-05-05T22:10:53.876528Z","steps":["trace[452569143] 'process raft request' (duration: 122.684858ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:53.876788Z","caller":"traceutil/trace.go:171","msg":"trace[653192303] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"113.930214ms","start":"2026-05-05T22:10:53.762817Z","end":"2026-05-05T22:10:53.876747Z","steps":["trace[653192303] 'process raft request' (duration: 113.718962ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:53.8768Z","caller":"traceutil/trace.go:171","msg":"trace[1279646285] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"120.845113ms","start":"2026-05-05T22:10:53.755922Z","end":"2026-05-05T22:10:53.876767Z","steps":["trace[1279646285] 'process raft request' (duration: 120.52707ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:10:54.111312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.267897ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-05T22:10:54.111474Z","caller":"traceutil/trace.go:171","msg":"trace[255232034] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"229.691475ms","start":"2026-05-05T22:10:53.88172Z","end":"2026-05-05T22:10:54.111411Z","steps":["trace[255232034] 'process raft request' (duration: 77.251567ms)","trace[255232034] 'compare' (duration: 152.118536ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:10:54.114293Z","caller":"traceutil/trace.go:171","msg":"trace[750035861] linearizableReadLoop","detail":"{readStateIndex:392; appliedIndex:388; }","duration":"219.986524ms","start":"2026-05-05T22:10:53.894281Z","end":"2026-05-05T22:10:54.114268Z","steps":["trace[750035861] 'read index received' (duration: 64.746953ms)","trace[750035861] 'applied index is now lower than readState.Index' (duration: 155.238561ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:10:54.114428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.120415ms","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-05-05T22:10:54.114484Z","caller":"traceutil/trace.go:171","msg":"trace[544925235] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:384; }","duration":"220.192005ms","start":"2026-05-05T22:10:53.894265Z","end":"2026-05-05T22:10:54.114457Z","steps":["trace[544925235] 'agreement among raft nodes before linearized reading' (duration: 220.098075ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:54.1147Z","caller":"traceutil/trace.go:171","msg":"trace[1403217993] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"232.288927ms","start":"2026-05-05T22:10:53.882382Z","end":"2026-05-05T22:10:54.114671Z","steps":["trace[1403217993] 'process raft request' (duration: 231.673232ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:54.114763Z","caller":"traceutil/trace.go:171","msg":"trace[37835311] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"228.776877ms","start":"2026-05-05T22:10:53.885972Z","end":"2026-05-05T22:10:54.114749Z","steps":["trace[37835311] 'process raft request' (duration: 228.253343ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:54.114722Z","caller":"traceutil/trace.go:171","msg":"trace[1825745485] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"232.182736ms","start":"2026-05-05T22:10:53.882523Z","end":"2026-05-05T22:10:54.114706Z","steps":["trace[1825745485] 'process raft request' (duration: 231.634192ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:55.295519Z","caller":"traceutil/trace.go:171","msg":"trace[1404380631] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"164.627732ms","start":"2026-05-05T22:10:55.130847Z","end":"2026-05-05T22:10:55.295475Z","steps":["trace[1404380631] 'process raft request' (duration: 81.518169ms)","trace[1404380631] 'compare' (duration: 82.916802ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:11:04.243374Z","caller":"traceutil/trace.go:171","msg":"trace[1344315834] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"247.604199ms","start":"2026-05-05T22:11:03.995735Z","end":"2026-05-05T22:11:04.243339Z","steps":["trace[1344315834] 'process raft request' (duration: 247.376157ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:04.243566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.590988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T22:11:04.243676Z","caller":"traceutil/trace.go:171","msg":"trace[1945467259] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:426; }","duration":"119.765809ms","start":"2026-05-05T22:11:04.123889Z","end":"2026-05-05T22:11:04.243655Z","steps":["trace[1945467259] 'agreement among raft nodes before linearized reading' (duration: 119.562937ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:11:04.243308Z","caller":"traceutil/trace.go:171","msg":"trace[255957356] linearizableReadLoop","detail":"{readStateIndex:437; appliedIndex:436; }","duration":"119.332865ms","start":"2026-05-05T22:11:04.123942Z","end":"2026-05-05T22:11:04.243275Z","steps":["trace[255957356] 'read index received' (duration: 119.196744ms)","trace[255957356] 'applied index is now lower than readState.Index' (duration: 134.781µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:11:04.590862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.675207ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-05T22:11:04.591048Z","caller":"traceutil/trace.go:171","msg":"trace[284918754] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"339.532456ms","start":"2026-05-05T22:11:04.251494Z","end":"2026-05-05T22:11:04.591027Z","steps":["trace[284918754] 'process raft request' (duration: 198.582887ms)","trace[284918754] 'compare' (duration: 140.473605ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:11:04.591242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:04.251475Z","time spent":"339.698107ms","remote":"127.0.0.1:38338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3563,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T22:11:04.626724Z","caller":"traceutil/trace.go:171","msg":"trace[1543596417] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"375.106265ms","start":"2026-05-05T22:11:04.251584Z","end":"2026-05-05T22:11:04.62669Z","steps":["trace[1543596417] 'process raft request' (duration: 374.762903ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:11:04.626824Z","caller":"traceutil/trace.go:171","msg":"trace[865876019] linearizableReadLoop","detail":"{readStateIndex:440; appliedIndex:437; }","duration":"374.995794ms","start":"2026-05-05T22:11:04.251803Z","end":"2026-05-05T22:11:04.626798Z","steps":["trace[865876019] 'read index received' (duration: 198.320854ms)","trace[865876019] 'applied index is now lower than readState.Index' (duration: 176.67295ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:11:04.626918Z","caller":"traceutil/trace.go:171","msg":"trace[1593365254] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"375.314507ms","start":"2026-05-05T22:11:04.251595Z","end":"2026-05-05T22:11:04.626909Z","steps":["trace[1593365254] 'process raft request' (duration: 374.887944ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:04.627005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:04.251567Z","time spent":"375.376837ms","remote":"127.0.0.1:38238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":680,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T22:11:04.627102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.571334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T22:11:04.627132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:04.251567Z","time spent":"375.261616ms","remote":"127.0.0.1:38586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T22:11:04.627159Z","caller":"traceutil/trace.go:171","msg":"trace[381916481] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:429; }","duration":"381.650145ms","start":"2026-05-05T22:11:04.245493Z","end":"2026-05-05T22:11:04.627143Z","steps":["trace[381916481] 'agreement among raft nodes before linearized reading' (duration: 381.538794ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:04.627202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:04.245483Z","time spent":"381.711295ms","remote":"127.0.0.1:38142","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-05T22:11:04.627229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.882586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-05T22:11:04.627255Z","caller":"traceutil/trace.go:171","msg":"trace[1690144139] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:429; }","duration":"381.950487ms","start":"2026-05-05T22:11:04.245297Z","end":"2026-05-05T22:11:04.627248Z","steps":["trace[1690144139] 'agreement among raft nodes before linearized reading' (duration: 381.882086ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:04.62728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:04.245278Z","time spent":"381.997557ms","remote":"127.0.0.1:38426","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-05T22:11:04.931168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.581634ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-05T22:11:04.931426Z","caller":"traceutil/trace.go:171","msg":"trace[550145572] linearizableReadLoop","detail":"{readStateIndex:444; appliedIndex:440; }","duration":"304.538509ms","start":"2026-05-05T22:11:04.626871Z","end":"2026-05-05T22:11:04.93141Z","steps":["trace[550145572] 'read index received' (duration: 129.658143ms)","trace[550145572] 'applied index is now lower than readState.Index' (duration: 174.879516ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:11:04.931529Z","caller":"traceutil/trace.go:171","msg":"trace[1652290843] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"334.529168ms","start":"2026-05-05T22:11:04.596965Z","end":"2026-05-05T22:11:04.931494Z","steps":["trace[1652290843] 'process raft request' (duration: 334.374106ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:11:04.93158Z","caller":"traceutil/trace.go:171","msg":"trace[384830694] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"335.048942ms","start":"2026-05-05T22:11:04.596494Z","end":"2026-05-05T22:11:04.931543Z","steps":["trace[384830694] 'process raft request' (duration: 334.778709ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:04.931713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:04.596957Z","time spent":"334.674499ms","remote":"127.0.0.1:38238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T22:11:04.931771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:04.596488Z","time spent":"335.189183ms","remote":"127.0.0.1:38620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3795,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T22:11:04.931782Z","caller":"traceutil/trace.go:171","msg":"trace[1876893567] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"334.094296ms","start":"2026-05-05T22:11:04.597652Z","end":"2026-05-05T22:11:04.931747Z","steps":["trace[1876893567] 'process raft request' (duration: 333.717612ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:04.931816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.824364ms","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-05T22:11:04.931875Z","caller":"traceutil/trace.go:171","msg":"trace[1530658790] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:433; }","duration":"664.916245ms","start":"2026-05-05T22:11:04.266944Z","end":"2026-05-05T22:11:04.93186Z","steps":["trace[1530658790] 'agreement among raft nodes before linearized reading' (duration: 664.795804ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:04.93192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:04.266931Z","time spent":"664.977765ms","remote":"127.0.0.1:38426","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-05T22:11:04.931968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:04.597643Z","time spent":"334.216497ms","remote":"127.0.0.1:38338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4037,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T22:11:04.932062Z","caller":"traceutil/trace.go:171","msg":"trace[1339128589] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"336.15138ms","start":"2026-05-05T22:11:04.595878Z","end":"2026-05-05T22:11:04.93203Z","steps":["trace[1339128589] 'process raft request' (duration: 160.637318ms)","trace[1339128589] 'compare' (duration: 174.439913ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:11:04.932145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:04.595858Z","time spent":"336.25024ms","remote":"127.0.0.1:38238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T22:11:04.937103Z","caller":"traceutil/trace.go:171","msg":"trace[1537136466] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"305.837591ms","start":"2026-05-05T22:11:04.631252Z","end":"2026-05-05T22:11:04.93709Z","steps":["trace[1537136466] 'process raft request' (duration: 305.713929ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:04.937171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:04.631237Z","time spent":"305.899552ms","remote":"127.0.0.1:38426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T22:11:04.937447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.642706ms","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-05T22:11:04.93748Z","caller":"traceutil/trace.go:171","msg":"trace[41971252] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:435; }","duration":"236.704726ms","start":"2026-05-05T22:11:04.700768Z","end":"2026-05-05T22:11:04.937473Z","steps":["trace[41971252] 'agreement among raft nodes before linearized reading' (duration: 236.639536ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:11:04.937503Z","caller":"traceutil/trace.go:171","msg":"trace[1818330378] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"303.748255ms","start":"2026-05-05T22:11:04.633728Z","end":"2026-05-05T22:11:04.937476Z","steps":["trace[1818330378] 'process raft request' (duration: 303.321881ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:04.937611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:04.633702Z","time spent":"303.851546ms","remote":"127.0.0.1:38620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3804,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T22:11:05.277069Z","caller":"traceutil/trace.go:171","msg":"trace[930193717] transaction","detail":"{read_only:false; response_revision:441; number_of_response:1; }","duration":"259.893807ms","start":"2026-05-05T22:11:05.017146Z","end":"2026-05-05T22:11:05.27704Z","steps":["trace[930193717] 'process raft request' (duration: 194.755286ms)","trace[930193717] 'compare' (duration: 64.896669ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:11:05.277131Z","caller":"traceutil/trace.go:171","msg":"trace[1317990063] transaction","detail":"{read_only:false; number_of_response:1; response_revision:442; }","duration":"179.888963ms","start":"2026-05-05T22:11:05.097221Z","end":"2026-05-05T22:11:05.27711Z","steps":["trace[1317990063] 'process raft request' (duration: 179.731852ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:11:05.277278Z","caller":"traceutil/trace.go:171","msg":"trace[1907919109] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"178.638124ms","start":"2026-05-05T22:11:05.098634Z","end":"2026-05-05T22:11:05.277272Z","steps":["trace[1907919109] 'process raft request' (duration: 178.373142ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:11:16.449386Z","caller":"traceutil/trace.go:171","msg":"trace[1941613947] linearizableReadLoop","detail":"{readStateIndex:507; appliedIndex:505; }","duration":"229.901346ms","start":"2026-05-05T22:11:16.219451Z","end":"2026-05-05T22:11:16.449352Z","steps":["trace[1941613947] 'read index received' (duration: 220.729762ms)","trace[1941613947] 'applied index is now lower than readState.Index' (duration: 9.170114ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:11:16.449619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.127778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.222\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-05T22:11:16.449922Z","caller":"traceutil/trace.go:171","msg":"trace[1168427144] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"236.553802ms","start":"2026-05-05T22:11:16.213331Z","end":"2026-05-05T22:11:16.449885Z","steps":["trace[1168427144] 'process raft request' (duration: 226.846344ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:11:16.449937Z","caller":"traceutil/trace.go:171","msg":"trace[1784938819] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"235.706237ms","start":"2026-05-05T22:11:16.214181Z","end":"2026-05-05T22:11:16.449887Z","steps":["trace[1784938819] 'process raft request' (duration: 235.120043ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:11:16.449753Z","caller":"traceutil/trace.go:171","msg":"trace[329339434] range","detail":"{range_begin:/registry/masterleases/199.204.45.222; range_end:; response_count:1; response_revision:494; }","duration":"230.245178ms","start":"2026-05-05T22:11:16.21942Z","end":"2026-05-05T22:11:16.449665Z","steps":["trace[329339434] 'agreement among raft nodes before linearized reading' (duration: 230.062307ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:11:17.445365Z","caller":"traceutil/trace.go:171","msg":"trace[1593655337] linearizableReadLoop","detail":"{readStateIndex:533; appliedIndex:532; }","duration":"384.4261ms","start":"2026-05-05T22:11:17.060901Z","end":"2026-05-05T22:11:17.445327Z","steps":["trace[1593655337] 'read index received' (duration: 384.082367ms)","trace[1593655337] 'applied index is now lower than readState.Index' (duration: 342.093µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:11:17.445612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.671352ms","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-05T22:11:17.445652Z","caller":"traceutil/trace.go:171","msg":"trace[415269118] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:519; }","duration":"384.765782ms","start":"2026-05-05T22:11:17.060874Z","end":"2026-05-05T22:11:17.445639Z","steps":["trace[415269118] 'agreement among raft nodes before linearized reading' (duration: 384.598561ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:17.445693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:17.060862Z","time spent":"384.821092ms","remote":"127.0.0.1:38426","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-05T22:11:17.446048Z","caller":"traceutil/trace.go:171","msg":"trace[235195470] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"395.765297ms","start":"2026-05-05T22:11:17.050244Z","end":"2026-05-05T22:11:17.446009Z","steps":["trace[235195470] 'process raft request' (duration: 394.897752ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:17.446224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:17.050231Z","time spent":"395.906478ms","remote":"127.0.0.1:38426","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-05T22:11:17.919203Z","caller":"traceutil/trace.go:171","msg":"trace[987599869] linearizableReadLoop","detail":"{readStateIndex:534; appliedIndex:533; }","duration":"259.654283ms","start":"2026-05-05T22:11:17.659524Z","end":"2026-05-05T22:11:17.919178Z","steps":["trace[987599869] 'read index received' (duration: 219.0064ms)","trace[987599869] 'applied index is now lower than readState.Index' (duration: 40.646523ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:11:17.919363Z","caller":"traceutil/trace.go:171","msg":"trace[1100048576] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"468.992447ms","start":"2026-05-05T22:11:17.450349Z","end":"2026-05-05T22:11:17.919341Z","steps":["trace[1100048576] 'process raft request' (duration: 428.311774ms)","trace[1100048576] 'compare' (duration: 40.30767ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:11:17.91948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:17.450328Z","time spent":"469.062887ms","remote":"127.0.0.1:38426","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-05T22:11:17.919726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.205797ms","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-05T22:11:17.919778Z","caller":"traceutil/trace.go:171","msg":"trace[1592081343] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:520; }","duration":"260.321787ms","start":"2026-05-05T22:11:17.659444Z","end":"2026-05-05T22:11:17.919766Z","steps":["trace[1592081343] 'agreement among raft nodes before linearized reading' (duration: 260.217587ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:17.919973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.907474ms","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-05T22:11:17.920057Z","caller":"traceutil/trace.go:171","msg":"trace[204926034] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:520; }","duration":"224.057165ms","start":"2026-05-05T22:11:17.695981Z","end":"2026-05-05T22:11:17.920039Z","steps":["trace[204926034] 'agreement among raft nodes before linearized reading' (duration: 223.421031ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:19.525782Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118177821312618,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T22:11:19.83324Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.107336522s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-05T22:11:19.837352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.889938ms","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-05T22:11:19.837442Z","caller":"traceutil/trace.go:171","msg":"trace[1011187160] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:568; }","duration":"366.995259ms","start":"2026-05-05T22:11:19.470428Z","end":"2026-05-05T22:11:19.837424Z","steps":["trace[1011187160] 'range keys from in-memory index tree' (duration: 366.873958ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:11:19.837871Z","caller":"traceutil/trace.go:171","msg":"trace[589154452] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"1.112168246s","start":"2026-05-05T22:11:18.725694Z","end":"2026-05-05T22:11:19.837862Z","steps":["trace[589154452] 'process raft request' (duration: 1.107894156s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:19.837959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:18.725669Z","time spent":"1.112227886s","remote":"127.0.0.1:38210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80679,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T22:11:19.842384Z","caller":"traceutil/trace.go:171","msg":"trace[1748925428] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"1.113405474s","start":"2026-05-05T22:11:18.728882Z","end":"2026-05-05T22:11:19.842287Z","steps":["trace[1748925428] 'process raft request' (duration: 1.112614709s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:19.842869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:18.728854Z","time spent":"1.113746546s","remote":"127.0.0.1:38210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59616,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T22:11:19.843173Z","caller":"traceutil/trace.go:171","msg":"trace[451319600] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"1.076115167s","start":"2026-05-05T22:11:18.767016Z","end":"2026-05-05T22:11:19.843131Z","steps":["trace[451319600] 'process raft request' (duration: 1.074738948s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:19.843351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:18.766993Z","time spent":"1.076272058s","remote":"127.0.0.1:38210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T22:11:19.843539Z","caller":"traceutil/trace.go:171","msg":"trace[665647356] linearizableReadLoop","detail":"{readStateIndex:588; appliedIndex:584; }","duration":"818.450419ms","start":"2026-05-05T22:11:19.025072Z","end":"2026-05-05T22:11:19.843523Z","steps":["trace[665647356] 'read index received' (duration: 808.41122ms)","trace[665647356] 'applied index is now lower than readState.Index' (duration: 10.038189ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:11:19.843706Z","caller":"traceutil/trace.go:171","msg":"trace[1189242916] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"597.841054ms","start":"2026-05-05T22:11:19.245854Z","end":"2026-05-05T22:11:19.843695Z","steps":["trace[1189242916] 'process raft request' (duration: 596.022301ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:19.843823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:19.245798Z","time spent":"597.985426ms","remote":"127.0.0.1:38426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T22:11:19.843877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"818.806251ms","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-05T22:11:19.843906Z","caller":"traceutil/trace.go:171","msg":"trace[789606845] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:572; }","duration":"818.864281ms","start":"2026-05-05T22:11:19.025032Z","end":"2026-05-05T22:11:19.843896Z","steps":["trace[789606845] 'agreement among raft nodes before linearized reading' (duration: 818.826061ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:19.843933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:19.02501Z","time spent":"818.918122ms","remote":"127.0.0.1:38426","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-05T22:11:19.843834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.691216ms","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-05T22:11:19.844154Z","caller":"traceutil/trace.go:171","msg":"trace[1295664155] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:572; }","duration":"393.051638ms","start":"2026-05-05T22:11:19.451088Z","end":"2026-05-05T22:11:19.84414Z","steps":["trace[1295664155] 'agreement among raft nodes before linearized reading' (duration: 392.699256ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:19.844996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:19.451066Z","time spent":"393.915623ms","remote":"127.0.0.1:38426","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-05T22:11:26.383801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.183125ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T22:11:26.383923Z","caller":"traceutil/trace.go:171","msg":"trace[1294171] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"459.359578ms","start":"2026-05-05T22:11:25.924535Z","end":"2026-05-05T22:11:26.383894Z","steps":["trace[1294171] 'process raft request' (duration: 211.007912ms)","trace[1294171] 'compare' (duration: 248.045404ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:11:26.383984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:25.924518Z","time spent":"459.437899ms","remote":"127.0.0.1:38426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T22:11:27.566464Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.4290637s","expected-duration":"1s"} {"level":"info","ts":"2026-05-05T22:11:27.567039Z","caller":"traceutil/trace.go:171","msg":"trace[495355101] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"1.640651745s","start":"2026-05-05T22:11:25.926279Z","end":"2026-05-05T22:11:27.56693Z","steps":["trace[495355101] 'process raft request' (duration: 1.640338793s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:27.567278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:25.926262Z","time spent":"1.640877136s","remote":"127.0.0.1:38426","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-05T22:11:27.567684Z","caller":"traceutil/trace.go:171","msg":"trace[587191896] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:646; }","duration":"1.578238499s","start":"2026-05-05T22:11:25.98942Z","end":"2026-05-05T22:11:27.567658Z","steps":["trace[587191896] 'read index received' (duration: 146.181849ms)","trace[587191896] 'applied index is now lower than readState.Index' (duration: 1.43205557s)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:11:27.568137Z","caller":"traceutil/trace.go:171","msg":"trace[1093080800] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"1.473951597s","start":"2026-05-05T22:11:26.094163Z","end":"2026-05-05T22:11:27.568114Z","steps":["trace[1093080800] 'process raft request' (duration: 1.47282231s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:27.568283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:26.094144Z","time spent":"1.474038208s","remote":"127.0.0.1:38254","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-05T22:11:27.568712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.579236435s","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-05T22:11:27.568852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.404092964s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-gcz5k\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-05T22:11:27.56889Z","caller":"traceutil/trace.go:171","msg":"trace[561741642] range","detail":"{range_begin:/registry/pods/kube-system/cilium-gcz5k; range_end:; response_count:1; response_revision:632; }","duration":"1.404167154s","start":"2026-05-05T22:11:26.164712Z","end":"2026-05-05T22:11:27.568879Z","steps":["trace[561741642] 'agreement among raft nodes before linearized reading' (duration: 1.404070754s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:27.568921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:26.164692Z","time spent":"1.404222144s","remote":"127.0.0.1:38338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-gcz5k\" "} {"level":"info","ts":"2026-05-05T22:11:27.569Z","caller":"traceutil/trace.go:171","msg":"trace[844452878] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:632; }","duration":"1.579589627s","start":"2026-05-05T22:11:25.989385Z","end":"2026-05-05T22:11:27.568975Z","steps":["trace[844452878] 'agreement among raft nodes before linearized reading' (duration: 1.578885582s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:27.569197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:25.989366Z","time spent":"1.57981199s","remote":"127.0.0.1:38426","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-05T22:11:27.569305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.579760359s","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-05T22:11:27.569347Z","caller":"traceutil/trace.go:171","msg":"trace[293396373] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:632; }","duration":"1.57985821s","start":"2026-05-05T22:11:25.989477Z","end":"2026-05-05T22:11:27.569335Z","steps":["trace[293396373] 'agreement among raft nodes before linearized reading' (duration: 1.579184515s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:27.5694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:25.989453Z","time spent":"1.57993709s","remote":"127.0.0.1:38426","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-05T22:11:27.568745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.348510195s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.222\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-05T22:11:27.569526Z","caller":"traceutil/trace.go:171","msg":"trace[1997567399] range","detail":"{range_begin:/registry/masterleases/199.204.45.222; range_end:; response_count:1; response_revision:632; }","duration":"1.349321751s","start":"2026-05-05T22:11:26.220171Z","end":"2026-05-05T22:11:27.569492Z","steps":["trace[1997567399] 'agreement among raft nodes before linearized reading' (duration: 1.348533135s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:27.56961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:26.220147Z","time spent":"1.349443272s","remote":"127.0.0.1:38186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.222\" "} {"level":"warn","ts":"2026-05-05T22:11:27.569219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.443363895s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T22:11:27.569731Z","caller":"traceutil/trace.go:171","msg":"trace[1454941405] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:632; }","duration":"1.443929269s","start":"2026-05-05T22:11:26.125791Z","end":"2026-05-05T22:11:27.56972Z","steps":["trace[1454941405] 'agreement among raft nodes before linearized reading' (duration: 1.443364285s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:27.569772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:26.125767Z","time spent":"1.443995549s","remote":"127.0.0.1:38142","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-05T22:11:28.147763Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118177821312848,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T22:11:28.648538Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118177821312848,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T22:11:29.148653Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118177821312848,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T22:11:29.634289Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.987590336s","expected-duration":"1s"} {"level":"info","ts":"2026-05-05T22:11:29.634837Z","caller":"traceutil/trace.go:171","msg":"trace[149675729] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:652; }","duration":"1.987442616s","start":"2026-05-05T22:11:27.647371Z","end":"2026-05-05T22:11:29.634814Z","steps":["trace[149675729] 'read index received' (duration: 1.987068643s)","trace[149675729] 'applied index is now lower than readState.Index' (duration: 373.143µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:11:29.634827Z","caller":"traceutil/trace.go:171","msg":"trace[1206363047] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"2.05026894s","start":"2026-05-05T22:11:27.584518Z","end":"2026-05-05T22:11:29.634787Z","steps":["trace[1206363047] 'process raft request' (duration: 2.050010468s)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:11:29.635408Z","caller":"traceutil/trace.go:171","msg":"trace[1285793901] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"2.00786304s","start":"2026-05-05T22:11:27.627496Z","end":"2026-05-05T22:11:29.635359Z","steps":["trace[1285793901] 'process raft request' (duration: 2.007279317s)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:11:29.635286Z","caller":"traceutil/trace.go:171","msg":"trace[1520771511] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"2.045704869s","start":"2026-05-05T22:11:27.589202Z","end":"2026-05-05T22:11:29.634907Z","steps":["trace[1520771511] 'process raft request' (duration: 2.045518928s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:29.635596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:27.62747Z","time spent":"2.008036031s","remote":"127.0.0.1:38398","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-05T22:11:29.635692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:27.584495Z","time spent":"2.05043116s","remote":"127.0.0.1:38186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T22:11:29.635729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:27.589183Z","time spent":"2.046411374s","remote":"127.0.0.1:38338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T22:11:29.635514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.98813229s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T22:11:29.635943Z","caller":"traceutil/trace.go:171","msg":"trace[689419692] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:637; }","duration":"1.988590972s","start":"2026-05-05T22:11:27.647309Z","end":"2026-05-05T22:11:29.6359Z","steps":["trace[689419692] 'agreement among raft nodes before linearized reading' (duration: 1.988069469s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:29.636031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:27.647273Z","time spent":"1.988727733s","remote":"127.0.0.1:38142","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-05T22:11:29.636094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.247719152s","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-05T22:11:29.636159Z","caller":"traceutil/trace.go:171","msg":"trace[1235973721] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:637; }","duration":"1.247817573s","start":"2026-05-05T22:11:28.388326Z","end":"2026-05-05T22:11:29.636143Z","steps":["trace[1235973721] 'agreement among raft nodes before linearized reading' (duration: 1.247539851s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:29.636205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:28.388306Z","time spent":"1.247880673s","remote":"127.0.0.1:38426","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-05T22:11:29.63637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.969222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T22:11:29.636454Z","caller":"traceutil/trace.go:171","msg":"trace[2023068894] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:637; }","duration":"546.073604ms","start":"2026-05-05T22:11:29.090347Z","end":"2026-05-05T22:11:29.63642Z","steps":["trace[2023068894] 'agreement among raft nodes before linearized reading' (duration: 545.975422ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:29.636508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:29.090326Z","time spent":"546.168474ms","remote":"127.0.0.1:38140","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-05T22:11:29.750241Z","caller":"traceutil/trace.go:171","msg":"trace[925178806] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"106.739659ms","start":"2026-05-05T22:11:29.64347Z","end":"2026-05-05T22:11:29.750209Z","steps":["trace[925178806] 'process raft request' (duration: 105.730282ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:29.750654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.429237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-05-05T22:11:29.7507Z","caller":"traceutil/trace.go:171","msg":"trace[551963707] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:638; }","duration":"106.519688ms","start":"2026-05-05T22:11:29.644168Z","end":"2026-05-05T22:11:29.750688Z","steps":["trace[551963707] 'agreement among raft nodes before linearized reading' (duration: 106.422967ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:11:29.753415Z","caller":"traceutil/trace.go:171","msg":"trace[839550943] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"108.225688ms","start":"2026-05-05T22:11:29.645157Z","end":"2026-05-05T22:11:29.753382Z","steps":["trace[839550943] 'process raft request' (duration: 108.072437ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:11:29.749918Z","caller":"traceutil/trace.go:171","msg":"trace[1120298585] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:655; }","duration":"105.683843ms","start":"2026-05-05T22:11:29.644205Z","end":"2026-05-05T22:11:29.749889Z","steps":["trace[1120298585] 'read index received' (duration: 104.991228ms)","trace[1120298585] 'applied index is now lower than readState.Index' (duration: 691.625µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:11:29.754809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.249362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-05T22:11:29.754844Z","caller":"traceutil/trace.go:171","msg":"trace[1468562734] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:639; }","duration":"110.300862ms","start":"2026-05-05T22:11:29.644533Z","end":"2026-05-05T22:11:29.754834Z","steps":["trace[1468562734] 'agreement among raft nodes before linearized reading' (duration: 110.161411ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:29.754914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.517362ms","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-05T22:11:29.754977Z","caller":"traceutil/trace.go:171","msg":"trace[1585363967] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:639; }","duration":"105.603462ms","start":"2026-05-05T22:11:29.649357Z","end":"2026-05-05T22:11:29.754961Z","steps":["trace[1585363967] 'agreement among raft nodes before linearized reading' (duration: 105.397181ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:29.755001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.511421ms","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-05T22:11:29.755071Z","caller":"traceutil/trace.go:171","msg":"trace[1546917446] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:639; }","duration":"105.601672ms","start":"2026-05-05T22:11:29.649455Z","end":"2026-05-05T22:11:29.755056Z","steps":["trace[1546917446] 'agreement among raft nodes before linearized reading' (duration: 105.432941ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:29.755936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.666238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-gcz5k\" ","response":"range_response_count:1 size:17149"} {"level":"info","ts":"2026-05-05T22:11:29.756106Z","caller":"traceutil/trace.go:171","msg":"trace[857028906] range","detail":"{range_begin:/registry/pods/kube-system/cilium-gcz5k; range_end:; response_count:1; response_revision:639; }","duration":"110.346672ms","start":"2026-05-05T22:11:29.645682Z","end":"2026-05-05T22:11:29.756029Z","steps":["trace[857028906] 'agreement among raft nodes before linearized reading' (duration: 109.224885ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:29.757783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.54479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T22:11:29.757842Z","caller":"traceutil/trace.go:171","msg":"trace[692189860] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:639; }","duration":"111.607561ms","start":"2026-05-05T22:11:29.646221Z","end":"2026-05-05T22:11:29.757829Z","steps":["trace[692189860] 'agreement among raft nodes before linearized reading' (duration: 108.630051ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:11:31.798654Z","caller":"traceutil/trace.go:171","msg":"trace[1397075321] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"275.553228ms","start":"2026-05-05T22:11:31.52302Z","end":"2026-05-05T22:11:31.798573Z","steps":["trace[1397075321] 'process raft request' (duration: 275.414927ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:11:38.02682Z","caller":"traceutil/trace.go:171","msg":"trace[1829253492] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"155.230884ms","start":"2026-05-05T22:11:37.87155Z","end":"2026-05-05T22:11:38.026781Z","steps":["trace[1829253492] 'process raft request' (duration: 111.561009ms)","trace[1829253492] 'compare' (duration: 43.426113ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:11:38.026993Z","caller":"traceutil/trace.go:171","msg":"trace[2127682345] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"154.432164ms","start":"2026-05-05T22:11:37.872525Z","end":"2026-05-05T22:11:38.026957Z","steps":["trace[2127682345] 'process raft request' (duration: 154.201553ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:11:44.81647Z","caller":"traceutil/trace.go:171","msg":"trace[1732387938] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"464.395542ms","start":"2026-05-05T22:11:44.352051Z","end":"2026-05-05T22:11:44.816446Z","steps":["trace[1732387938] 'process raft request' (duration: 464.239075ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:44.816631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:44.352015Z","time spent":"464.526818ms","remote":"127.0.0.1:38426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T22:11:45.586749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.556976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T22:11:45.586835Z","caller":"traceutil/trace.go:171","msg":"trace[865665917] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:802; }","duration":"461.689631ms","start":"2026-05-05T22:11:45.125121Z","end":"2026-05-05T22:11:45.58681Z","steps":["trace[865665917] 'range keys from in-memory index tree' (duration: 461.465151ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:45.586877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:45.125099Z","time spent":"461.770784ms","remote":"127.0.0.1:38140","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-05T22:11:45.58747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.365583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-05T22:11:45.58756Z","caller":"traceutil/trace.go:171","msg":"trace[441727343] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:802; }","duration":"348.521991ms","start":"2026-05-05T22:11:45.23902Z","end":"2026-05-05T22:11:45.587542Z","steps":["trace[441727343] 'range keys from in-memory index tree' (duration: 348.167774ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:45.587669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:45.238997Z","time spent":"348.598425ms","remote":"127.0.0.1:38426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-05T22:11:45.588965Z","caller":"traceutil/trace.go:171","msg":"trace[1780330761] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"304.811715ms","start":"2026-05-05T22:11:45.284141Z","end":"2026-05-05T22:11:45.588953Z","steps":["trace[1780330761] 'process raft request' (duration: 304.686169ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:45.589079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:11:45.284112Z","time spent":"304.896088ms","remote":"127.0.0.1:38398","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-05T22:12:02.203075Z","caller":"traceutil/trace.go:171","msg":"trace[618754821] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"155.183478ms","start":"2026-05-05T22:12:02.047863Z","end":"2026-05-05T22:12:02.203046Z","steps":["trace[618754821] 'process raft request' (duration: 154.799503ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:14:10.47896Z","caller":"traceutil/trace.go:171","msg":"trace[972455252] transaction","detail":"{read_only:false; response_revision:1457; number_of_response:1; }","duration":"119.468475ms","start":"2026-05-05T22:14:10.359452Z","end":"2026-05-05T22:14:10.47892Z","steps":["trace[972455252] 'process raft request' (duration: 119.254412ms)"],"step_count":1}