{"level":"warn","ts":"2026-04-14T02:00:54.437777Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-14T02:00:54.437862Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.89: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.89:2380","--initial-cluster=instance=https://199.204.45.89:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.89:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.89:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-14T02:00:54.43794Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-14T02:00:54.437955Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.89:2380"]} {"level":"info","ts":"2026-04-14T02:00:54.437979Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-14T02:00:54.438784Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"]} {"level":"info","ts":"2026-04-14T02:00:54.438872Z","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.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.89:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-14T02:00:54.540724Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"101.543148ms"} {"level":"info","ts":"2026-04-14T02:00:54.644515Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c3b8446219deb8c1","cluster-id":"fe02a46d8aa9751f"} {"level":"info","ts":"2026-04-14T02:00:54.644639Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=()"} {"level":"info","ts":"2026-04-14T02:00:54.644669Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 0"} {"level":"info","ts":"2026-04-14T02:00:54.644688Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c3b8446219deb8c1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-14T02:00:54.644702Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 1"} {"level":"info","ts":"2026-04-14T02:00:54.644762Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"} {"level":"warn","ts":"2026-04-14T02:00:54.714071Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-14T02:00:54.747466Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-14T02:00:54.758995Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-14T02:00:54.766261Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c3b8446219deb8c1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-14T02:00:54.771366Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c3b8446219deb8c1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-14T02:00:54.771293Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-14T02:00:54.771578Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-14T02:00:54.773965Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-14T02:00:54.774094Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-14T02:00:54.774558Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c3b8446219deb8c1","initial-advertise-peer-urls":["https://199.204.45.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-14T02:00:54.774598Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-14T02:00:54.772355Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"} {"level":"info","ts":"2026-04-14T02:00:54.774907Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","added-peer-id":"c3b8446219deb8c1","added-peer-peer-urls":["https://199.204.45.89:2380"]} {"level":"info","ts":"2026-04-14T02:00:54.774669Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.89:2380"} {"level":"info","ts":"2026-04-14T02:00:54.775021Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.89:2380"} {"level":"info","ts":"2026-04-14T02:00:54.946751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 is starting a new election at term 1"} {"level":"info","ts":"2026-04-14T02:00:54.946818Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-14T02:00:54.947083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgPreVoteResp from c3b8446219deb8c1 at term 1"} {"level":"info","ts":"2026-04-14T02:00:54.947131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became candidate at term 2"} {"level":"info","ts":"2026-04-14T02:00:54.947157Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgVoteResp from c3b8446219deb8c1 at term 2"} {"level":"info","ts":"2026-04-14T02:00:54.947174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became leader at term 2"} {"level":"info","ts":"2026-04-14T02:00:54.947194Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c3b8446219deb8c1 elected leader c3b8446219deb8c1 at term 2"} {"level":"info","ts":"2026-04-14T02:00:54.951475Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c3b8446219deb8c1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.89:2379]}","request-path":"/0/members/c3b8446219deb8c1/attributes","cluster-id":"fe02a46d8aa9751f","publish-timeout":"7s"} {"level":"info","ts":"2026-04-14T02:00:54.951675Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-14T02:00:54.951799Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-14T02:00:54.951829Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T02:00:54.953045Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-14T02:00:54.953137Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-14T02:00:54.954255Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T02:00:54.954416Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T02:00:54.954516Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T02:00:54.955148Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-14T02:00:54.955525Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.89:2379"} {"level":"info","ts":"2026-04-14T02:00:56.319776Z","caller":"traceutil/trace.go:171","msg":"trace[1671759231] linearizableReadLoop","detail":"{readStateIndex:8; appliedIndex:7; }","duration":"104.872323ms","start":"2026-04-14T02:00:56.214884Z","end":"2026-04-14T02:00:56.319757Z","steps":["trace[1671759231] 'read index received' (duration: 103.082839ms)","trace[1671759231] 'applied index is now lower than readState.Index' (duration: 1.788844ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:00:56.320115Z","caller":"traceutil/trace.go:171","msg":"trace[1703083209] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"105.351877ms","start":"2026-04-14T02:00:56.214733Z","end":"2026-04-14T02:00:56.320085Z","steps":["trace[1703083209] 'process raft request' (duration: 103.074468ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:00:56.320166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.244737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-14T02:00:56.3205Z","caller":"traceutil/trace.go:171","msg":"trace[580258187] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:5; }","duration":"105.532839ms","start":"2026-04-14T02:00:56.214838Z","end":"2026-04-14T02:00:56.320371Z","steps":["trace[580258187] 'agreement among raft nodes before linearized reading' (duration: 105.232006ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:00:56.348976Z","caller":"traceutil/trace.go:171","msg":"trace[1338322217] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"133.214677ms","start":"2026-04-14T02:00:56.21573Z","end":"2026-04-14T02:00:56.348945Z","steps":["trace[1338322217] 'process raft request' (duration: 133.009445ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:00:56.349035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.077135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-14T02:00:56.349072Z","caller":"traceutil/trace.go:171","msg":"trace[1345733895] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11; }","duration":"133.145617ms","start":"2026-04-14T02:00:56.215917Z","end":"2026-04-14T02:00:56.349063Z","steps":["trace[1345733895] 'agreement among raft nodes before linearized reading' (duration: 133.054416ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:00:56.349174Z","caller":"traceutil/trace.go:171","msg":"trace[1226641561] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"114.826916ms","start":"2026-04-14T02:00:56.234277Z","end":"2026-04-14T02:00:56.349104Z","steps":["trace[1226641561] 'process raft request' (duration: 114.663115ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:00:56.34921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.122101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-14T02:00:56.349301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.49373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-14T02:00:56.34931Z","caller":"traceutil/trace.go:171","msg":"trace[1946169536] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"125.214201ms","start":"2026-04-14T02:00:56.224059Z","end":"2026-04-14T02:00:56.349273Z","steps":["trace[1946169536] 'agreement among raft nodes before linearized reading' (duration: 125.05046ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:00:56.349332Z","caller":"traceutil/trace.go:171","msg":"trace[1524045127] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"132.556942ms","start":"2026-04-14T02:00:56.216768Z","end":"2026-04-14T02:00:56.349325Z","steps":["trace[1524045127] 'agreement among raft nodes before linearized reading' (duration: 132.495451ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:00:56.34938Z","caller":"traceutil/trace.go:171","msg":"trace[344320602] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"133.108445ms","start":"2026-04-14T02:00:56.216177Z","end":"2026-04-14T02:00:56.349285Z","steps":["trace[344320602] 'process raft request' (duration: 132.668772ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:00:56.350935Z","caller":"traceutil/trace.go:171","msg":"trace[1015928599] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"134.489457ms","start":"2026-04-14T02:00:56.216422Z","end":"2026-04-14T02:00:56.350912Z","steps":["trace[1015928599] 'process raft request' (duration: 132.46984ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:00:56.351042Z","caller":"traceutil/trace.go:171","msg":"trace[1556080758] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"134.711419ms","start":"2026-04-14T02:00:56.216316Z","end":"2026-04-14T02:00:56.351028Z","steps":["trace[1556080758] 'process raft request' (duration: 132.552621ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:00:56.351418Z","caller":"traceutil/trace.go:171","msg":"trace[413022355] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"134.483007ms","start":"2026-04-14T02:00:56.216924Z","end":"2026-04-14T02:00:56.351407Z","steps":["trace[413022355] 'process raft request' (duration: 131.984996ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:00:56.491436Z","caller":"traceutil/trace.go:171","msg":"trace[2053229448] linearizableReadLoop","detail":"{readStateIndex:15; appliedIndex:14; }","duration":"136.391583ms","start":"2026-04-14T02:00:56.355016Z","end":"2026-04-14T02:00:56.491407Z","steps":["trace[2053229448] 'read index received' (duration: 85.603415ms)","trace[2053229448] 'applied index is now lower than readState.Index' (duration: 50.786988ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:00:56.491474Z","caller":"traceutil/trace.go:171","msg":"trace[517711989] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"166.645152ms","start":"2026-04-14T02:00:56.324792Z","end":"2026-04-14T02:00:56.491437Z","steps":["trace[517711989] 'process raft request' (duration: 115.740823ms)","trace[517711989] 'compare' (duration: 50.738678ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:00:56.491615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.583165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3170"} {"level":"info","ts":"2026-04-14T02:00:56.491671Z","caller":"traceutil/trace.go:171","msg":"trace[1449474302] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:12; }","duration":"136.690566ms","start":"2026-04-14T02:00:56.354967Z","end":"2026-04-14T02:00:56.491657Z","steps":["trace[1449474302] 'agreement among raft nodes before linearized reading' (duration: 136.544705ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:00:56.493585Z","caller":"traceutil/trace.go:171","msg":"trace[2129869318] transaction","detail":"{read_only:false; number_of_response:0; response_revision:13; }","duration":"137.047989ms","start":"2026-04-14T02:00:56.356527Z","end":"2026-04-14T02:00:56.493575Z","steps":["trace[2129869318] 'process raft request' (duration: 136.988338ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:00:56.493599Z","caller":"traceutil/trace.go:171","msg":"trace[1990846111] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"137.22019ms","start":"2026-04-14T02:00:56.356349Z","end":"2026-04-14T02:00:56.493569Z","steps":["trace[1990846111] 'process raft request' (duration: 137.104109ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:00:56.493826Z","caller":"traceutil/trace.go:171","msg":"trace[850924986] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"135.459526ms","start":"2026-04-14T02:00:56.358359Z","end":"2026-04-14T02:00:56.493819Z","steps":["trace[850924986] 'process raft request' (duration: 135.170593ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:00:56.49411Z","caller":"traceutil/trace.go:171","msg":"trace[1899003568] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"135.732308ms","start":"2026-04-14T02:00:56.358359Z","end":"2026-04-14T02:00:56.494091Z","steps":["trace[1899003568] 'process raft request' (duration: 135.394305ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:00:56.49423Z","caller":"traceutil/trace.go:171","msg":"trace[1837002132] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"135.683287ms","start":"2026-04-14T02:00:56.358541Z","end":"2026-04-14T02:00:56.494224Z","steps":["trace[1837002132] 'process raft request' (duration: 135.495536ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:00:56.494133Z","caller":"traceutil/trace.go:171","msg":"trace[144100948] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"135.678747ms","start":"2026-04-14T02:00:56.358446Z","end":"2026-04-14T02:00:56.494125Z","steps":["trace[144100948] 'process raft request' (duration: 135.338204ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:00:56.494528Z","caller":"traceutil/trace.go:171","msg":"trace[1920623915] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"136.0165ms","start":"2026-04-14T02:00:56.358505Z","end":"2026-04-14T02:00:56.494521Z","steps":["trace[1920623915] 'process raft request' (duration: 135.665037ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:00:56.49463Z","caller":"traceutil/trace.go:171","msg":"trace[380341089] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"133.320497ms","start":"2026-04-14T02:00:56.361293Z","end":"2026-04-14T02:00:56.494613Z","steps":["trace[380341089] 'process raft request' (duration: 132.908164ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:01:00.60727Z","caller":"traceutil/trace.go:171","msg":"trace[1861389961] transaction","detail":"{read_only:false; response_revision:268; number_of_response:1; }","duration":"105.889309ms","start":"2026-04-14T02:01:00.501352Z","end":"2026-04-14T02:01:00.607241Z","steps":["trace[1861389961] 'process raft request' (duration: 65.190823ms)","trace[1861389961] 'compare' (duration: 40.312743ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:01:04.206762Z","caller":"traceutil/trace.go:171","msg":"trace[965701517] linearizableReadLoop","detail":"{readStateIndex:311; appliedIndex:310; }","duration":"103.323829ms","start":"2026-04-14T02:01:04.103413Z","end":"2026-04-14T02:01:04.206737Z","steps":["trace[965701517] 'read index received' (duration: 103.065357ms)","trace[965701517] 'applied index is now lower than readState.Index' (duration: 257.752µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:01:04.206905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.481171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-14T02:01:04.207006Z","caller":"traceutil/trace.go:171","msg":"trace[957254153] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:302; }","duration":"103.630932ms","start":"2026-04-14T02:01:04.10336Z","end":"2026-04-14T02:01:04.20699Z","steps":["trace[957254153] 'agreement among raft nodes before linearized reading' (duration: 103.460221ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:01:04.207083Z","caller":"traceutil/trace.go:171","msg":"trace[2027073789] transaction","detail":"{read_only:false; response_revision:302; number_of_response:1; }","duration":"118.71017ms","start":"2026-04-14T02:01:04.088082Z","end":"2026-04-14T02:01:04.206793Z","steps":["trace[2027073789] 'process raft request' (duration: 118.464428ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:01:13.062396Z","caller":"traceutil/trace.go:171","msg":"trace[932611135] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"815.204713ms","start":"2026-04-14T02:01:12.247167Z","end":"2026-04-14T02:01:13.062372Z","steps":["trace[932611135] 'process raft request' (duration: 815.041421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:13.063227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:12.247143Z","time spent":"815.355733ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:01:13.467054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.112304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"warn","ts":"2026-04-14T02:01:13.467063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.380449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-14T02:01:13.467179Z","caller":"traceutil/trace.go:171","msg":"trace[361684857] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:406; }","duration":"245.54377ms","start":"2026-04-14T02:01:13.221628Z","end":"2026-04-14T02:01:13.467172Z","steps":["trace[361684857] 'range keys from in-memory index tree' (duration: 245.266968ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:01:13.467131Z","caller":"traceutil/trace.go:171","msg":"trace[916662946] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:406; }","duration":"246.245935ms","start":"2026-04-14T02:01:13.220867Z","end":"2026-04-14T02:01:13.467113Z","steps":["trace[916662946] 'range keys from in-memory index tree' (duration: 245.915252ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:01:13.801344Z","caller":"traceutil/trace.go:171","msg":"trace[2075081622] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"330.310484ms","start":"2026-04-14T02:01:13.471006Z","end":"2026-04-14T02:01:13.801317Z","steps":["trace[2075081622] 'process raft request' (duration: 325.79893ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:13.801512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:13.470996Z","time spent":"330.424355ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:01:19.405113Z","caller":"traceutil/trace.go:171","msg":"trace[2143298672] linearizableReadLoop","detail":"{readStateIndex:435; appliedIndex:434; }","duration":"315.235348ms","start":"2026-04-14T02:01:19.089853Z","end":"2026-04-14T02:01:19.405089Z","steps":["trace[2143298672] 'read index received' (duration: 315.06129ms)","trace[2143298672] 'applied index is now lower than readState.Index' (duration: 172.778µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:01:19.405402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.529781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/cilium-config-agent\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:01:19.405465Z","caller":"traceutil/trace.go:171","msg":"trace[1535615480] range","detail":"{range_begin:/registry/rolebindings/kube-system/cilium-config-agent; range_end:; response_count:0; response_revision:422; }","duration":"315.625855ms","start":"2026-04-14T02:01:19.089824Z","end":"2026-04-14T02:01:19.405449Z","steps":["trace[1535615480] 'agreement among raft nodes before linearized reading' (duration: 315.50191ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:01:19.405466Z","caller":"traceutil/trace.go:171","msg":"trace[347091188] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"316.63879ms","start":"2026-04-14T02:01:19.08879Z","end":"2026-04-14T02:01:19.405429Z","steps":["trace[347091188] 'process raft request' (duration: 316.18404ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:19.405502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:19.089816Z","time spent":"315.678327ms","remote":"127.0.0.1:33394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/rolebindings/kube-system/cilium-config-agent\" "} {"level":"warn","ts":"2026-04-14T02:01:19.405627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:19.088778Z","time spent":"316.766436ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:01:21.6834Z","caller":"traceutil/trace.go:171","msg":"trace[1000399224] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"480.115679ms","start":"2026-04-14T02:01:21.20326Z","end":"2026-04-14T02:01:21.683376Z","steps":["trace[1000399224] 'process raft request' (duration: 479.991223ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:21.683769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:21.203243Z","time spent":"480.450904ms","remote":"127.0.0.1:33116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T02:01:21.691421Z","caller":"traceutil/trace.go:171","msg":"trace[1176719528] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"470.190266ms","start":"2026-04-14T02:01:21.221198Z","end":"2026-04-14T02:01:21.691388Z","steps":["trace[1176719528] 'process raft request' (duration: 469.904364ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:01:21.691443Z","caller":"traceutil/trace.go:171","msg":"trace[2023228750] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"468.019272ms","start":"2026-04-14T02:01:21.223388Z","end":"2026-04-14T02:01:21.691407Z","steps":["trace[2023228750] 'process raft request' (duration: 467.785522ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:21.691556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:21.221188Z","time spent":"470.306732ms","remote":"127.0.0.1:33116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T02:01:21.691577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:21.223382Z","time spent":"468.125867ms","remote":"127.0.0.1:33116","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-04-14T02:01:21.691656Z","caller":"traceutil/trace.go:171","msg":"trace[407064832] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"440.368606ms","start":"2026-04-14T02:01:21.251259Z","end":"2026-04-14T02:01:21.691628Z","steps":["trace[407064832] 'process raft request' (duration: 440.00363ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:01:21.691715Z","caller":"traceutil/trace.go:171","msg":"trace[1231876007] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"475.670215ms","start":"2026-04-14T02:01:21.216037Z","end":"2026-04-14T02:01:21.691707Z","steps":["trace[1231876007] 'process raft request' (duration: 474.948384ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:01:21.691721Z","caller":"traceutil/trace.go:171","msg":"trace[716320264] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"444.036135ms","start":"2026-04-14T02:01:21.247675Z","end":"2026-04-14T02:01:21.691711Z","steps":["trace[716320264] 'process raft request' (duration: 443.541464ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:01:21.691756Z","caller":"traceutil/trace.go:171","msg":"trace[1312541650] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"474.370149ms","start":"2026-04-14T02:01:21.217373Z","end":"2026-04-14T02:01:21.691743Z","steps":["trace[1312541650] 'process raft request' (duration: 473.655568ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:21.691697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.428029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:01:21.691799Z","caller":"traceutil/trace.go:171","msg":"trace[213748649] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"474.326087ms","start":"2026-04-14T02:01:21.217465Z","end":"2026-04-14T02:01:21.691791Z","steps":["trace[213748649] 'process raft request' (duration: 473.603585ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:21.691819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:21.24766Z","time spent":"444.100559ms","remote":"127.0.0.1:33116","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-04-14T02:01:21.691844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:21.217458Z","time spent":"474.367918ms","remote":"127.0.0.1:33116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T02:01:21.691872Z","caller":"traceutil/trace.go:171","msg":"trace[773307708] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"413.979375ms","start":"2026-04-14T02:01:21.277883Z","end":"2026-04-14T02:01:21.691863Z","steps":["trace[773307708] 'process raft request' (duration: 413.426891ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:01:21.691648Z","caller":"traceutil/trace.go:171","msg":"trace[1074666251] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"470.362074ms","start":"2026-04-14T02:01:21.221241Z","end":"2026-04-14T02:01:21.691603Z","steps":["trace[1074666251] 'process raft request' (duration: 469.897103ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:21.691852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:21.251248Z","time spent":"440.507432ms","remote":"127.0.0.1:33116","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-04-14T02:01:21.691917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:21.277864Z","time spent":"414.036548ms","remote":"127.0.0.1:33116","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-04-14T02:01:21.691931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:21.221236Z","time spent":"470.677848ms","remote":"127.0.0.1:33116","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-04-14T02:01:21.691946Z","caller":"traceutil/trace.go:171","msg":"trace[215563484] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"322.472094ms","start":"2026-04-14T02:01:21.369466Z","end":"2026-04-14T02:01:21.691938Z","steps":["trace[215563484] 'process raft request' (duration: 321.90643ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:21.691827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:21.217354Z","time spent":"474.443362ms","remote":"127.0.0.1:33116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T02:01:21.691977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:21.369438Z","time spent":"322.524506ms","remote":"127.0.0.1:33116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T02:01:21.691765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:21.216021Z","time spent":"475.720218ms","remote":"127.0.0.1:33116","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-04-14T02:01:21.69168Z","caller":"traceutil/trace.go:171","msg":"trace[1609414806] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"483.611591ms","start":"2026-04-14T02:01:21.208055Z","end":"2026-04-14T02:01:21.691667Z","steps":["trace[1609414806] 'process raft request' (duration: 482.797326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:21.6921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:21.208036Z","time spent":"484.046191ms","remote":"127.0.0.1:33116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T02:01:21.691446Z","caller":"traceutil/trace.go:171","msg":"trace[174115920] linearizableReadLoop","detail":"{readStateIndex:485; appliedIndex:474; }","duration":"321.173517ms","start":"2026-04-14T02:01:21.370255Z","end":"2026-04-14T02:01:21.691428Z","steps":["trace[174115920] 'read index received' (duration: 313.101625ms)","trace[174115920] 'applied index is now lower than readState.Index' (duration: 8.070852ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:01:21.692266Z","caller":"traceutil/trace.go:171","msg":"trace[1122563753] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:472; }","duration":"321.910169ms","start":"2026-04-14T02:01:21.370236Z","end":"2026-04-14T02:01:21.692146Z","steps":["trace[1122563753] 'agreement among raft nodes before linearized reading' (duration: 321.254761ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:21.692349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:21.37023Z","time spent":"322.101838ms","remote":"127.0.0.1:33054","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-04-14T02:01:21.704081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.349919ms","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-04-14T02:01:21.704135Z","caller":"traceutil/trace.go:171","msg":"trace[1525915067] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:474; }","duration":"181.447743ms","start":"2026-04-14T02:01:21.522676Z","end":"2026-04-14T02:01:21.704124Z","steps":["trace[1525915067] 'agreement among raft nodes before linearized reading' (duration: 181.345958ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:21.70425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.964308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-14T02:01:21.704275Z","caller":"traceutil/trace.go:171","msg":"trace[667654982] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:474; }","duration":"295.998759ms","start":"2026-04-14T02:01:21.40827Z","end":"2026-04-14T02:01:21.704269Z","steps":["trace[667654982] 'agreement among raft nodes before linearized reading' (duration: 295.960818ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:01:28.194565Z","caller":"traceutil/trace.go:171","msg":"trace[1625042444] linearizableReadLoop","detail":"{readStateIndex:589; appliedIndex:588; }","duration":"202.673664ms","start":"2026-04-14T02:01:27.991859Z","end":"2026-04-14T02:01:28.194533Z","steps":["trace[1625042444] 'read index received' (duration: 202.646943ms)","trace[1625042444] 'applied index is now lower than readState.Index' (duration: 25.421µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:01:28.194799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.912753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-14T02:01:28.194882Z","caller":"traceutil/trace.go:171","msg":"trace[1584553955] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:570; }","duration":"203.034988ms","start":"2026-04-14T02:01:27.991827Z","end":"2026-04-14T02:01:28.194862Z","steps":["trace[1584553955] 'agreement among raft nodes before linearized reading' (duration: 202.812769ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:01:28.373722Z","caller":"traceutil/trace.go:171","msg":"trace[404323504] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"312.90545ms","start":"2026-04-14T02:01:28.060801Z","end":"2026-04-14T02:01:28.373707Z","steps":["trace[404323504] 'process raft request' (duration: 312.512794ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:28.373867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:28.060784Z","time spent":"313.027025ms","remote":"127.0.0.1:33142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:01:28.563751Z","caller":"traceutil/trace.go:171","msg":"trace[208698037] linearizableReadLoop","detail":"{readStateIndex:592; appliedIndex:589; }","duration":"192.169375ms","start":"2026-04-14T02:01:28.37156Z","end":"2026-04-14T02:01:28.563729Z","steps":["trace[208698037] 'read index received' (duration: 1.645156ms)","trace[208698037] 'applied index is now lower than readState.Index' (duration: 190.523409ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:01:28.563848Z","caller":"traceutil/trace.go:171","msg":"trace[1446312399] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"367.551537ms","start":"2026-04-14T02:01:28.196287Z","end":"2026-04-14T02:01:28.563839Z","steps":["trace[1446312399] 'process raft request' (duration: 367.233704ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:28.563959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:28.196266Z","time spent":"367.607069ms","remote":"127.0.0.1:33108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:01:28.564269Z","caller":"traceutil/trace.go:171","msg":"trace[1253152769] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"365.033556ms","start":"2026-04-14T02:01:28.199224Z","end":"2026-04-14T02:01:28.564258Z","steps":["trace[1253152769] 'process raft request' (duration: 364.463133ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:28.56433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:28.199203Z","time spent":"365.097918ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:01:28.564461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.911026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:01:28.564509Z","caller":"traceutil/trace.go:171","msg":"trace[2015124633] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:573; }","duration":"192.976998ms","start":"2026-04-14T02:01:28.371511Z","end":"2026-04-14T02:01:28.564488Z","steps":["trace[2015124633] 'agreement among raft nodes before linearized reading' (duration: 192.922156ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:29.209939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.032183ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-14T02:01:29.210033Z","caller":"traceutil/trace.go:171","msg":"trace[996355767] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:592; }","duration":"646.201124ms","start":"2026-04-14T02:01:28.563812Z","end":"2026-04-14T02:01:29.210013Z","steps":["trace[996355767] 'read index received' (duration: 1.138286ms)","trace[996355767] 'applied index is now lower than readState.Index' (duration: 645.061848ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:01:29.210107Z","caller":"traceutil/trace.go:171","msg":"trace[592289699] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"781.608178ms","start":"2026-04-14T02:01:28.428457Z","end":"2026-04-14T02:01:29.210065Z","steps":["trace[592289699] 'process raft request' (duration: 553.260173ms)","trace[592289699] 'compare' (duration: 227.901538ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:01:29.210166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.564169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-04-14T02:01:29.210197Z","caller":"traceutil/trace.go:171","msg":"trace[1882444323] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:574; }","duration":"643.633861ms","start":"2026-04-14T02:01:28.566554Z","end":"2026-04-14T02:01:29.210188Z","steps":["trace[1882444323] 'agreement among raft nodes before linearized reading' (duration: 643.553348ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:29.210225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:28.566534Z","time spent":"643.683984ms","remote":"127.0.0.1:33226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":445,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-04-14T02:01:29.210251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:28.428433Z","time spent":"781.749064ms","remote":"127.0.0.1:33288","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-04-14T02:01:29.210268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"711.970598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-pcgdt\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-14T02:01:29.210308Z","caller":"traceutil/trace.go:171","msg":"trace[1154652482] range","detail":"{range_begin:/registry/pods/kube-system/cilium-pcgdt; range_end:; response_count:1; response_revision:574; }","duration":"712.045952ms","start":"2026-04-14T02:01:28.49825Z","end":"2026-04-14T02:01:29.210296Z","steps":["trace[1154652482] 'agreement among raft nodes before linearized reading' (duration: 711.829073ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:29.210332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:28.498231Z","time spent":"712.095094ms","remote":"127.0.0.1:33246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-pcgdt\" "} {"level":"warn","ts":"2026-04-14T02:01:29.727203Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313095188313176512,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-14T02:01:30.227892Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313095188313176512,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-14T02:01:30.461106Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.236949446s","expected-duration":"1s"} {"level":"info","ts":"2026-04-14T02:01:30.529005Z","caller":"traceutil/trace.go:171","msg":"trace[271782115] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"1.304920717s","start":"2026-04-14T02:01:29.224066Z","end":"2026-04-14T02:01:30.528987Z","steps":["trace[271782115] 'process raft request' (duration: 1.237228287s)","trace[271782115] 'compare' (duration: 67.605987ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:01:30.529101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:29.224049Z","time spent":"1.305006601s","remote":"127.0.0.1:33246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:01:30.990535Z","caller":"traceutil/trace.go:171","msg":"trace[1899616935] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"1.073454631s","start":"2026-04-14T02:01:29.917051Z","end":"2026-04-14T02:01:30.990506Z","steps":["trace[1899616935] 'process raft request' (duration: 1.073225202s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:30.990702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:29.917029Z","time spent":"1.073592737s","remote":"127.0.0.1:33234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4538,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:01:30.991281Z","caller":"traceutil/trace.go:171","msg":"trace[666419758] linearizableReadLoop","detail":"{readStateIndex:596; appliedIndex:593; }","duration":"1.764727125s","start":"2026-04-14T02:01:29.226541Z","end":"2026-04-14T02:01:30.991268Z","steps":["trace[666419758] 'read index received' (duration: 1.23476598s)","trace[666419758] 'applied index is now lower than readState.Index' (duration: 529.959855ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:01:30.991374Z","caller":"traceutil/trace.go:171","msg":"trace[1597959887] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"1.022917893s","start":"2026-04-14T02:01:29.968405Z","end":"2026-04-14T02:01:30.991323Z","steps":["trace[1597959887] 'process raft request' (duration: 1.022022157s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:30.991617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:29.968378Z","time spent":"1.023204504s","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:01:30.99147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.764927723s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-04-14T02:01:30.991822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.622807985s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T02:01:30.99193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.113782894s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-14T02:01:30.991931Z","caller":"traceutil/trace.go:171","msg":"trace[898270959] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:577; }","duration":"1.62296734s","start":"2026-04-14T02:01:29.368939Z","end":"2026-04-14T02:01:30.991906Z","steps":["trace[898270959] 'agreement among raft nodes before linearized reading' (duration: 1.622798154s)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:01:30.991966Z","caller":"traceutil/trace.go:171","msg":"trace[977617487] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:577; }","duration":"1.113840356s","start":"2026-04-14T02:01:29.878113Z","end":"2026-04-14T02:01:30.991954Z","steps":["trace[977617487] 'agreement among raft nodes before linearized reading' (duration: 1.113721522s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:30.991983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:29.36892Z","time spent":"1.623054774s","remote":"127.0.0.1:33054","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-04-14T02:01:30.992001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:29.8781Z","time spent":"1.113894998s","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-14T02:01:30.992268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.219351909s","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-04-14T02:01:30.992318Z","caller":"traceutil/trace.go:171","msg":"trace[736286561] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:577; }","duration":"1.219405932s","start":"2026-04-14T02:01:29.772891Z","end":"2026-04-14T02:01:30.992297Z","steps":["trace[736286561] 'agreement among raft nodes before linearized reading' (duration: 1.219305828s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:30.992348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:29.772881Z","time spent":"1.219461264s","remote":"127.0.0.1:33306","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":"info","ts":"2026-04-14T02:01:30.992338Z","caller":"traceutil/trace.go:171","msg":"trace[2115137373] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:577; }","duration":"1.765244266s","start":"2026-04-14T02:01:29.226493Z","end":"2026-04-14T02:01:30.991737Z","steps":["trace[2115137373] 'agreement among raft nodes before linearized reading' (duration: 1.764925533s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:30.992407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:29.226477Z","time spent":"1.765903651s","remote":"127.0.0.1:33252","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-04-14T02:01:30.992483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.230027514s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-14T02:01:30.992487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.652677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-14T02:01:30.992527Z","caller":"traceutil/trace.go:171","msg":"trace[1955047786] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:577; }","duration":"424.703109ms","start":"2026-04-14T02:01:30.567816Z","end":"2026-04-14T02:01:30.992519Z","steps":["trace[1955047786] 'agreement among raft nodes before linearized reading' (duration: 424.394917ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:01:30.992548Z","caller":"traceutil/trace.go:171","msg":"trace[1738900565] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:577; }","duration":"1.230107717s","start":"2026-04-14T02:01:29.762412Z","end":"2026-04-14T02:01:30.99252Z","steps":["trace[1738900565] 'agreement among raft nodes before linearized reading' (duration: 1.229767143s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:30.99238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.0457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-pcgdt\" ","response":"range_response_count:1 size:17145"} {"level":"warn","ts":"2026-04-14T02:01:30.992595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:29.762394Z","time spent":"1.23019236s","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-14T02:01:30.992611Z","caller":"traceutil/trace.go:171","msg":"trace[983818642] range","detail":"{range_begin:/registry/pods/kube-system/cilium-pcgdt; range_end:; response_count:1; response_revision:577; }","duration":"457.329322ms","start":"2026-04-14T02:01:30.535271Z","end":"2026-04-14T02:01:30.9926Z","steps":["trace[983818642] 'agreement among raft nodes before linearized reading' (duration: 456.836762ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:30.992644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:30.535258Z","time spent":"457.377083ms","remote":"127.0.0.1:33246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":17169,"request content":"key:\"/registry/pods/kube-system/cilium-pcgdt\" "} {"level":"warn","ts":"2026-04-14T02:01:30.992854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:30.56781Z","time spent":"424.737491ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-14T02:01:32.87124Z","caller":"traceutil/trace.go:171","msg":"trace[1729523037] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"193.078228ms","start":"2026-04-14T02:01:32.678136Z","end":"2026-04-14T02:01:32.871214Z","steps":["trace[1729523037] 'process raft request' (duration: 154.213845ms)","trace[1729523037] 'compare' (duration: 38.761819ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:01:46.942684Z","caller":"traceutil/trace.go:171","msg":"trace[619210446] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"423.906749ms","start":"2026-04-14T02:01:46.518755Z","end":"2026-04-14T02:01:46.942662Z","steps":["trace[619210446] 'process raft request' (duration: 423.704932ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:46.942836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:46.518731Z","time spent":"424.029513ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:01:46.948067Z","caller":"traceutil/trace.go:171","msg":"trace[1548244926] transaction","detail":"{read_only:false; response_revision:738; number_of_response:1; }","duration":"343.331603ms","start":"2026-04-14T02:01:46.604703Z","end":"2026-04-14T02:01:46.948034Z","steps":["trace[1548244926] 'process raft request' (duration: 343.176728ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:01:46.948237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:01:46.604676Z","time spent":"343.479978ms","remote":"127.0.0.1:33288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:02:01.03391Z","caller":"traceutil/trace.go:171","msg":"trace[1448886404] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"169.630667ms","start":"2026-04-14T02:02:00.864242Z","end":"2026-04-14T02:02:01.033873Z","steps":["trace[1448886404] 'process raft request' (duration: 169.39079ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:02:01.266525Z","caller":"traceutil/trace.go:171","msg":"trace[1179399658] transaction","detail":"{read_only:false; response_revision:875; number_of_response:1; }","duration":"223.152725ms","start":"2026-04-14T02:02:01.043337Z","end":"2026-04-14T02:02:01.26649Z","steps":["trace[1179399658] 'process raft request' (duration: 155.364354ms)","trace[1179399658] 'compare' (duration: 67.676698ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:02:01.333834Z","caller":"traceutil/trace.go:171","msg":"trace[1494675871] transaction","detail":"{read_only:false; response_revision:876; number_of_response:1; }","duration":"290.186265ms","start":"2026-04-14T02:02:01.04361Z","end":"2026-04-14T02:02:01.333796Z","steps":["trace[1494675871] 'process raft request' (duration: 289.788833ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:02:01.333938Z","caller":"traceutil/trace.go:171","msg":"trace[1946756621] linearizableReadLoop","detail":"{readStateIndex:903; appliedIndex:900; }","duration":"266.155284ms","start":"2026-04-14T02:02:01.06776Z","end":"2026-04-14T02:02:01.333915Z","steps":["trace[1946756621] 'read index received' (duration: 130.928971ms)","trace[1946756621] 'applied index is now lower than readState.Index' (duration: 135.225353ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:02:01.334145Z","caller":"traceutil/trace.go:171","msg":"trace[1513509408] transaction","detail":"{read_only:false; response_revision:877; number_of_response:1; }","duration":"289.31292ms","start":"2026-04-14T02:02:01.044822Z","end":"2026-04-14T02:02:01.334135Z","steps":["trace[1513509408] 'process raft request' (duration: 288.790016ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:02:01.334338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.06893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T02:02:01.334377Z","caller":"traceutil/trace.go:171","msg":"trace[1073846985] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:877; }","duration":"134.159473ms","start":"2026-04-14T02:02:01.200207Z","end":"2026-04-14T02:02:01.334367Z","steps":["trace[1073846985] 'agreement among raft nodes before linearized reading' (duration: 134.035199ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:02:01.334585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.374014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-04-14T02:02:01.334612Z","caller":"traceutil/trace.go:171","msg":"trace[1222541292] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:877; }","duration":"107.459106ms","start":"2026-04-14T02:02:01.227145Z","end":"2026-04-14T02:02:01.334605Z","steps":["trace[1222541292] 'agreement among raft nodes before linearized reading' (duration: 107.368023ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:02:01.334741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.979187ms","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-04-14T02:02:01.334807Z","caller":"traceutil/trace.go:171","msg":"trace[284507948] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:877; }","duration":"267.07689ms","start":"2026-04-14T02:02:01.067711Z","end":"2026-04-14T02:02:01.334788Z","steps":["trace[284507948] 'agreement among raft nodes before linearized reading' (duration: 266.890005ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:02:01.334766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.911114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-14T02:02:01.33493Z","caller":"traceutil/trace.go:171","msg":"trace[1403386436] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:877; }","duration":"129.11362ms","start":"2026-04-14T02:02:01.205803Z","end":"2026-04-14T02:02:01.334917Z","steps":["trace[1403386436] 'agreement among raft nodes before linearized reading' (duration: 128.909734ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:02:12.246562Z","caller":"traceutil/trace.go:171","msg":"trace[414255417] transaction","detail":"{read_only:false; response_revision:924; number_of_response:1; }","duration":"598.697896ms","start":"2026-04-14T02:02:11.647842Z","end":"2026-04-14T02:02:12.24654Z","steps":["trace[414255417] 'process raft request' (duration: 598.553842ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:02:12.246721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:02:11.647819Z","time spent":"598.835479ms","remote":"127.0.0.1:33306","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-04-14T02:02:20.389807Z","caller":"traceutil/trace.go:171","msg":"trace[433171284] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"106.574511ms","start":"2026-04-14T02:02:20.283163Z","end":"2026-04-14T02:02:20.389738Z","steps":["trace[433171284] 'process raft request' (duration: 106.358116ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:02:54.771044Z","caller":"traceutil/trace.go:171","msg":"trace[472190696] transaction","detail":"{read_only:false; response_revision:1066; number_of_response:1; }","duration":"171.132314ms","start":"2026-04-14T02:02:54.599892Z","end":"2026-04-14T02:02:54.771025Z","steps":["trace[472190696] 'process raft request' (duration: 170.972868ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:02:55.53299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.9628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:02:55.53306Z","caller":"traceutil/trace.go:171","msg":"trace[344158243] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1066; }","duration":"163.068634ms","start":"2026-04-14T02:02:55.369974Z","end":"2026-04-14T02:02:55.533043Z","steps":["trace[344158243] 'range keys from in-memory index tree' (duration: 162.900008ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:02:55.532991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.590121ms","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-04-14T02:02:55.533137Z","caller":"traceutil/trace.go:171","msg":"trace[781343006] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1066; }","duration":"526.753547ms","start":"2026-04-14T02:02:55.006349Z","end":"2026-04-14T02:02:55.533103Z","steps":["trace[781343006] 'count revisions from in-memory index tree' (duration: 526.522059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:02:55.533177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:02:55.006307Z","time spent":"526.85432ms","remote":"127.0.0.1:53926","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":"info","ts":"2026-04-14T02:02:55.780058Z","caller":"traceutil/trace.go:171","msg":"trace[662321416] transaction","detail":"{read_only:false; response_revision:1067; number_of_response:1; }","duration":"157.628355ms","start":"2026-04-14T02:02:55.622396Z","end":"2026-04-14T02:02:55.780024Z","steps":["trace[662321416] 'process raft request' (duration: 157.337985ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:03:11.079835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"859.221656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:03:11.079924Z","caller":"traceutil/trace.go:171","msg":"trace[446455525] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1118; }","duration":"859.376441ms","start":"2026-04-14T02:03:10.220528Z","end":"2026-04-14T02:03:11.079904Z","steps":["trace[446455525] 'count revisions from in-memory index tree' (duration: 859.139563ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:03:11.079916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"709.773645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T02:03:11.07997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:03:10.220507Z","time spent":"859.451984ms","remote":"127.0.0.1:33522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":29,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"info","ts":"2026-04-14T02:03:11.07999Z","caller":"traceutil/trace.go:171","msg":"trace[2114244279] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1118; }","duration":"709.893159ms","start":"2026-04-14T02:03:10.370079Z","end":"2026-04-14T02:03:11.079972Z","steps":["trace[2114244279] 'range keys from in-memory index tree' (duration: 709.687591ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:03:11.080048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:03:10.370059Z","time spent":"709.981612ms","remote":"127.0.0.1:33054","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-04-14T02:03:11.081097Z","caller":"traceutil/trace.go:171","msg":"trace[625362096] transaction","detail":"{read_only:false; response_revision:1119; number_of_response:1; }","duration":"253.90836ms","start":"2026-04-14T02:03:10.827161Z","end":"2026-04-14T02:03:11.08107Z","steps":["trace[625362096] 'process raft request' (duration: 186.014582ms)","trace[625362096] 'compare' (duration: 67.779864ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:03:12.067737Z","caller":"traceutil/trace.go:171","msg":"trace[500138652] linearizableReadLoop","detail":"{readStateIndex:1161; appliedIndex:1160; }","duration":"120.540227ms","start":"2026-04-14T02:03:11.947175Z","end":"2026-04-14T02:03:12.067715Z","steps":["trace[500138652] 'read index received' (duration: 120.452084ms)","trace[500138652] 'applied index is now lower than readState.Index' (duration: 86.413µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:03:12.067796Z","caller":"traceutil/trace.go:171","msg":"trace[1122403295] transaction","detail":"{read_only:false; response_revision:1120; number_of_response:1; }","duration":"153.393338ms","start":"2026-04-14T02:03:11.914376Z","end":"2026-04-14T02:03:12.067769Z","steps":["trace[1122403295] 'process raft request' (duration: 153.187411ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:03:12.067977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.784225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-14T02:03:12.068027Z","caller":"traceutil/trace.go:171","msg":"trace[2102285705] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1120; }","duration":"120.867809ms","start":"2026-04-14T02:03:11.947147Z","end":"2026-04-14T02:03:12.068015Z","steps":["trace[2102285705] 'agreement among raft nodes before linearized reading' (duration: 120.662191ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:12.484506Z","caller":"traceutil/trace.go:171","msg":"trace[2142041143] transaction","detail":"{read_only:false; response_revision:1121; number_of_response:1; }","duration":"411.743291ms","start":"2026-04-14T02:03:12.072738Z","end":"2026-04-14T02:03:12.484482Z","steps":["trace[2142041143] 'process raft request' (duration: 411.574015ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:03:12.484721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:03:12.072718Z","time spent":"411.916908ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:03:12.487786Z","caller":"traceutil/trace.go:171","msg":"trace[732682981] transaction","detail":"{read_only:false; response_revision:1122; number_of_response:1; }","duration":"414.960194ms","start":"2026-04-14T02:03:12.072785Z","end":"2026-04-14T02:03:12.487745Z","steps":["trace[732682981] 'process raft request' (duration: 414.776577ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:12.487845Z","caller":"traceutil/trace.go:171","msg":"trace[1096798774] transaction","detail":"{read_only:false; response_revision:1124; number_of_response:1; }","duration":"414.959844ms","start":"2026-04-14T02:03:12.072877Z","end":"2026-04-14T02:03:12.487837Z","steps":["trace[1096798774] 'process raft request' (duration: 414.85192ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:12.487924Z","caller":"traceutil/trace.go:171","msg":"trace[832650336] linearizableReadLoop","detail":"{readStateIndex:1165; appliedIndex:1161; }","duration":"131.823369ms","start":"2026-04-14T02:03:12.356092Z","end":"2026-04-14T02:03:12.487915Z","steps":["trace[832650336] 'read index received' (duration: 128.153671ms)","trace[832650336] 'applied index is now lower than readState.Index' (duration: 3.668868ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:03:12.487791Z","caller":"traceutil/trace.go:171","msg":"trace[833032168] transaction","detail":"{read_only:false; response_revision:1123; number_of_response:1; }","duration":"414.917482ms","start":"2026-04-14T02:03:12.072856Z","end":"2026-04-14T02:03:12.487773Z","steps":["trace[833032168] 'process raft request' (duration: 414.827608ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:03:12.487944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:03:12.072771Z","time spent":"415.087038ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:03:12.487989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:03:12.072849Z","time spent":"415.112429ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:03:12.48814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:03:12.072855Z","time spent":"415.020355ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:03:12.492235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.135038ms","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":"warn","ts":"2026-04-14T02:03:12.492284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.737443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:03:12.492311Z","caller":"traceutil/trace.go:171","msg":"trace[30919543] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1124; }","duration":"136.20561ms","start":"2026-04-14T02:03:12.356077Z","end":"2026-04-14T02:03:12.492282Z","steps":["trace[30919543] 'agreement among raft nodes before linearized reading' (duration: 131.904951ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:12.492322Z","caller":"traceutil/trace.go:171","msg":"trace[1627851012] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1124; }","duration":"122.808655ms","start":"2026-04-14T02:03:12.369501Z","end":"2026-04-14T02:03:12.49231Z","steps":["trace[1627851012] 'agreement among raft nodes before linearized reading' (duration: 118.498545ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:28.71701Z","caller":"traceutil/trace.go:171","msg":"trace[1765041517] linearizableReadLoop","detail":"{readStateIndex:1220; appliedIndex:1218; }","duration":"150.622931ms","start":"2026-04-14T02:03:28.566359Z","end":"2026-04-14T02:03:28.716982Z","steps":["trace[1765041517] 'read index received' (duration: 10.477503ms)","trace[1765041517] 'applied index is now lower than readState.Index' (duration: 140.144348ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:03:28.717148Z","caller":"traceutil/trace.go:171","msg":"trace[1253034789] transaction","detail":"{read_only:false; response_revision:1175; number_of_response:1; }","duration":"157.734179ms","start":"2026-04-14T02:03:28.559398Z","end":"2026-04-14T02:03:28.717133Z","steps":["trace[1253034789] 'process raft request' (duration: 91.902252ms)","trace[1253034789] 'compare' (duration: 65.539026ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:03:28.717313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.833339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T02:03:28.717359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.978265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-14T02:03:28.717394Z","caller":"traceutil/trace.go:171","msg":"trace[1404418464] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1175; }","duration":"150.961504ms","start":"2026-04-14T02:03:28.566412Z","end":"2026-04-14T02:03:28.717374Z","steps":["trace[1404418464] 'agreement among raft nodes before linearized reading' (duration: 150.800248ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:03:28.717428Z","caller":"traceutil/trace.go:171","msg":"trace[1169560301] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1175; }","duration":"151.091528ms","start":"2026-04-14T02:03:28.566317Z","end":"2026-04-14T02:03:28.717409Z","steps":["trace[1169560301] 'agreement among raft nodes before linearized reading' (duration: 150.914672ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:03:28.717644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.688915ms","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-04-14T02:03:28.717977Z","caller":"traceutil/trace.go:171","msg":"trace[1091853382] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1175; }","duration":"151.023826ms","start":"2026-04-14T02:03:28.566915Z","end":"2026-04-14T02:03:28.717939Z","steps":["trace[1091853382] 'agreement among raft nodes before linearized reading' (duration: 150.613181ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:06.960941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.070366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T02:04:06.961046Z","caller":"traceutil/trace.go:171","msg":"trace[1159798603] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1299; }","duration":"118.219929ms","start":"2026-04-14T02:04:06.842795Z","end":"2026-04-14T02:04:06.961015Z","steps":["trace[1159798603] 'count revisions from in-memory index tree' (duration: 117.996064ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:04:07.069351Z","caller":"traceutil/trace.go:171","msg":"trace[1120657375] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"104.657193ms","start":"2026-04-14T02:04:06.964679Z","end":"2026-04-14T02:04:07.069337Z","steps":["trace[1120657375] 'process raft request' (duration: 104.569721ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:04:07.089493Z","caller":"traceutil/trace.go:171","msg":"trace[372933812] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"124.634744ms","start":"2026-04-14T02:04:06.964842Z","end":"2026-04-14T02:04:07.089477Z","steps":["trace[372933812] 'process raft request' (duration: 124.532632ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:04:07.089554Z","caller":"traceutil/trace.go:171","msg":"trace[1416948079] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"124.635375ms","start":"2026-04-14T02:04:06.964908Z","end":"2026-04-14T02:04:07.089544Z","steps":["trace[1416948079] 'process raft request' (duration: 124.540662ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:04:15.359497Z","caller":"traceutil/trace.go:171","msg":"trace[16039077] linearizableReadLoop","detail":"{readStateIndex:1383; appliedIndex:1382; }","duration":"163.688356ms","start":"2026-04-14T02:04:15.195783Z","end":"2026-04-14T02:04:15.359471Z","steps":["trace[16039077] 'read index received' (duration: 157.279082ms)","trace[16039077] 'applied index is now lower than readState.Index' (duration: 6.408204ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:04:15.35952Z","caller":"traceutil/trace.go:171","msg":"trace[2060284196] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"195.240567ms","start":"2026-04-14T02:04:15.164252Z","end":"2026-04-14T02:04:15.359492Z","steps":["trace[2060284196] 'process raft request' (duration: 188.876533ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:04:15.359635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.832909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T02:04:15.359669Z","caller":"traceutil/trace.go:171","msg":"trace[1714573920] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1329; }","duration":"163.928462ms","start":"2026-04-14T02:04:15.195731Z","end":"2026-04-14T02:04:15.35966Z","steps":["trace[1714573920] 'agreement among raft nodes before linearized reading' (duration: 163.834139ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:05:54.001664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.709577ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T02:05:54.001771Z","caller":"traceutil/trace.go:171","msg":"trace[34604065] linearizableReadLoop","detail":"{readStateIndex:1726; appliedIndex:1725; }","duration":"178.350023ms","start":"2026-04-14T02:05:53.823404Z","end":"2026-04-14T02:05:54.001754Z","steps":["trace[34604065] 'read index received' (duration: 22.343248ms)","trace[34604065] 'applied index is now lower than readState.Index' (duration: 156.005635ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:05:54.001898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.504416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-14T02:05:54.001899Z","caller":"traceutil/trace.go:171","msg":"trace[1024557508] transaction","detail":"{read_only:false; response_revision:1652; number_of_response:1; }","duration":"232.159387ms","start":"2026-04-14T02:05:53.769715Z","end":"2026-04-14T02:05:54.001875Z","steps":["trace[1024557508] 'process raft request' (duration: 76.164482ms)","trace[1024557508] 'compare' (duration: 155.585815ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:05:54.001924Z","caller":"traceutil/trace.go:171","msg":"trace[721559960] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1652; }","duration":"178.583748ms","start":"2026-04-14T02:05:53.823331Z","end":"2026-04-14T02:05:54.001915Z","steps":["trace[721559960] 'agreement among raft nodes before linearized reading' (duration: 178.467755ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:07:25.948516Z","caller":"traceutil/trace.go:171","msg":"trace[100048724] transaction","detail":"{read_only:false; response_revision:1952; number_of_response:1; }","duration":"226.27425ms","start":"2026-04-14T02:07:25.722223Z","end":"2026-04-14T02:07:25.948497Z","steps":["trace[100048724] 'process raft request' (duration: 226.172358ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:07:25.94865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.74976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-14T02:07:25.948519Z","caller":"traceutil/trace.go:171","msg":"trace[375997376] linearizableReadLoop","detail":"{readStateIndex:2044; appliedIndex:2044; }","duration":"132.607127ms","start":"2026-04-14T02:07:25.815894Z","end":"2026-04-14T02:07:25.948501Z","steps":["trace[375997376] 'read index received' (duration: 132.600296ms)","trace[375997376] 'applied index is now lower than readState.Index' (duration: 5.761µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:07:25.948687Z","caller":"traceutil/trace.go:171","msg":"trace[1334002017] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1952; }","duration":"132.828231ms","start":"2026-04-14T02:07:25.81585Z","end":"2026-04-14T02:07:25.948678Z","steps":["trace[1334002017] 'agreement among raft nodes before linearized reading' (duration: 132.682988ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:07:26.266637Z","caller":"traceutil/trace.go:171","msg":"trace[474003779] transaction","detail":"{read_only:false; response_revision:1953; number_of_response:1; }","duration":"404.928752ms","start":"2026-04-14T02:07:25.861675Z","end":"2026-04-14T02:07:26.266604Z","steps":["trace[474003779] 'process raft request' (duration: 399.995724ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:07:26.266731Z","caller":"traceutil/trace.go:171","msg":"trace[1532496526] transaction","detail":"{read_only:false; response_revision:1954; number_of_response:1; }","duration":"314.875241ms","start":"2026-04-14T02:07:25.951847Z","end":"2026-04-14T02:07:26.266723Z","steps":["trace[1532496526] 'process raft request' (duration: 314.732908ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:07:26.266779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:07:25.861663Z","time spent":"405.042274ms","remote":"127.0.0.1:33306","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-04-14T02:07:26.266828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.707356ms","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-04-14T02:07:26.266655Z","caller":"traceutil/trace.go:171","msg":"trace[189105556] linearizableReadLoop","detail":"{readStateIndex:2045; appliedIndex:2044; }","duration":"317.925441ms","start":"2026-04-14T02:07:25.948717Z","end":"2026-04-14T02:07:26.266642Z","steps":["trace[189105556] 'read index received' (duration: 312.964603ms)","trace[189105556] 'applied index is now lower than readState.Index' (duration: 4.960158ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:07:26.266856Z","caller":"traceutil/trace.go:171","msg":"trace[1795811541] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1954; }","duration":"416.774567ms","start":"2026-04-14T02:07:25.850073Z","end":"2026-04-14T02:07:26.266848Z","steps":["trace[1795811541] 'agreement among raft nodes before linearized reading' (duration: 416.608494ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:07:26.266882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:07:25.850052Z","time spent":"416.820848ms","remote":"127.0.0.1:54020","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-04-14T02:07:26.266785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:07:25.951828Z","time spent":"314.926122ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:07:26.267028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.06432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-14T02:07:26.267078Z","caller":"traceutil/trace.go:171","msg":"trace[875997378] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1954; }","duration":"185.142342ms","start":"2026-04-14T02:07:26.08192Z","end":"2026-04-14T02:07:26.267063Z","steps":["trace[875997378] 'agreement among raft nodes before linearized reading' (duration: 184.977728ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:07:26.267216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.288462ms","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-04-14T02:07:26.267244Z","caller":"traceutil/trace.go:171","msg":"trace[1323988514] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1954; }","duration":"122.350723ms","start":"2026-04-14T02:07:26.144885Z","end":"2026-04-14T02:07:26.267236Z","steps":["trace[1323988514] 'agreement among raft nodes before linearized reading' (duration: 122.275622ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:07:40.483421Z","caller":"traceutil/trace.go:171","msg":"trace[1270828042] linearizableReadLoop","detail":"{readStateIndex:2098; appliedIndex:2096; }","duration":"115.687046ms","start":"2026-04-14T02:07:40.367713Z","end":"2026-04-14T02:07:40.4834Z","steps":["trace[1270828042] 'read index received' (duration: 35.684611ms)","trace[1270828042] 'applied index is now lower than readState.Index' (duration: 80.001605ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:07:40.483472Z","caller":"traceutil/trace.go:171","msg":"trace[1245278167] transaction","detail":"{read_only:false; response_revision:2003; number_of_response:1; }","duration":"121.064513ms","start":"2026-04-14T02:07:40.362379Z","end":"2026-04-14T02:07:40.483443Z","steps":["trace[1245278167] 'process raft request' (duration: 120.710284ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:07:40.483529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.808998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:07:40.483653Z","caller":"traceutil/trace.go:171","msg":"trace[1016167206] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2003; }","duration":"115.967382ms","start":"2026-04-14T02:07:40.367668Z","end":"2026-04-14T02:07:40.483635Z","steps":["trace[1016167206] 'agreement among raft nodes before linearized reading' (duration: 115.818369ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:07:50.689888Z","caller":"traceutil/trace.go:171","msg":"trace[1221705079] linearizableReadLoop","detail":"{readStateIndex:2131; appliedIndex:2130; }","duration":"200.487675ms","start":"2026-04-14T02:07:50.489369Z","end":"2026-04-14T02:07:50.689856Z","steps":["trace[1221705079] 'read index received' (duration: 200.380743ms)","trace[1221705079] 'applied index is now lower than readState.Index' (duration: 105.412µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:07:50.69002Z","caller":"traceutil/trace.go:171","msg":"trace[1195661167] transaction","detail":"{read_only:false; response_revision:2034; number_of_response:1; }","duration":"209.224961ms","start":"2026-04-14T02:07:50.48076Z","end":"2026-04-14T02:07:50.689985Z","steps":["trace[1195661167] 'process raft request' (duration: 208.930484ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:07:50.690302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.917345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-14T02:07:50.690357Z","caller":"traceutil/trace.go:171","msg":"trace[2056553781] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2034; }","duration":"201.019567ms","start":"2026-04-14T02:07:50.489321Z","end":"2026-04-14T02:07:50.690341Z","steps":["trace[2056553781] 'agreement among raft nodes before linearized reading' (duration: 200.679949ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:07:51.19101Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313095188313180167,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-14T02:07:51.364548Z","caller":"traceutil/trace.go:171","msg":"trace[1225889097] transaction","detail":"{read_only:false; response_revision:2035; number_of_response:1; }","duration":"834.965347ms","start":"2026-04-14T02:07:50.529551Z","end":"2026-04-14T02:07:51.364516Z","steps":["trace[1225889097] 'process raft request' (duration: 818.339965ms)","trace[1225889097] 'compare' (duration: 16.502359ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:07:51.364706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:07:50.529518Z","time spent":"835.107069ms","remote":"127.0.0.1:33306","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-04-14T02:07:51.385363Z","caller":"traceutil/trace.go:171","msg":"trace[923840291] linearizableReadLoop","detail":"{readStateIndex:2133; appliedIndex:2131; }","duration":"695.366176ms","start":"2026-04-14T02:07:50.689973Z","end":"2026-04-14T02:07:51.385339Z","steps":["trace[923840291] 'read index received' (duration: 657.931254ms)","trace[923840291] 'applied index is now lower than readState.Index' (duration: 37.433752ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:07:51.38547Z","caller":"traceutil/trace.go:171","msg":"trace[847784728] transaction","detail":"{read_only:false; response_revision:2036; number_of_response:1; }","duration":"691.036815ms","start":"2026-04-14T02:07:50.694406Z","end":"2026-04-14T02:07:51.385443Z","steps":["trace[847784728] 'process raft request' (duration: 690.804569ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:07:51.385563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"713.74258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-14T02:07:51.385587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:07:50.694385Z","time spent":"691.137467ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:07:51.385594Z","caller":"traceutil/trace.go:171","msg":"trace[1030162615] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2036; }","duration":"713.824932ms","start":"2026-04-14T02:07:50.67176Z","end":"2026-04-14T02:07:51.385585Z","steps":["trace[1030162615] 'agreement among raft nodes before linearized reading' (duration: 713.679259ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:07:51.385626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:07:50.671731Z","time spent":"713.887893ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-14T02:07:51.385796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"850.630965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-14T02:07:51.385817Z","caller":"traceutil/trace.go:171","msg":"trace[587726772] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2036; }","duration":"850.686007ms","start":"2026-04-14T02:07:50.535125Z","end":"2026-04-14T02:07:51.385811Z","steps":["trace[587726772] 'agreement among raft nodes before linearized reading' (duration: 850.625045ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:07:51.385834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:07:50.535088Z","time spent":"850.742508ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-14T02:07:52.949092Z","caller":"traceutil/trace.go:171","msg":"trace[1844188978] transaction","detail":"{read_only:false; response_revision:2040; number_of_response:1; }","duration":"249.613983ms","start":"2026-04-14T02:07:52.699456Z","end":"2026-04-14T02:07:52.94907Z","steps":["trace[1844188978] 'process raft request' (duration: 249.48204ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:07:54.126828Z","caller":"traceutil/trace.go:171","msg":"trace[1601344451] transaction","detail":"{read_only:false; response_revision:2043; number_of_response:1; }","duration":"632.503455ms","start":"2026-04-14T02:07:53.494303Z","end":"2026-04-14T02:07:54.126807Z","steps":["trace[1601344451] 'process raft request' (duration: 632.359282ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:07:54.127068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:07:53.494281Z","time spent":"632.627338ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:07:54.378953Z","caller":"traceutil/trace.go:171","msg":"trace[1282838791] linearizableReadLoop","detail":"{readStateIndex:2142; appliedIndex:2141; }","duration":"252.647564ms","start":"2026-04-14T02:07:54.126286Z","end":"2026-04-14T02:07:54.378933Z","steps":["trace[1282838791] 'read index received' (duration: 743.007µs)","trace[1282838791] 'applied index is now lower than readState.Index' (duration: 251.903417ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:07:54.379059Z","caller":"traceutil/trace.go:171","msg":"trace[1692707022] transaction","detail":"{read_only:false; response_revision:2044; number_of_response:1; }","duration":"884.239257ms","start":"2026-04-14T02:07:53.494791Z","end":"2026-04-14T02:07:54.37903Z","steps":["trace[1692707022] 'process raft request' (duration: 822.733438ms)","trace[1692707022] 'compare' (duration: 60.823603ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:07:54.379169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:07:53.494772Z","time spent":"884.33214ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:07:54.379715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.402612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-14T02:07:54.379878Z","caller":"traceutil/trace.go:171","msg":"trace[1831173428] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2044; }","duration":"253.524445ms","start":"2026-04-14T02:07:54.126246Z","end":"2026-04-14T02:07:54.37977Z","steps":["trace[1831173428] 'agreement among raft nodes before linearized reading' (duration: 252.805558ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:07:55.699659Z","caller":"traceutil/trace.go:171","msg":"trace[879169515] transaction","detail":"{read_only:false; response_revision:2048; number_of_response:1; }","duration":"201.730323ms","start":"2026-04-14T02:07:55.49789Z","end":"2026-04-14T02:07:55.699621Z","steps":["trace[879169515] 'process raft request' (duration: 201.468257ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:08.849514Z","caller":"traceutil/trace.go:171","msg":"trace[1432400908] linearizableReadLoop","detail":"{readStateIndex:2246; appliedIndex:2245; }","duration":"272.141143ms","start":"2026-04-14T02:08:08.57735Z","end":"2026-04-14T02:08:08.849491Z","steps":["trace[1432400908] 'read index received' (duration: 271.956058ms)","trace[1432400908] 'applied index is now lower than readState.Index' (duration: 184.255µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:08:08.84979Z","caller":"traceutil/trace.go:171","msg":"trace[1253610278] transaction","detail":"{read_only:false; response_revision:2143; number_of_response:1; }","duration":"396.198321ms","start":"2026-04-14T02:08:08.453576Z","end":"2026-04-14T02:08:08.849774Z","steps":["trace[1253610278] 'process raft request' (duration: 395.792072ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:08.849948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:08.45356Z","time spent":"396.306945ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:08:08.850217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.86526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-14T02:08:08.850259Z","caller":"traceutil/trace.go:171","msg":"trace[495630332] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2143; }","duration":"272.938241ms","start":"2026-04-14T02:08:08.577309Z","end":"2026-04-14T02:08:08.850248Z","steps":["trace[495630332] 'agreement among raft nodes before linearized reading' (duration: 272.821339ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:08.850409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.563634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:08:08.850478Z","caller":"traceutil/trace.go:171","msg":"trace[60398933] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:2143; }","duration":"125.667457ms","start":"2026-04-14T02:08:08.724801Z","end":"2026-04-14T02:08:08.850468Z","steps":["trace[60398933] 'agreement among raft nodes before linearized reading' (duration: 125.580975ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:09.266547Z","caller":"traceutil/trace.go:171","msg":"trace[959980169] linearizableReadLoop","detail":"{readStateIndex:2247; appliedIndex:2246; }","duration":"335.720989ms","start":"2026-04-14T02:08:08.930796Z","end":"2026-04-14T02:08:09.266517Z","steps":["trace[959980169] 'read index received' (duration: 335.497963ms)","trace[959980169] 'applied index is now lower than readState.Index' (duration: 221.996µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:08:09.266666Z","caller":"traceutil/trace.go:171","msg":"trace[1371930195] transaction","detail":"{read_only:false; response_revision:2144; number_of_response:1; }","duration":"411.748728ms","start":"2026-04-14T02:08:08.854848Z","end":"2026-04-14T02:08:09.266596Z","steps":["trace[1371930195] 'process raft request' (duration: 411.481892ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:09.266778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.962285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T02:08:09.266822Z","caller":"traceutil/trace.go:171","msg":"trace[1520399250] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:2144; }","duration":"336.065727ms","start":"2026-04-14T02:08:08.930733Z","end":"2026-04-14T02:08:09.266799Z","steps":["trace[1520399250] 'agreement among raft nodes before linearized reading' (duration: 335.918604ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:09.26686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:08.930706Z","time spent":"336.145808ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":70,"response size":31,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"warn","ts":"2026-04-14T02:08:09.266941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:08.854827Z","time spent":"411.981743ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:08:09.268974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.729332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-14T02:08:09.269035Z","caller":"traceutil/trace.go:171","msg":"trace[2055524191] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2145; }","duration":"197.826434ms","start":"2026-04-14T02:08:09.071195Z","end":"2026-04-14T02:08:09.269022Z","steps":["trace[2055524191] 'agreement among raft nodes before linearized reading' (duration: 197.615389ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:09.269305Z","caller":"traceutil/trace.go:171","msg":"trace[224922534] transaction","detail":"{read_only:false; response_revision:2145; number_of_response:1; }","duration":"329.246917ms","start":"2026-04-14T02:08:08.940048Z","end":"2026-04-14T02:08:09.269295Z","steps":["trace[224922534] 'process raft request' (duration: 328.608042ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:09.269377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:08.940031Z","time spent":"329.308208ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:08:09.269877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.329398ms","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":"info","ts":"2026-04-14T02:08:09.269945Z","caller":"traceutil/trace.go:171","msg":"trace[180536628] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:2145; }","duration":"187.41157ms","start":"2026-04-14T02:08:09.082518Z","end":"2026-04-14T02:08:09.269929Z","steps":["trace[180536628] 'agreement among raft nodes before linearized reading' (duration: 187.306557ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:21.443324Z","caller":"traceutil/trace.go:171","msg":"trace[1140955952] linearizableReadLoop","detail":"{readStateIndex:2289; appliedIndex:2288; }","duration":"118.64689ms","start":"2026-04-14T02:08:21.324637Z","end":"2026-04-14T02:08:21.443284Z","steps":["trace[1140955952] 'read index received' (duration: 118.118838ms)","trace[1140955952] 'applied index is now lower than readState.Index' (duration: 526.132µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:08:21.443581Z","caller":"traceutil/trace.go:171","msg":"trace[547258516] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"119.606253ms","start":"2026-04-14T02:08:21.323945Z","end":"2026-04-14T02:08:21.443551Z","steps":["trace[547258516] 'process raft request' (duration: 118.801654ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:21.443648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.987169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-14T02:08:21.443678Z","caller":"traceutil/trace.go:171","msg":"trace[431796538] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2184; }","duration":"119.06828ms","start":"2026-04-14T02:08:21.324602Z","end":"2026-04-14T02:08:21.44367Z","steps":["trace[431796538] 'agreement among raft nodes before linearized reading' (duration: 118.907336ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:23.233984Z","caller":"traceutil/trace.go:171","msg":"trace[1101434058] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"319.959868ms","start":"2026-04-14T02:08:22.913989Z","end":"2026-04-14T02:08:23.233949Z","steps":["trace[1101434058] 'process raft request' (duration: 319.766434ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:23.234192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:22.91395Z","time spent":"320.129082ms","remote":"127.0.0.1:33306","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-04-14T02:08:23.527025Z","caller":"traceutil/trace.go:171","msg":"trace[1672320721] linearizableReadLoop","detail":"{readStateIndex:2295; appliedIndex:2294; }","duration":"156.703597ms","start":"2026-04-14T02:08:23.370294Z","end":"2026-04-14T02:08:23.526998Z","steps":["trace[1672320721] 'read index received' (duration: 145.997265ms)","trace[1672320721] 'applied index is now lower than readState.Index' (duration: 10.704722ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:08:23.52718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.868421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:08:23.527215Z","caller":"traceutil/trace.go:171","msg":"trace[1127715686] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2189; }","duration":"156.964663ms","start":"2026-04-14T02:08:23.370236Z","end":"2026-04-14T02:08:23.527201Z","steps":["trace[1127715686] 'agreement among raft nodes before linearized reading' (duration: 156.890991ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:29.713522Z","caller":"traceutil/trace.go:171","msg":"trace[1884311071] transaction","detail":"{read_only:false; response_revision:2258; number_of_response:1; }","duration":"253.386512ms","start":"2026-04-14T02:08:29.460109Z","end":"2026-04-14T02:08:29.713495Z","steps":["trace[1884311071] 'process raft request' (duration: 253.223688ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:30.133198Z","caller":"traceutil/trace.go:171","msg":"trace[45010635] linearizableReadLoop","detail":"{readStateIndex:2366; appliedIndex:2364; }","duration":"531.591147ms","start":"2026-04-14T02:08:29.601571Z","end":"2026-04-14T02:08:30.133162Z","steps":["trace[45010635] 'read index received' (duration: 111.79338ms)","trace[45010635] 'applied index is now lower than readState.Index' (duration: 419.796397ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:08:30.133232Z","caller":"traceutil/trace.go:171","msg":"trace[461031347] transaction","detail":"{read_only:false; response_revision:2259; number_of_response:1; }","duration":"535.823897ms","start":"2026-04-14T02:08:29.597379Z","end":"2026-04-14T02:08:30.133203Z","steps":["trace[461031347] 'process raft request' (duration: 535.489459ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:30.133322Z","caller":"traceutil/trace.go:171","msg":"trace[1155042983] transaction","detail":"{read_only:false; response_revision:2260; number_of_response:1; }","duration":"478.450737ms","start":"2026-04-14T02:08:29.654833Z","end":"2026-04-14T02:08:30.133284Z","steps":["trace[1155042983] 'process raft request' (duration: 478.259092ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:30.133423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:29.597346Z","time spent":"535.994631ms","remote":"127.0.0.1:33306","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-04-14T02:08:30.133439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.586105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:08:30.133499Z","caller":"traceutil/trace.go:171","msg":"trace[279680193] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:2260; }","duration":"125.802979ms","start":"2026-04-14T02:08:30.007681Z","end":"2026-04-14T02:08:30.133484Z","steps":["trace[279680193] 'agreement among raft nodes before linearized reading' (duration: 125.689607ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:30.133496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:29.654799Z","time spent":"478.605381ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:08:30.133555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.939596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-14T02:08:30.133662Z","caller":"traceutil/trace.go:171","msg":"trace[172289120] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2260; }","duration":"532.116419ms","start":"2026-04-14T02:08:29.60152Z","end":"2026-04-14T02:08:30.133637Z","steps":["trace[172289120] 'agreement among raft nodes before linearized reading' (duration: 531.771511ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:30.133733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:29.601504Z","time spent":"532.210142ms","remote":"127.0.0.1:33306","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-04-14T02:08:30.133811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.097568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-04-14T02:08:30.133863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.091362ms","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-04-14T02:08:30.133877Z","caller":"traceutil/trace.go:171","msg":"trace[1114537717] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2260; }","duration":"523.21478ms","start":"2026-04-14T02:08:29.610645Z","end":"2026-04-14T02:08:30.13386Z","steps":["trace[1114537717] 'agreement among raft nodes before linearized reading' (duration: 522.720859ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:30.133913Z","caller":"traceutil/trace.go:171","msg":"trace[1554516300] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:2260; }","duration":"258.173144ms","start":"2026-04-14T02:08:29.875728Z","end":"2026-04-14T02:08:30.133901Z","steps":["trace[1554516300] 'agreement among raft nodes before linearized reading' (duration: 258.107363ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:30.133927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:29.61062Z","time spent":"523.293412ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-14T02:08:30.579721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.093144ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T02:08:30.580512Z","caller":"traceutil/trace.go:171","msg":"trace[873207683] transaction","detail":"{read_only:false; response_revision:2261; number_of_response:1; }","duration":"441.60008ms","start":"2026-04-14T02:08:30.138868Z","end":"2026-04-14T02:08:30.580468Z","steps":["trace[873207683] 'process raft request' (duration: 312.706868ms)","trace[873207683] 'compare' (duration: 128.025922ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:08:30.580714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:30.138837Z","time spent":"441.759883ms","remote":"127.0.0.1:33306","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-04-14T02:08:30.836679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.558431ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-14T02:08:30.837205Z","caller":"traceutil/trace.go:171","msg":"trace[18528984] linearizableReadLoop","detail":"{readStateIndex:2371; appliedIndex:2367; }","duration":"602.819523ms","start":"2026-04-14T02:08:30.234366Z","end":"2026-04-14T02:08:30.837186Z","steps":["trace[18528984] 'read index received' (duration: 217.288142ms)","trace[18528984] 'applied index is now lower than readState.Index' (duration: 385.530321ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:08:30.837268Z","caller":"traceutil/trace.go:171","msg":"trace[647410554] transaction","detail":"{read_only:false; response_revision:2262; number_of_response:1; }","duration":"695.539544ms","start":"2026-04-14T02:08:30.141694Z","end":"2026-04-14T02:08:30.837234Z","steps":["trace[647410554] 'process raft request' (duration: 550.343958ms)","trace[647410554] 'compare' (duration: 144.419388ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:08:30.837329Z","caller":"traceutil/trace.go:171","msg":"trace[739862155] transaction","detail":"{read_only:false; response_revision:2264; number_of_response:1; }","duration":"695.444462ms","start":"2026-04-14T02:08:30.141831Z","end":"2026-04-14T02:08:30.837276Z","steps":["trace[739862155] 'process raft request' (duration: 695.251108ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:30.837434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:30.141682Z","time spent":"695.680138ms","remote":"127.0.0.1:33130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T02:08:30.837454Z","caller":"traceutil/trace.go:171","msg":"trace[1994272857] transaction","detail":"{read_only:false; response_revision:2263; number_of_response:1; }","duration":"695.599636ms","start":"2026-04-14T02:08:30.141788Z","end":"2026-04-14T02:08:30.837388Z","steps":["trace[1994272857] 'process raft request' (duration: 695.211817ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:30.837564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:30.141801Z","time spent":"695.640747ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:08:30.837707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:30.14178Z","time spent":"695.79618ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:08:30.837705Z","caller":"traceutil/trace.go:171","msg":"trace[1985435431] transaction","detail":"{read_only:false; response_revision:2265; number_of_response:1; }","duration":"486.079186ms","start":"2026-04-14T02:08:30.351589Z","end":"2026-04-14T02:08:30.837669Z","steps":["trace[1985435431] 'process raft request' (duration: 485.533574ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:30.83786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.992914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T02:08:30.837744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.337186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:08:30.837925Z","caller":"traceutil/trace.go:171","msg":"trace[857275620] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2265; }","duration":"466.077066ms","start":"2026-04-14T02:08:30.371825Z","end":"2026-04-14T02:08:30.837902Z","steps":["trace[857275620] 'agreement among raft nodes before linearized reading' (duration: 466.006874ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:30.837945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.044192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-14T02:08:30.837984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:30.371798Z","time spent":"466.177649ms","remote":"127.0.0.1:33054","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-04-14T02:08:30.838016Z","caller":"traceutil/trace.go:171","msg":"trace[750226882] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2265; }","duration":"502.175955ms","start":"2026-04-14T02:08:30.335812Z","end":"2026-04-14T02:08:30.837988Z","steps":["trace[750226882] 'agreement among raft nodes before linearized reading' (duration: 501.97354ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:30.838019Z","caller":"traceutil/trace.go:171","msg":"trace[878361885] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:2265; }","duration":"603.642992ms","start":"2026-04-14T02:08:30.234314Z","end":"2026-04-14T02:08:30.837957Z","steps":["trace[878361885] 'agreement among raft nodes before linearized reading' (duration: 603.277034ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:30.838059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:30.335777Z","time spent":"502.274927ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-14T02:08:30.838149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:30.234291Z","time spent":"603.811797ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-14T02:08:30.838273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:30.351552Z","time spent":"486.313412ms","remote":"127.0.0.1:33246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1768,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T02:08:31.117023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.136489ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-14T02:08:31.117182Z","caller":"traceutil/trace.go:171","msg":"trace[1209647571] linearizableReadLoop","detail":"{readStateIndex:2373; appliedIndex:2372; }","duration":"271.127699ms","start":"2026-04-14T02:08:30.846033Z","end":"2026-04-14T02:08:31.117161Z","steps":["trace[1209647571] 'read index received' (duration: 104.893428ms)","trace[1209647571] 'applied index is now lower than readState.Index' (duration: 166.233161ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:08:31.11727Z","caller":"traceutil/trace.go:171","msg":"trace[1868224995] transaction","detail":"{read_only:false; response_revision:2266; number_of_response:1; }","duration":"273.597168ms","start":"2026-04-14T02:08:30.843613Z","end":"2026-04-14T02:08:31.11721Z","steps":["trace[1868224995] 'process raft request' (duration: 107.200622ms)","trace[1868224995] 'compare' (duration: 165.993616ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:08:31.117474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.403906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:1783"} {"level":"info","ts":"2026-04-14T02:08:31.117513Z","caller":"traceutil/trace.go:171","msg":"trace[1683774289] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:2266; }","duration":"271.503667ms","start":"2026-04-14T02:08:30.845999Z","end":"2026-04-14T02:08:31.117502Z","steps":["trace[1683774289] 'agreement among raft nodes before linearized reading' (duration: 271.287062ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:31.617734Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313095188313180669,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-14T02:08:32.066845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.163533ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-14T02:08:32.067203Z","caller":"traceutil/trace.go:171","msg":"trace[1024305030] transaction","detail":"{read_only:false; response_revision:2269; number_of_response:1; }","duration":"1.220147737s","start":"2026-04-14T02:08:30.847032Z","end":"2026-04-14T02:08:32.06718Z","steps":["trace[1024305030] 'process raft request' (duration: 1.220069925s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:32.067329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:30.847014Z","time spent":"1.22025369s","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:08:32.067409Z","caller":"traceutil/trace.go:171","msg":"trace[483286102] transaction","detail":"{read_only:false; response_revision:2267; number_of_response:1; }","duration":"1.221335055s","start":"2026-04-14T02:08:30.846026Z","end":"2026-04-14T02:08:32.067361Z","steps":["trace[483286102] 'process raft request' (duration: 897.571918ms)","trace[483286102] 'compare' (duration: 323.014099ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:08:32.067445Z","caller":"traceutil/trace.go:171","msg":"trace[41029491] transaction","detail":"{read_only:false; response_revision:2268; number_of_response:1; }","duration":"1.221283074s","start":"2026-04-14T02:08:30.846122Z","end":"2026-04-14T02:08:32.067405Z","steps":["trace[41029491] 'process raft request' (duration: 1.220838533s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:32.06751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:30.845992Z","time spent":"1.221471838s","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":518,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T02:08:32.067624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:30.846109Z","time spent":"1.221434837s","remote":"127.0.0.1:33130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":656,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T02:08:32.410524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.679715ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T02:08:32.410778Z","caller":"traceutil/trace.go:171","msg":"trace[1550795797] transaction","detail":"{read_only:false; response_revision:2270; number_of_response:1; }","duration":"1.287946432s","start":"2026-04-14T02:08:31.122791Z","end":"2026-04-14T02:08:32.410738Z","steps":["trace[1550795797] 'process raft request' (duration: 1.156929739s)","trace[1550795797] 'compare' (duration: 130.526991ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:08:32.410859Z","caller":"traceutil/trace.go:171","msg":"trace[1229038485] transaction","detail":"{read_only:false; response_revision:2271; number_of_response:1; }","duration":"1.287817499s","start":"2026-04-14T02:08:31.122997Z","end":"2026-04-14T02:08:32.410815Z","steps":["trace[1229038485] 'process raft request' (duration: 1.287665505s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:32.410943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:31.122768Z","time spent":"1.288082316s","remote":"127.0.0.1:33246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2707,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T02:08:32.410947Z","caller":"traceutil/trace.go:171","msg":"trace[90020126] transaction","detail":"{read_only:false; response_revision:2273; number_of_response:1; }","duration":"270.421682ms","start":"2026-04-14T02:08:32.140501Z","end":"2026-04-14T02:08:32.410922Z","steps":["trace[90020126] 'process raft request' (duration: 270.31813ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:32.411028Z","caller":"traceutil/trace.go:171","msg":"trace[1642718509] transaction","detail":"{read_only:false; response_revision:2272; number_of_response:1; }","duration":"338.301539ms","start":"2026-04-14T02:08:32.072649Z","end":"2026-04-14T02:08:32.410951Z","steps":["trace[1642718509] 'process raft request' (duration: 338.108654ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:32.411135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:32.072614Z","time spent":"338.466953ms","remote":"127.0.0.1:33130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":929,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T02:08:32.411204Z","caller":"traceutil/trace.go:171","msg":"trace[1486623589] linearizableReadLoop","detail":"{readStateIndex:2378; appliedIndex:2373; }","duration":"1.293919852s","start":"2026-04-14T02:08:31.117257Z","end":"2026-04-14T02:08:32.411177Z","steps":["trace[1486623589] 'read index received' (duration: 626.445409ms)","trace[1486623589] 'applied index is now lower than readState.Index' (duration: 667.472633ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:08:32.411254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:31.12293Z","time spent":"1.288228719s","remote":"127.0.0.1:33130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":837,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T02:08:32.411402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.520631576s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1243"} {"level":"info","ts":"2026-04-14T02:08:32.411455Z","caller":"traceutil/trace.go:171","msg":"trace[2031602522] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:2273; }","duration":"1.520706718s","start":"2026-04-14T02:08:30.890737Z","end":"2026-04-14T02:08:32.411444Z","steps":["trace[2031602522] 'agreement among raft nodes before linearized reading' (duration: 1.520546625s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:32.411505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:30.890726Z","time spent":"1.520760289s","remote":"127.0.0.1:33222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":1267,"request content":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" "} {"level":"warn","ts":"2026-04-14T02:08:32.411537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.101812472s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"warn","ts":"2026-04-14T02:08:32.411542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.415119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-04-14T02:08:32.411577Z","caller":"traceutil/trace.go:171","msg":"trace[864486308] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2273; }","duration":"1.101904835s","start":"2026-04-14T02:08:31.309662Z","end":"2026-04-14T02:08:32.411567Z","steps":["trace[864486308] 'agreement among raft nodes before linearized reading' (duration: 1.101782992s)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:32.411584Z","caller":"traceutil/trace.go:171","msg":"trace[94583905] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2273; }","duration":"340.508431ms","start":"2026-04-14T02:08:32.071064Z","end":"2026-04-14T02:08:32.411572Z","steps":["trace[94583905] 'agreement among raft nodes before linearized reading' (duration: 340.400369ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:32.41159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.399221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-14T02:08:32.411616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:31.309631Z","time spent":"1.101977326s","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":498,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-14T02:08:32.411623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:32.071036Z","time spent":"340.573802ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":557,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-04-14T02:08:32.411654Z","caller":"traceutil/trace.go:171","msg":"trace[1256742139] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:2273; }","duration":"457.515073ms","start":"2026-04-14T02:08:31.954114Z","end":"2026-04-14T02:08:32.411629Z","steps":["trace[1256742139] 'agreement among raft nodes before linearized reading' (duration: 457.39027ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:32.411713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:31.954074Z","time spent":"457.625345ms","remote":"127.0.0.1:33406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":55,"response size":31,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"warn","ts":"2026-04-14T02:08:32.41181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.268818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2722"} {"level":"warn","ts":"2026-04-14T02:08:32.411411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.528386879s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" ","response":"range_response_count:1 size:212"} {"level":"info","ts":"2026-04-14T02:08:32.411858Z","caller":"traceutil/trace.go:171","msg":"trace[1072789425] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:2273; }","duration":"125.36588ms","start":"2026-04-14T02:08:32.286481Z","end":"2026-04-14T02:08:32.411847Z","steps":["trace[1072789425] 'agreement among raft nodes before linearized reading' (duration: 125.295718ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:32.411847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.078158426s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-14T02:08:32.411892Z","caller":"traceutil/trace.go:171","msg":"trace[756179398] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/attachdetach-controller; range_end:; response_count:1; response_revision:2273; }","duration":"1.528960283s","start":"2026-04-14T02:08:30.882919Z","end":"2026-04-14T02:08:32.411879Z","steps":["trace[756179398] 'agreement among raft nodes before linearized reading' (duration: 1.5284333s)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:32.411902Z","caller":"traceutil/trace.go:171","msg":"trace[726913464] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2273; }","duration":"1.078244488s","start":"2026-04-14T02:08:31.333643Z","end":"2026-04-14T02:08:32.411888Z","steps":["trace[726913464] 'agreement among raft nodes before linearized reading' (duration: 1.078035083s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:32.411937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:30.88289Z","time spent":"1.529036565s","remote":"127.0.0.1:33252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":236,"request content":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" "} {"level":"warn","ts":"2026-04-14T02:08:32.411943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:31.333633Z","time spent":"1.078303049s","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-14T02:08:32.411937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.803471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:08:32.412169Z","caller":"traceutil/trace.go:171","msg":"trace[1418761511] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:2273; }","duration":"413.073467ms","start":"2026-04-14T02:08:31.999083Z","end":"2026-04-14T02:08:32.412156Z","steps":["trace[1418761511] 'agreement among raft nodes before linearized reading' (duration: 412.821541ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:32.412223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:31.99906Z","time spent":"413.146979ms","remote":"127.0.0.1:33522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":29,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"info","ts":"2026-04-14T02:08:43.116066Z","caller":"traceutil/trace.go:171","msg":"trace[1883281606] transaction","detail":"{read_only:false; response_revision:2351; number_of_response:1; }","duration":"177.018275ms","start":"2026-04-14T02:08:42.939026Z","end":"2026-04-14T02:08:43.116044Z","steps":["trace[1883281606] 'process raft request' (duration: 173.346599ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:48.269142Z","caller":"traceutil/trace.go:171","msg":"trace[1943769559] linearizableReadLoop","detail":"{readStateIndex:2487; appliedIndex:2486; }","duration":"109.983358ms","start":"2026-04-14T02:08:48.159137Z","end":"2026-04-14T02:08:48.26912Z","steps":["trace[1943769559] 'read index received' (duration: 109.774453ms)","trace[1943769559] 'applied index is now lower than readState.Index' (duration: 207.835µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:08:48.269381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.231013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2815"} {"level":"info","ts":"2026-04-14T02:08:48.269418Z","caller":"traceutil/trace.go:171","msg":"trace[1492225899] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:2376; }","duration":"110.303165ms","start":"2026-04-14T02:08:48.159102Z","end":"2026-04-14T02:08:48.269405Z","steps":["trace[1492225899] 'agreement among raft nodes before linearized reading' (duration: 110.120341ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:48.269528Z","caller":"traceutil/trace.go:171","msg":"trace[1325152049] transaction","detail":"{read_only:false; response_revision:2376; number_of_response:1; }","duration":"120.155827ms","start":"2026-04-14T02:08:48.149291Z","end":"2026-04-14T02:08:48.269447Z","steps":["trace[1325152049] 'process raft request' (duration: 119.694076ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:49.024872Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313095188313180912,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-14T02:08:49.526015Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313095188313180912,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-14T02:08:50.026412Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313095188313180912,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-14T02:08:50.361366Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.853576792s","expected-duration":"1s"} {"level":"info","ts":"2026-04-14T02:08:50.361782Z","caller":"traceutil/trace.go:171","msg":"trace[859480018] linearizableReadLoop","detail":"{readStateIndex:2490; appliedIndex:2489; }","duration":"1.837609755s","start":"2026-04-14T02:08:48.52415Z","end":"2026-04-14T02:08:50.36176Z","steps":["trace[859480018] 'read index received' (duration: 1.837364979s)","trace[859480018] 'applied index is now lower than readState.Index' (duration: 243.626µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:08:50.361923Z","caller":"traceutil/trace.go:171","msg":"trace[974184948] transaction","detail":"{read_only:false; response_revision:2379; number_of_response:1; }","duration":"1.854270818s","start":"2026-04-14T02:08:48.507613Z","end":"2026-04-14T02:08:50.361883Z","steps":["trace[974184948] 'process raft request' (duration: 1.854014282s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:50.361999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.837831251s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-14T02:08:50.362029Z","caller":"traceutil/trace.go:171","msg":"trace[1215456329] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2379; }","duration":"1.837889422s","start":"2026-04-14T02:08:48.524132Z","end":"2026-04-14T02:08:50.362021Z","steps":["trace[1215456329] 'agreement among raft nodes before linearized reading' (duration: 1.837749159s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:50.362059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:48.524065Z","time spent":"1.837988574s","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-14T02:08:50.362076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:48.507572Z","time spent":"1.854423572s","remote":"127.0.0.1:33306","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-04-14T02:08:50.362106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.259554835s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:08:50.362169Z","caller":"traceutil/trace.go:171","msg":"trace[451522473] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:2379; }","duration":"1.259650036s","start":"2026-04-14T02:08:49.102501Z","end":"2026-04-14T02:08:50.362151Z","steps":["trace[451522473] 'agreement among raft nodes before linearized reading' (duration: 1.259543794s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:50.362217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.213863309s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"warn","ts":"2026-04-14T02:08:50.362224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:49.102484Z","time spent":"1.259724599s","remote":"127.0.0.1:33216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":29,"request content":"key:\"/registry/persistentvolumes/test-pv\" "} {"level":"warn","ts":"2026-04-14T02:08:50.36224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.078557785s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T02:08:50.362303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.629268194s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-14T02:08:50.362355Z","caller":"traceutil/trace.go:171","msg":"trace[1272701480] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:2379; }","duration":"1.078832861s","start":"2026-04-14T02:08:49.283494Z","end":"2026-04-14T02:08:50.362327Z","steps":["trace[1272701480] 'agreement among raft nodes before linearized reading' (duration: 1.078510704s)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:50.362425Z","caller":"traceutil/trace.go:171","msg":"trace[616375209] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2379; }","duration":"1.629403027s","start":"2026-04-14T02:08:48.732981Z","end":"2026-04-14T02:08:50.362384Z","steps":["trace[616375209] 'agreement among raft nodes before linearized reading' (duration: 1.629028308s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:50.362434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:49.283472Z","time spent":"1.078944624s","remote":"127.0.0.1:54118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-14T02:08:50.362545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:48.732955Z","time spent":"1.629578341s","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-14T02:08:50.362296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.029235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"warn","ts":"2026-04-14T02:08:50.362644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"993.105315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T02:08:50.362663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.290103013s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-14T02:08:50.362683Z","caller":"traceutil/trace.go:171","msg":"trace[1610475634] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2379; }","duration":"574.428204ms","start":"2026-04-14T02:08:49.788222Z","end":"2026-04-14T02:08:50.36265Z","steps":["trace[1610475634] 'agreement among raft nodes before linearized reading' (duration: 573.976493ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:50.362706Z","caller":"traceutil/trace.go:171","msg":"trace[1906900556] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2379; }","duration":"993.198997ms","start":"2026-04-14T02:08:49.369492Z","end":"2026-04-14T02:08:50.362691Z","steps":["trace[1906900556] 'agreement among raft nodes before linearized reading' (duration: 993.109835ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:50.362719Z","caller":"traceutil/trace.go:171","msg":"trace[1810421388] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2379; }","duration":"1.290194185s","start":"2026-04-14T02:08:49.072508Z","end":"2026-04-14T02:08:50.362703Z","steps":["trace[1810421388] 'agreement among raft nodes before linearized reading' (duration: 1.290077323s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:50.362746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:49.369472Z","time spent":"993.265048ms","remote":"127.0.0.1:33064","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-04-14T02:08:50.362753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:49.7882Z","time spent":"574.534066ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":550,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-14T02:08:50.362789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:49.072486Z","time spent":"1.290287187s","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-14T02:08:50.363139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.355091033s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-14T02:08:50.363257Z","caller":"traceutil/trace.go:171","msg":"trace[1610706234] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2379; }","duration":"1.214922324s","start":"2026-04-14T02:08:49.148324Z","end":"2026-04-14T02:08:50.363247Z","steps":["trace[1610706234] 'agreement among raft nodes before linearized reading' (duration: 1.213835859s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:50.363293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:49.148312Z","time spent":"1.214972975s","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-04-14T02:08:50.363207Z","caller":"traceutil/trace.go:171","msg":"trace[1652231410] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2379; }","duration":"1.355237247s","start":"2026-04-14T02:08:49.007953Z","end":"2026-04-14T02:08:50.36319Z","steps":["trace[1652231410] 'agreement among raft nodes before linearized reading' (duration: 1.354692284s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:50.364022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:49.007934Z","time spent":"1.356070296s","remote":"127.0.0.1:33306","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":"info","ts":"2026-04-14T02:08:50.573373Z","caller":"traceutil/trace.go:171","msg":"trace[521103699] transaction","detail":"{read_only:false; response_revision:2380; number_of_response:1; }","duration":"205.796272ms","start":"2026-04-14T02:08:50.367548Z","end":"2026-04-14T02:08:50.573345Z","steps":["trace[521103699] 'process raft request' (duration: 128.726189ms)","trace[521103699] 'compare' (duration: 76.94808ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:08:50.643796Z","caller":"traceutil/trace.go:171","msg":"trace[1585699294] linearizableReadLoop","detail":"{readStateIndex:2493; appliedIndex:2490; }","duration":"273.750442ms","start":"2026-04-14T02:08:50.370026Z","end":"2026-04-14T02:08:50.643776Z","steps":["trace[1585699294] 'read index received' (duration: 126.23178ms)","trace[1585699294] 'applied index is now lower than readState.Index' (duration: 147.517962ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:08:50.64381Z","caller":"traceutil/trace.go:171","msg":"trace[759318086] transaction","detail":"{read_only:false; response_revision:2381; number_of_response:1; }","duration":"273.809333ms","start":"2026-04-14T02:08:50.369956Z","end":"2026-04-14T02:08:50.643766Z","steps":["trace[759318086] 'process raft request' (duration: 273.575078ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:50.643896Z","caller":"traceutil/trace.go:171","msg":"trace[1881003046] transaction","detail":"{read_only:false; response_revision:2382; number_of_response:1; }","duration":"273.865894ms","start":"2026-04-14T02:08:50.370022Z","end":"2026-04-14T02:08:50.643888Z","steps":["trace[1881003046] 'process raft request' (duration: 273.632019ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:50.644175Z","caller":"traceutil/trace.go:171","msg":"trace[1762759539] transaction","detail":"{read_only:false; response_revision:2383; number_of_response:1; }","duration":"274.10072ms","start":"2026-04-14T02:08:50.370065Z","end":"2026-04-14T02:08:50.644165Z","steps":["trace[1762759539] 'process raft request' (duration: 273.620838ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:50.644305Z","caller":"traceutil/trace.go:171","msg":"trace[540039981] transaction","detail":"{read_only:false; response_revision:2385; number_of_response:1; }","duration":"274.129601ms","start":"2026-04-14T02:08:50.370159Z","end":"2026-04-14T02:08:50.644288Z","steps":["trace[540039981] 'process raft request' (duration: 273.574548ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:50.644332Z","caller":"traceutil/trace.go:171","msg":"trace[1617034287] transaction","detail":"{read_only:false; response_revision:2386; number_of_response:1; }","duration":"273.967487ms","start":"2026-04-14T02:08:50.37033Z","end":"2026-04-14T02:08:50.644297Z","steps":["trace[1617034287] 'process raft request' (duration: 273.421934ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:50.644542Z","caller":"traceutil/trace.go:171","msg":"trace[1438866481] transaction","detail":"{read_only:false; response_revision:2384; number_of_response:1; }","duration":"274.396997ms","start":"2026-04-14T02:08:50.370126Z","end":"2026-04-14T02:08:50.644523Z","steps":["trace[1438866481] 'process raft request' (duration: 273.583478ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:50.644599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.55423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:08:50.644868Z","caller":"traceutil/trace.go:171","msg":"trace[2142259184] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:2386; }","duration":"274.880188ms","start":"2026-04-14T02:08:50.369977Z","end":"2026-04-14T02:08:50.644857Z","steps":["trace[2142259184] 'agreement among raft nodes before linearized reading' (duration: 274.570031ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:50.748914Z","caller":"traceutil/trace.go:171","msg":"trace[1812090387] linearizableReadLoop","detail":"{readStateIndex:2498; appliedIndex:2497; }","duration":"105.040432ms","start":"2026-04-14T02:08:50.643852Z","end":"2026-04-14T02:08:50.748892Z","steps":["trace[1812090387] 'read index received' (duration: 49.748821ms)","trace[1812090387] 'applied index is now lower than readState.Index' (duration: 55.290951ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:08:50.74903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.631496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:08:50.749056Z","caller":"traceutil/trace.go:171","msg":"trace[340656411] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:2387; }","duration":"377.686337ms","start":"2026-04-14T02:08:50.371361Z","end":"2026-04-14T02:08:50.749048Z","steps":["trace[340656411] 'agreement among raft nodes before linearized reading' (duration: 377.601565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:50.749082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:50.371354Z","time spent":"377.722138ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-14T02:08:50.7492Z","caller":"traceutil/trace.go:171","msg":"trace[1892141036] transaction","detail":"{read_only:false; response_revision:2387; number_of_response:1; }","duration":"217.679422ms","start":"2026-04-14T02:08:50.531469Z","end":"2026-04-14T02:08:50.749148Z","steps":["trace[1892141036] 'process raft request' (duration: 162.186916ms)","trace[1892141036] 'compare' (duration: 55.156128ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:08:50.749403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.540514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:08:50.749489Z","caller":"traceutil/trace.go:171","msg":"trace[722822197] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2387; }","duration":"377.649066ms","start":"2026-04-14T02:08:50.371822Z","end":"2026-04-14T02:08:50.749472Z","steps":["trace[722822197] 'agreement among raft nodes before linearized reading' (duration: 377.472962ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:50.749562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:50.371818Z","time spent":"377.736358ms","remote":"127.0.0.1:33054","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-04-14T02:08:54.889712Z","caller":"traceutil/trace.go:171","msg":"trace[403340573] linearizableReadLoop","detail":"{readStateIndex:2514; appliedIndex:2513; }","duration":"436.741586ms","start":"2026-04-14T02:08:54.452954Z","end":"2026-04-14T02:08:54.889696Z","steps":["trace[403340573] 'read index received' (duration: 436.592122ms)","trace[403340573] 'applied index is now lower than readState.Index' (duration: 148.844µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T02:08:54.889887Z","caller":"traceutil/trace.go:171","msg":"trace[702095864] transaction","detail":"{read_only:false; response_revision:2402; number_of_response:1; }","duration":"511.559596ms","start":"2026-04-14T02:08:54.37832Z","end":"2026-04-14T02:08:54.889879Z","steps":["trace[702095864] 'process raft request' (duration: 511.269299ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:54.889957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:54.378291Z","time spent":"511.621058ms","remote":"127.0.0.1:33306","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-04-14T02:08:54.890096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.135245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T02:08:54.89012Z","caller":"traceutil/trace.go:171","msg":"trace[301056588] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:2402; }","duration":"437.220767ms","start":"2026-04-14T02:08:54.452892Z","end":"2026-04-14T02:08:54.890112Z","steps":["trace[301056588] 'agreement among raft nodes before linearized reading' (duration: 437.178036ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:54.890138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T02:08:54.452875Z","time spent":"437.258398ms","remote":"127.0.0.1:33272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-04-14T02:08:54.89033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.478262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-14T02:08:54.890349Z","caller":"traceutil/trace.go:171","msg":"trace[2142237544] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2402; }","duration":"142.512793ms","start":"2026-04-14T02:08:54.747831Z","end":"2026-04-14T02:08:54.890344Z","steps":["trace[2142237544] 'agreement among raft nodes before linearized reading' (duration: 142.445291ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:54.890386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.070094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-14T02:08:54.89043Z","caller":"traceutil/trace.go:171","msg":"trace[1232955260] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2402; }","duration":"230.134024ms","start":"2026-04-14T02:08:54.66028Z","end":"2026-04-14T02:08:54.890414Z","steps":["trace[1232955260] 'agreement among raft nodes before linearized reading' (duration: 230.051323ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:54.89047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.839282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-14T02:08:54.890509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.646072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T02:08:54.89054Z","caller":"traceutil/trace.go:171","msg":"trace[1010335505] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:2402; }","duration":"138.714113ms","start":"2026-04-14T02:08:54.751822Z","end":"2026-04-14T02:08:54.890536Z","steps":["trace[1010335505] 'agreement among raft nodes before linearized reading' (duration: 138.675032ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:54.890575Z","caller":"traceutil/trace.go:171","msg":"trace[1200968620] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2402; }","duration":"230.911153ms","start":"2026-04-14T02:08:54.659593Z","end":"2026-04-14T02:08:54.890504Z","steps":["trace[1200968620] 'agreement among raft nodes before linearized reading' (duration: 230.81179ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:54.890594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.535691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-14T02:08:54.890613Z","caller":"traceutil/trace.go:171","msg":"trace[1266521970] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2402; }","duration":"229.574522ms","start":"2026-04-14T02:08:54.661034Z","end":"2026-04-14T02:08:54.890608Z","steps":["trace[1266521970] 'agreement among raft nodes before linearized reading' (duration: 229.512481ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:08:54.890363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.747827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-14T02:08:54.890712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.874685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-14T02:08:54.890485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.612127ms","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-04-14T02:08:54.890739Z","caller":"traceutil/trace.go:171","msg":"trace[1382450590] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2402; }","duration":"231.928477ms","start":"2026-04-14T02:08:54.658802Z","end":"2026-04-14T02:08:54.89073Z","steps":["trace[1382450590] 'agreement among raft nodes before linearized reading' (duration: 231.854475ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:54.890761Z","caller":"traceutil/trace.go:171","msg":"trace[1586099607] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:2402; }","duration":"131.928845ms","start":"2026-04-14T02:08:54.758825Z","end":"2026-04-14T02:08:54.890754Z","steps":["trace[1586099607] 'agreement among raft nodes before linearized reading' (duration: 131.637978ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:08:54.890718Z","caller":"traceutil/trace.go:171","msg":"trace[637474527] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2402; }","duration":"233.164726ms","start":"2026-04-14T02:08:54.657549Z","end":"2026-04-14T02:08:54.890714Z","steps":["trace[637474527] 'agreement among raft nodes before linearized reading' (duration: 232.654324ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:09:13.177316Z","caller":"traceutil/trace.go:171","msg":"trace[451446362] transaction","detail":"{read_only:false; response_revision:2493; number_of_response:1; }","duration":"104.284024ms","start":"2026-04-14T02:09:13.073007Z","end":"2026-04-14T02:09:13.177291Z","steps":["trace[451446362] 'process raft request' (duration: 103.129255ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:09:13.1774Z","caller":"traceutil/trace.go:171","msg":"trace[822629945] transaction","detail":"{read_only:false; response_revision:2494; number_of_response:1; }","duration":"104.311774ms","start":"2026-04-14T02:09:13.073068Z","end":"2026-04-14T02:09:13.177379Z","steps":["trace[822629945] 'process raft request' (duration: 104.124869ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:09:13.177545Z","caller":"traceutil/trace.go:171","msg":"trace[25107146] transaction","detail":"{read_only:false; response_revision:2495; number_of_response:1; }","duration":"103.953515ms","start":"2026-04-14T02:09:13.073583Z","end":"2026-04-14T02:09:13.177537Z","steps":["trace[25107146] 'process raft request' (duration: 103.646617ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:09:13.177621Z","caller":"traceutil/trace.go:171","msg":"trace[915406510] transaction","detail":"{read_only:false; response_revision:2496; number_of_response:1; }","duration":"103.165176ms","start":"2026-04-14T02:09:13.074448Z","end":"2026-04-14T02:09:13.177613Z","steps":["trace[915406510] 'process raft request' (duration: 102.820247ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:09:17.179594Z","caller":"traceutil/trace.go:171","msg":"trace[1574706728] linearizableReadLoop","detail":"{readStateIndex:2621; appliedIndex:2620; }","duration":"180.298703ms","start":"2026-04-14T02:09:16.999272Z","end":"2026-04-14T02:09:17.179571Z","steps":["trace[1574706728] 'read index received' (duration: 180.074198ms)","trace[1574706728] 'applied index is now lower than readState.Index' (duration: 223.445µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T02:09:17.179771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.476107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-public/default\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-04-14T02:09:17.179749Z","caller":"traceutil/trace.go:171","msg":"trace[612814607] transaction","detail":"{read_only:false; response_revision:2505; number_of_response:1; }","duration":"187.772939ms","start":"2026-04-14T02:09:16.991934Z","end":"2026-04-14T02:09:17.179706Z","steps":["trace[612814607] 'process raft request' (duration: 187.488071ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T02:09:17.179822Z","caller":"traceutil/trace.go:171","msg":"trace[1805843039] range","detail":"{range_begin:/registry/serviceaccounts/kube-public/default; range_end:; response_count:1; response_revision:2505; }","duration":"180.57822ms","start":"2026-04-14T02:09:16.99923Z","end":"2026-04-14T02:09:17.179809Z","steps":["trace[1805843039] 'agreement among raft nodes before linearized reading' (duration: 180.468017ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:09:17.180047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.48622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/ceph-csi-rbd-provisioner\" ","response":"range_response_count:1 size:11246"} {"level":"info","ts":"2026-04-14T02:09:17.180118Z","caller":"traceutil/trace.go:171","msg":"trace[567548396] range","detail":"{range_begin:/registry/deployments/kube-system/ceph-csi-rbd-provisioner; range_end:; response_count:1; response_revision:2505; }","duration":"164.600993ms","start":"2026-04-14T02:09:17.0155Z","end":"2026-04-14T02:09:17.180101Z","steps":["trace[567548396] 'agreement among raft nodes before linearized reading' (duration: 164.389898ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T02:09:17.180745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.073099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-14T02:09:17.180831Z","caller":"traceutil/trace.go:171","msg":"trace[1677222107] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2505; }","duration":"174.13863ms","start":"2026-04-14T02:09:17.006646Z","end":"2026-04-14T02:09:17.180785Z","steps":["trace[1677222107] 'agreement among raft nodes before linearized reading' (duration: 173.155656ms)"],"step_count":1}