{"level":"warn","ts":"2026-10-15T14:14:57.113136Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-15T14:14:57.113277Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.109: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.109:2380","--initial-cluster=instance=https://199.204.45.109:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.109:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.109: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-10-15T14:14:57.113373Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-15T14:14:57.113402Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-10-15T14:14:57.113428Z","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-10-15T14:14:57.114372Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"]} {"level":"info","ts":"2026-10-15T14:14:57.114503Z","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.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.109: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-10-15T14:14:57.117946Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.129395ms"} {"level":"info","ts":"2026-10-15T14:14:57.125675Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d71a1778b31d4ce","cluster-id":"aaca35652fabf9b2"} {"level":"info","ts":"2026-10-15T14:14:57.125745Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=()"} {"level":"info","ts":"2026-10-15T14:14:57.125767Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 0"} {"level":"info","ts":"2026-10-15T14:14:57.125777Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d71a1778b31d4ce [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-15T14:14:57.125787Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 1"} {"level":"info","ts":"2026-10-15T14:14:57.125824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"warn","ts":"2026-10-15T14:14:57.139469Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-15T14:14:57.140926Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-15T14:14:57.142295Z","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-10-15T14:14:57.144523Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d71a1778b31d4ce","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-15T14:14:57.144771Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d71a1778b31d4ce","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-15T14:14:57.144885Z","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-10-15T14:14:57.145149Z","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-10-15T14:14:57.145221Z","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-10-15T14:14:57.146783Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"info","ts":"2026-10-15T14:14:57.147409Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","added-peer-id":"d71a1778b31d4ce","added-peer-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-10-15T14:14:57.149008Z","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-10-15T14:14:57.149151Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-10-15T14:14:57.149213Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-10-15T14:14:57.149603Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d71a1778b31d4ce","initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-15T14:14:57.149655Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-15T14:14:57.626634Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce is starting a new election at term 1"} {"level":"info","ts":"2026-10-15T14:14:57.626712Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became pre-candidate at term 1"} {"level":"info","ts":"2026-10-15T14:14:57.626738Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgPreVoteResp from d71a1778b31d4ce at term 1"} {"level":"info","ts":"2026-10-15T14:14:57.62676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became candidate at term 2"} {"level":"info","ts":"2026-10-15T14:14:57.626771Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgVoteResp from d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-10-15T14:14:57.6268Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became leader at term 2"} {"level":"info","ts":"2026-10-15T14:14:57.626819Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d71a1778b31d4ce elected leader d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-10-15T14:14:57.627794Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T14:14:57.628563Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T14:14:57.628571Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d71a1778b31d4ce","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.109:2379]}","request-path":"/0/members/d71a1778b31d4ce/attributes","cluster-id":"aaca35652fabf9b2","publish-timeout":"7s"} {"level":"info","ts":"2026-10-15T14:14:57.628715Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T14:14:57.628885Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-15T14:14:57.628941Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-15T14:14:57.630522Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.109:2379"} {"level":"info","ts":"2026-10-15T14:14:57.63189Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-15T14:14:57.633022Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T14:14:57.633158Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T14:14:57.633209Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T14:15:14.394813Z","caller":"traceutil/trace.go:171","msg":"trace[824414044] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"136.092267ms","start":"2026-10-15T14:15:14.258683Z","end":"2026-10-15T14:15:14.394776Z","steps":["trace[824414044] 'process raft request' (duration: 135.801549ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:15:51.327365Z","caller":"traceutil/trace.go:171","msg":"trace[1853492697] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"141.282861ms","start":"2026-10-15T14:15:51.186048Z","end":"2026-10-15T14:15:51.327331Z","steps":["trace[1853492697] 'process raft request' (duration: 140.439608ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:15:51.334874Z","caller":"traceutil/trace.go:171","msg":"trace[722488095] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"122.807607ms","start":"2026-10-15T14:15:51.212025Z","end":"2026-10-15T14:15:51.334832Z","steps":["trace[722488095] 'process raft request' (duration: 122.574231ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:15:51.821277Z","caller":"traceutil/trace.go:171","msg":"trace[634776753] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"398.291355ms","start":"2026-10-15T14:15:51.42296Z","end":"2026-10-15T14:15:51.821251Z","steps":["trace[634776753] 'process raft request' (duration: 393.765911ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:15:51.82156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.878313ms","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-10-15T14:15:51.821666Z","caller":"traceutil/trace.go:171","msg":"trace[454189545] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:660; }","duration":"358.038837ms","start":"2026-10-15T14:15:51.463608Z","end":"2026-10-15T14:15:51.821647Z","steps":["trace[454189545] 'agreement among raft nodes before linearized reading' (duration: 357.724629ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:15:51.821714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:15:51.463586Z","time spent":"358.112099ms","remote":"127.0.0.1:42932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-10-15T14:15:51.821277Z","caller":"traceutil/trace.go:171","msg":"trace[1541790518] linearizableReadLoop","detail":"{readStateIndex:685; appliedIndex:684; }","duration":"357.582924ms","start":"2026-10-15T14:15:51.463658Z","end":"2026-10-15T14:15:51.821241Z","steps":["trace[1541790518] 'read index received' (duration: 353.046241ms)","trace[1541790518] 'applied index is now lower than readState.Index' (duration: 4.535063ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:15:51.822078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.785288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-gz2v6\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-10-15T14:15:51.822133Z","caller":"traceutil/trace.go:171","msg":"trace[245852114] range","detail":"{range_begin:/registry/pods/kube-system/cilium-gz2v6; range_end:; response_count:1; response_revision:660; }","duration":"351.85937ms","start":"2026-10-15T14:15:51.470255Z","end":"2026-10-15T14:15:51.822115Z","steps":["trace[245852114] 'agreement among raft nodes before linearized reading' (duration: 351.748707ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:15:51.822176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:15:51.470245Z","time spent":"351.918851ms","remote":"127.0.0.1:42840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-gz2v6\" "} {"level":"warn","ts":"2026-10-15T14:15:51.822331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:15:51.422899Z","time spent":"398.469629ms","remote":"127.0.0.1:42912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-15T14:16:37.235808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.101612ms","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-10-15T14:16:37.235913Z","caller":"traceutil/trace.go:171","msg":"trace[1113356724] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1222; }","duration":"117.286326ms","start":"2026-10-15T14:16:37.118606Z","end":"2026-10-15T14:16:37.235892Z","steps":["trace[1113356724] 'range keys from in-memory index tree' (duration: 116.807383ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:17:26.265834Z","caller":"traceutil/trace.go:171","msg":"trace[1821421180] linearizableReadLoop","detail":"{readStateIndex:1965; appliedIndex:1964; }","duration":"186.764387ms","start":"2026-10-15T14:17:26.079043Z","end":"2026-10-15T14:17:26.265807Z","steps":["trace[1821421180] 'read index received' (duration: 186.733037ms)","trace[1821421180] 'applied index is now lower than readState.Index' (duration: 30.25µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:17:26.265987Z","caller":"traceutil/trace.go:171","msg":"trace[98681231] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"206.161051ms","start":"2026-10-15T14:17:26.059767Z","end":"2026-10-15T14:17:26.265928Z","steps":["trace[98681231] 'process raft request' (duration: 205.892203ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:17:26.266193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.084316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-944dbe7d-f841-4cbb-a1fe-4490dffbb987\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-10-15T14:17:26.266344Z","caller":"traceutil/trace.go:171","msg":"trace[892406048] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-944dbe7d-f841-4cbb-a1fe-4490dffbb987; range_end:; response_count:1; response_revision:1891; }","duration":"187.296822ms","start":"2026-10-15T14:17:26.079014Z","end":"2026-10-15T14:17:26.266311Z","steps":["trace[892406048] 'agreement among raft nodes before linearized reading' (duration: 186.982084ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:17:26.294406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.262185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T14:17:26.294503Z","caller":"traceutil/trace.go:171","msg":"trace[1229179893] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1892; }","duration":"113.42736ms","start":"2026-10-15T14:17:26.181054Z","end":"2026-10-15T14:17:26.294481Z","steps":["trace[1229179893] 'agreement among raft nodes before linearized reading' (duration: 113.232685ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:17:26.693838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.986293ms","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-10-15T14:17:26.693939Z","caller":"traceutil/trace.go:171","msg":"trace[792882735] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1894; }","duration":"175.150508ms","start":"2026-10-15T14:17:26.518762Z","end":"2026-10-15T14:17:26.693912Z","steps":["trace[792882735] 'range keys from in-memory index tree' (duration: 174.777838ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:18:16.102225Z","caller":"traceutil/trace.go:171","msg":"trace[412700061] transaction","detail":"{read_only:false; response_revision:2220; number_of_response:1; }","duration":"128.13464ms","start":"2026-10-15T14:18:15.974048Z","end":"2026-10-15T14:18:16.102183Z","steps":["trace[412700061] 'process raft request' (duration: 127.852242ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:18:16.5022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.115832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T14:18:16.502489Z","caller":"traceutil/trace.go:171","msg":"trace[2124627623] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2220; }","duration":"323.370209ms","start":"2026-10-15T14:18:16.17894Z","end":"2026-10-15T14:18:16.502311Z","steps":["trace[2124627623] 'range keys from in-memory index tree' (duration: 322.981499ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:18:16.502596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:18:16.178911Z","time spent":"323.669137ms","remote":"127.0.0.1:42688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-15T14:18:16.503262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.909911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-10-15T14:18:16.50345Z","caller":"traceutil/trace.go:171","msg":"trace[703801789] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2220; }","duration":"268.170249ms","start":"2026-10-15T14:18:16.235249Z","end":"2026-10-15T14:18:16.503419Z","steps":["trace[703801789] 'range keys from in-memory index tree' (duration: 266.870703ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:18:16.563268Z","caller":"traceutil/trace.go:171","msg":"trace[2118578350] linearizableReadLoop","detail":"{readStateIndex:2306; appliedIndex:2305; }","duration":"136.042488ms","start":"2026-10-15T14:18:16.427147Z","end":"2026-10-15T14:18:16.56319Z","steps":["trace[2118578350] 'read index received' (duration: 75.278394ms)","trace[2118578350] 'applied index is now lower than readState.Index' (duration: 60.760694ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:18:16.563606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.438999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-10-15T14:18:16.563714Z","caller":"traceutil/trace.go:171","msg":"trace[1388288886] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2222; }","duration":"136.609524ms","start":"2026-10-15T14:18:16.427077Z","end":"2026-10-15T14:18:16.563686Z","steps":["trace[1388288886] 'agreement among raft nodes before linearized reading' (duration: 136.231484ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:19:39.309099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.335062ms","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-10-15T14:19:39.309224Z","caller":"traceutil/trace.go:171","msg":"trace[1568418491] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2859; }","duration":"106.555088ms","start":"2026-10-15T14:19:39.202646Z","end":"2026-10-15T14:19:39.309201Z","steps":["trace[1568418491] 'range keys from in-memory index tree' (duration: 106.094885ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:19:39.628896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.173348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-15T14:19:39.629006Z","caller":"traceutil/trace.go:171","msg":"trace[773577963] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2860; }","duration":"209.341902ms","start":"2026-10-15T14:19:39.419643Z","end":"2026-10-15T14:19:39.628985Z","steps":["trace[773577963] 'range keys from in-memory index tree' (duration: 208.979152ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:24:13.233394Z","caller":"traceutil/trace.go:171","msg":"trace[1822760798] transaction","detail":"{read_only:false; response_revision:4972; number_of_response:1; }","duration":"101.022603ms","start":"2026-10-15T14:24:13.132341Z","end":"2026-10-15T14:24:13.233364Z","steps":["trace[1822760798] 'process raft request' (duration: 64.75788ms)","trace[1822760798] 'compare' (duration: 36.090128ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:24:13.235075Z","caller":"traceutil/trace.go:171","msg":"trace[470859953] transaction","detail":"{read_only:false; response_revision:4973; number_of_response:1; }","duration":"100.231951ms","start":"2026-10-15T14:24:13.134802Z","end":"2026-10-15T14:24:13.235034Z","steps":["trace[470859953] 'process raft request' (duration: 100.008225ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:24:21.49391Z","caller":"traceutil/trace.go:171","msg":"trace[682669536] transaction","detail":"{read_only:false; response_revision:5159; number_of_response:1; }","duration":"145.41099ms","start":"2026-10-15T14:24:21.348464Z","end":"2026-10-15T14:24:21.493875Z","steps":["trace[682669536] 'process raft request' (duration: 145.193884ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:24:26.645531Z","caller":"traceutil/trace.go:171","msg":"trace[697023914] transaction","detail":"{read_only:false; response_revision:5304; number_of_response:1; }","duration":"292.087155ms","start":"2026-10-15T14:24:26.353401Z","end":"2026-10-15T14:24:26.645488Z","steps":["trace[697023914] 'process raft request' (duration: 291.855618ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:24:26.645765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.515573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-zhk87\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-10-15T14:24:26.645825Z","caller":"traceutil/trace.go:171","msg":"trace[676970665] range","detail":"{range_begin:/registry/pods/openstack/keepalived-zhk87; range_end:; response_count:1; response_revision:5304; }","duration":"268.650217ms","start":"2026-10-15T14:24:26.377163Z","end":"2026-10-15T14:24:26.645813Z","steps":["trace[676970665] 'agreement among raft nodes before linearized reading' (duration: 268.41974ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:24:26.645531Z","caller":"traceutil/trace.go:171","msg":"trace[1793467382] linearizableReadLoop","detail":"{readStateIndex:5504; appliedIndex:5502; }","duration":"268.159833ms","start":"2026-10-15T14:24:26.377272Z","end":"2026-10-15T14:24:26.645432Z","steps":["trace[1793467382] 'read index received' (duration: 214.395927ms)","trace[1793467382] 'applied index is now lower than readState.Index' (duration: 53.762516ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:24:26.646545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.666121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8e9f8907-e157-4242-9872-70921641b6b6\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-10-15T14:24:26.646583Z","caller":"traceutil/trace.go:171","msg":"trace[1935447345] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8e9f8907-e157-4242-9872-70921641b6b6; range_end:; response_count:1; response_revision:5304; }","duration":"237.759543ms","start":"2026-10-15T14:24:26.408813Z","end":"2026-10-15T14:24:26.646572Z","steps":["trace[1935447345] 'agreement among raft nodes before linearized reading' (duration: 237.65338ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:24:26.911781Z","caller":"traceutil/trace.go:171","msg":"trace[763650004] transaction","detail":"{read_only:false; response_revision:5306; number_of_response:1; }","duration":"110.489464ms","start":"2026-10-15T14:24:26.801257Z","end":"2026-10-15T14:24:26.911746Z","steps":["trace[763650004] 'process raft request' (duration: 89.341389ms)","trace[763650004] 'compare' (duration: 20.991871ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:24:48.211195Z","caller":"traceutil/trace.go:171","msg":"trace[1594854423] transaction","detail":"{read_only:false; response_revision:5725; number_of_response:1; }","duration":"134.980331ms","start":"2026-10-15T14:24:48.076178Z","end":"2026-10-15T14:24:48.211158Z","steps":["trace[1594854423] 'process raft request' (duration: 42.587867ms)","trace[1594854423] 'compare' (duration: 92.110126ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:24:48.457785Z","caller":"traceutil/trace.go:171","msg":"trace[891556385] transaction","detail":"{read_only:false; response_revision:5726; number_of_response:1; }","duration":"117.716064ms","start":"2026-10-15T14:24:48.340004Z","end":"2026-10-15T14:24:48.45772Z","steps":["trace[891556385] 'process raft request' (duration: 79.357543ms)","trace[891556385] 'compare' (duration: 38.063692ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:24:57.76835Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2961} {"level":"info","ts":"2026-10-15T14:24:57.838199Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2961,"took":"68.594036ms","hash":2362608386,"current-db-size-bytes":54788096,"current-db-size":"55 MB","current-db-size-in-use-bytes":32051200,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-15T14:24:57.838318Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2362608386,"revision":2961,"compact-revision":-1} {"level":"warn","ts":"2026-10-15T14:24:59.645144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.206476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-15T14:24:59.645218Z","caller":"traceutil/trace.go:171","msg":"trace[1366459984] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5867; }","duration":"153.339509ms","start":"2026-10-15T14:24:59.491858Z","end":"2026-10-15T14:24:59.645197Z","steps":["trace[1366459984] 'range keys from in-memory index tree' (duration: 153.025321ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:29:57.776077Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5855} {"level":"info","ts":"2026-10-15T14:29:57.874065Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5855,"took":"95.227038ms","hash":4130529058,"current-db-size-bytes":54788096,"current-db-size":"55 MB","current-db-size-in-use-bytes":26845184,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-10-15T14:29:57.874175Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4130529058,"revision":5855,"compact-revision":2961} {"level":"info","ts":"2026-10-15T14:31:07.181974Z","caller":"traceutil/trace.go:171","msg":"trace[169638302] transaction","detail":"{read_only:false; response_revision:8621; number_of_response:1; }","duration":"171.07452ms","start":"2026-10-15T14:31:07.01086Z","end":"2026-10-15T14:31:07.181934Z","steps":["trace[169638302] 'process raft request' (duration: 170.764931ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:31:07.1974Z","caller":"traceutil/trace.go:171","msg":"trace[2067170256] transaction","detail":"{read_only:false; response_revision:8622; number_of_response:1; }","duration":"182.327923ms","start":"2026-10-15T14:31:07.01504Z","end":"2026-10-15T14:31:07.197368Z","steps":["trace[2067170256] 'process raft request' (duration: 181.8797ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:31:07.878884Z","caller":"traceutil/trace.go:171","msg":"trace[186526520] linearizableReadLoop","detail":"{readStateIndex:8930; appliedIndex:8929; }","duration":"143.636809ms","start":"2026-10-15T14:31:07.735213Z","end":"2026-10-15T14:31:07.87885Z","steps":["trace[186526520] 'read index received' (duration: 143.423263ms)","trace[186526520] 'applied index is now lower than readState.Index' (duration: 212.106µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:31:07.879019Z","caller":"traceutil/trace.go:171","msg":"trace[357520393] transaction","detail":"{read_only:false; response_revision:8625; number_of_response:1; }","duration":"175.247425ms","start":"2026-10-15T14:31:07.703729Z","end":"2026-10-15T14:31:07.878976Z","steps":["trace[357520393] 'process raft request' (duration: 174.914106ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:31:07.879183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.942818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-15T14:31:07.879228Z","caller":"traceutil/trace.go:171","msg":"trace[1101386127] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8625; }","duration":"144.075771ms","start":"2026-10-15T14:31:07.735141Z","end":"2026-10-15T14:31:07.879217Z","steps":["trace[1101386127] 'agreement among raft nodes before linearized reading' (duration: 143.843505ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:31:38.233164Z","caller":"traceutil/trace.go:171","msg":"trace[344345407] linearizableReadLoop","detail":"{readStateIndex:9153; appliedIndex:9152; }","duration":"137.402567ms","start":"2026-10-15T14:31:38.09573Z","end":"2026-10-15T14:31:38.233133Z","steps":["trace[344345407] 'read index received' (duration: 137.254753ms)","trace[344345407] 'applied index is now lower than readState.Index' (duration: 146.654µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:31:38.233259Z","caller":"traceutil/trace.go:171","msg":"trace[1071692723] transaction","detail":"{read_only:false; response_revision:8840; number_of_response:1; }","duration":"162.192985ms","start":"2026-10-15T14:31:38.071025Z","end":"2026-10-15T14:31:38.233218Z","steps":["trace[1071692723] 'process raft request' (duration: 161.899676ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:31:38.233592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.798169ms","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-10-15T14:31:38.233715Z","caller":"traceutil/trace.go:171","msg":"trace[1951059794] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8840; }","duration":"138.013245ms","start":"2026-10-15T14:31:38.095673Z","end":"2026-10-15T14:31:38.233686Z","steps":["trace[1951059794] 'agreement among raft nodes before linearized reading' (duration: 137.632984ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:31:38.321194Z","caller":"traceutil/trace.go:171","msg":"trace[1969004394] transaction","detail":"{read_only:false; response_revision:8841; number_of_response:1; }","duration":"195.410445ms","start":"2026-10-15T14:31:38.125756Z","end":"2026-10-15T14:31:38.321167Z","steps":["trace[1969004394] 'process raft request' (duration: 171.034669ms)","trace[1969004394] 'compare' (duration: 24.18852ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:31:45.913218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.294693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-10-15T14:31:45.913406Z","caller":"traceutil/trace.go:171","msg":"trace[604251022] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8884; }","duration":"111.569092ms","start":"2026-10-15T14:31:45.801804Z","end":"2026-10-15T14:31:45.913373Z","steps":["trace[604251022] 'range keys from in-memory index tree' (duration: 111.013796ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:31:46.606427Z","caller":"traceutil/trace.go:171","msg":"trace[1183823149] transaction","detail":"{read_only:false; response_revision:8885; number_of_response:1; }","duration":"321.151209ms","start":"2026-10-15T14:31:46.285253Z","end":"2026-10-15T14:31:46.606404Z","steps":["trace[1183823149] 'process raft request' (duration: 320.942333ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:31:46.606828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:31:46.285232Z","time spent":"321.274973ms","remote":"127.0.0.1:42932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T14:31:46.63191Z","caller":"traceutil/trace.go:171","msg":"trace[2083722457] transaction","detail":"{read_only:false; response_revision:8886; number_of_response:1; }","duration":"270.535217ms","start":"2026-10-15T14:31:46.361347Z","end":"2026-10-15T14:31:46.631883Z","steps":["trace[2083722457] 'process raft request' (duration: 257.783604ms)","trace[2083722457] 'compare' (duration: 12.615699ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:31:46.633817Z","caller":"traceutil/trace.go:171","msg":"trace[1827181288] linearizableReadLoop","detail":"{readStateIndex:9200; appliedIndex:9198; }","duration":"269.020355ms","start":"2026-10-15T14:31:46.364781Z","end":"2026-10-15T14:31:46.633801Z","steps":["trace[1827181288] 'read index received' (duration: 241.470512ms)","trace[1827181288] 'applied index is now lower than readState.Index' (duration: 27.548343ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:31:46.634058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.229711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-15T14:31:46.634602Z","caller":"traceutil/trace.go:171","msg":"trace[329105278] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8886; }","duration":"269.811137ms","start":"2026-10-15T14:31:46.364728Z","end":"2026-10-15T14:31:46.63454Z","steps":["trace[329105278] 'agreement among raft nodes before linearized reading' (duration: 269.144288ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:31:53.108503Z","caller":"traceutil/trace.go:171","msg":"trace[2105092829] transaction","detail":"{read_only:false; response_revision:8960; number_of_response:1; }","duration":"108.415535ms","start":"2026-10-15T14:31:53.000047Z","end":"2026-10-15T14:31:53.108463Z","steps":["trace[2105092829] 'process raft request' (duration: 96.145885ms)","trace[2105092829] 'compare' (duration: 12.131106ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:31:53.674731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.818597ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T14:31:53.674848Z","caller":"traceutil/trace.go:171","msg":"trace[755591446] linearizableReadLoop","detail":"{readStateIndex:9284; appliedIndex:9283; }","duration":"105.149535ms","start":"2026-10-15T14:31:53.56968Z","end":"2026-10-15T14:31:53.67483Z","steps":["trace[755591446] 'read index received' (duration: 40.861µs)","trace[755591446] 'applied index is now lower than readState.Index' (duration: 105.107554ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:31:53.674942Z","caller":"traceutil/trace.go:171","msg":"trace[288750716] transaction","detail":"{read_only:false; response_revision:8964; number_of_response:1; }","duration":"145.912324ms","start":"2026-10-15T14:31:53.528994Z","end":"2026-10-15T14:31:53.674907Z","steps":["trace[288750716] 'process raft request' (duration: 23.628984ms)","trace[288750716] 'compare' (duration: 121.452787ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:31:53.675022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.35515ms","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-10-15T14:31:53.675053Z","caller":"traceutil/trace.go:171","msg":"trace[1716781682] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8964; }","duration":"105.428633ms","start":"2026-10-15T14:31:53.569615Z","end":"2026-10-15T14:31:53.675043Z","steps":["trace[1716781682] 'agreement among raft nodes before linearized reading' (duration: 105.290439ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:31:53.868603Z","caller":"traceutil/trace.go:171","msg":"trace[377002616] linearizableReadLoop","detail":"{readStateIndex:9287; appliedIndex:9285; }","duration":"164.104839ms","start":"2026-10-15T14:31:53.704449Z","end":"2026-10-15T14:31:53.868554Z","steps":["trace[377002616] 'read index received' (duration: 163.487412ms)","trace[377002616] 'applied index is now lower than readState.Index' (duration: 616.117µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:31:53.868958Z","caller":"traceutil/trace.go:171","msg":"trace[183898819] transaction","detail":"{read_only:false; response_revision:8967; number_of_response:1; }","duration":"187.638571ms","start":"2026-10-15T14:31:53.681303Z","end":"2026-10-15T14:31:53.868942Z","steps":["trace[183898819] 'process raft request' (duration: 187.189769ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:31:53.869022Z","caller":"traceutil/trace.go:171","msg":"trace[372928358] transaction","detail":"{read_only:false; response_revision:8966; number_of_response:1; }","duration":"190.994604ms","start":"2026-10-15T14:31:53.677981Z","end":"2026-10-15T14:31:53.868975Z","steps":["trace[372928358] 'process raft request' (duration: 189.797881ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:31:53.86911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.620613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T14:31:53.869221Z","caller":"traceutil/trace.go:171","msg":"trace[1650350639] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:8967; }","duration":"164.803689ms","start":"2026-10-15T14:31:53.704393Z","end":"2026-10-15T14:31:53.869197Z","steps":["trace[1650350639] 'agreement among raft nodes before linearized reading' (duration: 164.612883ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:31:53.880588Z","caller":"traceutil/trace.go:171","msg":"trace[1519981254] transaction","detail":"{read_only:false; response_revision:8968; number_of_response:1; }","duration":"175.30313ms","start":"2026-10-15T14:31:53.705229Z","end":"2026-10-15T14:31:53.880532Z","steps":["trace[1519981254] 'process raft request' (duration: 174.705123ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:31:53.880596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.480417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-zhk87\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-10-15T14:31:53.880706Z","caller":"traceutil/trace.go:171","msg":"trace[103391826] range","detail":"{range_begin:/registry/pods/openstack/keepalived-zhk87; range_end:; response_count:1; response_revision:8968; }","duration":"152.689413ms","start":"2026-10-15T14:31:53.727993Z","end":"2026-10-15T14:31:53.880682Z","steps":["trace[103391826] 'agreement among raft nodes before linearized reading' (duration: 152.153038ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:32:14.463043Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000251c.wal"} {"level":"info","ts":"2026-10-15T14:33:01.766211Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d71a1778b31d4ce","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-15T14:33:01.772413Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-15T14:33:01.772521Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"warn","ts":"2026-10-15T14:33:14.287745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.137818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T14:33:14.287994Z","caller":"traceutil/trace.go:171","msg":"trace[969218048] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9733; }","duration":"108.328973ms","start":"2026-10-15T14:33:14.179517Z","end":"2026-10-15T14:33:14.287846Z","steps":["trace[969218048] 'range keys from in-memory index tree' (duration: 107.965783ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:34:57.786251Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8051} {"level":"info","ts":"2026-10-15T14:34:57.889504Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8051,"took":"100.054594ms","hash":2884151184,"current-db-size-bytes":54788096,"current-db-size":"55 MB","current-db-size-in-use-bytes":28442624,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-15T14:34:57.889595Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2884151184,"revision":8051,"compact-revision":5855} {"level":"info","ts":"2026-10-15T14:36:44.798006Z","caller":"traceutil/trace.go:171","msg":"trace[11962145] linearizableReadLoop","detail":"{readStateIndex:11890; appliedIndex:11889; }","duration":"242.034192ms","start":"2026-10-15T14:36:44.555937Z","end":"2026-10-15T14:36:44.797971Z","steps":["trace[11962145] 'read index received' (duration: 191.399337ms)","trace[11962145] 'applied index is now lower than readState.Index' (duration: 50.633535ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:36:44.798243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.282438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-10-15T14:36:44.798279Z","caller":"traceutil/trace.go:171","msg":"trace[1074101565] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:11498; }","duration":"242.360801ms","start":"2026-10-15T14:36:44.555903Z","end":"2026-10-15T14:36:44.798264Z","steps":["trace[1074101565] 'agreement among raft nodes before linearized reading' (duration: 242.179836ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:36:44.798579Z","caller":"traceutil/trace.go:171","msg":"trace[272712242] transaction","detail":"{read_only:false; response_revision:11498; number_of_response:1; }","duration":"266.007756ms","start":"2026-10-15T14:36:44.532516Z","end":"2026-10-15T14:36:44.798524Z","steps":["trace[272712242] 'process raft request' (duration: 214.894868ms)","trace[272712242] 'compare' (duration: 50.408898ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:37:00.696049Z","caller":"traceutil/trace.go:171","msg":"trace[1194182074] transaction","detail":"{read_only:false; response_revision:11585; number_of_response:1; }","duration":"148.042235ms","start":"2026-10-15T14:37:00.547972Z","end":"2026-10-15T14:37:00.696014Z","steps":["trace[1194182074] 'process raft request' (duration: 147.298515ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:39:57.794545Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10483} {"level":"info","ts":"2026-10-15T14:39:57.890918Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10483,"took":"92.492835ms","hash":1700089391,"current-db-size-bytes":54788096,"current-db-size":"55 MB","current-db-size-in-use-bytes":27828224,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-15T14:39:57.891Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1700089391,"revision":10483,"compact-revision":8051} {"level":"info","ts":"2026-10-15T14:43:31.378825Z","caller":"traceutil/trace.go:171","msg":"trace[315742199] linearizableReadLoop","detail":"{readStateIndex:14695; appliedIndex:14694; }","duration":"137.515702ms","start":"2026-10-15T14:43:31.241267Z","end":"2026-10-15T14:43:31.378783Z","steps":["trace[315742199] 'read index received' (duration: 114.981307ms)","trace[315742199] 'applied index is now lower than readState.Index' (duration: 22.531565ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:43:31.379007Z","caller":"traceutil/trace.go:171","msg":"trace[590364055] transaction","detail":"{read_only:false; response_revision:14207; number_of_response:1; }","duration":"137.83218ms","start":"2026-10-15T14:43:31.241159Z","end":"2026-10-15T14:43:31.378991Z","steps":["trace[590364055] 'process raft request' (duration: 115.256565ms)","trace[590364055] 'compare' (duration: 21.812714ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:43:31.379192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.901592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T14:43:31.379837Z","caller":"traceutil/trace.go:171","msg":"trace[832236906] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14207; }","duration":"138.565971ms","start":"2026-10-15T14:43:31.241226Z","end":"2026-10-15T14:43:31.379792Z","steps":["trace[832236906] 'agreement among raft nodes before linearized reading' (duration: 137.841511ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:43:38.999112Z","caller":"traceutil/trace.go:171","msg":"trace[1687705474] linearizableReadLoop","detail":"{readStateIndex:14735; appliedIndex:14734; }","duration":"200.855777ms","start":"2026-10-15T14:43:38.798227Z","end":"2026-10-15T14:43:38.999082Z","steps":["trace[1687705474] 'read index received' (duration: 200.803025ms)","trace[1687705474] 'applied index is now lower than readState.Index' (duration: 51.152µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:43:38.999239Z","caller":"traceutil/trace.go:171","msg":"trace[114733722] transaction","detail":"{read_only:false; response_revision:14246; number_of_response:1; }","duration":"305.162477ms","start":"2026-10-15T14:43:38.694018Z","end":"2026-10-15T14:43:38.999181Z","steps":["trace[114733722] 'process raft request' (duration: 304.88594ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:43:38.999354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.111463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-cd2gq\" ","response":"range_response_count:1 size:12599"} {"level":"info","ts":"2026-10-15T14:43:38.999413Z","caller":"traceutil/trace.go:171","msg":"trace[176540905] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-cd2gq; range_end:; response_count:1; response_revision:14246; }","duration":"201.241367ms","start":"2026-10-15T14:43:38.798159Z","end":"2026-10-15T14:43:38.9994Z","steps":["trace[176540905] 'agreement among raft nodes before linearized reading' (duration: 201.035332ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:43:38.999539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:43:38.693981Z","time spent":"305.423584ms","remote":"127.0.0.1:42932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T14:43:39.023265Z","caller":"traceutil/trace.go:171","msg":"trace[265110291] transaction","detail":"{read_only:false; response_revision:14247; number_of_response:1; }","duration":"109.104913ms","start":"2026-10-15T14:43:38.914135Z","end":"2026-10-15T14:43:39.02324Z","steps":["trace[265110291] 'process raft request' (duration: 108.951989ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:43:39.393612Z","caller":"traceutil/trace.go:171","msg":"trace[1356494603] linearizableReadLoop","detail":"{readStateIndex:14737; appliedIndex:14736; }","duration":"309.22032ms","start":"2026-10-15T14:43:39.08436Z","end":"2026-10-15T14:43:39.39358Z","steps":["trace[1356494603] 'read index received' (duration: 268.620094ms)","trace[1356494603] 'applied index is now lower than readState.Index' (duration: 40.598596ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:43:39.393647Z","caller":"traceutil/trace.go:171","msg":"trace[2047575084] transaction","detail":"{read_only:false; response_revision:14248; number_of_response:1; }","duration":"378.648743ms","start":"2026-10-15T14:43:39.014961Z","end":"2026-10-15T14:43:39.39361Z","steps":["trace[2047575084] 'process raft request' (duration: 337.966666ms)","trace[2047575084] 'compare' (duration: 40.375449ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:43:39.393839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:43:39.014922Z","time spent":"378.808478ms","remote":"127.0.0.1:42840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12713,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T14:43:39.393898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.525817ms","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-10-15T14:43:39.39395Z","caller":"traceutil/trace.go:171","msg":"trace[1950563915] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14248; }","duration":"309.585849ms","start":"2026-10-15T14:43:39.084337Z","end":"2026-10-15T14:43:39.393923Z","steps":["trace[1950563915] 'agreement among raft nodes before linearized reading' (duration: 309.402025ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:43:39.393993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:43:39.084269Z","time spent":"309.712392ms","remote":"127.0.0.1:42932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-15T14:43:39.394185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.300136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T14:43:39.394251Z","caller":"traceutil/trace.go:171","msg":"trace[588498991] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14248; }","duration":"215.406849ms","start":"2026-10-15T14:43:39.178826Z","end":"2026-10-15T14:43:39.394233Z","steps":["trace[588498991] 'agreement among raft nodes before linearized reading' (duration: 215.296686ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:43:39.394299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.904045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-10-15T14:43:39.394396Z","caller":"traceutil/trace.go:171","msg":"trace[901515384] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:14248; }","duration":"149.002198ms","start":"2026-10-15T14:43:39.245348Z","end":"2026-10-15T14:43:39.39435Z","steps":["trace[901515384] 'agreement among raft nodes before linearized reading' (duration: 148.71597ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:43:39.394032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.810639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-10-15T14:43:39.395214Z","caller":"traceutil/trace.go:171","msg":"trace[1234270432] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14248; }","duration":"305.059823ms","start":"2026-10-15T14:43:39.090133Z","end":"2026-10-15T14:43:39.395192Z","steps":["trace[1234270432] 'agreement among raft nodes before linearized reading' (duration: 303.691665ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:43:39.395263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:43:39.090103Z","time spent":"305.142196ms","remote":"127.0.0.1:42932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-10-15T14:44:57.802673Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12762} {"level":"info","ts":"2026-10-15T14:44:57.89446Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12762,"took":"86.798865ms","hash":1902760765,"current-db-size-bytes":54788096,"current-db-size":"55 MB","current-db-size-in-use-bytes":30466048,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-15T14:44:57.894536Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1902760765,"revision":12762,"compact-revision":10483} {"level":"info","ts":"2026-10-15T14:45:13.484101Z","caller":"traceutil/trace.go:171","msg":"trace[675041858] transaction","detail":"{read_only:false; response_revision:15292; number_of_response:1; }","duration":"101.534754ms","start":"2026-10-15T14:45:13.38254Z","end":"2026-10-15T14:45:13.484075Z","steps":["trace[675041858] 'process raft request' (duration: 101.111973ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:45:19.897873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.022111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-xckm7\" ","response":"range_response_count:1 size:9796"} {"level":"info","ts":"2026-10-15T14:45:19.897981Z","caller":"traceutil/trace.go:171","msg":"trace[1401901691] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-xckm7; range_end:; response_count:1; response_revision:15324; }","duration":"144.179826ms","start":"2026-10-15T14:45:19.753776Z","end":"2026-10-15T14:45:19.897956Z","steps":["trace[1401901691] 'range keys from in-memory index tree' (duration: 143.845506ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:49:57.809463Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15208} {"level":"info","ts":"2026-10-15T14:49:57.91067Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15208,"took":"98.993111ms","hash":1942145486,"current-db-size-bytes":54788096,"current-db-size":"55 MB","current-db-size-in-use-bytes":32186368,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-15T14:49:57.910745Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1942145486,"revision":15208,"compact-revision":12762} {"level":"warn","ts":"2026-10-15T14:50:52.237591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.497385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T14:50:52.237674Z","caller":"traceutil/trace.go:171","msg":"trace[1378305349] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:17817; }","duration":"160.595357ms","start":"2026-10-15T14:50:52.077059Z","end":"2026-10-15T14:50:52.237654Z","steps":["trace[1378305349] 'count revisions from in-memory index tree' (duration: 160.404502ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:50:52.237992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.215908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-10-15T14:50:52.238028Z","caller":"traceutil/trace.go:171","msg":"trace[473897311] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:17817; }","duration":"151.31601ms","start":"2026-10-15T14:50:52.086702Z","end":"2026-10-15T14:50:52.238018Z","steps":["trace[473897311] 'range keys from in-memory index tree' (duration: 151.050943ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:50:57.745334Z","caller":"traceutil/trace.go:171","msg":"trace[652351506] transaction","detail":"{read_only:false; response_revision:17848; number_of_response:1; }","duration":"237.772504ms","start":"2026-10-15T14:50:57.507517Z","end":"2026-10-15T14:50:57.745289Z","steps":["trace[652351506] 'process raft request' (duration: 198.878877ms)","trace[652351506] 'compare' (duration: 38.223408ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:50:57.954128Z","caller":"traceutil/trace.go:171","msg":"trace[12362311] linearizableReadLoop","detail":"{readStateIndex:18457; appliedIndex:18456; }","duration":"101.886451ms","start":"2026-10-15T14:50:57.852216Z","end":"2026-10-15T14:50:57.954102Z","steps":["trace[12362311] 'read index received' (duration: 53.130541ms)","trace[12362311] 'applied index is now lower than readState.Index' (duration: 48.75504ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:50:57.954268Z","caller":"traceutil/trace.go:171","msg":"trace[929168891] transaction","detail":"{read_only:false; response_revision:17849; number_of_response:1; }","duration":"118.197023ms","start":"2026-10-15T14:50:57.836058Z","end":"2026-10-15T14:50:57.954255Z","steps":["trace[929168891] 'process raft request' (duration: 69.287718ms)","trace[929168891] 'compare' (duration: 48.589936ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:50:57.954455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.083249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-rjhlx\" ","response":"range_response_count:1 size:20763"} {"level":"info","ts":"2026-10-15T14:50:57.954493Z","caller":"traceutil/trace.go:171","msg":"trace[29229790] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-rjhlx; range_end:; response_count:1; response_revision:17849; }","duration":"101.149381ms","start":"2026-10-15T14:50:57.853333Z","end":"2026-10-15T14:50:57.954482Z","steps":["trace[29229790] 'agreement among raft nodes before linearized reading' (duration: 101.007837ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:50:57.954717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.492638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-5jwqs\" ","response":"range_response_count:1 size:22133"} {"level":"info","ts":"2026-10-15T14:50:57.954756Z","caller":"traceutil/trace.go:171","msg":"trace[1433242619] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-5jwqs; range_end:; response_count:1; response_revision:17849; }","duration":"102.55823ms","start":"2026-10-15T14:50:57.852186Z","end":"2026-10-15T14:50:57.954744Z","steps":["trace[1433242619] 'agreement among raft nodes before linearized reading' (duration: 102.441767ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:50:58.395959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.651518ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-15T14:50:58.396062Z","caller":"traceutil/trace.go:171","msg":"trace[1300209593] linearizableReadLoop","detail":"{readStateIndex:18460; appliedIndex:18459; }","duration":"216.794724ms","start":"2026-10-15T14:50:58.179249Z","end":"2026-10-15T14:50:58.396043Z","steps":["trace[1300209593] 'read index received' (duration: 20.959831ms)","trace[1300209593] 'applied index is now lower than readState.Index' (duration: 195.833222ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:50:58.396174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.950567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T14:50:58.396206Z","caller":"traceutil/trace.go:171","msg":"trace[48152276] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17852; }","duration":"217.0304ms","start":"2026-10-15T14:50:58.179166Z","end":"2026-10-15T14:50:58.396196Z","steps":["trace[48152276] 'agreement among raft nodes before linearized reading' (duration: 216.967448ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:50:58.396168Z","caller":"traceutil/trace.go:171","msg":"trace[1336919129] transaction","detail":"{read_only:false; response_revision:17852; number_of_response:1; }","duration":"418.713424ms","start":"2026-10-15T14:50:57.977401Z","end":"2026-10-15T14:50:58.396114Z","steps":["trace[1336919129] 'process raft request' (duration: 222.787908ms)","trace[1336919129] 'compare' (duration: 195.180525ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:50:58.39637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:50:57.97737Z","time spent":"418.890629ms","remote":"127.0.0.1:42840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20878,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T14:50:58.638809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.372755ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-15T14:50:58.638973Z","caller":"traceutil/trace.go:171","msg":"trace[38692441] linearizableReadLoop","detail":"{readStateIndex:18461; appliedIndex:18460; }","duration":"236.603292ms","start":"2026-10-15T14:50:58.402347Z","end":"2026-10-15T14:50:58.63895Z","steps":["trace[38692441] 'read index received' (duration: 42.611µs)","trace[38692441] 'applied index is now lower than readState.Index' (duration: 236.558831ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:50:58.639081Z","caller":"traceutil/trace.go:171","msg":"trace[310396256] transaction","detail":"{read_only:false; response_revision:17853; number_of_response:1; }","duration":"236.727145ms","start":"2026-10-15T14:50:58.402305Z","end":"2026-10-15T14:50:58.639032Z","steps":["trace[310396256] 'process raft request' (duration: 104.01316ms)","trace[310396256] 'compare' (duration: 132.125689ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:50:58.639316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.002972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-10-15T14:50:58.639372Z","caller":"traceutil/trace.go:171","msg":"trace[479126216] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:17853; }","duration":"207.052474ms","start":"2026-10-15T14:50:58.432302Z","end":"2026-10-15T14:50:58.639354Z","steps":["trace[479126216] 'agreement among raft nodes before linearized reading' (duration: 206.886569ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:50:58.639138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.787446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T14:50:58.639529Z","caller":"traceutil/trace.go:171","msg":"trace[1374407719] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17853; }","duration":"237.224709ms","start":"2026-10-15T14:50:58.402287Z","end":"2026-10-15T14:50:58.639512Z","steps":["trace[1374407719] 'agreement among raft nodes before linearized reading' (duration: 236.797047ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:50:58.640161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.158423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-4be204c4-3113-4289-ba7d-4c12a8a875dd\" ","response":"range_response_count:1 size:1294"} {"level":"info","ts":"2026-10-15T14:50:58.640216Z","caller":"traceutil/trace.go:171","msg":"trace[2118866282] range","detail":"{range_begin:/registry/persistentvolumes/pvc-4be204c4-3113-4289-ba7d-4c12a8a875dd; range_end:; response_count:1; response_revision:17853; }","duration":"230.286627ms","start":"2026-10-15T14:50:58.409914Z","end":"2026-10-15T14:50:58.6402Z","steps":["trace[2118866282] 'agreement among raft nodes before linearized reading' (duration: 230.03631ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:50:58.641149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.152201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:94 size:945967"} {"level":"info","ts":"2026-10-15T14:50:58.641268Z","caller":"traceutil/trace.go:171","msg":"trace[1067765846] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:94; response_revision:17853; }","duration":"231.327946ms","start":"2026-10-15T14:50:58.409913Z","end":"2026-10-15T14:50:58.641241Z","steps":["trace[1067765846] 'agreement among raft nodes before linearized reading' (duration: 229.218128ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:52:03.135745Z","caller":"traceutil/trace.go:171","msg":"trace[1292971077] transaction","detail":"{read_only:false; response_revision:18603; number_of_response:1; }","duration":"101.443976ms","start":"2026-10-15T14:52:03.034266Z","end":"2026-10-15T14:52:03.13571Z","steps":["trace[1292971077] 'process raft request' (duration: 90.215945ms)","trace[1292971077] 'compare' (duration: 11.045146ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:52:03.297203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.867471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-5jwqs\" ","response":"range_response_count:1 size:23320"} {"level":"info","ts":"2026-10-15T14:52:03.297288Z","caller":"traceutil/trace.go:171","msg":"trace[688198640] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-5jwqs; range_end:; response_count:1; response_revision:18605; }","duration":"113.006886ms","start":"2026-10-15T14:52:03.18426Z","end":"2026-10-15T14:52:03.297267Z","steps":["trace[688198640] 'agreement among raft nodes before linearized reading' (duration: 112.768599ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:53:51.204654Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d71a1778b31d4ce","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-15T14:53:51.211183Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-15T14:53:51.211293Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-15T14:54:57.81539Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17435} {"level":"info","ts":"2026-10-15T14:54:57.914296Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17435,"took":"96.104568ms","hash":2663090596,"current-db-size-bytes":54788096,"current-db-size":"55 MB","current-db-size-in-use-bytes":34770944,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-10-15T14:54:57.914365Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2663090596,"revision":17435,"compact-revision":15208} {"level":"info","ts":"2026-10-15T14:56:35.984454Z","caller":"traceutil/trace.go:171","msg":"trace[1978389051] transaction","detail":"{read_only:false; response_revision:20491; number_of_response:1; }","duration":"109.369699ms","start":"2026-10-15T14:56:35.875018Z","end":"2026-10-15T14:56:35.984388Z","steps":["trace[1978389051] 'process raft request' (duration: 106.898331ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:56:36.164012Z","caller":"traceutil/trace.go:171","msg":"trace[2042311891] transaction","detail":"{read_only:false; response_revision:20492; number_of_response:1; }","duration":"175.054851ms","start":"2026-10-15T14:56:35.988934Z","end":"2026-10-15T14:56:36.163989Z","steps":["trace[2042311891] 'process raft request' (duration: 170.760943ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:56:36.602127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.039929ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-10-15T14:56:36.602859Z","caller":"traceutil/trace.go:171","msg":"trace[923663901] transaction","detail":"{read_only:false; response_revision:20493; number_of_response:1; }","duration":"304.71553ms","start":"2026-10-15T14:56:36.298107Z","end":"2026-10-15T14:56:36.602823Z","steps":["trace[923663901] 'process raft request' (duration: 304.117273ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:56:36.603242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:56:36.298082Z","time spent":"304.853954ms","remote":"127.0.0.1:42932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T14:56:36.752215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.29355ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-15T14:56:36.752425Z","caller":"traceutil/trace.go:171","msg":"trace[1898096617] transaction","detail":"{read_only:false; response_revision:20494; number_of_response:1; }","duration":"390.383584ms","start":"2026-10-15T14:56:36.362019Z","end":"2026-10-15T14:56:36.752402Z","steps":["trace[1898096617] 'process raft request' (duration: 240.785755ms)","trace[1898096617] 'compare' (duration: 149.143036ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:56:36.752602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:56:36.361994Z","time spent":"390.469256ms","remote":"127.0.0.1:42932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T14:56:36.75277Z","caller":"traceutil/trace.go:171","msg":"trace[46038357] linearizableReadLoop","detail":"{readStateIndex:21189; appliedIndex:21185; }","duration":"289.214532ms","start":"2026-10-15T14:56:36.463523Z","end":"2026-10-15T14:56:36.752738Z","steps":["trace[46038357] 'read index received' (duration: 84.712148ms)","trace[46038357] 'applied index is now lower than readState.Index' (duration: 204.501044ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:56:36.752986Z","caller":"traceutil/trace.go:171","msg":"trace[597725704] transaction","detail":"{read_only:false; response_revision:20495; number_of_response:1; }","duration":"336.61806ms","start":"2026-10-15T14:56:36.416354Z","end":"2026-10-15T14:56:36.752972Z","steps":["trace[597725704] 'process raft request' (duration: 335.991113ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:56:36.753137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:56:36.416334Z","time spent":"336.679802ms","remote":"127.0.0.1:42932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T14:56:36.753401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.420722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-10-15T14:56:36.753548Z","caller":"traceutil/trace.go:171","msg":"trace[551056469] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:20496; }","duration":"133.631388ms","start":"2026-10-15T14:56:36.619886Z","end":"2026-10-15T14:56:36.753517Z","steps":["trace[551056469] 'agreement among raft nodes before linearized reading' (duration: 133.280818ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:56:36.753616Z","caller":"traceutil/trace.go:171","msg":"trace[390551684] transaction","detail":"{read_only:false; response_revision:20496; number_of_response:1; }","duration":"163.081511ms","start":"2026-10-15T14:56:36.59052Z","end":"2026-10-15T14:56:36.753601Z","steps":["trace[390551684] 'process raft request' (duration: 162.098724ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:56:36.753469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.910091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-10-15T14:56:36.754067Z","caller":"traceutil/trace.go:171","msg":"trace[866494576] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:20496; }","duration":"290.575529ms","start":"2026-10-15T14:56:36.463479Z","end":"2026-10-15T14:56:36.754054Z","steps":["trace[866494576] 'agreement among raft nodes before linearized reading' (duration: 289.587502ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:56:36.881832Z","caller":"traceutil/trace.go:171","msg":"trace[1386353839] transaction","detail":"{read_only:false; response_revision:20497; number_of_response:1; }","duration":"123.440037ms","start":"2026-10-15T14:56:36.758334Z","end":"2026-10-15T14:56:36.881774Z","steps":["trace[1386353839] 'process raft request' (duration: 94.483088ms)","trace[1386353839] 'compare' (duration: 28.180738ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:56:36.882407Z","caller":"traceutil/trace.go:171","msg":"trace[1024098712] transaction","detail":"{read_only:false; response_revision:20498; number_of_response:1; }","duration":"123.503659ms","start":"2026-10-15T14:56:36.758866Z","end":"2026-10-15T14:56:36.88237Z","steps":["trace[1024098712] 'process raft request' (duration: 122.752528ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:59:57.821573Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19898} {"level":"info","ts":"2026-10-15T14:59:57.946775Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19898,"took":"121.820262ms","hash":1969087471,"current-db-size-bytes":54788096,"current-db-size":"55 MB","current-db-size-in-use-bytes":30568448,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-15T14:59:57.946828Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1969087471,"revision":19898,"compact-revision":17435} {"level":"info","ts":"2026-10-15T15:03:45.224862Z","caller":"traceutil/trace.go:171","msg":"trace[1616729200] transaction","detail":"{read_only:false; response_revision:24943; number_of_response:1; }","duration":"121.781211ms","start":"2026-10-15T15:03:45.103055Z","end":"2026-10-15T15:03:45.224836Z","steps":["trace[1616729200] 'process raft request' (duration: 121.638177ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:03:45.525924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.819345ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-15T15:03:45.526035Z","caller":"traceutil/trace.go:171","msg":"trace[297818746] linearizableReadLoop","detail":"{readStateIndex:25758; appliedIndex:25757; }","duration":"285.208501ms","start":"2026-10-15T15:03:45.240807Z","end":"2026-10-15T15:03:45.526015Z","steps":["trace[297818746] 'read index received' (duration: 135.14945ms)","trace[297818746] 'applied index is now lower than readState.Index' (duration: 150.057391ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T15:03:45.526131Z","caller":"traceutil/trace.go:171","msg":"trace[498417072] transaction","detail":"{read_only:false; response_revision:24944; number_of_response:1; }","duration":"357.305211ms","start":"2026-10-15T15:03:45.168814Z","end":"2026-10-15T15:03:45.526119Z","steps":["trace[498417072] 'process raft request' (duration: 207.201948ms)","trace[498417072] 'compare' (duration: 149.376783ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T15:03:45.526196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:03:45.168795Z","time spent":"357.366573ms","remote":"127.0.0.1:42932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":496,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T15:03:45.526407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.964536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"warn","ts":"2026-10-15T15:03:45.526477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.655684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-10-15T15:03:45.526529Z","caller":"traceutil/trace.go:171","msg":"trace[2065837785] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24944; }","duration":"101.166612ms","start":"2026-10-15T15:03:45.42534Z","end":"2026-10-15T15:03:45.526506Z","steps":["trace[2065837785] 'agreement among raft nodes before linearized reading' (duration: 100.800772ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:03:45.526566Z","caller":"traceutil/trace.go:171","msg":"trace[1252573530] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24944; }","duration":"285.785398ms","start":"2026-10-15T15:03:45.240758Z","end":"2026-10-15T15:03:45.526544Z","steps":["trace[1252573530] 'agreement among raft nodes before linearized reading' (duration: 285.532311ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:03:45.739232Z","caller":"traceutil/trace.go:171","msg":"trace[516842086] linearizableReadLoop","detail":"{readStateIndex:25761; appliedIndex:25760; }","duration":"118.769937ms","start":"2026-10-15T15:03:45.62042Z","end":"2026-10-15T15:03:45.73919Z","steps":["trace[516842086] 'read index received' (duration: 117.797461ms)","trace[516842086] 'applied index is now lower than readState.Index' (duration: 970.326µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T15:03:45.739284Z","caller":"traceutil/trace.go:171","msg":"trace[2032088882] transaction","detail":"{read_only:false; response_revision:24947; number_of_response:1; }","duration":"147.451988ms","start":"2026-10-15T15:03:45.591797Z","end":"2026-10-15T15:03:45.739249Z","steps":["trace[2032088882] 'process raft request' (duration: 146.555643ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:03:45.739374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.929745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/applicationcredentials/\" range_end:\"/registry/openstack.k-orc.cloud/applicationcredentials0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T15:03:45.739505Z","caller":"traceutil/trace.go:171","msg":"trace[834250052] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/applicationcredentials/; range_end:/registry/openstack.k-orc.cloud/applicationcredentials0; response_count:0; response_revision:24947; }","duration":"151.12544ms","start":"2026-10-15T15:03:45.588354Z","end":"2026-10-15T15:03:45.739479Z","steps":["trace[834250052] 'agreement among raft nodes before linearized reading' (duration: 150.894684ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:03:45.739592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.629034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-10-15T15:03:45.73968Z","caller":"traceutil/trace.go:171","msg":"trace[556196196] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:24947; }","duration":"159.762509ms","start":"2026-10-15T15:03:45.579873Z","end":"2026-10-15T15:03:45.739636Z","steps":["trace[556196196] 'agreement among raft nodes before linearized reading' (duration: 159.45917ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:04:46.908451Z","caller":"traceutil/trace.go:171","msg":"trace[1450146267] transaction","detail":"{read_only:false; response_revision:25502; number_of_response:1; }","duration":"139.426373ms","start":"2026-10-15T15:04:46.768971Z","end":"2026-10-15T15:04:46.908398Z","steps":["trace[1450146267] 'process raft request' (duration: 139.259458ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:04:47.085869Z","caller":"traceutil/trace.go:171","msg":"trace[704929936] transaction","detail":"{read_only:false; response_revision:25503; number_of_response:1; }","duration":"316.33791ms","start":"2026-10-15T15:04:46.769496Z","end":"2026-10-15T15:04:47.085834Z","steps":["trace[704929936] 'process raft request' (duration: 300.894814ms)","trace[704929936] 'compare' (duration: 15.046485ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T15:04:47.085943Z","caller":"traceutil/trace.go:171","msg":"trace[1381445288] transaction","detail":"{read_only:false; response_revision:25504; number_of_response:1; }","duration":"299.31303ms","start":"2026-10-15T15:04:46.7866Z","end":"2026-10-15T15:04:47.085913Z","steps":["trace[1381445288] 'process raft request' (duration: 299.117245ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:04:47.085989Z","caller":"traceutil/trace.go:171","msg":"trace[1046183478] transaction","detail":"{read_only:false; response_revision:25505; number_of_response:1; }","duration":"208.891118ms","start":"2026-10-15T15:04:46.877071Z","end":"2026-10-15T15:04:47.085962Z","steps":["trace[1046183478] 'process raft request' (duration: 208.761345ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:04:47.086041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:04:46.769434Z","time spent":"316.517264ms","remote":"127.0.0.1:42932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T15:04:47.853794Z","caller":"traceutil/trace.go:171","msg":"trace[2052805716] linearizableReadLoop","detail":"{readStateIndex:26337; appliedIndex:26336; }","duration":"129.571411ms","start":"2026-10-15T15:04:47.724193Z","end":"2026-10-15T15:04:47.853764Z","steps":["trace[2052805716] 'read index received' (duration: 129.412077ms)","trace[2052805716] 'applied index is now lower than readState.Index' (duration: 157.944µs)"],"step_count":2} {"level":"warn","ts":"2026-10-15T15:04:47.853953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.736146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T15:04:47.853943Z","caller":"traceutil/trace.go:171","msg":"trace[308340242] transaction","detail":"{read_only:false; response_revision:25509; number_of_response:1; }","duration":"280.181263ms","start":"2026-10-15T15:04:47.573673Z","end":"2026-10-15T15:04:47.853854Z","steps":["trace[308340242] 'process raft request' (duration: 279.929826ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:04:47.854011Z","caller":"traceutil/trace.go:171","msg":"trace[691653188] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:25509; }","duration":"129.842079ms","start":"2026-10-15T15:04:47.724152Z","end":"2026-10-15T15:04:47.853994Z","steps":["trace[691653188] 'agreement among raft nodes before linearized reading' (duration: 129.727916ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:04:47.879481Z","caller":"traceutil/trace.go:171","msg":"trace[1439916929] transaction","detail":"{read_only:false; response_revision:25510; number_of_response:1; }","duration":"102.830794ms","start":"2026-10-15T15:04:47.776622Z","end":"2026-10-15T15:04:47.879453Z","steps":["trace[1439916929] 'process raft request' (duration: 102.67179ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:04:57.831289Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22117} {"level":"info","ts":"2026-10-15T15:04:57.954809Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22117,"took":"117.791917ms","hash":875573218,"current-db-size-bytes":54788096,"current-db-size":"55 MB","current-db-size-in-use-bytes":44720128,"current-db-size-in-use":"45 MB"} {"level":"info","ts":"2026-10-15T15:04:57.954899Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":875573218,"revision":22117,"compact-revision":19898} {"level":"info","ts":"2026-10-15T15:05:18.257582Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006899.wal"} {"level":"info","ts":"2026-10-15T15:09:57.838268Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25580} {"level":"info","ts":"2026-10-15T15:09:58.013881Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25580,"took":"171.203219ms","hash":2006008786,"current-db-size-bytes":55418880,"current-db-size":"55 MB","current-db-size-in-use-bytes":35966976,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-15T15:09:58.013963Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2006008786,"revision":25580,"compact-revision":22117} {"level":"info","ts":"2026-10-15T15:11:16.123383Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d71a1778b31d4ce","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-15T15:11:16.129855Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-15T15:11:16.130006Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-15T15:14:57.846448Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28477} {"level":"info","ts":"2026-10-15T15:14:58.002938Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28477,"took":"151.089045ms","hash":2217606994,"current-db-size-bytes":55418880,"current-db-size":"55 MB","current-db-size-in-use-bytes":30916608,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-15T15:14:58.003016Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2217606994,"revision":28477,"compact-revision":25580} {"level":"info","ts":"2026-10-15T15:18:46.420407Z","caller":"traceutil/trace.go:171","msg":"trace[1423961892] linearizableReadLoop","detail":"{readStateIndex:33448; appliedIndex:33447; }","duration":"117.519592ms","start":"2026-10-15T15:18:46.302864Z","end":"2026-10-15T15:18:46.420383Z","steps":["trace[1423961892] 'read index received' (duration: 117.322667ms)","trace[1423961892] 'applied index is now lower than readState.Index' (duration: 195.905µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T15:18:46.420508Z","caller":"traceutil/trace.go:171","msg":"trace[857440975] transaction","detail":"{read_only:false; response_revision:32430; number_of_response:1; }","duration":"208.70991ms","start":"2026-10-15T15:18:46.211764Z","end":"2026-10-15T15:18:46.420474Z","steps":["trace[857440975] 'process raft request' (duration: 208.472643ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:18:46.420641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.738458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-10-15T15:18:46.420695Z","caller":"traceutil/trace.go:171","msg":"trace[1024996451] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:32430; }","duration":"117.849051ms","start":"2026-10-15T15:18:46.302823Z","end":"2026-10-15T15:18:46.420672Z","steps":["trace[1024996451] 'agreement among raft nodes before linearized reading' (duration: 117.682026ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:18:46.456445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.026481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-15T15:18:46.45653Z","caller":"traceutil/trace.go:171","msg":"trace[2111498912] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:32431; }","duration":"152.171205ms","start":"2026-10-15T15:18:46.304341Z","end":"2026-10-15T15:18:46.456512Z","steps":["trace[2111498912] 'agreement among raft nodes before linearized reading' (duration: 151.943939ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:18:46.456768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.78725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:38 size:318663"} {"level":"info","ts":"2026-10-15T15:18:46.45685Z","caller":"traceutil/trace.go:171","msg":"trace[280651928] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:38; response_revision:32431; }","duration":"121.881712ms","start":"2026-10-15T15:18:46.334948Z","end":"2026-10-15T15:18:46.45683Z","steps":["trace[280651928] 'agreement among raft nodes before linearized reading' (duration: 121.317097ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:18:46.457023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.146154ms","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:8"} {"level":"info","ts":"2026-10-15T15:18:46.457076Z","caller":"traceutil/trace.go:171","msg":"trace[1285987268] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:32431; }","duration":"104.246217ms","start":"2026-10-15T15:18:46.352815Z","end":"2026-10-15T15:18:46.457061Z","steps":["trace[1285987268] 'agreement among raft nodes before linearized reading' (duration: 103.403293ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:18:46.565922Z","caller":"traceutil/trace.go:171","msg":"trace[755123765] transaction","detail":"{read_only:false; response_revision:32432; number_of_response:1; }","duration":"140.172055ms","start":"2026-10-15T15:18:46.425704Z","end":"2026-10-15T15:18:46.565876Z","steps":["trace[755123765] 'process raft request' (duration: 139.942449ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:18:46.566434Z","caller":"traceutil/trace.go:171","msg":"trace[1522520003] linearizableReadLoop","detail":"{readStateIndex:33450; appliedIndex:33449; }","duration":"109.660846ms","start":"2026-10-15T15:18:46.456159Z","end":"2026-10-15T15:18:46.56582Z","steps":["trace[1522520003] 'read index received' (duration: 109.504301ms)","trace[1522520003] 'applied index is now lower than readState.Index' (duration: 155.535µs)"],"step_count":2} {"level":"warn","ts":"2026-10-15T15:18:46.566628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.555911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" ","response":"range_response_count:1 size:18849"} {"level":"info","ts":"2026-10-15T15:18:46.566668Z","caller":"traceutil/trace.go:171","msg":"trace[769746141] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:1; response_revision:32432; }","duration":"138.664314ms","start":"2026-10-15T15:18:46.427992Z","end":"2026-10-15T15:18:46.566657Z","steps":["trace[769746141] 'agreement among raft nodes before linearized reading' (duration: 138.498889ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:18:46.567439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.759111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-10-15T15:18:46.567531Z","caller":"traceutil/trace.go:171","msg":"trace[261641326] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:32432; }","duration":"112.936266ms","start":"2026-10-15T15:18:46.454582Z","end":"2026-10-15T15:18:46.567518Z","steps":["trace[261641326] 'agreement among raft nodes before linearized reading' (duration: 111.305761ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:18:46.620655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.45791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/servers/\" range_end:\"/registry/openstack.k-orc.cloud/servers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T15:18:46.620713Z","caller":"traceutil/trace.go:171","msg":"trace[1453034886] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/servers/; range_end:/registry/openstack.k-orc.cloud/servers0; response_count:0; response_revision:32433; }","duration":"125.551183ms","start":"2026-10-15T15:18:46.495145Z","end":"2026-10-15T15:18:46.620696Z","steps":["trace[1453034886] 'agreement among raft nodes before linearized reading' (duration: 125.43365ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:18:46.620854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.307401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-10-15T15:18:46.620909Z","caller":"traceutil/trace.go:171","msg":"trace[2131594119] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:32433; }","duration":"103.394943ms","start":"2026-10-15T15:18:46.517501Z","end":"2026-10-15T15:18:46.620896Z","steps":["trace[2131594119] 'agreement among raft nodes before linearized reading' (duration: 103.227659ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:18:51.708253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.708252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-15T15:18:51.708368Z","caller":"traceutil/trace.go:171","msg":"trace[607546614] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:32469; }","duration":"131.834896ms","start":"2026-10-15T15:18:51.576511Z","end":"2026-10-15T15:18:51.708346Z","steps":["trace[607546614] 'range keys from in-memory index tree' (duration: 131.509486ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:19:57.853571Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30695} {"level":"info","ts":"2026-10-15T15:19:57.969201Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30695,"took":"112.838994ms","hash":811279037,"current-db-size-bytes":55418880,"current-db-size":"55 MB","current-db-size-in-use-bytes":31309824,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-15T15:19:57.969269Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":811279037,"revision":30695,"compact-revision":28477} {"level":"info","ts":"2026-10-15T15:24:57.860605Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32957} {"level":"info","ts":"2026-10-15T15:24:57.997364Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32957,"took":"133.40983ms","hash":486578621,"current-db-size-bytes":55418880,"current-db-size":"55 MB","current-db-size-in-use-bytes":31113216,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-15T15:24:57.997437Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":486578621,"revision":32957,"compact-revision":30695} {"level":"info","ts":"2026-10-15T15:29:32.935574Z","caller":"traceutil/trace.go:171","msg":"trace[1906736650] transaction","detail":"{read_only:false; response_revision:37297; number_of_response:1; }","duration":"126.273197ms","start":"2026-10-15T15:29:32.809266Z","end":"2026-10-15T15:29:32.935539Z","steps":["trace[1906736650] 'process raft request' (duration: 110.986069ms)","trace[1906736650] 'compare' (duration: 14.870816ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T15:29:34.783549Z","caller":"traceutil/trace.go:171","msg":"trace[132767029] transaction","detail":"{read_only:false; response_revision:37308; number_of_response:1; }","duration":"138.333646ms","start":"2026-10-15T15:29:34.645198Z","end":"2026-10-15T15:29:34.783532Z","steps":["trace[132767029] 'process raft request' (duration: 137.462152ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:29:34.783914Z","caller":"traceutil/trace.go:171","msg":"trace[837687182] transaction","detail":"{read_only:false; response_revision:37309; number_of_response:1; }","duration":"130.545083ms","start":"2026-10-15T15:29:34.65336Z","end":"2026-10-15T15:29:34.783905Z","steps":["trace[837687182] 'process raft request' (duration: 130.147982ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:29:57.867909Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35249} {"level":"info","ts":"2026-10-15T15:29:58.009877Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35249,"took":"138.996093ms","hash":4264342100,"current-db-size-bytes":55881728,"current-db-size":"56 MB","current-db-size-in-use-bytes":33386496,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-15T15:29:58.00995Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4264342100,"revision":35249,"compact-revision":32957} {"level":"info","ts":"2026-10-15T15:32:47.843136Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d71a1778b31d4ce","local-member-applied-index":40005,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-15T15:32:47.853506Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40005} {"level":"info","ts":"2026-10-15T15:32:47.853976Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35005} {"level":"info","ts":"2026-10-15T15:34:57.873656Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37480} {"level":"info","ts":"2026-10-15T15:34:58.023684Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37480,"took":"145.98407ms","hash":775358250,"current-db-size-bytes":56729600,"current-db-size":"57 MB","current-db-size-in-use-bytes":33046528,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-15T15:34:58.023751Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":775358250,"revision":37480,"compact-revision":35249} {"level":"info","ts":"2026-10-15T15:34:58.824379Z","caller":"traceutil/trace.go:171","msg":"trace[276863322] linearizableReadLoop","detail":"{readStateIndex:40997; appliedIndex:40996; }","duration":"147.10315ms","start":"2026-10-15T15:34:58.677224Z","end":"2026-10-15T15:34:58.824327Z","steps":["trace[276863322] 'read index received' (duration: 146.848763ms)","trace[276863322] 'applied index is now lower than readState.Index' (duration: 253.207µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T15:34:58.824487Z","caller":"traceutil/trace.go:171","msg":"trace[264158878] transaction","detail":"{read_only:false; response_revision:39764; number_of_response:1; }","duration":"149.325061ms","start":"2026-10-15T15:34:58.675124Z","end":"2026-10-15T15:34:58.824449Z","steps":["trace[264158878] 'process raft request' (duration: 149.048254ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:34:58.824697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.954101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/neutron-rpc-server\" ","response":"range_response_count:1 size:7955"} {"level":"info","ts":"2026-10-15T15:34:58.824762Z","caller":"traceutil/trace.go:171","msg":"trace[1379270341] range","detail":"{range_begin:/registry/deployments/openstack/neutron-rpc-server; range_end:; response_count:1; response_revision:39764; }","duration":"118.062154ms","start":"2026-10-15T15:34:58.706683Z","end":"2026-10-15T15:34:58.824745Z","steps":["trace[1379270341] 'agreement among raft nodes before linearized reading' (duration: 117.830738ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:34:58.824932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.658465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/neutron-coredns\" ","response":"range_response_count:1 size:5229"} {"level":"info","ts":"2026-10-15T15:34:58.825058Z","caller":"traceutil/trace.go:171","msg":"trace[239183900] range","detail":"{range_begin:/registry/deployments/openstack/neutron-coredns; range_end:; response_count:1; response_revision:39764; }","duration":"147.82913ms","start":"2026-10-15T15:34:58.677199Z","end":"2026-10-15T15:34:58.825028Z","steps":["trace[239183900] 'agreement among raft nodes before linearized reading' (duration: 147.312826ms)"],"step_count":1}