{"level":"warn","ts":"2026-04-22T00:25:27.122361Z","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-22T00:25:27.122497Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.115: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.115:2380","--initial-cluster=instance=https://199.204.45.115:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.115:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.115: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-22T00:25:27.122601Z","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-22T00:25:27.122656Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.115:2380"]} {"level":"info","ts":"2026-04-22T00:25:27.12269Z","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-22T00:25:27.123318Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"]} {"level":"info","ts":"2026-04-22T00:25:27.123445Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.115: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-22T00:25:27.13446Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"10.728449ms"} {"level":"info","ts":"2026-04-22T00:25:27.171176Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e3aaa5c123e150e0","cluster-id":"61ec519698823541"} {"level":"info","ts":"2026-04-22T00:25:27.171532Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=()"} {"level":"info","ts":"2026-04-22T00:25:27.171656Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 0"} {"level":"info","ts":"2026-04-22T00:25:27.171708Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e3aaa5c123e150e0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-22T00:25:27.171789Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 1"} {"level":"info","ts":"2026-04-22T00:25:27.171854Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"} {"level":"warn","ts":"2026-04-22T00:25:27.190624Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-22T00:25:27.192056Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-22T00:25:27.193208Z","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-22T00:25:27.195945Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e3aaa5c123e150e0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-22T00:25:27.196357Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e3aaa5c123e150e0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-22T00:25:27.197772Z","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-22T00:25:27.197945Z","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-22T00:25:27.198013Z","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-22T00:25:27.199197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"} {"level":"info","ts":"2026-04-22T00:25:27.199586Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","added-peer-id":"e3aaa5c123e150e0","added-peer-peer-urls":["https://199.204.45.115:2380"]} {"level":"info","ts":"2026-04-22T00:25:27.202583Z","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-22T00:25:27.202793Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.115:2380"} {"level":"info","ts":"2026-04-22T00:25:27.202831Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e3aaa5c123e150e0","initial-advertise-peer-urls":["https://199.204.45.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-22T00:25:27.202846Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.115:2380"} {"level":"info","ts":"2026-04-22T00:25:27.202866Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-22T00:25:27.973069Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 is starting a new election at term 1"} {"level":"info","ts":"2026-04-22T00:25:27.973178Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-22T00:25:27.973227Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgPreVoteResp from e3aaa5c123e150e0 at term 1"} {"level":"info","ts":"2026-04-22T00:25:27.97325Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became candidate at term 2"} {"level":"info","ts":"2026-04-22T00:25:27.973261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgVoteResp from e3aaa5c123e150e0 at term 2"} {"level":"info","ts":"2026-04-22T00:25:27.9733Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became leader at term 2"} {"level":"info","ts":"2026-04-22T00:25:27.973348Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e3aaa5c123e150e0 elected leader e3aaa5c123e150e0 at term 2"} {"level":"info","ts":"2026-04-22T00:25:28.668344Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e3aaa5c123e150e0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.115:2379]}","request-path":"/0/members/e3aaa5c123e150e0/attributes","cluster-id":"61ec519698823541","publish-timeout":"7s"} {"level":"info","ts":"2026-04-22T00:25:28.668787Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T00:25:28.669064Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T00:25:28.669599Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T00:25:28.671717Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-22T00:25:28.67176Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-22T00:25:28.672345Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-22T00:25:28.674126Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.115:2379"} {"level":"info","ts":"2026-04-22T00:25:28.713001Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T00:25:28.713152Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T00:25:28.713198Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-22T00:25:29.032937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.700404ms","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":"warn","ts":"2026-04-22T00:25:29.03294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.219952ms","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-22T00:25:29.032993Z","caller":"traceutil/trace.go:171","msg":"trace[1364819076] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"214.760985ms","start":"2026-04-22T00:25:28.818219Z","end":"2026-04-22T00:25:29.03298Z","steps":["trace[1364819076] 'range keys from in-memory index tree' (duration: 214.668083ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:25:29.033025Z","caller":"traceutil/trace.go:171","msg":"trace[1211079234] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"235.402405ms","start":"2026-04-22T00:25:28.797601Z","end":"2026-04-22T00:25:29.033004Z","steps":["trace[1211079234] 'count revisions from in-memory index tree' (duration: 235.15191ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:25:29.033105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.140872ms","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-22T00:25:29.033351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.123387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-22T00:25:29.033403Z","caller":"traceutil/trace.go:171","msg":"trace[1843637964] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1; }","duration":"260.203489ms","start":"2026-04-22T00:25:28.77318Z","end":"2026-04-22T00:25:29.033384Z","steps":["trace[1843637964] 'count revisions from in-memory index tree' (duration: 260.023955ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:25:29.033568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.955908ms","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-22T00:25:29.033654Z","caller":"traceutil/trace.go:171","msg":"trace[832934565] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"236.09475ms","start":"2026-04-22T00:25:28.797541Z","end":"2026-04-22T00:25:29.033636Z","steps":["trace[832934565] 'range keys from in-memory index tree' (duration: 235.834164ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:25:29.033823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.796696ms","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-22T00:25:29.033863Z","caller":"traceutil/trace.go:171","msg":"trace[2087858640] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"215.514631ms","start":"2026-04-22T00:25:28.818336Z","end":"2026-04-22T00:25:29.033851Z","steps":["trace[2087858640] 'count revisions from in-memory index tree' (duration: 214.637642ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:25:29.034122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.38815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-22T00:25:29.03412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.452468ms","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-22T00:25:29.034154Z","caller":"traceutil/trace.go:171","msg":"trace[2012195395] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"121.451311ms","start":"2026-04-22T00:25:28.912694Z","end":"2026-04-22T00:25:29.034146Z","steps":["trace[2012195395] 'count revisions from in-memory index tree' (duration: 121.331919ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:25:29.034169Z","caller":"traceutil/trace.go:171","msg":"trace[951929607] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"248.514679ms","start":"2026-04-22T00:25:28.785638Z","end":"2026-04-22T00:25:29.034152Z","steps":["trace[951929607] 'range keys from in-memory index tree' (duration: 248.412376ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:25:29.034265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.100509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-22T00:25:29.03429Z","caller":"traceutil/trace.go:171","msg":"trace[847089428] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"188.13666ms","start":"2026-04-22T00:25:28.846147Z","end":"2026-04-22T00:25:29.034284Z","steps":["trace[847089428] 'count revisions from in-memory index tree' (duration: 188.020967ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:25:29.034335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.500717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-22T00:25:29.03439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.037698ms","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-22T00:25:29.034399Z","caller":"traceutil/trace.go:171","msg":"trace[1959313053] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1; }","duration":"106.59413ms","start":"2026-04-22T00:25:28.927782Z","end":"2026-04-22T00:25:29.034376Z","steps":["trace[1959313053] 'range keys from in-memory index tree' (duration: 106.417656ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:25:29.034416Z","caller":"traceutil/trace.go:171","msg":"trace[952731932] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"188.099069ms","start":"2026-04-22T00:25:28.84631Z","end":"2026-04-22T00:25:29.034409Z","steps":["trace[952731932] 'range keys from in-memory index tree' (duration: 187.953526ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:25:29.034488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.583654ms","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-22T00:25:29.034511Z","caller":"traceutil/trace.go:171","msg":"trace[431417355] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"177.638935ms","start":"2026-04-22T00:25:28.856866Z","end":"2026-04-22T00:25:29.034505Z","steps":["trace[431417355] 'range keys from in-memory index tree' (duration: 177.529533ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:25:29.034564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.390916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-22T00:25:29.034603Z","caller":"traceutil/trace.go:171","msg":"trace[1893465737] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1; }","duration":"106.451736ms","start":"2026-04-22T00:25:28.928142Z","end":"2026-04-22T00:25:29.034594Z","steps":["trace[1893465737] 'count revisions from in-memory index tree' (duration: 106.336263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:25:29.034618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.721557ms","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-22T00:25:29.034637Z","caller":"traceutil/trace.go:171","msg":"trace[1129084795] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"177.754698ms","start":"2026-04-22T00:25:28.856876Z","end":"2026-04-22T00:25:29.034631Z","steps":["trace[1129084795] 'count revisions from in-memory index tree' (duration: 177.654766ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:25:29.034749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.106889ms","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-22T00:25:29.034777Z","caller":"traceutil/trace.go:171","msg":"trace[2000168697] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"166.153669ms","start":"2026-04-22T00:25:28.868618Z","end":"2026-04-22T00:25:29.034771Z","steps":["trace[2000168697] 'count revisions from in-memory index tree' (duration: 166.048428ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:25:29.034928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.16823ms","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-22T00:25:29.034954Z","caller":"traceutil/trace.go:171","msg":"trace[1882512281] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"166.222151ms","start":"2026-04-22T00:25:28.868725Z","end":"2026-04-22T00:25:29.034948Z","steps":["trace[1882512281] 'range keys from in-memory index tree' (duration: 166.086468ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:25:29.035058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.086375ms","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":"info","ts":"2026-04-22T00:25:29.035082Z","caller":"traceutil/trace.go:171","msg":"trace[50599012] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"156.128825ms","start":"2026-04-22T00:25:28.878946Z","end":"2026-04-22T00:25:29.035075Z","steps":["trace[50599012] 'range keys from in-memory index tree' (duration: 156.021963ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:25:29.035086Z","caller":"traceutil/trace.go:171","msg":"trace[1886966999] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"204.166878ms","start":"2026-04-22T00:25:28.830886Z","end":"2026-04-22T00:25:29.035053Z","steps":["trace[1886966999] 'range keys from in-memory index tree' (duration: 202.081831ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:25:29.035211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.303689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-22T00:25:29.035269Z","caller":"traceutil/trace.go:171","msg":"trace[407035427] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"156.388581ms","start":"2026-04-22T00:25:28.878864Z","end":"2026-04-22T00:25:29.035253Z","steps":["trace[407035427] 'count revisions from in-memory index tree' (duration: 156.174467ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:25:29.03285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.701053ms","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-22T00:25:29.03537Z","caller":"traceutil/trace.go:171","msg":"trace[1381875586] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"204.497485ms","start":"2026-04-22T00:25:28.830857Z","end":"2026-04-22T00:25:29.035355Z","steps":["trace[1381875586] 'count revisions from in-memory index tree' (duration: 201.59808ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:25:29.035424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.170522ms","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-22T00:25:29.035464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.037882ms","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":"warn","ts":"2026-04-22T00:25:29.032911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.198098ms","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-22T00:25:29.035487Z","caller":"traceutil/trace.go:171","msg":"trace[1012738245] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"134.063673ms","start":"2026-04-22T00:25:28.901417Z","end":"2026-04-22T00:25:29.035481Z","steps":["trace[1012738245] 'range keys from in-memory index tree' (duration: 133.975161ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:25:29.035492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.835842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-22T00:25:29.035496Z","caller":"traceutil/trace.go:171","msg":"trace[1568472651] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"227.789766ms","start":"2026-04-22T00:25:28.807697Z","end":"2026-04-22T00:25:29.035487Z","steps":["trace[1568472651] 'range keys from in-memory index tree' (duration: 225.171817ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:25:29.035518Z","caller":"traceutil/trace.go:171","msg":"trace[1687065416] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"122.892494ms","start":"2026-04-22T00:25:28.912618Z","end":"2026-04-22T00:25:29.035511Z","steps":["trace[1687065416] 'range keys from in-memory index tree' (duration: 122.74626ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:25:29.035584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.752402ms","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-22T00:25:29.035607Z","caller":"traceutil/trace.go:171","msg":"trace[1799555941] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"144.779213ms","start":"2026-04-22T00:25:28.890822Z","end":"2026-04-22T00:25:29.035601Z","steps":["trace[1799555941] 'count revisions from in-memory index tree' (duration: 144.513047ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:25:29.032923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.26156ms","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-22T00:25:29.035673Z","caller":"traceutil/trace.go:171","msg":"trace[511712786] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"228.020641ms","start":"2026-04-22T00:25:28.807644Z","end":"2026-04-22T00:25:29.035665Z","steps":["trace[511712786] 'count revisions from in-memory index tree' (duration: 225.175467ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:25:29.035687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.318998ms","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-22T00:25:29.035704Z","caller":"traceutil/trace.go:171","msg":"trace[91814144] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"134.35902ms","start":"2026-04-22T00:25:28.90134Z","end":"2026-04-22T00:25:29.035699Z","steps":["trace[91814144] 'count revisions from in-memory index tree' (duration: 134.250847ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:25:29.035461Z","caller":"traceutil/trace.go:171","msg":"trace[824895566] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"145.226262ms","start":"2026-04-22T00:25:28.890226Z","end":"2026-04-22T00:25:29.035452Z","steps":["trace[824895566] 'range keys from in-memory index tree' (duration: 144.916715ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:25:29.036001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.240648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-22T00:25:29.036031Z","caller":"traceutil/trace.go:171","msg":"trace[1120568787] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"250.297589ms","start":"2026-04-22T00:25:28.785728Z","end":"2026-04-22T00:25:29.036025Z","steps":["trace[1120568787] 'count revisions from in-memory index tree' (duration: 250.171966ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:25:58.126571Z","caller":"traceutil/trace.go:171","msg":"trace[783912909] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"285.196317ms","start":"2026-04-22T00:25:57.841351Z","end":"2026-04-22T00:25:58.126547Z","steps":["trace[783912909] 'process raft request' (duration: 285.029413ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:25:58.134764Z","caller":"traceutil/trace.go:171","msg":"trace[1866570619] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"260.999242ms","start":"2026-04-22T00:25:57.87374Z","end":"2026-04-22T00:25:58.134739Z","steps":["trace[1866570619] 'process raft request' (duration: 260.633333ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:25:58.134799Z","caller":"traceutil/trace.go:171","msg":"trace[284718740] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"124.323186ms","start":"2026-04-22T00:25:58.010459Z","end":"2026-04-22T00:25:58.134782Z","steps":["trace[284718740] 'process raft request' (duration: 124.248704ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:25:58.134915Z","caller":"traceutil/trace.go:171","msg":"trace[1580669812] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"252.035272ms","start":"2026-04-22T00:25:57.882869Z","end":"2026-04-22T00:25:58.134904Z","steps":["trace[1580669812] 'process raft request' (duration: 251.53376ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:25:58.134933Z","caller":"traceutil/trace.go:171","msg":"trace[1454772184] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"278.760026ms","start":"2026-04-22T00:25:57.856153Z","end":"2026-04-22T00:25:58.134913Z","steps":["trace[1454772184] 'process raft request' (duration: 278.105591ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:25:58.134994Z","caller":"traceutil/trace.go:171","msg":"trace[2070848766] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"249.743398ms","start":"2026-04-22T00:25:57.885242Z","end":"2026-04-22T00:25:58.134985Z","steps":["trace[2070848766] 'process raft request' (duration: 249.201206ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:25:58.135066Z","caller":"traceutil/trace.go:171","msg":"trace[1219750736] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"239.735404ms","start":"2026-04-22T00:25:57.895321Z","end":"2026-04-22T00:25:58.135057Z","steps":["trace[1219750736] 'process raft request' (duration: 239.165271ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:25:58.135119Z","caller":"traceutil/trace.go:171","msg":"trace[1011740391] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"282.030583ms","start":"2026-04-22T00:25:57.853081Z","end":"2026-04-22T00:25:58.135111Z","steps":["trace[1011740391] 'process raft request' (duration: 281.107532ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:25:58.135136Z","caller":"traceutil/trace.go:171","msg":"trace[1950249199] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"261.458312ms","start":"2026-04-22T00:25:57.873606Z","end":"2026-04-22T00:25:58.135064Z","steps":["trace[1950249199] 'process raft request' (duration: 260.692575ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:25:58.135204Z","caller":"traceutil/trace.go:171","msg":"trace[671684171] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"261.531223ms","start":"2026-04-22T00:25:57.873667Z","end":"2026-04-22T00:25:58.135198Z","steps":["trace[671684171] 'process raft request' (duration: 260.669114ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:25:58.135248Z","caller":"traceutil/trace.go:171","msg":"trace[844769485] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"226.71607ms","start":"2026-04-22T00:25:57.908525Z","end":"2026-04-22T00:25:58.135241Z","steps":["trace[844769485] 'process raft request' (duration: 226.012774ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:25:58.135382Z","caller":"traceutil/trace.go:171","msg":"trace[153814261] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"221.703752ms","start":"2026-04-22T00:25:57.913672Z","end":"2026-04-22T00:25:58.135375Z","steps":["trace[153814261] 'process raft request' (duration: 220.919104ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:25:59.034441Z","caller":"traceutil/trace.go:171","msg":"trace[1428544162] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"130.348287ms","start":"2026-04-22T00:25:58.904063Z","end":"2026-04-22T00:25:59.034411Z","steps":["trace[1428544162] 'process raft request' (duration: 130.166023ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:25:59.188709Z","caller":"traceutil/trace.go:171","msg":"trace[484494019] linearizableReadLoop","detail":"{readStateIndex:561; appliedIndex:560; }","duration":"142.86829ms","start":"2026-04-22T00:25:59.045816Z","end":"2026-04-22T00:25:59.188685Z","steps":["trace[484494019] 'read index received' (duration: 50.392698ms)","trace[484494019] 'applied index is now lower than readState.Index' (duration: 92.474552ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:25:59.188866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.025893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:25:59.188904Z","caller":"traceutil/trace.go:171","msg":"trace[14717885] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:540; }","duration":"143.110125ms","start":"2026-04-22T00:25:59.045785Z","end":"2026-04-22T00:25:59.188895Z","steps":["trace[14717885] 'agreement among raft nodes before linearized reading' (duration: 142.986902ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:25:59.188863Z","caller":"traceutil/trace.go:171","msg":"trace[394157514] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"174.57063ms","start":"2026-04-22T00:25:59.014167Z","end":"2026-04-22T00:25:59.188738Z","steps":["trace[394157514] 'process raft request' (duration: 82.137139ms)","trace[394157514] 'compare' (duration: 92.162005ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:26:04.938275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.97162ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T00:26:04.938382Z","caller":"traceutil/trace.go:171","msg":"trace[681596829] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:596; }","duration":"645.699834ms","start":"2026-04-22T00:26:04.292666Z","end":"2026-04-22T00:26:04.938365Z","steps":["trace[681596829] 'read index received' (duration: 393.086749ms)","trace[681596829] 'applied index is now lower than readState.Index' (duration: 252.611935ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:26:04.938426Z","caller":"traceutil/trace.go:171","msg":"trace[1232576809] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"649.756587ms","start":"2026-04-22T00:26:04.288642Z","end":"2026-04-22T00:26:04.938398Z","steps":["trace[1232576809] 'process raft request' (duration: 397.021119ms)","trace[1232576809] 'compare' (duration: 251.687963ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:26:04.938569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"645.906628ms","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-22T00:26:04.938606Z","caller":"traceutil/trace.go:171","msg":"trace[1952745558] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:575; }","duration":"645.97314ms","start":"2026-04-22T00:26:04.292623Z","end":"2026-04-22T00:26:04.938597Z","steps":["trace[1952745558] 'agreement among raft nodes before linearized reading' (duration: 645.807276ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:26:04.938593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:26:04.288625Z","time spent":"649.8596ms","remote":"127.0.0.1:59164","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-22T00:26:04.938654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:26:04.292606Z","time spent":"646.040561ms","remote":"127.0.0.1:59164","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-22T00:26:05.088576Z","caller":"traceutil/trace.go:171","msg":"trace[131465289] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"686.441876ms","start":"2026-04-22T00:26:04.402111Z","end":"2026-04-22T00:26:05.088553Z","steps":["trace[131465289] 'process raft request' (duration: 656.873625ms)","trace[131465289] 'compare' (duration: 28.821964ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:26:05.088753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:26:04.402081Z","time spent":"686.559628ms","remote":"127.0.0.1:59164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:26:05.089235Z","caller":"traceutil/trace.go:171","msg":"trace[494608073] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:597; }","duration":"150.800685ms","start":"2026-04-22T00:26:04.938407Z","end":"2026-04-22T00:26:05.089208Z","steps":["trace[494608073] 'read index received' (duration: 120.589518ms)","trace[494608073] 'applied index is now lower than readState.Index' (duration: 30.210107ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:26:05.089345Z","caller":"traceutil/trace.go:171","msg":"trace[698046806] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"461.745163ms","start":"2026-04-22T00:26:04.627589Z","end":"2026-04-22T00:26:05.089335Z","steps":["trace[698046806] 'process raft request' (duration: 461.107307ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:26:05.089479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:26:04.627559Z","time spent":"461.816365ms","remote":"127.0.0.1:59004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036297,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T00:26:05.089947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.363558ms","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-22T00:26:05.090053Z","caller":"traceutil/trace.go:171","msg":"trace[1219707480] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:577; }","duration":"548.513321ms","start":"2026-04-22T00:26:04.541518Z","end":"2026-04-22T00:26:05.090032Z","steps":["trace[1219707480] 'agreement among raft nodes before linearized reading' (duration: 547.832315ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:26:05.090128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:26:04.541498Z","time spent":"548.614454ms","remote":"127.0.0.1:59164","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-22T00:26:05.099376Z","caller":"traceutil/trace.go:171","msg":"trace[514778845] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"156.310805ms","start":"2026-04-22T00:26:04.943048Z","end":"2026-04-22T00:26:05.099359Z","steps":["trace[514778845] 'process raft request' (duration: 156.229113ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:26:05.335796Z","caller":"traceutil/trace.go:171","msg":"trace[1541233511] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"271.560808ms","start":"2026-04-22T00:26:05.064206Z","end":"2026-04-22T00:26:05.335767Z","steps":["trace[1541233511] 'process raft request' (duration: 262.864424ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:26:05.335891Z","caller":"traceutil/trace.go:171","msg":"trace[918997766] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"195.318646ms","start":"2026-04-22T00:26:05.140543Z","end":"2026-04-22T00:26:05.335862Z","steps":["trace[918997766] 'process raft request' (duration: 195.267564ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:26:05.336254Z","caller":"traceutil/trace.go:171","msg":"trace[276072527] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:599; }","duration":"246.939972ms","start":"2026-04-22T00:26:05.0893Z","end":"2026-04-22T00:26:05.33624Z","steps":["trace[276072527] 'read index received' (duration: 10.001073ms)","trace[276072527] 'applied index is now lower than readState.Index' (duration: 236.937369ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:26:05.336483Z","caller":"traceutil/trace.go:171","msg":"trace[229701647] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"242.464009ms","start":"2026-04-22T00:26:05.094007Z","end":"2026-04-22T00:26:05.336471Z","steps":["trace[229701647] 'process raft request' (duration: 241.694491ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:26:05.336564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.747063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:26:05.336604Z","caller":"traceutil/trace.go:171","msg":"trace[41239872] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:581; }","duration":"289.825115ms","start":"2026-04-22T00:26:05.046768Z","end":"2026-04-22T00:26:05.336593Z","steps":["trace[41239872] 'agreement among raft nodes before linearized reading' (duration: 289.739813ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:26:05.336871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.363562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-22T00:26:05.33693Z","caller":"traceutil/trace.go:171","msg":"trace[837405700] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:581; }","duration":"182.466845ms","start":"2026-04-22T00:26:05.154451Z","end":"2026-04-22T00:26:05.336917Z","steps":["trace[837405700] 'agreement among raft nodes before linearized reading' (duration: 182.324052ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:26:05.949114Z","caller":"traceutil/trace.go:171","msg":"trace[564605399] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"207.188621ms","start":"2026-04-22T00:26:05.741902Z","end":"2026-04-22T00:26:05.949091Z","steps":["trace[564605399] 'process raft request' (duration: 206.572937ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:26:07.172274Z","caller":"traceutil/trace.go:171","msg":"trace[1763732411] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:611; }","duration":"128.733439ms","start":"2026-04-22T00:26:07.043517Z","end":"2026-04-22T00:26:07.172251Z","steps":["trace[1763732411] 'read index received' (duration: 128.608806ms)","trace[1763732411] 'applied index is now lower than readState.Index' (duration: 123.503µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:26:07.172339Z","caller":"traceutil/trace.go:171","msg":"trace[1445811876] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"225.272055ms","start":"2026-04-22T00:26:06.947045Z","end":"2026-04-22T00:26:07.172318Z","steps":["trace[1445811876] 'process raft request' (duration: 225.071821ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:26:07.172461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.930614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:26:07.172514Z","caller":"traceutil/trace.go:171","msg":"trace[574377260] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:590; }","duration":"129.034136ms","start":"2026-04-22T00:26:07.043464Z","end":"2026-04-22T00:26:07.172498Z","steps":["trace[574377260] 'agreement among raft nodes before linearized reading' (duration: 128.875503ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:26:07.768952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.776511ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T00:26:07.769204Z","caller":"traceutil/trace.go:171","msg":"trace[909348078] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"592.575451ms","start":"2026-04-22T00:26:07.176599Z","end":"2026-04-22T00:26:07.769175Z","steps":["trace[909348078] 'process raft request' (duration: 57.400521ms)","trace[909348078] 'compare' (duration: 534.638938ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:26:07.76936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:26:07.176577Z","time spent":"592.703495ms","remote":"127.0.0.1:59164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:26:07.774599Z","caller":"traceutil/trace.go:171","msg":"trace[1193506679] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:612; }","duration":"434.054146ms","start":"2026-04-22T00:26:07.340501Z","end":"2026-04-22T00:26:07.774555Z","steps":["trace[1193506679] 'read index received' (duration: 379.320547ms)","trace[1193506679] 'applied index is now lower than readState.Index' (duration: 54.731579ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:26:07.774958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.425815ms","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-22T00:26:07.775005Z","caller":"traceutil/trace.go:171","msg":"trace[196232] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:591; }","duration":"434.542328ms","start":"2026-04-22T00:26:07.340451Z","end":"2026-04-22T00:26:07.774993Z","steps":["trace[196232] 'agreement among raft nodes before linearized reading' (duration: 434.247341ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:26:07.775052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:26:07.340427Z","time spent":"434.612049ms","remote":"127.0.0.1:59164","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-22T00:26:08.97353Z","caller":"traceutil/trace.go:171","msg":"trace[1594051591] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"104.517653ms","start":"2026-04-22T00:26:08.868998Z","end":"2026-04-22T00:26:08.973515Z","steps":["trace[1594051591] 'process raft request' (duration: 104.410101ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:26:09.152529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.465579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:26:09.152608Z","caller":"traceutil/trace.go:171","msg":"trace[1161953454] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:597; }","duration":"109.594252ms","start":"2026-04-22T00:26:09.042995Z","end":"2026-04-22T00:26:09.152589Z","steps":["trace[1161953454] 'range keys from in-memory index tree' (duration: 109.353416ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:26:23.649048Z","caller":"traceutil/trace.go:171","msg":"trace[1709726088] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"286.58371ms","start":"2026-04-22T00:26:23.362424Z","end":"2026-04-22T00:26:23.649008Z","steps":["trace[1709726088] 'process raft request' (duration: 286.341185ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:26:23.649082Z","caller":"traceutil/trace.go:171","msg":"trace[1603345409] linearizableReadLoop","detail":"{readStateIndex:774; appliedIndex:773; }","duration":"154.3948ms","start":"2026-04-22T00:26:23.494538Z","end":"2026-04-22T00:26:23.648933Z","steps":["trace[1603345409] 'read index received' (duration: 154.136394ms)","trace[1603345409] 'applied index is now lower than readState.Index' (duration: 257.365µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:26:23.649268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.716096ms","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-22T00:26:23.649353Z","caller":"traceutil/trace.go:171","msg":"trace[562090359] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:747; }","duration":"154.87704ms","start":"2026-04-22T00:26:23.494462Z","end":"2026-04-22T00:26:23.64934Z","steps":["trace[562090359] 'agreement among raft nodes before linearized reading' (duration: 154.616254ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:26:24.53084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.252218ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T00:26:24.530955Z","caller":"traceutil/trace.go:171","msg":"trace[1560557916] linearizableReadLoop","detail":"{readStateIndex:775; appliedIndex:774; }","duration":"704.186112ms","start":"2026-04-22T00:26:23.826754Z","end":"2026-04-22T00:26:24.53094Z","steps":["trace[1560557916] 'read index received' (duration: 42.698638ms)","trace[1560557916] 'applied index is now lower than readState.Index' (duration: 661.486034ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:26:24.531183Z","caller":"traceutil/trace.go:171","msg":"trace[543856374] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"876.467998ms","start":"2026-04-22T00:26:23.654701Z","end":"2026-04-22T00:26:24.531169Z","steps":["trace[543856374] 'process raft request' (duration: 214.789451ms)","trace[543856374] 'compare' (duration: 660.899528ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:26:24.531252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:26:23.654678Z","time spent":"876.539749ms","remote":"127.0.0.1:59164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T00:26:24.531318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.31759ms","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-22T00:26:24.531369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.765009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T00:26:24.531413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.799456ms","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-22T00:26:24.531418Z","caller":"traceutil/trace.go:171","msg":"trace[1588445632] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:748; }","duration":"670.454753ms","start":"2026-04-22T00:26:23.860935Z","end":"2026-04-22T00:26:24.531389Z","steps":["trace[1588445632] 'agreement among raft nodes before linearized reading' (duration: 670.255098ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:26:24.531453Z","caller":"traceutil/trace.go:171","msg":"trace[968301761] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:748; }","duration":"486.885541ms","start":"2026-04-22T00:26:24.04455Z","end":"2026-04-22T00:26:24.531436Z","steps":["trace[968301761] 'agreement among raft nodes before linearized reading' (duration: 486.750738ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:26:24.531465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:26:23.860914Z","time spent":"670.540764ms","remote":"127.0.0.1:59164","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-22T00:26:24.531458Z","caller":"traceutil/trace.go:171","msg":"trace[4941633] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:748; }","duration":"485.857478ms","start":"2026-04-22T00:26:24.045587Z","end":"2026-04-22T00:26:24.531444Z","steps":["trace[4941633] 'agreement among raft nodes before linearized reading' (duration: 485.702945ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:26:24.531481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.721444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-f7rqc\" ","response":"range_response_count:1 size:3965"} {"level":"warn","ts":"2026-04-22T00:26:24.531502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:26:24.04558Z","time spent":"485.914599ms","remote":"127.0.0.1:59164","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-22T00:26:24.531499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:26:24.044532Z","time spent":"486.958823ms","remote":"127.0.0.1:58866","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-22T00:26:24.531535Z","caller":"traceutil/trace.go:171","msg":"trace[1787471811] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-f7rqc; range_end:; response_count:1; response_revision:748; }","duration":"704.815276ms","start":"2026-04-22T00:26:23.826701Z","end":"2026-04-22T00:26:24.531516Z","steps":["trace[1787471811] 'agreement among raft nodes before linearized reading' (duration: 704.633802ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:26:24.531571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:26:23.826676Z","time spent":"704.886767ms","remote":"127.0.0.1:59088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-f7rqc\" "} {"level":"warn","ts":"2026-04-22T00:26:24.531718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"668.241371ms","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-22T00:26:24.533739Z","caller":"traceutil/trace.go:171","msg":"trace[1813613579] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:748; }","duration":"668.376224ms","start":"2026-04-22T00:26:23.863409Z","end":"2026-04-22T00:26:24.531785Z","steps":["trace[1813613579] 'agreement among raft nodes before linearized reading' (duration: 668.081407ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:26:24.533788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:26:23.863387Z","time spent":"670.389131ms","remote":"127.0.0.1:59164","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-22T00:26:39.052008Z","caller":"traceutil/trace.go:171","msg":"trace[401766240] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"143.540511ms","start":"2026-04-22T00:26:38.908435Z","end":"2026-04-22T00:26:39.051975Z","steps":["trace[401766240] 'process raft request' (duration: 143.332156ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:26:39.882926Z","caller":"traceutil/trace.go:171","msg":"trace[1434919012] transaction","detail":"{read_only:false; response_revision:893; number_of_response:1; }","duration":"103.701067ms","start":"2026-04-22T00:26:39.779197Z","end":"2026-04-22T00:26:39.882898Z","steps":["trace[1434919012] 'process raft request' (duration: 103.533813ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:26:49.148214Z","caller":"traceutil/trace.go:171","msg":"trace[1500052976] transaction","detail":"{read_only:false; response_revision:922; number_of_response:1; }","duration":"387.01144ms","start":"2026-04-22T00:26:48.761173Z","end":"2026-04-22T00:26:49.148184Z","steps":["trace[1500052976] 'process raft request' (duration: 386.865216ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:26:49.148503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:26:48.761161Z","time spent":"387.137303ms","remote":"127.0.0.1:59164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:26:49.357791Z","caller":"traceutil/trace.go:171","msg":"trace[2004588768] linearizableReadLoop","detail":"{readStateIndex:955; appliedIndex:953; }","duration":"594.322872ms","start":"2026-04-22T00:26:48.763438Z","end":"2026-04-22T00:26:49.357761Z","steps":["trace[2004588768] 'read index received' (duration: 384.645484ms)","trace[2004588768] 'applied index is now lower than readState.Index' (duration: 209.676058ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:26:49.357967Z","caller":"traceutil/trace.go:171","msg":"trace[1861176466] transaction","detail":"{read_only:false; response_revision:923; number_of_response:1; }","duration":"595.597792ms","start":"2026-04-22T00:26:48.76234Z","end":"2026-04-22T00:26:49.357938Z","steps":["trace[1861176466] 'process raft request' (duration: 498.44064ms)","trace[1861176466] 'compare' (duration: 96.851705ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:26:49.358169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.546227ms","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-22T00:26:49.35823Z","caller":"traceutil/trace.go:171","msg":"trace[1786228789] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:923; }","duration":"594.812243ms","start":"2026-04-22T00:26:48.763403Z","end":"2026-04-22T00:26:49.358215Z","steps":["trace[1786228789] 'agreement among raft nodes before linearized reading' (duration: 594.461785ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:26:49.358226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:26:48.762318Z","time spent":"595.719295ms","remote":"127.0.0.1:59164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T00:26:49.35828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:26:48.763393Z","time spent":"594.870705ms","remote":"127.0.0.1:59164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-22T00:26:49.581199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.983745ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T00:26:49.581364Z","caller":"traceutil/trace.go:171","msg":"trace[569764529] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"159.95595ms","start":"2026-04-22T00:26:49.421378Z","end":"2026-04-22T00:26:49.581334Z","steps":["trace[569764529] 'process raft request' (duration: 41.7445ms)","trace[569764529] 'compare' (duration: 117.841602ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:27:01.560254Z","caller":"traceutil/trace.go:171","msg":"trace[265426773] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"118.307293ms","start":"2026-04-22T00:27:01.441919Z","end":"2026-04-22T00:27:01.560226Z","steps":["trace[265426773] 'process raft request' (duration: 118.050207ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:27:01.928351Z","caller":"traceutil/trace.go:171","msg":"trace[547033613] linearizableReadLoop","detail":"{readStateIndex:1003; appliedIndex:1002; }","duration":"168.058132ms","start":"2026-04-22T00:27:01.760275Z","end":"2026-04-22T00:27:01.928333Z","steps":["trace[547033613] 'read index received' (duration: 127.354258ms)","trace[547033613] 'applied index is now lower than readState.Index' (duration: 40.702994ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:27:01.928536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.244536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.115\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-22T00:27:01.928575Z","caller":"traceutil/trace.go:171","msg":"trace[2073999505] range","detail":"{range_begin:/registry/masterleases/199.204.45.115; range_end:; response_count:1; response_revision:969; }","duration":"168.318228ms","start":"2026-04-22T00:27:01.760248Z","end":"2026-04-22T00:27:01.928566Z","steps":["trace[2073999505] 'agreement among raft nodes before linearized reading' (duration: 168.163494ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:27:01.928639Z","caller":"traceutil/trace.go:171","msg":"trace[662251668] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"201.936665ms","start":"2026-04-22T00:27:01.726673Z","end":"2026-04-22T00:27:01.92861Z","steps":["trace[662251668] 'process raft request' (duration: 160.977215ms)","trace[662251668] 'compare' (duration: 40.421098ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:27:02.366896Z","caller":"traceutil/trace.go:171","msg":"trace[1431775117] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"244.275518ms","start":"2026-04-22T00:27:02.1226Z","end":"2026-04-22T00:27:02.366876Z","steps":["trace[1431775117] 'process raft request' (duration: 244.134815ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:27:03.054331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.494479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:27:03.05439Z","caller":"traceutil/trace.go:171","msg":"trace[1653558971] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:971; }","duration":"232.603141ms","start":"2026-04-22T00:27:02.821774Z","end":"2026-04-22T00:27:03.054377Z","steps":["trace[1653558971] 'count revisions from in-memory index tree' (duration: 232.393136ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:27:03.05438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.416478ms","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-22T00:27:03.054436Z","caller":"traceutil/trace.go:171","msg":"trace[984171668] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:971; }","duration":"273.51647ms","start":"2026-04-22T00:27:02.780906Z","end":"2026-04-22T00:27:03.054422Z","steps":["trace[984171668] 'range keys from in-memory index tree' (duration: 273.233294ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:27:03.404397Z","caller":"traceutil/trace.go:171","msg":"trace[1597790996] linearizableReadLoop","detail":"{readStateIndex:1007; appliedIndex:1006; }","duration":"181.619204ms","start":"2026-04-22T00:27:03.222751Z","end":"2026-04-22T00:27:03.40437Z","steps":["trace[1597790996] 'read index received' (duration: 181.47391ms)","trace[1597790996] 'applied index is now lower than readState.Index' (duration: 144.253µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:27:03.404624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.854169ms","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-22T00:27:03.404669Z","caller":"traceutil/trace.go:171","msg":"trace[230088926] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:972; }","duration":"181.91094ms","start":"2026-04-22T00:27:03.222745Z","end":"2026-04-22T00:27:03.404656Z","steps":["trace[230088926] 'agreement among raft nodes before linearized reading' (duration: 181.743886ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:27:03.404676Z","caller":"traceutil/trace.go:171","msg":"trace[1552939707] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"345.821354ms","start":"2026-04-22T00:27:03.05881Z","end":"2026-04-22T00:27:03.404632Z","steps":["trace[1552939707] 'process raft request' (duration: 345.436135ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:27:03.404846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:27:03.058789Z","time spent":"345.957546ms","remote":"127.0.0.1:59164","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-22T00:27:27.30217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.478762ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-22T00:27:27.30229Z","caller":"traceutil/trace.go:171","msg":"trace[1827787338] linearizableReadLoop","detail":"{readStateIndex:1089; appliedIndex:1088; }","duration":"257.107082ms","start":"2026-04-22T00:27:27.045166Z","end":"2026-04-22T00:27:27.302273Z","steps":["trace[1827787338] 'read index received' (duration: 65.511µs)","trace[1827787338] 'applied index is now lower than readState.Index' (duration: 257.039821ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:27:27.302377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.214285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:27:27.302428Z","caller":"traceutil/trace.go:171","msg":"trace[1482051086] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1049; }","duration":"257.305047ms","start":"2026-04-22T00:27:27.045112Z","end":"2026-04-22T00:27:27.302417Z","steps":["trace[1482051086] 'agreement among raft nodes before linearized reading' (duration: 257.225775ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:27:28.347641Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831308127669518,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T00:27:28.848275Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831308127669518,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T00:27:28.878719Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.032052134s","expected-duration":"1s"} {"level":"info","ts":"2026-04-22T00:27:28.879209Z","caller":"traceutil/trace.go:171","msg":"trace[186960406] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"1.032609717s","start":"2026-04-22T00:27:27.846577Z","end":"2026-04-22T00:27:28.879187Z","steps":["trace[186960406] 'process raft request' (duration: 1.032395682s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:27:28.879329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:27:27.846564Z","time spent":"1.032693898s","remote":"127.0.0.1:59164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:27:28.894289Z","caller":"traceutil/trace.go:171","msg":"trace[231679801] linearizableReadLoop","detail":"{readStateIndex:1094; appliedIndex:1092; }","duration":"1.04708092s","start":"2026-04-22T00:27:27.847181Z","end":"2026-04-22T00:27:28.894261Z","steps":["trace[231679801] 'read index received' (duration: 1.031750527s)","trace[231679801] 'applied index is now lower than readState.Index' (duration: 15.329513ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:27:28.894379Z","caller":"traceutil/trace.go:171","msg":"trace[2039842896] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"679.9411ms","start":"2026-04-22T00:27:28.214427Z","end":"2026-04-22T00:27:28.894368Z","steps":["trace[2039842896] 'process raft request' (duration: 679.751946ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:27:28.894449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:27:28.214408Z","time spent":"679.993991ms","remote":"127.0.0.1:59164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T00:27:28.894538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.987587ms","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-22T00:27:28.894541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"964.694907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-22T00:27:28.894608Z","caller":"traceutil/trace.go:171","msg":"trace[563719858] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1054; }","duration":"243.091409ms","start":"2026-04-22T00:27:28.651499Z","end":"2026-04-22T00:27:28.89459Z","steps":["trace[563719858] 'agreement among raft nodes before linearized reading' (duration: 242.926115ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:27:28.894661Z","caller":"traceutil/trace.go:171","msg":"trace[1127827024] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1054; }","duration":"964.83827ms","start":"2026-04-22T00:27:27.929798Z","end":"2026-04-22T00:27:28.894636Z","steps":["trace[1127827024] 'agreement among raft nodes before linearized reading' (duration: 964.619005ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:27:28.894743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"744.061849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:27:28.894788Z","caller":"traceutil/trace.go:171","msg":"trace[129441326] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1054; }","duration":"744.139031ms","start":"2026-04-22T00:27:28.150637Z","end":"2026-04-22T00:27:28.894776Z","steps":["trace[129441326] 'agreement among raft nodes before linearized reading' (duration: 744.073179ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:27:28.894809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"849.548129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:27:28.894863Z","caller":"traceutil/trace.go:171","msg":"trace[769645181] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1054; }","duration":"849.63313ms","start":"2026-04-22T00:27:28.045216Z","end":"2026-04-22T00:27:28.89485Z","steps":["trace[769645181] 'agreement among raft nodes before linearized reading' (duration: 849.560319ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:27:28.894909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:27:28.045196Z","time spent":"849.702022ms","remote":"127.0.0.1:58866","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-22T00:27:28.894987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.047799776s","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-22T00:27:28.895027Z","caller":"traceutil/trace.go:171","msg":"trace[1627443112] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1054; }","duration":"1.047854988s","start":"2026-04-22T00:27:27.847163Z","end":"2026-04-22T00:27:28.895018Z","steps":["trace[1627443112] 'agreement among raft nodes before linearized reading' (duration: 1.047679343s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:27:28.894819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:27:28.150621Z","time spent":"744.190532ms","remote":"127.0.0.1:59308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-22T00:27:28.895055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:27:27.847155Z","time spent":"1.047893859s","remote":"127.0.0.1:59164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-22T00:27:28.894744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:27:27.929728Z","time spent":"964.988593ms","remote":"127.0.0.1:59342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"info","ts":"2026-04-22T00:27:29.075238Z","caller":"traceutil/trace.go:171","msg":"trace[1798418103] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"175.54218ms","start":"2026-04-22T00:27:28.899646Z","end":"2026-04-22T00:27:29.075188Z","steps":["trace[1798418103] 'process raft request' (duration: 147.784802ms)","trace[1798418103] 'compare' (duration: 27.393349ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:27:29.092954Z","caller":"traceutil/trace.go:171","msg":"trace[400135377] transaction","detail":"{read_only:false; response_revision:1056; number_of_response:1; }","duration":"192.238766ms","start":"2026-04-22T00:27:28.899873Z","end":"2026-04-22T00:27:29.092111Z","steps":["trace[400135377] 'process raft request' (duration: 192.092832ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:27:43.399811Z","caller":"traceutil/trace.go:171","msg":"trace[1982651087] linearizableReadLoop","detail":"{readStateIndex:1199; appliedIndex:1198; }","duration":"182.676237ms","start":"2026-04-22T00:27:43.217078Z","end":"2026-04-22T00:27:43.399755Z","steps":["trace[1982651087] 'read index received' (duration: 182.352509ms)","trace[1982651087] 'applied index is now lower than readState.Index' (duration: 322.098µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:27:43.399839Z","caller":"traceutil/trace.go:171","msg":"trace[872841876] transaction","detail":"{read_only:false; response_revision:1154; number_of_response:1; }","duration":"241.115205ms","start":"2026-04-22T00:27:43.158682Z","end":"2026-04-22T00:27:43.399797Z","steps":["trace[872841876] 'process raft request' (duration: 240.827628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:27:43.400022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.927742ms","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-22T00:27:43.400062Z","caller":"traceutil/trace.go:171","msg":"trace[1924794908] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1154; }","duration":"183.035005ms","start":"2026-04-22T00:27:43.21702Z","end":"2026-04-22T00:27:43.400055Z","steps":["trace[1924794908] 'agreement among raft nodes before linearized reading' (duration: 182.877541ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:27:49.364398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.123889ms","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-22T00:27:49.364554Z","caller":"traceutil/trace.go:171","msg":"trace[2004541755] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1172; }","duration":"130.303803ms","start":"2026-04-22T00:27:49.234231Z","end":"2026-04-22T00:27:49.364535Z","steps":["trace[2004541755] 'range keys from in-memory index tree' (duration: 130.101319ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:27:53.175754Z","caller":"traceutil/trace.go:171","msg":"trace[1506565784] transaction","detail":"{read_only:false; response_revision:1185; number_of_response:1; }","duration":"105.504215ms","start":"2026-04-22T00:27:53.070214Z","end":"2026-04-22T00:27:53.175718Z","steps":["trace[1506565784] 'process raft request' (duration: 26.617782ms)","trace[1506565784] 'compare' (duration: 78.736499ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:27:53.295154Z","caller":"traceutil/trace.go:171","msg":"trace[1961190099] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"116.008905ms","start":"2026-04-22T00:27:53.179126Z","end":"2026-04-22T00:27:53.295135Z","steps":["trace[1961190099] 'process raft request' (duration: 115.326238ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:27:53.620301Z","caller":"traceutil/trace.go:171","msg":"trace[975567435] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"122.042588ms","start":"2026-04-22T00:27:53.498235Z","end":"2026-04-22T00:27:53.620278Z","steps":["trace[975567435] 'process raft request' (duration: 30.487224ms)","trace[975567435] 'compare' (duration: 91.421251ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:27:58.020845Z","caller":"traceutil/trace.go:171","msg":"trace[699388864] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"110.734068ms","start":"2026-04-22T00:27:57.910087Z","end":"2026-04-22T00:27:58.020821Z","steps":["trace[699388864] 'process raft request' (duration: 98.492308ms)","trace[699388864] 'compare' (duration: 11.920043ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:27:59.969174Z","caller":"traceutil/trace.go:171","msg":"trace[587289161] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"100.021065ms","start":"2026-04-22T00:27:59.869105Z","end":"2026-04-22T00:27:59.969126Z","steps":["trace[587289161] 'process raft request' (duration: 99.858832ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:28:00.038797Z","caller":"traceutil/trace.go:171","msg":"trace[1026358021] linearizableReadLoop","detail":"{readStateIndex:1271; appliedIndex:1269; }","duration":"141.397347ms","start":"2026-04-22T00:27:59.897375Z","end":"2026-04-22T00:28:00.038772Z","steps":["trace[1026358021] 'read index received' (duration: 71.61006ms)","trace[1026358021] 'applied index is now lower than readState.Index' (duration: 69.786127ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:28:00.038859Z","caller":"traceutil/trace.go:171","msg":"trace[1677748638] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"166.512694ms","start":"2026-04-22T00:27:59.872309Z","end":"2026-04-22T00:28:00.038822Z","steps":["trace[1677748638] 'process raft request' (duration: 166.33787ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:28:00.038955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.556772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:28:00.038999Z","caller":"traceutil/trace.go:171","msg":"trace[1254262091] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1223; }","duration":"141.647613ms","start":"2026-04-22T00:27:59.897336Z","end":"2026-04-22T00:28:00.038984Z","steps":["trace[1254262091] 'agreement among raft nodes before linearized reading' (duration: 141.553641ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:28:00.03914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.630603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:28:00.039205Z","caller":"traceutil/trace.go:171","msg":"trace[1534972318] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1223; }","duration":"141.770466ms","start":"2026-04-22T00:27:59.897421Z","end":"2026-04-22T00:28:00.039191Z","steps":["trace[1534972318] 'agreement among raft nodes before linearized reading' (duration: 141.615992ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:28:01.408755Z","caller":"traceutil/trace.go:171","msg":"trace[1443980482] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"182.425121ms","start":"2026-04-22T00:28:01.225745Z","end":"2026-04-22T00:28:01.40817Z","steps":["trace[1443980482] 'process raft request' (duration: 182.024931ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:28:01.822612Z","caller":"traceutil/trace.go:171","msg":"trace[1876009005] linearizableReadLoop","detail":"{readStateIndex:1279; appliedIndex:1278; }","duration":"293.135121ms","start":"2026-04-22T00:28:01.529445Z","end":"2026-04-22T00:28:01.82258Z","steps":["trace[1876009005] 'read index received' (duration: 248.328487ms)","trace[1876009005] 'applied index is now lower than readState.Index' (duration: 44.804944ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:28:01.82273Z","caller":"traceutil/trace.go:171","msg":"trace[1315903125] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"408.652592ms","start":"2026-04-22T00:28:01.414054Z","end":"2026-04-22T00:28:01.822707Z","steps":["trace[1315903125] 'process raft request' (duration: 363.822258ms)","trace[1315903125] 'compare' (duration: 44.356142ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:28:01.822807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.341525ms","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-22T00:28:01.822841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:28:01.414042Z","time spent":"408.733124ms","remote":"127.0.0.1:59164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:28:01.822878Z","caller":"traceutil/trace.go:171","msg":"trace[112227972] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1231; }","duration":"293.468318ms","start":"2026-04-22T00:28:01.529395Z","end":"2026-04-22T00:28:01.822864Z","steps":["trace[112227972] 'agreement among raft nodes before linearized reading' (duration: 293.346075ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:28:01.822921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.506082ms","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-22T00:28:01.822977Z","caller":"traceutil/trace.go:171","msg":"trace[1031385033] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1231; }","duration":"283.610144ms","start":"2026-04-22T00:28:01.539353Z","end":"2026-04-22T00:28:01.822963Z","steps":["trace[1031385033] 'agreement among raft nodes before linearized reading' (duration: 283.41481ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:28:01.823117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.624391ms","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-22T00:28:01.823139Z","caller":"traceutil/trace.go:171","msg":"trace[575952047] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1231; }","duration":"170.683282ms","start":"2026-04-22T00:28:01.65245Z","end":"2026-04-22T00:28:01.823133Z","steps":["trace[575952047] 'agreement among raft nodes before linearized reading' (duration: 170.622591ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:28:02.039402Z","caller":"traceutil/trace.go:171","msg":"trace[1856113007] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"103.231391ms","start":"2026-04-22T00:28:01.936132Z","end":"2026-04-22T00:28:02.039364Z","steps":["trace[1856113007] 'process raft request' (duration: 102.77687ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:28:02.191121Z","caller":"traceutil/trace.go:171","msg":"trace[939326764] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"123.800439ms","start":"2026-04-22T00:28:02.067297Z","end":"2026-04-22T00:28:02.191097Z","steps":["trace[939326764] 'process raft request' (duration: 59.949193ms)","trace[939326764] 'compare' (duration: 63.767984ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:28:03.468878Z","caller":"traceutil/trace.go:171","msg":"trace[1051028553] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"326.188584ms","start":"2026-04-22T00:28:03.142671Z","end":"2026-04-22T00:28:03.46886Z","steps":["trace[1051028553] 'process raft request' (duration: 326.02348ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:28:03.469005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:28:03.142649Z","time spent":"326.289886ms","remote":"127.0.0.1:59164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:28:03.755853Z","caller":"traceutil/trace.go:171","msg":"trace[1465526937] linearizableReadLoop","detail":"{readStateIndex:1289; appliedIndex:1287; }","duration":"287.19085ms","start":"2026-04-22T00:28:03.468642Z","end":"2026-04-22T00:28:03.755833Z","steps":["trace[1465526937] 'read index received' (duration: 286.966644ms)","trace[1465526937] 'applied index is now lower than readState.Index' (duration: 223.436µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:28:03.756113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.434015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:28:03.756149Z","caller":"traceutil/trace.go:171","msg":"trace[1680493435] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1240; }","duration":"287.539528ms","start":"2026-04-22T00:28:03.4686Z","end":"2026-04-22T00:28:03.75614Z","steps":["trace[1680493435] 'agreement among raft nodes before linearized reading' (duration: 287.316542ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:28:03.756226Z","caller":"traceutil/trace.go:171","msg":"trace[342273636] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"368.805826ms","start":"2026-04-22T00:28:03.387404Z","end":"2026-04-22T00:28:03.75621Z","steps":["trace[342273636] 'process raft request' (duration: 368.252563ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:28:03.756286Z","caller":"traceutil/trace.go:171","msg":"trace[681595874] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"341.900048ms","start":"2026-04-22T00:28:03.41437Z","end":"2026-04-22T00:28:03.75627Z","steps":["trace[681595874] 'process raft request' (duration: 341.410746ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:28:03.756313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:28:03.387379Z","time spent":"368.891459ms","remote":"127.0.0.1:58976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-22T00:28:03.756374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:28:03.414342Z","time spent":"341.974569ms","remote":"127.0.0.1:59164","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-22T00:28:03.864883Z","caller":"traceutil/trace.go:171","msg":"trace[1048509989] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"104.988394ms","start":"2026-04-22T00:28:03.759853Z","end":"2026-04-22T00:28:03.864841Z","steps":["trace[1048509989] 'process raft request' (duration: 75.069353ms)","trace[1048509989] 'compare' (duration: 29.642023ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:28:48.760706Z","caller":"traceutil/trace.go:171","msg":"trace[700561997] transaction","detail":"{read_only:false; response_revision:1480; number_of_response:1; }","duration":"116.152228ms","start":"2026-04-22T00:28:48.644525Z","end":"2026-04-22T00:28:48.760677Z","steps":["trace[700561997] 'process raft request' (duration: 115.985724ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:05.155897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.38183ms","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-22T00:30:05.155961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.99531ms","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-22T00:30:05.156003Z","caller":"traceutil/trace.go:171","msg":"trace[466742255] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1827; }","duration":"199.542104ms","start":"2026-04-22T00:30:04.956438Z","end":"2026-04-22T00:30:05.15598Z","steps":["trace[466742255] 'range keys from in-memory index tree' (duration: 199.157495ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:05.156085Z","caller":"traceutil/trace.go:171","msg":"trace[1515012133] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1827; }","duration":"136.164944ms","start":"2026-04-22T00:30:05.0199Z","end":"2026-04-22T00:30:05.156065Z","steps":["trace[1515012133] 'range keys from in-memory index tree' (duration: 135.822697ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:05.156107Z","caller":"traceutil/trace.go:171","msg":"trace[1432848757] linearizableReadLoop","detail":"{readStateIndex:1901; appliedIndex:1900; }","duration":"101.569536ms","start":"2026-04-22T00:30:05.054516Z","end":"2026-04-22T00:30:05.156086Z","steps":["trace[1432848757] 'read index received' (duration: 99.27357ms)","trace[1432848757] 'applied index is now lower than readState.Index' (duration: 2.294845ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:30:05.156187Z","caller":"traceutil/trace.go:171","msg":"trace[286580926] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"116.911213ms","start":"2026-04-22T00:30:05.039261Z","end":"2026-04-22T00:30:05.156172Z","steps":["trace[286580926] 'process raft request' (duration: 114.552816ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:05.156409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.868922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:525"} {"level":"info","ts":"2026-04-22T00:30:05.156494Z","caller":"traceutil/trace.go:171","msg":"trace[1176918397] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1828; }","duration":"101.998446ms","start":"2026-04-22T00:30:05.054472Z","end":"2026-04-22T00:30:05.156471Z","steps":["trace[1176918397] 'agreement among raft nodes before linearized reading' (duration: 101.75917ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:14.948785Z","caller":"traceutil/trace.go:171","msg":"trace[1920228882] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"127.109116ms","start":"2026-04-22T00:30:14.821648Z","end":"2026-04-22T00:30:14.948757Z","steps":["trace[1920228882] 'process raft request' (duration: 120.201761ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:51.812581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"814.871653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-22T00:30:51.81265Z","caller":"traceutil/trace.go:171","msg":"trace[505026437] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2035; }","duration":"814.985806ms","start":"2026-04-22T00:30:50.997647Z","end":"2026-04-22T00:30:51.812633Z","steps":["trace[505026437] 'range keys from in-memory index tree' (duration: 814.721349ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:51.812639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.037928ms","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-22T00:30:51.812681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:30:50.997622Z","time spent":"815.052587ms","remote":"127.0.0.1:59164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-04-22T00:30:51.812678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.248546ms","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-22T00:30:51.812733Z","caller":"traceutil/trace.go:171","msg":"trace[1964758655] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2035; }","duration":"697.182533ms","start":"2026-04-22T00:30:51.115527Z","end":"2026-04-22T00:30:51.81271Z","steps":["trace[1964758655] 'range keys from in-memory index tree' (duration: 696.846054ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:51.81277Z","caller":"traceutil/trace.go:171","msg":"trace[1679863494] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2035; }","duration":"443.37581ms","start":"2026-04-22T00:30:51.369371Z","end":"2026-04-22T00:30:51.812747Z","steps":["trace[1679863494] 'range keys from in-memory index tree' (duration: 443.03761ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:51.81279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:30:51.115498Z","time spent":"697.277605ms","remote":"127.0.0.1:59164","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-22T00:30:51.812847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:30:51.369351Z","time spent":"443.485402ms","remote":"127.0.0.1:59164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-22T00:30:51.812891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"776.423013ms","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-22T00:30:51.812917Z","caller":"traceutil/trace.go:171","msg":"trace[123841843] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2035; }","duration":"776.469905ms","start":"2026-04-22T00:30:51.036438Z","end":"2026-04-22T00:30:51.812908Z","steps":["trace[123841843] 'range keys from in-memory index tree' (duration: 776.334791ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:51.812918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.176093ms","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-22T00:30:51.812961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"768.646387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:30:51.81298Z","caller":"traceutil/trace.go:171","msg":"trace[1374561470] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2035; }","duration":"768.700068ms","start":"2026-04-22T00:30:51.044274Z","end":"2026-04-22T00:30:51.812974Z","steps":["trace[1374561470] 'range keys from in-memory index tree' (duration: 768.541744ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:51.812976Z","caller":"traceutil/trace.go:171","msg":"trace[1208316401] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2035; }","duration":"697.268175ms","start":"2026-04-22T00:30:51.115692Z","end":"2026-04-22T00:30:51.812961Z","steps":["trace[1208316401] 'range keys from in-memory index tree' (duration: 697.025649ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:51.813029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:30:51.115678Z","time spent":"697.337446ms","remote":"127.0.0.1:59164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-22T00:30:51.813119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.213822ms","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-22T00:30:51.813139Z","caller":"traceutil/trace.go:171","msg":"trace[186821977] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2035; }","duration":"440.271585ms","start":"2026-04-22T00:30:51.372862Z","end":"2026-04-22T00:30:51.813134Z","steps":["trace[186821977] 'range keys from in-memory index tree' (duration: 440.110051ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:51.813157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:30:51.372841Z","time spent":"440.311766ms","remote":"127.0.0.1:59164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-22T00:30:51.812935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:30:51.036427Z","time spent":"776.503165ms","remote":"127.0.0.1:59164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-22T00:30:51.812997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:30:51.044253Z","time spent":"768.739399ms","remote":"127.0.0.1:58866","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-22T00:30:51.838658Z","caller":"traceutil/trace.go:171","msg":"trace[154444500] linearizableReadLoop","detail":"{readStateIndex:2118; appliedIndex:2117; }","duration":"156.395749ms","start":"2026-04-22T00:30:51.682239Z","end":"2026-04-22T00:30:51.838634Z","steps":["trace[154444500] 'read index received' (duration: 156.350018ms)","trace[154444500] 'applied index is now lower than readState.Index' (duration: 44.541µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:30:51.838909Z","caller":"traceutil/trace.go:171","msg":"trace[74856039] transaction","detail":"{read_only:false; response_revision:2036; number_of_response:1; }","duration":"322.846679ms","start":"2026-04-22T00:30:51.516017Z","end":"2026-04-22T00:30:51.838863Z","steps":["trace[74856039] 'process raft request' (duration: 322.482051ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:51.838944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.685826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:30:51.839105Z","caller":"traceutil/trace.go:171","msg":"trace[356865767] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:2036; }","duration":"156.88842ms","start":"2026-04-22T00:30:51.682195Z","end":"2026-04-22T00:30:51.839084Z","steps":["trace[356865767] 'agreement among raft nodes before linearized reading' (duration: 156.686826ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:51.839039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:30:51.515991Z","time spent":"322.981392ms","remote":"127.0.0.1:59164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T00:30:53.545601Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831308127671890,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-22T00:30:53.57894Z","caller":"traceutil/trace.go:171","msg":"trace[787220438] linearizableReadLoop","detail":"{readStateIndex:2128; appliedIndex:2127; }","duration":"533.742995ms","start":"2026-04-22T00:30:53.04517Z","end":"2026-04-22T00:30:53.578913Z","steps":["trace[787220438] 'read index received' (duration: 533.497819ms)","trace[787220438] 'applied index is now lower than readState.Index' (duration: 244.216µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:30:53.579077Z","caller":"traceutil/trace.go:171","msg":"trace[1338285904] transaction","detail":"{read_only:false; response_revision:2045; number_of_response:1; }","duration":"788.371148ms","start":"2026-04-22T00:30:52.790687Z","end":"2026-04-22T00:30:53.579058Z","steps":["trace[1338285904] 'process raft request' (duration: 788.059221ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:53.579381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:30:52.790665Z","time spent":"788.467701ms","remote":"127.0.0.1:59164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T00:30:53.579454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.269637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:30:53.579509Z","caller":"traceutil/trace.go:171","msg":"trace[633902977] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2045; }","duration":"534.36157ms","start":"2026-04-22T00:30:53.045132Z","end":"2026-04-22T00:30:53.579493Z","steps":["trace[633902977] 'agreement among raft nodes before linearized reading' (duration: 534.265517ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:53.579556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:30:53.045114Z","time spent":"534.431251ms","remote":"127.0.0.1:58878","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-22T00:30:53.579477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.864624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:30:53.579703Z","caller":"traceutil/trace.go:171","msg":"trace[983536771] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2045; }","duration":"392.165451ms","start":"2026-04-22T00:30:53.187518Z","end":"2026-04-22T00:30:53.579684Z","steps":["trace[983536771] 'agreement among raft nodes before linearized reading' (duration: 391.845263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:53.579759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:30:53.187481Z","time spent":"392.262403ms","remote":"127.0.0.1:54654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-04-22T00:31:22.435123Z","caller":"traceutil/trace.go:171","msg":"trace[80183889] linearizableReadLoop","detail":"{readStateIndex:2292; appliedIndex:2291; }","duration":"109.14836ms","start":"2026-04-22T00:31:22.325953Z","end":"2026-04-22T00:31:22.435101Z","steps":["trace[80183889] 'read index received' (duration: 108.916865ms)","trace[80183889] 'applied index is now lower than readState.Index' (duration: 230.485µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:31:22.435169Z","caller":"traceutil/trace.go:171","msg":"trace[745837012] transaction","detail":"{read_only:false; response_revision:2202; number_of_response:1; }","duration":"130.426111ms","start":"2026-04-22T00:31:22.304716Z","end":"2026-04-22T00:31:22.435142Z","steps":["trace[745837012] 'process raft request' (duration: 130.224446ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:22.435372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.405126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-04-22T00:31:22.435418Z","caller":"traceutil/trace.go:171","msg":"trace[1590252732] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2202; }","duration":"109.491518ms","start":"2026-04-22T00:31:22.325913Z","end":"2026-04-22T00:31:22.435404Z","steps":["trace[1590252732] 'agreement among raft nodes before linearized reading' (duration: 109.313214ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:22.435462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.193747ms","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-22T00:31:22.435527Z","caller":"traceutil/trace.go:171","msg":"trace[975070460] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2202; }","duration":"103.3131ms","start":"2026-04-22T00:31:22.332197Z","end":"2026-04-22T00:31:22.43551Z","steps":["trace[975070460] 'agreement among raft nodes before linearized reading' (duration: 103.067224ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:30.415447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.125801ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T00:31:30.415858Z","caller":"traceutil/trace.go:171","msg":"trace[103050042] transaction","detail":"{read_only:false; response_revision:2242; number_of_response:1; }","duration":"316.979169ms","start":"2026-04-22T00:31:30.098851Z","end":"2026-04-22T00:31:30.41583Z","steps":["trace[103050042] 'process raft request' (duration: 39.380065ms)","trace[103050042] 'compare' (duration: 276.840755ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:31:30.416461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:30.09883Z","time spent":"317.583294ms","remote":"127.0.0.1:59164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":516,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:31:30.416102Z","caller":"traceutil/trace.go:171","msg":"trace[653585495] transaction","detail":"{read_only:false; response_revision:2244; number_of_response:1; }","duration":"317.0134ms","start":"2026-04-22T00:31:30.099065Z","end":"2026-04-22T00:31:30.416078Z","steps":["trace[653585495] 'process raft request' (duration: 316.551758ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:30.416931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:30.099054Z","time spent":"317.569033ms","remote":"127.0.0.1:59164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:31:30.416144Z","caller":"traceutil/trace.go:171","msg":"trace[1813643860] transaction","detail":"{read_only:false; response_revision:2243; number_of_response:1; }","duration":"317.099982ms","start":"2026-04-22T00:31:30.099035Z","end":"2026-04-22T00:31:30.416135Z","steps":["trace[1813643860] 'process raft request' (duration: 316.530018ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:30.417123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:30.099007Z","time spent":"318.069474ms","remote":"127.0.0.1:59164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:31:30.630101Z","caller":"traceutil/trace.go:171","msg":"trace[1198361870] transaction","detail":"{read_only:false; response_revision:2246; number_of_response:1; }","duration":"148.261367ms","start":"2026-04-22T00:31:30.481799Z","end":"2026-04-22T00:31:30.63006Z","steps":["trace[1198361870] 'process raft request' (duration: 147.96947ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:31:30.652099Z","caller":"traceutil/trace.go:171","msg":"trace[282921715] transaction","detail":"{read_only:false; response_revision:2247; number_of_response:1; }","duration":"169.634741ms","start":"2026-04-22T00:31:30.482434Z","end":"2026-04-22T00:31:30.652068Z","steps":["trace[282921715] 'process raft request' (duration: 169.334964ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:31:56.85848Z","caller":"traceutil/trace.go:171","msg":"trace[165695423] transaction","detail":"{read_only:false; response_revision:2372; number_of_response:1; }","duration":"104.134519ms","start":"2026-04-22T00:31:56.754317Z","end":"2026-04-22T00:31:56.858452Z","steps":["trace[165695423] 'process raft request' (duration: 36.642229ms)","trace[165695423] 'compare' (duration: 67.238904ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:31:56.858696Z","caller":"traceutil/trace.go:171","msg":"trace[1035982431] transaction","detail":"{read_only:false; response_revision:2373; number_of_response:1; }","duration":"104.242462ms","start":"2026-04-22T00:31:56.754388Z","end":"2026-04-22T00:31:56.858631Z","steps":["trace[1035982431] 'process raft request' (duration: 103.963275ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:31:58.079996Z","caller":"traceutil/trace.go:171","msg":"trace[1434049912] linearizableReadLoop","detail":"{readStateIndex:2473; appliedIndex:2472; }","duration":"231.907165ms","start":"2026-04-22T00:31:57.848063Z","end":"2026-04-22T00:31:58.07997Z","steps":["trace[1434049912] 'read index received' (duration: 231.731331ms)","trace[1434049912] 'applied index is now lower than readState.Index' (duration: 174.844µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:31:58.08008Z","caller":"traceutil/trace.go:171","msg":"trace[1413600532] transaction","detail":"{read_only:false; response_revision:2375; number_of_response:1; }","duration":"251.133417ms","start":"2026-04-22T00:31:57.828908Z","end":"2026-04-22T00:31:58.080041Z","steps":["trace[1413600532] 'process raft request' (duration: 250.912542ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:58.080187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.107491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/system:controller:bootstrap-signer\" ","response":"range_response_count:1 size:618"} {"level":"info","ts":"2026-04-22T00:31:58.080369Z","caller":"traceutil/trace.go:171","msg":"trace[312593095] range","detail":"{range_begin:/registry/roles/kube-system/system:controller:bootstrap-signer; range_end:; response_count:1; response_revision:2375; }","duration":"232.268824ms","start":"2026-04-22T00:31:57.848024Z","end":"2026-04-22T00:31:58.080293Z","steps":["trace[312593095] 'agreement among raft nodes before linearized reading' (duration: 232.061899ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:58.115902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.212291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/system::leader-locking-kube-scheduler\" ","response":"range_response_count:1 size:661"} {"level":"info","ts":"2026-04-22T00:31:58.115954Z","caller":"traceutil/trace.go:171","msg":"trace[702581954] range","detail":"{range_begin:/registry/roles/kube-system/system::leader-locking-kube-scheduler; range_end:; response_count:1; response_revision:2376; }","duration":"264.288493ms","start":"2026-04-22T00:31:57.851654Z","end":"2026-04-22T00:31:58.115942Z","steps":["trace[702581954] 'agreement among raft nodes before linearized reading' (duration: 264.182841ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:31:58.116167Z","caller":"traceutil/trace.go:171","msg":"trace[719736005] transaction","detail":"{read_only:false; response_revision:2376; number_of_response:1; }","duration":"240.979673ms","start":"2026-04-22T00:31:57.875182Z","end":"2026-04-22T00:31:58.116162Z","steps":["trace[719736005] 'process raft request' (duration: 240.562213ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:58.1163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.334985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-22T00:31:58.116314Z","caller":"traceutil/trace.go:171","msg":"trace[1962387350] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:2376; }","duration":"194.352515ms","start":"2026-04-22T00:31:57.921957Z","end":"2026-04-22T00:31:58.11631Z","steps":["trace[1962387350] 'agreement among raft nodes before linearized reading' (duration: 194.327715ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:32:06.660589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.582509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-vfq2p\" ","response":"range_response_count:1 size:13724"} {"level":"info","ts":"2026-04-22T00:32:06.66071Z","caller":"traceutil/trace.go:171","msg":"trace[1083152718] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-vfq2p; range_end:; response_count:1; response_revision:2413; }","duration":"443.737333ms","start":"2026-04-22T00:32:06.216951Z","end":"2026-04-22T00:32:06.660689Z","steps":["trace[1083152718] 'range keys from in-memory index tree' (duration: 443.335434ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:32:06.660778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:32:06.216937Z","time spent":"443.825535ms","remote":"127.0.0.1:59088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":13747,"request content":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-vfq2p\" "} {"level":"warn","ts":"2026-04-22T00:32:06.660975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.698114ms","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-22T00:32:06.661056Z","caller":"traceutil/trace.go:171","msg":"trace[14004595] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2413; }","duration":"409.816786ms","start":"2026-04-22T00:32:06.251218Z","end":"2026-04-22T00:32:06.661035Z","steps":["trace[14004595] 'range keys from in-memory index tree' (duration: 408.911195ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:32:06.66111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:32:06.251196Z","time spent":"409.901519ms","remote":"127.0.0.1:59164","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-22T00:32:07.021757Z","caller":"traceutil/trace.go:171","msg":"trace[2138021283] transaction","detail":"{read_only:false; response_revision:2415; number_of_response:1; }","duration":"323.959125ms","start":"2026-04-22T00:32:06.697772Z","end":"2026-04-22T00:32:07.021731Z","steps":["trace[2138021283] 'process raft request' (duration: 322.228723ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:32:07.021918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:32:06.697747Z","time spent":"324.092718ms","remote":"127.0.0.1:59164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:32:07.022265Z","caller":"traceutil/trace.go:171","msg":"trace[1188615083] transaction","detail":"{read_only:false; response_revision:2416; number_of_response:1; }","duration":"322.889229ms","start":"2026-04-22T00:32:06.699344Z","end":"2026-04-22T00:32:07.022233Z","steps":["trace[1188615083] 'process raft request' (duration: 322.300565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:32:07.022429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:32:06.699335Z","time spent":"323.009642ms","remote":"127.0.0.1:59164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:32:07.022559Z","caller":"traceutil/trace.go:171","msg":"trace[2142530311] linearizableReadLoop","detail":"{readStateIndex:2514; appliedIndex:2512; }","duration":"323.75438ms","start":"2026-04-22T00:32:06.698774Z","end":"2026-04-22T00:32:07.022529Z","steps":["trace[2142530311] 'read index received' (duration: 26.102178ms)","trace[2142530311] 'applied index is now lower than readState.Index' (duration: 297.647212ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:32:07.024409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.114596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-22T00:32:07.024505Z","caller":"traceutil/trace.go:171","msg":"trace[1578191020] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2416; }","duration":"316.223869ms","start":"2026-04-22T00:32:06.708259Z","end":"2026-04-22T00:32:07.024483Z","steps":["trace[1578191020] 'agreement among raft nodes before linearized reading' (duration: 316.015254ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:32:07.024555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:32:06.708253Z","time spent":"316.28822ms","remote":"127.0.0.1:59164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-04-22T00:32:07.024571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.41468ms","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-22T00:32:07.024628Z","caller":"traceutil/trace.go:171","msg":"trace[992424254] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2416; }","duration":"129.491822ms","start":"2026-04-22T00:32:06.895122Z","end":"2026-04-22T00:32:07.024614Z","steps":["trace[992424254] 'agreement among raft nodes before linearized reading' (duration: 129.305358ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:32:07.024629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.946733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:6951"} {"level":"info","ts":"2026-04-22T00:32:07.024695Z","caller":"traceutil/trace.go:171","msg":"trace[894939130] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:2416; }","duration":"326.033975ms","start":"2026-04-22T00:32:06.698642Z","end":"2026-04-22T00:32:07.024676Z","steps":["trace[894939130] 'agreement among raft nodes before linearized reading' (duration: 324.035846ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:32:07.024567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.002484ms","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-22T00:32:07.024741Z","caller":"traceutil/trace.go:171","msg":"trace[1310782396] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2416; }","duration":"130.22877ms","start":"2026-04-22T00:32:06.8945Z","end":"2026-04-22T00:32:07.024728Z","steps":["trace[1310782396] 'agreement among raft nodes before linearized reading' (duration: 129.934603ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:32:07.024746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:32:06.698372Z","time spent":"326.356433ms","remote":"127.0.0.1:59086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":6974,"request content":"key:\"/registry/minions/instance\" "}