{"level":"warn","ts":"2026-04-20T02:02:49.289778Z","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-20T02:02:49.289917Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.141: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.141:2380","--initial-cluster=instance=https://199.204.45.141:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.141:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.141: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-20T02:02:49.290012Z","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-20T02:02:49.290028Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.141:2380"]} {"level":"info","ts":"2026-04-20T02:02:49.290056Z","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-20T02:02:49.291117Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"]} {"level":"info","ts":"2026-04-20T02:02:49.291218Z","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.141:2380"],"listen-peer-urls":["https://199.204.45.141:2380"],"advertise-client-urls":["https://199.204.45.141:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.141: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-20T02:02:49.295862Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.320645ms"} {"level":"info","ts":"2026-04-20T02:02:49.307751Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9ef3b4f68930dc2","cluster-id":"b19a5957e6e65747"} {"level":"info","ts":"2026-04-20T02:02:49.30787Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T02:02:49.307907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became follower at term 0"} {"level":"info","ts":"2026-04-20T02:02:49.307924Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9ef3b4f68930dc2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T02:02:49.307938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became follower at term 1"} {"level":"info","ts":"2026-04-20T02:02:49.30799Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=(715856078018121154)"} {"level":"warn","ts":"2026-04-20T02:02:49.317585Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T02:02:49.320725Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T02:02:49.321954Z","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-20T02:02:49.326709Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9ef3b4f68930dc2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T02:02:49.326909Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9ef3b4f68930dc2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T02:02:49.327081Z","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-20T02:02:49.327195Z","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-20T02:02:49.327207Z","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-20T02:02:49.32794Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=(715856078018121154)"} {"level":"info","ts":"2026-04-20T02:02:49.328067Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b19a5957e6e65747","local-member-id":"9ef3b4f68930dc2","added-peer-id":"9ef3b4f68930dc2","added-peer-peer-urls":["https://199.204.45.141:2380"]} {"level":"info","ts":"2026-04-20T02:02:49.329797Z","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-20T02:02:49.330051Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9ef3b4f68930dc2","initial-advertise-peer-urls":["https://199.204.45.141:2380"],"listen-peer-urls":["https://199.204.45.141:2380"],"advertise-client-urls":["https://199.204.45.141:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T02:02:49.330084Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T02:02:49.330208Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.141:2380"} {"level":"info","ts":"2026-04-20T02:02:49.330222Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.141:2380"} {"level":"info","ts":"2026-04-20T02:02:50.308842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T02:02:50.308927Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T02:02:50.309028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 received MsgPreVoteResp from 9ef3b4f68930dc2 at term 1"} {"level":"info","ts":"2026-04-20T02:02:50.309069Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became candidate at term 2"} {"level":"info","ts":"2026-04-20T02:02:50.309084Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 received MsgVoteResp from 9ef3b4f68930dc2 at term 2"} {"level":"info","ts":"2026-04-20T02:02:50.309103Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became leader at term 2"} {"level":"info","ts":"2026-04-20T02:02:50.309119Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9ef3b4f68930dc2 elected leader 9ef3b4f68930dc2 at term 2"} {"level":"info","ts":"2026-04-20T02:02:51.067805Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T02:02:51.067823Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9ef3b4f68930dc2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.141:2379]}","request-path":"/0/members/9ef3b4f68930dc2/attributes","cluster-id":"b19a5957e6e65747","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T02:02:51.068194Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T02:02:51.068263Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T02:02:51.068345Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T02:02:51.068377Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T02:02:51.07207Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.141:2379"} {"level":"info","ts":"2026-04-20T02:02:51.072126Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T02:02:51.07966Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b19a5957e6e65747","local-member-id":"9ef3b4f68930dc2","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T02:02:51.080016Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T02:02:51.080072Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-20T02:02:51.556877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.029466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.556975Z","caller":"traceutil/trace.go:171","msg":"trace[1951256937] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"233.216921ms","start":"2026-04-20T02:02:51.323744Z","end":"2026-04-20T02:02:51.556961Z","steps":["trace[1951256937] 'count revisions from in-memory index tree' (duration: 232.873913ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.557033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.883904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.557055Z","caller":"traceutil/trace.go:171","msg":"trace[1580319678] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"314.936475ms","start":"2026-04-20T02:02:51.242113Z","end":"2026-04-20T02:02:51.55705Z","steps":["trace[1580319678] 'count revisions from in-memory index tree' (duration: 314.797942ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.557082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:51.242105Z","time spent":"314.970465ms","remote":"127.0.0.1:57808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":27,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"warn","ts":"2026-04-20T02:02:51.557499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.040115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.557558Z","caller":"traceutil/trace.go:171","msg":"trace[1421228309] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"305.122607ms","start":"2026-04-20T02:02:51.252423Z","end":"2026-04-20T02:02:51.557546Z","steps":["trace[1421228309] 'count revisions from in-memory index tree' (duration: 305.013065ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.557599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:51.115502Z","time spent":"442.091672ms","remote":"127.0.0.1:57718","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-20T02:02:51.55762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:51.252419Z","time spent":"305.187009ms","remote":"127.0.0.1:57818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"warn","ts":"2026-04-20T02:02:51.557824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.861277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.5579Z","caller":"traceutil/trace.go:171","msg":"trace[1956868301] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1; }","duration":"222.006469ms","start":"2026-04-20T02:02:51.335877Z","end":"2026-04-20T02:02:51.557884Z","steps":["trace[1956868301] 'count revisions from in-memory index tree' (duration: 221.730394ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.557978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.580848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.558048Z","caller":"traceutil/trace.go:171","msg":"trace[1601701686] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"305.64176ms","start":"2026-04-20T02:02:51.25237Z","end":"2026-04-20T02:02:51.558012Z","steps":["trace[1601701686] 'range keys from in-memory index tree' (duration: 305.463556ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.558099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:51.252356Z","time spent":"305.731571ms","remote":"127.0.0.1:57818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" limit:10000 "} {"level":"warn","ts":"2026-04-20T02:02:51.558219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.981778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.558258Z","caller":"traceutil/trace.go:171","msg":"trace[278045304] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1; }","duration":"222.086861ms","start":"2026-04-20T02:02:51.336163Z","end":"2026-04-20T02:02:51.55825Z","steps":["trace[278045304] 'range keys from in-memory index tree' (duration: 221.875306ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.558256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.563811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.558322Z","caller":"traceutil/trace.go:171","msg":"trace[860211736] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"439.639892ms","start":"2026-04-20T02:02:51.118658Z","end":"2026-04-20T02:02:51.558298Z","steps":["trace[860211736] 'range keys from in-memory index tree' (duration: 439.461608ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.558372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:51.118646Z","time spent":"439.714184ms","remote":"127.0.0.1:57722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":121,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 "} {"level":"warn","ts":"2026-04-20T02:02:51.558421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.550146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-20T02:02:51.558406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.257217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.558487Z","caller":"traceutil/trace.go:171","msg":"trace[1549053890] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"211.617858ms","start":"2026-04-20T02:02:51.34682Z","end":"2026-04-20T02:02:51.558437Z","steps":["trace[1549053890] 'range keys from in-memory index tree' (duration: 211.386782ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:02:51.558502Z","caller":"traceutil/trace.go:171","msg":"trace[1231354412] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"288.37955ms","start":"2026-04-20T02:02:51.270074Z","end":"2026-04-20T02:02:51.558453Z","steps":["trace[1231354412] 'range keys from in-memory index tree' (duration: 288.086534ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.558617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.835317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.558688Z","caller":"traceutil/trace.go:171","msg":"trace[935264304] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"439.933339ms","start":"2026-04-20T02:02:51.118741Z","end":"2026-04-20T02:02:51.558674Z","steps":["trace[935264304] 'count revisions from in-memory index tree' (duration: 439.775506ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.558715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.772041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-20T02:02:51.558736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:51.118718Z","time spent":"440.006142ms","remote":"127.0.0.1:57722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"warn","ts":"2026-04-20T02:02:51.558794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.152634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-20T02:02:51.558758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.466672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.558839Z","caller":"traceutil/trace.go:171","msg":"trace[2110216008] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1; }","duration":"201.235825ms","start":"2026-04-20T02:02:51.357598Z","end":"2026-04-20T02:02:51.558833Z","steps":["trace[2110216008] 'range keys from in-memory index tree' (duration: 201.121582ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:02:51.55884Z","caller":"traceutil/trace.go:171","msg":"trace[1268622225] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"288.564925ms","start":"2026-04-20T02:02:51.270258Z","end":"2026-04-20T02:02:51.558822Z","steps":["trace[1268622225] 'count revisions from in-memory index tree' (duration: 288.319269ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.558903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.257399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.558947Z","caller":"traceutil/trace.go:171","msg":"trace[1199585302] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1; }","duration":"389.357882ms","start":"2026-04-20T02:02:51.169576Z","end":"2026-04-20T02:02:51.558934Z","steps":["trace[1199585302] 'count revisions from in-memory index tree' (duration: 389.133297ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.558994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:51.16953Z","time spent":"389.453674ms","remote":"127.0.0.1:57756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":0,"response size":27,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-04-20T02:02:51.559041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.511162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.559068Z","caller":"traceutil/trace.go:171","msg":"trace[1572183343] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1; }","duration":"201.573304ms","start":"2026-04-20T02:02:51.357485Z","end":"2026-04-20T02:02:51.559059Z","steps":["trace[1572183343] 'count revisions from in-memory index tree' (duration: 201.375059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.559078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.988507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.559178Z","caller":"traceutil/trace.go:171","msg":"trace[1801003066] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"252.154011ms","start":"2026-04-20T02:02:51.307005Z","end":"2026-04-20T02:02:51.559159Z","steps":["trace[1801003066] 'count revisions from in-memory index tree' (duration: 251.894375ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.559208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.140458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-20T02:02:51.55922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.677308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.559251Z","caller":"traceutil/trace.go:171","msg":"trace[1106318722] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"377.728229ms","start":"2026-04-20T02:02:51.181514Z","end":"2026-04-20T02:02:51.559242Z","steps":["trace[1106318722] 'count revisions from in-memory index tree' (duration: 377.647327ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.559201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.479417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-20T02:02:51.559292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.268501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-20T02:02:51.559306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:51.181509Z","time spent":"377.78884ms","remote":"127.0.0.1:57762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-04-20T02:02:51.559342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.242234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.559305Z","caller":"traceutil/trace.go:171","msg":"trace[1181601852] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"235.63784ms","start":"2026-04-20T02:02:51.323657Z","end":"2026-04-20T02:02:51.559294Z","steps":["trace[1181601852] 'range keys from in-memory index tree' (duration: 235.363323ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:02:51.559365Z","caller":"traceutil/trace.go:171","msg":"trace[1517915542] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"140.280485ms","start":"2026-04-20T02:02:51.41908Z","end":"2026-04-20T02:02:51.559361Z","steps":["trace[1517915542] 'range keys from in-memory index tree' (duration: 140.158352ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.55944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.449302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-20T02:02:51.559453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.187511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.55949Z","caller":"traceutil/trace.go:171","msg":"trace[316498849] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"364.242893ms","start":"2026-04-20T02:02:51.195233Z","end":"2026-04-20T02:02:51.559476Z","steps":["trace[316498849] 'range keys from in-memory index tree' (duration: 364.101499ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:02:51.559501Z","caller":"traceutil/trace.go:171","msg":"trace[210769015] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"274.536355ms","start":"2026-04-20T02:02:51.284935Z","end":"2026-04-20T02:02:51.559471Z","steps":["trace[210769015] 'range keys from in-memory index tree' (duration: 274.36401ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.559528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:51.195222Z","time spent":"364.289523ms","remote":"127.0.0.1:57770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":27,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 "} {"level":"warn","ts":"2026-04-20T02:02:51.559543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.334736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.559573Z","caller":"traceutil/trace.go:171","msg":"trace[1193224055] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"140.379638ms","start":"2026-04-20T02:02:51.419181Z","end":"2026-04-20T02:02:51.559561Z","steps":["trace[1193224055] 'count revisions from in-memory index tree' (duration: 140.246754ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.559659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.445062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.559697Z","caller":"traceutil/trace.go:171","msg":"trace[832619422] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"274.483493ms","start":"2026-04-20T02:02:51.285204Z","end":"2026-04-20T02:02:51.559687Z","steps":["trace[832619422] 'count revisions from in-memory index tree' (duration: 274.376791ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.559707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.313296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.559733Z","caller":"traceutil/trace.go:171","msg":"trace[1468088398] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1; }","duration":"126.389108ms","start":"2026-04-20T02:02:51.433338Z","end":"2026-04-20T02:02:51.559727Z","steps":["trace[1468088398] 'range keys from in-memory index tree' (duration: 126.236955ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.559738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.295434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.559795Z","caller":"traceutil/trace.go:171","msg":"trace[1673602136] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"364.408266ms","start":"2026-04-20T02:02:51.195377Z","end":"2026-04-20T02:02:51.559785Z","steps":["trace[1673602136] 'count revisions from in-memory index tree' (duration: 364.193201ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.559825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.451589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-20T02:02:51.559837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:51.19534Z","time spent":"364.486318ms","remote":"127.0.0.1:57770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"info","ts":"2026-04-20T02:02:51.559853Z","caller":"traceutil/trace.go:171","msg":"trace[214171803] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"264.525231ms","start":"2026-04-20T02:02:51.295322Z","end":"2026-04-20T02:02:51.559847Z","steps":["trace[214171803] 'range keys from in-memory index tree' (duration: 264.325716ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.55988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.525661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.559907Z","caller":"traceutil/trace.go:171","msg":"trace[363891111] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1; }","duration":"126.600403ms","start":"2026-04-20T02:02:51.433301Z","end":"2026-04-20T02:02:51.559901Z","steps":["trace[363891111] 'count revisions from in-memory index tree' (duration: 126.391048ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.55996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.013791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-20T02:02:51.559979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.153006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.559995Z","caller":"traceutil/trace.go:171","msg":"trace[751222488] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"351.088533ms","start":"2026-04-20T02:02:51.208898Z","end":"2026-04-20T02:02:51.559987Z","steps":["trace[751222488] 'count revisions from in-memory index tree' (duration: 350.907708ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.559179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.996836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.560033Z","caller":"traceutil/trace.go:171","msg":"trace[1107306039] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"378.857767ms","start":"2026-04-20T02:02:51.181169Z","end":"2026-04-20T02:02:51.560026Z","steps":["trace[1107306039] 'range keys from in-memory index tree' (duration: 377.923254ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.560049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.091917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-20T02:02:51.560064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.872368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-20T02:02:51.560068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:51.181151Z","time spent":"378.905388ms","remote":"127.0.0.1:57762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" limit:10000 "} {"level":"info","ts":"2026-04-20T02:02:51.560072Z","caller":"traceutil/trace.go:171","msg":"trace[1565144387] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1; }","duration":"118.126498ms","start":"2026-04-20T02:02:51.441938Z","end":"2026-04-20T02:02:51.560065Z","steps":["trace[1565144387] 'count revisions from in-memory index tree' (duration: 118.010785ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:02:51.560126Z","caller":"traceutil/trace.go:171","msg":"trace[924892984] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"351.029401ms","start":"2026-04-20T02:02:51.20906Z","end":"2026-04-20T02:02:51.560089Z","steps":["trace[924892984] 'range keys from in-memory index tree' (duration: 350.705473ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.560195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:51.208954Z","time spent":"351.225646ms","remote":"127.0.0.1:57772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":27,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" limit:10000 "} {"level":"info","ts":"2026-04-20T02:02:51.560008Z","caller":"traceutil/trace.go:171","msg":"trace[1692979479] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"253.208916ms","start":"2026-04-20T02:02:51.306789Z","end":"2026-04-20T02:02:51.559997Z","steps":["trace[1692979479] 'range keys from in-memory index tree' (duration: 253.108444ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.560246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.298433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.560268Z","caller":"traceutil/trace.go:171","msg":"trace[233928872] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1; }","duration":"118.321973ms","start":"2026-04-20T02:02:51.44194Z","end":"2026-04-20T02:02:51.560262Z","steps":["trace[233928872] 'range keys from in-memory index tree' (duration: 118.18267ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:02:51.559234Z","caller":"traceutil/trace.go:171","msg":"trace[1872138913] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"153.190339ms","start":"2026-04-20T02:02:51.406036Z","end":"2026-04-20T02:02:51.559226Z","steps":["trace[1872138913] 'count revisions from in-memory index tree' (duration: 153.071715ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.560447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.674937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.560475Z","caller":"traceutil/trace.go:171","msg":"trace[733513031] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1; }","duration":"103.712927ms","start":"2026-04-20T02:02:51.456753Z","end":"2026-04-20T02:02:51.560466Z","steps":["trace[733513031] 'count revisions from in-memory index tree' (duration: 103.604425ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:02:51.559316Z","caller":"traceutil/trace.go:171","msg":"trace[1557173853] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"153.293472ms","start":"2026-04-20T02:02:51.406017Z","end":"2026-04-20T02:02:51.559311Z","steps":["trace[1557173853] 'range keys from in-memory index tree' (duration: 153.138077ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.560652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.724638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-20T02:02:51.559799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.403798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.560709Z","caller":"traceutil/trace.go:171","msg":"trace[1585974915] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"265.342082ms","start":"2026-04-20T02:02:51.295353Z","end":"2026-04-20T02:02:51.560696Z","steps":["trace[1585974915] 'count revisions from in-memory index tree' (duration: 264.326986ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.560674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.717165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.560836Z","caller":"traceutil/trace.go:171","msg":"trace[1969371959] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"342.005042ms","start":"2026-04-20T02:02:51.21878Z","end":"2026-04-20T02:02:51.560785Z","steps":["trace[1969371959] 'count revisions from in-memory index tree' (duration: 341.620943ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.560032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:51.208872Z","time spent":"351.152574ms","remote":"127.0.0.1:57772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"warn","ts":"2026-04-20T02:02:51.560877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.412927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-20T02:02:51.560897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:51.21876Z","time spent":"342.124315ms","remote":"127.0.0.1:57786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"warn","ts":"2026-04-20T02:02:51.560942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.342106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.560961Z","caller":"traceutil/trace.go:171","msg":"trace[1383743452] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"329.386656ms","start":"2026-04-20T02:02:51.231568Z","end":"2026-04-20T02:02:51.560955Z","steps":["trace[1383743452] 'range keys from in-memory index tree' (duration: 329.259684ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.560984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:51.231559Z","time spent":"329.419638ms","remote":"127.0.0.1:57802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 "} {"level":"info","ts":"2026-04-20T02:02:51.560678Z","caller":"traceutil/trace.go:171","msg":"trace[1232183839] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1; }","duration":"103.787259ms","start":"2026-04-20T02:02:51.456885Z","end":"2026-04-20T02:02:51.560672Z","steps":["trace[1232183839] 'range keys from in-memory index tree' (duration: 103.614905ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:02:51.558739Z","caller":"traceutil/trace.go:171","msg":"trace[44568304] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"211.834173ms","start":"2026-04-20T02:02:51.346899Z","end":"2026-04-20T02:02:51.558733Z","steps":["trace[44568304] 'count revisions from in-memory index tree' (duration: 211.670079ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.560839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.652504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.561652Z","caller":"traceutil/trace.go:171","msg":"trace[1241734555] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"342.482003ms","start":"2026-04-20T02:02:51.219152Z","end":"2026-04-20T02:02:51.561634Z","steps":["trace[1241734555] 'range keys from in-memory index tree' (duration: 341.548621ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:02:51.560908Z","caller":"traceutil/trace.go:171","msg":"trace[245161014] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"329.487549ms","start":"2026-04-20T02:02:51.231413Z","end":"2026-04-20T02:02:51.560901Z","steps":["trace[245161014] 'count revisions from in-memory index tree' (duration: 329.354516ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.561714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:51.231378Z","time spent":"330.325579ms","remote":"127.0.0.1:57802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-04-20T02:02:51.561726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:51.219139Z","time spent":"342.570786ms","remote":"127.0.0.1:57786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:10000 "} {"level":"warn","ts":"2026-04-20T02:02:51.557467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.52075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T02:02:51.56419Z","caller":"traceutil/trace.go:171","msg":"trace[271604344] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"320.270514ms","start":"2026-04-20T02:02:51.241813Z","end":"2026-04-20T02:02:51.562084Z","steps":["trace[271604344] 'range keys from in-memory index tree' (duration: 315.428667ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:02:51.564299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:51.241805Z","time spent":"322.466867ms","remote":"127.0.0.1:57808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":27,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" limit:10000 "} {"level":"info","ts":"2026-04-20T02:03:21.235007Z","caller":"traceutil/trace.go:171","msg":"trace[1464800603] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"102.993159ms","start":"2026-04-20T02:03:21.131968Z","end":"2026-04-20T02:03:21.234961Z","steps":["trace[1464800603] 'process raft request' (duration: 102.820235ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:03:23.146627Z","caller":"traceutil/trace.go:171","msg":"trace[1255003848] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:606; }","duration":"311.740227ms","start":"2026-04-20T02:03:22.834851Z","end":"2026-04-20T02:03:23.146591Z","steps":["trace[1255003848] 'read index received' (duration: 310.996579ms)","trace[1255003848] 'applied index is now lower than readState.Index' (duration: 742.398µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:03:23.146695Z","caller":"traceutil/trace.go:171","msg":"trace[314474285] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"316.481842ms","start":"2026-04-20T02:03:22.830183Z","end":"2026-04-20T02:03:23.146665Z","steps":["trace[314474285] 'process raft request' (duration: 315.56084ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:03:23.146931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.050084ms","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-20T02:03:23.14699Z","caller":"traceutil/trace.go:171","msg":"trace[1983975563] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:585; }","duration":"312.141227ms","start":"2026-04-20T02:03:22.83483Z","end":"2026-04-20T02:03:23.146971Z","steps":["trace[1983975563] 'agreement among raft nodes before linearized reading' (duration: 311.928862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:03:23.147038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:03:22.834785Z","time spent":"312.240869ms","remote":"127.0.0.1:57950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-20T02:03:23.147339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:03:22.830154Z","time spent":"316.617075ms","remote":"127.0.0.1:57722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208461,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:03:23.157376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.984282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-20T02:03:23.15747Z","caller":"traceutil/trace.go:171","msg":"trace[1682993524] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:586; }","duration":"218.140575ms","start":"2026-04-20T02:03:22.939314Z","end":"2026-04-20T02:03:23.157455Z","steps":["trace[1682993524] 'agreement among raft nodes before linearized reading' (duration: 217.976251ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:03:23.157365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.46914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"} {"level":"info","ts":"2026-04-20T02:03:23.157607Z","caller":"traceutil/trace.go:171","msg":"trace[1984324938] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:586; }","duration":"292.777508ms","start":"2026-04-20T02:03:22.864806Z","end":"2026-04-20T02:03:23.157583Z","steps":["trace[1984324938] 'agreement among raft nodes before linearized reading' (duration: 292.405249ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:03:23.158629Z","caller":"traceutil/trace.go:171","msg":"trace[1677479917] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"204.696488ms","start":"2026-04-20T02:03:22.953908Z","end":"2026-04-20T02:03:23.158605Z","steps":["trace[1677479917] 'process raft request' (duration: 202.372392ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:03:27.340321Z","caller":"traceutil/trace.go:171","msg":"trace[1143350461] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"106.192677ms","start":"2026-04-20T02:03:27.234108Z","end":"2026-04-20T02:03:27.340301Z","steps":["trace[1143350461] 'process raft request' (duration: 105.744247ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:03:27.565005Z","caller":"traceutil/trace.go:171","msg":"trace[1343272259] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"147.977092ms","start":"2026-04-20T02:03:27.417Z","end":"2026-04-20T02:03:27.564977Z","steps":["trace[1343272259] 'process raft request' (duration: 147.823399ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:03:27.604628Z","caller":"traceutil/trace.go:171","msg":"trace[1473280707] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"104.822395ms","start":"2026-04-20T02:03:27.499759Z","end":"2026-04-20T02:03:27.604581Z","steps":["trace[1473280707] 'process raft request' (duration: 103.927543ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:03:28.142516Z","caller":"traceutil/trace.go:171","msg":"trace[281938492] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"482.721138ms","start":"2026-04-20T02:03:27.659761Z","end":"2026-04-20T02:03:28.142482Z","steps":["trace[281938492] 'process raft request' (duration: 482.540833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:03:28.142757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:03:27.659728Z","time spent":"482.927473ms","remote":"127.0.0.1:58044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T02:03:29.724624Z","caller":"traceutil/trace.go:171","msg":"trace[1670648610] linearizableReadLoop","detail":"{readStateIndex:680; appliedIndex:679; }","duration":"118.607678ms","start":"2026-04-20T02:03:29.605982Z","end":"2026-04-20T02:03:29.72459Z","steps":["trace[1670648610] 'read index received' (duration: 118.360442ms)","trace[1670648610] 'applied index is now lower than readState.Index' (duration: 245.906µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:03:29.724969Z","caller":"traceutil/trace.go:171","msg":"trace[1130374909] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"119.435269ms","start":"2026-04-20T02:03:29.605522Z","end":"2026-04-20T02:03:29.724957Z","steps":["trace[1130374909] 'process raft request' (duration: 118.904816ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:03:29.72526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.244574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:03:29.725298Z","caller":"traceutil/trace.go:171","msg":"trace[977478366] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:657; }","duration":"119.317936ms","start":"2026-04-20T02:03:29.605967Z","end":"2026-04-20T02:03:29.725285Z","steps":["trace[977478366] 'agreement among raft nodes before linearized reading' (duration: 119.188133ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:03:43.795529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.064579ms","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-20T02:03:43.795673Z","caller":"traceutil/trace.go:171","msg":"trace[827142270] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:779; }","duration":"292.288025ms","start":"2026-04-20T02:03:43.503361Z","end":"2026-04-20T02:03:43.795649Z","steps":["trace[827142270] 'range keys from in-memory index tree' (duration: 291.807893ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:03:43.795759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.493598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-z6znd\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-04-20T02:03:43.79586Z","caller":"traceutil/trace.go:171","msg":"trace[688531508] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-z6znd; range_end:; response_count:1; response_revision:779; }","duration":"266.663153ms","start":"2026-04-20T02:03:43.529175Z","end":"2026-04-20T02:03:43.795838Z","steps":["trace[688531508] 'range keys from in-memory index tree' (duration: 265.861803ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:04:19.908363Z","caller":"traceutil/trace.go:171","msg":"trace[1250431991] linearizableReadLoop","detail":"{readStateIndex:1035; appliedIndex:1034; }","duration":"288.490167ms","start":"2026-04-20T02:04:19.619838Z","end":"2026-04-20T02:04:19.908329Z","steps":["trace[1250431991] 'read index received' (duration: 288.266052ms)","trace[1250431991] 'applied index is now lower than readState.Index' (duration: 222.625µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:04:19.908476Z","caller":"traceutil/trace.go:171","msg":"trace[1949587265] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"394.794239ms","start":"2026-04-20T02:04:19.513638Z","end":"2026-04-20T02:04:19.908432Z","steps":["trace[1949587265] 'process raft request' (duration: 394.500041ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:04:19.908665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.957261ms","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-20T02:04:19.908671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:04:19.513605Z","time spent":"394.971553ms","remote":"127.0.0.1:57950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:04:19.908698Z","caller":"traceutil/trace.go:171","msg":"trace[169670834] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1001; }","duration":"271.053753ms","start":"2026-04-20T02:04:19.637635Z","end":"2026-04-20T02:04:19.908688Z","steps":["trace[169670834] 'agreement among raft nodes before linearized reading' (duration: 270.903369ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:04:19.908762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.896546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-20T02:04:19.908788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.82271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T02:04:19.908849Z","caller":"traceutil/trace.go:171","msg":"trace[186573730] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1001; }","duration":"289.087211ms","start":"2026-04-20T02:04:19.619738Z","end":"2026-04-20T02:04:19.908825Z","steps":["trace[186573730] 'agreement among raft nodes before linearized reading' (duration: 288.761533ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:04:19.908872Z","caller":"traceutil/trace.go:171","msg":"trace[1750670885] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1001; }","duration":"133.953753ms","start":"2026-04-20T02:04:19.774895Z","end":"2026-04-20T02:04:19.908848Z","steps":["trace[1750670885] 'agreement among raft nodes before linearized reading' (duration: 133.81802ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:04:46.496564Z","caller":"traceutil/trace.go:171","msg":"trace[904234327] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"263.005509ms","start":"2026-04-20T02:04:46.233526Z","end":"2026-04-20T02:04:46.496532Z","steps":["trace[904234327] 'process raft request' (duration: 262.796664ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:04:46.511803Z","caller":"traceutil/trace.go:171","msg":"trace[653017094] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"257.286168ms","start":"2026-04-20T02:04:46.254483Z","end":"2026-04-20T02:04:46.51177Z","steps":["trace[653017094] 'process raft request' (duration: 257.231887ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:04:46.512157Z","caller":"traceutil/trace.go:171","msg":"trace[507964897] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"278.583937ms","start":"2026-04-20T02:04:46.233525Z","end":"2026-04-20T02:04:46.512109Z","steps":["trace[507964897] 'process raft request' (duration: 278.037743ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:00.344999Z","caller":"traceutil/trace.go:171","msg":"trace[369695108] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"169.47825ms","start":"2026-04-20T02:05:00.175493Z","end":"2026-04-20T02:05:00.344971Z","steps":["trace[369695108] 'process raft request' (duration: 169.202594ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:00.346152Z","caller":"traceutil/trace.go:171","msg":"trace[798145481] linearizableReadLoop","detail":"{readStateIndex:1232; appliedIndex:1230; }","duration":"149.3695ms","start":"2026-04-20T02:05:00.196725Z","end":"2026-04-20T02:05:00.346095Z","steps":["trace[798145481] 'read index received' (duration: 148.132031ms)","trace[798145481] 'applied index is now lower than readState.Index' (duration: 1.236099ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:05:00.346393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.630116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:05:00.34643Z","caller":"traceutil/trace.go:171","msg":"trace[140941756] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1187; }","duration":"149.714518ms","start":"2026-04-20T02:05:00.196702Z","end":"2026-04-20T02:05:00.346417Z","steps":["trace[140941756] 'agreement among raft nodes before linearized reading' (duration: 149.577264ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:00.346473Z","caller":"traceutil/trace.go:171","msg":"trace[658455551] transaction","detail":"{read_only:false; response_revision:1187; number_of_response:1; }","duration":"169.973982ms","start":"2026-04-20T02:05:00.176464Z","end":"2026-04-20T02:05:00.346438Z","steps":["trace[658455551] 'process raft request' (duration: 169.473791ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:16.841848Z","caller":"traceutil/trace.go:171","msg":"trace[434452752] linearizableReadLoop","detail":"{readStateIndex:1305; appliedIndex:1304; }","duration":"186.981331ms","start":"2026-04-20T02:05:16.654839Z","end":"2026-04-20T02:05:16.84182Z","steps":["trace[434452752] 'read index received' (duration: 186.755976ms)","trace[434452752] 'applied index is now lower than readState.Index' (duration: 224.255µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:05:16.842279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.425422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-20T02:05:16.842383Z","caller":"traceutil/trace.go:171","msg":"trace[2060911377] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1257; }","duration":"187.589265ms","start":"2026-04-20T02:05:16.65477Z","end":"2026-04-20T02:05:16.842359Z","steps":["trace[2060911377] 'agreement among raft nodes before linearized reading' (duration: 187.36884ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:16.842388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.97224ms","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-20T02:05:16.842469Z","caller":"traceutil/trace.go:171","msg":"trace[1784258768] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1257; }","duration":"183.089064ms","start":"2026-04-20T02:05:16.659355Z","end":"2026-04-20T02:05:16.842444Z","steps":["trace[1784258768] 'agreement among raft nodes before linearized reading' (duration: 182.813137ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:16.841897Z","caller":"traceutil/trace.go:171","msg":"trace[421684092] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"224.331757ms","start":"2026-04-20T02:05:16.617543Z","end":"2026-04-20T02:05:16.841874Z","steps":["trace[421684092] 'process raft request' (duration: 224.118963ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:17.149488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.166799ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T02:05:17.149615Z","caller":"traceutil/trace.go:171","msg":"trace[10412168] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"302.057827ms","start":"2026-04-20T02:05:16.847537Z","end":"2026-04-20T02:05:17.149594Z","steps":["trace[10412168] 'process raft request' (duration: 130.55736ms)","trace[10412168] 'compare' (duration: 171.033687ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:05:17.149677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:16.847515Z","time spent":"302.134348ms","remote":"127.0.0.1:57950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:05:17.16071Z","caller":"traceutil/trace.go:171","msg":"trace[1515700895] linearizableReadLoop","detail":"{readStateIndex:1307; appliedIndex:1305; }","duration":"244.57442ms","start":"2026-04-20T02:05:16.916099Z","end":"2026-04-20T02:05:17.160673Z","steps":["trace[1515700895] 'read index received' (duration: 62.014329ms)","trace[1515700895] 'applied index is now lower than readState.Index' (duration: 182.558321ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:05:17.161024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.898337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-8wp75\" ","response":"range_response_count:1 size:11061"} {"level":"info","ts":"2026-04-20T02:05:17.161078Z","caller":"traceutil/trace.go:171","msg":"trace[904757931] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-8wp75; range_end:; response_count:1; response_revision:1259; }","duration":"245.02642ms","start":"2026-04-20T02:05:16.916038Z","end":"2026-04-20T02:05:17.161064Z","steps":["trace[904757931] 'agreement among raft nodes before linearized reading' (duration: 244.782634ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:17.161489Z","caller":"traceutil/trace.go:171","msg":"trace[811501986] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"313.801426ms","start":"2026-04-20T02:05:16.847673Z","end":"2026-04-20T02:05:17.161475Z","steps":["trace[811501986] 'process raft request' (duration: 312.821124ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:17.161626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:16.84764Z","time spent":"313.886038ms","remote":"127.0.0.1:57950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:05:17.319588Z","caller":"traceutil/trace.go:171","msg":"trace[1563355856] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"101.458803ms","start":"2026-04-20T02:05:17.218106Z","end":"2026-04-20T02:05:17.319565Z","steps":["trace[1563355856] 'process raft request' (duration: 101.259388ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:17.319799Z","caller":"traceutil/trace.go:171","msg":"trace[644756050] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"101.683918ms","start":"2026-04-20T02:05:17.218107Z","end":"2026-04-20T02:05:17.319791Z","steps":["trace[644756050] 'process raft request' (duration: 101.407482ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:19.002694Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":991528215543965396,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T02:05:19.503771Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":991528215543965396,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T02:05:19.561789Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.285999781s","expected-duration":"1s"} {"level":"info","ts":"2026-04-20T02:05:19.562186Z","caller":"traceutil/trace.go:171","msg":"trace[13597408] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"1.286522692s","start":"2026-04-20T02:05:18.27564Z","end":"2026-04-20T02:05:19.562162Z","steps":["trace[13597408] 'process raft request' (duration: 1.286391399s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:19.562301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:18.275615Z","time spent":"1.286609394s","remote":"127.0.0.1:57950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:05:19.679873Z","caller":"traceutil/trace.go:171","msg":"trace[1103967534] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"740.15889ms","start":"2026-04-20T02:05:18.939647Z","end":"2026-04-20T02:05:19.679806Z","steps":["trace[1103967534] 'process raft request' (duration: 739.880234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:19.680126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:18.93961Z","time spent":"740.368114ms","remote":"127.0.0.1:57950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:05:19.705321Z","caller":"traceutil/trace.go:171","msg":"trace[105517088] linearizableReadLoop","detail":"{readStateIndex:1314; appliedIndex:1312; }","duration":"1.202973598s","start":"2026-04-20T02:05:18.502327Z","end":"2026-04-20T02:05:19.7053Z","steps":["trace[105517088] 'read index received' (duration: 1.060039805s)","trace[105517088] 'applied index is now lower than readState.Index' (duration: 142.930613ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:05:19.705331Z","caller":"traceutil/trace.go:171","msg":"trace[1791054093] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"132.454183ms","start":"2026-04-20T02:05:19.572847Z","end":"2026-04-20T02:05:19.705301Z","steps":["trace[1791054093] 'process raft request' (duration: 132.280969ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:19.705583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.203242805s","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-20T02:05:19.705618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.399599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:05:19.705661Z","caller":"traceutil/trace.go:171","msg":"trace[746273980] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1266; }","duration":"500.486742ms","start":"2026-04-20T02:05:19.205163Z","end":"2026-04-20T02:05:19.705649Z","steps":["trace[746273980] 'agreement among raft nodes before linearized reading' (duration: 500.39749ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:19.705667Z","caller":"traceutil/trace.go:171","msg":"trace[1582700418] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1266; }","duration":"1.203370298s","start":"2026-04-20T02:05:18.502277Z","end":"2026-04-20T02:05:19.705648Z","steps":["trace[1582700418] 'agreement among raft nodes before linearized reading' (duration: 1.203115442s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:19.705686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.751511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-20T02:05:19.705695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:19.205151Z","time spent":"500.531103ms","remote":"127.0.0.1:57660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-20T02:05:19.705715Z","caller":"traceutil/trace.go:171","msg":"trace[1925722498] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1266; }","duration":"539.831172ms","start":"2026-04-20T02:05:19.165875Z","end":"2026-04-20T02:05:19.705706Z","steps":["trace[1925722498] 'agreement among raft nodes before linearized reading' (duration: 539.762341ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:19.705718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:18.502255Z","time spent":"1.20345344s","remote":"127.0.0.1:57950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-20T02:05:19.705748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:19.165848Z","time spent":"539.894434ms","remote":"127.0.0.1:57950","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-20T02:05:19.705605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.195235131s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-20T02:05:19.705852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"766.403411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:05:19.705849Z","caller":"traceutil/trace.go:171","msg":"trace[791572577] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1266; }","duration":"1.195534479s","start":"2026-04-20T02:05:18.510301Z","end":"2026-04-20T02:05:19.705835Z","steps":["trace[791572577] 'agreement among raft nodes before linearized reading' (duration: 1.1951518s)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:19.705877Z","caller":"traceutil/trace.go:171","msg":"trace[659491978] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:1266; }","duration":"766.431532ms","start":"2026-04-20T02:05:18.939437Z","end":"2026-04-20T02:05:19.705869Z","steps":["trace[659491978] 'agreement among raft nodes before linearized reading' (duration: 766.385231ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:19.705889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:18.510275Z","time spent":"1.19560403s","remote":"127.0.0.1:57950","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-20T02:05:19.705898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:18.939366Z","time spent":"766.526844ms","remote":"127.0.0.1:54652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-04-20T02:05:19.70592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.908189ms","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-20T02:05:19.706008Z","caller":"traceutil/trace.go:171","msg":"trace[1599951175] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1266; }","duration":"552.052023ms","start":"2026-04-20T02:05:19.153934Z","end":"2026-04-20T02:05:19.705986Z","steps":["trace[1599951175] 'agreement among raft nodes before linearized reading' (duration: 551.823017ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:19.706097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:19.153909Z","time spent":"552.175695ms","remote":"127.0.0.1:57950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-20T02:05:19.992197Z","caller":"traceutil/trace.go:171","msg":"trace[2042482861] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"132.952005ms","start":"2026-04-20T02:05:19.859217Z","end":"2026-04-20T02:05:19.992169Z","steps":["trace[2042482861] 'process raft request' (duration: 132.704239ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:33.779983Z","caller":"traceutil/trace.go:171","msg":"trace[1945826676] transaction","detail":"{read_only:false; response_revision:1362; number_of_response:1; }","duration":"145.204686ms","start":"2026-04-20T02:05:33.634743Z","end":"2026-04-20T02:05:33.779947Z","steps":["trace[1945826676] 'process raft request' (duration: 144.993541ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:16.352709Z","caller":"traceutil/trace.go:171","msg":"trace[713599414] transaction","detail":"{read_only:false; response_revision:1555; number_of_response:1; }","duration":"441.412606ms","start":"2026-04-20T02:06:15.911258Z","end":"2026-04-20T02:06:16.35267Z","steps":["trace[713599414] 'process raft request' (duration: 441.143349ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:16.353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:15.91122Z","time spent":"441.659632ms","remote":"127.0.0.1:57950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:06:16.355686Z","caller":"traceutil/trace.go:171","msg":"trace[568589377] linearizableReadLoop","detail":"{readStateIndex:1616; appliedIndex:1614; }","duration":"366.553091ms","start":"2026-04-20T02:06:15.989102Z","end":"2026-04-20T02:06:16.355655Z","steps":["trace[568589377] 'read index received' (duration: 363.5228ms)","trace[568589377] 'applied index is now lower than readState.Index' (duration: 3.028911ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:06:16.355814Z","caller":"traceutil/trace.go:171","msg":"trace[1777668492] transaction","detail":"{read_only:false; response_revision:1556; number_of_response:1; }","duration":"411.274495ms","start":"2026-04-20T02:06:15.944514Z","end":"2026-04-20T02:06:16.355788Z","steps":["trace[1777668492] 'process raft request' (duration: 410.952178ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:16.355966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.828907ms","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-20T02:06:16.356004Z","caller":"traceutil/trace.go:171","msg":"trace[143621078] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1556; }","duration":"366.93813ms","start":"2026-04-20T02:06:15.989055Z","end":"2026-04-20T02:06:16.355993Z","steps":["trace[143621078] 'agreement among raft nodes before linearized reading' (duration: 366.747165ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:16.356023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:15.944458Z","time spent":"411.404158ms","remote":"127.0.0.1:57950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:06:16.356042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:15.989041Z","time spent":"366.992071ms","remote":"127.0.0.1:57950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-20T02:06:16.356168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.667992ms","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-20T02:06:16.356258Z","caller":"traceutil/trace.go:171","msg":"trace[443183869] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1556; }","duration":"195.830266ms","start":"2026-04-20T02:06:16.160406Z","end":"2026-04-20T02:06:16.356236Z","steps":["trace[443183869] 'agreement among raft nodes before linearized reading' (duration: 195.583881ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:16.356278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.391587ms","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-20T02:06:16.356318Z","caller":"traceutil/trace.go:171","msg":"trace[1672034853] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1556; }","duration":"198.475899ms","start":"2026-04-20T02:06:16.157829Z","end":"2026-04-20T02:06:16.356305Z","steps":["trace[1672034853] 'agreement among raft nodes before linearized reading' (duration: 198.382367ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:24.82791Z","caller":"traceutil/trace.go:171","msg":"trace[1655712437] linearizableReadLoop","detail":"{readStateIndex:1653; appliedIndex:1652; }","duration":"432.558556ms","start":"2026-04-20T02:06:24.395306Z","end":"2026-04-20T02:06:24.827864Z","steps":["trace[1655712437] 'read index received' (duration: 432.274369ms)","trace[1655712437] 'applied index is now lower than readState.Index' (duration: 283.047µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:06:24.828349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.004976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-20T02:06:24.828464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.625985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.141\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-20T02:06:24.82852Z","caller":"traceutil/trace.go:171","msg":"trace[21899364] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1592; }","duration":"433.250121ms","start":"2026-04-20T02:06:24.395241Z","end":"2026-04-20T02:06:24.828491Z","steps":["trace[21899364] 'agreement among raft nodes before linearized reading' (duration: 432.865172ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:24.828402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.817245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-20T02:06:24.828643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.294723ms","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":"info","ts":"2026-04-20T02:06:24.828069Z","caller":"traceutil/trace.go:171","msg":"trace[818487476] transaction","detail":"{read_only:false; response_revision:1592; number_of_response:1; }","duration":"441.786714ms","start":"2026-04-20T02:06:24.386256Z","end":"2026-04-20T02:06:24.828043Z","steps":["trace[818487476] 'process raft request' (duration: 441.423126ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:24.828775Z","caller":"traceutil/trace.go:171","msg":"trace[988070243] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1592; }","duration":"195.474247ms","start":"2026-04-20T02:06:24.633271Z","end":"2026-04-20T02:06:24.828745Z","steps":["trace[988070243] 'agreement among raft nodes before linearized reading' (duration: 194.982806ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:24.828547Z","caller":"traceutil/trace.go:171","msg":"trace[919097514] range","detail":"{range_begin:/registry/masterleases/199.204.45.141; range_end:; response_count:1; response_revision:1592; }","duration":"364.742227ms","start":"2026-04-20T02:06:24.463787Z","end":"2026-04-20T02:06:24.828529Z","steps":["trace[919097514] 'agreement among raft nodes before linearized reading' (duration: 364.43961ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:24.828617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.623539ms","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":"warn","ts":"2026-04-20T02:06:24.828965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:24.386232Z","time spent":"442.524592ms","remote":"127.0.0.1:57950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:06:24.828672Z","caller":"traceutil/trace.go:171","msg":"trace[1828442770] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1592; }","duration":"431.159303ms","start":"2026-04-20T02:06:24.39749Z","end":"2026-04-20T02:06:24.828649Z","steps":["trace[1828442770] 'agreement among raft nodes before linearized reading' (duration: 430.700722ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:24.829032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:24.39748Z","time spent":"431.540633ms","remote":"127.0.0.1:57950","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-20T02:06:24.828882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:24.463774Z","time spent":"365.098926ms","remote":"127.0.0.1:57714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.141\" "} {"level":"warn","ts":"2026-04-20T02:06:24.828595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:24.395211Z","time spent":"433.370355ms","remote":"127.0.0.1:57950","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-20T02:06:24.828432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.230391ms","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-20T02:06:24.829331Z","caller":"traceutil/trace.go:171","msg":"trace[17609868] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1592; }","duration":"428.171723ms","start":"2026-04-20T02:06:24.401147Z","end":"2026-04-20T02:06:24.829319Z","steps":["trace[17609868] 'agreement among raft nodes before linearized reading' (duration: 427.082506ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:24.829363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:24.401131Z","time spent":"428.224695ms","remote":"127.0.0.1:57950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-20T02:06:24.828615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.196875ms","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-20T02:06:24.829445Z","caller":"traceutil/trace.go:171","msg":"trace[1151901429] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1592; }","duration":"214.041906ms","start":"2026-04-20T02:06:24.615386Z","end":"2026-04-20T02:06:24.829428Z","steps":["trace[1151901429] 'agreement among raft nodes before linearized reading' (duration: 213.180045ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:24.82857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.283579ms","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-20T02:06:24.829644Z","caller":"traceutil/trace.go:171","msg":"trace[1714321994] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1592; }","duration":"430.393446ms","start":"2026-04-20T02:06:24.399234Z","end":"2026-04-20T02:06:24.829627Z","steps":["trace[1714321994] 'agreement among raft nodes before linearized reading' (duration: 429.172566ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:24.829722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:24.399224Z","time spent":"430.477968ms","remote":"127.0.0.1:57950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-20T02:06:24.828984Z","caller":"traceutil/trace.go:171","msg":"trace[1955125892] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1592; }","duration":"424.945376ms","start":"2026-04-20T02:06:24.403964Z","end":"2026-04-20T02:06:24.828909Z","steps":["trace[1955125892] 'agreement among raft nodes before linearized reading' (duration: 424.528836ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:24.829798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:24.403956Z","time spent":"425.824377ms","remote":"127.0.0.1:57950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-20T02:06:27.005576Z","caller":"traceutil/trace.go:171","msg":"trace[1438004354] transaction","detail":"{read_only:false; response_revision:1601; number_of_response:1; }","duration":"632.921938ms","start":"2026-04-20T02:06:26.372618Z","end":"2026-04-20T02:06:27.00554Z","steps":["trace[1438004354] 'process raft request' (duration: 632.524759ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:27.005903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:26.372594Z","time spent":"633.089452ms","remote":"127.0.0.1:57950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:06:27.006439Z","caller":"traceutil/trace.go:171","msg":"trace[1961206259] linearizableReadLoop","detail":"{readStateIndex:1664; appliedIndex:1662; }","duration":"165.577133ms","start":"2026-04-20T02:06:26.840849Z","end":"2026-04-20T02:06:27.006426Z","steps":["trace[1961206259] 'read index received' (duration: 164.138188ms)","trace[1961206259] 'applied index is now lower than readState.Index' (duration: 1.437925ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:06:27.006483Z","caller":"traceutil/trace.go:171","msg":"trace[1835095658] transaction","detail":"{read_only:false; response_revision:1602; number_of_response:1; }","duration":"171.486902ms","start":"2026-04-20T02:06:26.834971Z","end":"2026-04-20T02:06:27.006457Z","steps":["trace[1835095658] 'process raft request' (duration: 171.40684ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:27.006627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.774967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-20T02:06:27.006664Z","caller":"traceutil/trace.go:171","msg":"trace[423185660] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1602; }","duration":"165.846899ms","start":"2026-04-20T02:06:26.840808Z","end":"2026-04-20T02:06:27.006655Z","steps":["trace[423185660] 'agreement among raft nodes before linearized reading' (duration: 165.703486ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:27.006628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.34706ms","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-20T02:06:27.006743Z","caller":"traceutil/trace.go:171","msg":"trace[1752137528] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1602; }","duration":"163.518404ms","start":"2026-04-20T02:06:26.843216Z","end":"2026-04-20T02:06:27.006734Z","steps":["trace[1752137528] 'agreement among raft nodes before linearized reading' (duration: 163.35138ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:27.006763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.793793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-20T02:06:27.006791Z","caller":"traceutil/trace.go:171","msg":"trace[1689168609] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1602; }","duration":"161.834175ms","start":"2026-04-20T02:06:26.844951Z","end":"2026-04-20T02:06:27.006785Z","steps":["trace[1689168609] 'agreement among raft nodes before linearized reading' (duration: 161.771753ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:27.006846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.997721ms","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-20T02:06:27.006873Z","caller":"traceutil/trace.go:171","msg":"trace[383962675] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1602; }","duration":"163.052433ms","start":"2026-04-20T02:06:26.843815Z","end":"2026-04-20T02:06:27.006867Z","steps":["trace[383962675] 'agreement among raft nodes before linearized reading' (duration: 162.979041ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:27.006878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.481683ms","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-20T02:06:27.006896Z","caller":"traceutil/trace.go:171","msg":"trace[1570797343] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1602; }","duration":"163.544944ms","start":"2026-04-20T02:06:26.843346Z","end":"2026-04-20T02:06:27.006891Z","steps":["trace[1570797343] 'agreement among raft nodes before linearized reading' (duration: 163.494953ms)"],"step_count":1}