No matter what I do, every transaction initially returns “Webhook verification failed” and the transaction is listed as “Pending” in GravityForms. Hours later, it appears they clear. See short video and logs below.
Any help is greatly appreciated.
Here is a simple video demonstrating the problem (and showing the log results). Also, logs below.
Be Advised: I made this donation via PayPay Sandbox at 1:40 AM. The transaction came back as “Pending” with the log error: "Webhook verification failed. PayPal Debug ID: " and some ID numbers.
2023-03-12 1:46:00.420782 - DEBUG --> GFPaymentAddOn::validation(): Authorization result for form #63 submission => Array
(
[is_authorized] => 1
)
2023-03-12 1:46:00.429785 - DEBUG --> GFFeedAddOn::maybe_process_feed(): Checking for feeds to process for entry #144 for gravityformsppcp.
2023-03-12 1:46:00.429897 - DEBUG --> GFFeedAddOn::maybe_process_feed(): Starting to process feed (#102 - PayPal Donation (One Time)) for entry #144 for gravityformsppcp
2023-03-12 1:46:00.429944 - DEBUG --> GFFeedAddOn::maybe_process_feed(): Marking entry #144 as fulfilled for gravityformsppcp
2023-03-12 1:46:02.712826 - DEBUG --> GF_PPCP::process_capture(): Updating entry #144 with result => Array
(
[is_success] => 1
[transaction_id] => 3DK230732K2249451
[amount] => 25.00
[payment_method] => PayPal
)
2023-03-12 1:46:02.716943 - DEBUG --> GFPaymentAddOn::add_pending_payment(): Processing request.
2023-03-12 1:46:45.519691 - DEBUG --> GFPaymentAddOn::maybe_process_callback(): Initializing callback processing for: gravityformsppcp
2023-03-12 1:46:45.746464 - ERROR --> GF_PPCP::get_webhook_event(): Webhook verification status is FAILURE
2023-03-12 1:46:45.746643 - DEBUG --> GFPaymentAddOn::maybe_process_callback(): Result from gateway callback => WP_Error Object
(
[errors] => Array
(
[failed_verification] => Array
(
[0] => Webhook verification failed. PayPal Debug ID: 39b6719075511
)
)
[error_data] => Array
(
)
[additional_data:protected] => Array
(
)
)
However, checked this morning, and apparently, at 4:00 AM the transaction went through, and the logs show the following:
2023-03-12 3:39:37.266360 - DEBUG --> GFPaymentAddOn::process_callback_action(): Processing callback action.
2023-03-12 3:39:37.267584 - DEBUG --> GFPaymentAddOn::complete_payment(): Processing request.
2023-03-12 3:39:38.162767 - DEBUG --> GFPaymentAddOn::maybe_process_callback(): Result of callback action => 1
2023-03-12 3:59:46.914475 - DEBUG --> GFPaymentAddOn::maybe_process_callback(): Initializing callback processing for: gravityformsppcp
2023-03-12 3:59:47.205542 - DEBUG --> GF_PPCP::log_webhook_event_details() Webhook log => Array
(
[id] => WH-52F12286Y1960620H-76Y69290NF9289734
[type] => PAYMENT.CAPTURE.COMPLETED
[event_version] => 1.0
[resource_version] => 2.0
)
2023-03-12 3:59:47.208765 - DEBUG --> GFPaymentAddOn::maybe_process_callback(): Result from gateway callback => Array
(
[id] => WH-52F12286Y1960620H-76Y69290NF9289734
[entry_id] => 144
[transaction_id] => 3DK230732K2249451
[type] => complete_payment
[amount] => 25.00
)
2023-03-12 3:59:47.208863 - DEBUG --> GFPaymentAddOn::process_callback_action(): Processing callback action.
2023-03-12 3:59:47.210572 - DEBUG --> GFPaymentAddOn::complete_payment(): Processing request.
2023-03-12 3:59:48.029735 - DEBUG --> GFPaymentAddOn::maybe_process_callback(): Result of callback action => 1