{"level":"warn","ts":"2026-06-24T00:48:02.802513Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-24T00:48:02.802622Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.53: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.53:2380","--initial-cluster=instance=https://199.204.45.53:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.53:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.53:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-24T00:48:02.802718Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-24T00:48:02.802737Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-06-24T00:48:02.802765Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-24T00:48:02.803653Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"]} {"level":"info","ts":"2026-06-24T00:48:02.803771Z","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.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.53:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-24T00:48:03.019017Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"214.958556ms"} {"level":"info","ts":"2026-06-24T00:48:03.611684Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c47ca1a7b1fe506b","cluster-id":"95bd21e158fabf07"} {"level":"info","ts":"2026-06-24T00:48:03.611837Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=()"} {"level":"info","ts":"2026-06-24T00:48:03.611872Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 0"} {"level":"info","ts":"2026-06-24T00:48:03.611887Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c47ca1a7b1fe506b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-24T00:48:03.61191Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 1"} {"level":"info","ts":"2026-06-24T00:48:03.611966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"warn","ts":"2026-06-24T00:48:03.619767Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-24T00:48:03.622451Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-24T00:48:03.633169Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-24T00:48:03.644717Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c47ca1a7b1fe506b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-24T00:48:03.644931Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-24T00:48:03.645002Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-24T00:48:03.645017Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-24T00:48:03.645372Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c47ca1a7b1fe506b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-24T00:48:03.651763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"info","ts":"2026-06-24T00:48:03.652124Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","added-peer-id":"c47ca1a7b1fe506b","added-peer-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-06-24T00:48:03.652472Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-24T00:48:03.652613Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-06-24T00:48:03.652685Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-06-24T00:48:03.652888Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c47ca1a7b1fe506b","initial-advertise-peer-urls":["https://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-24T00:48:03.652941Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-24T00:48:04.616187Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b is starting a new election at term 1"} {"level":"info","ts":"2026-06-24T00:48:04.616276Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became pre-candidate at term 1"} {"level":"info","ts":"2026-06-24T00:48:04.616306Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgPreVoteResp from c47ca1a7b1fe506b at term 1"} {"level":"info","ts":"2026-06-24T00:48:04.616327Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became candidate at term 2"} {"level":"info","ts":"2026-06-24T00:48:04.616336Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgVoteResp from c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-06-24T00:48:04.616362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became leader at term 2"} {"level":"info","ts":"2026-06-24T00:48:04.616375Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c47ca1a7b1fe506b elected leader c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-06-24T00:48:04.619648Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T00:48:04.621569Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c47ca1a7b1fe506b","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.53:2379]}","request-path":"/0/members/c47ca1a7b1fe506b/attributes","cluster-id":"95bd21e158fabf07","publish-timeout":"7s"} {"level":"info","ts":"2026-06-24T00:48:04.621589Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T00:48:04.62157Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T00:48:04.621853Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-24T00:48:04.62188Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-24T00:48:04.623517Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.53:2379"} {"level":"info","ts":"2026-06-24T00:48:04.624304Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-24T00:48:04.640689Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T00:48:04.640857Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T00:48:04.640909Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T00:48:07.560294Z","caller":"traceutil/trace.go:171","msg":"trace[651653515] transaction","detail":"{read_only:false; response_revision:153; number_of_response:1; }","duration":"182.626461ms","start":"2026-06-24T00:48:07.377638Z","end":"2026-06-24T00:48:07.560265Z","steps":["trace[651653515] 'process raft request' (duration: 119.141585ms)","trace[651653515] 'compare' (duration: 63.326185ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:48:09.594999Z","caller":"traceutil/trace.go:171","msg":"trace[1530486794] transaction","detail":"{read_only:false; response_revision:232; number_of_response:1; }","duration":"108.770358ms","start":"2026-06-24T00:48:09.4862Z","end":"2026-06-24T00:48:09.59497Z","steps":["trace[1530486794] 'process raft request' (duration: 108.604477ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:09.640014Z","caller":"traceutil/trace.go:171","msg":"trace[1744346678] transaction","detail":"{read_only:false; response_revision:233; number_of_response:1; }","duration":"135.253743ms","start":"2026-06-24T00:48:09.504724Z","end":"2026-06-24T00:48:09.639977Z","steps":["trace[1744346678] 'process raft request' (duration: 134.932691ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:10.347637Z","caller":"traceutil/trace.go:171","msg":"trace[764622436] transaction","detail":"{read_only:false; response_revision:256; number_of_response:1; }","duration":"116.63818ms","start":"2026-06-24T00:48:10.230958Z","end":"2026-06-24T00:48:10.347596Z","steps":["trace[764622436] 'process raft request' (duration: 53.523052ms)","trace[764622436] 'compare' (duration: 62.477904ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:48:10.347789Z","caller":"traceutil/trace.go:171","msg":"trace[987545262] transaction","detail":"{read_only:false; response_revision:257; number_of_response:1; }","duration":"116.125317ms","start":"2026-06-24T00:48:10.231631Z","end":"2026-06-24T00:48:10.347757Z","steps":["trace[987545262] 'process raft request' (duration: 115.647944ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:10.375008Z","caller":"traceutil/trace.go:171","msg":"trace[30586240] transaction","detail":"{read_only:false; number_of_response:0; response_revision:259; }","duration":"109.434369ms","start":"2026-06-24T00:48:10.265559Z","end":"2026-06-24T00:48:10.374994Z","steps":["trace[30586240] 'process raft request' (duration: 109.397229ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:10.375046Z","caller":"traceutil/trace.go:171","msg":"trace[893250790] transaction","detail":"{read_only:false; response_revision:258; number_of_response:1; }","duration":"121.813641ms","start":"2026-06-24T00:48:10.253213Z","end":"2026-06-24T00:48:10.375026Z","steps":["trace[893250790] 'process raft request' (duration: 121.54347ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:10.375052Z","caller":"traceutil/trace.go:171","msg":"trace[1512967095] transaction","detail":"{read_only:false; response_revision:259; number_of_response:1; }","duration":"109.812681ms","start":"2026-06-24T00:48:10.26522Z","end":"2026-06-24T00:48:10.375032Z","steps":["trace[1512967095] 'process raft request' (duration: 109.690221ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:10.628372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.004784ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T00:48:10.628642Z","caller":"traceutil/trace.go:171","msg":"trace[156922805] linearizableReadLoop","detail":"{readStateIndex:275; appliedIndex:273; }","duration":"191.783579ms","start":"2026-06-24T00:48:10.43684Z","end":"2026-06-24T00:48:10.628624Z","steps":["trace[156922805] 'read index received' (duration: 42.90681ms)","trace[156922805] 'applied index is now lower than readState.Index' (duration: 148.875409ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:48:10.628752Z","caller":"traceutil/trace.go:171","msg":"trace[522306881] transaction","detail":"{read_only:false; response_revision:263; number_of_response:1; }","duration":"238.756233ms","start":"2026-06-24T00:48:10.389969Z","end":"2026-06-24T00:48:10.628725Z","steps":["trace[522306881] 'process raft request' (duration: 89.763363ms)","trace[522306881] 'compare' (duration: 147.761713ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:48:10.628853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.67418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3466"} {"level":"info","ts":"2026-06-24T00:48:10.628895Z","caller":"traceutil/trace.go:171","msg":"trace[1062620543] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:264; }","duration":"241.772331ms","start":"2026-06-24T00:48:10.387111Z","end":"2026-06-24T00:48:10.628883Z","steps":["trace[1062620543] 'agreement among raft nodes before linearized reading' (duration: 241.61763ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:10.628952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.960052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:5513"} {"level":"info","ts":"2026-06-24T00:48:10.62903Z","caller":"traceutil/trace.go:171","msg":"trace[1349475490] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:264; }","duration":"242.081992ms","start":"2026-06-24T00:48:10.386929Z","end":"2026-06-24T00:48:10.629011Z","steps":["trace[1349475490] 'agreement among raft nodes before linearized reading' (duration: 241.908801ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:10.629099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.975452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3972"} {"level":"info","ts":"2026-06-24T00:48:10.629159Z","caller":"traceutil/trace.go:171","msg":"trace[1325668976] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:264; }","duration":"242.065362ms","start":"2026-06-24T00:48:10.38707Z","end":"2026-06-24T00:48:10.629136Z","steps":["trace[1325668976] 'agreement among raft nodes before linearized reading' (duration: 241.982612ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:10.629451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.377545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2920"} {"level":"info","ts":"2026-06-24T00:48:10.630202Z","caller":"traceutil/trace.go:171","msg":"trace[2133475805] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:264; }","duration":"243.295799ms","start":"2026-06-24T00:48:10.386884Z","end":"2026-06-24T00:48:10.63018Z","steps":["trace[2133475805] 'agreement among raft nodes before linearized reading' (duration: 241.908051ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:10.630045Z","caller":"traceutil/trace.go:171","msg":"trace[2054867972] transaction","detail":"{read_only:false; response_revision:264; number_of_response:1; }","duration":"238.383041ms","start":"2026-06-24T00:48:10.390287Z","end":"2026-06-24T00:48:10.62867Z","steps":["trace[2054867972] 'process raft request' (duration: 238.19188ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:10.645537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.203187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"warn","ts":"2026-06-24T00:48:10.645531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.946625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4016"} {"level":"info","ts":"2026-06-24T00:48:10.645577Z","caller":"traceutil/trace.go:171","msg":"trace[443759462] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:265; }","duration":"205.283188ms","start":"2026-06-24T00:48:10.440283Z","end":"2026-06-24T00:48:10.645567Z","steps":["trace[443759462] 'agreement among raft nodes before linearized reading' (duration: 205.179037ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:10.645597Z","caller":"traceutil/trace.go:171","msg":"trace[2142190411] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:265; }","duration":"205.052217ms","start":"2026-06-24T00:48:10.440528Z","end":"2026-06-24T00:48:10.64558Z","steps":["trace[2142190411] 'agreement among raft nodes before linearized reading' (duration: 204.927376ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:10.64568Z","caller":"traceutil/trace.go:171","msg":"trace[2139159194] transaction","detail":"{read_only:false; response_revision:265; number_of_response:1; }","duration":"205.027646ms","start":"2026-06-24T00:48:10.440634Z","end":"2026-06-24T00:48:10.645662Z","steps":["trace[2139159194] 'process raft request' (duration: 204.698264ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:10.890557Z","caller":"traceutil/trace.go:171","msg":"trace[54058860] transaction","detail":"{read_only:false; response_revision:270; number_of_response:1; }","duration":"235.914947ms","start":"2026-06-24T00:48:10.654429Z","end":"2026-06-24T00:48:10.890344Z","steps":["trace[54058860] 'process raft request' (duration: 203.81038ms)","trace[54058860] 'compare' (duration: 30.121936ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:48:10.891025Z","caller":"traceutil/trace.go:171","msg":"trace[2066994118] transaction","detail":"{read_only:false; response_revision:271; number_of_response:1; }","duration":"234.544518ms","start":"2026-06-24T00:48:10.656379Z","end":"2026-06-24T00:48:10.890923Z","steps":["trace[2066994118] 'process raft request' (duration: 232.311575ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:10.894896Z","caller":"traceutil/trace.go:171","msg":"trace[1142428655] linearizableReadLoop","detail":"{readStateIndex:283; appliedIndex:280; }","duration":"167.820779ms","start":"2026-06-24T00:48:10.727022Z","end":"2026-06-24T00:48:10.894843Z","steps":["trace[1142428655] 'read index received' (duration: 131.164516ms)","trace[1142428655] 'applied index is now lower than readState.Index' (duration: 36.654343ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:48:10.894984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.94544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslicemirroring-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:48:10.894884Z","caller":"traceutil/trace.go:171","msg":"trace[1333674071] transaction","detail":"{read_only:false; response_revision:272; number_of_response:1; }","duration":"237.654856ms","start":"2026-06-24T00:48:10.657196Z","end":"2026-06-24T00:48:10.894851Z","steps":["trace[1333674071] 'process raft request' (duration: 237.431745ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:10.89507Z","caller":"traceutil/trace.go:171","msg":"trace[1244933954] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslicemirroring-controller; range_end:; response_count:0; response_revision:272; }","duration":"168.05031ms","start":"2026-06-24T00:48:10.726979Z","end":"2026-06-24T00:48:10.89503Z","steps":["trace[1244933954] 'agreement among raft nodes before linearized reading' (duration: 167.94308ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:11.134062Z","caller":"traceutil/trace.go:171","msg":"trace[331107073] transaction","detail":"{read_only:false; response_revision:276; number_of_response:1; }","duration":"145.266024ms","start":"2026-06-24T00:48:10.988776Z","end":"2026-06-24T00:48:11.134042Z","steps":["trace[331107073] 'process raft request' (duration: 145.153163ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:11.136292Z","caller":"traceutil/trace.go:171","msg":"trace[1857185003] transaction","detail":"{read_only:false; response_revision:277; number_of_response:1; }","duration":"145.329955ms","start":"2026-06-24T00:48:10.990943Z","end":"2026-06-24T00:48:11.136273Z","steps":["trace[1857185003] 'process raft request' (duration: 145.233884ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:11.354838Z","caller":"traceutil/trace.go:171","msg":"trace[1654768463] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"107.520584ms","start":"2026-06-24T00:48:11.247267Z","end":"2026-06-24T00:48:11.354788Z","steps":["trace[1654768463] 'process raft request' (duration: 107.283633ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:11.480818Z","caller":"traceutil/trace.go:171","msg":"trace[1270882857] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"108.852472ms","start":"2026-06-24T00:48:11.371942Z","end":"2026-06-24T00:48:11.480795Z","steps":["trace[1270882857] 'process raft request' (duration: 67.950415ms)","trace[1270882857] 'compare' (duration: 40.582255ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:48:11.803228Z","caller":"traceutil/trace.go:171","msg":"trace[1299338927] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"221.480806ms","start":"2026-06-24T00:48:11.581728Z","end":"2026-06-24T00:48:11.803209Z","steps":["trace[1299338927] 'process raft request' (duration: 200.582985ms)","trace[1299338927] 'compare' (duration: 20.620489ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:48:11.803327Z","caller":"traceutil/trace.go:171","msg":"trace[937564539] transaction","detail":"{read_only:false; response_revision:288; number_of_response:1; }","duration":"199.800361ms","start":"2026-06-24T00:48:11.603503Z","end":"2026-06-24T00:48:11.803303Z","steps":["trace[937564539] 'process raft request' (duration: 199.520219ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:12.226774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.200165ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T00:48:12.226915Z","caller":"traceutil/trace.go:171","msg":"trace[818459700] linearizableReadLoop","detail":"{readStateIndex:306; appliedIndex:305; }","duration":"373.940346ms","start":"2026-06-24T00:48:11.852954Z","end":"2026-06-24T00:48:12.226894Z","steps":["trace[818459700] 'read index received' (duration: 84.291029ms)","trace[818459700] 'applied index is now lower than readState.Index' (duration: 289.647917ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:48:12.227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.046396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:48:12.22701Z","caller":"traceutil/trace.go:171","msg":"trace[928821380] transaction","detail":"{read_only:false; response_revision:291; number_of_response:1; }","duration":"375.747536ms","start":"2026-06-24T00:48:11.851229Z","end":"2026-06-24T00:48:12.226977Z","steps":["trace[928821380] 'process raft request' (duration: 86.106249ms)","trace[928821380] 'compare' (duration: 289.084654ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:48:12.227101Z","caller":"traceutil/trace.go:171","msg":"trace[651721468] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:0; response_revision:291; }","duration":"374.095267ms","start":"2026-06-24T00:48:11.85293Z","end":"2026-06-24T00:48:12.227025Z","steps":["trace[651721468] 'agreement among raft nodes before linearized reading' (duration: 374.019586ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:12.22715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:11.852923Z","time spent":"374.217927ms","remote":"127.0.0.1:48622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":0,"response size":29,"request content":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" "} {"level":"warn","ts":"2026-06-24T00:48:12.227157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:11.851214Z","time spent":"375.859487ms","remote":"127.0.0.1:48606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5311,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:48:12.534205Z","caller":"traceutil/trace.go:171","msg":"trace[1568799844] linearizableReadLoop","detail":"{readStateIndex:308; appliedIndex:306; }","duration":"295.71407ms","start":"2026-06-24T00:48:12.238466Z","end":"2026-06-24T00:48:12.53418Z","steps":["trace[1568799844] 'read index received' (duration: 15.318488ms)","trace[1568799844] 'applied index is now lower than readState.Index' (duration: 280.394532ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:48:12.534298Z","caller":"traceutil/trace.go:171","msg":"trace[118922641] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"296.344424ms","start":"2026-06-24T00:48:12.23791Z","end":"2026-06-24T00:48:12.534254Z","steps":["trace[118922641] 'process raft request' (duration: 278.49338ms)","trace[118922641] 'compare' (duration: 17.672463ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:48:12.53437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.882941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-24T00:48:12.534433Z","caller":"traceutil/trace.go:171","msg":"trace[1545030056] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:293; }","duration":"295.976802ms","start":"2026-06-24T00:48:12.238443Z","end":"2026-06-24T00:48:12.534419Z","steps":["trace[1545030056] 'agreement among raft nodes before linearized reading' (duration: 295.839601ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:12.534556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.899208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-24T00:48:12.534598Z","caller":"traceutil/trace.go:171","msg":"trace[640746046] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:293; }","duration":"182.983028ms","start":"2026-06-24T00:48:12.351601Z","end":"2026-06-24T00:48:12.534584Z","steps":["trace[640746046] 'agreement among raft nodes before linearized reading' (duration: 182.893378ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:12.534625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.29896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-06-24T00:48:12.534732Z","caller":"traceutil/trace.go:171","msg":"trace[1146860328] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:293; }","duration":"278.4341ms","start":"2026-06-24T00:48:12.256269Z","end":"2026-06-24T00:48:12.534703Z","steps":["trace[1146860328] 'agreement among raft nodes before linearized reading' (duration: 278.221989ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:13.186707Z","caller":"traceutil/trace.go:171","msg":"trace[227952398] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"122.515666ms","start":"2026-06-24T00:48:13.064151Z","end":"2026-06-24T00:48:13.186667Z","steps":["trace[227952398] 'process raft request' (duration: 122.290935ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:13.394577Z","caller":"traceutil/trace.go:171","msg":"trace[1867943190] linearizableReadLoop","detail":"{readStateIndex:322; appliedIndex:321; }","duration":"191.923345ms","start":"2026-06-24T00:48:13.202612Z","end":"2026-06-24T00:48:13.394536Z","steps":["trace[1867943190] 'read index received' (duration: 187.460889ms)","trace[1867943190] 'applied index is now lower than readState.Index' (duration: 4.460846ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:48:13.394765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.132737ms","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-06-24T00:48:13.394869Z","caller":"traceutil/trace.go:171","msg":"trace[890168881] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:307; }","duration":"192.283678ms","start":"2026-06-24T00:48:13.202572Z","end":"2026-06-24T00:48:13.394856Z","steps":["trace[890168881] 'agreement among raft nodes before linearized reading' (duration: 192.059277ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:13.394598Z","caller":"traceutil/trace.go:171","msg":"trace[796571105] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"199.589459ms","start":"2026-06-24T00:48:13.194979Z","end":"2026-06-24T00:48:13.394568Z","steps":["trace[796571105] 'process raft request' (duration: 195.202144ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:13.395111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.210765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7294"} {"level":"warn","ts":"2026-06-24T00:48:13.394918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.071804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5325"} {"level":"warn","ts":"2026-06-24T00:48:13.395149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.903723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4659"} {"level":"info","ts":"2026-06-24T00:48:13.395285Z","caller":"traceutil/trace.go:171","msg":"trace[992335316] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:307; }","duration":"150.452146ms","start":"2026-06-24T00:48:13.244766Z","end":"2026-06-24T00:48:13.395218Z","steps":["trace[992335316] 'agreement among raft nodes before linearized reading' (duration: 150.021353ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:13.395306Z","caller":"traceutil/trace.go:171","msg":"trace[367671129] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:307; }","duration":"150.357916ms","start":"2026-06-24T00:48:13.244829Z","end":"2026-06-24T00:48:13.395187Z","steps":["trace[367671129] 'agreement among raft nodes before linearized reading' (duration: 150.076664ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:13.394937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.058218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6961"} {"level":"info","ts":"2026-06-24T00:48:13.395445Z","caller":"traceutil/trace.go:171","msg":"trace[184859287] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:307; }","duration":"149.605761ms","start":"2026-06-24T00:48:13.245821Z","end":"2026-06-24T00:48:13.395427Z","steps":["trace[184859287] 'agreement among raft nodes before linearized reading' (duration: 148.984638ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:13.395397Z","caller":"traceutil/trace.go:171","msg":"trace[290813119] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:307; }","duration":"150.109484ms","start":"2026-06-24T00:48:13.245189Z","end":"2026-06-24T00:48:13.395298Z","steps":["trace[290813119] 'agreement among raft nodes before linearized reading' (duration: 149.634982ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:13.394999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.25448ms","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-06-24T00:48:13.396008Z","caller":"traceutil/trace.go:171","msg":"trace[1630575749] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:307; }","duration":"143.276826ms","start":"2026-06-24T00:48:13.252712Z","end":"2026-06-24T00:48:13.395988Z","steps":["trace[1630575749] 'agreement among raft nodes before linearized reading' (duration: 142.24895ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:13.394999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.700512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4322"} {"level":"info","ts":"2026-06-24T00:48:13.396209Z","caller":"traceutil/trace.go:171","msg":"trace[752175269] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:307; }","duration":"150.95246ms","start":"2026-06-24T00:48:13.245244Z","end":"2026-06-24T00:48:13.396196Z","steps":["trace[752175269] 'agreement among raft nodes before linearized reading' (duration: 149.685892ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:13.819646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.219821ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T00:48:13.820153Z","caller":"traceutil/trace.go:171","msg":"trace[1797599468] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"414.726659ms","start":"2026-06-24T00:48:13.405366Z","end":"2026-06-24T00:48:13.820093Z","steps":["trace[1797599468] 'process raft request' (duration: 262.743204ms)","trace[1797599468] 'compare' (duration: 151.06866ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:48:13.820193Z","caller":"traceutil/trace.go:171","msg":"trace[856948442] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"412.554836ms","start":"2026-06-24T00:48:13.407593Z","end":"2026-06-24T00:48:13.820148Z","steps":["trace[856948442] 'process raft request' (duration: 412.231914ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:13.820352Z","caller":"traceutil/trace.go:171","msg":"trace[1473917680] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"412.574976ms","start":"2026-06-24T00:48:13.407743Z","end":"2026-06-24T00:48:13.820318Z","steps":["trace[1473917680] 'process raft request' (duration: 412.274325ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:13.820414Z","caller":"traceutil/trace.go:171","msg":"trace[675232491] linearizableReadLoop","detail":"{readStateIndex:329; appliedIndex:323; }","duration":"366.648062ms","start":"2026-06-24T00:48:13.453745Z","end":"2026-06-24T00:48:13.820393Z","steps":["trace[675232491] 'read index received' (duration: 214.391345ms)","trace[675232491] 'applied index is now lower than readState.Index' (duration: 152.255577ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:48:13.820416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:13.407578Z","time spent":"412.698077ms","remote":"127.0.0.1:48536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1723,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T00:48:13.820498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:13.407692Z","time spent":"412.738927ms","remote":"127.0.0.1:48900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3642,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T00:48:13.820643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.865693ms","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-06-24T00:48:13.820632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:13.405331Z","time spent":"414.94463ms","remote":"127.0.0.1:48672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1050,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:48:13.820684Z","caller":"traceutil/trace.go:171","msg":"trace[2031734622] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:314; }","duration":"366.969333ms","start":"2026-06-24T00:48:13.453702Z","end":"2026-06-24T00:48:13.820672Z","steps":["trace[2031734622] 'agreement among raft nodes before linearized reading' (duration: 366.757912ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:13.820743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:13.453688Z","time spent":"367.045844ms","remote":"127.0.0.1:48622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":221,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "} {"level":"info","ts":"2026-06-24T00:48:13.820807Z","caller":"traceutil/trace.go:171","msg":"trace[2093483468] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"412.613886ms","start":"2026-06-24T00:48:13.408181Z","end":"2026-06-24T00:48:13.820795Z","steps":["trace[2093483468] 'process raft request' (duration: 411.933242ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:13.820906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:13.408171Z","time spent":"412.687736ms","remote":"127.0.0.1:48744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":899,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:48:13.82107Z","caller":"traceutil/trace.go:171","msg":"trace[233848949] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"412.806348ms","start":"2026-06-24T00:48:13.408252Z","end":"2026-06-24T00:48:13.821058Z","steps":["trace[233848949] 'process raft request' (duration: 411.967363ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:13.821226Z","caller":"traceutil/trace.go:171","msg":"trace[1738130978] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"412.831047ms","start":"2026-06-24T00:48:13.40832Z","end":"2026-06-24T00:48:13.821151Z","steps":["trace[1738130978] 'process raft request' (duration: 412.027002ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:13.821149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:13.408243Z","time spent":"412.862788ms","remote":"127.0.0.1:48744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2094,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:48:13.821413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:13.408314Z","time spent":"413.019338ms","remote":"127.0.0.1:48744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2191,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:48:13.823114Z","caller":"traceutil/trace.go:171","msg":"trace[1515299947] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"364.499009ms","start":"2026-06-24T00:48:13.458586Z","end":"2026-06-24T00:48:13.823085Z","steps":["trace[1515299947] 'process raft request' (duration: 364.366658ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:13.823273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:13.458572Z","time spent":"364.63202ms","remote":"127.0.0.1:48606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3378,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T00:48:14.33938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.52305ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T00:48:14.339519Z","caller":"traceutil/trace.go:171","msg":"trace[811873201] linearizableReadLoop","detail":"{readStateIndex:346; appliedIndex:345; }","duration":"465.335562ms","start":"2026-06-24T00:48:13.874163Z","end":"2026-06-24T00:48:14.339499Z","steps":["trace[811873201] 'read index received' (duration: 128.615801ms)","trace[811873201] 'applied index is now lower than readState.Index' (duration: 336.718041ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:48:14.339559Z","caller":"traceutil/trace.go:171","msg":"trace[1992497797] transaction","detail":"{read_only:false; response_revision:331; number_of_response:1; }","duration":"466.65446ms","start":"2026-06-24T00:48:13.872872Z","end":"2026-06-24T00:48:14.339526Z","steps":["trace[1992497797] 'process raft request' (duration: 129.895578ms)","trace[1992497797] 'compare' (duration: 336.372419ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:48:14.339622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.453843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2839"} {"level":"info","ts":"2026-06-24T00:48:14.339654Z","caller":"traceutil/trace.go:171","msg":"trace[93659833] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:331; }","duration":"465.528443ms","start":"2026-06-24T00:48:13.874113Z","end":"2026-06-24T00:48:14.339641Z","steps":["trace[93659833] 'agreement among raft nodes before linearized reading' (duration: 465.460173ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:14.339688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:13.874085Z","time spent":"465.595023ms","remote":"127.0.0.1:48896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":2863,"request content":"key:\"/registry/daemonsets/kube-system/kube-proxy\" "} {"level":"warn","ts":"2026-06-24T00:48:14.339698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:13.872851Z","time spent":"466.7711ms","remote":"127.0.0.1:48882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4002,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:48:14.436971Z","caller":"traceutil/trace.go:171","msg":"trace[1298184430] transaction","detail":"{read_only:false; response_revision:333; number_of_response:1; }","duration":"559.437872ms","start":"2026-06-24T00:48:13.877491Z","end":"2026-06-24T00:48:14.436929Z","steps":["trace[1298184430] 'process raft request' (duration: 559.321172ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:14.437033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.141704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-06-24T00:48:14.437096Z","caller":"traceutil/trace.go:171","msg":"trace[2071641065] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:335; }","duration":"445.271294ms","start":"2026-06-24T00:48:13.991811Z","end":"2026-06-24T00:48:14.437082Z","steps":["trace[2071641065] 'agreement among raft nodes before linearized reading' (duration: 445.133123ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:14.437073Z","caller":"traceutil/trace.go:171","msg":"trace[325607231] transaction","detail":"{read_only:false; response_revision:334; number_of_response:1; }","duration":"557.153679ms","start":"2026-06-24T00:48:13.879872Z","end":"2026-06-24T00:48:14.437026Z","steps":["trace[325607231] 'process raft request' (duration: 556.978158ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:14.437116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:13.87747Z","time spent":"559.581103ms","remote":"127.0.0.1:48498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T00:48:14.437137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:13.991781Z","time spent":"445.343114ms","remote":"127.0.0.1:48622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":209,"request content":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" "} {"level":"warn","ts":"2026-06-24T00:48:14.437215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:13.87986Z","time spent":"557.28753ms","remote":"127.0.0.1:48606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3527,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:48:14.437362Z","caller":"traceutil/trace.go:171","msg":"trace[522537403] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"560.017956ms","start":"2026-06-24T00:48:13.877333Z","end":"2026-06-24T00:48:14.437351Z","steps":["trace[522537403] 'process raft request' (duration: 559.389442ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:14.437412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:13.877286Z","time spent":"560.102726ms","remote":"127.0.0.1:48498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:48:14.437401Z","caller":"traceutil/trace.go:171","msg":"trace[1915672168] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"554.613104ms","start":"2026-06-24T00:48:13.882771Z","end":"2026-06-24T00:48:14.437384Z","steps":["trace[1915672168] 'process raft request' (duration: 554.123691ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:14.437603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:13.882761Z","time spent":"554.790175ms","remote":"127.0.0.1:48606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4001,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:48:14.840761Z","caller":"traceutil/trace.go:171","msg":"trace[569379210] linearizableReadLoop","detail":"{readStateIndex:351; appliedIndex:350; }","duration":"402.339677ms","start":"2026-06-24T00:48:14.438392Z","end":"2026-06-24T00:48:14.840732Z","steps":["trace[569379210] 'read index received' (duration: 397.886402ms)","trace[569379210] 'applied index is now lower than readState.Index' (duration: 4.451875ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:48:14.84089Z","caller":"traceutil/trace.go:171","msg":"trace[1281942854] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"495.876944ms","start":"2026-06-24T00:48:14.344998Z","end":"2026-06-24T00:48:14.840875Z","steps":["trace[1281942854] 'process raft request' (duration: 491.129787ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:14.841037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:14.344972Z","time spent":"495.964515ms","remote":"127.0.0.1:48896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2886,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:48:14.841319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.87472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-xbj4v\" ","response":"range_response_count:1 size:4462"} {"level":"info","ts":"2026-06-24T00:48:14.841569Z","caller":"traceutil/trace.go:171","msg":"trace[1687681876] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-xbj4v; range_end:; response_count:1; response_revision:336; }","duration":"403.107252ms","start":"2026-06-24T00:48:14.438369Z","end":"2026-06-24T00:48:14.841476Z","steps":["trace[1687681876] 'agreement among raft nodes before linearized reading' (duration: 402.666599ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:14.841728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:14.438359Z","time spent":"403.350354ms","remote":"127.0.0.1:48606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":4486,"request content":"key:\"/registry/pods/kube-system/kube-proxy-xbj4v\" "} {"level":"info","ts":"2026-06-24T00:48:14.872776Z","caller":"traceutil/trace.go:171","msg":"trace[603417322] transaction","detail":"{read_only:false; response_revision:338; number_of_response:1; }","duration":"429.633324ms","start":"2026-06-24T00:48:14.443117Z","end":"2026-06-24T00:48:14.872751Z","steps":["trace[603417322] 'process raft request' (duration: 429.536644ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:14.872984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:14.443084Z","time spent":"429.812166ms","remote":"127.0.0.1:48498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T00:48:14.873034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.729437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-06-24T00:48:14.873128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.891916ms","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-06-24T00:48:14.873179Z","caller":"traceutil/trace.go:171","msg":"trace[597424277] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:340; }","duration":"321.968937ms","start":"2026-06-24T00:48:14.551201Z","end":"2026-06-24T00:48:14.87317Z","steps":["trace[597424277] 'agreement among raft nodes before linearized reading' (duration: 321.888246ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:14.873207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:14.551189Z","time spent":"322.010807ms","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-24T00:48:14.8728Z","caller":"traceutil/trace.go:171","msg":"trace[892633842] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"429.350552ms","start":"2026-06-24T00:48:14.443437Z","end":"2026-06-24T00:48:14.872788Z","steps":["trace[892633842] 'process raft request' (duration: 429.256232ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:14.873323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:14.443426Z","time spent":"429.851806ms","remote":"127.0.0.1:48900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3759,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:48:14.873142Z","caller":"traceutil/trace.go:171","msg":"trace[403710762] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:340; }","duration":"323.884318ms","start":"2026-06-24T00:48:14.549249Z","end":"2026-06-24T00:48:14.873134Z","steps":["trace[403710762] 'agreement among raft nodes before linearized reading' (duration: 323.749088ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:14.87343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:14.54923Z","time spent":"324.19299ms","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-24T00:48:14.872791Z","caller":"traceutil/trace.go:171","msg":"trace[557108482] transaction","detail":"{read_only:false; response_revision:337; number_of_response:1; }","duration":"430.119827ms","start":"2026-06-24T00:48:14.442651Z","end":"2026-06-24T00:48:14.872771Z","steps":["trace[557108482] 'process raft request' (duration: 429.904176ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:14.873529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:14.442629Z","time spent":"430.882702ms","remote":"127.0.0.1:48498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:48:14.872838Z","caller":"traceutil/trace.go:171","msg":"trace[913769982] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"428.497698ms","start":"2026-06-24T00:48:14.444334Z","end":"2026-06-24T00:48:14.872832Z","steps":["trace[913769982] 'process raft request' (duration: 428.400117ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:14.873676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:14.444323Z","time spent":"429.286742ms","remote":"127.0.0.1:48606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4001,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:48:14.873075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.302499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-24T00:48:14.873741Z","caller":"traceutil/trace.go:171","msg":"trace[839115566] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:340; }","duration":"140.001163ms","start":"2026-06-24T00:48:14.733732Z","end":"2026-06-24T00:48:14.873734Z","steps":["trace[839115566] 'agreement among raft nodes before linearized reading' (duration: 139.323379ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:16.156669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.622907ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:42"} {"level":"info","ts":"2026-06-24T00:48:16.156756Z","caller":"traceutil/trace.go:171","msg":"trace[1838618199] linearizableReadLoop","detail":"{readStateIndex:364; appliedIndex:363; }","duration":"566.513454ms","start":"2026-06-24T00:48:15.590225Z","end":"2026-06-24T00:48:16.156739Z","steps":["trace[1838618199] 'read index received' (duration: 341.800252ms)","trace[1838618199] 'applied index is now lower than readState.Index' (duration: 224.711992ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:48:16.156825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:15.560801Z","time spent":"596.021407ms","remote":"127.0.0.1:48914","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-24T00:48:16.157214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.961707ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:48:16.157394Z","caller":"traceutil/trace.go:171","msg":"trace[895031783] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:348; }","duration":"567.135415ms","start":"2026-06-24T00:48:15.590216Z","end":"2026-06-24T00:48:16.157351Z","steps":["trace[895031783] 'agreement among raft nodes before linearized reading' (duration: 566.64151ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:16.248684Z","caller":"traceutil/trace.go:171","msg":"trace[209778847] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"310.921096ms","start":"2026-06-24T00:48:15.937742Z","end":"2026-06-24T00:48:16.248663Z","steps":["trace[209778847] 'process raft request' (duration: 310.701925ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:16.248741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.282812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4322"} {"level":"warn","ts":"2026-06-24T00:48:16.248779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:15.937721Z","time spent":"311.01744ms","remote":"127.0.0.1:48498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T00:48:16.248778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.286254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/coredns-7c96b6546b-mrmm8.18bbddee7a01ac26\" ","response":"range_response_count:1 size:845"} {"level":"info","ts":"2026-06-24T00:48:16.248921Z","caller":"traceutil/trace.go:171","msg":"trace[2030646291] range","detail":"{range_begin:/registry/events/kube-system/coredns-7c96b6546b-mrmm8.18bbddee7a01ac26; range_end:; response_count:1; response_revision:349; }","duration":"609.41584ms","start":"2026-06-24T00:48:15.639442Z","end":"2026-06-24T00:48:16.248858Z","steps":["trace[2030646291] 'agreement among raft nodes before linearized reading' (duration: 609.245091ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:16.248802Z","caller":"traceutil/trace.go:171","msg":"trace[1080527694] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:349; }","duration":"630.391017ms","start":"2026-06-24T00:48:15.618394Z","end":"2026-06-24T00:48:16.248785Z","steps":["trace[1080527694] 'agreement among raft nodes before linearized reading' (duration: 630.207028ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:16.248963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:15.63942Z","time spent":"609.534545ms","remote":"127.0.0.1:48498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":869,"request content":"key:\"/registry/events/kube-system/coredns-7c96b6546b-mrmm8.18bbddee7a01ac26\" "} {"level":"warn","ts":"2026-06-24T00:48:16.248975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:15.618375Z","time spent":"630.587106ms","remote":"127.0.0.1:48606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4346,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"info","ts":"2026-06-24T00:48:16.317357Z","caller":"traceutil/trace.go:171","msg":"trace[1384807018] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"159.27329ms","start":"2026-06-24T00:48:16.15805Z","end":"2026-06-24T00:48:16.317323Z","steps":["trace[1384807018] 'process raft request' (duration: 132.528827ms)","trace[1384807018] 'compare' (duration: 26.466869ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:48:16.700555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.516034ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T00:48:16.700797Z","caller":"traceutil/trace.go:171","msg":"trace[1795585502] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"258.543261ms","start":"2026-06-24T00:48:16.442236Z","end":"2026-06-24T00:48:16.700779Z","steps":["trace[1795585502] 'process raft request' (duration: 258.492948ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:16.700806Z","caller":"traceutil/trace.go:171","msg":"trace[1292799796] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"446.292703ms","start":"2026-06-24T00:48:16.254473Z","end":"2026-06-24T00:48:16.700766Z","steps":["trace[1292799796] 'process raft request' (duration: 173.472814ms)","trace[1292799796] 'compare' (duration: 272.380587ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:48:16.701029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:16.254441Z","time spent":"446.471533ms","remote":"127.0.0.1:48498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:48:16.701412Z","caller":"traceutil/trace.go:171","msg":"trace[627509801] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"445.348235ms","start":"2026-06-24T00:48:16.256029Z","end":"2026-06-24T00:48:16.701377Z","steps":["trace[627509801] 'process raft request' (duration: 444.627019ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:16.701622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:16.256002Z","time spent":"445.503513ms","remote":"127.0.0.1:48606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4307,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:48:30.976035Z","caller":"traceutil/trace.go:171","msg":"trace[13756675] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"442.787714ms","start":"2026-06-24T00:48:30.533224Z","end":"2026-06-24T00:48:30.976011Z","steps":["trace[13756675] 'process raft request' (duration: 442.644328ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:30.976237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:30.533202Z","time spent":"442.909259ms","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:48:31.216075Z","caller":"traceutil/trace.go:171","msg":"trace[883066834] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"224.41904ms","start":"2026-06-24T00:48:30.991615Z","end":"2026-06-24T00:48:31.216034Z","steps":["trace[883066834] 'process raft request' (duration: 148.134936ms)","trace[883066834] 'compare' (duration: 75.808324ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:48:32.954774Z","caller":"traceutil/trace.go:171","msg":"trace[1141664927] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"337.043425ms","start":"2026-06-24T00:48:32.617706Z","end":"2026-06-24T00:48:32.95475Z","steps":["trace[1141664927] 'process raft request' (duration: 336.898809ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:32.95492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:32.617681Z","time spent":"337.164901ms","remote":"127.0.0.1:48882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:48:33.089649Z","caller":"traceutil/trace.go:171","msg":"trace[1855187634] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"128.546422ms","start":"2026-06-24T00:48:32.961077Z","end":"2026-06-24T00:48:33.089624Z","steps":["trace[1855187634] 'process raft request' (duration: 104.742437ms)","trace[1855187634] 'compare' (duration: 23.69504ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:48:47.253944Z","caller":"traceutil/trace.go:171","msg":"trace[384386447] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"732.302828ms","start":"2026-06-24T00:48:46.521619Z","end":"2026-06-24T00:48:47.253922Z","steps":["trace[384386447] 'process raft request' (duration: 732.168953ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:47.254074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:46.521601Z","time spent":"732.416741ms","remote":"127.0.0.1:48474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:48:47.673264Z","caller":"traceutil/trace.go:171","msg":"trace[314547924] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"1.147605053s","start":"2026-06-24T00:48:46.525623Z","end":"2026-06-24T00:48:47.673228Z","steps":["trace[314547924] 'process raft request' (duration: 1.147384375s)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:47.673292Z","caller":"traceutil/trace.go:171","msg":"trace[286125095] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"1.143722225s","start":"2026-06-24T00:48:46.529533Z","end":"2026-06-24T00:48:47.673255Z","steps":["trace[286125095] 'process raft request' (duration: 1.143640242s)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:47.67338Z","caller":"traceutil/trace.go:171","msg":"trace[1447136686] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"1.142694529s","start":"2026-06-24T00:48:46.530667Z","end":"2026-06-24T00:48:47.673362Z","steps":["trace[1447136686] 'process raft request' (duration: 1.142545494s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:47.673446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:46.525604Z","time spent":"1.147765979s","remote":"127.0.0.1:48474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T00:48:47.673476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:46.530661Z","time spent":"1.142757571s","remote":"127.0.0.1:48474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:48:47.673562Z","caller":"traceutil/trace.go:171","msg":"trace[463709801] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"1.140143337s","start":"2026-06-24T00:48:46.533411Z","end":"2026-06-24T00:48:47.673554Z","steps":["trace[463709801] 'process raft request' (duration: 1.139864178s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:47.673476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:46.529514Z","time spent":"1.143883531s","remote":"127.0.0.1:48474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T00:48:47.673602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:46.533405Z","time spent":"1.140181659s","remote":"127.0.0.1:48474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:48:47.673634Z","caller":"traceutil/trace.go:171","msg":"trace[25652413] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"1.131693837s","start":"2026-06-24T00:48:46.541933Z","end":"2026-06-24T00:48:47.673627Z","steps":["trace[25652413] 'process raft request' (duration: 1.13149153s)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:47.673656Z","caller":"traceutil/trace.go:171","msg":"trace[1781423258] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"1.125241767s","start":"2026-06-24T00:48:46.548402Z","end":"2026-06-24T00:48:47.673643Z","steps":["trace[1781423258] 'process raft request' (duration: 1.12506174s)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:47.673697Z","caller":"traceutil/trace.go:171","msg":"trace[1704966916] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"1.132719843s","start":"2026-06-24T00:48:46.540971Z","end":"2026-06-24T00:48:47.67369Z","steps":["trace[1704966916] 'process raft request' (duration: 1.132371781s)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:47.673711Z","caller":"traceutil/trace.go:171","msg":"trace[194490102] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"1.120264679s","start":"2026-06-24T00:48:46.553429Z","end":"2026-06-24T00:48:47.673694Z","steps":["trace[194490102] 'process raft request' (duration: 1.120113884s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:47.67372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:46.54838Z","time spent":"1.12531602s","remote":"127.0.0.1:48474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T00:48:47.673722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:46.540961Z","time spent":"1.132749394s","remote":"127.0.0.1:48474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:48:47.673737Z","caller":"traceutil/trace.go:171","msg":"trace[1232246814] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"990.227821ms","start":"2026-06-24T00:48:46.683487Z","end":"2026-06-24T00:48:47.673714Z","steps":["trace[1232246814] 'process raft request' (duration: 990.175599ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:47.673757Z","caller":"traceutil/trace.go:171","msg":"trace[1984996595] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"1.142232442s","start":"2026-06-24T00:48:46.531467Z","end":"2026-06-24T00:48:47.673699Z","steps":["trace[1984996595] 'process raft request' (duration: 1.141778616s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:47.6738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:46.553411Z","time spent":"1.120347403s","remote":"127.0.0.1:48474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T00:48:47.673842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:46.683459Z","time spent":"990.335445ms","remote":"127.0.0.1:48474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:48:47.673931Z","caller":"traceutil/trace.go:171","msg":"trace[2003891343] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"1.086661134s","start":"2026-06-24T00:48:46.587264Z","end":"2026-06-24T00:48:47.673925Z","steps":["trace[2003891343] 'process raft request' (duration: 1.086324362s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:47.673969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:46.587239Z","time spent":"1.086708265s","remote":"127.0.0.1:48474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T00:48:47.674013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:46.531461Z","time spent":"1.142388357s","remote":"127.0.0.1:48474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T00:48:47.673669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:46.541907Z","time spent":"1.131745328s","remote":"127.0.0.1:48474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:48:47.68964Z","caller":"traceutil/trace.go:171","msg":"trace[234983174] linearizableReadLoop","detail":"{readStateIndex:532; appliedIndex:517; }","duration":"344.076279ms","start":"2026-06-24T00:48:47.34555Z","end":"2026-06-24T00:48:47.689626Z","steps":["trace[234983174] 'read index received' (duration: 327.458505ms)","trace[234983174] 'applied index is now lower than readState.Index' (duration: 16.617004ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:48:47.689824Z","caller":"traceutil/trace.go:171","msg":"trace[262465298] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"430.412618ms","start":"2026-06-24T00:48:47.259402Z","end":"2026-06-24T00:48:47.689815Z","steps":["trace[262465298] 'process raft request' (duration: 429.973452ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:47.689881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:47.259377Z","time spent":"430.46879ms","remote":"127.0.0.1:48924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:48:47.689985Z","caller":"traceutil/trace.go:171","msg":"trace[1926209882] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"430.488891ms","start":"2026-06-24T00:48:47.25949Z","end":"2026-06-24T00:48:47.689979Z","steps":["trace[1926209882] 'process raft request' (duration: 429.967092ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:47.690016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:47.25943Z","time spent":"430.573163ms","remote":"127.0.0.1:48924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:48:47.690145Z","caller":"traceutil/trace.go:171","msg":"trace[838191135] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"427.484825ms","start":"2026-06-24T00:48:47.262655Z","end":"2026-06-24T00:48:47.69014Z","steps":["trace[838191135] 'process raft request' (duration: 426.844483ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:47.690186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:47.262628Z","time spent":"427.533877ms","remote":"127.0.0.1:48474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:48:47.690253Z","caller":"traceutil/trace.go:171","msg":"trace[1168470316] transaction","detail":"{read_only:false; number_of_response:1; response_revision:509; }","duration":"425.380851ms","start":"2026-06-24T00:48:47.264868Z","end":"2026-06-24T00:48:47.690249Z","steps":["trace[1168470316] 'process raft request' (duration: 424.680066ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:47.690281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:47.264844Z","time spent":"425.423023ms","remote":"127.0.0.1:48474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":101,"response count":0,"response size":10113,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:48:47.69039Z","caller":"traceutil/trace.go:171","msg":"trace[1690160399] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"338.171472ms","start":"2026-06-24T00:48:47.352213Z","end":"2026-06-24T00:48:47.690384Z","steps":["trace[1690160399] 'process raft request' (duration: 337.373884ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:47.690419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:47.352189Z","time spent":"338.214923ms","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:48:47.690498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.957801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-24T00:48:47.690518Z","caller":"traceutil/trace.go:171","msg":"trace[1696680167] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:510; }","duration":"345.046473ms","start":"2026-06-24T00:48:47.345468Z","end":"2026-06-24T00:48:47.690514Z","steps":["trace[1696680167] 'agreement among raft nodes before linearized reading' (duration: 345.008012ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:47.690533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:47.345446Z","time spent":"345.083045ms","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-24T00:48:47.696168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.068249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-24T00:48:47.696222Z","caller":"traceutil/trace.go:171","msg":"trace[136790703] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:512; }","duration":"346.152392ms","start":"2026-06-24T00:48:47.350058Z","end":"2026-06-24T00:48:47.69621Z","steps":["trace[136790703] 'agreement among raft nodes before linearized reading' (duration: 346.050228ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:47.69625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:47.350043Z","time spent":"346.201984ms","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T00:48:47.696543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.246008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:48:47.696562Z","caller":"traceutil/trace.go:171","msg":"trace[1510192236] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:512; }","duration":"106.265039ms","start":"2026-06-24T00:48:47.590293Z","end":"2026-06-24T00:48:47.696558Z","steps":["trace[1510192236] 'agreement among raft nodes before linearized reading' (duration: 106.238198ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:47.696646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.449647ms","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-06-24T00:48:47.696663Z","caller":"traceutil/trace.go:171","msg":"trace[1614711174] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:512; }","duration":"343.476348ms","start":"2026-06-24T00:48:47.353183Z","end":"2026-06-24T00:48:47.696659Z","steps":["trace[1614711174] 'agreement among raft nodes before linearized reading' (duration: 343.445337ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:47.696675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:47.353178Z","time spent":"343.493549ms","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T00:48:47.696733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.717207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-24T00:48:47.696748Z","caller":"traceutil/trace.go:171","msg":"trace[1245171006] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:512; }","duration":"343.745647ms","start":"2026-06-24T00:48:47.352999Z","end":"2026-06-24T00:48:47.696745Z","steps":["trace[1245171006] 'agreement among raft nodes before linearized reading' (duration: 343.720827ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:47.696761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:47.352993Z","time spent":"343.765238ms","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-24T00:48:52.866833Z","caller":"traceutil/trace.go:171","msg":"trace[1629614546] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"353.017715ms","start":"2026-06-24T00:48:52.513796Z","end":"2026-06-24T00:48:52.866814Z","steps":["trace[1629614546] 'process raft request' (duration: 352.898371ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:52.866955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:52.513766Z","time spent":"353.131678ms","remote":"127.0.0.1:48744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1092,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:48:53.479645Z","caller":"traceutil/trace.go:171","msg":"trace[455297784] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"177.216927ms","start":"2026-06-24T00:48:53.3024Z","end":"2026-06-24T00:48:53.479617Z","steps":["trace[455297784] 'process raft request' (duration: 173.431652ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:54.447187Z","caller":"traceutil/trace.go:171","msg":"trace[1937777569] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"124.098753ms","start":"2026-06-24T00:48:54.323066Z","end":"2026-06-24T00:48:54.447164Z","steps":["trace[1937777569] 'process raft request' (duration: 123.933518ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:55.091115Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794900129658971145,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-24T00:48:55.277824Z","caller":"traceutil/trace.go:171","msg":"trace[1115608359] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"687.334204ms","start":"2026-06-24T00:48:54.590469Z","end":"2026-06-24T00:48:55.277803Z","steps":["trace[1115608359] 'read index received' (duration: 686.60643ms)","trace[1115608359] 'applied index is now lower than readState.Index' (duration: 727.064µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:48:55.277868Z","caller":"traceutil/trace.go:171","msg":"trace[135431113] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"840.478963ms","start":"2026-06-24T00:48:54.43737Z","end":"2026-06-24T00:48:55.277849Z","steps":["trace[135431113] 'process raft request' (duration: 839.839143ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:55.277925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.450988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:48:55.277948Z","caller":"traceutil/trace.go:171","msg":"trace[1078360792] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:609; }","duration":"687.52662ms","start":"2026-06-24T00:48:54.590414Z","end":"2026-06-24T00:48:55.277941Z","steps":["trace[1078360792] 'agreement among raft nodes before linearized reading' (duration: 687.459188ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:55.27798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:54.590386Z","time spent":"687.589122ms","remote":"127.0.0.1:48432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T00:48:55.27798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:54.437342Z","time spent":"840.570476ms","remote":"127.0.0.1:48524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:48:57.590804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000423908s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-06-24T00:48:57.590892Z","caller":"traceutil/trace.go:171","msg":"trace[774794588] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000587614s","start":"2026-06-24T00:48:55.590285Z","end":"2026-06-24T00:48:57.590872Z","steps":["trace[774794588] 'agreement among raft nodes before linearized reading' (duration: 2.000449769s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:57.591132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:55.590262Z","time spent":"2.000856202s","remote":"127.0.0.1:48432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/24 00:48:57 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-24T00:48:59.591384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999980506s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-24T00:48:59.59148Z","caller":"traceutil/trace.go:171","msg":"trace[1415333646] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00012983s","start":"2026-06-24T00:48:57.591326Z","end":"2026-06-24T00:48:59.591455Z","steps":["trace[1415333646] 'agreement among raft nodes before linearized reading' (duration: 2.000019367s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:59.591533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:57.591303Z","time spent":"2.000219313s","remote":"127.0.0.1:48420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/24 00:48:59 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-24T00:49:00.733698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.998759529s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-24T00:49:00.733806Z","caller":"traceutil/trace.go:171","msg":"trace[436845726] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.998918764s","start":"2026-06-24T00:48:55.734862Z","end":"2026-06-24T00:49:00.73378Z","steps":["trace[436845726] 'agreement among raft nodes before linearized reading' (duration: 4.99879062s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:00.733879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:55.734841Z","time spent":"4.999020917s","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} 2026/06/24 00:49:00 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-24T00:49:00.735987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999746877s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-24T00:49:00.736051Z","caller":"traceutil/trace.go:171","msg":"trace[444200620] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"4.99984715s","start":"2026-06-24T00:48:55.736189Z","end":"2026-06-24T00:49:00.736037Z","steps":["trace[444200620] 'agreement among raft nodes before linearized reading' (duration: 4.999763777s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:00.736089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:55.73618Z","time spent":"4.999903262s","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} 2026/06/24 00:49:00 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-24T00:49:01.009228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.259326472s","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-06-24T00:49:01.009397Z","caller":"traceutil/trace.go:171","msg":"trace[1182309809] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:609; }","duration":"5.259502357s","start":"2026-06-24T00:48:55.749875Z","end":"2026-06-24T00:49:01.009377Z","steps":["trace[1182309809] 'range keys from in-memory index tree' (duration: 5.259312221s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:01.009877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.606777758s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T00:49:01.009954Z","caller":"traceutil/trace.go:171","msg":"trace[314113929] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:635; }","duration":"5.419613116s","start":"2026-06-24T00:48:55.590325Z","end":"2026-06-24T00:49:01.009938Z","steps":["trace[314113929] 'read index received' (duration: 46.291µs)","trace[314113929] 'applied index is now lower than readState.Index' (duration: 5.419565415s)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:49:01.010017Z","caller":"traceutil/trace.go:171","msg":"trace[836837638] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"5.683248322s","start":"2026-06-24T00:48:55.326734Z","end":"2026-06-24T00:49:01.009982Z","steps":["trace[836837638] 'process raft request' (duration: 76.306319ms)","trace[836837638] 'compare' (duration: 5.606041096s)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:49:01.010141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:55.326712Z","time spent":"5.683372046s","remote":"127.0.0.1:48646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T00:49:01.222348Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.223524198s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-24T00:49:01.593009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.313606ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T00:49:01.593281Z","caller":"traceutil/trace.go:171","msg":"trace[1644118281] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"1.99778545s","start":"2026-06-24T00:48:59.595425Z","end":"2026-06-24T00:49:01.593211Z","steps":["trace[1644118281] 'process raft request' (duration: 1.997672577s)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:49:01.593486Z","caller":"traceutil/trace.go:171","msg":"trace[1203138355] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"3.594779092s","start":"2026-06-24T00:48:57.998688Z","end":"2026-06-24T00:49:01.593467Z","steps":["trace[1203138355] 'process raft request' (duration: 3.22393155s)","trace[1203138355] 'compare' (duration: 370.10378ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:49:01.593478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:59.595387Z","time spent":"1.998003958s","remote":"127.0.0.1:48498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T00:49:01.593545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.995400447s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T00:49:01.593562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:57.998653Z","time spent":"3.594873655s","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:49:01.593606Z","caller":"traceutil/trace.go:171","msg":"trace[1216446495] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:612; }","duration":"1.995513051s","start":"2026-06-24T00:48:59.598077Z","end":"2026-06-24T00:49:01.59359Z","steps":["trace[1216446495] 'agreement among raft nodes before linearized reading' (duration: 1.995389587s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:01.593644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:59.598052Z","time spent":"1.995583082s","remote":"127.0.0.1:48432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T00:49:01.593633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.839073771s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-24T00:49:01.593621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.380925467s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.53\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-24T00:49:01.593693Z","caller":"traceutil/trace.go:171","msg":"trace[955248529] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:612; }","duration":"5.839180055s","start":"2026-06-24T00:48:55.754497Z","end":"2026-06-24T00:49:01.593677Z","steps":["trace[955248529] 'agreement among raft nodes before linearized reading' (duration: 5.838973918s)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:49:01.593707Z","caller":"traceutil/trace.go:171","msg":"trace[1902756023] range","detail":"{range_begin:/registry/masterleases/199.204.45.53; range_end:; response_count:1; response_revision:612; }","duration":"3.381069982s","start":"2026-06-24T00:48:58.212618Z","end":"2026-06-24T00:49:01.593688Z","steps":["trace[1902756023] 'agreement among raft nodes before linearized reading' (duration: 3.380837395s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:01.593711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.839894617s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-24T00:49:01.593744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:55.754475Z","time spent":"5.839259026s","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-24T00:49:01.59375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:58.212586Z","time spent":"3.381155505s","remote":"127.0.0.1:48460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.53\" "} {"level":"info","ts":"2026-06-24T00:49:01.593767Z","caller":"traceutil/trace.go:171","msg":"trace[1780507738] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:612; }","duration":"5.839999421s","start":"2026-06-24T00:48:55.75375Z","end":"2026-06-24T00:49:01.59375Z","steps":["trace[1780507738] 'agreement among raft nodes before linearized reading' (duration: 5.839832316s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:01.593803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:55.753727Z","time spent":"5.840068092s","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-24T00:49:01.593849Z","caller":"traceutil/trace.go:171","msg":"trace[151670219] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:636; }","duration":"583.175472ms","start":"2026-06-24T00:49:01.009983Z","end":"2026-06-24T00:49:01.593158Z","steps":["trace[151670219] 'read index received' (duration: 212.720922ms)","trace[151670219] 'applied index is now lower than readState.Index' (duration: 370.44552ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:49:01.593958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.312625ms","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-06-24T00:49:01.593985Z","caller":"traceutil/trace.go:171","msg":"trace[1348765903] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:612; }","duration":"580.379497ms","start":"2026-06-24T00:49:01.013597Z","end":"2026-06-24T00:49:01.593976Z","steps":["trace[1348765903] 'agreement among raft nodes before linearized reading' (duration: 580.320615ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:01.594014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:49:01.013581Z","time spent":"580.426309ms","remote":"127.0.0.1:48622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":217,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-06-24T00:49:02.919682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.407298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-24T00:49:02.919837Z","caller":"traceutil/trace.go:171","msg":"trace[1174578746] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:625; }","duration":"180.605563ms","start":"2026-06-24T00:49:02.739204Z","end":"2026-06-24T00:49:02.919809Z","steps":["trace[1174578746] 'range keys from in-memory index tree' (duration: 180.222652ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:02.91984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.84668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-24T00:49:02.919917Z","caller":"traceutil/trace.go:171","msg":"trace[1732687278] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:625; }","duration":"184.968494ms","start":"2026-06-24T00:49:02.734929Z","end":"2026-06-24T00:49:02.919897Z","steps":["trace[1732687278] 'range keys from in-memory index tree' (duration: 184.595843ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:49:13.30046Z","caller":"traceutil/trace.go:171","msg":"trace[1938829404] linearizableReadLoop","detail":"{readStateIndex:773; appliedIndex:772; }","duration":"307.086633ms","start":"2026-06-24T00:49:12.99335Z","end":"2026-06-24T00:49:13.300436Z","steps":["trace[1938829404] 'read index received' (duration: 305.912101ms)","trace[1938829404] 'applied index is now lower than readState.Index' (duration: 1.173702ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:49:13.30162Z","caller":"traceutil/trace.go:171","msg":"trace[765170961] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"312.052666ms","start":"2026-06-24T00:49:12.989485Z","end":"2026-06-24T00:49:13.301537Z","steps":["trace[765170961] 'process raft request' (duration: 309.841717ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:13.302893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:49:12.989474Z","time spent":"312.190161ms","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:49:13.303343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.98508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-24T00:49:13.30559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.573871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:49:13.305684Z","caller":"traceutil/trace.go:171","msg":"trace[1603097234] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:742; }","duration":"280.798767ms","start":"2026-06-24T00:49:13.024867Z","end":"2026-06-24T00:49:13.305666Z","steps":["trace[1603097234] 'agreement among raft nodes before linearized reading' (duration: 280.56691ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:49:13.303393Z","caller":"traceutil/trace.go:171","msg":"trace[572658703] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:742; }","duration":"310.048941ms","start":"2026-06-24T00:49:12.99333Z","end":"2026-06-24T00:49:13.303379Z","steps":["trace[572658703] 'agreement among raft nodes before linearized reading' (duration: 309.916958ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:13.306039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.54783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:49:13.306085Z","caller":"traceutil/trace.go:171","msg":"trace[1024111627] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:742; }","duration":"184.619441ms","start":"2026-06-24T00:49:13.121452Z","end":"2026-06-24T00:49:13.306072Z","steps":["trace[1024111627] 'agreement among raft nodes before linearized reading' (duration: 184.541459ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:13.306307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.826957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:49:13.306358Z","caller":"traceutil/trace.go:171","msg":"trace[690688378] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:742; }","duration":"184.890089ms","start":"2026-06-24T00:49:13.121456Z","end":"2026-06-24T00:49:13.306346Z","steps":["trace[690688378] 'agreement among raft nodes before linearized reading' (duration: 184.813207ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:13.306397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.280897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:49:13.306477Z","caller":"traceutil/trace.go:171","msg":"trace[1658853749] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:742; }","duration":"223.41097ms","start":"2026-06-24T00:49:13.083053Z","end":"2026-06-24T00:49:13.306464Z","steps":["trace[1658853749] 'agreement among raft nodes before linearized reading' (duration: 223.308927ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:13.306533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.642713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:49:13.306576Z","caller":"traceutil/trace.go:171","msg":"trace[1597054913] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:742; }","duration":"280.697204ms","start":"2026-06-24T00:49:13.025868Z","end":"2026-06-24T00:49:13.306565Z","steps":["trace[1597054913] 'agreement among raft nodes before linearized reading' (duration: 280.638652ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:13.306691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.694961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:49:13.306714Z","caller":"traceutil/trace.go:171","msg":"trace[1899709711] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:742; }","duration":"281.729272ms","start":"2026-06-24T00:49:13.02498Z","end":"2026-06-24T00:49:13.306709Z","steps":["trace[1899709711] 'agreement among raft nodes before linearized reading' (duration: 281.694421ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:13.306725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.29367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:49:13.306747Z","caller":"traceutil/trace.go:171","msg":"trace[525374201] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:742; }","duration":"185.33553ms","start":"2026-06-24T00:49:13.121407Z","end":"2026-06-24T00:49:13.306743Z","steps":["trace[525374201] 'agreement among raft nodes before linearized reading' (duration: 185.29925ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:13.306087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:49:12.993323Z","time spent":"312.747684ms","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T00:49:13.307357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.204902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:49:13.307402Z","caller":"traceutil/trace.go:171","msg":"trace[1217236600] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:742; }","duration":"224.255853ms","start":"2026-06-24T00:49:13.083134Z","end":"2026-06-24T00:49:13.30739Z","steps":["trace[1217236600] 'agreement among raft nodes before linearized reading' (duration: 224.187691ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:13.307549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.348821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:49:13.307587Z","caller":"traceutil/trace.go:171","msg":"trace[1836711228] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:742; }","duration":"207.397622ms","start":"2026-06-24T00:49:13.10018Z","end":"2026-06-24T00:49:13.307578Z","steps":["trace[1836711228] 'agreement among raft nodes before linearized reading' (duration: 207.34139ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:13.307778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.605727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:49:13.307816Z","caller":"traceutil/trace.go:171","msg":"trace[1634404903] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:742; }","duration":"207.646628ms","start":"2026-06-24T00:49:13.10016Z","end":"2026-06-24T00:49:13.307807Z","steps":["trace[1634404903] 'agreement among raft nodes before linearized reading' (duration: 207.589016ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:13.308101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.964532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:49:13.308133Z","caller":"traceutil/trace.go:171","msg":"trace[148925185] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:742; }","duration":"225.006943ms","start":"2026-06-24T00:49:13.08312Z","end":"2026-06-24T00:49:13.308127Z","steps":["trace[148925185] 'agreement among raft nodes before linearized reading' (duration: 224.961851ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:49:14.839463Z","caller":"traceutil/trace.go:171","msg":"trace[590404198] linearizableReadLoop","detail":"{readStateIndex:782; appliedIndex:781; }","duration":"248.881168ms","start":"2026-06-24T00:49:14.590557Z","end":"2026-06-24T00:49:14.839439Z","steps":["trace[590404198] 'read index received' (duration: 248.643211ms)","trace[590404198] 'applied index is now lower than readState.Index' (duration: 237.007µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:49:14.839521Z","caller":"traceutil/trace.go:171","msg":"trace[320447033] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"306.132125ms","start":"2026-06-24T00:49:14.533357Z","end":"2026-06-24T00:49:14.839489Z","steps":["trace[320447033] 'process raft request' (duration: 305.896819ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:14.839579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.001751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:49:14.839614Z","caller":"traceutil/trace.go:171","msg":"trace[547528080] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:751; }","duration":"249.090953ms","start":"2026-06-24T00:49:14.59051Z","end":"2026-06-24T00:49:14.839601Z","steps":["trace[547528080] 'agreement among raft nodes before linearized reading' (duration: 249.022591ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:14.839653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:49:14.533339Z","time spent":"306.245439ms","remote":"127.0.0.1:48606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5031,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:49:17.380588Z","caller":"traceutil/trace.go:171","msg":"trace[1361223342] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"141.854093ms","start":"2026-06-24T00:49:17.238709Z","end":"2026-06-24T00:49:17.380563Z","steps":["trace[1361223342] 'process raft request' (duration: 141.700849ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:18.089633Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794900129658971540,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:49:18.590291Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794900129658971540,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:49:18.732016Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.185327255s","expected-duration":"1s"} {"level":"info","ts":"2026-06-24T00:49:18.732513Z","caller":"traceutil/trace.go:171","msg":"trace[487429258] linearizableReadLoop","detail":"{readStateIndex:807; appliedIndex:806; }","duration":"1.143260422s","start":"2026-06-24T00:49:17.589221Z","end":"2026-06-24T00:49:18.732481Z","steps":["trace[487429258] 'read index received' (duration: 1.142933324s)","trace[487429258] 'applied index is now lower than readState.Index' (duration: 321.978µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:49:18.732684Z","caller":"traceutil/trace.go:171","msg":"trace[1916484915] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"1.186100205s","start":"2026-06-24T00:49:17.546571Z","end":"2026-06-24T00:49:18.732672Z","steps":["trace[1916484915] 'process raft request' (duration: 1.185687534s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:18.732843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:49:17.546551Z","time spent":"1.186174877s","remote":"127.0.0.1:48606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4024,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:49:18.733017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.143763574s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T00:49:18.733065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.774388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.53\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-06-24T00:49:18.733105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"985.764146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-24T00:49:18.733115Z","caller":"traceutil/trace.go:171","msg":"trace[52930083] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:775; }","duration":"1.143927679s","start":"2026-06-24T00:49:17.589165Z","end":"2026-06-24T00:49:18.733093Z","steps":["trace[52930083] 'agreement among raft nodes before linearized reading' (duration: 1.143743185s)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:49:18.733153Z","caller":"traceutil/trace.go:171","msg":"trace[1116535166] range","detail":"{range_begin:/registry/masterleases/199.204.45.53; range_end:; response_count:1; response_revision:775; }","duration":"519.900641ms","start":"2026-06-24T00:49:18.213225Z","end":"2026-06-24T00:49:18.733125Z","steps":["trace[1116535166] 'agreement among raft nodes before linearized reading' (duration: 519.638235ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:49:18.733165Z","caller":"traceutil/trace.go:171","msg":"trace[1434695116] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:775; }","duration":"985.849268ms","start":"2026-06-24T00:49:17.747301Z","end":"2026-06-24T00:49:18.733151Z","steps":["trace[1434695116] 'agreement among raft nodes before linearized reading' (duration: 985.657353ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:18.733174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:49:17.589144Z","time spent":"1.144022311s","remote":"127.0.0.1:48432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T00:49:18.733215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:49:17.74729Z","time spent":"985.91728ms","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-24T00:49:18.73307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"985.970581ms","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-06-24T00:49:18.733553Z","caller":"traceutil/trace.go:171","msg":"trace[1089632926] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:775; }","duration":"986.510585ms","start":"2026-06-24T00:49:17.747025Z","end":"2026-06-24T00:49:18.733536Z","steps":["trace[1089632926] 'agreement among raft nodes before linearized reading' (duration: 985.793867ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:18.733638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:49:17.747006Z","time spent":"986.615818ms","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T00:49:18.733528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:49:18.213206Z","time spent":"520.006784ms","remote":"127.0.0.1:48460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.53\" "} {"level":"info","ts":"2026-06-24T00:49:19.73477Z","caller":"traceutil/trace.go:171","msg":"trace[1183388553] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"150.500163ms","start":"2026-06-24T00:49:19.584248Z","end":"2026-06-24T00:49:19.734748Z","steps":["trace[1183388553] 'process raft request' (duration: 150.360459ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:49:32.059185Z","caller":"traceutil/trace.go:171","msg":"trace[685415602] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"374.506643ms","start":"2026-06-24T00:49:31.684652Z","end":"2026-06-24T00:49:32.059158Z","steps":["trace[685415602] 'process raft request' (duration: 374.3576ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:32.059334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:49:31.684629Z","time spent":"374.637057ms","remote":"127.0.0.1:48498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":811,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T00:49:32.322534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.752275ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T00:49:32.322646Z","caller":"traceutil/trace.go:171","msg":"trace[1656863233] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"625.10482ms","start":"2026-06-24T00:49:31.697519Z","end":"2026-06-24T00:49:32.322624Z","steps":["trace[1656863233] 'process raft request' (duration: 450.179151ms)","trace[1656863233] 'compare' (duration: 174.605882ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:49:32.322709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:49:31.697498Z","time spent":"625.180872ms","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:49:32.850777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.421846ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T00:49:32.851086Z","caller":"traceutil/trace.go:171","msg":"trace[94617239] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"513.164876ms","start":"2026-06-24T00:49:32.337854Z","end":"2026-06-24T00:49:32.851019Z","steps":["trace[94617239] 'process raft request' (duration: 176.419272ms)","trace[94617239] 'compare' (duration: 336.311064ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:49:32.851157Z","caller":"traceutil/trace.go:171","msg":"trace[926780199] linearizableReadLoop","detail":"{readStateIndex:967; appliedIndex:965; }","duration":"262.920156ms","start":"2026-06-24T00:49:32.588053Z","end":"2026-06-24T00:49:32.850973Z","steps":["trace[926780199] 'read index received' (duration: 86.717128ms)","trace[926780199] 'applied index is now lower than readState.Index' (duration: 176.201708ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:49:32.851232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:49:32.337835Z","time spent":"513.32181ms","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:49:32.851269Z","caller":"traceutil/trace.go:171","msg":"trace[1232477772] transaction","detail":"{read_only:false; response_revision:932; number_of_response:1; }","duration":"355.187998ms","start":"2026-06-24T00:49:32.496049Z","end":"2026-06-24T00:49:32.851237Z","steps":["trace[1232477772] 'process raft request' (duration: 354.84507ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:32.85133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.265983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:49:32.851389Z","caller":"traceutil/trace.go:171","msg":"trace[973923212] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:932; }","duration":"263.360086ms","start":"2026-06-24T00:49:32.588012Z","end":"2026-06-24T00:49:32.851373Z","steps":["trace[973923212] 'agreement among raft nodes before linearized reading' (duration: 263.229553ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:32.851408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:49:32.496023Z","time spent":"355.303391ms","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:49:33.44173Z","caller":"traceutil/trace.go:171","msg":"trace[881157709] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"586.225652ms","start":"2026-06-24T00:49:32.855486Z","end":"2026-06-24T00:49:33.441712Z","steps":["trace[881157709] 'process raft request' (duration: 575.413381ms)","trace[881157709] 'compare' (duration: 10.74146ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:49:33.441838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:49:32.855461Z","time spent":"586.321314ms","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:49:33.478906Z","caller":"traceutil/trace.go:171","msg":"trace[121391109] linearizableReadLoop","detail":"{readStateIndex:969; appliedIndex:967; }","duration":"462.512289ms","start":"2026-06-24T00:49:33.016373Z","end":"2026-06-24T00:49:33.478885Z","steps":["trace[121391109] 'read index received' (duration: 414.51177ms)","trace[121391109] 'applied index is now lower than readState.Index' (duration: 47.999669ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:49:33.479108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.723383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-dhssd\" ","response":"range_response_count:1 size:5676"} {"level":"info","ts":"2026-06-24T00:49:33.479138Z","caller":"traceutil/trace.go:171","msg":"trace[255378732] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-dhssd; range_end:; response_count:1; response_revision:934; }","duration":"462.805045ms","start":"2026-06-24T00:49:33.016324Z","end":"2026-06-24T00:49:33.479129Z","steps":["trace[255378732] 'agreement among raft nodes before linearized reading' (duration: 462.685953ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:33.479178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:49:33.016304Z","time spent":"462.868327ms","remote":"127.0.0.1:48606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":1,"response size":5700,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-dhssd\" "} {"level":"warn","ts":"2026-06-24T00:49:33.479246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.102746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:49:33.479335Z","caller":"traceutil/trace.go:171","msg":"trace[852916048] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:934; }","duration":"293.25075ms","start":"2026-06-24T00:49:33.186067Z","end":"2026-06-24T00:49:33.479318Z","steps":["trace[852916048] 'agreement among raft nodes before linearized reading' (duration: 293.093266ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:49:33.479273Z","caller":"traceutil/trace.go:171","msg":"trace[1031245671] transaction","detail":"{read_only:false; response_revision:934; number_of_response:1; }","duration":"622.731655ms","start":"2026-06-24T00:49:32.856251Z","end":"2026-06-24T00:49:33.478983Z","steps":["trace[1031245671] 'process raft request' (duration: 622.528901ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:33.479613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:49:32.856231Z","time spent":"623.287337ms","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:49:33.682326Z","caller":"traceutil/trace.go:171","msg":"trace[874544448] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"116.089115ms","start":"2026-06-24T00:49:33.566221Z","end":"2026-06-24T00:49:33.68231Z","steps":["trace[874544448] 'process raft request' (duration: 116.025743ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:49:33.68235Z","caller":"traceutil/trace.go:171","msg":"trace[2047558787] transaction","detail":"{read_only:false; response_revision:937; number_of_response:1; }","duration":"116.102955ms","start":"2026-06-24T00:49:33.56621Z","end":"2026-06-24T00:49:33.682313Z","steps":["trace[2047558787] 'process raft request' (duration: 115.932421ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:49:33.682681Z","caller":"traceutil/trace.go:171","msg":"trace[1632353595] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"115.457731ms","start":"2026-06-24T00:49:33.567203Z","end":"2026-06-24T00:49:33.682661Z","steps":["trace[1632353595] 'process raft request' (duration: 115.069992ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:49:33.682829Z","caller":"traceutil/trace.go:171","msg":"trace[1983074461] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"115.530653ms","start":"2026-06-24T00:49:33.567273Z","end":"2026-06-24T00:49:33.682804Z","steps":["trace[1983074461] 'process raft request' (duration: 115.376569ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:49:33.682835Z","caller":"traceutil/trace.go:171","msg":"trace[1143924058] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"115.600964ms","start":"2026-06-24T00:49:33.567208Z","end":"2026-06-24T00:49:33.682809Z","steps":["trace[1143924058] 'process raft request' (duration: 115.313077ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:49:34.051545Z","caller":"traceutil/trace.go:171","msg":"trace[1697924259] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"192.63657ms","start":"2026-06-24T00:49:33.858886Z","end":"2026-06-24T00:49:34.051522Z","steps":["trace[1697924259] 'process raft request' (duration: 192.484037ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:49:34.166976Z","caller":"traceutil/trace.go:171","msg":"trace[1138324740] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"110.345296ms","start":"2026-06-24T00:49:34.056613Z","end":"2026-06-24T00:49:34.166958Z","steps":["trace[1138324740] 'process raft request' (duration: 110.219623ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:49:34.765244Z","caller":"traceutil/trace.go:171","msg":"trace[1391813548] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"120.717856ms","start":"2026-06-24T00:49:34.644503Z","end":"2026-06-24T00:49:34.76522Z","steps":["trace[1391813548] 'process raft request' (duration: 120.572893ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:35.09046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.945348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T00:49:35.090578Z","caller":"traceutil/trace.go:171","msg":"trace[662345145] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:948; }","duration":"210.109532ms","start":"2026-06-24T00:49:34.880416Z","end":"2026-06-24T00:49:35.090526Z","steps":["trace[662345145] 'count revisions from in-memory index tree' (duration: 209.861757ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:35.09062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.636079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T00:49:35.090668Z","caller":"traceutil/trace.go:171","msg":"trace[416558003] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:948; }","duration":"227.721121ms","start":"2026-06-24T00:49:34.862934Z","end":"2026-06-24T00:49:35.090655Z","steps":["trace[416558003] 'count revisions from in-memory index tree' (duration: 227.563747ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:49:45.747263Z","caller":"traceutil/trace.go:171","msg":"trace[1305780740] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"106.682942ms","start":"2026-06-24T00:49:45.640527Z","end":"2026-06-24T00:49:45.74721Z","steps":["trace[1305780740] 'process raft request' (duration: 33.597847ms)","trace[1305780740] 'compare' (duration: 72.584615ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:49:52.010323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.46986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:49:52.010397Z","caller":"traceutil/trace.go:171","msg":"trace[795475429] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1008; }","duration":"162.626303ms","start":"2026-06-24T00:49:51.847757Z","end":"2026-06-24T00:49:52.010383Z","steps":["trace[795475429] 'count revisions from in-memory index tree' (duration: 162.391948ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:52.010571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.623867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-24T00:49:52.01065Z","caller":"traceutil/trace.go:171","msg":"trace[594912536] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1008; }","duration":"197.784711ms","start":"2026-06-24T00:49:51.812846Z","end":"2026-06-24T00:49:52.010631Z","steps":["trace[594912536] 'range keys from in-memory index tree' (duration: 197.369492ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:52.011374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.056969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-24T00:49:52.011467Z","caller":"traceutil/trace.go:171","msg":"trace[1988654920] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1008; }","duration":"112.391555ms","start":"2026-06-24T00:49:51.899058Z","end":"2026-06-24T00:49:52.01145Z","steps":["trace[1988654920] 'range keys from in-memory index tree' (duration: 111.293134ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:49:52.116466Z","caller":"traceutil/trace.go:171","msg":"trace[35426239] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"100.977751ms","start":"2026-06-24T00:49:52.015391Z","end":"2026-06-24T00:49:52.116368Z","steps":["trace[35426239] 'process raft request' (duration: 100.772267ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:49:52.356316Z","caller":"traceutil/trace.go:171","msg":"trace[128610035] linearizableReadLoop","detail":"{readStateIndex:1049; appliedIndex:1047; }","duration":"335.830322ms","start":"2026-06-24T00:49:52.020437Z","end":"2026-06-24T00:49:52.356267Z","steps":["trace[128610035] 'read index received' (duration: 95.782611ms)","trace[128610035] 'applied index is now lower than readState.Index' (duration: 240.046431ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:49:52.356318Z","caller":"traceutil/trace.go:171","msg":"trace[193785559] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"340.649324ms","start":"2026-06-24T00:49:52.015634Z","end":"2026-06-24T00:49:52.356284Z","steps":["trace[193785559] 'process raft request' (duration: 299.12046ms)","trace[193785559] 'compare' (duration: 41.212598ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:49:52.356484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.09557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-24T00:49:52.356487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:49:52.015612Z","time spent":"340.782816ms","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:49:52.356519Z","caller":"traceutil/trace.go:171","msg":"trace[766992628] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1010; }","duration":"127.177752ms","start":"2026-06-24T00:49:52.229332Z","end":"2026-06-24T00:49:52.356509Z","steps":["trace[766992628] 'agreement among raft nodes before linearized reading' (duration: 127.097011ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:52.356545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.698237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-06-24T00:49:52.356563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.116127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:1 size:2897"} {"level":"info","ts":"2026-06-24T00:49:52.356614Z","caller":"traceutil/trace.go:171","msg":"trace[495172670] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1010; }","duration":"268.83132ms","start":"2026-06-24T00:49:52.087764Z","end":"2026-06-24T00:49:52.356595Z","steps":["trace[495172670] 'agreement among raft nodes before linearized reading' (duration: 268.663317ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:49:52.356624Z","caller":"traceutil/trace.go:171","msg":"trace[1739118420] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:1; response_revision:1010; }","duration":"336.192798ms","start":"2026-06-24T00:49:52.020413Z","end":"2026-06-24T00:49:52.356606Z","steps":["trace[1739118420] 'agreement among raft nodes before linearized reading' (duration: 335.962164ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:52.356638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.781929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-24T00:49:52.35667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:49:52.020404Z","time spent":"336.25414ms","remote":"127.0.0.1:48646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":2921,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-06-24T00:49:52.356699Z","caller":"traceutil/trace.go:171","msg":"trace[1426449471] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1010; }","duration":"257.88432ms","start":"2026-06-24T00:49:52.098796Z","end":"2026-06-24T00:49:52.35668Z","steps":["trace[1426449471] 'agreement among raft nodes before linearized reading' (duration: 257.719977ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:49:52.530849Z","caller":"traceutil/trace.go:171","msg":"trace[782949503] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"168.388981ms","start":"2026-06-24T00:49:52.362422Z","end":"2026-06-24T00:49:52.530811Z","steps":["trace[782949503] 'process raft request' (duration: 166.849711ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:49:52.530989Z","caller":"traceutil/trace.go:171","msg":"trace[2033160972] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"168.443631ms","start":"2026-06-24T00:49:52.362494Z","end":"2026-06-24T00:49:52.530938Z","steps":["trace[2033160972] 'process raft request' (duration: 168.226397ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:49:53.292566Z","caller":"traceutil/trace.go:171","msg":"trace[1765313955] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"108.946538ms","start":"2026-06-24T00:49:53.183595Z","end":"2026-06-24T00:49:53.292541Z","steps":["trace[1765313955] 'process raft request' (duration: 108.780845ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:50:10.971394Z","caller":"traceutil/trace.go:171","msg":"trace[1045024010] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"173.047834ms","start":"2026-06-24T00:50:10.798298Z","end":"2026-06-24T00:50:10.971346Z","steps":["trace[1045024010] 'process raft request' (duration: 132.656422ms)","trace[1045024010] 'compare' (duration: 40.179359ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:50:10.97978Z","caller":"traceutil/trace.go:171","msg":"trace[1884762137] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"181.385156ms","start":"2026-06-24T00:50:10.798362Z","end":"2026-06-24T00:50:10.979747Z","steps":["trace[1884762137] 'process raft request' (duration: 181.182092ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:50:13.818195Z","caller":"traceutil/trace.go:171","msg":"trace[1039539324] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"106.10804ms","start":"2026-06-24T00:50:13.712061Z","end":"2026-06-24T00:50:13.818169Z","steps":["trace[1039539324] 'process raft request' (duration: 103.68649ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:50:14.11468Z","caller":"traceutil/trace.go:171","msg":"trace[1463513605] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"138.005418ms","start":"2026-06-24T00:50:13.976649Z","end":"2026-06-24T00:50:14.114655Z","steps":["trace[1463513605] 'process raft request' (duration: 137.879136ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:50:16.55419Z","caller":"traceutil/trace.go:171","msg":"trace[741041110] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"157.060318ms","start":"2026-06-24T00:50:16.397099Z","end":"2026-06-24T00:50:16.554159Z","steps":["trace[741041110] 'process raft request' (duration: 156.820674ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:50:16.710399Z","caller":"traceutil/trace.go:171","msg":"trace[214236864] linearizableReadLoop","detail":"{readStateIndex:1138; appliedIndex:1137; }","duration":"120.650595ms","start":"2026-06-24T00:50:16.589726Z","end":"2026-06-24T00:50:16.710377Z","steps":["trace[214236864] 'read index received' (duration: 120.431162ms)","trace[214236864] 'applied index is now lower than readState.Index' (duration: 218.533µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:50:16.710518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.768667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:50:16.710507Z","caller":"traceutil/trace.go:171","msg":"trace[139812047] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"150.691695ms","start":"2026-06-24T00:50:16.559785Z","end":"2026-06-24T00:50:16.710477Z","steps":["trace[139812047] 'process raft request' (duration: 150.435441ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:50:16.710557Z","caller":"traceutil/trace.go:171","msg":"trace[590901632] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1094; }","duration":"120.860888ms","start":"2026-06-24T00:50:16.589682Z","end":"2026-06-24T00:50:16.710542Z","steps":["trace[590901632] 'agreement among raft nodes before linearized reading' (duration: 120.779737ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:50:27.50347Z","caller":"traceutil/trace.go:171","msg":"trace[1252520357] transaction","detail":"{read_only:false; response_revision:1129; number_of_response:1; }","duration":"428.431588ms","start":"2026-06-24T00:50:27.07501Z","end":"2026-06-24T00:50:27.503442Z","steps":["trace[1252520357] 'process raft request' (duration: 428.319616ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:50:27.503602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:50:27.074978Z","time spent":"428.557159ms","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:50:30.43343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.812784876s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T00:50:30.433505Z","caller":"traceutil/trace.go:171","msg":"trace[622364912] linearizableReadLoop","detail":"{readStateIndex:1176; appliedIndex:1175; }","duration":"2.575351782s","start":"2026-06-24T00:50:27.858141Z","end":"2026-06-24T00:50:30.433493Z","steps":["trace[622364912] 'read index received' (duration: 39µs)","trace[622364912] 'applied index is now lower than readState.Index' (duration: 2.575311922s)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:50:30.433602Z","caller":"traceutil/trace.go:171","msg":"trace[119377001] transaction","detail":"{read_only:false; response_revision:1130; number_of_response:1; }","duration":"3.345810375s","start":"2026-06-24T00:50:27.087782Z","end":"2026-06-24T00:50:30.433592Z","steps":["trace[119377001] 'process raft request' (duration: 532.816075ms)","trace[119377001] 'compare' (duration: 2.811793592s)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:50:30.433641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:50:27.087739Z","time spent":"3.345881226s","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:50:30.433758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.575622356s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:50:30.433773Z","caller":"traceutil/trace.go:171","msg":"trace[2109765414] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1130; }","duration":"2.575666347s","start":"2026-06-24T00:50:27.858102Z","end":"2026-06-24T00:50:30.433768Z","steps":["trace[2109765414] 'agreement among raft nodes before linearized reading' (duration: 2.575636077s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:50:30.433788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:50:27.858086Z","time spent":"2.575697918s","remote":"127.0.0.1:55148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-06-24T00:50:30.433878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.216079662s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.53\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-24T00:50:30.433976Z","caller":"traceutil/trace.go:171","msg":"trace[811040074] range","detail":"{range_begin:/registry/masterleases/199.204.45.53; range_end:; response_count:1; response_revision:1130; }","duration":"2.216221764s","start":"2026-06-24T00:50:28.217737Z","end":"2026-06-24T00:50:30.433959Z","steps":["trace[811040074] 'agreement among raft nodes before linearized reading' (duration: 2.215979481s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:50:30.434017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:50:28.217719Z","time spent":"2.216287905s","remote":"127.0.0.1:48460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.53\" "} {"level":"warn","ts":"2026-06-24T00:50:30.434044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.844354612s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T00:50:30.434031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.809046705s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T00:50:30.434061Z","caller":"traceutil/trace.go:171","msg":"trace[1374549043] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1130; }","duration":"1.844400283s","start":"2026-06-24T00:50:28.589656Z","end":"2026-06-24T00:50:30.434056Z","steps":["trace[1374549043] 'agreement among raft nodes before linearized reading' (duration: 1.844378212s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:50:30.434074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:50:28.589642Z","time spent":"1.844429994s","remote":"127.0.0.1:48432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T00:50:30.43408Z","caller":"traceutil/trace.go:171","msg":"trace[1277493425] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1130; }","duration":"1.809097546s","start":"2026-06-24T00:50:28.624969Z","end":"2026-06-24T00:50:30.434066Z","steps":["trace[1277493425] 'agreement among raft nodes before linearized reading' (duration: 1.809023735s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:50:30.434114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:50:28.624916Z","time spent":"1.809188957s","remote":"127.0.0.1:50518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"warn","ts":"2026-06-24T00:50:30.434132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.182320107s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-24T00:50:30.434023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.858105142s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:50:30.434187Z","caller":"traceutil/trace.go:171","msg":"trace[1773561811] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1130; }","duration":"2.182395778s","start":"2026-06-24T00:50:28.251779Z","end":"2026-06-24T00:50:30.434175Z","steps":["trace[1773561811] 'agreement among raft nodes before linearized reading' (duration: 2.182238066s)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:50:30.434194Z","caller":"traceutil/trace.go:171","msg":"trace[819770378] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1130; }","duration":"1.858307325s","start":"2026-06-24T00:50:28.575875Z","end":"2026-06-24T00:50:30.434182Z","steps":["trace[819770378] 'agreement among raft nodes before linearized reading' (duration: 1.858118102s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:50:30.434225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:50:28.251727Z","time spent":"2.18247995s","remote":"127.0.0.1:48668","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-06-24T00:50:30.434231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:50:28.575854Z","time spent":"1.858364455s","remote":"127.0.0.1:55296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-06-24T00:50:30.434227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.677296099s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-24T00:50:30.434306Z","caller":"traceutil/trace.go:171","msg":"trace[1872617922] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1130; }","duration":"1.67740535s","start":"2026-06-24T00:50:28.756896Z","end":"2026-06-24T00:50:30.434301Z","steps":["trace[1872617922] 'agreement among raft nodes before linearized reading' (duration: 1.677278788s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:50:30.434322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:50:28.756882Z","time spent":"1.677435431s","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-24T00:50:30.434352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.801825645s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-24T00:50:30.434419Z","caller":"traceutil/trace.go:171","msg":"trace[1141609448] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1130; }","duration":"1.801913286s","start":"2026-06-24T00:50:28.632463Z","end":"2026-06-24T00:50:30.434376Z","steps":["trace[1141609448] 'agreement among raft nodes before linearized reading' (duration: 1.801800035s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:50:30.434449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:50:28.63245Z","time spent":"1.801990607s","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-24T00:50:56.719552Z","caller":"traceutil/trace.go:171","msg":"trace[1431094521] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"115.069552ms","start":"2026-06-24T00:50:56.604456Z","end":"2026-06-24T00:50:56.719525Z","steps":["trace[1431094521] 'process raft request' (duration: 114.757887ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:50:57.003081Z","caller":"traceutil/trace.go:171","msg":"trace[1420040304] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"257.973817ms","start":"2026-06-24T00:50:56.745075Z","end":"2026-06-24T00:50:57.003049Z","steps":["trace[1420040304] 'process raft request' (duration: 256.412846ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:50:57.003281Z","caller":"traceutil/trace.go:171","msg":"trace[879575631] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"257.665033ms","start":"2026-06-24T00:50:56.745585Z","end":"2026-06-24T00:50:57.00325Z","steps":["trace[879575631] 'process raft request' (duration: 257.42033ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:50:58.902599Z","caller":"traceutil/trace.go:171","msg":"trace[1912246773] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"114.993819ms","start":"2026-06-24T00:50:58.787559Z","end":"2026-06-24T00:50:58.902552Z","steps":["trace[1912246773] 'process raft request' (duration: 79.442116ms)","trace[1912246773] 'compare' (duration: 35.268379ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:50:58.902672Z","caller":"traceutil/trace.go:171","msg":"trace[500561873] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"113.107234ms","start":"2026-06-24T00:50:58.789523Z","end":"2026-06-24T00:50:58.90263Z","steps":["trace[500561873] 'process raft request' (duration: 112.914652ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:51:03.141022Z","caller":"traceutil/trace.go:171","msg":"trace[2119852683] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"336.522774ms","start":"2026-06-24T00:51:02.80447Z","end":"2026-06-24T00:51:03.140993Z","steps":["trace[2119852683] 'process raft request' (duration: 336.366442ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:51:03.14124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:51:02.804447Z","time spent":"336.691666ms","remote":"127.0.0.1:48668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:51:03.141419Z","caller":"traceutil/trace.go:171","msg":"trace[322470961] linearizableReadLoop","detail":"{readStateIndex:1305; appliedIndex:1305; }","duration":"292.517488ms","start":"2026-06-24T00:51:02.84886Z","end":"2026-06-24T00:51:03.141377Z","steps":["trace[322470961] 'read index received' (duration: 292.506987ms)","trace[322470961] 'applied index is now lower than readState.Index' (duration: 7.87µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:51:03.141732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.707102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-24T00:51:03.141794Z","caller":"traceutil/trace.go:171","msg":"trace[769022812] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1251; }","duration":"225.803503ms","start":"2026-06-24T00:51:02.915974Z","end":"2026-06-24T00:51:03.141777Z","steps":["trace[769022812] 'agreement among raft nodes before linearized reading' (duration: 225.60342ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:51:03.142014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.155446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-24T00:51:03.142063Z","caller":"traceutil/trace.go:171","msg":"trace[357080871] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1251; }","duration":"293.235806ms","start":"2026-06-24T00:51:02.848815Z","end":"2026-06-24T00:51:03.142051Z","steps":["trace[357080871] 'agreement among raft nodes before linearized reading' (duration: 293.089564ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:51:03.142124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.086451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-24T00:51:03.142181Z","caller":"traceutil/trace.go:171","msg":"trace[666977733] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1251; }","duration":"221.193602ms","start":"2026-06-24T00:51:02.920978Z","end":"2026-06-24T00:51:03.142171Z","steps":["trace[666977733] 'agreement among raft nodes before linearized reading' (duration: 221.07721ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:51:03.142222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.663573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-abe63b5c-a343-419d-b27d-0c67aa05acaf\" ","response":"range_response_count:1 size:3578"} {"level":"info","ts":"2026-06-24T00:51:03.142373Z","caller":"traceutil/trace.go:171","msg":"trace[2139389427] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-abe63b5c-a343-419d-b27d-0c67aa05acaf; range_end:; response_count:1; response_revision:1251; }","duration":"155.840016ms","start":"2026-06-24T00:51:02.986513Z","end":"2026-06-24T00:51:03.142353Z","steps":["trace[2139389427] 'agreement among raft nodes before linearized reading' (duration: 155.524002ms)"],"step_count":1}