{"level":"warn","ts":"2026-04-20T02:03:39.131561Z","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:03:39.131703Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.222:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.222:2380","--initial-cluster=instance=https://199.204.45.222:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.222:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.222:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-20T02:03:39.131808Z","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:03:39.13183Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-04-20T02:03:39.131868Z","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:03:39.132729Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"]} {"level":"info","ts":"2026-04-20T02:03:39.132859Z","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":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.222:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-20T02:03:39.136613Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.495497ms"} {"level":"info","ts":"2026-04-20T02:03:39.145914Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"380f6760faea5f9e","cluster-id":"b87e8aca83a17eab"} {"level":"info","ts":"2026-04-20T02:03:39.14606Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T02:03:39.146117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 0"} {"level":"info","ts":"2026-04-20T02:03:39.146144Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 380f6760faea5f9e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T02:03:39.146181Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 1"} {"level":"info","ts":"2026-04-20T02:03:39.146264Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"warn","ts":"2026-04-20T02:03:39.15521Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T02:03:39.156833Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T02:03:39.157807Z","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:03:39.16113Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"380f6760faea5f9e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T02:03:39.161921Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"380f6760faea5f9e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T02:03:39.161992Z","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:03:39.162057Z","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:03:39.162071Z","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:03:39.162493Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"info","ts":"2026-04-20T02:03:39.163382Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","added-peer-id":"380f6760faea5f9e","added-peer-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-04-20T02:03:39.167653Z","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:03:39.167733Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-04-20T02:03:39.167799Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-04-20T02:03:39.168182Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"380f6760faea5f9e","initial-advertise-peer-urls":["https://199.204.45.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T02:03:39.168267Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T02:03:40.047204Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T02:03:40.047361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T02:03:40.0474Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgPreVoteResp from 380f6760faea5f9e at term 1"} {"level":"info","ts":"2026-04-20T02:03:40.047425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became candidate at term 2"} {"level":"info","ts":"2026-04-20T02:03:40.047441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgVoteResp from 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-04-20T02:03:40.047461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became leader at term 2"} {"level":"info","ts":"2026-04-20T02:03:40.047474Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 380f6760faea5f9e elected leader 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-04-20T02:03:40.048987Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T02:03:40.049765Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T02:03:40.049754Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"380f6760faea5f9e","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.222:2379]}","request-path":"/0/members/380f6760faea5f9e/attributes","cluster-id":"b87e8aca83a17eab","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T02:03:40.050196Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T02:03:40.050193Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T02:03:40.050331Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T02:03:40.050372Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T02:03:40.05052Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T02:03:40.050541Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T02:03:40.053565Z","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:03:40.053657Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.222:2379"} {"level":"warn","ts":"2026-04-20T02:03:40.381171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.524141ms","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":"warn","ts":"2026-04-20T02:03:40.381119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.813026ms","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":"warn","ts":"2026-04-20T02:03:40.381173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.689742ms","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:03:40.381256Z","caller":"traceutil/trace.go:171","msg":"trace[1965842995] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"129.737776ms","start":"2026-04-20T02:03:40.251496Z","end":"2026-04-20T02:03:40.381234Z","steps":["trace[1965842995] 'count revisions from in-memory index tree' (duration: 129.105911ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:03:40.381204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.012781ms","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:03:40.381271Z","caller":"traceutil/trace.go:171","msg":"trace[439915755] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"231.114644ms","start":"2026-04-20T02:03:40.150136Z","end":"2026-04-20T02:03:40.381251Z","steps":["trace[439915755] 'count revisions from in-memory index tree' (duration: 230.691764ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:03:40.381319Z","caller":"traceutil/trace.go:171","msg":"trace[27172664] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"218.991451ms","start":"2026-04-20T02:03:40.162294Z","end":"2026-04-20T02:03:40.381286Z","steps":["trace[27172664] 'range keys from in-memory index tree' (duration: 218.627382ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:03:40.381329Z","caller":"traceutil/trace.go:171","msg":"trace[1153219220] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"231.347239ms","start":"2026-04-20T02:03:40.149947Z","end":"2026-04-20T02:03:40.381295Z","steps":["trace[1153219220] 'range keys from in-memory index tree' (duration: 230.916308ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:03:40.381414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.899472ms","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:03:40.381403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.772117ms","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:03:40.381539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.66269ms","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:03:40.381556Z","caller":"traceutil/trace.go:171","msg":"trace[1326460533] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"158.700122ms","start":"2026-04-20T02:03:40.22285Z","end":"2026-04-20T02:03:40.38155Z","steps":["trace[1326460533] 'range keys from in-memory index tree' (duration: 158.603539ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:03:40.381523Z","caller":"traceutil/trace.go:171","msg":"trace[740507814] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"184.101547ms","start":"2026-04-20T02:03:40.1974Z","end":"2026-04-20T02:03:40.381501Z","steps":["trace[740507814] 'range keys from in-memory index tree' (duration: 183.793949ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:03:40.381676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.714211ms","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:03:40.381694Z","caller":"traceutil/trace.go:171","msg":"trace[85762442] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"142.759303ms","start":"2026-04-20T02:03:40.23893Z","end":"2026-04-20T02:03:40.381689Z","steps":["trace[85762442] 'count revisions from in-memory index tree' (duration: 142.676521ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:03:40.381718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.079491ms","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:03:40.381151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.864867ms","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:03:40.381779Z","caller":"traceutil/trace.go:171","msg":"trace[749633019] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"115.176434ms","start":"2026-04-20T02:03:40.266591Z","end":"2026-04-20T02:03:40.381767Z","steps":["trace[749633019] 'range keys from in-memory index tree' (duration: 114.985648ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:03:40.381805Z","caller":"traceutil/trace.go:171","msg":"trace[559328121] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"219.625497ms","start":"2026-04-20T02:03:40.162173Z","end":"2026-04-20T02:03:40.381799Z","steps":["trace[559328121] 'count revisions from in-memory index tree' (duration: 218.757925ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:03:40.381692Z","caller":"traceutil/trace.go:171","msg":"trace[1773906020] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"129.977373ms","start":"2026-04-20T02:03:40.251565Z","end":"2026-04-20T02:03:40.381543Z","steps":["trace[1773906020] 'range keys from in-memory index tree' (duration: 129.410278ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:03:40.381478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.187868ms","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:03:40.381922Z","caller":"traceutil/trace.go:171","msg":"trace[441791633] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"170.653371ms","start":"2026-04-20T02:03:40.211259Z","end":"2026-04-20T02:03:40.381913Z","steps":["trace[441791633] 'range keys from in-memory index tree' (duration: 170.004734ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:03:40.381955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.199493ms","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:03:40.382007Z","caller":"traceutil/trace.go:171","msg":"trace[1155319175] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"115.243244ms","start":"2026-04-20T02:03:40.266742Z","end":"2026-04-20T02:03:40.381986Z","steps":["trace[1155319175] 'count revisions from in-memory index tree' (duration: 115.130642ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:03:40.382176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.002683ms","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:03:40.382215Z","caller":"traceutil/trace.go:171","msg":"trace[747889908] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"102.054114ms","start":"2026-04-20T02:03:40.28015Z","end":"2026-04-20T02:03:40.382204Z","steps":["trace[747889908] 'count revisions from in-memory index tree' (duration: 101.934752ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:03:40.382418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.069235ms","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:03:40.382503Z","caller":"traceutil/trace.go:171","msg":"trace[44507172] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"102.198698ms","start":"2026-04-20T02:03:40.280282Z","end":"2026-04-20T02:03:40.382481Z","steps":["trace[44507172] 'range keys from in-memory index tree' (duration: 101.938032ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:03:40.382539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.853987ms","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":"info","ts":"2026-04-20T02:03:40.382565Z","caller":"traceutil/trace.go:171","msg":"trace[1345081824] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"208.884738ms","start":"2026-04-20T02:03:40.173673Z","end":"2026-04-20T02:03:40.382557Z","steps":["trace[1345081824] 'count revisions from in-memory index tree' (duration: 208.823166ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:03:40.382516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.483548ms","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:03:40.382629Z","caller":"traceutil/trace.go:171","msg":"trace[992808870] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"196.60804ms","start":"2026-04-20T02:03:40.186008Z","end":"2026-04-20T02:03:40.382616Z","steps":["trace[992808870] 'count revisions from in-memory index tree' (duration: 196.402586ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:03:40.382685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.965279ms","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:03:40.382705Z","caller":"traceutil/trace.go:171","msg":"trace[502042350] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"197.011341ms","start":"2026-04-20T02:03:40.185687Z","end":"2026-04-20T02:03:40.382698Z","steps":["trace[502042350] 'range keys from in-memory index tree' (duration: 196.887007ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:03:40.381522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.699881ms","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:03:40.382891Z","caller":"traceutil/trace.go:171","msg":"trace[226864035] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"160.068036ms","start":"2026-04-20T02:03:40.2228Z","end":"2026-04-20T02:03:40.382868Z","steps":["trace[226864035] 'count revisions from in-memory index tree' (duration: 158.63143ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:03:40.381449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.336003ms","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":"warn","ts":"2026-04-20T02:03:40.38165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.859306ms","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:03:40.383198Z","caller":"traceutil/trace.go:171","msg":"trace[1139938687] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"172.100997ms","start":"2026-04-20T02:03:40.21109Z","end":"2026-04-20T02:03:40.383191Z","steps":["trace[1139938687] 'count revisions from in-memory index tree' (duration: 170.285041ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:03:40.383234Z","caller":"traceutil/trace.go:171","msg":"trace[717790382] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"144.447424ms","start":"2026-04-20T02:03:40.238756Z","end":"2026-04-20T02:03:40.383203Z","steps":["trace[717790382] 'range keys from in-memory index tree' (duration: 142.777873ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:03:40.383265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.077426ms","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":"info","ts":"2026-04-20T02:03:40.383365Z","caller":"traceutil/trace.go:171","msg":"trace[610536884] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"186.18438ms","start":"2026-04-20T02:03:40.197126Z","end":"2026-04-20T02:03:40.383311Z","steps":["trace[610536884] 'count revisions from in-memory index tree' (duration: 186.025045ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:03:40.382192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.54155ms","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":"info","ts":"2026-04-20T02:03:40.383689Z","caller":"traceutil/trace.go:171","msg":"trace[1008942153] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"210.001485ms","start":"2026-04-20T02:03:40.173622Z","end":"2026-04-20T02:03:40.383623Z","steps":["trace[1008942153] 'range keys from in-memory index tree' (duration: 208.490838ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:03:52.917254Z","caller":"traceutil/trace.go:171","msg":"trace[1441560563] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"160.120268ms","start":"2026-04-20T02:03:52.757107Z","end":"2026-04-20T02:03:52.917228Z","steps":["trace[1441560563] 'process raft request' (duration: 159.982305ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:04:12.083309Z","caller":"traceutil/trace.go:171","msg":"trace[1246728147] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"120.189428ms","start":"2026-04-20T02:04:11.963086Z","end":"2026-04-20T02:04:12.083276Z","steps":["trace[1246728147] 'process raft request' (duration: 119.778038ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:04:18.296256Z","caller":"traceutil/trace.go:171","msg":"trace[1486077621] linearizableReadLoop","detail":"{readStateIndex:596; appliedIndex:595; }","duration":"215.823308ms","start":"2026-04-20T02:04:18.080391Z","end":"2026-04-20T02:04:18.296214Z","steps":["trace[1486077621] 'read index received' (duration: 214.73452ms)","trace[1486077621] 'applied index is now lower than readState.Index' (duration: 1.087318ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:04:18.296333Z","caller":"traceutil/trace.go:171","msg":"trace[737650467] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"241.548287ms","start":"2026-04-20T02:04:18.054743Z","end":"2026-04-20T02:04:18.296291Z","steps":["trace[737650467] 'process raft request' (duration: 240.48619ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:04:18.296611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.196266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-5lx7r\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-20T02:04:18.296694Z","caller":"traceutil/trace.go:171","msg":"trace[1229907425] range","detail":"{range_begin:/registry/pods/kube-system/cilium-5lx7r; range_end:; response_count:1; response_revision:578; }","duration":"216.341081ms","start":"2026-04-20T02:04:18.08033Z","end":"2026-04-20T02:04:18.296671Z","steps":["trace[1229907425] 'agreement among raft nodes before linearized reading' (duration: 216.058024ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:04:18.325256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.0369ms","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:04:18.32536Z","caller":"traceutil/trace.go:171","msg":"trace[359193657] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:578; }","duration":"213.211944ms","start":"2026-04-20T02:04:18.112126Z","end":"2026-04-20T02:04:18.325338Z","steps":["trace[359193657] 'agreement among raft nodes before linearized reading' (duration: 212.793174ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:04:19.160769Z","caller":"traceutil/trace.go:171","msg":"trace[1222081568] linearizableReadLoop","detail":"{readStateIndex:602; appliedIndex:601; }","duration":"112.982562ms","start":"2026-04-20T02:04:19.047766Z","end":"2026-04-20T02:04:19.160748Z","steps":["trace[1222081568] 'read index received' (duration: 112.202263ms)","trace[1222081568] 'applied index is now lower than readState.Index' (duration: 779.609µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:04:19.160881Z","caller":"traceutil/trace.go:171","msg":"trace[354366512] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"390.288435ms","start":"2026-04-20T02:04:18.770559Z","end":"2026-04-20T02:04:19.160847Z","steps":["trace[354366512] 'process raft request' (duration: 389.655549ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:04:19.166096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:04:18.769845Z","time spent":"391.114734ms","remote":"127.0.0.1:54382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:04:19.926288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"878.478945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-20T02:04:19.926388Z","caller":"traceutil/trace.go:171","msg":"trace[1995648114] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:583; }","duration":"878.640168ms","start":"2026-04-20T02:04:19.047722Z","end":"2026-04-20T02:04:19.926362Z","steps":["trace[1995648114] 'agreement among raft nodes before linearized reading' (duration: 113.110155ms)","trace[1995648114] 'range keys from in-memory index tree' (duration: 765.286427ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:04:19.926439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:04:19.0477Z","time spent":"878.727521ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-20T02:04:19.92922Z","caller":"traceutil/trace.go:171","msg":"trace[1903752137] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:602; }","duration":"271.381237ms","start":"2026-04-20T02:04:19.657799Z","end":"2026-04-20T02:04:19.92918Z","steps":["trace[1903752137] 'read index received' (duration: 270.989758ms)","trace[1903752137] 'applied index is now lower than readState.Index' (duration: 390.259µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:04:19.929334Z","caller":"traceutil/trace.go:171","msg":"trace[591380177] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"704.90499ms","start":"2026-04-20T02:04:19.22437Z","end":"2026-04-20T02:04:19.929275Z","steps":["trace[591380177] 'process raft request' (duration: 704.562282ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:04:19.929485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:04:19.224314Z","time spent":"705.093254ms","remote":"127.0.0.1:54754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T02:04:19.929578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.752396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T02:04:19.929604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.723339ms","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:04:19.929686Z","caller":"traceutil/trace.go:171","msg":"trace[1031111916] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:584; }","duration":"209.877013ms","start":"2026-04-20T02:04:19.719794Z","end":"2026-04-20T02:04:19.929671Z","steps":["trace[1031111916] 'agreement among raft nodes before linearized reading' (duration: 209.609166ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:04:19.929696Z","caller":"traceutil/trace.go:171","msg":"trace[315351595] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:584; }","duration":"271.92524ms","start":"2026-04-20T02:04:19.65774Z","end":"2026-04-20T02:04:19.929665Z","steps":["trace[315351595] 'agreement among raft nodes before linearized reading' (duration: 271.597382ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:04:20.183128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.845868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:04:20.183221Z","caller":"traceutil/trace.go:171","msg":"trace[583660850] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:586; }","duration":"144.032352ms","start":"2026-04-20T02:04:20.039163Z","end":"2026-04-20T02:04:20.183196Z","steps":["trace[583660850] 'count revisions from in-memory index tree' (duration: 143.719014ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:04:20.183219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.963981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:04:20.183352Z","caller":"traceutil/trace.go:171","msg":"trace[1175264422] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:586; }","duration":"144.128774ms","start":"2026-04-20T02:04:20.039151Z","end":"2026-04-20T02:04:20.18328Z","steps":["trace[1175264422] 'range keys from in-memory index tree' (duration: 143.810937ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:04:20.18345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.53361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:04:20.183592Z","caller":"traceutil/trace.go:171","msg":"trace[999066880] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:586; }","duration":"143.744936ms","start":"2026-04-20T02:04:20.039821Z","end":"2026-04-20T02:04:20.183566Z","steps":["trace[999066880] 'range keys from in-memory index tree' (duration: 143.346486ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:19.427551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"807.601122ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-20T02:05:19.427978Z","caller":"traceutil/trace.go:171","msg":"trace[151102367] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"1.380525063s","start":"2026-04-20T02:05:18.047398Z","end":"2026-04-20T02:05:19.427923Z","steps":["trace[151102367] 'process raft request' (duration: 572.222074ms)","trace[151102367] 'compare' (duration: 807.435717ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:05:19.428006Z","caller":"traceutil/trace.go:171","msg":"trace[1364370947] linearizableReadLoop","detail":"{readStateIndex:1292; appliedIndex:1291; }","duration":"1.177361703s","start":"2026-04-20T02:05:18.250587Z","end":"2026-04-20T02:05:19.427949Z","steps":["trace[1364370947] 'read index received' (duration: 368.953002ms)","trace[1364370947] 'applied index is now lower than readState.Index' (duration: 808.402211ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:05:19.428215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:18.047365Z","time spent":"1.380713067s","remote":"127.0.0.1:54610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1089,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T02:05:19.436371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.185753139s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-20T02:05:19.436463Z","caller":"traceutil/trace.go:171","msg":"trace[1376524597] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1255; }","duration":"1.185914553s","start":"2026-04-20T02:05:18.250525Z","end":"2026-04-20T02:05:19.43644Z","steps":["trace[1376524597] 'agreement among raft nodes before linearized reading' (duration: 1.177502257s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:19.436513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:18.250499Z","time spent":"1.186002854s","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-20T02:05:19.436528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.164452848s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-20T02:05:19.436596Z","caller":"traceutil/trace.go:171","msg":"trace[120797965] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1256; }","duration":"1.164590492s","start":"2026-04-20T02:05:18.271988Z","end":"2026-04-20T02:05:19.436578Z","steps":["trace[120797965] 'agreement among raft nodes before linearized reading' (duration: 1.164398867s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:19.436636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"881.007497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T02:05:19.43668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:18.271966Z","time spent":"1.164670253s","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-20T02:05:19.436691Z","caller":"traceutil/trace.go:171","msg":"trace[1648698770] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1256; }","duration":"881.118829ms","start":"2026-04-20T02:05:18.555559Z","end":"2026-04-20T02:05:19.436678Z","steps":["trace[1648698770] 'agreement among raft nodes before linearized reading' (duration: 881.032797ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:19.436729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:18.555535Z","time spent":"881.184561ms","remote":"127.0.0.1:54436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"warn","ts":"2026-04-20T02:05:19.436783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"769.639073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-20T02:05:19.436921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"769.564741ms","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:05:19.436971Z","caller":"traceutil/trace.go:171","msg":"trace[517988106] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1256; }","duration":"769.864038ms","start":"2026-04-20T02:05:18.667092Z","end":"2026-04-20T02:05:19.436956Z","steps":["trace[517988106] 'agreement among raft nodes before linearized reading' (duration: 769.574111ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:19.437006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:18.66707Z","time spent":"769.9265ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-20T02:05:19.437008Z","caller":"traceutil/trace.go:171","msg":"trace[714476325] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1256; }","duration":"769.711085ms","start":"2026-04-20T02:05:18.667276Z","end":"2026-04-20T02:05:19.436987Z","steps":["trace[714476325] 'agreement among raft nodes before linearized reading' (duration: 769.225683ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:19.436636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"779.708489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T02:05:19.437046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:18.667265Z","time spent":"769.772686ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-20T02:05:19.437079Z","caller":"traceutil/trace.go:171","msg":"trace[17056212] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1256; }","duration":"780.1643ms","start":"2026-04-20T02:05:18.656901Z","end":"2026-04-20T02:05:19.437066Z","steps":["trace[17056212] 'agreement among raft nodes before linearized reading' (duration: 779.657278ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:19.437113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:18.656788Z","time spent":"780.316574ms","remote":"127.0.0.1:54304","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.436877Z","caller":"traceutil/trace.go:171","msg":"trace[825128774] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"963.810281ms","start":"2026-04-20T02:05:18.473045Z","end":"2026-04-20T02:05:19.436856Z","steps":["trace[825128774] 'process raft request' (duration: 963.200046ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:19.437271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:18.473013Z","time spent":"964.19516ms","remote":"127.0.0.1:54546","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:05:19.436886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"931.755638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T02:05:19.437342Z","caller":"traceutil/trace.go:171","msg":"trace[1423792260] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:1256; }","duration":"932.26118ms","start":"2026-04-20T02:05:18.505072Z","end":"2026-04-20T02:05:19.437334Z","steps":["trace[1423792260] 'agreement among raft nodes before linearized reading' (duration: 931.734048ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:19.437411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:18.50506Z","time spent":"932.337792ms","remote":"127.0.0.1:54702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":7,"response size":30,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"info","ts":"2026-04-20T02:05:37.629174Z","caller":"traceutil/trace.go:171","msg":"trace[600846062] transaction","detail":"{read_only:false; response_revision:1594; number_of_response:1; }","duration":"127.403145ms","start":"2026-04-20T02:05:37.501739Z","end":"2026-04-20T02:05:37.629142Z","steps":["trace[600846062] 'process raft request' (duration: 122.141916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:38.072922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.512017ms","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:38.072993Z","caller":"traceutil/trace.go:171","msg":"trace[1818670990] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1620; }","duration":"232.64059ms","start":"2026-04-20T02:05:37.840334Z","end":"2026-04-20T02:05:38.072974Z","steps":["trace[1818670990] 'range keys from in-memory index tree' (duration: 232.342313ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:52.025061Z","caller":"traceutil/trace.go:171","msg":"trace[2069904505] linearizableReadLoop","detail":"{readStateIndex:1876; appliedIndex:1875; }","duration":"367.226601ms","start":"2026-04-20T02:05:51.657798Z","end":"2026-04-20T02:05:52.025025Z","steps":["trace[2069904505] 'read index received' (duration: 366.945694ms)","trace[2069904505] 'applied index is now lower than readState.Index' (duration: 279.067µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:05:52.025243Z","caller":"traceutil/trace.go:171","msg":"trace[1546382747] transaction","detail":"{read_only:false; response_revision:1807; number_of_response:1; }","duration":"451.936282ms","start":"2026-04-20T02:05:51.573294Z","end":"2026-04-20T02:05:52.02523Z","steps":["trace[1546382747] 'process raft request' (duration: 451.46346ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:52.025516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.685252ms","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:52.025621Z","caller":"traceutil/trace.go:171","msg":"trace[913032779] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1807; }","duration":"367.856056ms","start":"2026-04-20T02:05:51.657741Z","end":"2026-04-20T02:05:52.025597Z","steps":["trace[913032779] 'agreement among raft nodes before linearized reading' (duration: 367.650931ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:52.025665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:51.657711Z","time spent":"367.947108ms","remote":"127.0.0.1:54298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-20T02:05:52.025633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:51.573256Z","time spent":"452.022674ms","remote":"127.0.0.1:54478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3729,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:05:52.135304Z","caller":"traceutil/trace.go:171","msg":"trace[1327989567] transaction","detail":"{read_only:false; response_revision:1808; number_of_response:1; }","duration":"395.295727ms","start":"2026-04-20T02:05:51.739974Z","end":"2026-04-20T02:05:52.13527Z","steps":["trace[1327989567] 'process raft request' (duration: 305.613733ms)","trace[1327989567] 'compare' (duration: 89.463588ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:05:52.135463Z","caller":"traceutil/trace.go:171","msg":"trace[657437167] linearizableReadLoop","detail":"{readStateIndex:1878; appliedIndex:1876; }","duration":"110.278967ms","start":"2026-04-20T02:05:52.02515Z","end":"2026-04-20T02:05:52.135429Z","steps":["trace[657437167] 'read index received' (duration: 20.314136ms)","trace[657437167] 'applied index is now lower than readState.Index' (duration: 89.962511ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:05:52.135533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:51.739947Z","time spent":"395.477261ms","remote":"127.0.0.1:54546","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:52.135652Z","caller":"traceutil/trace.go:171","msg":"trace[162871598] transaction","detail":"{read_only:false; response_revision:1809; number_of_response:1; }","duration":"191.084503ms","start":"2026-04-20T02:05:51.944502Z","end":"2026-04-20T02:05:52.135586Z","steps":["trace[162871598] 'process raft request' (duration: 190.715024ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:52.135797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.558748ms","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:52.13581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.740349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:05:52.135855Z","caller":"traceutil/trace.go:171","msg":"trace[2058941225] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1809; }","duration":"385.694962ms","start":"2026-04-20T02:05:51.750144Z","end":"2026-04-20T02:05:52.135839Z","steps":["trace[2058941225] 'agreement among raft nodes before linearized reading' (duration: 385.397065ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:52.135902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:51.750109Z","time spent":"385.780834ms","remote":"127.0.0.1:54546","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:52.135849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.462517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-20T02:05:52.135921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.735579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-20T02:05:52.135994Z","caller":"traceutil/trace.go:171","msg":"trace[1267838521] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1809; }","duration":"383.644553ms","start":"2026-04-20T02:05:51.752324Z","end":"2026-04-20T02:05:52.135968Z","steps":["trace[1267838521] 'agreement among raft nodes before linearized reading' (duration: 383.411096ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:52.136032Z","caller":"traceutil/trace.go:171","msg":"trace[865982006] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1809; }","duration":"382.895624ms","start":"2026-04-20T02:05:51.75311Z","end":"2026-04-20T02:05:52.136006Z","steps":["trace[865982006] 'agreement among raft nodes before linearized reading' (duration: 382.568796ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:52.136061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:51.752295Z","time spent":"383.750195ms","remote":"127.0.0.1:54546","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:05:52.136088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:51.753093Z","time spent":"382.985696ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-20T02:05:52.136224Z","caller":"traceutil/trace.go:171","msg":"trace[1479922425] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1809; }","duration":"346.811321ms","start":"2026-04-20T02:05:51.789044Z","end":"2026-04-20T02:05:52.135855Z","steps":["trace[1479922425] 'agreement among raft nodes before linearized reading' (duration: 346.605736ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:52.136308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:51.789019Z","time spent":"347.267823ms","remote":"127.0.0.1:54674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"warn","ts":"2026-04-20T02:05:52.136455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.404087ms","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:05:52.136549Z","caller":"traceutil/trace.go:171","msg":"trace[340497059] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1809; }","duration":"381.578882ms","start":"2026-04-20T02:05:51.754948Z","end":"2026-04-20T02:05:52.136527Z","steps":["trace[340497059] 'agreement among raft nodes before linearized reading' (duration: 380.565897ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:52.136602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:51.754925Z","time spent":"381.667905ms","remote":"127.0.0.1:54546","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:52.472881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.356429ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T02:05:52.473194Z","caller":"traceutil/trace.go:171","msg":"trace[1645805802] transaction","detail":"{read_only:false; response_revision:1812; number_of_response:1; }","duration":"331.175949ms","start":"2026-04-20T02:05:52.141996Z","end":"2026-04-20T02:05:52.473172Z","steps":["trace[1645805802] 'process raft request' (duration: 331.085827ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:52.473167Z","caller":"traceutil/trace.go:171","msg":"trace[1247519614] transaction","detail":"{read_only:false; response_revision:1810; number_of_response:1; }","duration":"331.754614ms","start":"2026-04-20T02:05:52.141367Z","end":"2026-04-20T02:05:52.473122Z","steps":["trace[1247519614] 'process raft request' (duration: 165.053826ms)","trace[1247519614] 'compare' (duration: 166.158725ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:05:52.473191Z","caller":"traceutil/trace.go:171","msg":"trace[84753130] transaction","detail":"{read_only:false; response_revision:1811; number_of_response:1; }","duration":"331.212171ms","start":"2026-04-20T02:05:52.14194Z","end":"2026-04-20T02:05:52.473152Z","steps":["trace[84753130] 'process raft request' (duration: 331.053097ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:52.473278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:52.141957Z","time spent":"331.285902ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:05:52.47337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:52.141914Z","time spent":"331.358873ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:05:52.47338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:52.141338Z","time spent":"331.921368ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:05:52.473391Z","caller":"traceutil/trace.go:171","msg":"trace[1641550470] linearizableReadLoop","detail":"{readStateIndex:1882; appliedIndex:1878; }","duration":"320.632112ms","start":"2026-04-20T02:05:52.152728Z","end":"2026-04-20T02:05:52.47336Z","steps":["trace[1641550470] 'read index received' (duration: 153.674848ms)","trace[1641550470] 'applied index is now lower than readState.Index' (duration: 166.956024ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:05:52.473513Z","caller":"traceutil/trace.go:171","msg":"trace[209249690] transaction","detail":"{read_only:false; response_revision:1813; number_of_response:1; }","duration":"331.339093ms","start":"2026-04-20T02:05:52.142046Z","end":"2026-04-20T02:05:52.473385Z","steps":["trace[209249690] 'process raft request' (duration: 331.076157ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:52.47361Z","caller":"traceutil/trace.go:171","msg":"trace[107535866] transaction","detail":"{read_only:false; response_revision:1814; number_of_response:1; }","duration":"298.621193ms","start":"2026-04-20T02:05:52.174969Z","end":"2026-04-20T02:05:52.473591Z","steps":["trace[107535866] 'process raft request' (duration: 298.282975ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:52.473734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.988931ms","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:05:52.473784Z","caller":"traceutil/trace.go:171","msg":"trace[1053839489] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1814; }","duration":"321.098783ms","start":"2026-04-20T02:05:52.152675Z","end":"2026-04-20T02:05:52.473773Z","steps":["trace[1053839489] 'agreement among raft nodes before linearized reading' (duration: 320.919989ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:52.473771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:52.142007Z","time spent":"331.63505ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:05:52.473829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:52.152657Z","time spent":"321.162445ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-20T02:05:52.473769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.753124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ed46aed3-196f-434f-99bd-05d7ea7004f1\" ","response":"range_response_count:1 size:3744"} {"level":"warn","ts":"2026-04-20T02:05:52.473868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.024759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-20T02:05:52.473918Z","caller":"traceutil/trace.go:171","msg":"trace[751261167] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1814; }","duration":"170.120281ms","start":"2026-04-20T02:05:52.303781Z","end":"2026-04-20T02:05:52.473902Z","steps":["trace[751261167] 'agreement among raft nodes before linearized reading' (duration: 170.021408ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:52.473989Z","caller":"traceutil/trace.go:171","msg":"trace[1080501505] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ed46aed3-196f-434f-99bd-05d7ea7004f1; range_end:; response_count:1; response_revision:1814; }","duration":"311.898798ms","start":"2026-04-20T02:05:52.161963Z","end":"2026-04-20T02:05:52.473862Z","steps":["trace[1080501505] 'agreement among raft nodes before linearized reading' (duration: 311.667962ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:52.474031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:52.161946Z","time spent":"312.074841ms","remote":"127.0.0.1:54478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3767,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ed46aed3-196f-434f-99bd-05d7ea7004f1\" "} {"level":"info","ts":"2026-04-20T02:06:06.368261Z","caller":"traceutil/trace.go:171","msg":"trace[464838047] transaction","detail":"{read_only:false; response_revision:1926; number_of_response:1; }","duration":"182.308488ms","start":"2026-04-20T02:06:06.185923Z","end":"2026-04-20T02:06:06.368232Z","steps":["trace[464838047] 'process raft request' (duration: 182.152534ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:06.36913Z","caller":"traceutil/trace.go:171","msg":"trace[871010490] transaction","detail":"{read_only:false; response_revision:1927; number_of_response:1; }","duration":"181.287643ms","start":"2026-04-20T02:06:06.187816Z","end":"2026-04-20T02:06:06.369104Z","steps":["trace[871010490] 'process raft request' (duration: 181.16675ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:23.873637Z","caller":"traceutil/trace.go:171","msg":"trace[642351012] linearizableReadLoop","detail":"{readStateIndex:2116; appliedIndex:2115; }","duration":"216.589517ms","start":"2026-04-20T02:06:23.657018Z","end":"2026-04-20T02:06:23.873607Z","steps":["trace[642351012] 'read index received' (duration: 216.513726ms)","trace[642351012] 'applied index is now lower than readState.Index' (duration: 73.981µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:06:23.873768Z","caller":"traceutil/trace.go:171","msg":"trace[1587847870] transaction","detail":"{read_only:false; response_revision:2040; number_of_response:1; }","duration":"312.934724ms","start":"2026-04-20T02:06:23.560769Z","end":"2026-04-20T02:06:23.873703Z","steps":["trace[1587847870] 'process raft request' (duration: 312.635617ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:23.873966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:23.560739Z","time spent":"313.108168ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:06:23.874115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.818387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-20T02:06:23.87417Z","caller":"traceutil/trace.go:171","msg":"trace[1562848469] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2040; }","duration":"181.949111ms","start":"2026-04-20T02:06:23.692203Z","end":"2026-04-20T02:06:23.874152Z","steps":["trace[1562848469] 'agreement among raft nodes before linearized reading' (duration: 181.668114ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:23.874368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.312256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:06:23.874519Z","caller":"traceutil/trace.go:171","msg":"trace[715285278] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2040; }","duration":"217.528611ms","start":"2026-04-20T02:06:23.656957Z","end":"2026-04-20T02:06:23.874486Z","steps":["trace[715285278] 'agreement among raft nodes before linearized reading' (duration: 216.862675ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:24.825376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"806.922545ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:06:24.82553Z","caller":"traceutil/trace.go:171","msg":"trace[730923705] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2040; }","duration":"807.101369ms","start":"2026-04-20T02:06:24.018404Z","end":"2026-04-20T02:06:24.825506Z","steps":["trace[730923705] 'range keys from in-memory index tree' (duration: 806.906405ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:24.825547Z","caller":"traceutil/trace.go:171","msg":"trace[1536886785] transaction","detail":"{read_only:false; response_revision:2041; number_of_response:1; }","duration":"630.788207ms","start":"2026-04-20T02:06:24.194717Z","end":"2026-04-20T02:06:24.825505Z","steps":["trace[1536886785] 'process raft request' (duration: 628.018279ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:24.826856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:24.194688Z","time spent":"630.958122ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:06:24.830541Z","caller":"traceutil/trace.go:171","msg":"trace[1838364914] linearizableReadLoop","detail":"{readStateIndex:2121; appliedIndex:2116; }","duration":"209.975885ms","start":"2026-04-20T02:06:24.62037Z","end":"2026-04-20T02:06:24.830346Z","steps":["trace[1838364914] 'read index received' (duration: 202.363369ms)","trace[1838364914] 'applied index is now lower than readState.Index' (duration: 7.608376ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:06:24.832214Z","caller":"traceutil/trace.go:171","msg":"trace[1326641272] transaction","detail":"{read_only:false; response_revision:2045; number_of_response:1; }","duration":"238.326319ms","start":"2026-04-20T02:06:24.593839Z","end":"2026-04-20T02:06:24.832165Z","steps":["trace[1326641272] 'process raft request' (duration: 236.222857ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:24.83228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.42679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:06:24.832331Z","caller":"traceutil/trace.go:171","msg":"trace[2088195942] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2045; }","duration":"175.486852ms","start":"2026-04-20T02:06:24.656819Z","end":"2026-04-20T02:06:24.832306Z","steps":["trace[2088195942] 'agreement among raft nodes before linearized reading' (duration: 175.41556ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:24.832292Z","caller":"traceutil/trace.go:171","msg":"trace[1086693304] transaction","detail":"{read_only:false; response_revision:2044; number_of_response:1; }","duration":"246.726454ms","start":"2026-04-20T02:06:24.58551Z","end":"2026-04-20T02:06:24.832236Z","steps":["trace[1086693304] 'process raft request' (duration: 244.285104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:24.832371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.89257ms","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.832562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.636358ms","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:24.832612Z","caller":"traceutil/trace.go:171","msg":"trace[1196793584] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2045; }","duration":"169.141596ms","start":"2026-04-20T02:06:24.663422Z","end":"2026-04-20T02:06:24.832564Z","steps":["trace[1196793584] 'agreement among raft nodes before linearized reading' (duration: 168.816119ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:24.832587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.492505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-20T02:06:24.832676Z","caller":"traceutil/trace.go:171","msg":"trace[1408211355] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2045; }","duration":"207.861913ms","start":"2026-04-20T02:06:24.624774Z","end":"2026-04-20T02:06:24.832636Z","steps":["trace[1408211355] 'agreement among raft nodes before linearized reading' (duration: 207.491844ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:24.83271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.548606ms","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.83285Z","caller":"traceutil/trace.go:171","msg":"trace[1902551562] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2045; }","duration":"205.717151ms","start":"2026-04-20T02:06:24.627119Z","end":"2026-04-20T02:06:24.832836Z","steps":["trace[1902551562] 'agreement among raft nodes before linearized reading' (duration: 205.183088ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:24.83273Z","caller":"traceutil/trace.go:171","msg":"trace[1254148442] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2045; }","duration":"207.652688ms","start":"2026-04-20T02:06:24.62503Z","end":"2026-04-20T02:06:24.832683Z","steps":["trace[1254148442] 'agreement among raft nodes before linearized reading' (duration: 207.275049ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:24.832888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.331534ms","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.833089Z","caller":"traceutil/trace.go:171","msg":"trace[378768988] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2045; }","duration":"212.733983ms","start":"2026-04-20T02:06:24.620319Z","end":"2026-04-20T02:06:24.833053Z","steps":["trace[378768988] 'agreement among raft nodes before linearized reading' (duration: 211.912473ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:24.832374Z","caller":"traceutil/trace.go:171","msg":"trace[1500186947] transaction","detail":"{read_only:false; response_revision:2042; number_of_response:1; }","duration":"549.218502ms","start":"2026-04-20T02:06:24.283071Z","end":"2026-04-20T02:06:24.832289Z","steps":["trace[1500186947] 'process raft request' (duration: 545.292026ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:24.833465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:24.283052Z","time spent":"550.343869ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:06:24.832545Z","caller":"traceutil/trace.go:171","msg":"trace[514430827] transaction","detail":"{read_only:false; response_revision:2043; number_of_response:1; }","duration":"402.29585ms","start":"2026-04-20T02:06:24.4299Z","end":"2026-04-20T02:06:24.832196Z","steps":["trace[514430827] 'process raft request' (duration: 399.628884ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:24.833825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:24.429855Z","time spent":"403.842418ms","remote":"127.0.0.1:54546","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:26.390108Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890117827505232493,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T02:06:26.890312Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890117827505232493,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T02:06:27.009015Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.129615365s","expected-duration":"1s"} {"level":"info","ts":"2026-04-20T02:06:27.009777Z","caller":"traceutil/trace.go:171","msg":"trace[1087416460] transaction","detail":"{read_only:false; response_revision:2052; number_of_response:1; }","duration":"1.130528588s","start":"2026-04-20T02:06:25.879202Z","end":"2026-04-20T02:06:27.009731Z","steps":["trace[1087416460] 'process raft request' (duration: 1.13021041s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:27.010127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:25.879167Z","time spent":"1.130755413s","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:06:27.013288Z","caller":"traceutil/trace.go:171","msg":"trace[882268695] transaction","detail":"{read_only:false; response_revision:2053; number_of_response:1; }","duration":"174.515489ms","start":"2026-04-20T02:06:26.838747Z","end":"2026-04-20T02:06:27.013263Z","steps":["trace[882268695] 'process raft request' (duration: 174.356904ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:27.013836Z","caller":"traceutil/trace.go:171","msg":"trace[1372289900] transaction","detail":"{read_only:false; response_revision:2054; number_of_response:1; }","duration":"174.9823ms","start":"2026-04-20T02:06:26.838814Z","end":"2026-04-20T02:06:27.013797Z","steps":["trace[1372289900] 'process raft request' (duration: 174.377705ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:27.013883Z","caller":"traceutil/trace.go:171","msg":"trace[449307260] linearizableReadLoop","detail":"{readStateIndex:2131; appliedIndex:2127; }","duration":"1.124428919s","start":"2026-04-20T02:06:25.889436Z","end":"2026-04-20T02:06:27.013865Z","steps":["trace[449307260] 'read index received' (duration: 1.120016991s)","trace[449307260] 'applied index is now lower than readState.Index' (duration: 4.410998ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:06:27.014132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.124708606s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-20T02:06:27.014176Z","caller":"traceutil/trace.go:171","msg":"trace[97376262] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2055; }","duration":"1.124809269s","start":"2026-04-20T02:06:25.889356Z","end":"2026-04-20T02:06:27.014165Z","steps":["trace[97376262] 'agreement among raft nodes before linearized reading' (duration: 1.124553372s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:27.014203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:25.889324Z","time spent":"1.12487263s","remote":"127.0.0.1:53892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-04-20T02:06:27.014353Z","caller":"traceutil/trace.go:171","msg":"trace[73652369] transaction","detail":"{read_only:false; response_revision:2055; number_of_response:1; }","duration":"174.939728ms","start":"2026-04-20T02:06:26.839385Z","end":"2026-04-20T02:06:27.014325Z","steps":["trace[73652369] 'process raft request' (duration: 174.250192ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:27.014603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"746.800354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:06:27.014681Z","caller":"traceutil/trace.go:171","msg":"trace[588383531] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:2055; }","duration":"746.954827ms","start":"2026-04-20T02:06:26.267706Z","end":"2026-04-20T02:06:27.014661Z","steps":["trace[588383531] 'agreement among raft nodes before linearized reading' (duration: 746.746182ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:27.014698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.903ms","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.014725Z","caller":"traceutil/trace.go:171","msg":"trace[1741916924] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2055; }","duration":"168.965272ms","start":"2026-04-20T02:06:26.845752Z","end":"2026-04-20T02:06:27.014717Z","steps":["trace[1741916924] 'agreement among raft nodes before linearized reading' (duration: 168.9044ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:27.014735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:26.267682Z","time spent":"747.03561ms","remote":"127.0.0.1:34946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-20T02:06:27.014631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.371682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-20T02:06:27.014751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.312938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:06:27.014821Z","caller":"traceutil/trace.go:171","msg":"trace[779143582] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2055; }","duration":"169.563756ms","start":"2026-04-20T02:06:26.845236Z","end":"2026-04-20T02:06:27.0148Z","steps":["trace[779143582] 'agreement among raft nodes before linearized reading' (duration: 169.30374ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:27.014839Z","caller":"traceutil/trace.go:171","msg":"trace[389736449] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2055; }","duration":"357.465901ms","start":"2026-04-20T02:06:26.657347Z","end":"2026-04-20T02:06:27.014813Z","steps":["trace[389736449] 'agreement among raft nodes before linearized reading' (duration: 357.299307ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:27.014867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.10874ms","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:27.014872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.134846ms","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.014922Z","caller":"traceutil/trace.go:171","msg":"trace[1485748482] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2055; }","duration":"170.204542ms","start":"2026-04-20T02:06:26.844702Z","end":"2026-04-20T02:06:27.014907Z","steps":["trace[1485748482] 'agreement among raft nodes before linearized reading' (duration: 169.976537ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:27.014944Z","caller":"traceutil/trace.go:171","msg":"trace[1891504652] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2055; }","duration":"169.231068ms","start":"2026-04-20T02:06:26.845692Z","end":"2026-04-20T02:06:27.014923Z","steps":["trace[1891504652] 'agreement among raft nodes before linearized reading' (duration: 169.024483ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:27.014881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:26.65732Z","time spent":"357.551995ms","remote":"127.0.0.1:54304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-20T02:06:27.01526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.838546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-20T02:06:27.015367Z","caller":"traceutil/trace.go:171","msg":"trace[1377693116] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2055; }","duration":"173.028011ms","start":"2026-04-20T02:06:26.842315Z","end":"2026-04-20T02:06:27.015343Z","steps":["trace[1377693116] 'agreement among raft nodes before linearized reading' (duration: 172.334084ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:37.150531Z","caller":"traceutil/trace.go:171","msg":"trace[1573077036] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"105.12782ms","start":"2026-04-20T02:06:37.045372Z","end":"2026-04-20T02:06:37.150499Z","steps":["trace[1573077036] 'process raft request' (duration: 104.899075ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:37.198386Z","caller":"traceutil/trace.go:171","msg":"trace[187782061] transaction","detail":"{read_only:false; response_revision:2107; number_of_response:1; }","duration":"146.014221ms","start":"2026-04-20T02:06:37.052337Z","end":"2026-04-20T02:06:37.198351Z","steps":["trace[187782061] 'process raft request' (duration: 145.930579ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:37.198443Z","caller":"traceutil/trace.go:171","msg":"trace[1300526831] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"146.314728ms","start":"2026-04-20T02:06:37.052085Z","end":"2026-04-20T02:06:37.1984Z","steps":["trace[1300526831] 'process raft request' (duration: 145.9967ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:37.198623Z","caller":"traceutil/trace.go:171","msg":"trace[431348217] transaction","detail":"{read_only:false; response_revision:2108; number_of_response:1; }","duration":"145.55804ms","start":"2026-04-20T02:06:37.053049Z","end":"2026-04-20T02:06:37.198607Z","steps":["trace[431348217] 'process raft request' (duration: 145.262233ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:37.198632Z","caller":"traceutil/trace.go:171","msg":"trace[326906165] linearizableReadLoop","detail":"{readStateIndex:2186; appliedIndex:2182; }","duration":"143.306224ms","start":"2026-04-20T02:06:37.05529Z","end":"2026-04-20T02:06:37.198596Z","steps":["trace[326906165] 'read index received' (duration: 95.066335ms)","trace[326906165] 'applied index is now lower than readState.Index' (duration: 48.238149ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:06:37.198952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.47217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-04-20T02:06:37.198953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.579334ms","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":"warn","ts":"2026-04-20T02:06:37.198962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.494206ms","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:37.199018Z","caller":"traceutil/trace.go:171","msg":"trace[1495146110] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2108; }","duration":"132.694076ms","start":"2026-04-20T02:06:37.066309Z","end":"2026-04-20T02:06:37.199003Z","steps":["trace[1495146110] 'agreement among raft nodes before linearized reading' (duration: 132.517121ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:37.199008Z","caller":"traceutil/trace.go:171","msg":"trace[2076500900] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2108; }","duration":"114.571832ms","start":"2026-04-20T02:06:37.08442Z","end":"2026-04-20T02:06:37.198991Z","steps":["trace[2076500900] 'agreement among raft nodes before linearized reading' (duration: 114.409507ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:37.199031Z","caller":"traceutil/trace.go:171","msg":"trace[1670562631] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2108; }","duration":"133.578058ms","start":"2026-04-20T02:06:37.065436Z","end":"2026-04-20T02:06:37.199014Z","steps":["trace[1670562631] 'agreement among raft nodes before linearized reading' (duration: 133.418073ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:37.199041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.426998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-20T02:06:37.199054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.751726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-20T02:06:37.199101Z","caller":"traceutil/trace.go:171","msg":"trace[32707206] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2108; }","duration":"134.53021ms","start":"2026-04-20T02:06:37.064555Z","end":"2026-04-20T02:06:37.199086Z","steps":["trace[32707206] 'agreement among raft nodes before linearized reading' (duration: 134.312994ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:37.199107Z","caller":"traceutil/trace.go:171","msg":"trace[2114046947] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2108; }","duration":"143.830048ms","start":"2026-04-20T02:06:37.055263Z","end":"2026-04-20T02:06:37.199093Z","steps":["trace[2114046947] 'agreement among raft nodes before linearized reading' (duration: 143.50746ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:37.199189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.364775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-20T02:06:37.199219Z","caller":"traceutil/trace.go:171","msg":"trace[62687237] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2108; }","duration":"136.398846ms","start":"2026-04-20T02:06:37.062812Z","end":"2026-04-20T02:06:37.199211Z","steps":["trace[62687237] 'agreement among raft nodes before linearized reading' (duration: 136.296974ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:43.369206Z","caller":"traceutil/trace.go:171","msg":"trace[1378384626] linearizableReadLoop","detail":"{readStateIndex:2215; appliedIndex:2214; }","duration":"180.608967ms","start":"2026-04-20T02:06:43.188565Z","end":"2026-04-20T02:06:43.369174Z","steps":["trace[1378384626] 'read index received' (duration: 180.33025ms)","trace[1378384626] 'applied index is now lower than readState.Index' (duration: 277.207µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:06:43.36933Z","caller":"traceutil/trace.go:171","msg":"trace[579332599] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"200.509294ms","start":"2026-04-20T02:06:43.168786Z","end":"2026-04-20T02:06:43.369295Z","steps":["trace[579332599] 'process raft request' (duration: 200.132905ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:43.369558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.968715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.222\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-20T02:06:43.369616Z","caller":"traceutil/trace.go:171","msg":"trace[1307566182] range","detail":"{range_begin:/registry/masterleases/199.204.45.222; range_end:; response_count:1; response_revision:2136; }","duration":"181.096738ms","start":"2026-04-20T02:06:43.188506Z","end":"2026-04-20T02:06:43.369603Z","steps":["trace[1307566182] 'agreement among raft nodes before linearized reading' (duration: 180.873223ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:43.794024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.271026ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T02:06:43.794246Z","caller":"traceutil/trace.go:171","msg":"trace[1908159093] transaction","detail":"{read_only:false; response_revision:2137; number_of_response:1; }","duration":"576.407237ms","start":"2026-04-20T02:06:43.217807Z","end":"2026-04-20T02:06:43.794214Z","steps":["trace[1908159093] 'process raft request' (duration: 425.832744ms)","trace[1908159093] 'compare' (duration: 150.146662ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:06:43.794328Z","caller":"traceutil/trace.go:171","msg":"trace[703526083] linearizableReadLoop","detail":"{readStateIndex:2218; appliedIndex:2215; }","duration":"424.958183ms","start":"2026-04-20T02:06:43.369346Z","end":"2026-04-20T02:06:43.794304Z","steps":["trace[703526083] 'read index received' (duration: 274.37945ms)","trace[703526083] 'applied index is now lower than readState.Index' (duration: 150.577623ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:06:43.794415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:43.217788Z","time spent":"576.53597ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:06:43.794579Z","caller":"traceutil/trace.go:171","msg":"trace[220080584] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"573.553098ms","start":"2026-04-20T02:06:43.220998Z","end":"2026-04-20T02:06:43.794551Z","steps":["trace[220080584] 'process raft request' (duration: 573.22927ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:43.794647Z","caller":"traceutil/trace.go:171","msg":"trace[1159947799] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"574.06761ms","start":"2026-04-20T02:06:43.220554Z","end":"2026-04-20T02:06:43.794622Z","steps":["trace[1159947799] 'process raft request' (duration: 573.588578ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:43.794699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.611957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-20T02:06:43.794714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.860624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-04-20T02:06:43.794755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:43.220544Z","time spent":"574.152771ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:06:43.794802Z","caller":"traceutil/trace.go:171","msg":"trace[829000762] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2139; }","duration":"548.69562ms","start":"2026-04-20T02:06:43.246054Z","end":"2026-04-20T02:06:43.794749Z","steps":["trace[829000762] 'agreement among raft nodes before linearized reading' (duration: 548.503825ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:43.794698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.57044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-20T02:06:43.794873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:43.246044Z","time spent":"548.815752ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-20T02:06:43.794888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.452714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-20T02:06:43.794703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:43.220984Z","time spent":"573.66149ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:06:43.794878Z","caller":"traceutil/trace.go:171","msg":"trace[1810268420] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2139; }","duration":"549.780295ms","start":"2026-04-20T02:06:43.245086Z","end":"2026-04-20T02:06:43.794866Z","steps":["trace[1810268420] 'agreement among raft nodes before linearized reading' (duration: 549.478218ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:43.794822Z","caller":"traceutil/trace.go:171","msg":"trace[821361898] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2139; }","duration":"537.997557ms","start":"2026-04-20T02:06:43.256801Z","end":"2026-04-20T02:06:43.794799Z","steps":["trace[821361898] 'agreement among raft nodes before linearized reading' (duration: 537.759861ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:43.795004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:43.245072Z","time spent":"549.921329ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-20T02:06:43.794697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.176247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"warn","ts":"2026-04-20T02:06:43.795041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:43.256784Z","time spent":"538.242463ms","remote":"127.0.0.1:53892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-20T02:06:43.794874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.889782ms","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:43.795105Z","caller":"traceutil/trace.go:171","msg":"trace[970807580] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2139; }","duration":"465.614686ms","start":"2026-04-20T02:06:43.32945Z","end":"2026-04-20T02:06:43.795064Z","steps":["trace[970807580] 'agreement among raft nodes before linearized reading' (duration: 465.073713ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:43.795129Z","caller":"traceutil/trace.go:171","msg":"trace[692230151] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2139; }","duration":"562.161248ms","start":"2026-04-20T02:06:43.232953Z","end":"2026-04-20T02:06:43.795114Z","steps":["trace[692230151] 'agreement among raft nodes before linearized reading' (duration: 561.774699ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:43.795173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:43.232938Z","time spent":"562.222281ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-20T02:06:43.795184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:43.32942Z","time spent":"465.728479ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":552,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"info","ts":"2026-04-20T02:06:43.794955Z","caller":"traceutil/trace.go:171","msg":"trace[1910117257] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2139; }","duration":"548.564126ms","start":"2026-04-20T02:06:43.246374Z","end":"2026-04-20T02:06:43.794938Z","steps":["trace[1910117257] 'agreement among raft nodes before linearized reading' (duration: 548.450533ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:43.795278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:43.246343Z","time spent":"548.927385ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-20T02:06:43.795546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.71875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-20T02:06:43.795617Z","caller":"traceutil/trace.go:171","msg":"trace[1592115606] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2139; }","duration":"548.819272ms","start":"2026-04-20T02:06:43.246779Z","end":"2026-04-20T02:06:43.795599Z","steps":["trace[1592115606] 'agreement among raft nodes before linearized reading' (duration: 548.460083ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:43.795661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:43.246763Z","time spent":"548.886894ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-20T02:06:43.802707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.210006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:06:43.802754Z","caller":"traceutil/trace.go:171","msg":"trace[674177099] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2139; }","duration":"146.312988ms","start":"2026-04-20T02:06:43.656431Z","end":"2026-04-20T02:06:43.802744Z","steps":["trace[674177099] 'agreement among raft nodes before linearized reading' (duration: 146.240706ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:43.802703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:43.37062Z","time spent":"432.080186ms","remote":"127.0.0.1:54330","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-20T02:06:44.009787Z","caller":"traceutil/trace.go:171","msg":"trace[2121831265] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"210.044046ms","start":"2026-04-20T02:06:43.799712Z","end":"2026-04-20T02:06:44.009756Z","steps":["trace[2121831265] 'process raft request' (duration: 205.733571ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:44.00993Z","caller":"traceutil/trace.go:171","msg":"trace[282843513] transaction","detail":"{read_only:false; response_revision:2141; number_of_response:1; }","duration":"210.21476ms","start":"2026-04-20T02:06:43.799696Z","end":"2026-04-20T02:06:44.009911Z","steps":["trace[282843513] 'process raft request' (duration: 209.974414ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:44.010478Z","caller":"traceutil/trace.go:171","msg":"trace[941384550] transaction","detail":"{read_only:false; response_revision:2142; number_of_response:1; }","duration":"210.676661ms","start":"2026-04-20T02:06:43.799778Z","end":"2026-04-20T02:06:44.010455Z","steps":["trace[941384550] 'process raft request' (duration: 210.067257ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:44.010534Z","caller":"traceutil/trace.go:171","msg":"trace[655287177] transaction","detail":"{read_only:false; response_revision:2143; number_of_response:1; }","duration":"210.698652ms","start":"2026-04-20T02:06:43.799802Z","end":"2026-04-20T02:06:44.0105Z","steps":["trace[655287177] 'process raft request' (duration: 210.321953ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:44.010595Z","caller":"traceutil/trace.go:171","msg":"trace[925742690] linearizableReadLoop","detail":"{readStateIndex:2225; appliedIndex:2219; }","duration":"207.013922ms","start":"2026-04-20T02:06:43.803564Z","end":"2026-04-20T02:06:44.010578Z","steps":["trace[925742690] 'read index received' (duration: 201.873116ms)","trace[925742690] 'applied index is now lower than readState.Index' (duration: 5.139796ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:06:44.010528Z","caller":"traceutil/trace.go:171","msg":"trace[217430408] transaction","detail":"{read_only:false; response_revision:2144; number_of_response:1; }","duration":"210.61573ms","start":"2026-04-20T02:06:43.799883Z","end":"2026-04-20T02:06:44.010498Z","steps":["trace[217430408] 'process raft request' (duration: 210.536518ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:44.010663Z","caller":"traceutil/trace.go:171","msg":"trace[1915633139] transaction","detail":"{read_only:false; response_revision:2145; number_of_response:1; }","duration":"210.003435ms","start":"2026-04-20T02:06:43.800628Z","end":"2026-04-20T02:06:44.010631Z","steps":["trace[1915633139] 'process raft request' (duration: 209.830201ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:44.010699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.104634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:06:44.010751Z","caller":"traceutil/trace.go:171","msg":"trace[312005941] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2145; }","duration":"207.195907ms","start":"2026-04-20T02:06:43.803542Z","end":"2026-04-20T02:06:44.010737Z","steps":["trace[312005941] 'agreement among raft nodes before linearized reading' (duration: 207.097305ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:44.037592Z","caller":"traceutil/trace.go:171","msg":"trace[831612522] transaction","detail":"{read_only:false; response_revision:2146; number_of_response:1; }","duration":"233.975312ms","start":"2026-04-20T02:06:43.803592Z","end":"2026-04-20T02:06:44.037567Z","steps":["trace[831612522] 'process raft request' (duration: 233.834998ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:07:39.99149Z","caller":"traceutil/trace.go:171","msg":"trace[1769184139] transaction","detail":"{read_only:false; response_revision:2610; number_of_response:1; }","duration":"297.239071ms","start":"2026-04-20T02:07:39.694161Z","end":"2026-04-20T02:07:39.9914Z","steps":["trace[1769184139] 'process raft request' (duration: 296.993125ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:07:39.992325Z","caller":"traceutil/trace.go:171","msg":"trace[779067684] transaction","detail":"{read_only:false; response_revision:2611; number_of_response:1; }","duration":"158.645165ms","start":"2026-04-20T02:07:39.833654Z","end":"2026-04-20T02:07:39.992299Z","steps":["trace[779067684] 'process raft request' (duration: 158.475601ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:08:12.557025Z","caller":"traceutil/trace.go:171","msg":"trace[1897014193] transaction","detail":"{read_only:false; response_revision:2811; number_of_response:1; }","duration":"112.571065ms","start":"2026-04-20T02:08:12.444423Z","end":"2026-04-20T02:08:12.556994Z","steps":["trace[1897014193] 'process raft request' (duration: 112.35694ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:08:12.629362Z","caller":"traceutil/trace.go:171","msg":"trace[1039699987] linearizableReadLoop","detail":"{readStateIndex:2918; appliedIndex:2916; }","duration":"184.363519ms","start":"2026-04-20T02:08:12.444966Z","end":"2026-04-20T02:08:12.62933Z","steps":["trace[1039699987] 'read index received' (duration: 111.900789ms)","trace[1039699987] 'applied index is now lower than readState.Index' (duration: 72.46132ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:08:12.629393Z","caller":"traceutil/trace.go:171","msg":"trace[1903834792] transaction","detail":"{read_only:false; response_revision:2812; number_of_response:1; }","duration":"184.858341ms","start":"2026-04-20T02:08:12.444487Z","end":"2026-04-20T02:08:12.629345Z","steps":["trace[1903834792] 'process raft request' (duration: 171.23717ms)","trace[1903834792] 'compare' (duration: 13.368165ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:08:12.629484Z","caller":"traceutil/trace.go:171","msg":"trace[307340143] transaction","detail":"{read_only:false; response_revision:2814; number_of_response:1; }","duration":"182.495824ms","start":"2026-04-20T02:08:12.446977Z","end":"2026-04-20T02:08:12.629473Z","steps":["trace[307340143] 'process raft request' (duration: 182.31417ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:08:12.629657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.655636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-20T02:08:12.629695Z","caller":"traceutil/trace.go:171","msg":"trace[1139848941] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2814; }","duration":"184.782499ms","start":"2026-04-20T02:08:12.444903Z","end":"2026-04-20T02:08:12.629686Z","steps":["trace[1139848941] 'agreement among raft nodes before linearized reading' (duration: 184.598715ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:08:12.629436Z","caller":"traceutil/trace.go:171","msg":"trace[1751128360] transaction","detail":"{read_only:false; response_revision:2813; number_of_response:1; }","duration":"183.277112ms","start":"2026-04-20T02:08:12.446137Z","end":"2026-04-20T02:08:12.629414Z","steps":["trace[1751128360] 'process raft request' (duration: 183.112488ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:08:12.629731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.365464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-04-20T02:08:12.629814Z","caller":"traceutil/trace.go:171","msg":"trace[58566691] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2814; }","duration":"141.500798ms","start":"2026-04-20T02:08:12.488291Z","end":"2026-04-20T02:08:12.629792Z","steps":["trace[58566691] 'agreement among raft nodes before linearized reading' (duration: 141.280072ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:08:12.892704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.005563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-04-20T02:08:12.892816Z","caller":"traceutil/trace.go:171","msg":"trace[1604334815] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2816; }","duration":"159.187277ms","start":"2026-04-20T02:08:12.7336Z","end":"2026-04-20T02:08:12.892788Z","steps":["trace[1604334815] 'range keys from in-memory index tree' (duration: 158.702346ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:08:18.400789Z","caller":"traceutil/trace.go:171","msg":"trace[1727923560] transaction","detail":"{read_only:false; response_revision:2844; number_of_response:1; }","duration":"210.792961ms","start":"2026-04-20T02:08:18.189966Z","end":"2026-04-20T02:08:18.400759Z","steps":["trace[1727923560] 'process raft request' (duration: 210.677638ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:08:18.400815Z","caller":"traceutil/trace.go:171","msg":"trace[201908131] transaction","detail":"{read_only:false; response_revision:2843; number_of_response:1; }","duration":"210.841042ms","start":"2026-04-20T02:08:18.189937Z","end":"2026-04-20T02:08:18.400778Z","steps":["trace[201908131] 'process raft request' (duration: 210.540435ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:08:18.400982Z","caller":"traceutil/trace.go:171","msg":"trace[875040341] transaction","detail":"{read_only:false; response_revision:2845; number_of_response:1; }","duration":"210.958095ms","start":"2026-04-20T02:08:18.189989Z","end":"2026-04-20T02:08:18.400947Z","steps":["trace[875040341] 'process raft request' (duration: 210.722319ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:11:00.434726Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890117827505237091,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T02:11:00.93581Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890117827505237091,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T02:11:01.190602Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.320140682s","expected-duration":"1s"} {"level":"info","ts":"2026-04-20T02:11:01.191126Z","caller":"traceutil/trace.go:171","msg":"trace[784569243] transaction","detail":"{read_only:false; response_revision:3903; number_of_response:1; }","duration":"1.320783367s","start":"2026-04-20T02:10:59.870314Z","end":"2026-04-20T02:11:01.191097Z","steps":["trace[784569243] 'process raft request' (duration: 1.32047544s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:11:01.191267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:10:59.870277Z","time spent":"1.32089672s","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:11:01.192349Z","caller":"traceutil/trace.go:171","msg":"trace[309736024] linearizableReadLoop","detail":"{readStateIndex:4051; appliedIndex:4049; }","duration":"1.258168632s","start":"2026-04-20T02:10:59.934157Z","end":"2026-04-20T02:11:01.192325Z","steps":["trace[309736024] 'read index received' (duration: 1.256792178s)","trace[309736024] 'applied index is now lower than readState.Index' (duration: 1.375354ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:11:01.192483Z","caller":"traceutil/trace.go:171","msg":"trace[1629815531] transaction","detail":"{read_only:false; response_revision:3906; number_of_response:1; }","duration":"230.168012ms","start":"2026-04-20T02:11:00.962298Z","end":"2026-04-20T02:11:01.192466Z","steps":["trace[1629815531] 'process raft request' (duration: 229.936606ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:11:01.192528Z","caller":"traceutil/trace.go:171","msg":"trace[277549409] transaction","detail":"{read_only:false; response_revision:3905; number_of_response:1; }","duration":"235.009919ms","start":"2026-04-20T02:11:00.957472Z","end":"2026-04-20T02:11:01.192482Z","steps":["trace[277549409] 'process raft request' (duration: 234.730233ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:11:01.192616Z","caller":"traceutil/trace.go:171","msg":"trace[1312357390] transaction","detail":"{read_only:false; response_revision:3904; number_of_response:1; }","duration":"380.971897ms","start":"2026-04-20T02:11:00.811613Z","end":"2026-04-20T02:11:01.192585Z","steps":["trace[1312357390] 'process raft request' (duration: 380.406092ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:11:01.192767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:11:00.811582Z","time spent":"381.0962ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:11:01.192784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.94424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:11:01.192822Z","caller":"traceutil/trace.go:171","msg":"trace[1942858921] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3907; }","duration":"535.019042ms","start":"2026-04-20T02:11:00.657791Z","end":"2026-04-20T02:11:01.192811Z","steps":["trace[1942858921] 'agreement among raft nodes before linearized reading' (duration: 534.93675ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:11:01.193019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:11:00.657767Z","time spent":"535.245998ms","remote":"127.0.0.1:54298","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:11:01.192753Z","caller":"traceutil/trace.go:171","msg":"trace[83359590] transaction","detail":"{read_only:false; response_revision:3907; number_of_response:1; }","duration":"227.016554ms","start":"2026-04-20T02:11:00.965672Z","end":"2026-04-20T02:11:01.192688Z","steps":["trace[83359590] 'process raft request' (duration: 226.623305ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:11:01.193034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.2184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T02:11:01.193186Z","caller":"traceutil/trace.go:171","msg":"trace[1263098588] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:3907; }","duration":"216.60086ms","start":"2026-04-20T02:11:00.976563Z","end":"2026-04-20T02:11:01.193164Z","steps":["trace[1263098588] 'agreement among raft nodes before linearized reading' (duration: 216.19097ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:11:01.19332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.259154336s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:11:01.193624Z","caller":"traceutil/trace.go:171","msg":"trace[2008567539] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3907; }","duration":"1.259396342s","start":"2026-04-20T02:10:59.934094Z","end":"2026-04-20T02:11:01.19349Z","steps":["trace[2008567539] 'agreement among raft nodes before linearized reading' (duration: 1.25850215s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:11:01.193695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:10:59.934047Z","time spent":"1.259633377s","remote":"127.0.0.1:54304","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:12:03.524923Z","caller":"traceutil/trace.go:171","msg":"trace[565193154] linearizableReadLoop","detail":"{readStateIndex:4887; appliedIndex:4886; }","duration":"114.495159ms","start":"2026-04-20T02:12:03.410388Z","end":"2026-04-20T02:12:03.524883Z","steps":["trace[565193154] 'read index received' (duration: 112.571914ms)","trace[565193154] 'applied index is now lower than readState.Index' (duration: 1.921755ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:12:03.525088Z","caller":"traceutil/trace.go:171","msg":"trace[2115747272] transaction","detail":"{read_only:false; response_revision:4709; number_of_response:1; }","duration":"114.750855ms","start":"2026-04-20T02:12:03.410281Z","end":"2026-04-20T02:12:03.525032Z","steps":["trace[2115747272] 'process raft request' (duration: 112.762288ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:12:03.525345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.906569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-04-20T02:12:03.52545Z","caller":"traceutil/trace.go:171","msg":"trace[430267419] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4709; }","duration":"115.073312ms","start":"2026-04-20T02:12:03.410355Z","end":"2026-04-20T02:12:03.525429Z","steps":["trace[430267419] 'agreement among raft nodes before linearized reading' (duration: 114.692063ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:12:03.526396Z","caller":"traceutil/trace.go:171","msg":"trace[1004232639] transaction","detail":"{read_only:false; response_revision:4710; number_of_response:1; }","duration":"105.056773ms","start":"2026-04-20T02:12:03.421323Z","end":"2026-04-20T02:12:03.52638Z","steps":["trace[1004232639] 'process raft request' (duration: 104.882159ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:12:07.726434Z","caller":"traceutil/trace.go:171","msg":"trace[296554508] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4818; }","duration":"113.588647ms","start":"2026-04-20T02:12:07.612816Z","end":"2026-04-20T02:12:07.726405Z","steps":["trace[296554508] 'process raft request' (duration: 102.356058ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:12:12.17447Z","caller":"traceutil/trace.go:171","msg":"trace[906634473] linearizableReadLoop","detail":"{readStateIndex:5183; appliedIndex:5181; }","duration":"342.917603ms","start":"2026-04-20T02:12:11.831516Z","end":"2026-04-20T02:12:12.174433Z","steps":["trace[906634473] 'read index received' (duration: 267.875817ms)","trace[906634473] 'applied index is now lower than readState.Index' (duration: 75.039926ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:12:12.174509Z","caller":"traceutil/trace.go:171","msg":"trace[272220614] transaction","detail":"{read_only:false; response_revision:4996; number_of_response:1; }","duration":"364.610301ms","start":"2026-04-20T02:12:11.809841Z","end":"2026-04-20T02:12:12.174452Z","steps":["trace[272220614] 'process raft request' (duration: 289.472773ms)","trace[272220614] 'compare' (duration: 74.833581ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:12:12.1745Z","caller":"traceutil/trace.go:171","msg":"trace[527311735] transaction","detail":"{read_only:false; response_revision:4997; number_of_response:1; }","duration":"363.093965ms","start":"2026-04-20T02:12:11.811365Z","end":"2026-04-20T02:12:12.174459Z","steps":["trace[527311735] 'process raft request' (duration: 362.956502ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:12:12.174641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.105838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-20T02:12:12.174693Z","caller":"traceutil/trace.go:171","msg":"trace[807298214] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4997; }","duration":"343.21002ms","start":"2026-04-20T02:12:11.83147Z","end":"2026-04-20T02:12:12.17468Z","steps":["trace[807298214] 'agreement among raft nodes before linearized reading' (duration: 343.042457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:12:12.17473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:12:11.831449Z","time spent":"343.270101ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-20T02:12:12.174776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:12:11.80981Z","time spent":"364.820356ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:12:12.174783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:12:11.811351Z","time spent":"363.31304ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:12:12.174886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.356313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-zhxbf\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-04-20T02:12:12.174954Z","caller":"traceutil/trace.go:171","msg":"trace[1679177741] range","detail":"{range_begin:/registry/pods/openstack/keepalived-zhxbf; range_end:; response_count:1; response_revision:4997; }","duration":"269.489565ms","start":"2026-04-20T02:12:11.905446Z","end":"2026-04-20T02:12:12.174936Z","steps":["trace[1679177741] 'agreement among raft nodes before linearized reading' (duration: 269.24547ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:12:12.174957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.149657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:12:12.175003Z","caller":"traceutil/trace.go:171","msg":"trace[381581226] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:4997; }","duration":"233.237039ms","start":"2026-04-20T02:12:11.941754Z","end":"2026-04-20T02:12:12.174991Z","steps":["trace[381581226] 'agreement among raft nodes before linearized reading' (duration: 233.170087ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:12:23.900056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.154057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-zsxjs\" ","response":"range_response_count:1 size:7818"} {"level":"info","ts":"2026-04-20T02:12:23.900158Z","caller":"traceutil/trace.go:171","msg":"trace[950688324] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-zsxjs; range_end:; response_count:1; response_revision:5228; }","duration":"136.259429ms","start":"2026-04-20T02:12:23.763871Z","end":"2026-04-20T02:12:23.90013Z","steps":["trace[950688324] 'range keys from in-memory index tree' (duration: 136.004902ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:12:23.921738Z","caller":"traceutil/trace.go:171","msg":"trace[1403121054] transaction","detail":"{read_only:false; response_revision:5229; number_of_response:1; }","duration":"156.678228ms","start":"2026-04-20T02:12:23.765031Z","end":"2026-04-20T02:12:23.921709Z","steps":["trace[1403121054] 'process raft request' (duration: 156.491934ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:12:23.937428Z","caller":"traceutil/trace.go:171","msg":"trace[717398041] transaction","detail":"{read_only:false; response_revision:5231; number_of_response:1; }","duration":"169.218229ms","start":"2026-04-20T02:12:23.768187Z","end":"2026-04-20T02:12:23.937405Z","steps":["trace[717398041] 'process raft request' (duration: 169.088856ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:12:23.937506Z","caller":"traceutil/trace.go:171","msg":"trace[1195509891] transaction","detail":"{read_only:false; response_revision:5230; number_of_response:1; }","duration":"169.336201ms","start":"2026-04-20T02:12:23.76816Z","end":"2026-04-20T02:12:23.937496Z","steps":["trace[1195509891] 'process raft request' (duration: 169.017433ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:12:25.777523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.585126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:12:25.777627Z","caller":"traceutil/trace.go:171","msg":"trace[515147765] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5257; }","duration":"123.74864ms","start":"2026-04-20T02:12:25.653855Z","end":"2026-04-20T02:12:25.777603Z","steps":["trace[515147765] 'range keys from in-memory index tree' (duration: 123.503914ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:12:25.777741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.383346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/goldpinger-p7x6d\" ","response":"range_response_count:1 size:4995"} {"level":"warn","ts":"2026-04-20T02:12:25.777751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.398466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-04-20T02:12:25.777858Z","caller":"traceutil/trace.go:171","msg":"trace[2090081782] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5257; }","duration":"132.580601ms","start":"2026-04-20T02:12:25.645253Z","end":"2026-04-20T02:12:25.777834Z","steps":["trace[2090081782] 'range keys from in-memory index tree' (duration: 132.160642ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:12:25.777871Z","caller":"traceutil/trace.go:171","msg":"trace[751542640] range","detail":"{range_begin:/registry/pods/monitoring/goldpinger-p7x6d; range_end:; response_count:1; response_revision:5257; }","duration":"132.55093ms","start":"2026-04-20T02:12:25.645266Z","end":"2026-04-20T02:12:25.777817Z","steps":["trace[751542640] 'range keys from in-memory index tree' (duration: 132.090389ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:12:25.777926Z","caller":"traceutil/trace.go:171","msg":"trace[1136343839] transaction","detail":"{read_only:false; response_revision:5258; number_of_response:1; }","duration":"109.495789ms","start":"2026-04-20T02:12:25.668399Z","end":"2026-04-20T02:12:25.777895Z","steps":["trace[1136343839] 'process raft request' (duration: 74.641825ms)","trace[1136343839] 'compare' (duration: 34.434314ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:12:25.777974Z","caller":"traceutil/trace.go:171","msg":"trace[107245306] transaction","detail":"{read_only:false; response_revision:5259; number_of_response:1; }","duration":"109.10314ms","start":"2026-04-20T02:12:25.668817Z","end":"2026-04-20T02:12:25.77792Z","steps":["trace[107245306] 'process raft request' (duration: 108.976517ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:12:25.778148Z","caller":"traceutil/trace.go:171","msg":"trace[1354695264] transaction","detail":"{read_only:false; response_revision:5260; number_of_response:1; }","duration":"108.499856ms","start":"2026-04-20T02:12:25.669607Z","end":"2026-04-20T02:12:25.778107Z","steps":["trace[1354695264] 'process raft request' (duration: 108.268391ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:12:31.143081Z","caller":"traceutil/trace.go:171","msg":"trace[668074868] transaction","detail":"{read_only:false; response_revision:5394; number_of_response:1; }","duration":"149.857394ms","start":"2026-04-20T02:12:30.99319Z","end":"2026-04-20T02:12:31.143047Z","steps":["trace[668074868] 'process raft request' (duration: 149.289971ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:12:42.975017Z","caller":"traceutil/trace.go:171","msg":"trace[1450998624] transaction","detail":"{read_only:false; response_revision:5561; number_of_response:1; }","duration":"124.9772ms","start":"2026-04-20T02:12:42.850008Z","end":"2026-04-20T02:12:42.974985Z","steps":["trace[1450998624] 'process raft request' (duration: 124.757785ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:13:40.123226Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2962} {"level":"info","ts":"2026-04-20T02:13:40.449469Z","caller":"traceutil/trace.go:171","msg":"trace[1677315966] linearizableReadLoop","detail":"{readStateIndex:6243; appliedIndex:6242; }","duration":"110.549646ms","start":"2026-04-20T02:13:40.338893Z","end":"2026-04-20T02:13:40.449443Z","steps":["trace[1677315966] 'read index received' (duration: 110.402233ms)","trace[1677315966] 'applied index is now lower than readState.Index' (duration: 146.393µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:13:40.449557Z","caller":"traceutil/trace.go:171","msg":"trace[2133824897] transaction","detail":"{read_only:false; response_revision:6027; number_of_response:1; }","duration":"175.52586ms","start":"2026-04-20T02:13:40.273985Z","end":"2026-04-20T02:13:40.449511Z","steps":["trace[2133824897] 'process raft request' (duration: 175.294164ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:13:40.449685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.776451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-20T02:13:40.44972Z","caller":"traceutil/trace.go:171","msg":"trace[376201618] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6027; }","duration":"110.879974ms","start":"2026-04-20T02:13:40.338832Z","end":"2026-04-20T02:13:40.449712Z","steps":["trace[376201618] 'agreement among raft nodes before linearized reading' (duration: 110.72844ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:13:40.558962Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2962,"took":"433.402257ms","hash":314365380,"current-db-size-bytes":57868288,"current-db-size":"58 MB","current-db-size-in-use-bytes":33243136,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-20T02:13:40.55904Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":314365380,"revision":2962,"compact-revision":-1} {"level":"info","ts":"2026-04-20T02:13:40.559378Z","caller":"traceutil/trace.go:171","msg":"trace[782309467] linearizableReadLoop","detail":"{readStateIndex:6244; appliedIndex:6243; }","duration":"109.823589ms","start":"2026-04-20T02:13:40.44953Z","end":"2026-04-20T02:13:40.559354Z","steps":["trace[782309467] 'read index received' (duration: 22.850448ms)","trace[782309467] 'applied index is now lower than readState.Index' (duration: 86.971951ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:13:40.559451Z","caller":"traceutil/trace.go:171","msg":"trace[220587775] transaction","detail":"{read_only:false; response_revision:6028; number_of_response:1; }","duration":"202.142522ms","start":"2026-04-20T02:13:40.357272Z","end":"2026-04-20T02:13:40.559414Z","steps":["trace[220587775] 'process raft request' (duration: 115.09361ms)","trace[220587775] 'compare' (duration: 86.681383ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:13:40.671759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.79936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-04-20T02:13:40.671853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.404373ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T02:13:40.671887Z","caller":"traceutil/trace.go:171","msg":"trace[1595811216] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6028; }","duration":"322.974045ms","start":"2026-04-20T02:13:40.348884Z","end":"2026-04-20T02:13:40.671858Z","steps":["trace[1595811216] 'agreement among raft nodes before linearized reading' (duration: 210.590222ms)","trace[1595811216] 'range keys from in-memory index tree' (duration: 112.108435ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:13:40.671945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:13:40.34887Z","time spent":"323.063667ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-20T02:13:40.671944Z","caller":"traceutil/trace.go:171","msg":"trace[678695337] linearizableReadLoop","detail":"{readStateIndex:6245; appliedIndex:6244; }","duration":"112.503626ms","start":"2026-04-20T02:13:40.559427Z","end":"2026-04-20T02:13:40.671931Z","steps":["trace[678695337] 'read index received' (duration: 65.022µs)","trace[678695337] 'applied index is now lower than readState.Index' (duration: 112.437424ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:13:40.672082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.892372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T02:13:40.672064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.474212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T02:13:40.672167Z","caller":"traceutil/trace.go:171","msg":"trace[186649810] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:6029; }","duration":"161.622916ms","start":"2026-04-20T02:13:40.510522Z","end":"2026-04-20T02:13:40.672145Z","steps":["trace[186649810] 'agreement among raft nodes before linearized reading' (duration: 161.428581ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:13:40.672357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.22677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:13:40.672401Z","caller":"traceutil/trace.go:171","msg":"trace[2023565558] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:6029; }","duration":"164.310693ms","start":"2026-04-20T02:13:40.508079Z","end":"2026-04-20T02:13:40.67239Z","steps":["trace[2023565558] 'agreement among raft nodes before linearized reading' (duration: 164.244301ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:13:40.672417Z","caller":"traceutil/trace.go:171","msg":"trace[1043712700] transaction","detail":"{read_only:false; response_revision:6029; number_of_response:1; }","duration":"218.772575ms","start":"2026-04-20T02:13:40.453632Z","end":"2026-04-20T02:13:40.672404Z","steps":["trace[1043712700] 'process raft request' (duration: 105.713585ms)","trace[1043712700] 'compare' (duration: 112.263979ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:13:40.672109Z","caller":"traceutil/trace.go:171","msg":"trace[659804762] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:6029; }","duration":"163.947633ms","start":"2026-04-20T02:13:40.508152Z","end":"2026-04-20T02:13:40.6721Z","steps":["trace[659804762] 'agreement among raft nodes before linearized reading' (duration: 163.866811ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:13:40.810913Z","caller":"traceutil/trace.go:171","msg":"trace[274824966] transaction","detail":"{read_only:false; response_revision:6031; number_of_response:1; }","duration":"133.434284ms","start":"2026-04-20T02:13:40.677442Z","end":"2026-04-20T02:13:40.810877Z","steps":["trace[274824966] 'process raft request' (duration: 128.718707ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:13:40.811288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.803799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-20T02:13:40.811416Z","caller":"traceutil/trace.go:171","msg":"trace[1492926538] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6032; }","duration":"130.977163ms","start":"2026-04-20T02:13:40.680419Z","end":"2026-04-20T02:13:40.811396Z","steps":["trace[1492926538] 'agreement among raft nodes before linearized reading' (duration: 130.660945ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:13:40.811437Z","caller":"traceutil/trace.go:171","msg":"trace[246935222] transaction","detail":"{read_only:false; response_revision:6032; number_of_response:1; }","duration":"132.129612ms","start":"2026-04-20T02:13:40.679031Z","end":"2026-04-20T02:13:40.811161Z","steps":["trace[246935222] 'process raft request' (duration: 131.790064ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:17:24.956272Z","caller":"traceutil/trace.go:171","msg":"trace[241051219] transaction","detail":"{read_only:false; response_revision:7611; number_of_response:1; }","duration":"104.071632ms","start":"2026-04-20T02:17:24.852165Z","end":"2026-04-20T02:17:24.956236Z","steps":["trace[241051219] 'process raft request' (duration: 53.671675ms)","trace[241051219] 'compare' (duration: 50.042329ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:17:26.630731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.515955ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T02:17:26.630936Z","caller":"traceutil/trace.go:171","msg":"trace[497376047] linearizableReadLoop","detail":"{readStateIndex:7890; appliedIndex:7889; }","duration":"491.987169ms","start":"2026-04-20T02:17:26.13893Z","end":"2026-04-20T02:17:26.630918Z","steps":["trace[497376047] 'read index received' (duration: 248.184266ms)","trace[497376047] 'applied index is now lower than readState.Index' (duration: 243.801573ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:17:26.631Z","caller":"traceutil/trace.go:171","msg":"trace[107840785] transaction","detail":"{read_only:false; response_revision:7623; number_of_response:1; }","duration":"519.002791ms","start":"2026-04-20T02:17:26.111973Z","end":"2026-04-20T02:17:26.630976Z","steps":["trace[107840785] 'process raft request' (duration: 275.151548ms)","trace[107840785] 'compare' (duration: 243.392752ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:17:26.631062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.112262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T02:17:26.631092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:17:26.111951Z","time spent":"519.097034ms","remote":"127.0.0.1:54478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8186,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:17:26.631154Z","caller":"traceutil/trace.go:171","msg":"trace[62762836] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:7623; }","duration":"492.254335ms","start":"2026-04-20T02:17:26.138879Z","end":"2026-04-20T02:17:26.631134Z","steps":["trace[62762836] 'agreement among raft nodes before linearized reading' (duration: 492.099821ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:17:26.631198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:17:26.138858Z","time spent":"492.329857ms","remote":"127.0.0.1:53700","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true "} {"level":"warn","ts":"2026-04-20T02:17:26.631468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.695754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-04-20T02:17:26.631574Z","caller":"traceutil/trace.go:171","msg":"trace[369464178] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:7623; }","duration":"364.878719ms","start":"2026-04-20T02:17:26.266678Z","end":"2026-04-20T02:17:26.631557Z","steps":["trace[369464178] 'agreement among raft nodes before linearized reading' (duration: 364.414488ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:17:26.631618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:17:26.266655Z","time spent":"364.95169ms","remote":"127.0.0.1:54478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-04-20T02:17:28.190528Z","caller":"traceutil/trace.go:171","msg":"trace[1035258161] linearizableReadLoop","detail":"{readStateIndex:7897; appliedIndex:7895; }","duration":"181.326907ms","start":"2026-04-20T02:17:28.009178Z","end":"2026-04-20T02:17:28.190505Z","steps":["trace[1035258161] 'read index received' (duration: 31.102668ms)","trace[1035258161] 'applied index is now lower than readState.Index' (duration: 150.221689ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:17:28.190575Z","caller":"traceutil/trace.go:171","msg":"trace[261297732] transaction","detail":"{read_only:false; response_revision:7630; number_of_response:1; }","duration":"186.345737ms","start":"2026-04-20T02:17:28.004206Z","end":"2026-04-20T02:17:28.190552Z","steps":["trace[261297732] 'process raft request' (duration: 121.041976ms)","trace[261297732] 'compare' (duration: 64.904052ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:17:28.190688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.130129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:17:28.190719Z","caller":"traceutil/trace.go:171","msg":"trace[1630503601] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:7631; }","duration":"172.218351ms","start":"2026-04-20T02:17:28.018491Z","end":"2026-04-20T02:17:28.190709Z","steps":["trace[1630503601] 'agreement among raft nodes before linearized reading' (duration: 172.140759ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:17:28.190764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.565413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-20T02:17:28.190868Z","caller":"traceutil/trace.go:171","msg":"trace[1634842585] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7631; }","duration":"181.694766ms","start":"2026-04-20T02:17:28.00915Z","end":"2026-04-20T02:17:28.190845Z","steps":["trace[1634842585] 'agreement among raft nodes before linearized reading' (duration: 181.44889ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:17:28.19091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.380489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-zhxbf\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-04-20T02:17:28.190932Z","caller":"traceutil/trace.go:171","msg":"trace[405664564] range","detail":"{range_begin:/registry/pods/openstack/keepalived-zhxbf; range_end:; response_count:1; response_revision:7631; }","duration":"104.435091ms","start":"2026-04-20T02:17:28.086491Z","end":"2026-04-20T02:17:28.190926Z","steps":["trace[405664564] 'agreement among raft nodes before linearized reading' (duration: 104.330048ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:17:28.358231Z","caller":"traceutil/trace.go:171","msg":"trace[298115973] linearizableReadLoop","detail":"{readStateIndex:7901; appliedIndex:7898; }","duration":"163.078425ms","start":"2026-04-20T02:17:28.195136Z","end":"2026-04-20T02:17:28.358214Z","steps":["trace[298115973] 'read index received' (duration: 47.658073ms)","trace[298115973] 'applied index is now lower than readState.Index' (duration: 115.419472ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:17:28.358271Z","caller":"traceutil/trace.go:171","msg":"trace[883461671] transaction","detail":"{read_only:false; response_revision:7634; number_of_response:1; }","duration":"163.253818ms","start":"2026-04-20T02:17:28.194984Z","end":"2026-04-20T02:17:28.358238Z","steps":["trace[883461671] 'process raft request' (duration: 163.150686ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:17:28.358332Z","caller":"traceutil/trace.go:171","msg":"trace[1770332137] transaction","detail":"{read_only:false; response_revision:7635; number_of_response:1; }","duration":"153.187289ms","start":"2026-04-20T02:17:28.205121Z","end":"2026-04-20T02:17:28.358308Z","steps":["trace[1770332137] 'process raft request' (duration: 153.047295ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:17:28.358269Z","caller":"traceutil/trace.go:171","msg":"trace[21314483] transaction","detail":"{read_only:false; response_revision:7633; number_of_response:1; }","duration":"163.278249ms","start":"2026-04-20T02:17:28.194962Z","end":"2026-04-20T02:17:28.358241Z","steps":["trace[21314483] 'process raft request' (duration: 126.016704ms)","trace[21314483] 'compare' (duration: 37.03827ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:17:28.358545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.385722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:23 size:199404"} {"level":"info","ts":"2026-04-20T02:17:28.358879Z","caller":"traceutil/trace.go:171","msg":"trace[780187295] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:23; response_revision:7635; }","duration":"163.672178ms","start":"2026-04-20T02:17:28.19511Z","end":"2026-04-20T02:17:28.358782Z","steps":["trace[780187295] 'agreement among raft nodes before linearized reading' (duration: 163.179386ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:17:29.490467Z","caller":"traceutil/trace.go:171","msg":"trace[366644798] transaction","detail":"{read_only:false; response_revision:7643; number_of_response:1; }","duration":"122.05371ms","start":"2026-04-20T02:17:29.368376Z","end":"2026-04-20T02:17:29.490429Z","steps":["trace[366644798] 'process raft request' (duration: 121.761883ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:17:32.996896Z","caller":"traceutil/trace.go:171","msg":"trace[889635033] transaction","detail":"{read_only:false; response_revision:7661; number_of_response:1; }","duration":"115.463542ms","start":"2026-04-20T02:17:32.881409Z","end":"2026-04-20T02:17:32.996872Z","steps":["trace[889635033] 'process raft request' (duration: 115.319719ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:17:34.062487Z","caller":"traceutil/trace.go:171","msg":"trace[1477453422] transaction","detail":"{read_only:false; response_revision:7667; number_of_response:1; }","duration":"100.803995ms","start":"2026-04-20T02:17:33.961651Z","end":"2026-04-20T02:17:34.062455Z","steps":["trace[1477453422] 'process raft request' (duration: 100.538798ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:17:39.225947Z","caller":"traceutil/trace.go:171","msg":"trace[1131117219] transaction","detail":"{read_only:false; response_revision:7690; number_of_response:1; }","duration":"202.249346ms","start":"2026-04-20T02:17:39.023673Z","end":"2026-04-20T02:17:39.225922Z","steps":["trace[1131117219] 'process raft request' (duration: 202.064362ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:17:39.37316Z","caller":"traceutil/trace.go:171","msg":"trace[2043615862] transaction","detail":"{read_only:false; response_revision:7692; number_of_response:1; }","duration":"161.370483ms","start":"2026-04-20T02:17:39.211765Z","end":"2026-04-20T02:17:39.373135Z","steps":["trace[2043615862] 'process raft request' (duration: 161.288871ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:17:39.373301Z","caller":"traceutil/trace.go:171","msg":"trace[849786061] linearizableReadLoop","detail":"{readStateIndex:7963; appliedIndex:7960; }","duration":"106.571751ms","start":"2026-04-20T02:17:39.266702Z","end":"2026-04-20T02:17:39.373273Z","steps":["trace[849786061] 'read index received' (duration: 9.321941ms)","trace[849786061] 'applied index is now lower than readState.Index' (duration: 97.24854ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:17:39.373488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.705165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:17:39.373497Z","caller":"traceutil/trace.go:171","msg":"trace[815269614] transaction","detail":"{read_only:false; response_revision:7693; number_of_response:1; }","duration":"119.769595ms","start":"2026-04-20T02:17:39.253712Z","end":"2026-04-20T02:17:39.373482Z","steps":["trace[815269614] 'process raft request' (duration: 119.390586ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:17:39.373574Z","caller":"traceutil/trace.go:171","msg":"trace[912265835] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:7693; }","duration":"106.873868ms","start":"2026-04-20T02:17:39.266654Z","end":"2026-04-20T02:17:39.373528Z","steps":["trace[912265835] 'agreement among raft nodes before linearized reading' (duration: 106.712435ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:17:39.373566Z","caller":"traceutil/trace.go:171","msg":"trace[1318012400] transaction","detail":"{read_only:false; response_revision:7691; number_of_response:1; }","duration":"167.879689ms","start":"2026-04-20T02:17:39.205238Z","end":"2026-04-20T02:17:39.373118Z","steps":["trace[1318012400] 'process raft request' (duration: 70.803612ms)","trace[1318012400] 'compare' (duration: 96.880102ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:18:40.13144Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6024} {"level":"info","ts":"2026-04-20T02:18:40.24676Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6024,"took":"113.491999ms","hash":2093898712,"current-db-size-bytes":57868288,"current-db-size":"58 MB","current-db-size-in-use-bytes":21590016,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-20T02:18:40.246836Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2093898712,"revision":6024,"compact-revision":2962} {"level":"info","ts":"2026-04-20T02:18:48.746403Z","caller":"traceutil/trace.go:171","msg":"trace[1184187235] transaction","detail":"{read_only:false; response_revision:8290; number_of_response:1; }","duration":"257.637453ms","start":"2026-04-20T02:18:48.488746Z","end":"2026-04-20T02:18:48.746384Z","steps":["trace[1184187235] 'process raft request' (duration: 257.50297ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:18:48.766756Z","caller":"traceutil/trace.go:171","msg":"trace[1406884182] linearizableReadLoop","detail":"{readStateIndex:8580; appliedIndex:8578; }","duration":"217.504545ms","start":"2026-04-20T02:18:48.549226Z","end":"2026-04-20T02:18:48.76673Z","steps":["trace[1406884182] 'read index received' (duration: 197.099393ms)","trace[1406884182] 'applied index is now lower than readState.Index' (duration: 20.403712ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:18:48.76711Z","caller":"traceutil/trace.go:171","msg":"trace[891957297] transaction","detail":"{read_only:false; response_revision:8291; number_of_response:1; }","duration":"265.254653ms","start":"2026-04-20T02:18:48.501838Z","end":"2026-04-20T02:18:48.767093Z","steps":["trace[891957297] 'process raft request' (duration: 264.73832ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:18:48.76752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.158152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:18:48.767565Z","caller":"traceutil/trace.go:171","msg":"trace[1588637078] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:8291; }","duration":"218.371997ms","start":"2026-04-20T02:18:48.549179Z","end":"2026-04-20T02:18:48.767551Z","steps":["trace[1588637078] 'agreement among raft nodes before linearized reading' (duration: 218.117261ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:18:48.767894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.912059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-20T02:18:48.76798Z","caller":"traceutil/trace.go:171","msg":"trace[744528500] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8291; }","duration":"158.183996ms","start":"2026-04-20T02:18:48.609778Z","end":"2026-04-20T02:18:48.767962Z","steps":["trace[744528500] 'agreement among raft nodes before linearized reading' (duration: 157.774146ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:18:48.76819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.271948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:18:48.768235Z","caller":"traceutil/trace.go:171","msg":"trace[1300803717] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8291; }","duration":"111.35973ms","start":"2026-04-20T02:18:48.656865Z","end":"2026-04-20T02:18:48.768225Z","steps":["trace[1300803717] 'agreement among raft nodes before linearized reading' (duration: 111.290508ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:18:49.02277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.01048ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T02:18:49.022896Z","caller":"traceutil/trace.go:171","msg":"trace[1053659375] transaction","detail":"{read_only:false; response_revision:8292; number_of_response:1; }","duration":"250.695019ms","start":"2026-04-20T02:18:48.772179Z","end":"2026-04-20T02:18:49.022874Z","steps":["trace[1053659375] 'process raft request' (duration: 48.479825ms)","trace[1053659375] 'compare' (duration: 201.863976ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:18:49.02433Z","caller":"traceutil/trace.go:171","msg":"trace[1524404790] linearizableReadLoop","detail":"{readStateIndex:8582; appliedIndex:8580; }","duration":"250.195788ms","start":"2026-04-20T02:18:48.77411Z","end":"2026-04-20T02:18:49.024306Z","steps":["trace[1524404790] 'read index received' (duration: 46.632792ms)","trace[1524404790] 'applied index is now lower than readState.Index' (duration: 203.562106ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:18:49.024713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.494026ms","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:18:49.024805Z","caller":"traceutil/trace.go:171","msg":"trace[1351656000] transaction","detail":"{read_only:false; response_revision:8293; number_of_response:1; }","duration":"252.559904ms","start":"2026-04-20T02:18:48.772233Z","end":"2026-04-20T02:18:49.024793Z","steps":["trace[1351656000] 'process raft request' (duration: 251.934118ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:18:49.02481Z","caller":"traceutil/trace.go:171","msg":"trace[494541305] 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:8293; }","duration":"198.61256ms","start":"2026-04-20T02:18:48.826176Z","end":"2026-04-20T02:18:49.024789Z","steps":["trace[494541305] 'agreement among raft nodes before linearized reading' (duration: 198.456775ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:18:49.024753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.622558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-04-20T02:18:49.024997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.902917ms","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:18:49.025039Z","caller":"traceutil/trace.go:171","msg":"trace[1805354562] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8293; }","duration":"148.979699ms","start":"2026-04-20T02:18:48.876049Z","end":"2026-04-20T02:18:49.025029Z","steps":["trace[1805354562] 'agreement among raft nodes before linearized reading' (duration: 148.879046ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:18:49.025036Z","caller":"traceutil/trace.go:171","msg":"trace[464625501] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8293; }","duration":"250.941435ms","start":"2026-04-20T02:18:48.774083Z","end":"2026-04-20T02:18:49.025024Z","steps":["trace[464625501] 'agreement among raft nodes before linearized reading' (duration: 250.546585ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:18:49.025087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.331338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-zhxbf\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-04-20T02:18:49.025151Z","caller":"traceutil/trace.go:171","msg":"trace[1840686694] range","detail":"{range_begin:/registry/pods/openstack/keepalived-zhxbf; range_end:; response_count:1; response_revision:8293; }","duration":"122.419621ms","start":"2026-04-20T02:18:48.902715Z","end":"2026-04-20T02:18:49.025134Z","steps":["trace[1840686694] 'agreement among raft nodes before linearized reading' (duration: 122.236027ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:19:01.281613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.23943ms","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:19:01.281687Z","caller":"traceutil/trace.go:171","msg":"trace[1547287452] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8353; }","duration":"206.341673ms","start":"2026-04-20T02:19:01.075331Z","end":"2026-04-20T02:19:01.281673Z","steps":["trace[1547287452] 'range keys from in-memory index tree' (duration: 206.072956ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:19:01.281804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.338418ms","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:19:01.2819Z","caller":"traceutil/trace.go:171","msg":"trace[1211258348] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8353; }","duration":"205.460861ms","start":"2026-04-20T02:19:01.076424Z","end":"2026-04-20T02:19:01.281885Z","steps":["trace[1211258348] 'range keys from in-memory index tree' (duration: 205.224405ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:19:01.282215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.977039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-20T02:19:01.282272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.842357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-zhxbf\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-04-20T02:19:01.282303Z","caller":"traceutil/trace.go:171","msg":"trace[1852908202] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8353; }","duration":"199.094311ms","start":"2026-04-20T02:19:01.083191Z","end":"2026-04-20T02:19:01.282285Z","steps":["trace[1852908202] 'range keys from in-memory index tree' (duration: 198.820154ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:19:01.282333Z","caller":"traceutil/trace.go:171","msg":"trace[1522180225] range","detail":"{range_begin:/registry/pods/openstack/keepalived-zhxbf; range_end:; response_count:1; response_revision:8353; }","duration":"179.952749ms","start":"2026-04-20T02:19:01.10237Z","end":"2026-04-20T02:19:01.282323Z","steps":["trace[1522180225] 'range keys from in-memory index tree' (duration: 179.652422ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:19:01.282355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.505739ms","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:19:01.282357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.660322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-58686d47f4-sl8b4.18a7ef252f45210e\" ","response":"range_response_count:1 size:1135"} {"level":"info","ts":"2026-04-20T02:19:01.282397Z","caller":"traceutil/trace.go:171","msg":"trace[2065807274] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8353; }","duration":"207.581791ms","start":"2026-04-20T02:19:01.074805Z","end":"2026-04-20T02:19:01.282387Z","steps":["trace[2065807274] 'range keys from in-memory index tree' (duration: 207.367346ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:19:01.28241Z","caller":"traceutil/trace.go:171","msg":"trace[1725990730] range","detail":"{range_begin:/registry/events/openstack/barbican-api-58686d47f4-sl8b4.18a7ef252f45210e; range_end:; response_count:1; response_revision:8353; }","duration":"273.747535ms","start":"2026-04-20T02:19:01.00865Z","end":"2026-04-20T02:19:01.282397Z","steps":["trace[1725990730] 'range keys from in-memory index tree' (duration: 273.480138ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:19:01.282247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.854953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:19:01.282613Z","caller":"traceutil/trace.go:171","msg":"trace[1794517932] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:8353; }","duration":"190.215481ms","start":"2026-04-20T02:19:01.092377Z","end":"2026-04-20T02:19:01.282592Z","steps":["trace[1794517932] 'count revisions from in-memory index tree' (duration: 189.762951ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:19:02.333647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.07426ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T02:19:02.334033Z","caller":"traceutil/trace.go:171","msg":"trace[1347728217] transaction","detail":"{read_only:false; response_revision:8363; number_of_response:1; }","duration":"389.418795ms","start":"2026-04-20T02:19:01.944563Z","end":"2026-04-20T02:19:02.333982Z","steps":["trace[1347728217] 'process raft request' (duration: 70.883564ms)","trace[1347728217] 'compare' (duration: 317.936047ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:19:02.334229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:19:01.944537Z","time spent":"389.5915ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:19:03.38854Z","caller":"traceutil/trace.go:171","msg":"trace[1162621574] transaction","detail":"{read_only:false; response_revision:8365; number_of_response:1; }","duration":"123.007355ms","start":"2026-04-20T02:19:03.265496Z","end":"2026-04-20T02:19:03.388503Z","steps":["trace[1162621574] 'process raft request' (duration: 82.022887ms)","trace[1162621574] 'compare' (duration: 40.64249ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:19:03.719547Z","caller":"traceutil/trace.go:171","msg":"trace[1090513556] transaction","detail":"{read_only:false; response_revision:8371; number_of_response:1; }","duration":"151.1944ms","start":"2026-04-20T02:19:03.568319Z","end":"2026-04-20T02:19:03.719514Z","steps":["trace[1090513556] 'process raft request' (duration: 151.017286ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:19:27.249543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.743898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-hc477\" ","response":"range_response_count:1 size:4455"} {"level":"info","ts":"2026-04-20T02:19:27.249635Z","caller":"traceutil/trace.go:171","msg":"trace[811048189] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-hc477; range_end:; response_count:1; response_revision:8546; }","duration":"101.878182ms","start":"2026-04-20T02:19:27.147737Z","end":"2026-04-20T02:19:27.249616Z","steps":["trace[811048189] 'range keys from in-memory index tree' (duration: 101.579884ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:19:29.8373Z","caller":"traceutil/trace.go:171","msg":"trace[1074640629] transaction","detail":"{read_only:false; response_revision:8560; number_of_response:1; }","duration":"306.570004ms","start":"2026-04-20T02:19:29.530688Z","end":"2026-04-20T02:19:29.837258Z","steps":["trace[1074640629] 'process raft request' (duration: 306.276907ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:19:29.837485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:19:29.530673Z","time spent":"306.713798ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:19:29.837511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.381252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-20T02:19:29.83758Z","caller":"traceutil/trace.go:171","msg":"trace[109358451] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8560; }","duration":"304.504726ms","start":"2026-04-20T02:19:29.533063Z","end":"2026-04-20T02:19:29.837567Z","steps":["trace[109358451] 'agreement among raft nodes before linearized reading' (duration: 304.27372ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:19:29.837617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:19:29.533055Z","time spent":"304.553236ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-20T02:19:29.837293Z","caller":"traceutil/trace.go:171","msg":"trace[1854426526] linearizableReadLoop","detail":"{readStateIndex:8859; appliedIndex:8858; }","duration":"304.130356ms","start":"2026-04-20T02:19:29.533084Z","end":"2026-04-20T02:19:29.837214Z","steps":["trace[1854426526] 'read index received' (duration: 303.88081ms)","trace[1854426526] 'applied index is now lower than readState.Index' (duration: 238.306µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:19:30.1028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.440808ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T02:19:30.103218Z","caller":"traceutil/trace.go:171","msg":"trace[1454407762] linearizableReadLoop","detail":"{readStateIndex:8860; appliedIndex:8859; }","duration":"265.178718ms","start":"2026-04-20T02:19:29.838015Z","end":"2026-04-20T02:19:30.103193Z","steps":["trace[1454407762] 'read index received' (duration: 161.232828ms)","trace[1454407762] 'applied index is now lower than readState.Index' (duration: 103.94377ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:19:30.103505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.978767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-zhxbf\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-04-20T02:19:30.103545Z","caller":"traceutil/trace.go:171","msg":"trace[1643787202] transaction","detail":"{read_only:false; response_revision:8561; number_of_response:1; }","duration":"298.548324ms","start":"2026-04-20T02:19:29.804967Z","end":"2026-04-20T02:19:30.103516Z","steps":["trace[1643787202] 'process raft request' (duration: 194.279046ms)","trace[1643787202] 'compare' (duration: 103.08006ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:19:30.103573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.170077ms","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:19:30.103584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.931349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-20T02:19:30.10365Z","caller":"traceutil/trace.go:171","msg":"trace[739147948] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8561; }","duration":"568.29433ms","start":"2026-04-20T02:19:29.535338Z","end":"2026-04-20T02:19:30.103632Z","steps":["trace[739147948] 'agreement among raft nodes before linearized reading' (duration: 568.038694ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:19:30.103492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.875402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"warn","ts":"2026-04-20T02:19:30.103718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:19:29.535298Z","time spent":"568.411003ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-20T02:19:30.103716Z","caller":"traceutil/trace.go:171","msg":"trace[323944815] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:8561; }","duration":"514.131708ms","start":"2026-04-20T02:19:29.589567Z","end":"2026-04-20T02:19:30.103699Z","steps":["trace[323944815] 'agreement among raft nodes before linearized reading' (duration: 513.79486ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:19:30.103724Z","caller":"traceutil/trace.go:171","msg":"trace[2036194011] range","detail":"{range_begin:/registry/pods/openstack/keepalived-zhxbf; range_end:; response_count:1; response_revision:8561; }","duration":"538.120911ms","start":"2026-04-20T02:19:29.565485Z","end":"2026-04-20T02:19:30.103606Z","steps":["trace[2036194011] 'agreement among raft nodes before linearized reading' (duration: 537.884875ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:19:30.103858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:19:29.565473Z","time spent":"538.371896ms","remote":"127.0.0.1:54478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6553,"request content":"key:\"/registry/pods/openstack/keepalived-zhxbf\" "} {"level":"warn","ts":"2026-04-20T02:19:30.103792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:19:29.589555Z","time spent":"514.22589ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":552,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-04-20T02:19:30.103569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.542515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:19:30.103995Z","caller":"traceutil/trace.go:171","msg":"trace[1620281359] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8561; }","duration":"446.983556ms","start":"2026-04-20T02:19:29.657001Z","end":"2026-04-20T02:19:30.103984Z","steps":["trace[1620281359] 'agreement among raft nodes before linearized reading' (duration: 446.541505ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:19:30.104033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:19:29.656989Z","time spent":"447.035557ms","remote":"127.0.0.1:54304","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:19:30.103659Z","caller":"traceutil/trace.go:171","msg":"trace[1262139552] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8561; }","duration":"570.038732ms","start":"2026-04-20T02:19:29.533604Z","end":"2026-04-20T02:19:30.103642Z","steps":["trace[1262139552] 'agreement among raft nodes before linearized reading' (duration: 569.792116ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:19:30.104103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:19:29.533597Z","time spent":"570.480352ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-20T02:19:30.108034Z","caller":"traceutil/trace.go:171","msg":"trace[144205226] transaction","detail":"{read_only:false; response_revision:8565; number_of_response:1; }","duration":"126.491388ms","start":"2026-04-20T02:19:29.981519Z","end":"2026-04-20T02:19:30.10801Z","steps":["trace[144205226] 'process raft request' (duration: 126.372485ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:19:30.108176Z","caller":"traceutil/trace.go:171","msg":"trace[952847070] transaction","detail":"{read_only:false; response_revision:8562; number_of_response:1; }","duration":"267.210926ms","start":"2026-04-20T02:19:29.840954Z","end":"2026-04-20T02:19:30.108165Z","steps":["trace[952847070] 'process raft request' (duration: 266.760715ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:19:30.108266Z","caller":"traceutil/trace.go:171","msg":"trace[987909471] transaction","detail":"{read_only:false; response_revision:8563; number_of_response:1; }","duration":"175.046197ms","start":"2026-04-20T02:19:29.933209Z","end":"2026-04-20T02:19:30.108255Z","steps":["trace[987909471] 'process raft request' (duration: 174.611467ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:19:30.108378Z","caller":"traceutil/trace.go:171","msg":"trace[127782457] transaction","detail":"{read_only:false; response_revision:8564; number_of_response:1; }","duration":"128.606199ms","start":"2026-04-20T02:19:29.979743Z","end":"2026-04-20T02:19:30.10835Z","steps":["trace[127782457] 'process raft request' (duration: 128.113598ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:19:30.108463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.078026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:19:30.108534Z","caller":"traceutil/trace.go:171","msg":"trace[1020743376] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:8565; }","duration":"149.21047ms","start":"2026-04-20T02:19:29.959308Z","end":"2026-04-20T02:19:30.108518Z","steps":["trace[1020743376] 'agreement among raft nodes before linearized reading' (duration: 149.114148ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:19:33.935821Z","caller":"traceutil/trace.go:171","msg":"trace[1604295315] transaction","detail":"{read_only:false; response_revision:8582; number_of_response:1; }","duration":"121.262233ms","start":"2026-04-20T02:19:33.814535Z","end":"2026-04-20T02:19:33.935797Z","steps":["trace[1604295315] 'process raft request' (duration: 121.10307ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:19:43.347709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.351789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.222\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-20T02:19:43.34783Z","caller":"traceutil/trace.go:171","msg":"trace[124439450] range","detail":"{range_begin:/registry/masterleases/199.204.45.222; range_end:; response_count:1; response_revision:8673; }","duration":"114.524493ms","start":"2026-04-20T02:19:43.233278Z","end":"2026-04-20T02:19:43.347802Z","steps":["trace[124439450] 'range keys from in-memory index tree' (duration: 114.113914ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:19:43.641107Z","caller":"traceutil/trace.go:171","msg":"trace[1862583754] linearizableReadLoop","detail":"{readStateIndex:8981; appliedIndex:8979; }","duration":"183.792406ms","start":"2026-04-20T02:19:43.457286Z","end":"2026-04-20T02:19:43.641078Z","steps":["trace[1862583754] 'read index received' (duration: 45.094016ms)","trace[1862583754] 'applied index is now lower than readState.Index' (duration: 138.69726ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:19:43.641217Z","caller":"traceutil/trace.go:171","msg":"trace[1040549631] transaction","detail":"{read_only:false; response_revision:8675; number_of_response:1; }","duration":"284.557731ms","start":"2026-04-20T02:19:43.356615Z","end":"2026-04-20T02:19:43.641173Z","steps":["trace[1040549631] 'process raft request' (duration: 284.308995ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:19:43.64172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.420701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-04-20T02:19:43.641778Z","caller":"traceutil/trace.go:171","msg":"trace[1054493406] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:8675; }","duration":"184.520383ms","start":"2026-04-20T02:19:43.457241Z","end":"2026-04-20T02:19:43.641761Z","steps":["trace[1054493406] 'agreement among raft nodes before linearized reading' (duration: 183.97406ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:19:43.766375Z","caller":"traceutil/trace.go:171","msg":"trace[1845663408] linearizableReadLoop","detail":"{readStateIndex:8983; appliedIndex:8982; }","duration":"102.627128ms","start":"2026-04-20T02:19:43.663724Z","end":"2026-04-20T02:19:43.766351Z","steps":["trace[1845663408] 'read index received' (duration: 102.553717ms)","trace[1845663408] 'applied index is now lower than readState.Index' (duration: 72.341µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:19:43.766944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.193132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-04-20T02:19:43.767054Z","caller":"traceutil/trace.go:171","msg":"trace[1100370691] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:8677; }","duration":"103.350606ms","start":"2026-04-20T02:19:43.663682Z","end":"2026-04-20T02:19:43.767033Z","steps":["trace[1100370691] 'agreement among raft nodes before linearized reading' (duration: 102.772552ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:19:43.767346Z","caller":"traceutil/trace.go:171","msg":"trace[795420431] transaction","detail":"{read_only:false; response_revision:8677; number_of_response:1; }","duration":"120.30551ms","start":"2026-04-20T02:19:43.646092Z","end":"2026-04-20T02:19:43.766397Z","steps":["trace[795420431] 'process raft request' (duration: 120.114816ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:19:44.203871Z","caller":"traceutil/trace.go:171","msg":"trace[1826661266] transaction","detail":"{read_only:false; response_revision:8681; number_of_response:1; }","duration":"116.553761ms","start":"2026-04-20T02:19:44.087281Z","end":"2026-04-20T02:19:44.203835Z","steps":["trace[1826661266] 'process raft request' (duration: 116.313656ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:19:44.354455Z","caller":"traceutil/trace.go:171","msg":"trace[501603010] transaction","detail":"{read_only:false; response_revision:8682; number_of_response:1; }","duration":"186.960221ms","start":"2026-04-20T02:19:44.167476Z","end":"2026-04-20T02:19:44.354436Z","steps":["trace[501603010] 'process raft request' (duration: 90.895209ms)","trace[501603010] 'compare' (duration: 95.928569ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:19:44.354596Z","caller":"traceutil/trace.go:171","msg":"trace[1692768146] transaction","detail":"{read_only:false; response_revision:8683; number_of_response:1; }","duration":"186.769457ms","start":"2026-04-20T02:19:44.167822Z","end":"2026-04-20T02:19:44.354591Z","steps":["trace[1692768146] 'process raft request' (duration: 186.588952ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:19:44.35474Z","caller":"traceutil/trace.go:171","msg":"trace[388229153] linearizableReadLoop","detail":"{readStateIndex:8991; appliedIndex:8987; }","duration":"150.987672ms","start":"2026-04-20T02:19:44.203745Z","end":"2026-04-20T02:19:44.354733Z","steps":["trace[388229153] 'read index received' (duration: 54.608762ms)","trace[388229153] 'applied index is now lower than readState.Index' (duration: 96.37833ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:19:44.354805Z","caller":"traceutil/trace.go:171","msg":"trace[654239824] transaction","detail":"{read_only:false; response_revision:8684; number_of_response:1; }","duration":"185.898237ms","start":"2026-04-20T02:19:44.168902Z","end":"2026-04-20T02:19:44.354801Z","steps":["trace[654239824] 'process raft request' (duration: 185.66539ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:19:44.354877Z","caller":"traceutil/trace.go:171","msg":"trace[735723957] transaction","detail":"{read_only:false; response_revision:8685; number_of_response:1; }","duration":"179.890173ms","start":"2026-04-20T02:19:44.174967Z","end":"2026-04-20T02:19:44.354857Z","steps":["trace[735723957] 'process raft request' (duration: 179.711818ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:19:44.35506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.264325ms","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:19:44.355083Z","caller":"traceutil/trace.go:171","msg":"trace[60075070] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8685; }","duration":"155.316587ms","start":"2026-04-20T02:19:44.199761Z","end":"2026-04-20T02:19:44.355077Z","steps":["trace[60075070] 'agreement among raft nodes before linearized reading' (duration: 155.221345ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:19:44.355121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.502745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-20T02:19:44.35517Z","caller":"traceutil/trace.go:171","msg":"trace[86324126] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8685; }","duration":"156.587607ms","start":"2026-04-20T02:19:44.19857Z","end":"2026-04-20T02:19:44.355157Z","steps":["trace[86324126] 'agreement among raft nodes before linearized reading' (duration: 156.439974ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:19:44.355439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.922181ms","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:19:44.355513Z","caller":"traceutil/trace.go:171","msg":"trace[242339240] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8685; }","duration":"156.028033ms","start":"2026-04-20T02:19:44.199467Z","end":"2026-04-20T02:19:44.355495Z","steps":["trace[242339240] 'agreement among raft nodes before linearized reading' (duration: 155.777087ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:19:44.373646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.643431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-zhxbf\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-04-20T02:19:44.373727Z","caller":"traceutil/trace.go:171","msg":"trace[1868827395] range","detail":"{range_begin:/registry/pods/openstack/keepalived-zhxbf; range_end:; response_count:1; response_revision:8686; }","duration":"167.757813ms","start":"2026-04-20T02:19:44.205951Z","end":"2026-04-20T02:19:44.373709Z","steps":["trace[1868827395] 'agreement among raft nodes before linearized reading' (duration: 167.557168ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:19:44.373991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.747823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3565"} {"level":"info","ts":"2026-04-20T02:19:44.37411Z","caller":"traceutil/trace.go:171","msg":"trace[1063725272] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:8686; }","duration":"136.925756ms","start":"2026-04-20T02:19:44.237154Z","end":"2026-04-20T02:19:44.37408Z","steps":["trace[1063725272] 'agreement among raft nodes before linearized reading' (duration: 136.576378ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:19:56.70224Z","caller":"traceutil/trace.go:171","msg":"trace[111622246] transaction","detail":"{read_only:false; response_revision:8781; number_of_response:1; }","duration":"109.3936ms","start":"2026-04-20T02:19:56.592815Z","end":"2026-04-20T02:19:56.702208Z","steps":["trace[111622246] 'process raft request' (duration: 109.340299ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:19:56.702248Z","caller":"traceutil/trace.go:171","msg":"trace[134508953] transaction","detail":"{read_only:false; response_revision:8780; number_of_response:1; }","duration":"110.738682ms","start":"2026-04-20T02:19:56.591475Z","end":"2026-04-20T02:19:56.702214Z","steps":["trace[134508953] 'process raft request' (duration: 97.753663ms)","trace[134508953] 'compare' (duration: 12.763674ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:19:56.702236Z","caller":"traceutil/trace.go:171","msg":"trace[662623554] linearizableReadLoop","detail":"{readStateIndex:9089; appliedIndex:9088; }","duration":"109.858021ms","start":"2026-04-20T02:19:56.592342Z","end":"2026-04-20T02:19:56.7022Z","steps":["trace[662623554] 'read index received' (duration: 96.85408ms)","trace[662623554] 'applied index is now lower than readState.Index' (duration: 13.001791ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:19:56.7029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.521557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228702"} {"level":"info","ts":"2026-04-20T02:19:56.70296Z","caller":"traceutil/trace.go:171","msg":"trace[898691346] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8781; }","duration":"110.632289ms","start":"2026-04-20T02:19:56.592312Z","end":"2026-04-20T02:19:56.702944Z","steps":["trace[898691346] 'agreement among raft nodes before linearized reading' (duration: 109.997634ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:19:57.744127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.178413ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T02:19:57.744292Z","caller":"traceutil/trace.go:171","msg":"trace[923201011] linearizableReadLoop","detail":"{readStateIndex:9097; appliedIndex:9096; }","duration":"187.146085ms","start":"2026-04-20T02:19:57.557123Z","end":"2026-04-20T02:19:57.744269Z","steps":["trace[923201011] 'read index received' (duration: 52.941µs)","trace[923201011] 'applied index is now lower than readState.Index' (duration: 187.091164ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:19:57.74435Z","caller":"traceutil/trace.go:171","msg":"trace[409112595] transaction","detail":"{read_only:false; response_revision:8788; number_of_response:1; }","duration":"292.492459ms","start":"2026-04-20T02:19:57.451797Z","end":"2026-04-20T02:19:57.74429Z","steps":["trace[409112595] 'process raft request' (duration: 85.038669ms)","trace[409112595] 'compare' (duration: 207.01824ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:19:57.744448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.32482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/pvc-ceph-client-key\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T02:19:57.744584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.490628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T02:19:57.744653Z","caller":"traceutil/trace.go:171","msg":"trace[1084346177] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:8788; }","duration":"183.621151ms","start":"2026-04-20T02:19:57.561018Z","end":"2026-04-20T02:19:57.744639Z","steps":["trace[1084346177] 'agreement among raft nodes before linearized reading' (duration: 183.489988ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:19:57.744495Z","caller":"traceutil/trace.go:171","msg":"trace[1044894533] range","detail":"{range_begin:/registry/secrets/openstack/pvc-ceph-client-key; range_end:; response_count:0; response_revision:8788; }","duration":"187.410401ms","start":"2026-04-20T02:19:57.557072Z","end":"2026-04-20T02:19:57.744482Z","steps":["trace[1044894533] 'agreement among raft nodes before linearized reading' (duration: 187.324869ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:20:14.500979Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002459.wal"} {"level":"info","ts":"2026-04-20T02:21:00.447015Z","caller":"traceutil/trace.go:171","msg":"trace[1845495966] linearizableReadLoop","detail":"{readStateIndex:9749; appliedIndex:9748; }","duration":"148.211772ms","start":"2026-04-20T02:21:00.298772Z","end":"2026-04-20T02:21:00.446984Z","steps":["trace[1845495966] 'read index received' (duration: 147.951266ms)","trace[1845495966] 'applied index is now lower than readState.Index' (duration: 258.816µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:21:00.447088Z","caller":"traceutil/trace.go:171","msg":"trace[889964048] transaction","detail":"{read_only:false; response_revision:9423; number_of_response:1; }","duration":"245.063924ms","start":"2026-04-20T02:21:00.201972Z","end":"2026-04-20T02:21:00.447036Z","steps":["trace[889964048] 'process raft request' (duration: 244.841978ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:21:00.447215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.416077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:21:00.447262Z","caller":"traceutil/trace.go:171","msg":"trace[699957284] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:9423; }","duration":"148.52654ms","start":"2026-04-20T02:21:00.298724Z","end":"2026-04-20T02:21:00.44725Z","steps":["trace[699957284] 'agreement among raft nodes before linearized reading' (duration: 148.425757ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:21:34.422046Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"380f6760faea5f9e","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-20T02:21:34.426918Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-20T02:21:34.427074Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-20T02:23:19.580602Z","caller":"traceutil/trace.go:171","msg":"trace[292958658] transaction","detail":"{read_only:false; response_revision:10478; number_of_response:1; }","duration":"108.384842ms","start":"2026-04-20T02:23:19.472191Z","end":"2026-04-20T02:23:19.580576Z","steps":["trace[292958658] 'process raft request' (duration: 108.233449ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:23:40.13908Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8109} {"level":"info","ts":"2026-04-20T02:23:40.209882Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8109,"took":"68.752023ms","hash":1582514933,"current-db-size-bytes":57868288,"current-db-size":"58 MB","current-db-size-in-use-bytes":29007872,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-20T02:23:40.209945Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1582514933,"revision":8109,"compact-revision":6024} {"level":"info","ts":"2026-04-20T02:28:40.145067Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10632} {"level":"info","ts":"2026-04-20T02:28:40.239839Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10632,"took":"92.904558ms","hash":2285291158,"current-db-size-bytes":57868288,"current-db-size":"58 MB","current-db-size-in-use-bytes":20692992,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-20T02:28:40.239899Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2285291158,"revision":10632,"compact-revision":8109}