View Issue Details

Jump to NotesJump to History
IDProjectCategoryView StatusDate SubmittedLast Update
0010242Talermerchant backendpublic2025-08-07 16:032025-08-07 16:05
Reportersebasjm Assigned To 
PrioritynormalSeveritymajorReproducibilityalways
Status newResolutionopen 
Product Version1.0 stretch goals 
Target Version1.0 stretch goals 
Summary0010242: adding wire transfer remains unverified
DescriptionI made some orders which are now paid.
The wire transfer to the merchant bank account arrives.
After adding the wire transfer into the merchant backoffice I expect the be verifed after some minutes, it doesn't.
Logs doesn't show any error, running the reconciliation manually don't have any effect

# taler-merchant-reconciliation -c /etc/taler-merchant/taler-merchant.conf -L INFO -t
su: warning: cannot change directory to /var/lib/taler: No such file or directory
2025-08-07T13:54:28.686146+0000 taler-merchant-reconciliation-10207 INFO Change in PQ event FD to -1
2025-08-07T13:54:28.686197+0000 taler-merchant-reconciliation-10207 INFO New poll FD is -1
2025-08-07T13:54:28.691865+0000 taler-merchant-reconciliation-10207 INFO Loading SQL resources from `merchant-'
2025-08-07T13:54:28.693503+0000 taler-merchant-reconciliation-10207 INFO SQL resource `/usr/share/taler-merchant/sql/merchant-0022.sql' does not exist
2025-08-07T13:54:28.693582+0000 taler-merchant-reconciliation-10207 INFO Change in PQ event FD to 7
2025-08-07T13:54:28.693595+0000 taler-merchant-reconciliation-10207 INFO New poll FD is 7
2025-08-07T13:54:28.693639+0000 taler-merchant-reconciliation-10207 INFO Starting event scheduler
2025-08-07T13:54:28.693655+0000 taler-merchant-reconciliation-10207 INFO New poll FD is 7
2025-08-07T13:54:28.693667+0000 taler-merchant-reconciliation-10207 INFO Activating poll job on 7
2025-08-07T13:54:28.693686+0000 taler-merchant-reconciliation-10207 INFO Executing PQ command `LISTEN XR6849FMRD2AJFY1E2YY0GWA8GN0YT407Z66WHJB0SAKJWF8G2Q60'
2025-08-07T13:54:28.693775+0000 taler-merchant-reconciliation-10207 INFO Executing PQ command `LISTEN XW9K15VBEKGDMCMN31SKH75KVXND1GTW5MW7WME4CMPQ0X9ECWTR0'
2025-08-07T13:54:28.695463+0000 taler-merchant-reconciliation-10207 INFO No more open inquiries and in test mode. Existing.
2025-08-07T13:54:28.695495+0000 taler-merchant-reconciliation-10207 INFO Running shutdown
2025-08-07T13:54:28.695516+0000 taler-merchant-reconciliation-10207 INFO Executing PQ command `UNLISTEN XR6849FMRD2AJFY1E2YY0GWA8GN0YT407Z66WHJB0SAKJWF8G2Q60'
2025-08-07T13:54:28.695579+0000 taler-merchant-reconciliation-10207 INFO Executing PQ command `UNLISTEN XW9K15VBEKGDMCMN31SKH75KVXND1GTW5MW7WME4CMPQ0X9ECWTR0'
2025-08-07T13:54:28.695656+0000 taler-merchant-reconciliation-10207 INFO Stopping PQ event scheduler job



Logs from reconciliation service


Aug 07 13:35:11 1c1f9294084f taler-merchant-reconciliation[9631]: INFO Got response code 200 from exchange for GET /transfers/$WTID
Aug 07 13:35:11 1c1f9294084f taler-merchant-reconciliation[9631]: INFO Starting merchant DB transaction `insert transfer details'
Aug 07 13:35:11 1c1f9294084f taler-merchant-reconciliation[9631]: INFO Transfer details inserted:
Aug 07 13:35:11 1c1f9294084f taler-merchant-reconciliation[9631]: INFO Committing merchant DB transaction insert transfer details
Aug 07 13:35:11 1c1f9294084f taler-merchant-reconciliation[9631]: INFO Coin original deposit value is WHY:10
Aug 07 13:35:11 1c1f9294084f taler-merchant-reconciliation[9631]: INFO Checking coin with value WHY:10
Aug 07 13:35:11 1c1f9294084f taler-merchant-reconciliation[9631]: INFO HTTP request for `http://exchange.taler.localhost/transfers/TRCESAQXFS87CBTMH8W73QD9SDGMBGCEVRQDS8DGJFXEPCR3MJTG' finished with 200 after 7 ms
Aug 07 13:38:06 1c1f9294084f taler-merchant-reconciliation[9631]: INFO PG poll job active
Aug 07 13:38:06 1c1f9294084f taler-merchant-reconciliation[9631]: INFO Received notification xr6849fmrd2ajfy1e2yy0gwa8gn0yt407z66whjb0sakjwf8g2q60 with extra data `'
Aug 07 13:38:06 1c1f9294084f taler-merchant-reconciliation[9631]: INFO Received notification xr6849fmrd2ajfy1e2yy0gwa8gn0yt407z66whjb0sakjwf8g2q60 with extra data `'
Aug 07 13:38:06 1c1f9294084f taler-merchant-reconciliation[9631]: INFO PG poll job finishes after 2 events
Aug 07 13:38:06 1c1f9294084f taler-merchant-reconciliation[9631]: INFO Resubscribing
Aug 07 13:38:06 1c1f9294084f taler-merchant-reconciliation[9631]: INFO Got response code 200 from exchange for GET /transfers/$WTID
Aug 07 13:38:06 1c1f9294084f taler-merchant-reconciliation[9631]: INFO Starting merchant DB transaction `insert transfer details'
Aug 07 13:38:06 1c1f9294084f taler-merchant-reconciliation[9631]: INFO Transfer details inserted:
Aug 07 13:38:06 1c1f9294084f taler-merchant-reconciliation[9631]: INFO Committing merchant DB transaction insert transfer details
Aug 07 13:38:06 1c1f9294084f taler-merchant-reconciliation[9631]: INFO Coin original deposit value is WHY:1
Aug 07 13:38:06 1c1f9294084f taler-merchant-reconciliation[9631]: INFO Checking coin with value WHY:1
Aug 07 13:38:06 1c1f9294084f taler-merchant-reconciliation[9631]: INFO HTTP request for `http://exchange.taler.localhost/transfers/9P60XJYBWSR3MPE31X7DT4JS2CMDZVTNGVMZDCXNSSD3305R4FE0' finished with 200 after 11 ms


Here are the 2 wire transfers that i'm expecting to be verified, (the one with WHY:2 is a testing)

$ curl 'http://backend.taler.localhost/private/transfers?payto_uri=payto%3A%2F%2Fx-taler-bank%2Fbank.taler.localhost%2Fmerch%3Freceiver-name%3Dmerch&limit=-6' \
  -H 'Accept: application/json' \
  -H 'Accept-Language: en-US,en;q=0.9' \
  -H 'Authorization: Bearer secret-token:CD6Z7FJKHDSBJ0N5TR41JRC8QW38C492K39VR5E92RSZVG5HQ3FG' \
  -H 'Cache-Control: no-cache' \
  -H 'Connection: keep-alive' \
  -H 'Pragma: no-cache' \
  -H 'Referer: http://backend.taler.localhost/webui/' \
  -H 'Sec-Fetch-Dest: empty' \
  -H 'Sec-Fetch-Mode: cors' \
  -H 'Sec-Fetch-Site: same-origin' \
  -H 'User-Agent: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36' \
  -H 'sec-ch-ua: "Not)A;Brand";v="8", "Chromium";v="138"' \
  -H 'sec-ch-ua-mobile: ?0' \
  -H 'sec-ch-ua-platform: "Linux"'
{
  "transfers": [
    {
      "credit_amount": "WHY:2",
      "wtid": "9P60XJYBWSR3MPE31X7DT4JS2CMDZVTNGVMZDCXNSSD3305R4FE0",
      "payto_uri": "payto://x-taler-bank/bank.taler.localhost/merch?receiver-name=merch",
      "exchange_url": "http://exchange.taler.localhost/",
      "transfer_serial_id": 3,
      "verified": false,
      "confirmed": true,
      "expected": false,
      "execution_time": {
        "t_s": 1754574800
      }
    },
    {
      "credit_amount": "WHY:1",
      "wtid": "9P60XJYBWSR3MPE31X7DT4JS2CMDZVTNGVMZDCXNSSD3305R4FE0",
      "payto_uri": "payto://x-taler-bank/bank.taler.localhost/merch?receiver-name=merch",
      "exchange_url": "http://exchange.taler.localhost/",
      "transfer_serial_id": 2,
      "verified": false,
      "confirmed": true,
      "expected": true,
      "execution_time": {
        "t_s": 1754574788
      }
    },
    {
      "credit_amount": "WHY:10",
      "wtid": "TRCESAQXFS87CBTMH8W73QD9SDGMBGCEVRQDS8DGJFXEPCR3MJTG",
      "payto_uri": "payto://x-taler-bank/bank.taler.localhost/merch?receiver-name=merch",
      "exchange_url": "http://exchange.taler.localhost/",
      "transfer_serial_id": 1,
      "verified": false,
      "confirmed": true,
      "expected": true,
      "execution_time": {
        "t_s": 1754574279
      }
    }
  ]
}
TagsNo tags attached.

Activities

sebasjm

2025-08-07 16:05

developer   ~0025635

after addning a new wire transfer with ID "9P60XJYBWSR3MPE31X7DT4JS2CMDZVTNGVMZDCXNSSD3305EEEEE" it is added successfully but is shown with a different id in the list

      "wtid": "9P60XJYBWSR3MPE31X7DT4JS2CMDZVTNGVMZDCXNSSD3305EEEE0",

( a zero in the last character )

Issue History

Date Modified Username Field Change
2025-08-07 16:03 sebasjm New Issue
2025-08-07 16:05 sebasjm Note Added: 0025635