{"level":"warn","ts":"2026-05-11T07:26:40.488668Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-11T07:26:40.488791Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.30: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.30:2380","--initial-cluster=instance=https://199.204.45.30:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.30:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.30: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-05-11T07:26:40.488902Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-11T07:26:40.488922Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.30:2380"]} {"level":"info","ts":"2026-05-11T07:26:40.488944Z","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-05-11T07:26:40.489864Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.30:2379"]} {"level":"info","ts":"2026-05-11T07:26:40.490081Z","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.30:2380"],"listen-peer-urls":["https://199.204.45.30:2380"],"advertise-client-urls":["https://199.204.45.30:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.30:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.30: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-05-11T07:26:40.494876Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.769252ms"} {"level":"info","ts":"2026-05-11T07:26:40.500407Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c6cf68dde442ffa5","cluster-id":"98b7ecdca9045526"} {"level":"info","ts":"2026-05-11T07:26:40.500474Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c6cf68dde442ffa5 switched to configuration voters=()"} {"level":"info","ts":"2026-05-11T07:26:40.500496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c6cf68dde442ffa5 became follower at term 0"} {"level":"info","ts":"2026-05-11T07:26:40.500516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c6cf68dde442ffa5 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-11T07:26:40.500526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c6cf68dde442ffa5 became follower at term 1"} {"level":"info","ts":"2026-05-11T07:26:40.500568Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c6cf68dde442ffa5 switched to configuration voters=(14325784241915494309)"} {"level":"warn","ts":"2026-05-11T07:26:40.507362Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-11T07:26:40.510254Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-11T07:26:40.511676Z","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-05-11T07:26:40.513739Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c6cf68dde442ffa5","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-11T07:26:40.51389Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c6cf68dde442ffa5","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-11T07:26:40.514081Z","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-05-11T07:26:40.514318Z","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-05-11T07:26:40.514391Z","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-05-11T07:26:40.515048Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c6cf68dde442ffa5 switched to configuration voters=(14325784241915494309)"} {"level":"info","ts":"2026-05-11T07:26:40.515217Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"98b7ecdca9045526","local-member-id":"c6cf68dde442ffa5","added-peer-id":"c6cf68dde442ffa5","added-peer-peer-urls":["https://199.204.45.30:2380"]} {"level":"info","ts":"2026-05-11T07:26:40.517284Z","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-05-11T07:26:40.517473Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.30:2380"} {"level":"info","ts":"2026-05-11T07:26:40.517503Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.30:2380"} {"level":"info","ts":"2026-05-11T07:26:40.518351Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c6cf68dde442ffa5","initial-advertise-peer-urls":["https://199.204.45.30:2380"],"listen-peer-urls":["https://199.204.45.30:2380"],"advertise-client-urls":["https://199.204.45.30:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.30:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-11T07:26:40.518406Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-11T07:26:40.701254Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c6cf68dde442ffa5 is starting a new election at term 1"} {"level":"info","ts":"2026-05-11T07:26:40.701414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c6cf68dde442ffa5 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-11T07:26:40.701502Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c6cf68dde442ffa5 received MsgPreVoteResp from c6cf68dde442ffa5 at term 1"} {"level":"info","ts":"2026-05-11T07:26:40.701576Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c6cf68dde442ffa5 became candidate at term 2"} {"level":"info","ts":"2026-05-11T07:26:40.701616Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c6cf68dde442ffa5 received MsgVoteResp from c6cf68dde442ffa5 at term 2"} {"level":"info","ts":"2026-05-11T07:26:40.701688Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c6cf68dde442ffa5 became leader at term 2"} {"level":"info","ts":"2026-05-11T07:26:40.701729Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c6cf68dde442ffa5 elected leader c6cf68dde442ffa5 at term 2"} {"level":"info","ts":"2026-05-11T07:26:40.702799Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c6cf68dde442ffa5","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.30:2379]}","request-path":"/0/members/c6cf68dde442ffa5/attributes","cluster-id":"98b7ecdca9045526","publish-timeout":"7s"} {"level":"info","ts":"2026-05-11T07:26:40.702933Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-11T07:26:40.70314Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-11T07:26:40.703201Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-11T07:26:40.703275Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-11T07:26:40.706346Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-11T07:26:40.707444Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.30:2379"} {"level":"info","ts":"2026-05-11T07:26:40.702873Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T07:26:40.712425Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"98b7ecdca9045526","local-member-id":"c6cf68dde442ffa5","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T07:26:40.712563Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T07:26:40.712592Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T07:26:43.316914Z","caller":"traceutil/trace.go:171","msg":"trace[103744009] linearizableReadLoop","detail":"{readStateIndex:89; appliedIndex:88; }","duration":"128.694024ms","start":"2026-05-11T07:26:43.18819Z","end":"2026-05-11T07:26:43.316884Z","steps":["trace[103744009] 'read index received' (duration: 128.500997ms)","trace[103744009] 'applied index is now lower than readState.Index' (duration: 191.127µs)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:26:43.317092Z","caller":"traceutil/trace.go:171","msg":"trace[1650522759] transaction","detail":"{read_only:false; response_revision:85; number_of_response:1; }","duration":"154.30858ms","start":"2026-05-11T07:26:43.162729Z","end":"2026-05-11T07:26:43.317037Z","steps":["trace[1650522759] 'process raft request' (duration: 154.017354ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:26:43.317291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.04275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T07:26:43.317452Z","caller":"traceutil/trace.go:171","msg":"trace[727021016] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:85; }","duration":"129.288578ms","start":"2026-05-11T07:26:43.188132Z","end":"2026-05-11T07:26:43.31742Z","steps":["trace[727021016] 'agreement among raft nodes before linearized reading' (duration: 128.954902ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:07.496744Z","caller":"traceutil/trace.go:171","msg":"trace[466338677] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"268.569681ms","start":"2026-05-11T07:27:07.228152Z","end":"2026-05-11T07:27:07.496722Z","steps":["trace[466338677] 'process raft request' (duration: 266.306165ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:07.497083Z","caller":"traceutil/trace.go:171","msg":"trace[1560614223] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"247.942591ms","start":"2026-05-11T07:27:07.249104Z","end":"2026-05-11T07:27:07.497047Z","steps":["trace[1560614223] 'process raft request' (duration: 247.546025ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:07.503373Z","caller":"traceutil/trace.go:171","msg":"trace[1241019108] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"234.534454ms","start":"2026-05-11T07:27:07.268813Z","end":"2026-05-11T07:27:07.503348Z","steps":["trace[1241019108] 'process raft request' (duration: 233.782845ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:12.875815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.635373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-11T07:27:12.875914Z","caller":"traceutil/trace.go:171","msg":"trace[787346234] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:563; }","duration":"116.804416ms","start":"2026-05-11T07:27:12.759093Z","end":"2026-05-11T07:27:12.875898Z","steps":["trace[787346234] 'range keys from in-memory index tree' (duration: 116.46253ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:12.902245Z","caller":"traceutil/trace.go:171","msg":"trace[315890297] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"135.982436ms","start":"2026-05-11T07:27:12.766228Z","end":"2026-05-11T07:27:12.90221Z","steps":["trace[315890297] 'process raft request' (duration: 134.756697ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:13.209921Z","caller":"traceutil/trace.go:171","msg":"trace[150389734] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"275.65355ms","start":"2026-05-11T07:27:12.934243Z","end":"2026-05-11T07:27:13.209896Z","steps":["trace[150389734] 'process raft request' (duration: 275.475497ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:13.219846Z","caller":"traceutil/trace.go:171","msg":"trace[1549911715] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"233.58954ms","start":"2026-05-11T07:27:12.986226Z","end":"2026-05-11T07:27:13.219816Z","steps":["trace[1549911715] 'process raft request' (duration: 233.385226ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:13.391515Z","caller":"traceutil/trace.go:171","msg":"trace[50701931] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"158.326042ms","start":"2026-05-11T07:27:13.233161Z","end":"2026-05-11T07:27:13.391487Z","steps":["trace[50701931] 'process raft request' (duration: 106.33624ms)","trace[50701931] 'compare' (duration: 51.785998ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:27:13.39162Z","caller":"traceutil/trace.go:171","msg":"trace[2037088038] linearizableReadLoop","detail":"{readStateIndex:590; appliedIndex:588; }","duration":"153.31564ms","start":"2026-05-11T07:27:13.238269Z","end":"2026-05-11T07:27:13.391585Z","steps":["trace[2037088038] 'read index received' (duration: 101.238307ms)","trace[2037088038] 'applied index is now lower than readState.Index' (duration: 52.075813ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:27:13.391731Z","caller":"traceutil/trace.go:171","msg":"trace[1833234036] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"158.305502ms","start":"2026-05-11T07:27:13.233402Z","end":"2026-05-11T07:27:13.391707Z","steps":["trace[1833234036] 'process raft request' (duration: 158.005617ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:13.391749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.462632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:27:13.391799Z","caller":"traceutil/trace.go:171","msg":"trace[110792834] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:569; }","duration":"153.545073ms","start":"2026-05-11T07:27:13.238237Z","end":"2026-05-11T07:27:13.391782Z","steps":["trace[110792834] 'agreement among raft nodes before linearized reading' (duration: 153.460522ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:28.323359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.775166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:27:28.323495Z","caller":"traceutil/trace.go:171","msg":"trace[1270378314] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:727; }","duration":"146.965321ms","start":"2026-05-11T07:27:28.176498Z","end":"2026-05-11T07:27:28.323464Z","steps":["trace[1270378314] 'range keys from in-memory index tree' (duration: 146.665532ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:28.323447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.390905ms","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-05-11T07:27:28.323748Z","caller":"traceutil/trace.go:171","msg":"trace[273673266] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:727; }","duration":"233.679652ms","start":"2026-05-11T07:27:28.090032Z","end":"2026-05-11T07:27:28.323711Z","steps":["trace[273673266] 'range keys from in-memory index tree' (duration: 233.375065ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:39.62231Z","caller":"traceutil/trace.go:171","msg":"trace[700042573] transaction","detail":"{read_only:false; response_revision:879; number_of_response:1; }","duration":"109.585265ms","start":"2026-05-11T07:27:39.512704Z","end":"2026-05-11T07:27:39.622289Z","steps":["trace[700042573] 'process raft request' (duration: 103.970245ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:41.317547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.126914ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T07:27:41.317794Z","caller":"traceutil/trace.go:171","msg":"trace[513417134] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"445.961399ms","start":"2026-05-11T07:27:40.871797Z","end":"2026-05-11T07:27:41.317758Z","steps":["trace[513417134] 'process raft request' (duration: 134.846873ms)","trace[513417134] 'compare' (duration: 309.901867ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:27:41.317867Z","caller":"traceutil/trace.go:171","msg":"trace[342019626] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"411.054272ms","start":"2026-05-11T07:27:40.906789Z","end":"2026-05-11T07:27:41.317843Z","steps":["trace[342019626] 'process raft request' (duration: 411.009171ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:41.318023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:27:40.906762Z","time spent":"411.154056ms","remote":"127.0.0.1:58090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":953,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T07:27:41.318035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:27:40.871767Z","time spent":"446.107824ms","remote":"127.0.0.1:57970","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105407,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T07:27:41.318267Z","caller":"traceutil/trace.go:171","msg":"trace[1011959064] linearizableReadLoop","detail":"{readStateIndex:1031; appliedIndex:1029; }","duration":"442.457075ms","start":"2026-05-11T07:27:40.875574Z","end":"2026-05-11T07:27:41.318031Z","steps":["trace[1011959064] 'read index received' (duration: 13.363215ms)","trace[1011959064] 'applied index is now lower than readState.Index' (duration: 429.08828ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:27:41.318257Z","caller":"traceutil/trace.go:171","msg":"trace[621836410] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"411.515968ms","start":"2026-05-11T07:27:40.906516Z","end":"2026-05-11T07:27:41.318032Z","steps":["trace[621836410] 'process raft request' (duration: 411.186557ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:41.318407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:27:40.906501Z","time spent":"411.837148ms","remote":"127.0.0.1:58090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":956,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T07:27:41.318417Z","caller":"traceutil/trace.go:171","msg":"trace[1676741163] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"411.804138ms","start":"2026-05-11T07:27:40.906602Z","end":"2026-05-11T07:27:41.318406Z","steps":["trace[1676741163] 'process raft request' (duration: 411.164486ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:41.318473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:27:40.906573Z","time spent":"411.87391ms","remote":"127.0.0.1:58090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T07:27:41.318646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.882439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/node-feature-discovery-gc\" ","response":"range_response_count:1 size:879"} {"level":"warn","ts":"2026-05-11T07:27:41.318617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.028624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/node-feature-discovery\" ","response":"range_response_count:1 size:873"} {"level":"info","ts":"2026-05-11T07:27:41.318677Z","caller":"traceutil/trace.go:171","msg":"trace[1532833305] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/node-feature-discovery-gc; range_end:; response_count:1; response_revision:1002; }","duration":"442.933821ms","start":"2026-05-11T07:27:40.875732Z","end":"2026-05-11T07:27:41.318665Z","steps":["trace[1532833305] 'agreement among raft nodes before linearized reading' (duration: 442.826458ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:41.318692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.558355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-m49gg\" ","response":"range_response_count:1 size:5676"} {"level":"info","ts":"2026-05-11T07:27:41.318697Z","caller":"traceutil/trace.go:171","msg":"trace[1867833183] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/node-feature-discovery; range_end:; response_count:1; response_revision:1002; }","duration":"443.139847ms","start":"2026-05-11T07:27:40.875537Z","end":"2026-05-11T07:27:41.318677Z","steps":["trace[1867833183] 'agreement among raft nodes before linearized reading' (duration: 442.882019ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:41.318721Z","caller":"traceutil/trace.go:171","msg":"trace[62674191] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-m49gg; range_end:; response_count:1; response_revision:1002; }","duration":"180.608837ms","start":"2026-05-11T07:27:41.1381Z","end":"2026-05-11T07:27:41.318709Z","steps":["trace[62674191] 'agreement among raft nodes before linearized reading' (duration: 180.472952ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:41.318749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.723381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/rbd-csi-provisioner-role\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T07:27:41.318705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:27:40.875722Z","time spent":"442.976542ms","remote":"127.0.0.1:58090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":903,"request content":"key:\"/registry/serviceaccounts/monitoring/node-feature-discovery-gc\" "} {"level":"info","ts":"2026-05-11T07:27:41.318782Z","caller":"traceutil/trace.go:171","msg":"trace[2066554840] range","detail":"{range_begin:/registry/clusterrolebindings/rbd-csi-provisioner-role; range_end:; response_count:0; response_revision:1002; }","duration":"437.783783ms","start":"2026-05-11T07:27:40.88099Z","end":"2026-05-11T07:27:41.318773Z","steps":["trace[2066554840] 'agreement among raft nodes before linearized reading' (duration: 437.734661ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:41.318806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:27:40.880974Z","time spent":"437.827445ms","remote":"127.0.0.1:58240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/clusterrolebindings/rbd-csi-provisioner-role\" "} {"level":"warn","ts":"2026-05-11T07:27:41.318805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.379608ms","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-05-11T07:27:41.318869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.795065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:27:41.318861Z","caller":"traceutil/trace.go:171","msg":"trace[1370749385] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1002; }","duration":"282.488731ms","start":"2026-05-11T07:27:41.036354Z","end":"2026-05-11T07:27:41.318843Z","steps":["trace[1370749385] 'agreement among raft nodes before linearized reading' (duration: 282.297805ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:41.318891Z","caller":"traceutil/trace.go:171","msg":"trace[1151961242] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1002; }","duration":"141.825465ms","start":"2026-05-11T07:27:41.177058Z","end":"2026-05-11T07:27:41.318884Z","steps":["trace[1151961242] 'agreement among raft nodes before linearized reading' (duration: 141.783704ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:41.318907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.085968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:27:41.318933Z","caller":"traceutil/trace.go:171","msg":"trace[1520750140] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1002; }","duration":"160.13335ms","start":"2026-05-11T07:27:41.15879Z","end":"2026-05-11T07:27:41.318924Z","steps":["trace[1520750140] 'agreement among raft nodes before linearized reading' (duration: 160.091338ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:41.318746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:27:40.875531Z","time spent":"443.202549ms","remote":"127.0.0.1:58090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":897,"request content":"key:\"/registry/serviceaccounts/monitoring/node-feature-discovery\" "} {"level":"info","ts":"2026-05-11T07:27:42.067449Z","caller":"traceutil/trace.go:171","msg":"trace[2047982828] transaction","detail":"{read_only:false; response_revision:1177; number_of_response:1; }","duration":"101.773473ms","start":"2026-05-11T07:27:41.965639Z","end":"2026-05-11T07:27:42.067412Z","steps":["trace[2047982828] 'process raft request' (duration: 61.38499ms)","trace[2047982828] 'compare' (duration: 40.159495ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:27:42.093708Z","caller":"traceutil/trace.go:171","msg":"trace[1413118475] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"117.827106ms","start":"2026-05-11T07:27:41.975839Z","end":"2026-05-11T07:27:42.093666Z","steps":["trace[1413118475] 'process raft request' (duration: 117.599138ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:42.093945Z","caller":"traceutil/trace.go:171","msg":"trace[868902768] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"112.455958ms","start":"2026-05-11T07:27:41.981456Z","end":"2026-05-11T07:27:42.093912Z","steps":["trace[868902768] 'process raft request' (duration: 112.152828ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:42.094133Z","caller":"traceutil/trace.go:171","msg":"trace[755371513] linearizableReadLoop","detail":"{readStateIndex:1213; appliedIndex:1210; }","duration":"107.056881ms","start":"2026-05-11T07:27:41.987066Z","end":"2026-05-11T07:27:42.094123Z","steps":["trace[755371513] 'read index received' (duration: 39.973364ms)","trace[755371513] 'applied index is now lower than readState.Index' (duration: 67.082437ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T07:27:42.094318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.236066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/cert-manager/cert-manager-webhook\" ","response":"range_response_count:1 size:971"} {"level":"info","ts":"2026-05-11T07:27:42.094433Z","caller":"traceutil/trace.go:171","msg":"trace[327015018] range","detail":"{range_begin:/registry/serviceaccounts/cert-manager/cert-manager-webhook; range_end:; response_count:1; response_revision:1181; }","duration":"107.352331ms","start":"2026-05-11T07:27:41.986997Z","end":"2026-05-11T07:27:42.094349Z","steps":["trace[327015018] 'agreement among raft nodes before linearized reading' (duration: 107.194496ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:42.14497Z","caller":"traceutil/trace.go:171","msg":"trace[523574805] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"111.143264ms","start":"2026-05-11T07:27:42.033806Z","end":"2026-05-11T07:27:42.144949Z","steps":["trace[523574805] 'process raft request' (duration: 110.570415ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:42.145259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.330173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-tvsvr\" ","response":"range_response_count:1 size:4880"} {"level":"info","ts":"2026-05-11T07:27:42.145348Z","caller":"traceutil/trace.go:171","msg":"trace[173003953] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-tvsvr; range_end:; response_count:1; response_revision:1183; }","duration":"132.455267ms","start":"2026-05-11T07:27:42.012871Z","end":"2026-05-11T07:27:42.145326Z","steps":["trace[173003953] 'agreement among raft nodes before linearized reading' (duration: 132.186618ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:42.145366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.405178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/cert-manager/cert-manager-cainjector\" ","response":"range_response_count:1 size:986"} {"level":"info","ts":"2026-05-11T07:27:42.145408Z","caller":"traceutil/trace.go:171","msg":"trace[1708193980] range","detail":"{range_begin:/registry/serviceaccounts/cert-manager/cert-manager-cainjector; range_end:; response_count:1; response_revision:1183; }","duration":"157.459109ms","start":"2026-05-11T07:27:41.987926Z","end":"2026-05-11T07:27:42.145385Z","steps":["trace[1708193980] 'agreement among raft nodes before linearized reading' (duration: 157.333875ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:42.145638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.394301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/cert-manager/cert-manager\" ","response":"range_response_count:1 size:968"} {"level":"info","ts":"2026-05-11T07:27:42.145708Z","caller":"traceutil/trace.go:171","msg":"trace[1461936262] range","detail":"{range_begin:/registry/serviceaccounts/cert-manager/cert-manager; range_end:; response_count:1; response_revision:1183; }","duration":"158.497614ms","start":"2026-05-11T07:27:41.987195Z","end":"2026-05-11T07:27:42.145693Z","steps":["trace[1461936262] 'agreement among raft nodes before linearized reading' (duration: 158.301018ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:48.975987Z","caller":"traceutil/trace.go:171","msg":"trace[1802101164] transaction","detail":"{read_only:false; response_revision:1371; number_of_response:1; }","duration":"138.186108ms","start":"2026-05-11T07:27:48.837775Z","end":"2026-05-11T07:27:48.975961Z","steps":["trace[1802101164] 'process raft request' (duration: 138.109855ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:48.976087Z","caller":"traceutil/trace.go:171","msg":"trace[1743397317] transaction","detail":"{read_only:false; response_revision:1370; number_of_response:1; }","duration":"140.679487ms","start":"2026-05-11T07:27:48.835359Z","end":"2026-05-11T07:27:48.976039Z","steps":["trace[1743397317] 'process raft request' (duration: 140.419238ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:49.163312Z","caller":"traceutil/trace.go:171","msg":"trace[2049741962] transaction","detail":"{read_only:false; response_revision:1373; number_of_response:1; }","duration":"139.093769ms","start":"2026-05-11T07:27:49.024176Z","end":"2026-05-11T07:27:49.16327Z","steps":["trace[2049741962] 'process raft request' (duration: 43.856085ms)","trace[2049741962] 'compare' (duration: 95.040087ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:27:49.195308Z","caller":"traceutil/trace.go:171","msg":"trace[1392591123] linearizableReadLoop","detail":"{readStateIndex:1413; appliedIndex:1410; }","duration":"156.756286ms","start":"2026-05-11T07:27:49.038526Z","end":"2026-05-11T07:27:49.195282Z","steps":["trace[1392591123] 'read index received' (duration: 29.50354ms)","trace[1392591123] 'applied index is now lower than readState.Index' (duration: 127.251776ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:27:49.195353Z","caller":"traceutil/trace.go:171","msg":"trace[893824591] transaction","detail":"{read_only:false; response_revision:1374; number_of_response:1; }","duration":"170.57978ms","start":"2026-05-11T07:27:49.024738Z","end":"2026-05-11T07:27:49.195318Z","steps":["trace[893824591] 'process raft request' (duration: 170.341442ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:49.195432Z","caller":"traceutil/trace.go:171","msg":"trace[819160911] transaction","detail":"{read_only:false; response_revision:1375; number_of_response:1; }","duration":"167.01401ms","start":"2026-05-11T07:27:49.028388Z","end":"2026-05-11T07:27:49.195402Z","steps":["trace[819160911] 'process raft request' (duration: 166.837634ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:49.195549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.996035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/\" range_end:\"/registry/secrets/openstack0\" ","response":"range_response_count:3 size:31386"} {"level":"info","ts":"2026-05-11T07:27:49.195592Z","caller":"traceutil/trace.go:171","msg":"trace[1004952978] range","detail":"{range_begin:/registry/secrets/openstack/; range_end:/registry/secrets/openstack0; response_count:3; response_revision:1375; }","duration":"157.062218ms","start":"2026-05-11T07:27:49.038519Z","end":"2026-05-11T07:27:49.195582Z","steps":["trace[1004952978] 'agreement among raft nodes before linearized reading' (duration: 156.860959ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:49.325964Z","caller":"traceutil/trace.go:171","msg":"trace[513144006] linearizableReadLoop","detail":"{readStateIndex:1415; appliedIndex:1413; }","duration":"121.118261ms","start":"2026-05-11T07:27:49.204821Z","end":"2026-05-11T07:27:49.325939Z","steps":["trace[513144006] 'read index received' (duration: 729.586µs)","trace[513144006] 'applied index is now lower than readState.Index' (duration: 120.387745ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:27:49.325986Z","caller":"traceutil/trace.go:171","msg":"trace[75418349] transaction","detail":"{read_only:false; response_revision:1376; number_of_response:1; }","duration":"126.096874ms","start":"2026-05-11T07:27:49.199864Z","end":"2026-05-11T07:27:49.325961Z","steps":["trace[75418349] 'process raft request' (duration: 125.923428ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:49.326322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.464855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-qk9td\" ","response":"range_response_count:1 size:9894"} {"level":"info","ts":"2026-05-11T07:27:49.326407Z","caller":"traceutil/trace.go:171","msg":"trace[780288371] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-qk9td; range_end:; response_count:1; response_revision:1376; }","duration":"121.586428ms","start":"2026-05-11T07:27:49.2048Z","end":"2026-05-11T07:27:49.326387Z","steps":["trace[780288371] 'agreement among raft nodes before linearized reading' (duration: 121.254366ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:49.44395Z","caller":"traceutil/trace.go:171","msg":"trace[1010643696] transaction","detail":"{read_only:false; response_revision:1377; number_of_response:1; }","duration":"105.992538ms","start":"2026-05-11T07:27:49.337924Z","end":"2026-05-11T07:27:49.443917Z","steps":["trace[1010643696] 'process raft request' (duration: 105.77577ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:49.610353Z","caller":"traceutil/trace.go:171","msg":"trace[1687793423] linearizableReadLoop","detail":"{readStateIndex:1417; appliedIndex:1416; }","duration":"157.868327ms","start":"2026-05-11T07:27:49.452462Z","end":"2026-05-11T07:27:49.61033Z","steps":["trace[1687793423] 'read index received' (duration: 140.18997ms)","trace[1687793423] 'applied index is now lower than readState.Index' (duration: 17.677377ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:27:49.610494Z","caller":"traceutil/trace.go:171","msg":"trace[1052245173] transaction","detail":"{read_only:false; response_revision:1378; number_of_response:1; }","duration":"161.571402ms","start":"2026-05-11T07:27:49.448871Z","end":"2026-05-11T07:27:49.610442Z","steps":["trace[1052245173] 'process raft request' (duration: 143.854793ms)","trace[1052245173] 'compare' (duration: 17.493091ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T07:27:49.61058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.976751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T07:27:49.610609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.148557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/openvswitch-server\" ","response":"range_response_count:1 size:543"} {"level":"info","ts":"2026-05-11T07:27:49.610632Z","caller":"traceutil/trace.go:171","msg":"trace[613654564] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1378; }","duration":"105.063855ms","start":"2026-05-11T07:27:49.505554Z","end":"2026-05-11T07:27:49.610618Z","steps":["trace[613654564] 'agreement among raft nodes before linearized reading' (duration: 104.970371ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:49.610639Z","caller":"traceutil/trace.go:171","msg":"trace[825732038] range","detail":"{range_begin:/registry/serviceaccounts/openstack/openvswitch-server; range_end:; response_count:1; response_revision:1378; }","duration":"158.202619ms","start":"2026-05-11T07:27:49.452427Z","end":"2026-05-11T07:27:49.61063Z","steps":["trace[825732038] 'agreement among raft nodes before linearized reading' (duration: 158.082785ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:49.805039Z","caller":"traceutil/trace.go:171","msg":"trace[515286666] linearizableReadLoop","detail":"{readStateIndex:1418; appliedIndex:1417; }","duration":"102.091265ms","start":"2026-05-11T07:27:49.70292Z","end":"2026-05-11T07:27:49.805012Z","steps":["trace[515286666] 'read index received' (duration: 67.339494ms)","trace[515286666] 'applied index is now lower than readState.Index' (duration: 34.750611ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:27:49.805157Z","caller":"traceutil/trace.go:171","msg":"trace[1869963122] transaction","detail":"{read_only:false; response_revision:1379; number_of_response:1; }","duration":"175.847194ms","start":"2026-05-11T07:27:49.629274Z","end":"2026-05-11T07:27:49.805121Z","steps":["trace[1869963122] 'process raft request' (duration: 140.920076ms)","trace[1869963122] 'compare' (duration: 34.689209ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T07:27:49.805315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.374196ms","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-05-11T07:27:49.805383Z","caller":"traceutil/trace.go:171","msg":"trace[1865223990] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1379; }","duration":"102.49753ms","start":"2026-05-11T07:27:49.702868Z","end":"2026-05-11T07:27:49.805365Z","steps":["trace[1865223990] 'agreement among raft nodes before linearized reading' (duration: 102.249561ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:50.043636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.542605ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T07:27:50.043751Z","caller":"traceutil/trace.go:171","msg":"trace[1099554672] linearizableReadLoop","detail":"{readStateIndex:1420; appliedIndex:1419; }","duration":"163.130105ms","start":"2026-05-11T07:27:49.880604Z","end":"2026-05-11T07:27:50.043734Z","steps":["trace[1099554672] 'read index received' (duration: 59.489976ms)","trace[1099554672] 'applied index is now lower than readState.Index' (duration: 103.638889ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:27:50.043777Z","caller":"traceutil/trace.go:171","msg":"trace[1309786201] transaction","detail":"{read_only:false; response_revision:1381; number_of_response:1; }","duration":"190.590931ms","start":"2026-05-11T07:27:49.853159Z","end":"2026-05-11T07:27:50.04375Z","steps":["trace[1309786201] 'process raft request' (duration: 86.854688ms)","trace[1309786201] 'compare' (duration: 103.414441ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T07:27:50.04385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.246949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:27:50.043887Z","caller":"traceutil/trace.go:171","msg":"trace[1910239584] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:1381; }","duration":"163.312001ms","start":"2026-05-11T07:27:49.880565Z","end":"2026-05-11T07:27:50.043877Z","steps":["trace[1910239584] 'agreement among raft nodes before linearized reading' (duration: 163.245859ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:50.130936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.341821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:27:50.131003Z","caller":"traceutil/trace.go:171","msg":"trace[444190884] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:1382; }","duration":"177.444104ms","start":"2026-05-11T07:27:49.953542Z","end":"2026-05-11T07:27:50.130986Z","steps":["trace[444190884] 'agreement among raft nodes before linearized reading' (duration: 177.336541ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:50.131165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.59542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:27:50.131276Z","caller":"traceutil/trace.go:171","msg":"trace[642627915] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:1382; }","duration":"177.750297ms","start":"2026-05-11T07:27:49.953505Z","end":"2026-05-11T07:27:50.131255Z","steps":["trace[642627915] 'agreement among raft nodes before linearized reading' (duration: 177.57178ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:50.131394Z","caller":"traceutil/trace.go:171","msg":"trace[135045546] transaction","detail":"{read_only:false; response_revision:1382; number_of_response:1; }","duration":"199.586237ms","start":"2026-05-11T07:27:49.931792Z","end":"2026-05-11T07:27:50.131378Z","steps":["trace[135045546] 'process raft request' (duration: 198.719924ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:50.131544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.941459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:27:50.131579Z","caller":"traceutil/trace.go:171","msg":"trace[134178516] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:1382; }","duration":"193.987062ms","start":"2026-05-11T07:27:49.937583Z","end":"2026-05-11T07:27:50.13157Z","steps":["trace[134178516] 'agreement among raft nodes before linearized reading' (duration: 193.93083ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:50.131753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.367205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:27:50.131791Z","caller":"traceutil/trace.go:171","msg":"trace[1881023401] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:1382; }","duration":"194.411017ms","start":"2026-05-11T07:27:49.937366Z","end":"2026-05-11T07:27:50.131777Z","steps":["trace[1881023401] 'agreement among raft nodes before linearized reading' (duration: 194.361826ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:50.131901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.540802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:27:50.131926Z","caller":"traceutil/trace.go:171","msg":"trace[2118889201] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:1382; }","duration":"194.580724ms","start":"2026-05-11T07:27:49.937339Z","end":"2026-05-11T07:27:50.131919Z","steps":["trace[2118889201] 'agreement among raft nodes before linearized reading' (duration: 194.542952ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:50.132035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.586636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:27:50.132065Z","caller":"traceutil/trace.go:171","msg":"trace[1394045504] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:1382; }","duration":"211.626887ms","start":"2026-05-11T07:27:49.920428Z","end":"2026-05-11T07:27:50.132055Z","steps":["trace[1394045504] 'agreement among raft nodes before linearized reading' (duration: 211.585885ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:50.132199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.777803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:27:50.132224Z","caller":"traceutil/trace.go:171","msg":"trace[911685320] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:1382; }","duration":"211.814183ms","start":"2026-05-11T07:27:49.920403Z","end":"2026-05-11T07:27:50.132217Z","steps":["trace[911685320] 'agreement among raft nodes before linearized reading' (duration: 211.773272ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:50.132382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.072099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:27:50.132416Z","caller":"traceutil/trace.go:171","msg":"trace[896408582] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:1382; }","duration":"213.130171ms","start":"2026-05-11T07:27:49.919274Z","end":"2026-05-11T07:27:50.132405Z","steps":["trace[896408582] 'agreement among raft nodes before linearized reading' (duration: 213.08115ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:50.132389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.584661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T07:27:50.132479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.505809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T07:27:50.132544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.192178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:27:50.132578Z","caller":"traceutil/trace.go:171","msg":"trace[1386119418] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:1382; }","duration":"235.260501ms","start":"2026-05-11T07:27:49.897308Z","end":"2026-05-11T07:27:50.132569Z","steps":["trace[1386119418] 'agreement among raft nodes before linearized reading' (duration: 235.206109ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:50.132586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.574177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:27:50.132619Z","caller":"traceutil/trace.go:171","msg":"trace[1804568283] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:1382; }","duration":"125.64951ms","start":"2026-05-11T07:27:50.00696Z","end":"2026-05-11T07:27:50.13261Z","steps":["trace[1804568283] 'agreement among raft nodes before linearized reading' (duration: 125.602518ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:50.132671Z","caller":"traceutil/trace.go:171","msg":"trace[590821202] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:1382; }","duration":"124.822209ms","start":"2026-05-11T07:27:50.007675Z","end":"2026-05-11T07:27:50.132498Z","steps":["trace[590821202] 'agreement among raft nodes before linearized reading' (duration: 124.566079ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:50.132702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.911145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T07:27:50.132747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.894733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T07:27:50.132815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.094346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T07:27:50.132828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.088822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:27:50.132825Z","caller":"traceutil/trace.go:171","msg":"trace[215829577] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:1382; }","duration":"160.007337ms","start":"2026-05-11T07:27:49.972801Z","end":"2026-05-11T07:27:50.132808Z","steps":["trace[215829577] 'agreement among raft nodes before linearized reading' (duration: 159.855522ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:50.132852Z","caller":"traceutil/trace.go:171","msg":"trace[1924178735] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:1382; }","duration":"236.138743ms","start":"2026-05-11T07:27:49.896706Z","end":"2026-05-11T07:27:50.132845Z","steps":["trace[1924178735] 'agreement among raft nodes before linearized reading' (duration: 236.093841ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:50.132853Z","caller":"traceutil/trace.go:171","msg":"trace[1087257414] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:1382; }","duration":"126.152488ms","start":"2026-05-11T07:27:50.00669Z","end":"2026-05-11T07:27:50.132843Z","steps":["trace[1087257414] 'agreement among raft nodes before linearized reading' (duration: 126.096566ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:50.133027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.460193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T07:27:50.133061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.837327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:27:50.133099Z","caller":"traceutil/trace.go:171","msg":"trace[1995025734] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:1382; }","duration":"178.880678ms","start":"2026-05-11T07:27:49.954208Z","end":"2026-05-11T07:27:50.133088Z","steps":["trace[1995025734] 'agreement among raft nodes before linearized reading' (duration: 178.826917ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:50.13311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.419529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:27:50.133136Z","caller":"traceutil/trace.go:171","msg":"trace[203321304] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:1382; }","duration":"252.45337ms","start":"2026-05-11T07:27:49.880674Z","end":"2026-05-11T07:27:50.133127Z","steps":["trace[203321304] 'agreement among raft nodes before linearized reading' (duration: 252.414798ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:50.133146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.246358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:27:50.133176Z","caller":"traceutil/trace.go:171","msg":"trace[76162643] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:1382; }","duration":"142.276689ms","start":"2026-05-11T07:27:49.990889Z","end":"2026-05-11T07:27:50.133166Z","steps":["trace[76162643] 'agreement among raft nodes before linearized reading' (duration: 142.233828ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:50.132777Z","caller":"traceutil/trace.go:171","msg":"trace[1505562140] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:1382; }","duration":"236.024328ms","start":"2026-05-11T07:27:49.896735Z","end":"2026-05-11T07:27:50.132759Z","steps":["trace[1505562140] 'agreement among raft nodes before linearized reading' (duration: 235.876363ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:50.133337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.269917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:27:50.133373Z","caller":"traceutil/trace.go:171","msg":"trace[529944876] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:1382; }","duration":"160.315129ms","start":"2026-05-11T07:27:49.97305Z","end":"2026-05-11T07:27:50.133365Z","steps":["trace[529944876] 'agreement among raft nodes before linearized reading' (duration: 160.257797ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:50.132541Z","caller":"traceutil/trace.go:171","msg":"trace[763587625] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:1382; }","duration":"159.604923ms","start":"2026-05-11T07:27:49.972921Z","end":"2026-05-11T07:27:50.132526Z","steps":["trace[763587625] 'agreement among raft nodes before linearized reading' (duration: 159.504379ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:50.133064Z","caller":"traceutil/trace.go:171","msg":"trace[797176605] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:1382; }","duration":"140.548436ms","start":"2026-05-11T07:27:49.992506Z","end":"2026-05-11T07:27:50.133054Z","steps":["trace[797176605] 'agreement among raft nodes before linearized reading' (duration: 140.496504ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:50.133104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.183127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:27:50.133622Z","caller":"traceutil/trace.go:171","msg":"trace[1319472117] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:1382; }","duration":"142.729927ms","start":"2026-05-11T07:27:49.990881Z","end":"2026-05-11T07:27:50.133611Z","steps":["trace[1319472117] 'agreement among raft nodes before linearized reading' (duration: 142.201837ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:50.133075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.801567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:27:50.133724Z","caller":"traceutil/trace.go:171","msg":"trace[231137187] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:1382; }","duration":"252.45508ms","start":"2026-05-11T07:27:49.881255Z","end":"2026-05-11T07:27:50.13371Z","steps":["trace[231137187] 'agreement among raft nodes before linearized reading' (duration: 251.762555ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:52.968626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.003091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-qk9td\" ","response":"range_response_count:1 size:11927"} {"level":"info","ts":"2026-05-11T07:27:52.968733Z","caller":"traceutil/trace.go:171","msg":"trace[1894091684] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-qk9td; range_end:; response_count:1; response_revision:1408; }","duration":"123.148846ms","start":"2026-05-11T07:27:52.845559Z","end":"2026-05-11T07:27:52.968707Z","steps":["trace[1894091684] 'range keys from in-memory index tree' (duration: 122.835464ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:52.968741Z","caller":"traceutil/trace.go:171","msg":"trace[600608460] transaction","detail":"{read_only:false; response_revision:1409; number_of_response:1; }","duration":"122.47242ms","start":"2026-05-11T07:27:52.846244Z","end":"2026-05-11T07:27:52.968716Z","steps":["trace[600608460] 'process raft request' (duration: 120.197245ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:56.059046Z","caller":"traceutil/trace.go:171","msg":"trace[275396597] linearizableReadLoop","detail":"{readStateIndex:1572; appliedIndex:1571; }","duration":"144.376299ms","start":"2026-05-11T07:27:55.914644Z","end":"2026-05-11T07:27:56.05902Z","steps":["trace[275396597] 'read index received' (duration: 144.202061ms)","trace[275396597] 'applied index is now lower than readState.Index' (duration: 173.048µs)"],"step_count":2} {"level":"warn","ts":"2026-05-11T07:27:56.059265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.599087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/cert-manager/cert-manager-cainjector-64b59ddb75-b77l5\" ","response":"range_response_count:1 size:3666"} {"level":"info","ts":"2026-05-11T07:27:56.059312Z","caller":"traceutil/trace.go:171","msg":"trace[216954806] range","detail":"{range_begin:/registry/pods/cert-manager/cert-manager-cainjector-64b59ddb75-b77l5; range_end:; response_count:1; response_revision:1532; }","duration":"144.678641ms","start":"2026-05-11T07:27:55.91462Z","end":"2026-05-11T07:27:56.059299Z","steps":["trace[216954806] 'agreement among raft nodes before linearized reading' (duration: 144.518554ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:56.059576Z","caller":"traceutil/trace.go:171","msg":"trace[2019247100] transaction","detail":"{read_only:false; response_revision:1532; number_of_response:1; }","duration":"146.882407ms","start":"2026-05-11T07:27:55.912681Z","end":"2026-05-11T07:27:56.059563Z","steps":["trace[2019247100] 'process raft request' (duration: 146.173238ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:58.311245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.619165ms","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-05-11T07:27:58.311384Z","caller":"traceutil/trace.go:171","msg":"trace[1896962179] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1564; }","duration":"221.798003ms","start":"2026-05-11T07:27:58.089564Z","end":"2026-05-11T07:27:58.311362Z","steps":["trace[1896962179] 'range keys from in-memory index tree' (duration: 221.593824ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:58.311881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.494452ms","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-05-11T07:27:58.311934Z","caller":"traceutil/trace.go:171","msg":"trace[401890223] transaction","detail":"{read_only:false; response_revision:1565; number_of_response:1; }","duration":"231.395137ms","start":"2026-05-11T07:27:58.080512Z","end":"2026-05-11T07:27:58.311907Z","steps":["trace[401890223] 'process raft request' (duration: 212.957718ms)","trace[401890223] 'compare' (duration: 17.741081ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:27:58.311916Z","caller":"traceutil/trace.go:171","msg":"trace[198313480] linearizableReadLoop","detail":"{readStateIndex:1605; appliedIndex:1604; }","duration":"134.124157ms","start":"2026-05-11T07:27:58.177746Z","end":"2026-05-11T07:27:58.31187Z","steps":["trace[198313480] 'read index received' (duration: 115.693758ms)","trace[198313480] 'applied index is now lower than readState.Index' (duration: 18.428639ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:27:58.311993Z","caller":"traceutil/trace.go:171","msg":"trace[194108233] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1564; }","duration":"248.66601ms","start":"2026-05-11T07:27:58.063302Z","end":"2026-05-11T07:27:58.311968Z","steps":["trace[194108233] 'range keys from in-memory index tree' (duration: 248.283764ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:58.312107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.332626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:27:58.312167Z","caller":"traceutil/trace.go:171","msg":"trace[756778026] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1565; }","duration":"134.452711ms","start":"2026-05-11T07:27:58.177693Z","end":"2026-05-11T07:27:58.312146Z","steps":["trace[756778026] 'agreement among raft nodes before linearized reading' (duration: 134.325296ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:58.51584Z","caller":"traceutil/trace.go:171","msg":"trace[246222465] transaction","detail":"{read_only:false; response_revision:1566; number_of_response:1; }","duration":"199.174256ms","start":"2026-05-11T07:27:58.316638Z","end":"2026-05-11T07:27:58.515812Z","steps":["trace[246222465] 'process raft request' (duration: 127.192089ms)","trace[246222465] 'compare' (duration: 71.849801ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T07:27:58.756974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.290691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-cpw7v\" ","response":"range_response_count:1 size:6441"} {"level":"warn","ts":"2026-05-11T07:27:58.756988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.869625ms","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-05-11T07:27:58.757049Z","caller":"traceutil/trace.go:171","msg":"trace[388854084] range","detail":"{range_begin:/registry/pods/openstack/keepalived-cpw7v; range_end:; response_count:1; response_revision:1566; }","duration":"102.379725ms","start":"2026-05-11T07:27:58.654652Z","end":"2026-05-11T07:27:58.757032Z","steps":["trace[388854084] 'range keys from in-memory index tree' (duration: 102.111384ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:58.757106Z","caller":"traceutil/trace.go:171","msg":"trace[1726335296] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1566; }","duration":"106.039112ms","start":"2026-05-11T07:27:58.65102Z","end":"2026-05-11T07:27:58.757059Z","steps":["trace[1726335296] 'range keys from in-memory index tree' (duration: 105.590364ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:27:58.906817Z","caller":"traceutil/trace.go:171","msg":"trace[911421914] linearizableReadLoop","detail":"{readStateIndex:1607; appliedIndex:1606; }","duration":"145.147189ms","start":"2026-05-11T07:27:58.761644Z","end":"2026-05-11T07:27:58.906791Z","steps":["trace[911421914] 'read index received' (duration: 144.932891ms)","trace[911421914] 'applied index is now lower than readState.Index' (duration: 209.638µs)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:27:58.906857Z","caller":"traceutil/trace.go:171","msg":"trace[669395134] transaction","detail":"{read_only:false; response_revision:1567; number_of_response:1; }","duration":"145.645139ms","start":"2026-05-11T07:27:58.761174Z","end":"2026-05-11T07:27:58.906819Z","steps":["trace[669395134] 'process raft request' (duration: 145.41867ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:58.907056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.529984ms","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-05-11T07:27:58.907093Z","caller":"traceutil/trace.go:171","msg":"trace[1238725851] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1567; }","duration":"137.624907ms","start":"2026-05-11T07:27:58.769458Z","end":"2026-05-11T07:27:58.907083Z","steps":["trace[1238725851] 'agreement among raft nodes before linearized reading' (duration: 137.480351ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:58.907232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.537345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:3 size:26789"} {"level":"info","ts":"2026-05-11T07:27:58.907356Z","caller":"traceutil/trace.go:171","msg":"trace[1572972279] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:3; response_revision:1567; }","duration":"145.712852ms","start":"2026-05-11T07:27:58.761618Z","end":"2026-05-11T07:27:58.907331Z","steps":["trace[1572972279] 'agreement among raft nodes before linearized reading' (duration: 145.294745ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:27:59.222009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.179129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:27:59.222102Z","caller":"traceutil/trace.go:171","msg":"trace[936806747] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1568; }","duration":"137.301034ms","start":"2026-05-11T07:27:59.08478Z","end":"2026-05-11T07:27:59.222081Z","steps":["trace[936806747] 'count revisions from in-memory index tree' (duration: 137.072425ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:28:01.824461Z","caller":"traceutil/trace.go:171","msg":"trace[1073353698] transaction","detail":"{read_only:false; response_revision:1674; number_of_response:1; }","duration":"153.709796ms","start":"2026-05-11T07:28:01.670731Z","end":"2026-05-11T07:28:01.824441Z","steps":["trace[1073353698] 'process raft request' (duration: 153.588051ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:28:02.035274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.052005ms","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-05-11T07:28:02.035357Z","caller":"traceutil/trace.go:171","msg":"trace[82008649] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1674; }","duration":"149.18549ms","start":"2026-05-11T07:28:01.886152Z","end":"2026-05-11T07:28:02.035337Z","steps":["trace[82008649] 'range keys from in-memory index tree' (duration: 148.814495ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:28:03.102002Z","caller":"traceutil/trace.go:171","msg":"trace[2079819481] linearizableReadLoop","detail":"{readStateIndex:1732; appliedIndex:1731; }","duration":"177.373384ms","start":"2026-05-11T07:28:02.924611Z","end":"2026-05-11T07:28:03.101985Z","steps":["trace[2079819481] 'read index received' (duration: 177.230508ms)","trace[2079819481] 'applied index is now lower than readState.Index' (duration: 142.016µs)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:28:03.102107Z","caller":"traceutil/trace.go:171","msg":"trace[44940333] transaction","detail":"{read_only:false; response_revision:1689; number_of_response:1; }","duration":"180.756263ms","start":"2026-05-11T07:28:02.921321Z","end":"2026-05-11T07:28:03.102077Z","steps":["trace[44940333] 'process raft request' (duration: 180.549625ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:28:03.102239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.612323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:7 size:61993"} {"level":"info","ts":"2026-05-11T07:28:03.102264Z","caller":"traceutil/trace.go:171","msg":"trace[176715110] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:7; response_revision:1689; }","duration":"177.692847ms","start":"2026-05-11T07:28:02.924566Z","end":"2026-05-11T07:28:03.102259Z","steps":["trace[176715110] 'agreement among raft nodes before linearized reading' (duration: 177.52044ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:28:03.102254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.03469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-11T07:28:03.102266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.571242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/ovn-northd-7659bd74f8-9h85d\" ","response":"range_response_count:1 size:6894"} {"level":"warn","ts":"2026-05-11T07:28:03.102304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.481191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/ovn-controller-default-njjx2.18ae72368bbd74c1\" ","response":"range_response_count:1 size:782"} {"level":"info","ts":"2026-05-11T07:28:03.10232Z","caller":"traceutil/trace.go:171","msg":"trace[894109648] range","detail":"{range_begin:/registry/pods/openstack/ovn-northd-7659bd74f8-9h85d; range_end:; response_count:1; response_revision:1689; }","duration":"177.650445ms","start":"2026-05-11T07:28:02.924657Z","end":"2026-05-11T07:28:03.102307Z","steps":["trace[894109648] 'agreement among raft nodes before linearized reading' (duration: 177.452097ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:28:03.102354Z","caller":"traceutil/trace.go:171","msg":"trace[1466178597] range","detail":"{range_begin:/registry/events/openstack/ovn-controller-default-njjx2.18ae72368bbd74c1; range_end:; response_count:1; response_revision:1689; }","duration":"132.567734ms","start":"2026-05-11T07:28:02.96977Z","end":"2026-05-11T07:28:03.102338Z","steps":["trace[1466178597] 'agreement among raft nodes before linearized reading' (duration: 132.424738ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:28:03.102382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.194969ms","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-05-11T07:28:03.102308Z","caller":"traceutil/trace.go:171","msg":"trace[1942677498] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1689; }","duration":"171.107033ms","start":"2026-05-11T07:28:02.931185Z","end":"2026-05-11T07:28:03.102292Z","steps":["trace[1942677498] 'agreement among raft nodes before linearized reading' (duration: 170.980228ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:28:03.10242Z","caller":"traceutil/trace.go:171","msg":"trace[1759664309] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1689; }","duration":"172.258561ms","start":"2026-05-11T07:28:02.93015Z","end":"2026-05-11T07:28:03.102408Z","steps":["trace[1759664309] 'agreement among raft nodes before linearized reading' (duration: 172.105665ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:28:05.095613Z","caller":"traceutil/trace.go:171","msg":"trace[932113701] transaction","detail":"{read_only:false; response_revision:1701; number_of_response:1; }","duration":"106.223159ms","start":"2026-05-11T07:28:04.989362Z","end":"2026-05-11T07:28:05.095585Z","steps":["trace[932113701] 'process raft request' (duration: 106.053482ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:28:05.945272Z","caller":"traceutil/trace.go:171","msg":"trace[1471343070] transaction","detail":"{read_only:false; response_revision:1704; number_of_response:1; }","duration":"100.93878ms","start":"2026-05-11T07:28:05.844312Z","end":"2026-05-11T07:28:05.94525Z","steps":["trace[1471343070] 'process raft request' (duration: 100.826694ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:28:10.08845Z","caller":"traceutil/trace.go:171","msg":"trace[1829556771] linearizableReadLoop","detail":"{readStateIndex:1763; appliedIndex:1762; }","duration":"131.939848ms","start":"2026-05-11T07:28:09.956488Z","end":"2026-05-11T07:28:10.088427Z","steps":["trace[1829556771] 'read index received' (duration: 131.847644ms)","trace[1829556771] 'applied index is now lower than readState.Index' (duration: 91.184µs)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:28:10.088548Z","caller":"traceutil/trace.go:171","msg":"trace[115413236] transaction","detail":"{read_only:false; response_revision:1718; number_of_response:1; }","duration":"218.328007ms","start":"2026-05-11T07:28:09.870184Z","end":"2026-05-11T07:28:10.088512Z","steps":["trace[115413236] 'process raft request' (duration: 218.098036ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:28:10.088632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.131647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-11T07:28:10.088664Z","caller":"traceutil/trace.go:171","msg":"trace[1980790213] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1718; }","duration":"132.215461ms","start":"2026-05-11T07:28:09.956439Z","end":"2026-05-11T07:28:10.088654Z","steps":["trace[1980790213] 'agreement among raft nodes before linearized reading' (duration: 132.075435ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:28:10.301243Z","caller":"traceutil/trace.go:171","msg":"trace[692643526] linearizableReadLoop","detail":"{readStateIndex:1766; appliedIndex:1765; }","duration":"125.573421ms","start":"2026-05-11T07:28:10.175639Z","end":"2026-05-11T07:28:10.301212Z","steps":["trace[692643526] 'read index received' (duration: 116.659819ms)","trace[692643526] 'applied index is now lower than readState.Index' (duration: 8.912092ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:28:10.301296Z","caller":"traceutil/trace.go:171","msg":"trace[919811628] transaction","detail":"{read_only:false; response_revision:1721; number_of_response:1; }","duration":"136.176478ms","start":"2026-05-11T07:28:10.165088Z","end":"2026-05-11T07:28:10.301264Z","steps":["trace[919811628] 'process raft request' (duration: 127.292447ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:28:10.301427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.763619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:28:10.301462Z","caller":"traceutil/trace.go:171","msg":"trace[1375627154] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1721; }","duration":"125.844703ms","start":"2026-05-11T07:28:10.175607Z","end":"2026-05-11T07:28:10.301451Z","steps":["trace[1375627154] 'agreement among raft nodes before linearized reading' (duration: 125.753918ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:28:10.301616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.006571ms","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-05-11T07:28:10.301665Z","caller":"traceutil/trace.go:171","msg":"trace[195949325] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1721; }","duration":"121.080265ms","start":"2026-05-11T07:28:10.180572Z","end":"2026-05-11T07:28:10.301652Z","steps":["trace[195949325] 'agreement among raft nodes before linearized reading' (duration: 120.892907ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:28:17.586269Z","caller":"traceutil/trace.go:171","msg":"trace[1884210475] transaction","detail":"{read_only:false; response_revision:1766; number_of_response:1; }","duration":"141.914364ms","start":"2026-05-11T07:28:17.444329Z","end":"2026-05-11T07:28:17.586244Z","steps":["trace[1884210475] 'process raft request' (duration: 141.742356ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:28:21.472457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.375323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/cert-manager-controller-approve:cert-manager-io\" ","response":"range_response_count:1 size:1207"} {"level":"info","ts":"2026-05-11T07:28:21.472547Z","caller":"traceutil/trace.go:171","msg":"trace[1993213390] range","detail":"{range_begin:/registry/clusterrolebindings/cert-manager-controller-approve:cert-manager-io; range_end:; response_count:1; response_revision:1799; }","duration":"125.501409ms","start":"2026-05-11T07:28:21.347027Z","end":"2026-05-11T07:28:21.472529Z","steps":["trace[1993213390] 'range keys from in-memory index tree' (duration: 125.247677ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:28:21.472503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.702334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/rbd-csi-nodeplugin\" ","response":"range_response_count:1 size:1080"} {"level":"info","ts":"2026-05-11T07:28:21.472693Z","caller":"traceutil/trace.go:171","msg":"trace[1164561856] range","detail":"{range_begin:/registry/clusterroles/rbd-csi-nodeplugin; range_end:; response_count:1; response_revision:1799; }","duration":"178.884892ms","start":"2026-05-11T07:28:21.293773Z","end":"2026-05-11T07:28:21.472658Z","steps":["trace[1164561856] 'range keys from in-memory index tree' (duration: 178.534486ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:28:22.399441Z","caller":"traceutil/trace.go:171","msg":"trace[1112155270] linearizableReadLoop","detail":"{readStateIndex:1850; appliedIndex:1849; }","duration":"200.682459ms","start":"2026-05-11T07:28:22.19873Z","end":"2026-05-11T07:28:22.399412Z","steps":["trace[1112155270] 'read index received' (duration: 172.712985ms)","trace[1112155270] 'applied index is now lower than readState.Index' (duration: 27.968274ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:28:22.399575Z","caller":"traceutil/trace.go:171","msg":"trace[2063652596] transaction","detail":"{read_only:false; response_revision:1803; number_of_response:1; }","duration":"204.786313ms","start":"2026-05-11T07:28:22.194752Z","end":"2026-05-11T07:28:22.399538Z","steps":["trace[2063652596] 'process raft request' (duration: 176.788528ms)","trace[2063652596] 'compare' (duration: 27.738423ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T07:28:22.399726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.976333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/cert-manager-controller-clusterissuers\" ","response":"range_response_count:1 size:1178"} {"level":"info","ts":"2026-05-11T07:28:22.399778Z","caller":"traceutil/trace.go:171","msg":"trace[195279096] range","detail":"{range_begin:/registry/clusterrolebindings/cert-manager-controller-clusterissuers; range_end:; response_count:1; response_revision:1803; }","duration":"201.058137ms","start":"2026-05-11T07:28:22.198703Z","end":"2026-05-11T07:28:22.399761Z","steps":["trace[195279096] 'agreement among raft nodes before linearized reading' (duration: 200.865108ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:28:22.399904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.846468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/rook-ceph-mgr-cluster\" ","response":"range_response_count:1 size:1052"} {"level":"info","ts":"2026-05-11T07:28:22.400026Z","caller":"traceutil/trace.go:171","msg":"trace[200948084] range","detail":"{range_begin:/registry/clusterroles/rook-ceph-mgr-cluster; range_end:; response_count:1; response_revision:1803; }","duration":"192.935303ms","start":"2026-05-11T07:28:22.207034Z","end":"2026-05-11T07:28:22.399969Z","steps":["trace[200948084] 'agreement among raft nodes before linearized reading' (duration: 192.712982ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:28:22.637306Z","caller":"traceutil/trace.go:171","msg":"trace[1265404803] linearizableReadLoop","detail":"{readStateIndex:1851; appliedIndex:1850; }","duration":"176.041672ms","start":"2026-05-11T07:28:22.461236Z","end":"2026-05-11T07:28:22.637277Z","steps":["trace[1265404803] 'read index received' (duration: 158.760664ms)","trace[1265404803] 'applied index is now lower than readState.Index' (duration: 17.279908ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:28:22.637374Z","caller":"traceutil/trace.go:171","msg":"trace[1368023700] transaction","detail":"{read_only:false; response_revision:1804; number_of_response:1; }","duration":"232.633471ms","start":"2026-05-11T07:28:22.404702Z","end":"2026-05-11T07:28:22.637335Z","steps":["trace[1368023700] 'process raft request' (duration: 215.27793ms)","trace[1368023700] 'compare' (duration: 17.162622ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T07:28:22.637582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.324516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:28:22.637716Z","caller":"traceutil/trace.go:171","msg":"trace[366411948] range","detail":"{range_begin:/registry/leases/ingress-nginx/ingress-nginx-leader; range_end:; response_count:0; response_revision:1804; }","duration":"176.509604ms","start":"2026-05-11T07:28:22.461181Z","end":"2026-05-11T07:28:22.63769Z","steps":["trace[366411948] 'agreement among raft nodes before linearized reading' (duration: 176.302925ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:28:22.869712Z","caller":"traceutil/trace.go:171","msg":"trace[117600431] transaction","detail":"{read_only:false; response_revision:1805; number_of_response:1; }","duration":"387.139864ms","start":"2026-05-11T07:28:22.482533Z","end":"2026-05-11T07:28:22.869673Z","steps":["trace[117600431] 'process raft request' (duration: 380.209265ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:28:22.87002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.110938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/rook-ceph-mgr-system\" ","response":"range_response_count:1 size:619"} {"level":"warn","ts":"2026-05-11T07:28:22.870017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.080675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/ovn-ovsdb-sb\" ","response":"range_response_count:1 size:520"} {"level":"info","ts":"2026-05-11T07:28:22.870073Z","caller":"traceutil/trace.go:171","msg":"trace[2082834743] range","detail":"{range_begin:/registry/clusterroles/rook-ceph-mgr-system; range_end:; response_count:1; response_revision:1806; }","duration":"385.214323ms","start":"2026-05-11T07:28:22.484848Z","end":"2026-05-11T07:28:22.870062Z","steps":["trace[2082834743] 'agreement among raft nodes before linearized reading' (duration: 385.048256ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:28:22.870093Z","caller":"traceutil/trace.go:171","msg":"trace[438920829] range","detail":"{range_begin:/registry/services/endpoints/openstack/ovn-ovsdb-sb; range_end:; response_count:1; response_revision:1806; }","duration":"296.214331ms","start":"2026-05-11T07:28:22.573861Z","end":"2026-05-11T07:28:22.870076Z","steps":["trace[438920829] 'agreement among raft nodes before linearized reading' (duration: 295.990901ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:28:22.870109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:28:22.484831Z","time spent":"385.269546ms","remote":"127.0.0.1:58238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":643,"request content":"key:\"/registry/clusterroles/rook-ceph-mgr-system\" "} {"level":"warn","ts":"2026-05-11T07:28:22.870111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.071124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/ovn-ovsdb-nb\" ","response":"range_response_count:1 size:520"} {"level":"info","ts":"2026-05-11T07:28:22.869779Z","caller":"traceutil/trace.go:171","msg":"trace[270141068] transaction","detail":"{read_only:false; response_revision:1806; number_of_response:1; }","duration":"246.878865ms","start":"2026-05-11T07:28:22.622874Z","end":"2026-05-11T07:28:22.869753Z","steps":["trace[270141068] 'process raft request' (duration: 246.77386ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:28:22.870234Z","caller":"traceutil/trace.go:171","msg":"trace[372659855] range","detail":"{range_begin:/registry/services/endpoints/openstack/ovn-ovsdb-nb; range_end:; response_count:1; response_revision:1806; }","duration":"296.244712ms","start":"2026-05-11T07:28:22.573969Z","end":"2026-05-11T07:28:22.870213Z","steps":["trace[372659855] 'agreement among raft nodes before linearized reading' (duration: 295.75796ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:28:22.870187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:28:22.482522Z","time spent":"387.454379ms","remote":"127.0.0.1:58154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T07:28:22.869731Z","caller":"traceutil/trace.go:171","msg":"trace[213066107] linearizableReadLoop","detail":"{readStateIndex:1853; appliedIndex:1851; }","duration":"232.330407ms","start":"2026-05-11T07:28:22.637382Z","end":"2026-05-11T07:28:22.869713Z","steps":["trace[213066107] 'read index received' (duration: 225.44712ms)","trace[213066107] 'applied index is now lower than readState.Index' (duration: 6.882377ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T07:28:22.870577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.433285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/rook-ceph-mgr-cluster\" ","response":"range_response_count:1 size:1052"} {"level":"info","ts":"2026-05-11T07:28:22.870651Z","caller":"traceutil/trace.go:171","msg":"trace[254518091] range","detail":"{range_begin:/registry/clusterroles/rook-ceph-mgr-cluster; range_end:; response_count:1; response_revision:1806; }","duration":"388.523749ms","start":"2026-05-11T07:28:22.482108Z","end":"2026-05-11T07:28:22.870631Z","steps":["trace[254518091] 'agreement among raft nodes before linearized reading' (duration: 387.663759ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:28:22.870666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.828331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/ingress-nginx/\" range_end:\"/registry/resourcequotas/ingress-nginx0\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T07:28:22.870679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.841453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T07:28:22.870706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:28:22.482101Z","time spent":"388.591083ms","remote":"127.0.0.1:58238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":1076,"request content":"key:\"/registry/clusterroles/rook-ceph-mgr-cluster\" "} {"level":"info","ts":"2026-05-11T07:28:22.870721Z","caller":"traceutil/trace.go:171","msg":"trace[2092140315] range","detail":"{range_begin:/registry/resourcequotas/ingress-nginx/; range_end:/registry/resourcequotas/ingress-nginx0; response_count:0; response_revision:1806; }","duration":"228.915155ms","start":"2026-05-11T07:28:22.641779Z","end":"2026-05-11T07:28:22.870695Z","steps":["trace[2092140315] 'agreement among raft nodes before linearized reading' (duration: 228.843802ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:28:22.870738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.964433ms","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-05-11T07:28:22.870801Z","caller":"traceutil/trace.go:171","msg":"trace[674810911] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1806; }","duration":"227.043006ms","start":"2026-05-11T07:28:22.643743Z","end":"2026-05-11T07:28:22.870786Z","steps":["trace[674810911] 'agreement among raft nodes before linearized reading' (duration: 226.90053ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:28:22.870742Z","caller":"traceutil/trace.go:171","msg":"trace[697503083] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1806; }","duration":"119.929587ms","start":"2026-05-11T07:28:22.75079Z","end":"2026-05-11T07:28:22.870719Z","steps":["trace[697503083] 'agreement among raft nodes before linearized reading' (duration: 119.831953ms)"],"step_count":1}