Skip to content

fix ChannelPending Panic#112

Closed
bitwalt wants to merge 1 commit intoRGB-Tools:masterfrom
bitwalt:rln-channelpending-panic
Closed

fix ChannelPending Panic#112
bitwalt wants to merge 1 commit intoRGB-Tools:masterfrom
bitwalt:rln-channelpending-panic

Conversation

@bitwalt
Copy link
Copy Markdown
Contributor

@bitwalt bitwalt commented Mar 20, 2026

reproduce and fix #111

@zoedberg
Copy link
Copy Markdown
Member

I cannot consider the test valid since it's doing a manual hack (setting rgb_send_lock and writing a dumb psbt). Tests should reproduce errors only by using public APIs and without making internal changes.

@bitwalt bitwalt force-pushed the rln-channelpending-panic branch 3 times, most recently from 194b12c to 446729c Compare March 24, 2026 16:18
@zoedberg
Copy link
Copy Markdown
Member

On my side the new test is failing. Here the logs:

---- test::openchannel_close_before_funding::openchannel_peer_offline_releases_lock stdout ----
skipping services initialization
starting node with peer port 9801
2026-03-24T17:08:12.525048Z  INFO request{uri=/init request_id=4b7a32fa-5334-497c-9427-2ce4541cb5a6}: rgb_lightning_node: STARTED
2026-03-24T17:08:12.554861Z  INFO rgb_lightning_node::utils: Created a new wallet
2026-03-24T17:08:12.554976Z  INFO request{uri=/init request_id=4b7a32fa-5334-497c-9427-2ce4541cb5a6 status_code=200 OK}: rgb_lightning_node: ENDED in 29.976338ms
unlocking node 0.0.0.0:36419
unlocking node 0.0.0.0:36419
2026-03-24T17:08:12.564882Z  INFO request{uri=/unlock request_id=126a87d1-4158-40fb-9e59-c3c8edf530a0}: rgb_lightning_node: STARTED
2026-03-24T17:08:12.564987Z  INFO request{uri=/unlock request_id=126a87d1-4158-40fb-9e59-c3c8edf530a0}: rgb_lightning_node::routes: Unlock started
2026-03-24T17:08:12.565134Z DEBUG rgb_lightning_node::routes: Starting LDK...
2026-03-24T17:08:12.570368Z  INFO rgb_lightning_node::ldk: Connected to an indexer with the Electrum protocol
2026-03-24T17:08:12.583267Z  INFO rgb_lightning_node::ldk: Using a custom proxy
2026-03-24T17:08:13.746889Z  INFO rgb_lightning_node::ldk: LDK logs are available at <your-supplied-ldk-data-dir-path>/.ldk/logs
2026-03-24T17:08:13.746914Z  INFO rgb_lightning_node::ldk: Local Node ID is 024808644a40068e0de85884c731549362f48b767a3b49fe13fdae97c362fe6390
2026-03-24T17:08:13.746925Z DEBUG rgb_lightning_node::routes: LDK started
2026-03-24T17:08:13.746940Z  INFO rgb_lightning_node::routes: Unlock completed
2026-03-24T17:08:13.747050Z  INFO request{uri=/unlock request_id=126a87d1-4158-40fb-9e59-c3c8edf530a0 status_code=200 OK}: rgb_lightning_node: ENDED in 1.182180607s
node on peer port 9801 started with address 0.0.0.0:36419
starting node with peer port 9802
2026-03-24T17:08:13.757893Z  INFO request{uri=/init request_id=f2538387-4be1-4489-b113-7c674a8acf61}: rgb_lightning_node: STARTED
2026-03-24T17:08:13.787544Z  INFO rgb_lightning_node::utils: Created a new wallet
2026-03-24T17:08:13.787685Z  INFO request{uri=/init request_id=f2538387-4be1-4489-b113-7c674a8acf61 status_code=200 OK}: rgb_lightning_node: ENDED in 29.815806ms
unlocking node 0.0.0.0:42131
unlocking node 0.0.0.0:42131
2026-03-24T17:08:13.797775Z  INFO request{uri=/unlock request_id=ae2cc98d-5b27-4ce3-b3e1-642b4c2af4bc}: rgb_lightning_node: STARTED
2026-03-24T17:08:13.797866Z  INFO request{uri=/unlock request_id=ae2cc98d-5b27-4ce3-b3e1-642b4c2af4bc}: rgb_lightning_node::routes: Unlock started
2026-03-24T17:08:13.798007Z DEBUG rgb_lightning_node::routes: Starting LDK...
2026-03-24T17:08:13.804045Z  INFO rgb_lightning_node::ldk: Connected to an indexer with the Electrum protocol
2026-03-24T17:08:13.816938Z  INFO rgb_lightning_node::ldk: Using a custom proxy
2026-03-24T17:08:14.942744Z  INFO rgb_lightning_node::ldk: LDK logs are available at <your-supplied-ldk-data-dir-path>/.ldk/logs
2026-03-24T17:08:14.942770Z  INFO rgb_lightning_node::ldk: Local Node ID is 0385615c234a30e6a90bf1e8b5409166982126be9c692b0001107ab5a4da3ab208
2026-03-24T17:08:14.942783Z DEBUG rgb_lightning_node::routes: LDK started
2026-03-24T17:08:14.942800Z  INFO rgb_lightning_node::routes: Unlock completed
2026-03-24T17:08:14.942942Z  INFO request{uri=/unlock request_id=ae2cc98d-5b27-4ce3-b3e1-642b4c2af4bc status_code=200 OK}: rgb_lightning_node: ENDED in 1.145183049s
node on peer port 9802 started with address 0.0.0.0:42131
funding wallet for node 0.0.0.0:36419
getting address for node 0.0.0.0:36419
2026-03-24T17:08:14.953629Z  INFO request{uri=/address request_id=08e4c3a1-eaad-47d7-a145-b1eefd7dc873}: rgb_lightning_node: STARTED
2026-03-24T17:08:14.960589Z  INFO request{uri=/address request_id=08e4c3a1-eaad-47d7-a145-b1eefd7dc873 status_code=200 OK}: rgb_lightning_node: ENDED in 6.982771ms
creating 5 UTXOs for node 0.0.0.0:36419
2026-03-24T17:08:15.330398Z  INFO request{uri=/createutxos request_id=24890a5b-1047-466f-829a-e6acbb70cf9a}: rgb_lightning_node: STARTED
2026-03-24T17:08:15.483018Z DEBUG rgb_lightning_node::routes: UTXO creation complete
2026-03-24T17:08:15.483200Z  INFO request{uri=/createutxos request_id=24890a5b-1047-466f-829a-e6acbb70cf9a status_code=200 OK}: rgb_lightning_node: ENDED in 152.852591ms
getting node info for 0.0.0.0:42131
2026-03-24T17:08:15.780564Z  INFO request{uri=/nodeinfo request_id=61be3c45-41fd-4768-9fd0-8b874ce8469b}: rgb_lightning_node: STARTED
2026-03-24T17:08:15.780692Z  INFO request{uri=/nodeinfo request_id=61be3c45-41fd-4768-9fd0-8b874ce8469b status_code=200 OK}: rgb_lightning_node: ENDED in 176.27µs
2026-03-24T17:08:15.788434Z  INFO request{uri=/openchannel request_id=e35b646b-4c33-4a6c-88cb-efdb6a4b3ad7}: rgb_lightning_node: STARTED
2026-03-24T17:08:15.799569Z  INFO rgb_lightning_node::utils: connected to peer (pubkey: 0385615c234a30e6a90bf1e8b5409166982126be9c692b0001107ab5a4da3ab208, addr: 127.0.0.1:9802)
2026-03-24T17:08:15.799666Z  INFO rgb_lightning_node::disk: persisted peer (pubkey: 0385615c234a30e6a90bf1e8b5409166982126be9c692b0001107ab5a4da3ab208, addr: 127.0.0.1:9802)
2026-03-24T17:08:15.799674Z DEBUG rgb_lightning_node::routes: RGB send lock set to true
2026-03-24T17:08:15.800888Z  INFO rgb_lightning_node::routes: EVENT: initiated channel with peer 0385615c234a30e6a90bf1e8b5409166982126be9c692b0001107ab5a4da3ab208
2026-03-24T17:08:15.800951Z  INFO request{uri=/openchannel request_id=e35b646b-4c33-4a6c-88cb-efdb6a4b3ad7 status_code=200 OK}: rgb_lightning_node: ENDED in 12.542153ms
shutting down node 0.0.0.0:42131
2026-03-24T17:08:15.808826Z  INFO request{uri=/shutdown request_id=73464668-0a92-4512-9a61-739efc91106f}: rgb_lightning_node: STARTED
2026-03-24T17:08:15.808904Z  INFO request{uri=/shutdown request_id=73464668-0a92-4512-9a61-739efc91106f status_code=200 OK}: rgb_lightning_node: ENDED in 105.358µs
2026-03-24T17:08:15.808966Z  INFO rgb_lightning_node: Received a shutdown signal
2026-03-24T17:08:15.808971Z  INFO rgb_lightning_node::ldk: Stopping LDK
2026-03-24T17:08:16.819276Z  INFO rgb_lightning_node::ldk: Stopped LDK
starting node with peer port 9803
2026-03-24T17:08:17.820162Z  INFO request{uri=/init request_id=2ee71daa-73ad-46cb-a450-f4544af48116}: rgb_lightning_node: STARTED
2026-03-24T17:08:17.844735Z  INFO rgb_lightning_node::utils: Created a new wallet
2026-03-24T17:08:17.844832Z  INFO request{uri=/init request_id=2ee71daa-73ad-46cb-a450-f4544af48116 status_code=200 OK}: rgb_lightning_node: ENDED in 24.713016ms
unlocking node 0.0.0.0:39289
unlocking node 0.0.0.0:39289
2026-03-24T17:08:17.852999Z  INFO request{uri=/unlock request_id=92619da1-8213-465f-906b-4d8a92528dc6}: rgb_lightning_node: STARTED
2026-03-24T17:08:17.853078Z  INFO request{uri=/unlock request_id=92619da1-8213-465f-906b-4d8a92528dc6}: rgb_lightning_node::routes: Unlock started
2026-03-24T17:08:17.853201Z DEBUG rgb_lightning_node::routes: Starting LDK...
2026-03-24T17:08:17.859063Z  INFO rgb_lightning_node::ldk: Connected to an indexer with the Electrum protocol
2026-03-24T17:08:17.871600Z  INFO rgb_lightning_node::ldk: Using a custom proxy
2026-03-24T17:08:19.016380Z  INFO rgb_lightning_node::ldk: LDK logs are available at <your-supplied-ldk-data-dir-path>/.ldk/logs
2026-03-24T17:08:19.016400Z  INFO rgb_lightning_node::ldk: Local Node ID is 02f47dabca17e248dcca5e8d3e99516a95b679d5651e643efed421c4686714312d
2026-03-24T17:08:19.016409Z DEBUG rgb_lightning_node::routes: LDK started
2026-03-24T17:08:19.016423Z  INFO rgb_lightning_node::routes: Unlock completed
2026-03-24T17:08:19.016531Z  INFO request{uri=/unlock request_id=92619da1-8213-465f-906b-4d8a92528dc6 status_code=200 OK}: rgb_lightning_node: ENDED in 1.163557835s
node on peer port 9803 started with address 0.0.0.0:39289
funding wallet for node 0.0.0.0:39289
getting address for node 0.0.0.0:39289
2026-03-24T17:08:19.026994Z  INFO request{uri=/address request_id=78d1f120-b43c-4118-8d35-8160f9b2f00a}: rgb_lightning_node: STARTED
2026-03-24T17:08:19.035358Z  INFO request{uri=/address request_id=78d1f120-b43c-4118-8d35-8160f9b2f00a status_code=200 OK}: rgb_lightning_node: ENDED in 8.378773ms
creating 10 UTXOs for node 0.0.0.0:39289
2026-03-24T17:08:19.417048Z  INFO request{uri=/createutxos request_id=40b320c5-30a2-43ad-a60d-b1ff570ca771}: rgb_lightning_node: STARTED
2026-03-24T17:08:19.626037Z DEBUG rgb_lightning_node::routes: UTXO creation complete
2026-03-24T17:08:19.626213Z  INFO request{uri=/createutxos request_id=40b320c5-30a2-43ad-a60d-b1ff570ca771 status_code=200 OK}: rgb_lightning_node: ENDED in 209.201865ms
getting node info for 0.0.0.0:39289
2026-03-24T17:08:19.891088Z  INFO request{uri=/nodeinfo request_id=95fc55d3-d9bc-4de8-82d7-992581d79b75}: rgb_lightning_node: STARTED
2026-03-24T17:08:19.891208Z  INFO request{uri=/nodeinfo request_id=95fc55d3-d9bc-4de8-82d7-992581d79b75 status_code=200 OK}: rgb_lightning_node: ENDED in 168.916µs
2026-03-24T17:08:19.898998Z  INFO request{uri=/openchannel request_id=8e1a4b83-cd1f-4188-b1f8-7fe5f89ffd27}: rgb_lightning_node: STARTED
2026-03-24T17:08:19.899135Z ERROR request{uri=/openchannel request_id=8e1a4b83-cd1f-4188-b1f8-7fe5f89ffd27}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:19.899180Z  INFO request{uri=/openchannel request_id=8e1a4b83-cd1f-4188-b1f8-7fe5f89ffd27 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 218.045µs
2026-03-24T17:08:20.908468Z  INFO request{uri=/openchannel request_id=fca2ed53-60e8-44bd-aa4e-38e1c8dce6a9}: rgb_lightning_node: STARTED
2026-03-24T17:08:20.908606Z ERROR request{uri=/openchannel request_id=fca2ed53-60e8-44bd-aa4e-38e1c8dce6a9}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:20.908655Z  INFO request{uri=/openchannel request_id=fca2ed53-60e8-44bd-aa4e-38e1c8dce6a9 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 236.228µs
2026-03-24T17:08:21.917496Z  INFO request{uri=/openchannel request_id=6c0ee39c-4860-4aa5-9861-08c162db86c0}: rgb_lightning_node: STARTED
2026-03-24T17:08:21.917637Z ERROR request{uri=/openchannel request_id=6c0ee39c-4860-4aa5-9861-08c162db86c0}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:21.917685Z  INFO request{uri=/openchannel request_id=6c0ee39c-4860-4aa5-9861-08c162db86c0 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 237.842µs
2026-03-24T17:08:22.927218Z  INFO request{uri=/openchannel request_id=402eb676-9784-45db-a69e-e2c8699d104a}: rgb_lightning_node: STARTED
2026-03-24T17:08:22.927362Z ERROR request{uri=/openchannel request_id=402eb676-9784-45db-a69e-e2c8699d104a}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:22.927411Z  INFO request{uri=/openchannel request_id=402eb676-9784-45db-a69e-e2c8699d104a status_code=403 Forbidden}: rgb_lightning_node: ENDED in 243.999µs
2026-03-24T17:08:23.937330Z  INFO request{uri=/openchannel request_id=f3830f2e-f73e-4bd1-807b-25a997fd07da}: rgb_lightning_node: STARTED
2026-03-24T17:08:23.937470Z ERROR request{uri=/openchannel request_id=f3830f2e-f73e-4bd1-807b-25a997fd07da}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:23.937519Z  INFO request{uri=/openchannel request_id=f3830f2e-f73e-4bd1-807b-25a997fd07da status_code=403 Forbidden}: rgb_lightning_node: ENDED in 237.821µs
2026-03-24T17:08:24.947199Z  INFO request{uri=/openchannel request_id=6e1d7a04-5e5a-4b6e-870e-c78e585a892f}: rgb_lightning_node: STARTED
2026-03-24T17:08:24.947340Z ERROR request{uri=/openchannel request_id=6e1d7a04-5e5a-4b6e-870e-c78e585a892f}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:24.947387Z  INFO request{uri=/openchannel request_id=6e1d7a04-5e5a-4b6e-870e-c78e585a892f status_code=403 Forbidden}: rgb_lightning_node: ENDED in 236.563µs
2026-03-24T17:08:25.958917Z  INFO request{uri=/openchannel request_id=175032df-8ffe-41ad-a760-75a182886f55}: rgb_lightning_node: STARTED
2026-03-24T17:08:25.959095Z ERROR request{uri=/openchannel request_id=175032df-8ffe-41ad-a760-75a182886f55}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:25.959155Z  INFO request{uri=/openchannel request_id=175032df-8ffe-41ad-a760-75a182886f55 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 294.992µs
2026-03-24T17:08:26.971341Z  INFO request{uri=/openchannel request_id=0c176ba0-3d3b-4167-8e86-a633261fe2f9}: rgb_lightning_node: STARTED
2026-03-24T17:08:26.971524Z ERROR request{uri=/openchannel request_id=0c176ba0-3d3b-4167-8e86-a633261fe2f9}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:26.971583Z  INFO request{uri=/openchannel request_id=0c176ba0-3d3b-4167-8e86-a633261fe2f9 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 301.294µs
2026-03-24T17:08:27.983163Z  INFO request{uri=/openchannel request_id=710249e6-770d-4445-a52d-63c20cb70b28}: rgb_lightning_node: STARTED
2026-03-24T17:08:27.983340Z ERROR request{uri=/openchannel request_id=710249e6-770d-4445-a52d-63c20cb70b28}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:27.983399Z  INFO request{uri=/openchannel request_id=710249e6-770d-4445-a52d-63c20cb70b28 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 295.194µs
2026-03-24T17:08:28.996076Z  INFO request{uri=/openchannel request_id=29814969-4523-4efc-8bb5-074e0af73c97}: rgb_lightning_node: STARTED
2026-03-24T17:08:28.996258Z ERROR request{uri=/openchannel request_id=29814969-4523-4efc-8bb5-074e0af73c97}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:28.996329Z  INFO request{uri=/openchannel request_id=29814969-4523-4efc-8bb5-074e0af73c97 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 312.859µs
2026-03-24T17:08:30.008819Z  INFO request{uri=/openchannel request_id=28f59878-d282-47ae-b1ad-1a98d9bab578}: rgb_lightning_node: STARTED
2026-03-24T17:08:30.008999Z ERROR request{uri=/openchannel request_id=28f59878-d282-47ae-b1ad-1a98d9bab578}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:30.009060Z  INFO request{uri=/openchannel request_id=28f59878-d282-47ae-b1ad-1a98d9bab578 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 299.986µs
2026-03-24T17:08:31.020920Z  INFO request{uri=/openchannel request_id=2ed2b4b8-8128-401a-b828-eeafb91ab0c8}: rgb_lightning_node: STARTED
2026-03-24T17:08:31.021096Z ERROR request{uri=/openchannel request_id=2ed2b4b8-8128-401a-b828-eeafb91ab0c8}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:31.021154Z  INFO request{uri=/openchannel request_id=2ed2b4b8-8128-401a-b828-eeafb91ab0c8 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 292.614µs
2026-03-24T17:08:32.032802Z  INFO request{uri=/openchannel request_id=d4ff538a-825d-4b0c-b410-d78c4a6d2217}: rgb_lightning_node: STARTED
2026-03-24T17:08:32.033153Z ERROR request{uri=/openchannel request_id=d4ff538a-825d-4b0c-b410-d78c4a6d2217}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:32.033369Z  INFO request{uri=/openchannel request_id=d4ff538a-825d-4b0c-b410-d78c4a6d2217 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 600.377µs
2026-03-24T17:08:33.045207Z  INFO request{uri=/openchannel request_id=cc6f1230-3a0a-4d97-ac62-d67c3570c054}: rgb_lightning_node: STARTED
2026-03-24T17:08:33.045384Z ERROR request{uri=/openchannel request_id=cc6f1230-3a0a-4d97-ac62-d67c3570c054}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:33.045444Z  INFO request{uri=/openchannel request_id=cc6f1230-3a0a-4d97-ac62-d67c3570c054 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 294.99µs
2026-03-24T17:08:34.056982Z  INFO request{uri=/openchannel request_id=d3d0514a-ee98-4151-91ec-218381aba58e}: rgb_lightning_node: STARTED
2026-03-24T17:08:34.057149Z ERROR request{uri=/openchannel request_id=d3d0514a-ee98-4151-91ec-218381aba58e}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:34.057200Z  INFO request{uri=/openchannel request_id=d3d0514a-ee98-4151-91ec-218381aba58e status_code=403 Forbidden}: rgb_lightning_node: ENDED in 275.631µs
2026-03-24T17:08:35.069087Z  INFO request{uri=/openchannel request_id=7879ba98-8035-495e-b2af-a23946331945}: rgb_lightning_node: STARTED
2026-03-24T17:08:35.069274Z ERROR request{uri=/openchannel request_id=7879ba98-8035-495e-b2af-a23946331945}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:35.069326Z  INFO request{uri=/openchannel request_id=7879ba98-8035-495e-b2af-a23946331945 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 298.065µs
2026-03-24T17:08:36.081820Z  INFO request{uri=/openchannel request_id=55406580-09e1-4a12-a9b1-9c09a20e693e}: rgb_lightning_node: STARTED
2026-03-24T17:08:36.082013Z ERROR request{uri=/openchannel request_id=55406580-09e1-4a12-a9b1-9c09a20e693e}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:36.082107Z  INFO request{uri=/openchannel request_id=55406580-09e1-4a12-a9b1-9c09a20e693e status_code=403 Forbidden}: rgb_lightning_node: ENDED in 346.823µs
2026-03-24T17:08:37.094752Z  INFO request{uri=/openchannel request_id=1a2d2e0c-af48-44c8-b491-27d09d8facfa}: rgb_lightning_node: STARTED
2026-03-24T17:08:37.094927Z ERROR request{uri=/openchannel request_id=1a2d2e0c-af48-44c8-b491-27d09d8facfa}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:37.094986Z  INFO request{uri=/openchannel request_id=1a2d2e0c-af48-44c8-b491-27d09d8facfa status_code=403 Forbidden}: rgb_lightning_node: ENDED in 290.745µs
2026-03-24T17:08:38.107221Z  INFO request{uri=/openchannel request_id=ccc19d72-ea33-4274-88d3-6ae9746f53fc}: rgb_lightning_node: STARTED
2026-03-24T17:08:38.107391Z ERROR request{uri=/openchannel request_id=ccc19d72-ea33-4274-88d3-6ae9746f53fc}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:38.107455Z  INFO request{uri=/openchannel request_id=ccc19d72-ea33-4274-88d3-6ae9746f53fc status_code=403 Forbidden}: rgb_lightning_node: ENDED in 291.034µs
2026-03-24T17:08:39.119631Z  INFO request{uri=/openchannel request_id=44d7c75a-0a67-442c-8a4c-1abdeb319615}: rgb_lightning_node: STARTED
2026-03-24T17:08:39.119806Z ERROR request{uri=/openchannel request_id=44d7c75a-0a67-442c-8a4c-1abdeb319615}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:39.119869Z  INFO request{uri=/openchannel request_id=44d7c75a-0a67-442c-8a4c-1abdeb319615 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 295.772µs
2026-03-24T17:08:40.132171Z  INFO request{uri=/openchannel request_id=b36cc13b-8674-4ee6-9008-2e3c7eba3d4e}: rgb_lightning_node: STARTED
2026-03-24T17:08:40.132345Z ERROR request{uri=/openchannel request_id=b36cc13b-8674-4ee6-9008-2e3c7eba3d4e}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:40.132403Z  INFO request{uri=/openchannel request_id=b36cc13b-8674-4ee6-9008-2e3c7eba3d4e status_code=403 Forbidden}: rgb_lightning_node: ENDED in 290.932µs
2026-03-24T17:08:41.143853Z  INFO request{uri=/openchannel request_id=6cefc0c5-d3f6-4354-b478-d408c131a8cc}: rgb_lightning_node: STARTED
2026-03-24T17:08:41.144035Z ERROR request{uri=/openchannel request_id=6cefc0c5-d3f6-4354-b478-d408c131a8cc}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:41.144094Z  INFO request{uri=/openchannel request_id=6cefc0c5-d3f6-4354-b478-d408c131a8cc status_code=403 Forbidden}: rgb_lightning_node: ENDED in 299.756µs
2026-03-24T17:08:42.156632Z  INFO request{uri=/openchannel request_id=8b857ed2-5b80-48a2-a98b-fb671c9d8dcf}: rgb_lightning_node: STARTED
2026-03-24T17:08:42.156811Z ERROR request{uri=/openchannel request_id=8b857ed2-5b80-48a2-a98b-fb671c9d8dcf}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:42.156871Z  INFO request{uri=/openchannel request_id=8b857ed2-5b80-48a2-a98b-fb671c9d8dcf status_code=403 Forbidden}: rgb_lightning_node: ENDED in 298.508µs
2026-03-24T17:08:43.169288Z  INFO request{uri=/openchannel request_id=865f56c4-b5ea-490c-b27d-d9a4a5a24a5e}: rgb_lightning_node: STARTED
2026-03-24T17:08:43.169465Z ERROR request{uri=/openchannel request_id=865f56c4-b5ea-490c-b27d-d9a4a5a24a5e}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:43.169521Z  INFO request{uri=/openchannel request_id=865f56c4-b5ea-490c-b27d-d9a4a5a24a5e status_code=403 Forbidden}: rgb_lightning_node: ENDED in 295.001µs
2026-03-24T17:08:44.181612Z  INFO request{uri=/openchannel request_id=3bb6773d-7502-4742-af02-34ce509ed706}: rgb_lightning_node: STARTED
2026-03-24T17:08:44.181789Z ERROR request{uri=/openchannel request_id=3bb6773d-7502-4742-af02-34ce509ed706}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:44.181847Z  INFO request{uri=/openchannel request_id=3bb6773d-7502-4742-af02-34ce509ed706 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 292.91µs
2026-03-24T17:08:45.194341Z  INFO request{uri=/openchannel request_id=28f2b7c4-1a90-4eb5-ac60-222834f98fa2}: rgb_lightning_node: STARTED
2026-03-24T17:08:45.194514Z ERROR request{uri=/openchannel request_id=28f2b7c4-1a90-4eb5-ac60-222834f98fa2}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:45.194578Z  INFO request{uri=/openchannel request_id=28f2b7c4-1a90-4eb5-ac60-222834f98fa2 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 295.293µs
2026-03-24T17:08:46.205875Z  INFO request{uri=/openchannel request_id=f919f1f6-bf91-4b6f-bb2f-94cef83723b4}: rgb_lightning_node: STARTED
2026-03-24T17:08:46.206053Z ERROR request{uri=/openchannel request_id=f919f1f6-bf91-4b6f-bb2f-94cef83723b4}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:46.206114Z  INFO request{uri=/openchannel request_id=f919f1f6-bf91-4b6f-bb2f-94cef83723b4 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 297.252µs
2026-03-24T17:08:47.218801Z  INFO request{uri=/openchannel request_id=51c9cee7-5748-43e8-aef5-50d9cd41e5f3}: rgb_lightning_node: STARTED
2026-03-24T17:08:47.218986Z ERROR request{uri=/openchannel request_id=51c9cee7-5748-43e8-aef5-50d9cd41e5f3}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:47.219043Z  INFO request{uri=/openchannel request_id=51c9cee7-5748-43e8-aef5-50d9cd41e5f3 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 310.65µs
2026-03-24T17:08:48.231945Z  INFO request{uri=/openchannel request_id=19d74f3d-e1b0-4422-a1fc-07ccce563980}: rgb_lightning_node: STARTED
2026-03-24T17:08:48.232124Z ERROR request{uri=/openchannel request_id=19d74f3d-e1b0-4422-a1fc-07ccce563980}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:48.232183Z  INFO request{uri=/openchannel request_id=19d74f3d-e1b0-4422-a1fc-07ccce563980 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 295.919µs
2026-03-24T17:08:49.244511Z  INFO request{uri=/openchannel request_id=76760711-8485-4e23-b01c-db9f98888544}: rgb_lightning_node: STARTED
2026-03-24T17:08:49.244684Z ERROR request{uri=/openchannel request_id=76760711-8485-4e23-b01c-db9f98888544}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:49.244739Z  INFO request{uri=/openchannel request_id=76760711-8485-4e23-b01c-db9f98888544 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 284.311µs
2026-03-24T17:08:50.258079Z  INFO request{uri=/openchannel request_id=e05c9498-733c-4963-b447-904169f88b1d}: rgb_lightning_node: STARTED
2026-03-24T17:08:50.258260Z ERROR request{uri=/openchannel request_id=e05c9498-733c-4963-b447-904169f88b1d}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:50.258321Z  INFO request{uri=/openchannel request_id=e05c9498-733c-4963-b447-904169f88b1d status_code=403 Forbidden}: rgb_lightning_node: ENDED in 300.522µs
2026-03-24T17:08:51.269729Z  INFO request{uri=/openchannel request_id=49b012cc-55cb-46e2-8088-ecdcf3f966cd}: rgb_lightning_node: STARTED
2026-03-24T17:08:51.269905Z ERROR request{uri=/openchannel request_id=49b012cc-55cb-46e2-8088-ecdcf3f966cd}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:51.269963Z  INFO request{uri=/openchannel request_id=49b012cc-55cb-46e2-8088-ecdcf3f966cd status_code=403 Forbidden}: rgb_lightning_node: ENDED in 292.486µs
2026-03-24T17:08:52.281953Z  INFO request{uri=/openchannel request_id=57fcccdb-3e0f-4432-8ac4-6d645b126dc5}: rgb_lightning_node: STARTED
2026-03-24T17:08:52.282130Z ERROR request{uri=/openchannel request_id=57fcccdb-3e0f-4432-8ac4-6d645b126dc5}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:52.282188Z  INFO request{uri=/openchannel request_id=57fcccdb-3e0f-4432-8ac4-6d645b126dc5 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 293.74µs
2026-03-24T17:08:53.294159Z  INFO request{uri=/openchannel request_id=6aed3dce-ad6d-4c6f-9965-bc5816e9758a}: rgb_lightning_node: STARTED
2026-03-24T17:08:53.294345Z ERROR request{uri=/openchannel request_id=6aed3dce-ad6d-4c6f-9965-bc5816e9758a}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:53.294409Z  INFO request{uri=/openchannel request_id=6aed3dce-ad6d-4c6f-9965-bc5816e9758a status_code=403 Forbidden}: rgb_lightning_node: ENDED in 306.184µs
2026-03-24T17:08:54.305883Z  INFO request{uri=/openchannel request_id=062d04db-a13b-49e9-aff3-0d2d9d9ff412}: rgb_lightning_node: STARTED
2026-03-24T17:08:54.306060Z ERROR request{uri=/openchannel request_id=062d04db-a13b-49e9-aff3-0d2d9d9ff412}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:54.306119Z  INFO request{uri=/openchannel request_id=062d04db-a13b-49e9-aff3-0d2d9d9ff412 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 295.142µs
2026-03-24T17:08:55.318628Z  INFO request{uri=/openchannel request_id=7e5c99ab-ac3a-4fe2-bcae-6f66ce888410}: rgb_lightning_node: STARTED
2026-03-24T17:08:55.318818Z ERROR request{uri=/openchannel request_id=7e5c99ab-ac3a-4fe2-bcae-6f66ce888410}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:55.318881Z  INFO request{uri=/openchannel request_id=7e5c99ab-ac3a-4fe2-bcae-6f66ce888410 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 313.383µs
2026-03-24T17:08:56.331304Z  INFO request{uri=/openchannel request_id=5abb5f93-64fc-43ef-9d5d-9ada5dfcd852}: rgb_lightning_node: STARTED
2026-03-24T17:08:56.331484Z ERROR request{uri=/openchannel request_id=5abb5f93-64fc-43ef-9d5d-9ada5dfcd852}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:56.331541Z  INFO request{uri=/openchannel request_id=5abb5f93-64fc-43ef-9d5d-9ada5dfcd852 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 296.366µs
2026-03-24T17:08:57.343692Z  INFO request{uri=/openchannel request_id=6c738e52-6dc3-4232-9e64-415f566c64b0}: rgb_lightning_node: STARTED
2026-03-24T17:08:57.343868Z ERROR request{uri=/openchannel request_id=6c738e52-6dc3-4232-9e64-415f566c64b0}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:57.343925Z  INFO request{uri=/openchannel request_id=6c738e52-6dc3-4232-9e64-415f566c64b0 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 292.059µs
2026-03-24T17:08:58.356116Z  INFO request{uri=/openchannel request_id=dc315ecf-38c1-4e16-95bd-19d3bae5b2ad}: rgb_lightning_node: STARTED
2026-03-24T17:08:58.356296Z ERROR request{uri=/openchannel request_id=dc315ecf-38c1-4e16-95bd-19d3bae5b2ad}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:58.356356Z  INFO request{uri=/openchannel request_id=dc315ecf-38c1-4e16-95bd-19d3bae5b2ad status_code=403 Forbidden}: rgb_lightning_node: ENDED in 299.462µs
2026-03-24T17:08:59.368774Z  INFO request{uri=/openchannel request_id=9baa34c7-c4e4-42fd-8e00-8909c0f050f6}: rgb_lightning_node: STARTED
2026-03-24T17:08:59.368952Z ERROR request{uri=/openchannel request_id=9baa34c7-c4e4-42fd-8e00-8909c0f050f6}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:08:59.369010Z  INFO request{uri=/openchannel request_id=9baa34c7-c4e4-42fd-8e00-8909c0f050f6 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 294.26µs
2026-03-24T17:09:00.381111Z  INFO request{uri=/openchannel request_id=f57a05dc-b12c-49f0-984e-15dcdcf55edb}: rgb_lightning_node: STARTED
2026-03-24T17:09:00.381293Z ERROR request{uri=/openchannel request_id=f57a05dc-b12c-49f0-984e-15dcdcf55edb}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:09:00.381352Z  INFO request{uri=/openchannel request_id=f57a05dc-b12c-49f0-984e-15dcdcf55edb status_code=403 Forbidden}: rgb_lightning_node: ENDED in 300.019µs
2026-03-24T17:09:01.394070Z  INFO request{uri=/openchannel request_id=2fb0942c-60a7-42c8-aa36-f425d320532c}: rgb_lightning_node: STARTED
2026-03-24T17:09:01.394274Z ERROR request{uri=/openchannel request_id=2fb0942c-60a7-42c8-aa36-f425d320532c}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:09:01.394341Z  INFO request{uri=/openchannel request_id=2fb0942c-60a7-42c8-aa36-f425d320532c status_code=403 Forbidden}: rgb_lightning_node: ENDED in 334.08µs
2026-03-24T17:09:02.406687Z  INFO request{uri=/openchannel request_id=c69b6efa-0601-4e3e-8106-a174c52ddb53}: rgb_lightning_node: STARTED
2026-03-24T17:09:02.406862Z ERROR request{uri=/openchannel request_id=c69b6efa-0601-4e3e-8106-a174c52ddb53}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:09:02.406921Z  INFO request{uri=/openchannel request_id=c69b6efa-0601-4e3e-8106-a174c52ddb53 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 294.495µs
2026-03-24T17:09:03.419482Z  INFO request{uri=/openchannel request_id=07309196-62e2-4154-ab3c-10661e2bf4ea}: rgb_lightning_node: STARTED
2026-03-24T17:09:03.419659Z ERROR request{uri=/openchannel request_id=07309196-62e2-4154-ab3c-10661e2bf4ea}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:09:03.419719Z  INFO request{uri=/openchannel request_id=07309196-62e2-4154-ab3c-10661e2bf4ea status_code=403 Forbidden}: rgb_lightning_node: ENDED in 306.509µs
2026-03-24T17:09:04.431546Z  INFO request{uri=/openchannel request_id=29888a11-69fd-4db9-8c24-955ee6fd169f}: rgb_lightning_node: STARTED
2026-03-24T17:09:04.431721Z ERROR request{uri=/openchannel request_id=29888a11-69fd-4db9-8c24-955ee6fd169f}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:09:04.431779Z  INFO request{uri=/openchannel request_id=29888a11-69fd-4db9-8c24-955ee6fd169f status_code=403 Forbidden}: rgb_lightning_node: ENDED in 291.402µs
2026-03-24T17:09:05.444067Z  INFO request{uri=/openchannel request_id=ca01608e-95e7-422b-bd2c-74519403a0e4}: rgb_lightning_node: STARTED
2026-03-24T17:09:05.444244Z ERROR request{uri=/openchannel request_id=ca01608e-95e7-422b-bd2c-74519403a0e4}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:09:05.444303Z  INFO request{uri=/openchannel request_id=ca01608e-95e7-422b-bd2c-74519403a0e4 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 297.655µs
2026-03-24T17:09:06.456835Z  INFO request{uri=/openchannel request_id=b3911488-8ae7-47a4-9478-1c1cab817e52}: rgb_lightning_node: STARTED
2026-03-24T17:09:06.457023Z ERROR request{uri=/openchannel request_id=b3911488-8ae7-47a4-9478-1c1cab817e52}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:09:06.457086Z  INFO request{uri=/openchannel request_id=b3911488-8ae7-47a4-9478-1c1cab817e52 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 312.633µs
2026-03-24T17:09:07.469438Z  INFO request{uri=/openchannel request_id=b8b6d556-04d6-478e-a47b-06cec90b456b}: rgb_lightning_node: STARTED
2026-03-24T17:09:07.469615Z ERROR request{uri=/openchannel request_id=b8b6d556-04d6-478e-a47b-06cec90b456b}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:09:07.469691Z  INFO request{uri=/openchannel request_id=b8b6d556-04d6-478e-a47b-06cec90b456b status_code=403 Forbidden}: rgb_lightning_node: ENDED in 312.731µs
2026-03-24T17:09:08.482434Z  INFO request{uri=/openchannel request_id=7b82970c-714b-4b18-97fb-27f32941bc4c}: rgb_lightning_node: STARTED
2026-03-24T17:09:08.482612Z ERROR request{uri=/openchannel request_id=7b82970c-714b-4b18-97fb-27f32941bc4c}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:09:08.482675Z  INFO request{uri=/openchannel request_id=7b82970c-714b-4b18-97fb-27f32941bc4c status_code=403 Forbidden}: rgb_lightning_node: ENDED in 300.352µs
2026-03-24T17:09:09.495396Z  INFO request{uri=/openchannel request_id=780b2701-42a1-4566-9818-e29f6169690e}: rgb_lightning_node: STARTED
2026-03-24T17:09:09.495581Z ERROR request{uri=/openchannel request_id=780b2701-42a1-4566-9818-e29f6169690e}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:09:09.495642Z  INFO request{uri=/openchannel request_id=780b2701-42a1-4566-9818-e29f6169690e status_code=403 Forbidden}: rgb_lightning_node: ENDED in 307.265µs
2026-03-24T17:09:10.507587Z  INFO request{uri=/openchannel request_id=2bfabbe8-61dd-4121-aaca-e4f2cddbcb0e}: rgb_lightning_node: STARTED
2026-03-24T17:09:10.507775Z ERROR request{uri=/openchannel request_id=2bfabbe8-61dd-4121-aaca-e4f2cddbcb0e}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:09:10.507835Z  INFO request{uri=/openchannel request_id=2bfabbe8-61dd-4121-aaca-e4f2cddbcb0e status_code=403 Forbidden}: rgb_lightning_node: ENDED in 306.582µs
2026-03-24T17:09:11.520554Z  INFO request{uri=/openchannel request_id=68fd0a99-6529-4e7a-9b72-8b6c02abb526}: rgb_lightning_node: STARTED
2026-03-24T17:09:11.520734Z ERROR request{uri=/openchannel request_id=68fd0a99-6529-4e7a-9b72-8b6c02abb526}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:09:11.520795Z  INFO request{uri=/openchannel request_id=68fd0a99-6529-4e7a-9b72-8b6c02abb526 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 300.539µs
2026-03-24T17:09:12.532951Z  INFO request{uri=/openchannel request_id=292f10cb-80f0-435e-b092-24c31b069d53}: rgb_lightning_node: STARTED
2026-03-24T17:09:12.533132Z ERROR request{uri=/openchannel request_id=292f10cb-80f0-435e-b092-24c31b069d53}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:09:12.533194Z  INFO request{uri=/openchannel request_id=292f10cb-80f0-435e-b092-24c31b069d53 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 300.875µs
2026-03-24T17:09:13.545608Z  INFO request{uri=/openchannel request_id=284aed84-aa0f-4383-a8ef-4cc9a781bed7}: rgb_lightning_node: STARTED
2026-03-24T17:09:13.545786Z ERROR request{uri=/openchannel request_id=284aed84-aa0f-4383-a8ef-4cc9a781bed7}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:09:13.545844Z  INFO request{uri=/openchannel request_id=284aed84-aa0f-4383-a8ef-4cc9a781bed7 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 295.948µs
2026-03-24T17:09:14.558158Z  INFO request{uri=/openchannel request_id=8585ac7b-88f9-418b-a7b3-f75d648c9b73}: rgb_lightning_node: STARTED
2026-03-24T17:09:14.558336Z ERROR request{uri=/openchannel request_id=8585ac7b-88f9-418b-a7b3-f75d648c9b73}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:09:14.558396Z  INFO request{uri=/openchannel request_id=8585ac7b-88f9-418b-a7b3-f75d648c9b73 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 295.867µs
2026-03-24T17:09:15.570549Z  INFO request{uri=/openchannel request_id=7c6edb1f-27be-4833-9f88-0a1c78faf652}: rgb_lightning_node: STARTED
2026-03-24T17:09:15.570729Z ERROR request{uri=/openchannel request_id=7c6edb1f-27be-4833-9f88-0a1c78faf652}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:09:15.570789Z  INFO request{uri=/openchannel request_id=7c6edb1f-27be-4833-9f88-0a1c78faf652 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 299.412µs
2026-03-24T17:09:16.583288Z  INFO request{uri=/openchannel request_id=eeb6496b-ffa7-45b0-b51a-439b18ea113d}: rgb_lightning_node: STARTED
2026-03-24T17:09:16.583478Z ERROR request{uri=/openchannel request_id=eeb6496b-ffa7-45b0-b51a-439b18ea113d}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:09:16.583539Z  INFO request{uri=/openchannel request_id=eeb6496b-ffa7-45b0-b51a-439b18ea113d status_code=403 Forbidden}: rgb_lightning_node: ENDED in 310.588µs
2026-03-24T17:09:17.595403Z  INFO request{uri=/openchannel request_id=7ac8e362-537d-4a65-b16c-a7e7bfbdf7ab}: rgb_lightning_node: STARTED
2026-03-24T17:09:17.595586Z ERROR request{uri=/openchannel request_id=7ac8e362-537d-4a65-b16c-a7e7bfbdf7ab}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:09:17.595646Z  INFO request{uri=/openchannel request_id=7ac8e362-537d-4a65-b16c-a7e7bfbdf7ab status_code=403 Forbidden}: rgb_lightning_node: ENDED in 302.061µs
2026-03-24T17:09:18.607729Z  INFO request{uri=/openchannel request_id=c8756789-861c-4c63-8b37-1996d895ebd5}: rgb_lightning_node: STARTED
2026-03-24T17:09:18.607927Z ERROR request{uri=/openchannel request_id=c8756789-861c-4c63-8b37-1996d895ebd5}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:09:18.607996Z  INFO request{uri=/openchannel request_id=c8756789-861c-4c63-8b37-1996d895ebd5 status_code=403 Forbidden}: rgb_lightning_node: ENDED in 328.408µs
2026-03-24T17:09:19.620482Z  INFO request{uri=/openchannel request_id=53eae54f-6545-4cbb-a157-6ba827757cec}: rgb_lightning_node: STARTED
2026-03-24T17:09:19.620661Z ERROR request{uri=/openchannel request_id=53eae54f-6545-4cbb-a157-6ba827757cec}: rgb_lightning_node::error: APIError: Cannot perform this operation while an open channel operation is in progress
2026-03-24T17:09:19.620721Z  INFO request{uri=/openchannel request_id=53eae54f-6545-4cbb-a157-6ba827757cec status_code=403 Forbidden}: rgb_lightning_node: ENDED in 298.529µs

thread 'test::openchannel_close_before_funding::openchannel_peer_offline_releases_lock' (2204697) panicked at src/test/openchannel_close_before_funding.rs:100:13:
rgb_send_lock remained stuck for 60s after peer shutdown - node cannot open new channels

@bitwalt bitwalt force-pushed the rln-channelpending-panic branch 2 times, most recently from a49204f to 45b4ae7 Compare March 24, 2026 19:44
@bitwalt
Copy link
Copy Markdown
Contributor Author

bitwalt commented Mar 25, 2026

The test is now passing, let me know if we can auto-release the lock if has been locked for more than 30 secs, or we should use another approach

@zoedberg
Copy link
Copy Markdown
Member

No, auto-releasing the lock is not safe. We need to find where it needs to be set to false. Is the analysis reported in #111 correct? Is a panic actually happening during the Event::ChannelPending?

@bitwalt
Copy link
Copy Markdown
Contributor Author

bitwalt commented Mar 25, 2026

Yes #111 analysis is correct

@zoedberg
Copy link
Copy Markdown
Member

I tried the test without the "fix" and I don't see any panic. What panic do you see?

@bitwalt bitwalt force-pushed the rln-channelpending-panic branch 2 times, most recently from 1725cb9 to 0fd5b66 Compare March 25, 2026 22:13
@bitwalt
Copy link
Copy Markdown
Contributor Author

bitwalt commented Mar 25, 2026

Reworked the PR based on your feedback:

Removed the 30s auto-release timeout

Regarding the panic question — the lock gets stuck even without a panic. The issue is that FundingGenerationReady only releases the lock on error (not on success), and ChannelClosed never releases it at all when channel_funding_txo is None. So if the channel stalls between FundingGenerationReady and ChannelPending (e.g. funding TX not mined, peer goes offline), the lock is held indefinitely.

@zoedberg
Copy link
Copy Markdown
Member

I tried the test without the fix but it passes, we need a bug to be proven before thinking about the fix

About

Regarding the panic question — the lock gets stuck even without a panic. The issue is that FundingGenerationReady only releases the lock on error (not on success), and ChannelClosed never releases it at all when channel_funding_txo is None. So if the channel stalls between FundingGenerationReady and ChannelPending (e.g. funding TX not mined, peer goes offline), the lock is held indefinitely.

the reasoning here has some issues. The lock should be released after calling the send end method. Before that it can be released only if errors arise.

Open a vanilla channel from node1 to node2, shut down node2 before
the funding TX is mined (ChannelPending never fires), then verify that
node1 cannot open a new channel to node3 because rgb_send_lock is
never released.

The ChannelClosed event handler does not reset rgb_send_lock, leaving
the node permanently unable to open new channels.

Ref: RGB-Tools#111
@bitwalt bitwalt force-pushed the rln-channelpending-panic branch from 0fd5b66 to 731bceb Compare March 26, 2026 18:12
@bitwalt
Copy link
Copy Markdown
Contributor Author

bitwalt commented Mar 27, 2026

on my env the test is failing but i saw on the pipeline is not. i will close this PR and reopening it, if I'll find a way to replicate the issue

@bitwalt bitwalt closed this Mar 27, 2026
@zoedberg
Copy link
Copy Markdown
Member

@bitwalt I found a way to reproduce the bug in a deterministic way in 57619a1

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment

Labels

None yet

Projects

None yet

Development

Successfully merging this pull request may close these issues.

rgb_send_lock gets stuck on channel open failure paths

2 participants