{"level":"warn","ts":"2026-04-21T19:16:21.894024Z","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-21T19:16:21.894111Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.78: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.78:2380","--initial-cluster=instance=https://199.204.45.78:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.78:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.78: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-21T19:16:21.894176Z","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-21T19:16:21.894189Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-04-21T19:16:21.894204Z","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-21T19:16:21.894787Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"]} {"level":"info","ts":"2026-04-21T19:16:21.894859Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.78: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-21T19:16:21.899122Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.067332ms"} {"level":"info","ts":"2026-04-21T19:16:21.905756Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6eb8766b1ec86e92","cluster-id":"9bbfe9e5d45d3718"} {"level":"info","ts":"2026-04-21T19:16:21.905826Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=()"} {"level":"info","ts":"2026-04-21T19:16:21.905848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 0"} {"level":"info","ts":"2026-04-21T19:16:21.905861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6eb8766b1ec86e92 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-21T19:16:21.90587Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 1"} {"level":"info","ts":"2026-04-21T19:16:21.905907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"warn","ts":"2026-04-21T19:16:21.923313Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-21T19:16:21.927008Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-21T19:16:21.928986Z","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-21T19:16:21.931745Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6eb8766b1ec86e92","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-21T19:16:21.93201Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6eb8766b1ec86e92","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-21T19:16:21.932083Z","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-21T19:16:21.932941Z","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-21T19:16:21.93306Z","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-21T19:16:21.933357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"info","ts":"2026-04-21T19:16:21.939988Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","added-peer-id":"6eb8766b1ec86e92","added-peer-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-04-21T19:16:21.942009Z","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-21T19:16:21.942154Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-04-21T19:16:21.94221Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-04-21T19:16:21.942527Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6eb8766b1ec86e92","initial-advertise-peer-urls":["https://199.204.45.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-21T19:16:21.94259Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-21T19:16:22.807042Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 is starting a new election at term 1"} {"level":"info","ts":"2026-04-21T19:16:22.807117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-21T19:16:22.807138Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgPreVoteResp from 6eb8766b1ec86e92 at term 1"} {"level":"info","ts":"2026-04-21T19:16:22.807153Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became candidate at term 2"} {"level":"info","ts":"2026-04-21T19:16:22.80716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgVoteResp from 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-04-21T19:16:22.80717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became leader at term 2"} {"level":"info","ts":"2026-04-21T19:16:22.807179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6eb8766b1ec86e92 elected leader 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-04-21T19:16:22.808503Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T19:16:22.80912Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T19:16:22.809121Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6eb8766b1ec86e92","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.78:2379]}","request-path":"/0/members/6eb8766b1ec86e92/attributes","cluster-id":"9bbfe9e5d45d3718","publish-timeout":"7s"} {"level":"info","ts":"2026-04-21T19:16:22.809161Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T19:16:22.809582Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-21T19:16:22.809629Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-21T19:16:22.811341Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-21T19:16:22.811524Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.78:2379"} {"level":"info","ts":"2026-04-21T19:16:22.811661Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T19:16:22.811809Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T19:16:22.811855Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-21T19:16:27.974117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.915933ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:16:27.975253Z","caller":"traceutil/trace.go:171","msg":"trace[1156999512] transaction","detail":"{read_only:false; response_revision:254; number_of_response:1; }","duration":"138.19978ms","start":"2026-04-21T19:16:27.836972Z","end":"2026-04-21T19:16:27.975172Z","steps":["trace[1156999512] 'process raft request' (duration: 33.768787ms)","trace[1156999512] 'compare' (duration: 100.651297ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:16:27.975465Z","caller":"traceutil/trace.go:171","msg":"trace[1736862518] transaction","detail":"{read_only:false; response_revision:255; number_of_response:1; }","duration":"100.185006ms","start":"2026-04-21T19:16:27.875234Z","end":"2026-04-21T19:16:27.975419Z","steps":["trace[1736862518] 'process raft request' (duration: 99.820737ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:28.176013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.896793ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:16:28.176173Z","caller":"traceutil/trace.go:171","msg":"trace[829826841] linearizableReadLoop","detail":"{readStateIndex:268; appliedIndex:267; }","duration":"102.305665ms","start":"2026-04-21T19:16:28.073839Z","end":"2026-04-21T19:16:28.176145Z","steps":["trace[829826841] 'read index received' (duration: 1.068134ms)","trace[829826841] 'applied index is now lower than readState.Index' (duration: 101.235861ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:16:28.176269Z","caller":"traceutil/trace.go:171","msg":"trace[1970194504] transaction","detail":"{read_only:false; response_revision:260; number_of_response:1; }","duration":"124.328025ms","start":"2026-04-21T19:16:28.051889Z","end":"2026-04-21T19:16:28.176217Z","steps":["trace[1970194504] 'process raft request' (duration: 23.097935ms)","trace[1970194504] 'compare' (duration: 100.616366ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:16:28.176429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.572892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:16:28.176499Z","caller":"traceutil/trace.go:171","msg":"trace[584832033] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:0; response_revision:260; }","duration":"102.685083ms","start":"2026-04-21T19:16:28.073792Z","end":"2026-04-21T19:16:28.176477Z","steps":["trace[584832033] 'agreement among raft nodes before linearized reading' (duration: 102.474298ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:28.515962Z","caller":"traceutil/trace.go:171","msg":"trace[75198278] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"156.899526ms","start":"2026-04-21T19:16:28.35904Z","end":"2026-04-21T19:16:28.515939Z","steps":["trace[75198278] 'process raft request' (duration: 155.976625ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:28.515931Z","caller":"traceutil/trace.go:171","msg":"trace[1826001467] linearizableReadLoop","detail":"{readStateIndex:275; appliedIndex:274; }","duration":"142.462388ms","start":"2026-04-21T19:16:28.373438Z","end":"2026-04-21T19:16:28.5159Z","steps":["trace[1826001467] 'read index received' (duration: 141.531706ms)","trace[1826001467] 'applied index is now lower than readState.Index' (duration: 929.462µs)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:16:28.516369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.914049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/statefulset-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:16:28.516426Z","caller":"traceutil/trace.go:171","msg":"trace[1313254638] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/statefulset-controller; range_end:; response_count:0; response_revision:267; }","duration":"143.037771ms","start":"2026-04-21T19:16:28.373373Z","end":"2026-04-21T19:16:28.516411Z","steps":["trace[1313254638] 'agreement among raft nodes before linearized reading' (duration: 142.664833ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:28.680015Z","caller":"traceutil/trace.go:171","msg":"trace[2003469569] transaction","detail":"{read_only:false; response_revision:269; number_of_response:1; }","duration":"157.782006ms","start":"2026-04-21T19:16:28.522197Z","end":"2026-04-21T19:16:28.679979Z","steps":["trace[2003469569] 'process raft request' (duration: 97.175138ms)","trace[2003469569] 'compare' (duration: 60.452724ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:16:28.992432Z","caller":"traceutil/trace.go:171","msg":"trace[386771241] linearizableReadLoop","detail":"{readStateIndex:285; appliedIndex:284; }","duration":"118.419981ms","start":"2026-04-21T19:16:28.873983Z","end":"2026-04-21T19:16:28.992403Z","steps":["trace[386771241] 'read index received' (duration: 49.700869ms)","trace[386771241] 'applied index is now lower than readState.Index' (duration: 68.717692ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:16:28.992487Z","caller":"traceutil/trace.go:171","msg":"trace[213556044] transaction","detail":"{read_only:false; response_revision:275; number_of_response:1; }","duration":"141.604268ms","start":"2026-04-21T19:16:28.85083Z","end":"2026-04-21T19:16:28.992434Z","steps":["trace[213556044] 'process raft request' (duration: 72.868386ms)","trace[213556044] 'compare' (duration: 68.474056ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:16:28.9926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.592875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:16:28.992644Z","caller":"traceutil/trace.go:171","msg":"trace[1230199381] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:0; response_revision:275; }","duration":"118.691397ms","start":"2026-04-21T19:16:28.873939Z","end":"2026-04-21T19:16:28.992631Z","steps":["trace[1230199381] 'agreement among raft nodes before linearized reading' (duration: 118.592525ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:29.220132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.858813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"warn","ts":"2026-04-21T19:16:29.220163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.497128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6751"} {"level":"info","ts":"2026-04-21T19:16:29.22023Z","caller":"traceutil/trace.go:171","msg":"trace[637038957] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:277; }","duration":"127.054518ms","start":"2026-04-21T19:16:29.093153Z","end":"2026-04-21T19:16:29.220208Z","steps":["trace[637038957] 'range keys from in-memory index tree' (duration: 126.690929ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:29.220259Z","caller":"traceutil/trace.go:171","msg":"trace[150452815] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:277; }","duration":"127.640451ms","start":"2026-04-21T19:16:29.092594Z","end":"2026-04-21T19:16:29.220234Z","steps":["trace[150452815] 'range keys from in-memory index tree' (duration: 127.365975ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:39.658552Z","caller":"traceutil/trace.go:171","msg":"trace[1834703655] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"295.264273ms","start":"2026-04-21T19:16:39.363259Z","end":"2026-04-21T19:16:39.658524Z","steps":["trace[1834703655] 'process raft request' (duration: 249.938066ms)","trace[1834703655] 'compare' (duration: 45.074432ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:16:39.947723Z","caller":"traceutil/trace.go:171","msg":"trace[1542488921] linearizableReadLoop","detail":"{readStateIndex:399; appliedIndex:398; }","duration":"128.165196ms","start":"2026-04-21T19:16:39.819529Z","end":"2026-04-21T19:16:39.947694Z","steps":["trace[1542488921] 'read index received' (duration: 15.551232ms)","trace[1542488921] 'applied index is now lower than readState.Index' (duration: 112.612624ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:16:39.947795Z","caller":"traceutil/trace.go:171","msg":"trace[1405799265] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"128.35432ms","start":"2026-04-21T19:16:39.819402Z","end":"2026-04-21T19:16:39.947757Z","steps":["trace[1405799265] 'process raft request' (duration: 76.3345ms)","trace[1405799265] 'compare' (duration: 51.801296ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:16:39.947929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.120563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4195"} {"level":"warn","ts":"2026-04-21T19:16:39.947901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.34544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-67659f764b\" ","response":"range_response_count:1 size:3810"} {"level":"info","ts":"2026-04-21T19:16:39.947969Z","caller":"traceutil/trace.go:171","msg":"trace[146901830] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:387; }","duration":"127.211275ms","start":"2026-04-21T19:16:39.820746Z","end":"2026-04-21T19:16:39.947957Z","steps":["trace[146901830] 'agreement among raft nodes before linearized reading' (duration: 127.117543ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:39.947991Z","caller":"traceutil/trace.go:171","msg":"trace[1054777619] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-67659f764b; range_end:; response_count:1; response_revision:387; }","duration":"128.466342ms","start":"2026-04-21T19:16:39.819503Z","end":"2026-04-21T19:16:39.94797Z","steps":["trace[1054777619] 'agreement among raft nodes before linearized reading' (duration: 128.304748ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:42.590646Z","caller":"traceutil/trace.go:171","msg":"trace[1670096800] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"181.894153ms","start":"2026-04-21T19:16:42.408725Z","end":"2026-04-21T19:16:42.590619Z","steps":["trace[1670096800] 'process raft request' (duration: 181.74834ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:44.522217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.915258ms","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-21T19:16:44.522373Z","caller":"traceutil/trace.go:171","msg":"trace[1235541741] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:412; }","duration":"713.076302ms","start":"2026-04-21T19:16:43.809269Z","end":"2026-04-21T19:16:44.522345Z","steps":["trace[1235541741] 'range keys from in-memory index tree' (duration: 712.896168ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:44.5225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.65649ms","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-21T19:16:44.522597Z","caller":"traceutil/trace.go:171","msg":"trace[487481461] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:412; }","duration":"116.816094ms","start":"2026-04-21T19:16:44.405757Z","end":"2026-04-21T19:16:44.522573Z","steps":["trace[487481461] 'range keys from in-memory index tree' (duration: 116.483106ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:44.654167Z","caller":"traceutil/trace.go:171","msg":"trace[523474997] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"126.993982ms","start":"2026-04-21T19:16:44.527142Z","end":"2026-04-21T19:16:44.654136Z","steps":["trace[523474997] 'process raft request' (duration: 126.787407ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:51.207501Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967604076334486987,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-21T19:16:51.249204Z","caller":"traceutil/trace.go:171","msg":"trace[357819476] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"566.936433ms","start":"2026-04-21T19:16:50.682244Z","end":"2026-04-21T19:16:51.249181Z","steps":["trace[357819476] 'process raft request' (duration: 566.79728ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:51.249573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:50.682226Z","time spent":"567.056635ms","remote":"127.0.0.1:60610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:16:51.260905Z","caller":"traceutil/trace.go:171","msg":"trace[1860021973] linearizableReadLoop","detail":"{readStateIndex:444; appliedIndex:443; }","duration":"554.038567ms","start":"2026-04-21T19:16:50.706833Z","end":"2026-04-21T19:16:51.260871Z","steps":["trace[1860021973] 'read index received' (duration: 542.383758ms)","trace[1860021973] 'applied index is now lower than readState.Index' (duration: 11.652799ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:16:51.261069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.218921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-21T19:16:51.261123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.837537ms","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-21T19:16:51.261162Z","caller":"traceutil/trace.go:171","msg":"trace[797803428] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:428; }","duration":"542.97066ms","start":"2026-04-21T19:16:50.718179Z","end":"2026-04-21T19:16:51.26115Z","steps":["trace[797803428] 'agreement among raft nodes before linearized reading' (duration: 542.845837ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:51.261171Z","caller":"traceutil/trace.go:171","msg":"trace[1216514219] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:428; }","duration":"554.358324ms","start":"2026-04-21T19:16:50.706773Z","end":"2026-04-21T19:16:51.261131Z","steps":["trace[1216514219] 'agreement among raft nodes before linearized reading' (duration: 554.20701ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:51.261166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.8498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:16:51.261203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:50.718155Z","time spent":"543.039662ms","remote":"127.0.0.1:60610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-21T19:16:51.261199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.012435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12669"} {"level":"warn","ts":"2026-04-21T19:16:51.261222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:50.706749Z","time spent":"554.461736ms","remote":"127.0.0.1:60610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-21T19:16:51.261258Z","caller":"traceutil/trace.go:171","msg":"trace[135681522] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:428; }","duration":"506.963902ms","start":"2026-04-21T19:16:50.754271Z","end":"2026-04-21T19:16:51.261235Z","steps":["trace[135681522] 'agreement among raft nodes before linearized reading' (duration: 506.810129ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:51.261305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:50.754259Z","time spent":"507.035263ms","remote":"127.0.0.1:60326","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-21T19:16:51.261334Z","caller":"traceutil/trace.go:171","msg":"trace[198004775] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:428; }","duration":"122.146038ms","start":"2026-04-21T19:16:51.139122Z","end":"2026-04-21T19:16:51.261268Z","steps":["trace[198004775] 'agreement among raft nodes before linearized reading' (duration: 121.929763ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:54.508296Z","caller":"traceutil/trace.go:171","msg":"trace[1191735134] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"712.0846ms","start":"2026-04-21T19:16:53.796182Z","end":"2026-04-21T19:16:54.508266Z","steps":["trace[1191735134] 'process raft request' (duration: 711.860925ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:54.508484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:53.796155Z","time spent":"712.258413ms","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T19:16:54.55468Z","caller":"traceutil/trace.go:171","msg":"trace[1883656785] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"757.437748ms","start":"2026-04-21T19:16:53.797195Z","end":"2026-04-21T19:16:54.554633Z","steps":["trace[1883656785] 'process raft request' (duration: 757.125751ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:54.554764Z","caller":"traceutil/trace.go:171","msg":"trace[1803098558] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"748.432296ms","start":"2026-04-21T19:16:53.806299Z","end":"2026-04-21T19:16:54.554731Z","steps":["trace[1803098558] 'process raft request' (duration: 748.241162ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:54.554876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:53.797185Z","time spent":"757.587181ms","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T19:16:54.554895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:53.806287Z","time spent":"748.545678ms","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T19:16:54.554907Z","caller":"traceutil/trace.go:171","msg":"trace[2087119017] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"754.178068ms","start":"2026-04-21T19:16:53.8007Z","end":"2026-04-21T19:16:54.554878Z","steps":["trace[2087119017] 'process raft request' (duration: 753.78227ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:54.554943Z","caller":"traceutil/trace.go:171","msg":"trace[1042419842] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"743.674414ms","start":"2026-04-21T19:16:53.811229Z","end":"2026-04-21T19:16:54.554903Z","steps":["trace[1042419842] 'process raft request' (duration: 743.409518ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:54.555011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:53.800681Z","time spent":"754.287751ms","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T19:16:54.555059Z","caller":"traceutil/trace.go:171","msg":"trace[583013246] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"724.843772ms","start":"2026-04-21T19:16:53.830188Z","end":"2026-04-21T19:16:54.555032Z","steps":["trace[583013246] 'process raft request' (duration: 724.539145ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:54.555069Z","caller":"traceutil/trace.go:171","msg":"trace[1084329836] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"734.439127ms","start":"2026-04-21T19:16:53.820568Z","end":"2026-04-21T19:16:54.555007Z","steps":["trace[1084329836] 'process raft request' (duration: 734.11388ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:54.555126Z","caller":"traceutil/trace.go:171","msg":"trace[1866182455] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"718.623349ms","start":"2026-04-21T19:16:53.836493Z","end":"2026-04-21T19:16:54.555116Z","steps":["trace[1866182455] 'process raft request' (duration: 718.332433ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:54.555088Z","caller":"traceutil/trace.go:171","msg":"trace[314319209] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"744.84716ms","start":"2026-04-21T19:16:53.810144Z","end":"2026-04-21T19:16:54.554991Z","steps":["trace[314319209] 'process raft request' (duration: 744.446081ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:54.555176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:53.836471Z","time spent":"718.6801ms","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T19:16:54.555178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:53.820546Z","time spent":"734.578791ms","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T19:16:54.555196Z","caller":"traceutil/trace.go:171","msg":"trace[1486827300] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"711.686731ms","start":"2026-04-21T19:16:53.843499Z","end":"2026-04-21T19:16:54.555185Z","steps":["trace[1486827300] 'process raft request' (duration: 711.539548ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:54.555237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:53.843472Z","time spent":"711.747943ms","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T19:16:54.55513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:53.830165Z","time spent":"724.927364ms","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T19:16:54.55531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:53.8101Z","time spent":"745.106295ms","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T19:16:54.555361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:53.811218Z","time spent":"743.772757ms","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T19:16:54.555412Z","caller":"traceutil/trace.go:171","msg":"trace[444954870] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"685.41501ms","start":"2026-04-21T19:16:53.869982Z","end":"2026-04-21T19:16:54.555397Z","steps":["trace[444954870] 'process raft request' (duration: 685.132404ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:54.555428Z","caller":"traceutil/trace.go:171","msg":"trace[434136675] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"582.357611ms","start":"2026-04-21T19:16:53.973021Z","end":"2026-04-21T19:16:54.555378Z","steps":["trace[434136675] 'process raft request' (duration: 582.188257ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:54.555478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:53.869953Z","time spent":"685.503973ms","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T19:16:54.555677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:53.973001Z","time spent":"582.528984ms","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T19:16:54.639146Z","caller":"traceutil/trace.go:171","msg":"trace[1087454888] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"120.960592ms","start":"2026-04-21T19:16:54.518165Z","end":"2026-04-21T19:16:54.639126Z","steps":["trace[1087454888] 'process raft request' (duration: 120.897611ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:54.639243Z","caller":"traceutil/trace.go:171","msg":"trace[2070789799] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"124.364104ms","start":"2026-04-21T19:16:54.514847Z","end":"2026-04-21T19:16:54.639211Z","steps":["trace[2070789799] 'process raft request' (duration: 103.0789ms)","trace[2070789799] 'compare' (duration: 20.959327ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:16:55.174579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.500482ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:16:55.174789Z","caller":"traceutil/trace.go:171","msg":"trace[1999438051] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"338.609998ms","start":"2026-04-21T19:16:54.836126Z","end":"2026-04-21T19:16:55.174736Z","steps":["trace[1999438051] 'process raft request' (duration: 143.805659ms)","trace[1999438051] 'compare' (duration: 194.357709ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:16:55.17489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:54.836089Z","time spent":"338.750831ms","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23066,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:16:55.184822Z","caller":"traceutil/trace.go:171","msg":"trace[1094373322] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"319.571192ms","start":"2026-04-21T19:16:54.865226Z","end":"2026-04-21T19:16:55.184797Z","steps":["trace[1094373322] 'process raft request' (duration: 319.203884ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:55.184912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:54.865192Z","time spent":"319.682964ms","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64392,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T19:16:55.185391Z","caller":"traceutil/trace.go:171","msg":"trace[1670073815] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"315.360202ms","start":"2026-04-21T19:16:54.869995Z","end":"2026-04-21T19:16:55.185355Z","steps":["trace[1670073815] 'process raft request' (duration: 314.637116ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:55.185724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:54.869966Z","time spent":"315.532956ms","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29546,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:16:55.422719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.978595ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:16:55.42283Z","caller":"traceutil/trace.go:171","msg":"trace[1544555101] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"150.075933ms","start":"2026-04-21T19:16:55.272737Z","end":"2026-04-21T19:16:55.422813Z","steps":["trace[1544555101] 'process raft request' (duration: 19.929435ms)","trace[1544555101] 'compare' (duration: 129.784801ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:16:55.454714Z","caller":"traceutil/trace.go:171","msg":"trace[1653838122] linearizableReadLoop","detail":"{readStateIndex:533; appliedIndex:532; }","duration":"155.441368ms","start":"2026-04-21T19:16:55.29925Z","end":"2026-04-21T19:16:55.454691Z","steps":["trace[1653838122] 'read index received' (duration: 155.356166ms)","trace[1653838122] 'applied index is now lower than readState.Index' (duration: 84.252µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:16:55.454881Z","caller":"traceutil/trace.go:171","msg":"trace[731717430] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"160.618069ms","start":"2026-04-21T19:16:55.294207Z","end":"2026-04-21T19:16:55.454825Z","steps":["trace[731717430] 'process raft request' (duration: 160.353433ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:55.455071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.805336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-21T19:16:55.455116Z","caller":"traceutil/trace.go:171","msg":"trace[1824924337] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:516; }","duration":"155.887438ms","start":"2026-04-21T19:16:55.299215Z","end":"2026-04-21T19:16:55.455103Z","steps":["trace[1824924337] 'agreement among raft nodes before linearized reading' (duration: 155.800656ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:55.842746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.797151ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:16:55.842939Z","caller":"traceutil/trace.go:171","msg":"trace[101926938] linearizableReadLoop","detail":"{readStateIndex:535; appliedIndex:533; }","duration":"388.128986ms","start":"2026-04-21T19:16:55.454797Z","end":"2026-04-21T19:16:55.842926Z","steps":["trace[101926938] 'read index received' (duration: 124.097209ms)","trace[101926938] 'applied index is now lower than readState.Index' (duration: 264.030977ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:16:55.843054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.30732ms","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-21T19:16:55.843029Z","caller":"traceutil/trace.go:171","msg":"trace[344467491] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"536.948922ms","start":"2026-04-21T19:16:55.30604Z","end":"2026-04-21T19:16:55.842989Z","steps":["trace[344467491] 'process raft request' (duration: 272.805253ms)","trace[344467491] 'compare' (duration: 263.519956ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:16:55.843006Z","caller":"traceutil/trace.go:171","msg":"trace[1652960048] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"391.63586ms","start":"2026-04-21T19:16:55.451331Z","end":"2026-04-21T19:16:55.842967Z","steps":["trace[1652960048] 'process raft request' (duration: 391.522548ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:55.843081Z","caller":"traceutil/trace.go:171","msg":"trace[745175606] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:518; }","duration":"537.346731ms","start":"2026-04-21T19:16:55.305727Z","end":"2026-04-21T19:16:55.843073Z","steps":["trace[745175606] 'agreement among raft nodes before linearized reading' (duration: 537.262209ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:55.843168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:55.306017Z","time spent":"537.078615ms","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59607,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:16:55.843136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.697161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-21T19:16:55.843208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:55.30572Z","time spent":"537.478923ms","remote":"127.0.0.1:60610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-21T19:16:55.843229Z","caller":"traceutil/trace.go:171","msg":"trace[762511112] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:518; }","duration":"532.826155ms","start":"2026-04-21T19:16:55.310379Z","end":"2026-04-21T19:16:55.843205Z","steps":["trace[762511112] 'agreement among raft nodes before linearized reading' (duration: 532.60912ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:55.84322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:55.451308Z","time spent":"391.809084ms","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19834,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T19:16:55.843273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:55.310364Z","time spent":"532.900436ms","remote":"127.0.0.1:60610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-21T19:16:55.907716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.237415ms","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-21T19:16:55.907715Z","caller":"traceutil/trace.go:171","msg":"trace[1488359601] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"437.844086ms","start":"2026-04-21T19:16:55.46982Z","end":"2026-04-21T19:16:55.907664Z","steps":["trace[1488359601] 'process raft request' (duration: 437.711194ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:55.907767Z","caller":"traceutil/trace.go:171","msg":"trace[1853423965] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"448.085515ms","start":"2026-04-21T19:16:55.45965Z","end":"2026-04-21T19:16:55.907735Z","steps":["trace[1853423965] 'process raft request' (duration: 447.753628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:55.907962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:55.4698Z","time spent":"438.022791ms","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65199,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:16:55.907974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:55.459575Z","time spent":"448.262619ms","remote":"127.0.0.1:60610","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-21T19:16:55.90797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.836925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:16:55.908063Z","caller":"traceutil/trace.go:171","msg":"trace[693735248] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:520; }","duration":"154.987799ms","start":"2026-04-21T19:16:55.753055Z","end":"2026-04-21T19:16:55.908042Z","steps":["trace[693735248] 'agreement among raft nodes before linearized reading' (duration: 154.814435ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:55.907793Z","caller":"traceutil/trace.go:171","msg":"trace[1449825558] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:520; }","duration":"423.357578ms","start":"2026-04-21T19:16:55.484417Z","end":"2026-04-21T19:16:55.907775Z","steps":["trace[1449825558] 'agreement among raft nodes before linearized reading' (duration: 423.218745ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:55.908131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:55.484403Z","time spent":"423.719365ms","remote":"127.0.0.1:60610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-21T19:16:56.065084Z","caller":"traceutil/trace.go:171","msg":"trace[896612157] linearizableReadLoop","detail":"{readStateIndex:540; appliedIndex:537; }","duration":"155.127011ms","start":"2026-04-21T19:16:55.909923Z","end":"2026-04-21T19:16:56.06505Z","steps":["trace[896612157] 'read index received' (duration: 126.479109ms)","trace[896612157] 'applied index is now lower than readState.Index' (duration: 28.646392ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:16:56.065326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.368676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:16:56.065385Z","caller":"traceutil/trace.go:171","msg":"trace[1784718221] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:523; }","duration":"155.496719ms","start":"2026-04-21T19:16:55.909873Z","end":"2026-04-21T19:16:56.06537Z","steps":["trace[1784718221] 'agreement among raft nodes before linearized reading' (duration: 155.308455ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:56.065818Z","caller":"traceutil/trace.go:171","msg":"trace[1817131173] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"217.662646ms","start":"2026-04-21T19:16:55.848136Z","end":"2026-04-21T19:16:56.065799Z","steps":["trace[1817131173] 'process raft request' (duration: 188.246868ms)","trace[1817131173] 'compare' (duration: 27.869735ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:16:56.066028Z","caller":"traceutil/trace.go:171","msg":"trace[689167997] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"217.697597ms","start":"2026-04-21T19:16:55.848303Z","end":"2026-04-21T19:16:56.066Z","steps":["trace[689167997] 'process raft request' (duration: 216.513982ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:56.066416Z","caller":"traceutil/trace.go:171","msg":"trace[1259305113] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"197.313802ms","start":"2026-04-21T19:16:55.869089Z","end":"2026-04-21T19:16:56.066402Z","steps":["trace[1259305113] 'process raft request' (duration: 195.82777ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:56.068173Z","caller":"traceutil/trace.go:171","msg":"trace[1871287995] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"135.949322ms","start":"2026-04-21T19:16:55.932194Z","end":"2026-04-21T19:16:56.068143Z","steps":["trace[1871287995] 'process raft request' (duration: 135.86668ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:56.0684Z","caller":"traceutil/trace.go:171","msg":"trace[1672873372] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"155.470519ms","start":"2026-04-21T19:16:55.91291Z","end":"2026-04-21T19:16:56.068381Z","steps":["trace[1672873372] 'process raft request' (duration: 155.02321ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:56.597219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.529828ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:16:56.597354Z","caller":"traceutil/trace.go:171","msg":"trace[181067051] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"477.764668ms","start":"2026-04-21T19:16:56.119569Z","end":"2026-04-21T19:16:56.597334Z","steps":["trace[181067051] 'process raft request' (duration: 131.020627ms)","trace[181067051] 'compare' (duration: 346.367983ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:16:56.597419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:56.119543Z","time spent":"477.846421ms","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80688,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:16:56.633468Z","caller":"traceutil/trace.go:171","msg":"trace[649259625] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"472.007336ms","start":"2026-04-21T19:16:56.161435Z","end":"2026-04-21T19:16:56.633442Z","steps":["trace[649259625] 'process raft request' (duration: 471.586917ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:56.633707Z","caller":"traceutil/trace.go:171","msg":"trace[737508653] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"479.435064ms","start":"2026-04-21T19:16:56.154246Z","end":"2026-04-21T19:16:56.633681Z","steps":["trace[737508653] 'process raft request' (duration: 478.471744ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:56.633842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:56.154212Z","time spent":"479.562487ms","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151212,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:16:56.634112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:56.161399Z","time spent":"472.356423ms","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T19:16:56.965674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.319263ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:16:56.96582Z","caller":"traceutil/trace.go:171","msg":"trace[120992692] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"310.041078ms","start":"2026-04-21T19:16:56.655761Z","end":"2026-04-21T19:16:56.965802Z","steps":["trace[120992692] 'process raft request' (duration: 156.50176ms)","trace[120992692] 'compare' (duration: 153.17143ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:16:56.965886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:56.655711Z","time spent":"310.146831ms","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18032,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:16:56.982463Z","caller":"traceutil/trace.go:171","msg":"trace[1175960118] linearizableReadLoop","detail":"{readStateIndex:550; appliedIndex:547; }","duration":"229.001398ms","start":"2026-04-21T19:16:56.753439Z","end":"2026-04-21T19:16:56.98244Z","steps":["trace[1175960118] 'read index received' (duration: 58.803795ms)","trace[1175960118] 'applied index is now lower than readState.Index' (duration: 170.196663ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:16:56.982476Z","caller":"traceutil/trace.go:171","msg":"trace[719769862] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"259.434117ms","start":"2026-04-21T19:16:56.723021Z","end":"2026-04-21T19:16:56.982456Z","steps":["trace[719769862] 'process raft request' (duration: 259.179672ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:56.982524Z","caller":"traceutil/trace.go:171","msg":"trace[252828333] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"249.902515ms","start":"2026-04-21T19:16:56.732616Z","end":"2026-04-21T19:16:56.982519Z","steps":["trace[252828333] 'process raft request' (duration: 249.777642ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:56.98267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.209153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:16:56.982768Z","caller":"traceutil/trace.go:171","msg":"trace[2098534224] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:532; }","duration":"229.378127ms","start":"2026-04-21T19:16:56.753366Z","end":"2026-04-21T19:16:56.982744Z","steps":["trace[2098534224] 'agreement among raft nodes before linearized reading' (duration: 229.190703ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:57.140007Z","caller":"traceutil/trace.go:171","msg":"trace[1657010219] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"112.930841ms","start":"2026-04-21T19:16:57.027052Z","end":"2026-04-21T19:16:57.139983Z","steps":["trace[1657010219] 'process raft request' (duration: 55.872163ms)","trace[1657010219] 'compare' (duration: 56.857664ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:16:57.479151Z","caller":"traceutil/trace.go:171","msg":"trace[1746062379] linearizableReadLoop","detail":"{readStateIndex:562; appliedIndex:561; }","duration":"107.006205ms","start":"2026-04-21T19:16:57.372115Z","end":"2026-04-21T19:16:57.479121Z","steps":["trace[1746062379] 'read index received' (duration: 29.844318ms)","trace[1746062379] 'applied index is now lower than readState.Index' (duration: 77.160897ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:16:57.479315Z","caller":"traceutil/trace.go:171","msg":"trace[2110734892] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"148.128462ms","start":"2026-04-21T19:16:57.331141Z","end":"2026-04-21T19:16:57.47927Z","steps":["trace[2110734892] 'process raft request' (duration: 70.912904ms)","trace[2110734892] 'compare' (duration: 76.943962ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:16:57.479399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.2596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"} {"level":"info","ts":"2026-04-21T19:16:57.479446Z","caller":"traceutil/trace.go:171","msg":"trace[161128607] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:544; }","duration":"107.372742ms","start":"2026-04-21T19:16:57.37206Z","end":"2026-04-21T19:16:57.479433Z","steps":["trace[161128607] 'agreement among raft nodes before linearized reading' (duration: 107.173608ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:57.987814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.387197ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:16:57.98793Z","caller":"traceutil/trace.go:171","msg":"trace[2032658885] linearizableReadLoop","detail":"{readStateIndex:565; appliedIndex:564; }","duration":"326.026578ms","start":"2026-04-21T19:16:57.661887Z","end":"2026-04-21T19:16:57.987914Z","steps":["trace[2032658885] 'read index received' (duration: 222.468928ms)","trace[2032658885] 'applied index is now lower than readState.Index' (duration: 103.5566ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:16:57.987997Z","caller":"traceutil/trace.go:171","msg":"trace[242975034] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"337.583925ms","start":"2026-04-21T19:16:57.650403Z","end":"2026-04-21T19:16:57.987987Z","steps":["trace[242975034] 'process raft request' (duration: 233.927172ms)","trace[242975034] 'compare' (duration: 103.088791ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:16:57.988061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:57.650368Z","time spent":"337.662697ms","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208461,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:16:57.988457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.520049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:74769"} {"level":"info","ts":"2026-04-21T19:16:57.988624Z","caller":"traceutil/trace.go:171","msg":"trace[1071434159] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:547; }","duration":"326.737064ms","start":"2026-04-21T19:16:57.661856Z","end":"2026-04-21T19:16:57.988593Z","steps":["trace[1071434159] 'agreement among raft nodes before linearized reading' (duration: 326.216303ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:57.98871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:57.661841Z","time spent":"326.855736ms","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":103,"response count":1,"response size":74792,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io\" "} {"level":"info","ts":"2026-04-21T19:16:57.995736Z","caller":"traceutil/trace.go:171","msg":"trace[1122830782] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"300.977065ms","start":"2026-04-21T19:16:57.694735Z","end":"2026-04-21T19:16:57.995712Z","steps":["trace[1122830782] 'process raft request' (duration: 300.223739ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:57.995755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.698609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:16:57.995837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:57.694712Z","time spent":"301.076987ms","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:16:57.995842Z","caller":"traceutil/trace.go:171","msg":"trace[1471313289] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:548; }","duration":"241.839042ms","start":"2026-04-21T19:16:57.753981Z","end":"2026-04-21T19:16:57.99582Z","steps":["trace[1471313289] 'agreement among raft nodes before linearized reading' (duration: 241.682869ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:58.54659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.803707ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:16:58.546718Z","caller":"traceutil/trace.go:171","msg":"trace[1749309662] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"385.155552ms","start":"2026-04-21T19:16:58.16154Z","end":"2026-04-21T19:16:58.546695Z","steps":["trace[1749309662] 'process raft request' (duration: 213.14409ms)","trace[1749309662] 'compare' (duration: 171.662484ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:16:58.546799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:58.161513Z","time spent":"385.254134ms","remote":"127.0.0.1:60610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:16:58.628216Z","caller":"traceutil/trace.go:171","msg":"trace[1514252370] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"466.615321ms","start":"2026-04-21T19:16:58.161572Z","end":"2026-04-21T19:16:58.628187Z","steps":["trace[1514252370] 'process raft request' (duration: 466.436858ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:58.628386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:58.161542Z","time spent":"466.756584ms","remote":"127.0.0.1:60610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:16:58.630167Z","caller":"traceutil/trace.go:171","msg":"trace[1020471360] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"467.754406ms","start":"2026-04-21T19:16:58.16232Z","end":"2026-04-21T19:16:58.630075Z","steps":["trace[1020471360] 'process raft request' (duration: 465.824335ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:58.630474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:58.162304Z","time spent":"468.050402ms","remote":"127.0.0.1:60610","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-21T19:16:58.63222Z","caller":"traceutil/trace.go:171","msg":"trace[2068416699] linearizableReadLoop","detail":"{readStateIndex:572; appliedIndex:568; }","duration":"354.681681ms","start":"2026-04-21T19:16:58.277481Z","end":"2026-04-21T19:16:58.632163Z","steps":["trace[2068416699] 'read index received' (duration: 97.273646ms)","trace[2068416699] 'applied index is now lower than readState.Index' (duration: 257.406385ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:16:58.632478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.995549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:15688"} {"level":"info","ts":"2026-04-21T19:16:58.632619Z","caller":"traceutil/trace.go:171","msg":"trace[1080965809] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:555; }","duration":"355.109651ms","start":"2026-04-21T19:16:58.277405Z","end":"2026-04-21T19:16:58.632514Z","steps":["trace[1080965809] 'agreement among raft nodes before linearized reading' (duration: 354.883046ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:16:58.632645Z","caller":"traceutil/trace.go:171","msg":"trace[1672927127] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"352.328221ms","start":"2026-04-21T19:16:58.28021Z","end":"2026-04-21T19:16:58.632538Z","steps":["trace[1672927127] 'process raft request' (duration: 351.837621ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:58.632701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:58.277365Z","time spent":"355.315335ms","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":1,"response size":15711,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io\" "} {"level":"info","ts":"2026-04-21T19:16:58.632676Z","caller":"traceutil/trace.go:171","msg":"trace[1111721962] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"402.520293ms","start":"2026-04-21T19:16:58.230078Z","end":"2026-04-21T19:16:58.632598Z","steps":["trace[1111721962] 'process raft request' (duration: 398.574228ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:16:58.632863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:58.280178Z","time spent":"352.564146ms","remote":"127.0.0.1:60610","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-21T19:16:58.632895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:16:58.230053Z","time spent":"402.776958ms","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208470,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:17:02.027985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.546133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:17:02.02811Z","caller":"traceutil/trace.go:171","msg":"trace[1374093702] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:573; }","duration":"142.732907ms","start":"2026-04-21T19:17:01.885353Z","end":"2026-04-21T19:17:02.028086Z","steps":["trace[1374093702] 'count revisions from in-memory index tree' (duration: 142.465061ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:02.028336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.86461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:17:02.028382Z","caller":"traceutil/trace.go:171","msg":"trace[1505229466] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:573; }","duration":"142.955582ms","start":"2026-04-21T19:17:01.885412Z","end":"2026-04-21T19:17:02.028368Z","steps":["trace[1505229466] 'range keys from in-memory index tree' (duration: 142.763378ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:02.269371Z","caller":"traceutil/trace.go:171","msg":"trace[1879255592] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"179.192115ms","start":"2026-04-21T19:17:02.090164Z","end":"2026-04-21T19:17:02.269356Z","steps":["trace[1879255592] 'process raft request' (duration: 179.096683ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:02.525053Z","caller":"traceutil/trace.go:171","msg":"trace[1059299721] linearizableReadLoop","detail":"{readStateIndex:594; appliedIndex:593; }","duration":"326.776326ms","start":"2026-04-21T19:17:02.198257Z","end":"2026-04-21T19:17:02.525033Z","steps":["trace[1059299721] 'read index received' (duration: 71.091598ms)","trace[1059299721] 'applied index is now lower than readState.Index' (duration: 255.683768ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:17:02.525178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.911168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:17:02.525233Z","caller":"traceutil/trace.go:171","msg":"trace[580741766] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:575; }","duration":"327.024651ms","start":"2026-04-21T19:17:02.198196Z","end":"2026-04-21T19:17:02.525221Z","steps":["trace[580741766] 'agreement among raft nodes before linearized reading' (duration: 326.922499ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:02.525275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:02.198163Z","time spent":"327.102253ms","remote":"127.0.0.1:43932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"info","ts":"2026-04-21T19:17:02.525114Z","caller":"traceutil/trace.go:171","msg":"trace[514193457] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"406.521048ms","start":"2026-04-21T19:17:02.118572Z","end":"2026-04-21T19:17:02.525093Z","steps":["trace[514193457] 'process raft request' (duration: 391.259242ms)","trace[514193457] 'compare' (duration: 14.877478ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:17:02.525423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:02.118552Z","time spent":"406.791453ms","remote":"127.0.0.1:60440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036225,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:17:02.525531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.807118ms","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":"warn","ts":"2026-04-21T19:17:02.525431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.114523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:17:02.525634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.538778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:17:02.52564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.722051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:17:02.525712Z","caller":"traceutil/trace.go:171","msg":"trace[261930952] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:575; }","duration":"176.62407ms","start":"2026-04-21T19:17:02.349064Z","end":"2026-04-21T19:17:02.525688Z","steps":["trace[261930952] 'agreement among raft nodes before linearized reading' (duration: 176.542578ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:02.525711Z","caller":"traceutil/trace.go:171","msg":"trace[849921050] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:575; }","duration":"327.396339ms","start":"2026-04-21T19:17:02.198252Z","end":"2026-04-21T19:17:02.525648Z","steps":["trace[849921050] 'agreement among raft nodes before linearized reading' (duration: 327.141063ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:02.525764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.447663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:17:02.525748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.672706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:17:02.525828Z","caller":"traceutil/trace.go:171","msg":"trace[1036551622] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:575; }","duration":"277.540864ms","start":"2026-04-21T19:17:02.248272Z","end":"2026-04-21T19:17:02.525813Z","steps":["trace[1036551622] 'agreement among raft nodes before linearized reading' (duration: 277.444432ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:02.525832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.538114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:17:02.52587Z","caller":"traceutil/trace.go:171","msg":"trace[425115628] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:575; }","duration":"298.903961ms","start":"2026-04-21T19:17:02.226937Z","end":"2026-04-21T19:17:02.525841Z","steps":["trace[425115628] 'agreement among raft nodes before linearized reading' (duration: 298.616815ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:02.52588Z","caller":"traceutil/trace.go:171","msg":"trace[219097551] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:575; }","duration":"276.614335ms","start":"2026-04-21T19:17:02.249254Z","end":"2026-04-21T19:17:02.525869Z","steps":["trace[219097551] 'agreement among raft nodes before linearized reading' (duration: 276.503032ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:02.525886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:02.198221Z","time spent":"327.599094ms","remote":"127.0.0.1:43932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-04-21T19:17:02.525987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.32893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:17:02.526067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.7876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:17:02.526087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.98493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:17:02.525826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.934332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:17:02.526181Z","caller":"traceutil/trace.go:171","msg":"trace[529496442] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:575; }","duration":"327.108762ms","start":"2026-04-21T19:17:02.199033Z","end":"2026-04-21T19:17:02.526142Z","steps":["trace[529496442] 'agreement among raft nodes before linearized reading' (duration: 326.98902ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:02.526215Z","caller":"traceutil/trace.go:171","msg":"trace[2000309656] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:575; }","duration":"299.457623ms","start":"2026-04-21T19:17:02.226746Z","end":"2026-04-21T19:17:02.526203Z","steps":["trace[2000309656] 'agreement among raft nodes before linearized reading' (duration: 298.947992ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:02.52623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:02.19901Z","time spent":"327.204395ms","remote":"127.0.0.1:43932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"warn","ts":"2026-04-21T19:17:02.525511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.664015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:17:02.527096Z","caller":"traceutil/trace.go:171","msg":"trace[394499330] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:575; }","duration":"255.32287ms","start":"2026-04-21T19:17:02.271751Z","end":"2026-04-21T19:17:02.527074Z","steps":["trace[394499330] 'agreement among raft nodes before linearized reading' (duration: 253.654975ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:02.526066Z","caller":"traceutil/trace.go:171","msg":"trace[1751576461] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:575; }","duration":"299.410972ms","start":"2026-04-21T19:17:02.226644Z","end":"2026-04-21T19:17:02.526055Z","steps":["trace[1751576461] 'agreement among raft nodes before linearized reading' (duration: 299.313899ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:02.527205Z","caller":"traceutil/trace.go:171","msg":"trace[1235937636] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:575; }","duration":"278.925505ms","start":"2026-04-21T19:17:02.248251Z","end":"2026-04-21T19:17:02.527176Z","steps":["trace[1235937636] 'agreement among raft nodes before linearized reading' (duration: 277.79326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:02.527227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:02.226617Z","time spent":"300.588487ms","remote":"127.0.0.1:43944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T19:17:02.526011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.46088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:17:02.525724Z","caller":"traceutil/trace.go:171","msg":"trace[130539077] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:575; }","duration":"175.843213ms","start":"2026-04-21T19:17:02.349863Z","end":"2026-04-21T19:17:02.525706Z","steps":["trace[130539077] 'agreement among raft nodes before linearized reading' (duration: 175.70192ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:02.527311Z","caller":"traceutil/trace.go:171","msg":"trace[189043124] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:575; }","duration":"254.766379ms","start":"2026-04-21T19:17:02.272523Z","end":"2026-04-21T19:17:02.527289Z","steps":["trace[189043124] 'agreement among raft nodes before linearized reading' (duration: 253.447251ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:02.525585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.384165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:17:02.525599Z","caller":"traceutil/trace.go:171","msg":"trace[819976551] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:575; }","duration":"253.88904ms","start":"2026-04-21T19:17:02.271697Z","end":"2026-04-21T19:17:02.525586Z","steps":["trace[819976551] 'agreement among raft nodes before linearized reading' (duration: 253.759977ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:02.527489Z","caller":"traceutil/trace.go:171","msg":"trace[961970432] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:575; }","duration":"178.295936ms","start":"2026-04-21T19:17:02.349157Z","end":"2026-04-21T19:17:02.527453Z","steps":["trace[961970432] 'agreement among raft nodes before linearized reading' (duration: 176.404096ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:02.750603Z","caller":"traceutil/trace.go:171","msg":"trace[1622257096] linearizableReadLoop","detail":"{readStateIndex:596; appliedIndex:594; }","duration":"105.666076ms","start":"2026-04-21T19:17:02.64492Z","end":"2026-04-21T19:17:02.750586Z","steps":["trace[1622257096] 'read index received' (duration: 72.649621ms)","trace[1622257096] 'applied index is now lower than readState.Index' (duration: 33.015574ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:02.750839Z","caller":"traceutil/trace.go:171","msg":"trace[1092967069] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"164.261466ms","start":"2026-04-21T19:17:02.586458Z","end":"2026-04-21T19:17:02.750719Z","steps":["trace[1092967069] 'process raft request' (duration: 164.083323ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:02.751203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.234867ms","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-21T19:17:02.75125Z","caller":"traceutil/trace.go:171","msg":"trace[849274818] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:577; }","duration":"106.37016ms","start":"2026-04-21T19:17:02.644868Z","end":"2026-04-21T19:17:02.751238Z","steps":["trace[849274818] 'agreement among raft nodes before linearized reading' (duration: 106.231357ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:02.751324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.119845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:17:02.751419Z","caller":"traceutil/trace.go:171","msg":"trace[798119553] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:577; }","duration":"106.31717ms","start":"2026-04-21T19:17:02.64508Z","end":"2026-04-21T19:17:02.751397Z","steps":["trace[798119553] 'agreement among raft nodes before linearized reading' (duration: 106.100775ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:02.751448Z","caller":"traceutil/trace.go:171","msg":"trace[354074312] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"187.557324ms","start":"2026-04-21T19:17:02.563844Z","end":"2026-04-21T19:17:02.751401Z","steps":["trace[354074312] 'process raft request' (duration: 153.65793ms)","trace[354074312] 'compare' (duration: 32.884882ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:17:02.751767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.920701ms","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-21T19:17:02.751834Z","caller":"traceutil/trace.go:171","msg":"trace[1672915384] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:577; }","duration":"106.027154ms","start":"2026-04-21T19:17:02.645791Z","end":"2026-04-21T19:17:02.751818Z","steps":["trace[1672915384] 'agreement among raft nodes before linearized reading' (duration: 105.903781ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:02.751828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.638286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:17:02.751907Z","caller":"traceutil/trace.go:171","msg":"trace[1478207493] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:577; }","duration":"106.748338ms","start":"2026-04-21T19:17:02.645138Z","end":"2026-04-21T19:17:02.751887Z","steps":["trace[1478207493] 'agreement among raft nodes before linearized reading' (duration: 106.629906ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:03.220965Z","caller":"traceutil/trace.go:171","msg":"trace[1033661097] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"464.301561ms","start":"2026-04-21T19:17:02.756636Z","end":"2026-04-21T19:17:03.220938Z","steps":["trace[1033661097] 'process raft request' (duration: 424.646975ms)","trace[1033661097] 'compare' (duration: 39.427561ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:17:03.221161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:02.756626Z","time spent":"464.452815ms","remote":"127.0.0.1:60610","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-21T19:17:03.252183Z","caller":"traceutil/trace.go:171","msg":"trace[1973382371] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:596; }","duration":"489.033629ms","start":"2026-04-21T19:17:02.763118Z","end":"2026-04-21T19:17:03.252152Z","steps":["trace[1973382371] 'read index received' (duration: 418.123306ms)","trace[1973382371] 'applied index is now lower than readState.Index' (duration: 70.908893ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:17:03.252408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.268337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:17:03.252389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.232133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:17:03.252472Z","caller":"traceutil/trace.go:171","msg":"trace[655871346] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:579; }","duration":"476.37715ms","start":"2026-04-21T19:17:02.776078Z","end":"2026-04-21T19:17:03.252455Z","steps":["trace[655871346] 'agreement among raft nodes before linearized reading' (duration: 476.256557ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:03.25248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.981525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:17:03.252483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.229567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:17:03.252498Z","caller":"traceutil/trace.go:171","msg":"trace[127328012] range","detail":"{range_begin:/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system; range_end:; response_count:0; response_revision:579; }","duration":"489.384257ms","start":"2026-04-21T19:17:02.763088Z","end":"2026-04-21T19:17:03.252473Z","steps":["trace[127328012] 'agreement among raft nodes before linearized reading' (duration: 489.200543ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:03.252538Z","caller":"traceutil/trace.go:171","msg":"trace[51699583] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:579; }","duration":"353.043176ms","start":"2026-04-21T19:17:02.899475Z","end":"2026-04-21T19:17:03.252519Z","steps":["trace[51699583] 'agreement among raft nodes before linearized reading' (duration: 352.980645ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:03.25255Z","caller":"traceutil/trace.go:171","msg":"trace[64044716] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:579; }","duration":"336.341259ms","start":"2026-04-21T19:17:02.916189Z","end":"2026-04-21T19:17:03.25253Z","steps":["trace[64044716] 'agreement among raft nodes before linearized reading' (duration: 336.209066ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:03.252569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:02.763077Z","time spent":"489.477029ms","remote":"127.0.0.1:60706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":28,"request content":"key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" "} {"level":"warn","ts":"2026-04-21T19:17:03.252591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:02.916175Z","time spent":"336.405401ms","remote":"127.0.0.1:44048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T19:17:03.252603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.842547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:17:03.252637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.953596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:17:03.252647Z","caller":"traceutil/trace.go:171","msg":"trace[468448044] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:579; }","duration":"370.909208ms","start":"2026-04-21T19:17:02.881726Z","end":"2026-04-21T19:17:03.252635Z","steps":["trace[468448044] 'agreement among raft nodes before linearized reading' (duration: 370.844056ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:03.252409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.965945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:17:03.252696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.222967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:17:03.252768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.549887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:17:03.252791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.217608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:17:03.252825Z","caller":"traceutil/trace.go:171","msg":"trace[2016536945] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:579; }","duration":"420.651469ms","start":"2026-04-21T19:17:02.832161Z","end":"2026-04-21T19:17:03.252812Z","steps":["trace[2016536945] 'agreement among raft nodes before linearized reading' (duration: 420.570428ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:03.252855Z","caller":"traceutil/trace.go:171","msg":"trace[1977991018] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:579; }","duration":"389.322121ms","start":"2026-04-21T19:17:02.863509Z","end":"2026-04-21T19:17:03.252832Z","steps":["trace[1977991018] 'agreement among raft nodes before linearized reading' (duration: 389.229609ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:03.252853Z","caller":"traceutil/trace.go:171","msg":"trace[425154482] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"494.063146ms","start":"2026-04-21T19:17:02.758181Z","end":"2026-04-21T19:17:03.252244Z","steps":["trace[425154482] 'process raft request' (duration: 493.804221ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:03.252831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.299986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:17:03.252896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:02.832142Z","time spent":"420.738152ms","remote":"127.0.0.1:44018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 "} {"level":"warn","ts":"2026-04-21T19:17:03.252888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.345137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:17:03.252923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:02.863502Z","time spent":"389.404982ms","remote":"127.0.0.1:44034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 "} {"level":"warn","ts":"2026-04-21T19:17:03.252537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:02.776065Z","time spent":"476.455881ms","remote":"127.0.0.1:44016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T19:17:03.252589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:02.899469Z","time spent":"353.111127ms","remote":"127.0.0.1:44046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-04-21T19:17:03.252944Z","caller":"traceutil/trace.go:171","msg":"trace[1813905649] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:579; }","duration":"371.518021ms","start":"2026-04-21T19:17:02.881406Z","end":"2026-04-21T19:17:03.252924Z","steps":["trace[1813905649] 'agreement among raft nodes before linearized reading' (duration: 371.231235ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:03.2527Z","caller":"traceutil/trace.go:171","msg":"trace[1233124799] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:579; }","duration":"421.083779ms","start":"2026-04-21T19:17:02.831603Z","end":"2026-04-21T19:17:03.252687Z","steps":["trace[1233124799] 'agreement among raft nodes before linearized reading' (duration: 421.012437ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:03.252968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.131455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:17:03.252974Z","caller":"traceutil/trace.go:171","msg":"trace[1257036187] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:579; }","duration":"371.462129ms","start":"2026-04-21T19:17:02.881488Z","end":"2026-04-21T19:17:03.25295Z","steps":["trace[1257036187] 'agreement among raft nodes before linearized reading' (duration: 371.307226ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:03.253007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:02.881393Z","time spent":"371.599292ms","remote":"127.0.0.1:44044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"info","ts":"2026-04-21T19:17:03.253016Z","caller":"traceutil/trace.go:171","msg":"trace[1166372672] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:579; }","duration":"336.195146ms","start":"2026-04-21T19:17:02.916808Z","end":"2026-04-21T19:17:03.253003Z","steps":["trace[1166372672] 'agreement among raft nodes before linearized reading' (duration: 336.130135ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:03.253015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:02.758165Z","time spent":"494.755682ms","remote":"127.0.0.1:60610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:17:03.25301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.006365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:17:03.253042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:02.881472Z","time spent":"371.552002ms","remote":"127.0.0.1:44044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"info","ts":"2026-04-21T19:17:03.252961Z","caller":"traceutil/trace.go:171","msg":"trace[1212559308] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:579; }","duration":"336.552774ms","start":"2026-04-21T19:17:02.916256Z","end":"2026-04-21T19:17:03.252809Z","steps":["trace[1212559308] 'agreement among raft nodes before linearized reading' (duration: 336.094584ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:03.253089Z","caller":"traceutil/trace.go:171","msg":"trace[1355618980] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:579; }","duration":"390.130098ms","start":"2026-04-21T19:17:02.862942Z","end":"2026-04-21T19:17:03.253072Z","steps":["trace[1355618980] 'agreement among raft nodes before linearized reading' (duration: 389.991735ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:03.253101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:02.916798Z","time spent":"336.258038ms","remote":"127.0.0.1:44046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"info","ts":"2026-04-21T19:17:03.252857Z","caller":"traceutil/trace.go:171","msg":"trace[1062847134] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:579; }","duration":"353.380784ms","start":"2026-04-21T19:17:02.899395Z","end":"2026-04-21T19:17:03.252776Z","steps":["trace[1062847134] 'agreement among raft nodes before linearized reading' (duration: 352.937284ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:03.253225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:02.916238Z","time spent":"336.923412ms","remote":"127.0.0.1:44048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-21T19:17:03.253015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:02.831569Z","time spent":"421.418386ms","remote":"127.0.0.1:44018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-21T19:17:03.25283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.15738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:17:03.253246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:02.899367Z","time spent":"353.841043ms","remote":"127.0.0.1:44046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-04-21T19:17:03.253357Z","caller":"traceutil/trace.go:171","msg":"trace[617906350] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:579; }","duration":"421.713913ms","start":"2026-04-21T19:17:02.831625Z","end":"2026-04-21T19:17:03.253339Z","steps":["trace[617906350] 'agreement among raft nodes before linearized reading' (duration: 421.11064ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:03.252662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.75849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:17:03.253433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:02.831575Z","time spent":"421.842435ms","remote":"127.0.0.1:44018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T19:17:03.252891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.676796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:17:03.253513Z","caller":"traceutil/trace.go:171","msg":"trace[1120391373] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:579; }","duration":"477.31699ms","start":"2026-04-21T19:17:02.776167Z","end":"2026-04-21T19:17:03.253484Z","steps":["trace[1120391373] 'agreement among raft nodes before linearized reading' (duration: 476.691116ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:03.253587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:02.776143Z","time spent":"477.422771ms","remote":"127.0.0.1:44016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-21T19:17:03.253146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:02.862915Z","time spent":"390.21566ms","remote":"127.0.0.1:44034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 "} {"level":"info","ts":"2026-04-21T19:17:03.253447Z","caller":"traceutil/trace.go:171","msg":"trace[229400434] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:579; }","duration":"390.604389ms","start":"2026-04-21T19:17:02.862827Z","end":"2026-04-21T19:17:03.253431Z","steps":["trace[229400434] 'agreement among raft nodes before linearized reading' (duration: 389.74828ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:03.253783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:02.862799Z","time spent":"390.968106ms","remote":"127.0.0.1:44034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-04-21T19:17:03.252689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:02.881707Z","time spent":"370.969319ms","remote":"127.0.0.1:44044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"warn","ts":"2026-04-21T19:17:04.252126Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967604076334487271,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T19:17:04.752551Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967604076334487271,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T19:17:05.0369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.227802378s","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-21T19:17:05.037077Z","caller":"traceutil/trace.go:171","msg":"trace[608404404] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:579; }","duration":"1.228002103s","start":"2026-04-21T19:17:03.80905Z","end":"2026-04-21T19:17:05.037052Z","steps":["trace[608404404] 'range keys from in-memory index tree' (duration: 1.227776848s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:05.064391Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.400513515s","expected-duration":"1s"} {"level":"info","ts":"2026-04-21T19:17:05.065829Z","caller":"traceutil/trace.go:171","msg":"trace[1798237940] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:598; }","duration":"1.314497278s","start":"2026-04-21T19:17:03.751311Z","end":"2026-04-21T19:17:05.065808Z","steps":["trace[1798237940] 'read index received' (duration: 1.313352114s)","trace[1798237940] 'applied index is now lower than readState.Index' (duration: 1.143814ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:05.065951Z","caller":"traceutil/trace.go:171","msg":"trace[268449665] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"1.403220482s","start":"2026-04-21T19:17:03.662688Z","end":"2026-04-21T19:17:05.065909Z","steps":["trace[268449665] 'process raft request' (duration: 1.402436236s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:05.066055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"792.803602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-21T19:17:05.066104Z","caller":"traceutil/trace.go:171","msg":"trace[289787403] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:580; }","duration":"792.889914ms","start":"2026-04-21T19:17:04.273205Z","end":"2026-04-21T19:17:05.066094Z","steps":["trace[289787403] 'agreement among raft nodes before linearized reading' (duration: 792.740691ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:05.066138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:04.273185Z","time spent":"792.944785ms","remote":"127.0.0.1:60610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-21T19:17:05.066149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:03.662656Z","time spent":"1.403399117s","remote":"127.0.0.1:60440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:17:05.066026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.314687693s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:17:05.066217Z","caller":"traceutil/trace.go:171","msg":"trace[727280835] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:580; }","duration":"1.314930498s","start":"2026-04-21T19:17:03.751266Z","end":"2026-04-21T19:17:05.066197Z","steps":["trace[727280835] 'agreement among raft nodes before linearized reading' (duration: 1.314658392s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:05.066248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:03.751243Z","time spent":"1.31499724s","remote":"127.0.0.1:60326","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-21T19:17:05.066242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.085355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-21T19:17:05.066325Z","caller":"traceutil/trace.go:171","msg":"trace[154290799] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:580; }","duration":"308.210158ms","start":"2026-04-21T19:17:04.758089Z","end":"2026-04-21T19:17:05.0663Z","steps":["trace[154290799] 'agreement among raft nodes before linearized reading' (duration: 307.936002ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:05.066047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.617602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:17:05.066555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:04.758067Z","time spent":"308.30055ms","remote":"127.0.0.1:60610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-21T19:17:05.066587Z","caller":"traceutil/trace.go:171","msg":"trace[812222882] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:580; }","duration":"149.210295ms","start":"2026-04-21T19:17:04.917369Z","end":"2026-04-21T19:17:05.066579Z","steps":["trace[812222882] 'agreement among raft nodes before linearized reading' (duration: 148.594642ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:07.16642Z","caller":"traceutil/trace.go:171","msg":"trace[2128517209] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"223.123273ms","start":"2026-04-21T19:17:06.943263Z","end":"2026-04-21T19:17:07.166386Z","steps":["trace[2128517209] 'process raft request' (duration: 222.915338ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:10.108709Z","caller":"traceutil/trace.go:171","msg":"trace[1161000270] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"113.377921ms","start":"2026-04-21T19:17:09.995302Z","end":"2026-04-21T19:17:10.10868Z","steps":["trace[1161000270] 'process raft request' (duration: 113.207957ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:13.378412Z","caller":"traceutil/trace.go:171","msg":"trace[939272147] linearizableReadLoop","detail":"{readStateIndex:717; appliedIndex:715; }","duration":"139.633381ms","start":"2026-04-21T19:17:13.238757Z","end":"2026-04-21T19:17:13.37839Z","steps":["trace[939272147] 'read index received' (duration: 131.423266ms)","trace[939272147] 'applied index is now lower than readState.Index' (duration: 8.208755ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:13.378482Z","caller":"traceutil/trace.go:171","msg":"trace[78701047] transaction","detail":"{read_only:false; number_of_response:0; response_revision:694; }","duration":"172.174995ms","start":"2026-04-21T19:17:13.206291Z","end":"2026-04-21T19:17:13.378466Z","steps":["trace[78701047] 'process raft request' (duration: 163.864688ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:13.378517Z","caller":"traceutil/trace.go:171","msg":"trace[1684835420] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"169.517728ms","start":"2026-04-21T19:17:13.208989Z","end":"2026-04-21T19:17:13.378507Z","steps":["trace[1684835420] 'process raft request' (duration: 169.329144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:13.378765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.971288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:1 size:1492"} {"level":"info","ts":"2026-04-21T19:17:13.378859Z","caller":"traceutil/trace.go:171","msg":"trace[152216419] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:1; response_revision:695; }","duration":"140.117701ms","start":"2026-04-21T19:17:13.238721Z","end":"2026-04-21T19:17:13.378839Z","steps":["trace[152216419] 'agreement among raft nodes before linearized reading' (duration: 139.826355ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:13.537255Z","caller":"traceutil/trace.go:171","msg":"trace[1554651346] linearizableReadLoop","detail":"{readStateIndex:718; appliedIndex:717; }","duration":"158.737568ms","start":"2026-04-21T19:17:13.378481Z","end":"2026-04-21T19:17:13.537219Z","steps":["trace[1554651346] 'read index received' (duration: 126.921699ms)","trace[1554651346] 'applied index is now lower than readState.Index' (duration: 31.814709ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:13.537304Z","caller":"traceutil/trace.go:171","msg":"trace[896589656] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"296.015249ms","start":"2026-04-21T19:17:13.241259Z","end":"2026-04-21T19:17:13.537274Z","steps":["trace[896589656] 'process raft request' (duration: 264.126588ms)","trace[896589656] 'compare' (duration: 31.657546ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:17:13.537519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.513453ms","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-21T19:17:13.537557Z","caller":"traceutil/trace.go:171","msg":"trace[977499147] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:696; }","duration":"269.594505ms","start":"2026-04-21T19:17:13.267953Z","end":"2026-04-21T19:17:13.537548Z","steps":["trace[977499147] 'agreement among raft nodes before linearized reading' (duration: 269.456082ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:13.537551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.934844ms","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-21T19:17:13.53766Z","caller":"traceutil/trace.go:171","msg":"trace[1047867669] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:696; }","duration":"241.070816ms","start":"2026-04-21T19:17:13.296563Z","end":"2026-04-21T19:17:13.537634Z","steps":["trace[1047867669] 'agreement among raft nodes before linearized reading' (duration: 240.80291ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:13.537695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.482302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:1 size:1711"} {"level":"info","ts":"2026-04-21T19:17:13.537848Z","caller":"traceutil/trace.go:171","msg":"trace[935103262] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:1; response_revision:696; }","duration":"157.701186ms","start":"2026-04-21T19:17:13.380115Z","end":"2026-04-21T19:17:13.537816Z","steps":["trace[935103262] 'agreement among raft nodes before linearized reading' (duration: 157.39954ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:16.647955Z","caller":"traceutil/trace.go:171","msg":"trace[496657203] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"145.400034ms","start":"2026-04-21T19:17:16.50252Z","end":"2026-04-21T19:17:16.64792Z","steps":["trace[496657203] 'process raft request' (duration: 145.160979ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:16.789253Z","caller":"traceutil/trace.go:171","msg":"trace[2051268303] transaction","detail":"{read_only:false; response_revision:714; number_of_response:1; }","duration":"125.172752ms","start":"2026-04-21T19:17:16.664043Z","end":"2026-04-21T19:17:16.789216Z","steps":["trace[2051268303] 'process raft request' (duration: 90.450641ms)","trace[2051268303] 'compare' (duration: 34.483946ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:17.065701Z","caller":"traceutil/trace.go:171","msg":"trace[2062530227] transaction","detail":"{read_only:false; response_revision:717; number_of_response:1; }","duration":"261.472801ms","start":"2026-04-21T19:17:16.804198Z","end":"2026-04-21T19:17:17.065671Z","steps":["trace[2062530227] 'process raft request' (duration: 261.42561ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:17.065896Z","caller":"traceutil/trace.go:171","msg":"trace[1049531322] transaction","detail":"{read_only:false; response_revision:716; number_of_response:1; }","duration":"268.451531ms","start":"2026-04-21T19:17:16.797417Z","end":"2026-04-21T19:17:17.065869Z","steps":["trace[1049531322] 'process raft request' (duration: 268.093913ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:17.577909Z","caller":"traceutil/trace.go:171","msg":"trace[1416887236] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"504.796296ms","start":"2026-04-21T19:17:17.073074Z","end":"2026-04-21T19:17:17.57787Z","steps":["trace[1416887236] 'process raft request' (duration: 413.340494ms)","trace[1416887236] 'compare' (duration: 91.267648ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:17:17.578053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:17.073041Z","time spent":"504.937248ms","remote":"127.0.0.1:60514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4532,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:17:17.578176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.208845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-21T19:17:17.578233Z","caller":"traceutil/trace.go:171","msg":"trace[707235811] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:718; }","duration":"357.307687ms","start":"2026-04-21T19:17:17.220912Z","end":"2026-04-21T19:17:17.57822Z","steps":["trace[707235811] 'agreement among raft nodes before linearized reading' (duration: 357.070262ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:17.578273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:17.22089Z","time spent":"357.369578ms","remote":"127.0.0.1:60610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-21T19:17:17.578127Z","caller":"traceutil/trace.go:171","msg":"trace[4352555] linearizableReadLoop","detail":"{readStateIndex:741; appliedIndex:740; }","duration":"356.888739ms","start":"2026-04-21T19:17:17.220965Z","end":"2026-04-21T19:17:17.577854Z","steps":["trace[4352555] 'read index received' (duration: 265.484998ms)","trace[4352555] 'applied index is now lower than readState.Index' (duration: 91.402141ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:17:17.578505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.082441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-21T19:17:17.578559Z","caller":"traceutil/trace.go:171","msg":"trace[947396595] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:718; }","duration":"163.172143ms","start":"2026-04-21T19:17:17.415371Z","end":"2026-04-21T19:17:17.578543Z","steps":["trace[947396595] 'agreement among raft nodes before linearized reading' (duration: 163.01462ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:20.137638Z","caller":"traceutil/trace.go:171","msg":"trace[2059626255] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"139.799944ms","start":"2026-04-21T19:17:19.997814Z","end":"2026-04-21T19:17:20.137614Z","steps":["trace[2059626255] 'process raft request' (duration: 132.181532ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:20.137849Z","caller":"traceutil/trace.go:171","msg":"trace[760741279] transaction","detail":"{read_only:false; response_revision:736; number_of_response:1; }","duration":"133.813366ms","start":"2026-04-21T19:17:20.003954Z","end":"2026-04-21T19:17:20.137768Z","steps":["trace[760741279] 'process raft request' (duration: 133.597621ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:20.306018Z","caller":"traceutil/trace.go:171","msg":"trace[1012271864] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"159.631068ms","start":"2026-04-21T19:17:20.146361Z","end":"2026-04-21T19:17:20.305992Z","steps":["trace[1012271864] 'process raft request' (duration: 159.559166ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:20.306019Z","caller":"traceutil/trace.go:171","msg":"trace[572837227] transaction","detail":"{read_only:false; response_revision:738; number_of_response:1; }","duration":"162.07582ms","start":"2026-04-21T19:17:20.14392Z","end":"2026-04-21T19:17:20.305996Z","steps":["trace[572837227] 'process raft request' (duration: 161.700432ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:21.081012Z","caller":"traceutil/trace.go:171","msg":"trace[633821892] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"109.689141ms","start":"2026-04-21T19:17:20.971294Z","end":"2026-04-21T19:17:21.080983Z","steps":["trace[633821892] 'process raft request' (duration: 109.466016ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:21.362587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.857219ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-21T19:17:21.832575Z","caller":"traceutil/trace.go:171","msg":"trace[1096489630] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"102.197912ms","start":"2026-04-21T19:17:21.730352Z","end":"2026-04-21T19:17:21.83255Z","steps":["trace[1096489630] 'process raft request' (duration: 65.306414ms)","trace[1096489630] 'compare' (duration: 36.715794ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:21.832926Z","caller":"traceutil/trace.go:171","msg":"trace[1374836633] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"101.824004ms","start":"2026-04-21T19:17:21.731087Z","end":"2026-04-21T19:17:21.832911Z","steps":["trace[1374836633] 'process raft request' (duration: 101.67047ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:21.832915Z","caller":"traceutil/trace.go:171","msg":"trace[575752110] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"101.916475ms","start":"2026-04-21T19:17:21.730973Z","end":"2026-04-21T19:17:21.832889Z","steps":["trace[575752110] 'process raft request' (duration: 101.517627ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:24.023955Z","caller":"traceutil/trace.go:171","msg":"trace[333918943] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"182.642078ms","start":"2026-04-21T19:17:23.841291Z","end":"2026-04-21T19:17:24.023933Z","steps":["trace[333918943] 'process raft request' (duration: 182.520366ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:24.292314Z","caller":"traceutil/trace.go:171","msg":"trace[2044987888] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"450.473906ms","start":"2026-04-21T19:17:23.841814Z","end":"2026-04-21T19:17:24.292288Z","steps":["trace[2044987888] 'process raft request' (duration: 448.180667ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:24.292488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:23.841789Z","time spent":"450.607779ms","remote":"127.0.0.1:60610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:17:24.29259Z","caller":"traceutil/trace.go:171","msg":"trace[316075028] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"450.725332ms","start":"2026-04-21T19:17:23.841838Z","end":"2026-04-21T19:17:24.292564Z","steps":["trace[316075028] 'process raft request' (duration: 450.372464ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:24.29279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:23.841804Z","time spent":"450.879415ms","remote":"127.0.0.1:60610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:17:25.280645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.283786ms","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-21T19:17:25.280762Z","caller":"traceutil/trace.go:171","msg":"trace[281166262] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:750; }","duration":"126.44198ms","start":"2026-04-21T19:17:25.154295Z","end":"2026-04-21T19:17:25.280737Z","steps":["trace[281166262] 'range keys from in-memory index tree' (duration: 126.112602ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:25.281317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.447161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:17:25.281427Z","caller":"traceutil/trace.go:171","msg":"trace[1335555176] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:750; }","duration":"528.635235ms","start":"2026-04-21T19:17:24.752772Z","end":"2026-04-21T19:17:25.281408Z","steps":["trace[1335555176] 'range keys from in-memory index tree' (duration: 528.340489ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:25.281498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:24.752748Z","time spent":"528.739377ms","remote":"127.0.0.1:60326","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-21T19:17:25.630511Z","caller":"traceutil/trace.go:171","msg":"trace[1473099490] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"344.955084ms","start":"2026-04-21T19:17:25.285531Z","end":"2026-04-21T19:17:25.630486Z","steps":["trace[1473099490] 'process raft request' (duration: 344.78573ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:25.630723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:25.285506Z","time spent":"345.104307ms","remote":"127.0.0.1:60610","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-21T19:17:29.677063Z","caller":"traceutil/trace.go:171","msg":"trace[217145513] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"144.600416ms","start":"2026-04-21T19:17:29.532425Z","end":"2026-04-21T19:17:29.677025Z","steps":["trace[217145513] 'process raft request' (duration: 105.363339ms)","trace[217145513] 'compare' (duration: 39.051604ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:17:30.8942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.196071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:17:30.894346Z","caller":"traceutil/trace.go:171","msg":"trace[172859355] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:777; }","duration":"139.446456ms","start":"2026-04-21T19:17:30.75487Z","end":"2026-04-21T19:17:30.894317Z","steps":["trace[172859355] 'range keys from in-memory index tree' (duration: 138.984207ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:32.003779Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967604076334487673,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T19:17:32.331997Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.380218502s","expected-duration":"1s"} {"level":"info","ts":"2026-04-21T19:17:32.332542Z","caller":"traceutil/trace.go:171","msg":"trace[854753231] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"1.380957869s","start":"2026-04-21T19:17:30.951556Z","end":"2026-04-21T19:17:32.332514Z","steps":["trace[854753231] 'process raft request' (duration: 1.380700233s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:32.332758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:30.951522Z","time spent":"1.381123332s","remote":"127.0.0.1:60522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4024,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:17:32.365264Z","caller":"traceutil/trace.go:171","msg":"trace[1118155888] linearizableReadLoop","detail":"{readStateIndex:805; appliedIndex:803; }","duration":"861.992791ms","start":"2026-04-21T19:17:31.503234Z","end":"2026-04-21T19:17:32.365227Z","steps":["trace[1118155888] 'read index received' (duration: 829.045938ms)","trace[1118155888] 'applied index is now lower than readState.Index' (duration: 32.944623ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:17:32.365476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"862.207206ms","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-21T19:17:32.365557Z","caller":"traceutil/trace.go:171","msg":"trace[25993019] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:778; }","duration":"862.370809ms","start":"2026-04-21T19:17:31.50317Z","end":"2026-04-21T19:17:32.365541Z","steps":["trace[25993019] 'agreement among raft nodes before linearized reading' (duration: 862.188145ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:32.365599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:31.503143Z","time spent":"862.44826ms","remote":"127.0.0.1:60778","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":"warn","ts":"2026-04-21T19:17:32.365701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.49495ms","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-21T19:17:32.365786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.791033ms","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-21T19:17:32.365826Z","caller":"traceutil/trace.go:171","msg":"trace[1231136392] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:778; }","duration":"661.710985ms","start":"2026-04-21T19:17:31.704086Z","end":"2026-04-21T19:17:32.365797Z","steps":["trace[1231136392] 'agreement among raft nodes before linearized reading' (duration: 661.363388ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:32.36571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.500101ms","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":"warn","ts":"2026-04-21T19:17:32.365882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:31.704057Z","time spent":"661.813897ms","remote":"127.0.0.1:60610","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-21T19:17:32.365629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.89986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-21T19:17:32.365864Z","caller":"traceutil/trace.go:171","msg":"trace[1056625946] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:778; }","duration":"406.900275ms","start":"2026-04-21T19:17:31.958942Z","end":"2026-04-21T19:17:32.365842Z","steps":["trace[1056625946] 'agreement among raft nodes before linearized reading' (duration: 406.738992ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:32.366008Z","caller":"traceutil/trace.go:171","msg":"trace[1139625844] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:778; }","duration":"165.288268ms","start":"2026-04-21T19:17:32.200675Z","end":"2026-04-21T19:17:32.365963Z","steps":["trace[1139625844] 'agreement among raft nodes before linearized reading' (duration: 164.804068ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:32.365971Z","caller":"traceutil/trace.go:171","msg":"trace[14756132] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:778; }","duration":"208.807107ms","start":"2026-04-21T19:17:32.157115Z","end":"2026-04-21T19:17:32.365922Z","steps":["trace[14756132] 'agreement among raft nodes before linearized reading' (duration: 208.47676ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:32.366005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:31.958918Z","time spent":"407.07163ms","remote":"127.0.0.1:60610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-21T19:17:37.54623Z","caller":"traceutil/trace.go:171","msg":"trace[1616489200] transaction","detail":"{read_only:false; response_revision:835; number_of_response:1; }","duration":"169.804155ms","start":"2026-04-21T19:17:37.376369Z","end":"2026-04-21T19:17:37.546173Z","steps":["trace[1616489200] 'process raft request' (duration: 119.868179ms)","trace[1616489200] 'compare' (duration: 49.174049ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:37.546987Z","caller":"traceutil/trace.go:171","msg":"trace[2033019355] linearizableReadLoop","detail":"{readStateIndex:864; appliedIndex:862; }","duration":"155.172773ms","start":"2026-04-21T19:17:37.39179Z","end":"2026-04-21T19:17:37.546962Z","steps":["trace[2033019355] 'read index received' (duration: 104.47657ms)","trace[2033019355] 'applied index is now lower than readState.Index' (duration: 50.694213ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:37.547044Z","caller":"traceutil/trace.go:171","msg":"trace[1414599679] transaction","detail":"{read_only:false; response_revision:836; number_of_response:1; }","duration":"160.538027ms","start":"2026-04-21T19:17:37.386461Z","end":"2026-04-21T19:17:37.546999Z","steps":["trace[1414599679] 'process raft request' (duration: 160.385674ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:37.547423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.592661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/\" range_end:\"/registry/serviceaccounts/envoy-gateway-system0\" limit:10000 ","response":"range_response_count:3 size:1862"} {"level":"info","ts":"2026-04-21T19:17:37.547495Z","caller":"traceutil/trace.go:171","msg":"trace[99289565] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/; range_end:/registry/serviceaccounts/envoy-gateway-system0; response_count:3; response_revision:836; }","duration":"155.719604ms","start":"2026-04-21T19:17:37.391753Z","end":"2026-04-21T19:17:37.547473Z","steps":["trace[99289565] 'agreement among raft nodes before linearized reading' (duration: 155.290415ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:39.906091Z","caller":"traceutil/trace.go:171","msg":"trace[589504137] transaction","detail":"{read_only:false; response_revision:850; number_of_response:1; }","duration":"109.474428ms","start":"2026-04-21T19:17:39.796572Z","end":"2026-04-21T19:17:39.906046Z","steps":["trace[589504137] 'process raft request' (duration: 81.864072ms)","trace[589504137] 'compare' (duration: 27.392611ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:39.915571Z","caller":"traceutil/trace.go:171","msg":"trace[1581077161] transaction","detail":"{read_only:false; response_revision:851; number_of_response:1; }","duration":"118.317365ms","start":"2026-04-21T19:17:39.797229Z","end":"2026-04-21T19:17:39.915546Z","steps":["trace[1581077161] 'process raft request' (duration: 118.127321ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:39.915781Z","caller":"traceutil/trace.go:171","msg":"trace[333358102] transaction","detail":"{read_only:false; response_revision:852; number_of_response:1; }","duration":"117.039485ms","start":"2026-04-21T19:17:39.798694Z","end":"2026-04-21T19:17:39.915733Z","steps":["trace[333358102] 'process raft request' (duration: 116.778679ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:48.682438Z","caller":"traceutil/trace.go:171","msg":"trace[2126034388] linearizableReadLoop","detail":"{readStateIndex:981; appliedIndex:977; }","duration":"118.899888ms","start":"2026-04-21T19:17:48.563521Z","end":"2026-04-21T19:17:48.682421Z","steps":["trace[2126034388] 'read index received' (duration: 78.521205ms)","trace[2126034388] 'applied index is now lower than readState.Index' (duration: 40.377183ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:48.682397Z","caller":"traceutil/trace.go:171","msg":"trace[641443716] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"120.817022ms","start":"2026-04-21T19:17:48.56154Z","end":"2026-04-21T19:17:48.682357Z","steps":["trace[641443716] 'process raft request' (duration: 120.523006ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:48.682498Z","caller":"traceutil/trace.go:171","msg":"trace[1901400028] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"120.540437ms","start":"2026-04-21T19:17:48.561947Z","end":"2026-04-21T19:17:48.682488Z","steps":["trace[1901400028] 'process raft request' (duration: 120.289841ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:48.682704Z","caller":"traceutil/trace.go:171","msg":"trace[1421106229] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"120.249679ms","start":"2026-04-21T19:17:48.562398Z","end":"2026-04-21T19:17:48.682648Z","steps":["trace[1421106229] 'process raft request' (duration: 119.912341ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:48.682798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.244876ms","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-21T19:17:48.682847Z","caller":"traceutil/trace.go:171","msg":"trace[1814317113] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:951; }","duration":"119.358639ms","start":"2026-04-21T19:17:48.563476Z","end":"2026-04-21T19:17:48.682835Z","steps":["trace[1814317113] 'agreement among raft nodes before linearized reading' (duration: 119.166724ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:49.231028Z","caller":"traceutil/trace.go:171","msg":"trace[1344148407] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"190.300537ms","start":"2026-04-21T19:17:49.040702Z","end":"2026-04-21T19:17:49.231002Z","steps":["trace[1344148407] 'process raft request' (duration: 190.136183ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:49.804116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.560369ms","expected-duration":"100ms","prefix":"","request":"header: txn: success: > failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-21T19:17:49.804253Z","caller":"traceutil/trace.go:171","msg":"trace[665427578] transaction","detail":"{read_only:false; number_of_response:1; response_revision:954; }","duration":"570.713926ms","start":"2026-04-21T19:17:49.233518Z","end":"2026-04-21T19:17:49.804232Z","steps":["trace[665427578] 'process raft request' (duration: 377.799438ms)","trace[665427578] 'compare' (duration: 192.413336ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:17:49.804328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:49.233495Z","time spent":"570.796197ms","remote":"127.0.0.1:60522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":55,"response count":0,"response size":41,"request content":"compare: success: > failure: >"} {"level":"info","ts":"2026-04-21T19:17:49.815927Z","caller":"traceutil/trace.go:171","msg":"trace[1604986817] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"236.891425ms","start":"2026-04-21T19:17:49.579004Z","end":"2026-04-21T19:17:49.815895Z","steps":["trace[1604986817] 'process raft request' (duration: 236.700251ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:49.87914Z","caller":"traceutil/trace.go:171","msg":"trace[778508489] linearizableReadLoop","detail":"{readStateIndex:986; appliedIndex:984; }","duration":"123.974147ms","start":"2026-04-21T19:17:49.755142Z","end":"2026-04-21T19:17:49.879117Z","steps":["trace[778508489] 'read index received' (duration: 60.690418ms)","trace[778508489] 'applied index is now lower than readState.Index' (duration: 63.282859ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:17:49.879261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.105001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:17:49.87929Z","caller":"traceutil/trace.go:171","msg":"trace[2107304316] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:956; }","duration":"124.185092ms","start":"2026-04-21T19:17:49.755093Z","end":"2026-04-21T19:17:49.879278Z","steps":["trace[2107304316] 'agreement among raft nodes before linearized reading' (duration: 124.10931ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:49.87929Z","caller":"traceutil/trace.go:171","msg":"trace[1466649137] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"146.099864ms","start":"2026-04-21T19:17:49.733145Z","end":"2026-04-21T19:17:49.879245Z","steps":["trace[1466649137] 'process raft request' (duration: 145.836878ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:50.720995Z","caller":"traceutil/trace.go:171","msg":"trace[854912375] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"104.881951ms","start":"2026-04-21T19:17:50.61603Z","end":"2026-04-21T19:17:50.720912Z","steps":["trace[854912375] 'process raft request' (duration: 90.182528ms)","trace[854912375] 'compare' (duration: 14.335514ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:51.343776Z","caller":"traceutil/trace.go:171","msg":"trace[1337849964] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"111.519176ms","start":"2026-04-21T19:17:51.232212Z","end":"2026-04-21T19:17:51.343731Z","steps":["trace[1337849964] 'process raft request' (duration: 63.707389ms)","trace[1337849964] 'compare' (duration: 47.50902ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:51.497691Z","caller":"traceutil/trace.go:171","msg":"trace[505469985] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"134.531942ms","start":"2026-04-21T19:17:51.363114Z","end":"2026-04-21T19:17:51.497646Z","steps":["trace[505469985] 'process raft request' (duration: 130.488028ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:51.730915Z","caller":"traceutil/trace.go:171","msg":"trace[1054319883] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"121.900448ms","start":"2026-04-21T19:17:51.608913Z","end":"2026-04-21T19:17:51.730814Z","steps":["trace[1054319883] 'process raft request' (duration: 121.321485ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:52.074123Z","caller":"traceutil/trace.go:171","msg":"trace[563305211] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"125.970623ms","start":"2026-04-21T19:17:51.948125Z","end":"2026-04-21T19:17:52.074095Z","steps":["trace[563305211] 'process raft request' (duration: 124.869588ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:52.074603Z","caller":"traceutil/trace.go:171","msg":"trace[956555921] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"123.405924ms","start":"2026-04-21T19:17:51.951181Z","end":"2026-04-21T19:17:52.074587Z","steps":["trace[956555921] 'process raft request' (duration: 123.167678ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:52.923968Z","caller":"traceutil/trace.go:171","msg":"trace[1188132299] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"161.33535ms","start":"2026-04-21T19:17:52.762594Z","end":"2026-04-21T19:17:52.923929Z","steps":["trace[1188132299] 'process raft request' (duration: 161.236098ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:52.924318Z","caller":"traceutil/trace.go:171","msg":"trace[511687112] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"160.942041ms","start":"2026-04-21T19:17:52.76335Z","end":"2026-04-21T19:17:52.924292Z","steps":["trace[511687112] 'process raft request' (duration: 160.529491ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:52.924415Z","caller":"traceutil/trace.go:171","msg":"trace[706634007] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"160.089501ms","start":"2026-04-21T19:17:52.76429Z","end":"2026-04-21T19:17:52.924379Z","steps":["trace[706634007] 'process raft request' (duration: 159.922377ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:52.924086Z","caller":"traceutil/trace.go:171","msg":"trace[891284275] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"161.736079ms","start":"2026-04-21T19:17:52.762289Z","end":"2026-04-21T19:17:52.924025Z","steps":["trace[891284275] 'process raft request' (duration: 161.359451ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:53.916845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.435641ms","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-21T19:17:53.917027Z","caller":"traceutil/trace.go:171","msg":"trace[1657109704] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1104; }","duration":"107.665286ms","start":"2026-04-21T19:17:53.809335Z","end":"2026-04-21T19:17:53.917Z","steps":["trace[1657109704] 'range keys from in-memory index tree' (duration: 107.40293ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:54.973879Z","caller":"traceutil/trace.go:171","msg":"trace[431167354] transaction","detail":"{read_only:false; response_revision:1109; number_of_response:1; }","duration":"100.467477ms","start":"2026-04-21T19:17:54.873356Z","end":"2026-04-21T19:17:54.973823Z","steps":["trace[431167354] 'process raft request' (duration: 61.092458ms)","trace[431167354] 'compare' (duration: 39.099082ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:56.147145Z","caller":"traceutil/trace.go:171","msg":"trace[373670727] transaction","detail":"{read_only:false; response_revision:1115; number_of_response:1; }","duration":"138.164448ms","start":"2026-04-21T19:17:56.008952Z","end":"2026-04-21T19:17:56.147117Z","steps":["trace[373670727] 'process raft request' (duration: 137.979934ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:56.182341Z","caller":"traceutil/trace.go:171","msg":"trace[301676284] transaction","detail":"{read_only:false; response_revision:1116; number_of_response:1; }","duration":"160.164462ms","start":"2026-04-21T19:17:56.022148Z","end":"2026-04-21T19:17:56.182313Z","steps":["trace[301676284] 'process raft request' (duration: 159.995258ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:57.132412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.724697ms","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-21T19:17:57.132535Z","caller":"traceutil/trace.go:171","msg":"trace[546750720] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1117; }","duration":"101.912281ms","start":"2026-04-21T19:17:57.030601Z","end":"2026-04-21T19:17:57.132513Z","steps":["trace[546750720] 'range keys from in-memory index tree' (duration: 101.570213ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:57.408879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.439623ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:17:57.409155Z","caller":"traceutil/trace.go:171","msg":"trace[1057637051] transaction","detail":"{read_only:false; response_revision:1121; number_of_response:1; }","duration":"271.310629ms","start":"2026-04-21T19:17:57.137822Z","end":"2026-04-21T19:17:57.409132Z","steps":["trace[1057637051] 'process raft request' (duration: 271.257218ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:57.409272Z","caller":"traceutil/trace.go:171","msg":"trace[667162464] transaction","detail":"{read_only:false; response_revision:1120; number_of_response:1; }","duration":"271.74731ms","start":"2026-04-21T19:17:57.13748Z","end":"2026-04-21T19:17:57.409228Z","steps":["trace[667162464] 'process raft request' (duration: 271.543525ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:57.409239Z","caller":"traceutil/trace.go:171","msg":"trace[426186736] transaction","detail":"{read_only:false; response_revision:1119; number_of_response:1; }","duration":"271.777281ms","start":"2026-04-21T19:17:57.137411Z","end":"2026-04-21T19:17:57.409188Z","steps":["trace[426186736] 'process raft request' (duration: 168.904777ms)","trace[426186736] 'compare' (duration: 102.252669ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:03.6288Z","caller":"traceutil/trace.go:171","msg":"trace[752550428] transaction","detail":"{read_only:false; response_revision:1153; number_of_response:1; }","duration":"145.857268ms","start":"2026-04-21T19:18:03.482903Z","end":"2026-04-21T19:18:03.62876Z","steps":["trace[752550428] 'process raft request' (duration: 145.572402ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:03.629071Z","caller":"traceutil/trace.go:171","msg":"trace[1210486603] transaction","detail":"{read_only:false; response_revision:1154; number_of_response:1; }","duration":"145.620663ms","start":"2026-04-21T19:18:03.483419Z","end":"2026-04-21T19:18:03.629039Z","steps":["trace[1210486603] 'process raft request' (duration: 145.283095ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:03.629403Z","caller":"traceutil/trace.go:171","msg":"trace[19362686] transaction","detail":"{read_only:false; response_revision:1155; number_of_response:1; }","duration":"144.889905ms","start":"2026-04-21T19:18:03.484481Z","end":"2026-04-21T19:18:03.62937Z","steps":["trace[19362686] 'process raft request' (duration: 144.462895ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:03.629919Z","caller":"traceutil/trace.go:171","msg":"trace[1308072827] linearizableReadLoop","detail":"{readStateIndex:1189; appliedIndex:1184; }","duration":"139.678594ms","start":"2026-04-21T19:18:03.490215Z","end":"2026-04-21T19:18:03.629893Z","steps":["trace[1308072827] 'read index received' (duration: 37.768532ms)","trace[1308072827] 'applied index is now lower than readState.Index' (duration: 101.908682ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:03.630093Z","caller":"traceutil/trace.go:171","msg":"trace[1277748700] transaction","detail":"{read_only:false; response_revision:1156; number_of_response:1; }","duration":"145.032039ms","start":"2026-04-21T19:18:03.485041Z","end":"2026-04-21T19:18:03.630073Z","steps":["trace[1277748700] 'process raft request' (duration: 144.132128ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:03.630231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.658982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:18:03.63029Z","caller":"traceutil/trace.go:171","msg":"trace[2003179843] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:1156; }","duration":"118.775216ms","start":"2026-04-21T19:18:03.511497Z","end":"2026-04-21T19:18:03.630272Z","steps":["trace[2003179843] 'agreement among raft nodes before linearized reading' (duration: 118.658103ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:03.630329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.96784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:18:03.630509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.290159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:18:03.630493Z","caller":"traceutil/trace.go:171","msg":"trace[409507889] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:1156; }","duration":"140.169745ms","start":"2026-04-21T19:18:03.490257Z","end":"2026-04-21T19:18:03.630427Z","steps":["trace[409507889] 'agreement among raft nodes before linearized reading' (duration: 139.829367ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:03.630554Z","caller":"traceutil/trace.go:171","msg":"trace[1061229064] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:1156; }","duration":"140.36329ms","start":"2026-04-21T19:18:03.49018Z","end":"2026-04-21T19:18:03.630544Z","steps":["trace[1061229064] 'agreement among raft nodes before linearized reading' (duration: 140.286388ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:03.63073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.673454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:18:03.630772Z","caller":"traceutil/trace.go:171","msg":"trace[1996456094] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:1156; }","duration":"139.718975ms","start":"2026-04-21T19:18:03.491042Z","end":"2026-04-21T19:18:03.630761Z","steps":["trace[1996456094] 'agreement among raft nodes before linearized reading' (duration: 139.651523ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:03.63076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.215676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:18:03.630857Z","caller":"traceutil/trace.go:171","msg":"trace[1113327409] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:1156; }","duration":"119.378ms","start":"2026-04-21T19:18:03.511459Z","end":"2026-04-21T19:18:03.630837Z","steps":["trace[1113327409] 'agreement among raft nodes before linearized reading' (duration: 119.204576ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:03.630848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.092983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:18:03.630981Z","caller":"traceutil/trace.go:171","msg":"trace[1147123862] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:1156; }","duration":"119.295528ms","start":"2026-04-21T19:18:03.511665Z","end":"2026-04-21T19:18:03.630961Z","steps":["trace[1147123862] 'agreement among raft nodes before linearized reading' (duration: 119.074392ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:10.536001Z","caller":"traceutil/trace.go:171","msg":"trace[294424971] linearizableReadLoop","detail":"{readStateIndex:1235; appliedIndex:1234; }","duration":"137.999394ms","start":"2026-04-21T19:18:10.397978Z","end":"2026-04-21T19:18:10.535978Z","steps":["trace[294424971] 'read index received' (duration: 137.857281ms)","trace[294424971] 'applied index is now lower than readState.Index' (duration: 141.163µs)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:18:10.536213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.21701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T19:18:10.536253Z","caller":"traceutil/trace.go:171","msg":"trace[889287879] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1200; }","duration":"138.320663ms","start":"2026-04-21T19:18:10.397923Z","end":"2026-04-21T19:18:10.536244Z","steps":["trace[889287879] 'agreement among raft nodes before linearized reading' (duration: 138.151719ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:10.536305Z","caller":"traceutil/trace.go:171","msg":"trace[1055644726] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"186.685592ms","start":"2026-04-21T19:18:10.349599Z","end":"2026-04-21T19:18:10.536285Z","steps":["trace[1055644726] 'process raft request' (duration: 186.233232ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:10.580662Z","caller":"traceutil/trace.go:171","msg":"trace[750693941] transaction","detail":"{read_only:false; response_revision:1201; number_of_response:1; }","duration":"107.367809ms","start":"2026-04-21T19:18:10.473254Z","end":"2026-04-21T19:18:10.580622Z","steps":["trace[750693941] 'process raft request' (duration: 107.085513ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:11.483069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.2377ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-21T19:18:11.483184Z","caller":"traceutil/trace.go:171","msg":"trace[844543768] linearizableReadLoop","detail":"{readStateIndex:1237; appliedIndex:1236; }","duration":"384.396582ms","start":"2026-04-21T19:18:11.098768Z","end":"2026-04-21T19:18:11.483164Z","steps":["trace[844543768] 'read index received' (duration: 144.932686ms)","trace[844543768] 'applied index is now lower than readState.Index' (duration: 239.462176ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:18:11.483471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.697089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-21T19:18:11.483522Z","caller":"traceutil/trace.go:171","msg":"trace[1171772011] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1201; }","duration":"384.806202ms","start":"2026-04-21T19:18:11.098698Z","end":"2026-04-21T19:18:11.483505Z","steps":["trace[1171772011] 'agreement among raft nodes before linearized reading' (duration: 384.589727ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:11.483597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:11.098676Z","time spent":"384.904554ms","remote":"127.0.0.1:60610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-21T19:18:11.483577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.767247ms","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-21T19:18:11.483749Z","caller":"traceutil/trace.go:171","msg":"trace[1416776141] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1201; }","duration":"160.946381ms","start":"2026-04-21T19:18:11.322747Z","end":"2026-04-21T19:18:11.483694Z","steps":["trace[1416776141] 'agreement among raft nodes before linearized reading' (duration: 160.603863ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:12.048304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.477492ms","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-21T19:18:12.048439Z","caller":"traceutil/trace.go:171","msg":"trace[1523354594] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1203; }","duration":"339.650047ms","start":"2026-04-21T19:18:11.708759Z","end":"2026-04-21T19:18:12.04841Z","steps":["trace[1523354594] 'range keys from in-memory index tree' (duration: 339.292558ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:12.048582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.65446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-21T19:18:12.04868Z","caller":"traceutil/trace.go:171","msg":"trace[319586987] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1203; }","duration":"444.801874ms","start":"2026-04-21T19:18:11.603857Z","end":"2026-04-21T19:18:12.048659Z","steps":["trace[319586987] 'range keys from in-memory index tree' (duration: 444.457235ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:12.048686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.33467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/cert-manager/cert-manager-webhook-548949fc64-vs42v\" ","response":"range_response_count:1 size:5102"} {"level":"warn","ts":"2026-04-21T19:18:12.048755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.998922ms","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-21T19:18:12.048841Z","caller":"traceutil/trace.go:171","msg":"trace[1168393343] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1203; }","duration":"342.152205ms","start":"2026-04-21T19:18:11.706669Z","end":"2026-04-21T19:18:12.048821Z","steps":["trace[1168393343] 'range keys from in-memory index tree' (duration: 341.708765ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:12.048899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:11.706643Z","time spent":"342.245727ms","remote":"127.0.0.1:60610","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-21T19:18:12.048571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:11.708744Z","time spent":"339.80553ms","remote":"127.0.0.1:60610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-21T19:18:12.048784Z","caller":"traceutil/trace.go:171","msg":"trace[902861454] range","detail":"{range_begin:/registry/pods/cert-manager/cert-manager-webhook-548949fc64-vs42v; range_end:; response_count:1; response_revision:1203; }","duration":"455.484823ms","start":"2026-04-21T19:18:11.593275Z","end":"2026-04-21T19:18:12.048759Z","steps":["trace[902861454] 'range keys from in-memory index tree' (duration: 455.077883ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:12.048723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:11.603837Z","time spent":"444.877145ms","remote":"127.0.0.1:60610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-21T19:18:12.049291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:11.593251Z","time spent":"455.991425ms","remote":"127.0.0.1:60522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":5125,"request content":"key:\"/registry/pods/cert-manager/cert-manager-webhook-548949fc64-vs42v\" "} {"level":"warn","ts":"2026-04-21T19:18:12.048304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.370648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:18:12.049464Z","caller":"traceutil/trace.go:171","msg":"trace[135026420] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1203; }","duration":"295.601308ms","start":"2026-04-21T19:18:11.753839Z","end":"2026-04-21T19:18:12.04944Z","steps":["trace[135026420] 'range keys from in-memory index tree' (duration: 294.266216ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:12.556524Z","caller":"traceutil/trace.go:171","msg":"trace[1458187447] linearizableReadLoop","detail":"{readStateIndex:1247; appliedIndex:1246; }","duration":"315.773038ms","start":"2026-04-21T19:18:12.240724Z","end":"2026-04-21T19:18:12.556497Z","steps":["trace[1458187447] 'read index received' (duration: 313.992466ms)","trace[1458187447] 'applied index is now lower than readState.Index' (duration: 1.779452ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:12.556553Z","caller":"traceutil/trace.go:171","msg":"trace[124930015] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"349.259421ms","start":"2026-04-21T19:18:12.207249Z","end":"2026-04-21T19:18:12.556508Z","steps":["trace[124930015] 'process raft request' (duration: 347.370147ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:12.556654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.903282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:18:12.55669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:12.207206Z","time spent":"349.412835ms","remote":"127.0.0.1:60816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4999,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:18:12.556713Z","caller":"traceutil/trace.go:171","msg":"trace[92355220] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1211; }","duration":"316.031805ms","start":"2026-04-21T19:18:12.240667Z","end":"2026-04-21T19:18:12.556699Z","steps":["trace[92355220] 'agreement among raft nodes before linearized reading' (duration: 315.913082ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:12.556751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:12.24065Z","time spent":"316.090236ms","remote":"127.0.0.1:60736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "} {"level":"warn","ts":"2026-04-21T19:18:12.592411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.50993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/cert-manager/cmapichecker-cx4vv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:18:12.592534Z","caller":"traceutil/trace.go:171","msg":"trace[423408963] range","detail":"{range_begin:/registry/cert-manager.io/certificates/cert-manager/cmapichecker-cx4vv; range_end:; response_count:0; response_revision:1212; }","duration":"157.710215ms","start":"2026-04-21T19:18:12.434796Z","end":"2026-04-21T19:18:12.592507Z","steps":["trace[423408963] 'agreement among raft nodes before linearized reading' (duration: 157.434249ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:14.067588Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967604076334488487,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-21T19:18:14.409065Z","caller":"traceutil/trace.go:171","msg":"trace[1639442925] linearizableReadLoop","detail":"{readStateIndex:1249; appliedIndex:1248; }","duration":"842.431175ms","start":"2026-04-21T19:18:13.566609Z","end":"2026-04-21T19:18:14.409041Z","steps":["trace[1639442925] 'read index received' (duration: 842.22653ms)","trace[1639442925] 'applied index is now lower than readState.Index' (duration: 203.325µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:14.409137Z","caller":"traceutil/trace.go:171","msg":"trace[18233073] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"905.075258ms","start":"2026-04-21T19:18:13.50403Z","end":"2026-04-21T19:18:14.409105Z","steps":["trace[18233073] 'process raft request' (duration: 904.806502ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:14.40931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"842.67238ms","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-21T19:18:14.409308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"657.077623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:18:14.409356Z","caller":"traceutil/trace.go:171","msg":"trace[1546764385] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1213; }","duration":"842.764133ms","start":"2026-04-21T19:18:13.566579Z","end":"2026-04-21T19:18:14.409343Z","steps":["trace[1546764385] 'agreement among raft nodes before linearized reading' (duration: 842.601119ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:14.409394Z","caller":"traceutil/trace.go:171","msg":"trace[1720077984] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1213; }","duration":"657.208187ms","start":"2026-04-21T19:18:13.752161Z","end":"2026-04-21T19:18:14.40937Z","steps":["trace[1720077984] 'agreement among raft nodes before linearized reading' (duration: 657.066803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:14.40942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:13.566566Z","time spent":"842.837304ms","remote":"127.0.0.1:60610","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-21T19:18:14.409407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.909191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-21T19:18:14.409453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:13.752127Z","time spent":"657.313289ms","remote":"127.0.0.1:60326","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-21T19:18:14.409495Z","caller":"traceutil/trace.go:171","msg":"trace[1061068566] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1213; }","duration":"304.036384ms","start":"2026-04-21T19:18:14.105436Z","end":"2026-04-21T19:18:14.409473Z","steps":["trace[1061068566] 'agreement among raft nodes before linearized reading' (duration: 303.811659ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:14.409545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:14.105404Z","time spent":"304.129966ms","remote":"127.0.0.1:60610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-21T19:18:14.409534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.091096ms","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-21T19:18:14.4096Z","caller":"traceutil/trace.go:171","msg":"trace[723277835] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1213; }","duration":"304.190848ms","start":"2026-04-21T19:18:14.105392Z","end":"2026-04-21T19:18:14.409583Z","steps":["trace[723277835] 'agreement among raft nodes before linearized reading' (duration: 303.944212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:14.409586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:13.504001Z","time spent":"905.207232ms","remote":"127.0.0.1:60610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:18:14.409652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:14.105373Z","time spent":"304.26679ms","remote":"127.0.0.1:60610","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-21T19:18:14.409819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.889282ms","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-21T19:18:14.409934Z","caller":"traceutil/trace.go:171","msg":"trace[1048672765] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1213; }","duration":"331.073636ms","start":"2026-04-21T19:18:14.078834Z","end":"2026-04-21T19:18:14.409908Z","steps":["trace[1048672765] 'agreement among raft nodes before linearized reading' (duration: 330.671317ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:14.410019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:14.078818Z","time spent":"331.166289ms","remote":"127.0.0.1:60610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-21T19:18:14.663558Z","caller":"traceutil/trace.go:171","msg":"trace[1200203853] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"248.872865ms","start":"2026-04-21T19:18:14.414655Z","end":"2026-04-21T19:18:14.663528Z","steps":["trace[1200203853] 'process raft request' (duration: 227.398464ms)","trace[1200203853] 'compare' (duration: 21.123863ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:14.665211Z","caller":"traceutil/trace.go:171","msg":"trace[77184313] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"250.415221ms","start":"2026-04-21T19:18:14.414769Z","end":"2026-04-21T19:18:14.665184Z","steps":["trace[77184313] 'process raft request' (duration: 250.209606ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:14.665416Z","caller":"traceutil/trace.go:171","msg":"trace[649176243] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"250.535084ms","start":"2026-04-21T19:18:14.41485Z","end":"2026-04-21T19:18:14.665385Z","steps":["trace[649176243] 'process raft request' (duration: 250.223666ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:14.665809Z","caller":"traceutil/trace.go:171","msg":"trace[694899634] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"250.617486ms","start":"2026-04-21T19:18:14.415172Z","end":"2026-04-21T19:18:14.66579Z","steps":["trace[694899634] 'process raft request' (duration: 250.402801ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:16.330456Z","caller":"traceutil/trace.go:171","msg":"trace[116462179] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"144.836654ms","start":"2026-04-21T19:18:16.185589Z","end":"2026-04-21T19:18:16.330425Z","steps":["trace[116462179] 'process raft request' (duration: 144.66882ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:16.945124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.358372ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:18:16.945231Z","caller":"traceutil/trace.go:171","msg":"trace[1695425978] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"273.799848ms","start":"2026-04-21T19:18:16.671411Z","end":"2026-04-21T19:18:16.945211Z","steps":["trace[1695425978] 'process raft request' (duration: 73.266952ms)","trace[1695425978] 'compare' (duration: 200.240009ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:16.968037Z","caller":"traceutil/trace.go:171","msg":"trace[1337543614] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"296.366425ms","start":"2026-04-21T19:18:16.671641Z","end":"2026-04-21T19:18:16.968007Z","steps":["trace[1337543614] 'process raft request' (duration: 296.117539ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:16.968035Z","caller":"traceutil/trace.go:171","msg":"trace[1263310783] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"294.940342ms","start":"2026-04-21T19:18:16.673064Z","end":"2026-04-21T19:18:16.968005Z","steps":["trace[1263310783] 'process raft request' (duration: 294.838309ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:16.968363Z","caller":"traceutil/trace.go:171","msg":"trace[339812131] linearizableReadLoop","detail":"{readStateIndex:1267; appliedIndex:1263; }","duration":"214.260286ms","start":"2026-04-21T19:18:16.754082Z","end":"2026-04-21T19:18:16.968342Z","steps":["trace[339812131] 'read index received' (duration: 213.701093ms)","trace[339812131] 'applied index is now lower than readState.Index' (duration: 557.943µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:16.968434Z","caller":"traceutil/trace.go:171","msg":"trace[1861911170] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"293.898047ms","start":"2026-04-21T19:18:16.674488Z","end":"2026-04-21T19:18:16.968386Z","steps":["trace[1861911170] 'process raft request' (duration: 293.721353ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:16.968537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.43875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:18:16.968595Z","caller":"traceutil/trace.go:171","msg":"trace[467253159] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1230; }","duration":"214.544903ms","start":"2026-04-21T19:18:16.754035Z","end":"2026-04-21T19:18:16.96858Z","steps":["trace[467253159] 'agreement among raft nodes before linearized reading' (duration: 214.43747ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:16.968946Z","caller":"traceutil/trace.go:171","msg":"trace[1056104752] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"295.72617ms","start":"2026-04-21T19:18:16.67319Z","end":"2026-04-21T19:18:16.968916Z","steps":["trace[1056104752] 'process raft request' (duration: 294.766797ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:17.461525Z","caller":"traceutil/trace.go:171","msg":"trace[824761934] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"122.955563ms","start":"2026-04-21T19:18:17.338538Z","end":"2026-04-21T19:18:17.461493Z","steps":["trace[824761934] 'process raft request' (duration: 122.738857ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:17.655149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.238176ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:18:17.655297Z","caller":"traceutil/trace.go:171","msg":"trace[1344795261] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"185.489404ms","start":"2026-04-21T19:18:17.469779Z","end":"2026-04-21T19:18:17.655268Z","steps":["trace[1344795261] 'process raft request' (duration: 84.009733ms)","trace[1344795261] 'compare' (duration: 100.915278ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:17.791962Z","caller":"traceutil/trace.go:171","msg":"trace[1540452890] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"129.106137ms","start":"2026-04-21T19:18:17.662755Z","end":"2026-04-21T19:18:17.791861Z","steps":["trace[1540452890] 'process raft request' (duration: 118.484239ms)","trace[1540452890] 'compare' (duration: 10.437054ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:18.117693Z","caller":"traceutil/trace.go:171","msg":"trace[1836935476] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"204.475048ms","start":"2026-04-21T19:18:17.913172Z","end":"2026-04-21T19:18:18.117647Z","steps":["trace[1836935476] 'process raft request' (duration: 130.487549ms)","trace[1836935476] 'compare' (duration: 73.811145ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:18.122042Z","caller":"traceutil/trace.go:171","msg":"trace[1940475591] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"136.856648ms","start":"2026-04-21T19:18:17.985155Z","end":"2026-04-21T19:18:18.122012Z","steps":["trace[1940475591] 'process raft request' (duration: 136.416408ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:19.256833Z","caller":"traceutil/trace.go:171","msg":"trace[700515312] linearizableReadLoop","detail":"{readStateIndex:1283; appliedIndex:1282; }","duration":"280.714269ms","start":"2026-04-21T19:18:18.976088Z","end":"2026-04-21T19:18:19.256802Z","steps":["trace[700515312] 'read index received' (duration: 272.573129ms)","trace[700515312] 'applied index is now lower than readState.Index' (duration: 8.13939ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:19.256995Z","caller":"traceutil/trace.go:171","msg":"trace[1072121717] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"282.92205ms","start":"2026-04-21T19:18:18.974056Z","end":"2026-04-21T19:18:19.256978Z","steps":["trace[1072121717] 'process raft request' (duration: 274.463093ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:19.25706Z","caller":"traceutil/trace.go:171","msg":"trace[2025129022] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"280.422173ms","start":"2026-04-21T19:18:18.976609Z","end":"2026-04-21T19:18:19.257031Z","steps":["trace[2025129022] 'process raft request' (duration: 280.286379ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:19.2572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.295734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/self-signed\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:18:19.257232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.068547ms","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-21T19:18:19.257289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.513838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T19:18:19.257329Z","caller":"traceutil/trace.go:171","msg":"trace[1884314907] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1246; }","duration":"281.220581ms","start":"2026-04-21T19:18:18.976085Z","end":"2026-04-21T19:18:19.257305Z","steps":["trace[1884314907] 'agreement among raft nodes before linearized reading' (duration: 280.938294ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:19.257365Z","caller":"traceutil/trace.go:171","msg":"trace[242068678] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1246; }","duration":"177.655531ms","start":"2026-04-21T19:18:19.079692Z","end":"2026-04-21T19:18:19.257347Z","steps":["trace[242068678] 'agreement among raft nodes before linearized reading' (duration: 177.490867ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:19.257308Z","caller":"traceutil/trace.go:171","msg":"trace[1798496327] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/self-signed; range_end:; response_count:0; response_revision:1246; }","duration":"109.459588ms","start":"2026-04-21T19:18:19.14781Z","end":"2026-04-21T19:18:19.257269Z","steps":["trace[1798496327] 'agreement among raft nodes before linearized reading' (duration: 109.245143ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:19.257471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.389525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-21T19:18:19.257477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.619404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T19:18:19.257498Z","caller":"traceutil/trace.go:171","msg":"trace[994656541] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1246; }","duration":"281.440206ms","start":"2026-04-21T19:18:18.976051Z","end":"2026-04-21T19:18:19.257491Z","steps":["trace[994656541] 'agreement among raft nodes before linearized reading' (duration: 281.288163ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:19.257511Z","caller":"traceutil/trace.go:171","msg":"trace[412379686] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1246; }","duration":"178.707996ms","start":"2026-04-21T19:18:19.078794Z","end":"2026-04-21T19:18:19.257502Z","steps":["trace[412379686] 'agreement among raft nodes before linearized reading' (duration: 178.648644ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:20.227415Z","caller":"traceutil/trace.go:171","msg":"trace[936382757] transaction","detail":"{read_only:false; response_revision:1253; number_of_response:1; }","duration":"101.491132ms","start":"2026-04-21T19:18:20.125892Z","end":"2026-04-21T19:18:20.227383Z","steps":["trace[936382757] 'process raft request' (duration: 101.381749ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:20.227481Z","caller":"traceutil/trace.go:171","msg":"trace[1708145733] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1252; }","duration":"102.459924ms","start":"2026-04-21T19:18:20.12493Z","end":"2026-04-21T19:18:20.22739Z","steps":["trace[1708145733] 'process raft request' (duration: 93.087935ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:20.494685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.851832ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:18:20.494824Z","caller":"traceutil/trace.go:171","msg":"trace[1273958381] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"261.381397ms","start":"2026-04-21T19:18:20.233418Z","end":"2026-04-21T19:18:20.494799Z","steps":["trace[1273958381] 'process raft request' (duration: 96.32621ms)","trace[1273958381] 'compare' (duration: 164.697999ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:20.501456Z","caller":"traceutil/trace.go:171","msg":"trace[106413897] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"266.825984ms","start":"2026-04-21T19:18:20.23461Z","end":"2026-04-21T19:18:20.501436Z","steps":["trace[106413897] 'process raft request' (duration: 266.590379ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:20.501501Z","caller":"traceutil/trace.go:171","msg":"trace[1651055196] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"261.689234ms","start":"2026-04-21T19:18:20.239782Z","end":"2026-04-21T19:18:20.501472Z","steps":["trace[1651055196] 'process raft request' (duration: 261.52881ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:20.50151Z","caller":"traceutil/trace.go:171","msg":"trace[1563287538] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1259; }","duration":"257.320632ms","start":"2026-04-21T19:18:20.244148Z","end":"2026-04-21T19:18:20.501469Z","steps":["trace[1563287538] 'process raft request' (duration: 257.278191ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:20.50169Z","caller":"traceutil/trace.go:171","msg":"trace[1800299592] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"259.972054ms","start":"2026-04-21T19:18:20.241675Z","end":"2026-04-21T19:18:20.501647Z","steps":["trace[1800299592] 'process raft request' (duration: 259.695268ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:20.756734Z","caller":"traceutil/trace.go:171","msg":"trace[823836027] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"241.722658ms","start":"2026-04-21T19:18:20.514987Z","end":"2026-04-21T19:18:20.75671Z","steps":["trace[823836027] 'process raft request' (duration: 217.671206ms)","trace[823836027] 'compare' (duration: 23.908019ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:18:20.756886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.691541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/cert-manager/\" range_end:\"/registry/resourcequotas/cert-manager0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:18:20.756946Z","caller":"traceutil/trace.go:171","msg":"trace[57208123] range","detail":"{range_begin:/registry/resourcequotas/cert-manager/; range_end:/registry/resourcequotas/cert-manager0; response_count:0; response_revision:1261; }","duration":"242.789493ms","start":"2026-04-21T19:18:20.51414Z","end":"2026-04-21T19:18:20.756929Z","steps":["trace[57208123] 'agreement among raft nodes before linearized reading' (duration: 242.679971ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:20.757052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.497232ms","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-21T19:18:20.757136Z","caller":"traceutil/trace.go:171","msg":"trace[532745987] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1261; }","duration":"205.686516ms","start":"2026-04-21T19:18:20.551433Z","end":"2026-04-21T19:18:20.75712Z","steps":["trace[532745987] 'agreement among raft nodes before linearized reading' (duration: 205.290977ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:20.756775Z","caller":"traceutil/trace.go:171","msg":"trace[29660099] linearizableReadLoop","detail":"{readStateIndex:1301; appliedIndex:1300; }","duration":"197.946096ms","start":"2026-04-21T19:18:20.558748Z","end":"2026-04-21T19:18:20.756694Z","steps":["trace[29660099] 'read index received' (duration: 174.037627ms)","trace[29660099] 'applied index is now lower than readState.Index' (duration: 23.907339ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:18:20.758089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.664602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/atmosphere.18a8755e266649fc\" ","response":"range_response_count:1 size:750"} {"level":"info","ts":"2026-04-21T19:18:20.758149Z","caller":"traceutil/trace.go:171","msg":"trace[2130055949] range","detail":"{range_begin:/registry/events/default/atmosphere.18a8755e266649fc; range_end:; response_count:1; response_revision:1262; }","duration":"195.726254ms","start":"2026-04-21T19:18:20.562409Z","end":"2026-04-21T19:18:20.758135Z","steps":["trace[2130055949] 'agreement among raft nodes before linearized reading' (duration: 195.56678ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:20.758218Z","caller":"traceutil/trace.go:171","msg":"trace[550629184] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"150.6527ms","start":"2026-04-21T19:18:20.607549Z","end":"2026-04-21T19:18:20.758202Z","steps":["trace[550629184] 'process raft request' (duration: 150.333603ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:21.035426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.60627ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:18:21.035596Z","caller":"traceutil/trace.go:171","msg":"trace[571481280] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"276.224434ms","start":"2026-04-21T19:18:20.759346Z","end":"2026-04-21T19:18:21.03557Z","steps":["trace[571481280] 'process raft request' (duration: 107.388869ms)","trace[571481280] 'compare' (duration: 168.337963ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:21.035761Z","caller":"traceutil/trace.go:171","msg":"trace[113718140] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"274.396011ms","start":"2026-04-21T19:18:20.761349Z","end":"2026-04-21T19:18:21.035745Z","steps":["trace[113718140] 'process raft request' (duration: 274.32603ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:21.035761Z","caller":"traceutil/trace.go:171","msg":"trace[10621335] linearizableReadLoop","detail":"{readStateIndex:1303; appliedIndex:1302; }","duration":"276.314647ms","start":"2026-04-21T19:18:20.759415Z","end":"2026-04-21T19:18:21.03573Z","steps":["trace[10621335] 'read index received' (duration: 107.342489ms)","trace[10621335] 'applied index is now lower than readState.Index' (duration: 168.969208ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:21.035818Z","caller":"traceutil/trace.go:171","msg":"trace[200649082] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"275.220341ms","start":"2026-04-21T19:18:20.760521Z","end":"2026-04-21T19:18:21.035742Z","steps":["trace[200649082] 'process raft request' (duration: 275.030797ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:21.036185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.1148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"warn","ts":"2026-04-21T19:18:21.036192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.997168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/cert-manager/cert-manager-selfsigned-ca\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:18:21.036242Z","caller":"traceutil/trace.go:171","msg":"trace[31046379] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:1265; }","duration":"231.220422ms","start":"2026-04-21T19:18:20.805008Z","end":"2026-04-21T19:18:21.036228Z","steps":["trace[31046379] 'agreement among raft nodes before linearized reading' (duration: 230.993137ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:21.036247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.808518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:18:21.036286Z","caller":"traceutil/trace.go:171","msg":"trace[1739971114] range","detail":"{range_begin:/registry/secrets/cert-manager/cert-manager-selfsigned-ca; range_end:; response_count:0; response_revision:1265; }","duration":"151.133921ms","start":"2026-04-21T19:18:20.885126Z","end":"2026-04-21T19:18:21.03626Z","steps":["trace[1739971114] 'agreement among raft nodes before linearized reading' (duration: 150.978598ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:21.036324Z","caller":"traceutil/trace.go:171","msg":"trace[2001235479] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1265; }","duration":"277.270008ms","start":"2026-04-21T19:18:20.759036Z","end":"2026-04-21T19:18:21.036306Z","steps":["trace[2001235479] 'agreement among raft nodes before linearized reading' (duration: 276.93367ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:21.162533Z","caller":"traceutil/trace.go:171","msg":"trace[1067178272] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"121.302034ms","start":"2026-04-21T19:18:21.041203Z","end":"2026-04-21T19:18:21.162505Z","steps":["trace[1067178272] 'process raft request' (duration: 121.084339ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:21.162838Z","caller":"traceutil/trace.go:171","msg":"trace[1076238547] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"121.302785ms","start":"2026-04-21T19:18:21.041476Z","end":"2026-04-21T19:18:21.162779Z","steps":["trace[1076238547] 'process raft request' (duration: 120.973597ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:21.16296Z","caller":"traceutil/trace.go:171","msg":"trace[1654053316] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"120.625579ms","start":"2026-04-21T19:18:21.042275Z","end":"2026-04-21T19:18:21.1629Z","steps":["trace[1654053316] 'process raft request' (duration: 120.499506ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:21.163019Z","caller":"traceutil/trace.go:171","msg":"trace[393042959] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"120.580378ms","start":"2026-04-21T19:18:21.042425Z","end":"2026-04-21T19:18:21.163005Z","steps":["trace[393042959] 'process raft request' (duration: 120.427944ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:21.163056Z","caller":"traceutil/trace.go:171","msg":"trace[1401028367] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"120.518087ms","start":"2026-04-21T19:18:21.042514Z","end":"2026-04-21T19:18:21.163032Z","steps":["trace[1401028367] 'process raft request' (duration: 120.367513ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:21.163145Z","caller":"traceutil/trace.go:171","msg":"trace[345341969] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"120.861704ms","start":"2026-04-21T19:18:21.042273Z","end":"2026-04-21T19:18:21.163135Z","steps":["trace[345341969] 'process raft request' (duration: 120.529576ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:21.163229Z","caller":"traceutil/trace.go:171","msg":"trace[985530162] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"121.215063ms","start":"2026-04-21T19:18:21.041994Z","end":"2026-04-21T19:18:21.16321Z","steps":["trace[985530162] 'process raft request' (duration: 120.691601ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:21.163238Z","caller":"traceutil/trace.go:171","msg":"trace[1554822398] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"119.671436ms","start":"2026-04-21T19:18:21.043549Z","end":"2026-04-21T19:18:21.16322Z","steps":["trace[1554822398] 'process raft request' (duration: 119.359639ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:21.163244Z","caller":"traceutil/trace.go:171","msg":"trace[1305478699] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"117.618558ms","start":"2026-04-21T19:18:21.045614Z","end":"2026-04-21T19:18:21.163233Z","steps":["trace[1305478699] 'process raft request' (duration: 117.336352ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:21.557722Z","caller":"traceutil/trace.go:171","msg":"trace[195376266] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"328.534737ms","start":"2026-04-21T19:18:21.229154Z","end":"2026-04-21T19:18:21.557689Z","steps":["trace[195376266] 'process raft request' (duration: 306.978633ms)","trace[195376266] 'compare' (duration: 21.358529ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:21.557836Z","caller":"traceutil/trace.go:171","msg":"trace[1454815829] linearizableReadLoop","detail":"{readStateIndex:1319; appliedIndex:1317; }","duration":"295.956695ms","start":"2026-04-21T19:18:21.261855Z","end":"2026-04-21T19:18:21.557811Z","steps":["trace[1454815829] 'read index received' (duration: 45.313739ms)","trace[1454815829] 'applied index is now lower than readState.Index' (duration: 250.641186ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:21.557946Z","caller":"traceutil/trace.go:171","msg":"trace[919027523] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"295.405523ms","start":"2026-04-21T19:18:21.262511Z","end":"2026-04-21T19:18:21.557917Z","steps":["trace[919027523] 'process raft request' (duration: 295.114896ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:21.557946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:21.229128Z","time spent":"328.68139ms","remote":"127.0.0.1:46412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4958,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:18:21.558076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.284714ms","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-21T19:18:21.558076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.249253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-21T19:18:21.558077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.211532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-21T19:18:21.55811Z","caller":"traceutil/trace.go:171","msg":"trace[1504047342] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1279; }","duration":"231.371506ms","start":"2026-04-21T19:18:21.326727Z","end":"2026-04-21T19:18:21.558099Z","steps":["trace[1504047342] 'agreement among raft nodes before linearized reading' (duration: 231.218083ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:21.558133Z","caller":"traceutil/trace.go:171","msg":"trace[2038031055] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1279; }","duration":"207.339035ms","start":"2026-04-21T19:18:21.350778Z","end":"2026-04-21T19:18:21.558117Z","steps":["trace[2038031055] 'agreement among raft nodes before linearized reading' (duration: 207.182461ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:21.558137Z","caller":"traceutil/trace.go:171","msg":"trace[93738882] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1279; }","duration":"296.321165ms","start":"2026-04-21T19:18:21.261803Z","end":"2026-04-21T19:18:21.558124Z","steps":["trace[93738882] 'agreement among raft nodes before linearized reading' (duration: 296.1206ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:25.646169Z","caller":"traceutil/trace.go:171","msg":"trace[1853065841] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"130.658362ms","start":"2026-04-21T19:18:25.515453Z","end":"2026-04-21T19:18:25.646111Z","steps":["trace[1853065841] 'process raft request' (duration: 130.281054ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:25.850454Z","caller":"traceutil/trace.go:171","msg":"trace[1166117441] linearizableReadLoop","detail":"{readStateIndex:1342; appliedIndex:1341; }","duration":"160.715806ms","start":"2026-04-21T19:18:25.689709Z","end":"2026-04-21T19:18:25.850425Z","steps":["trace[1166117441] 'read index received' (duration: 122.932903ms)","trace[1166117441] 'applied index is now lower than readState.Index' (duration: 37.781593ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:25.850463Z","caller":"traceutil/trace.go:171","msg":"trace[459403960] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"196.788379ms","start":"2026-04-21T19:18:25.653641Z","end":"2026-04-21T19:18:25.850429Z","steps":["trace[459403960] 'process raft request' (duration: 159.075348ms)","trace[459403960] 'compare' (duration: 37.556427ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:18:25.850741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.997922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-21T19:18:25.850885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.755319ms","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-21T19:18:25.85085Z","caller":"traceutil/trace.go:171","msg":"trace[1385042532] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1300; }","duration":"161.172796ms","start":"2026-04-21T19:18:25.689654Z","end":"2026-04-21T19:18:25.850826Z","steps":["trace[1385042532] 'agreement among raft nodes before linearized reading' (duration: 160.873279ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:25.850887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.809649ms","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-21T19:18:25.85096Z","caller":"traceutil/trace.go:171","msg":"trace[1765806887] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1300; }","duration":"125.866221ms","start":"2026-04-21T19:18:25.725075Z","end":"2026-04-21T19:18:25.850941Z","steps":["trace[1765806887] 'agreement among raft nodes before linearized reading' (duration: 125.682016ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:25.850977Z","caller":"traceutil/trace.go:171","msg":"trace[1142534360] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1300; }","duration":"125.946522ms","start":"2026-04-21T19:18:25.725019Z","end":"2026-04-21T19:18:25.850965Z","steps":["trace[1142534360] 'agreement among raft nodes before linearized reading' (duration: 125.567763ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:26.235768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.579497ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-04-21T19:18:26.235883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:25.851728Z","time spent":"384.151336ms","remote":"127.0.0.1:60374","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-21T19:18:26.823742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.276465ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:18:26.823994Z","caller":"traceutil/trace.go:171","msg":"trace[446492893] linearizableReadLoop","detail":"{readStateIndex:1346; appliedIndex:1342; }","duration":"875.894157ms","start":"2026-04-21T19:18:25.948088Z","end":"2026-04-21T19:18:26.823983Z","steps":["trace[446492893] 'read index received' (duration: 75.121945ms)","trace[446492893] 'applied index is now lower than readState.Index' (duration: 800.771572ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:26.82406Z","caller":"traceutil/trace.go:171","msg":"trace[1990799440] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"968.611073ms","start":"2026-04-21T19:18:25.855437Z","end":"2026-04-21T19:18:26.824049Z","steps":["trace[1990799440] 'process raft request' (duration: 968.49332ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:26.824027Z","caller":"traceutil/trace.go:171","msg":"trace[1947838970] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"969.026163ms","start":"2026-04-21T19:18:25.854942Z","end":"2026-04-21T19:18:26.823968Z","steps":["trace[1947838970] 'process raft request' (duration: 618.457251ms)","trace[1947838970] 'compare' (duration: 350.05489ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:18:26.824092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:25.855412Z","time spent":"968.661655ms","remote":"127.0.0.1:60610","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-21T19:18:26.824063Z","caller":"traceutil/trace.go:171","msg":"trace[1317808288] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"968.632714ms","start":"2026-04-21T19:18:25.855391Z","end":"2026-04-21T19:18:26.824024Z","steps":["trace[1317808288] 'process raft request' (duration: 968.429139ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:26.82422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"876.139032ms","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:7"} {"level":"warn","ts":"2026-04-21T19:18:26.824824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:25.855369Z","time spent":"969.396452ms","remote":"127.0.0.1:60610","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-21T19:18:26.824197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:25.85492Z","time spent":"969.187447ms","remote":"127.0.0.1:60610","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-21T19:18:26.824204Z","caller":"traceutil/trace.go:171","msg":"trace[1470393928] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"587.181041ms","start":"2026-04-21T19:18:26.236983Z","end":"2026-04-21T19:18:26.824164Z","steps":["trace[1470393928] 'process raft request' (duration: 586.976926ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:26.825036Z","caller":"traceutil/trace.go:171","msg":"trace[1873794718] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1304; }","duration":"876.865419ms","start":"2026-04-21T19:18:25.948036Z","end":"2026-04-21T19:18:26.824902Z","steps":["trace[1873794718] 'agreement among raft nodes before linearized reading' (duration: 876.129422ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:26.825115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:26.236961Z","time spent":"588.118592ms","remote":"127.0.0.1:60374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:18:26.825238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:25.948017Z","time spent":"877.140126ms","remote":"127.0.0.1:60506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":5,"response size":30,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"info","ts":"2026-04-21T19:18:28.970022Z","caller":"traceutil/trace.go:171","msg":"trace[765571171] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"136.030339ms","start":"2026-04-21T19:18:28.833959Z","end":"2026-04-21T19:18:28.969989Z","steps":["trace[765571171] 'process raft request' (duration: 135.955307ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:28.970153Z","caller":"traceutil/trace.go:171","msg":"trace[1410559389] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"137.101453ms","start":"2026-04-21T19:18:28.832999Z","end":"2026-04-21T19:18:28.970101Z","steps":["trace[1410559389] 'process raft request' (duration: 136.051869ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:29.738384Z","caller":"traceutil/trace.go:171","msg":"trace[626000419] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"101.058501ms","start":"2026-04-21T19:18:29.637299Z","end":"2026-04-21T19:18:29.738358Z","steps":["trace[626000419] 'process raft request' (duration: 100.927668ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:29.835764Z","caller":"traceutil/trace.go:171","msg":"trace[2068252565] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"148.542131ms","start":"2026-04-21T19:18:29.687186Z","end":"2026-04-21T19:18:29.835728Z","steps":["trace[2068252565] 'process raft request' (duration: 87.909365ms)","trace[2068252565] 'compare' (duration: 60.461642ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:29.844819Z","caller":"traceutil/trace.go:171","msg":"trace[1450752233] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"102.783362ms","start":"2026-04-21T19:18:29.741995Z","end":"2026-04-21T19:18:29.844778Z","steps":["trace[1450752233] 'process raft request' (duration: 102.572767ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:29.844889Z","caller":"traceutil/trace.go:171","msg":"trace[1206749427] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"102.779492ms","start":"2026-04-21T19:18:29.742083Z","end":"2026-04-21T19:18:29.844863Z","steps":["trace[1206749427] 'process raft request' (duration: 102.636038ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:30.13993Z","caller":"traceutil/trace.go:171","msg":"trace[30434391] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"244.80256ms","start":"2026-04-21T19:18:29.895087Z","end":"2026-04-21T19:18:30.13989Z","steps":["trace[30434391] 'process raft request' (duration: 165.987459ms)","trace[30434391] 'compare' (duration: 78.479753ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:18:30.488058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.720227ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:18:30.488358Z","caller":"traceutil/trace.go:171","msg":"trace[1647810359] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"205.584404ms","start":"2026-04-21T19:18:30.282746Z","end":"2026-04-21T19:18:30.488331Z","steps":["trace[1647810359] 'process raft request' (duration: 205.474122ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:30.488377Z","caller":"traceutil/trace.go:171","msg":"trace[1601641229] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"334.290671ms","start":"2026-04-21T19:18:30.154048Z","end":"2026-04-21T19:18:30.488339Z","steps":["trace[1601641229] 'process raft request' (duration: 137.215055ms)","trace[1601641229] 'compare' (duration: 196.541543ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:18:30.488528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:30.154021Z","time spent":"334.430564ms","remote":"127.0.0.1:60540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1056,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T19:18:30.943599Z","caller":"traceutil/trace.go:171","msg":"trace[1654172976] linearizableReadLoop","detail":"{readStateIndex:1365; appliedIndex:1364; }","duration":"187.741507ms","start":"2026-04-21T19:18:30.75583Z","end":"2026-04-21T19:18:30.943572Z","steps":["trace[1654172976] 'read index received' (duration: 94.330394ms)","trace[1654172976] 'applied index is now lower than readState.Index' (duration: 93.409833ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:30.943653Z","caller":"traceutil/trace.go:171","msg":"trace[2110690630] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"400.18501ms","start":"2026-04-21T19:18:30.543396Z","end":"2026-04-21T19:18:30.943581Z","steps":["trace[2110690630] 'process raft request' (duration: 306.842089ms)","trace[2110690630] 'compare' (duration: 93.187397ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:18:30.943771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.928822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:18:30.943827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:30.543363Z","time spent":"400.351164ms","remote":"127.0.0.1:60440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105315,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:18:30.943846Z","caller":"traceutil/trace.go:171","msg":"trace[764702371] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1322; }","duration":"188.063805ms","start":"2026-04-21T19:18:30.755769Z","end":"2026-04-21T19:18:30.943833Z","steps":["trace[764702371] 'agreement among raft nodes before linearized reading' (duration: 187.936122ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:31.161634Z","caller":"traceutil/trace.go:171","msg":"trace[690774471] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"212.995507ms","start":"2026-04-21T19:18:30.948577Z","end":"2026-04-21T19:18:31.161573Z","steps":["trace[690774471] 'process raft request' (duration: 152.637317ms)","trace[690774471] 'compare' (duration: 60.037342ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:31.161769Z","caller":"traceutil/trace.go:171","msg":"trace[1757668993] linearizableReadLoop","detail":"{readStateIndex:1367; appliedIndex:1365; }","duration":"187.739547ms","start":"2026-04-21T19:18:30.973997Z","end":"2026-04-21T19:18:31.161737Z","steps":["trace[1757668993] 'read index received' (duration: 127.224293ms)","trace[1757668993] 'applied index is now lower than readState.Index' (duration: 60.513934ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:18:31.162003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.984462ms","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-21T19:18:31.162047Z","caller":"traceutil/trace.go:171","msg":"trace[348207549] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1325; }","duration":"188.065225ms","start":"2026-04-21T19:18:30.973971Z","end":"2026-04-21T19:18:31.162036Z","steps":["trace[348207549] 'agreement among raft nodes before linearized reading' (duration: 187.906551ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:31.161977Z","caller":"traceutil/trace.go:171","msg":"trace[1654374882] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"206.494095ms","start":"2026-04-21T19:18:30.955451Z","end":"2026-04-21T19:18:31.161945Z","steps":["trace[1654374882] 'process raft request' (duration: 205.949733ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:31.162172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.008053ms","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-21T19:18:31.16244Z","caller":"traceutil/trace.go:171","msg":"trace[1959912745] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1325; }","duration":"188.3093ms","start":"2026-04-21T19:18:30.974107Z","end":"2026-04-21T19:18:31.162416Z","steps":["trace[1959912745] 'agreement among raft nodes before linearized reading' (duration: 187.86837ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:31.430119Z","caller":"traceutil/trace.go:171","msg":"trace[610934635] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"202.321507ms","start":"2026-04-21T19:18:31.227759Z","end":"2026-04-21T19:18:31.43008Z","steps":["trace[610934635] 'process raft request' (duration: 179.603986ms)","trace[610934635] 'compare' (duration: 22.499656ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:31.433976Z","caller":"traceutil/trace.go:171","msg":"trace[35882781] linearizableReadLoop","detail":"{readStateIndex:1372; appliedIndex:1370; }","duration":"177.505728ms","start":"2026-04-21T19:18:31.256449Z","end":"2026-04-21T19:18:31.433955Z","steps":["trace[35882781] 'read index received' (duration: 150.923586ms)","trace[35882781] 'applied index is now lower than readState.Index' (duration: 26.580772ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:18:31.434393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.918337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-21T19:18:31.434608Z","caller":"traceutil/trace.go:171","msg":"trace[1348147142] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1328; }","duration":"178.187144ms","start":"2026-04-21T19:18:31.256399Z","end":"2026-04-21T19:18:31.434586Z","steps":["trace[1348147142] 'agreement among raft nodes before linearized reading' (duration: 177.671662ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:31.434225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.786623ms","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-21T19:18:31.434762Z","caller":"traceutil/trace.go:171","msg":"trace[949937865] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1328; }","duration":"121.353926ms","start":"2026-04-21T19:18:31.313395Z","end":"2026-04-21T19:18:31.434749Z","steps":["trace[949937865] 'agreement among raft nodes before linearized reading' (duration: 120.712381ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:31.900639Z","caller":"traceutil/trace.go:171","msg":"trace[2105882610] transaction","detail":"{read_only:false; response_revision:1336; number_of_response:1; }","duration":"102.68647ms","start":"2026-04-21T19:18:31.797885Z","end":"2026-04-21T19:18:31.900571Z","steps":["trace[2105882610] 'process raft request' (duration: 18.055512ms)","trace[2105882610] 'compare' (duration: 84.360662ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:31.947943Z","caller":"traceutil/trace.go:171","msg":"trace[1522261637] transaction","detail":"{read_only:false; response_revision:1337; number_of_response:1; }","duration":"107.330868ms","start":"2026-04-21T19:18:31.840577Z","end":"2026-04-21T19:18:31.947908Z","steps":["trace[1522261637] 'process raft request' (duration: 107.106503ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:33.185714Z","caller":"traceutil/trace.go:171","msg":"trace[1560836461] transaction","detail":"{read_only:false; response_revision:1349; number_of_response:1; }","duration":"106.750915ms","start":"2026-04-21T19:18:33.078934Z","end":"2026-04-21T19:18:33.185685Z","steps":["trace[1560836461] 'process raft request' (duration: 106.598861ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:21:21.299218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.015403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:21:21.299338Z","caller":"traceutil/trace.go:171","msg":"trace[1186571769] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1956; }","duration":"544.236158ms","start":"2026-04-21T19:21:20.755079Z","end":"2026-04-21T19:21:21.299315Z","steps":["trace[1186571769] 'range keys from in-memory index tree' (duration: 543.87686ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:21:21.299386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:21:20.755049Z","time spent":"544.32633ms","remote":"127.0.0.1:60326","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-21T19:21:21.299373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.079076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:21:21.299506Z","caller":"traceutil/trace.go:171","msg":"trace[1618631099] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1956; }","duration":"571.24078ms","start":"2026-04-21T19:21:20.72824Z","end":"2026-04-21T19:21:21.299481Z","steps":["trace[1618631099] 'count revisions from in-memory index tree' (duration: 570.963894ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:21:21.299584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:21:20.728214Z","time spent":"571.346443ms","remote":"127.0.0.1:60456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"info","ts":"2026-04-21T19:21:30.471176Z","caller":"traceutil/trace.go:171","msg":"trace[401147841] transaction","detail":"{read_only:false; response_revision:1986; number_of_response:1; }","duration":"159.502278ms","start":"2026-04-21T19:21:30.311594Z","end":"2026-04-21T19:21:30.471097Z","steps":["trace[401147841] 'process raft request' (duration: 77.374812ms)","trace[401147841] 'compare' (duration: 82.000683ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:21:30.477125Z","caller":"traceutil/trace.go:171","msg":"trace[1329341204] transaction","detail":"{read_only:false; response_revision:1987; number_of_response:1; }","duration":"163.348369ms","start":"2026-04-21T19:21:30.313749Z","end":"2026-04-21T19:21:30.477098Z","steps":["trace[1329341204] 'process raft request' (duration: 163.198826ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:21:30.810632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.148762ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:21:30.810871Z","caller":"traceutil/trace.go:171","msg":"trace[1701043846] transaction","detail":"{read_only:false; response_revision:1989; number_of_response:1; }","duration":"300.883425ms","start":"2026-04-21T19:21:30.509942Z","end":"2026-04-21T19:21:30.810825Z","steps":["trace[1701043846] 'process raft request' (duration: 80.417435ms)","trace[1701043846] 'compare' (duration: 219.874356ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:21:30.810949Z","caller":"traceutil/trace.go:171","msg":"trace[2075849772] linearizableReadLoop","detail":"{readStateIndex:2070; appliedIndex:2069; }","duration":"292.468453ms","start":"2026-04-21T19:21:30.518468Z","end":"2026-04-21T19:21:30.810936Z","steps":["trace[2075849772] 'read index received' (duration: 71.932882ms)","trace[2075849772] 'applied index is now lower than readState.Index' (duration: 220.533701ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:21:30.811007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:21:30.50991Z","time spent":"301.038047ms","remote":"127.0.0.1:60610","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-21T19:21:30.810899Z","caller":"traceutil/trace.go:171","msg":"trace[1838099248] transaction","detail":"{read_only:false; response_revision:1990; number_of_response:1; }","duration":"161.643349ms","start":"2026-04-21T19:21:30.649236Z","end":"2026-04-21T19:21:30.81088Z","steps":["trace[1838099248] 'process raft request' (duration: 161.542406ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:21:30.811157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.493324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T19:21:30.811223Z","caller":"traceutil/trace.go:171","msg":"trace[1168209824] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1990; }","duration":"158.623977ms","start":"2026-04-21T19:21:30.652583Z","end":"2026-04-21T19:21:30.811207Z","steps":["trace[1168209824] 'agreement among raft nodes before linearized reading' (duration: 158.466803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:21:30.811503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.920934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-21T19:21:30.811589Z","caller":"traceutil/trace.go:171","msg":"trace[701356794] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1990; }","duration":"293.127159ms","start":"2026-04-21T19:21:30.518439Z","end":"2026-04-21T19:21:30.811567Z","steps":["trace[701356794] 'agreement among raft nodes before linearized reading' (duration: 292.569016ms)"],"step_count":1}