Zen Follower
- Join Date:
- Oct 2009
- Posts:
- 444
- Plugin Contributions:
- 0
v1.5 Duplicate order processing at certain times of the day
Hi,
Firstly, I apologize if there has been a previous thread about this, but I did not come across it in any searches that I did prior to posting.
I am running v1.5 and Paypal Website Payment Standard (not Express due to the problems associated with downloadable products and shipping addresses). I have made no changes to the cart in the past 4 months.
Starting about the last week of August, only during the times between about 12:30 am and 4:30am MST I am receiving duplicate orders for the orders placed in this timeframe; the remainder of the day everything works perfectly. The customer is only charged once, but it creates a duplicate order....the time stamp when reviewing the orders is the exact same time, the Trans ID, the ipn_id and the txn_id are all the exact same. In looking at the Paypal debug log for one of these orders (there are debug logs for each order including the duplicate) all of the info is the exact same. Here is the log (with email addresses taken out).....I am obviously missing something. This log is the log for the first order...
Sep 18 2013 3:41 -- IPN PROCESSING INITIATED.
*** Originating IP: 173.0.81.1 notify.paypal.com
*** Browser/User Agent: PayPal IPN ( https://www.paypal.com/ipn )Sep 18 2013 3:41 -- Breakpoint: 0 - Initializing debugging.
Sep 18 2013 3:41 -- Breakpoint: Flag Status:
isECtransaction = 0
isDPtransaction = 0Sep 18 2013 3:41 -- IPN INFO - POST VARS received (sorted):
Array
(
[business] =>
[charset] => windows-1252
[custom] => zenid=a86908cfcf3c7df4bdba03fe21ef42a7
[first_name] => Mrs F M
[handling_amount] => 0.00
[ipn_track_id] => 6f586e15eabcc
[item_name] => All the items in your shopping basket (see details in the store and on your store receipt).
[item_number] => Nitwit Collections� Purchase
[last_name] => Removed for posting at forum
[mc_currency] => USD
[mc_fee] => 1.90
[mc_gross] => 50.00
[notify_version] => 3.7
[payer_email] =>
[payer_id] => M7CFNXFKU6M24
[payer_status] => verified
[payment_date] => 01:41:11 Sep 18, 2013 PDT
[payment_fee] => 1.90
[payment_gross] => 50.00
[payment_status] => Completed
[payment_type] => instant
[protection_eligibility] => Ineligible
[quantity] => 1
[receiver_email] =>
[receiver_id] => ZKDJBFMRVEASQ
[residence_country] => GB
[shipping] => 0.00
[tax] => 0.00
[transaction_subject] => zenid=a86908cfcf3c7df4bdba03fe21ef42a7
[txn_id] => 1N273370PT639793G
[txn_type] => web_accept
[verify_sign] => AZRbwb-oLtBYiD2XTCBTSMRCqN0iAifjD5knVty0u.PG-1fdL5KfYFvJ
)Sep 18 2013 3:41 -- IPN INFO - POST VARS to be sent back (unsorted) for validation (using CURL):
To: www.paypal.com:80
Array
(
[cmd] => _notify-validate
[transaction_subject] => zenid=a86908cfcf3c7df4bdba03fe21ef42a7
[payment_date] => 01:41:11 Sep 18, 2013 PDT
[txn_type] => web_accept
[last_name] =>
[residence_country] => GB
[item_name] => All the items in your shopping basket (see details in the store and on your store receipt).
[payment_gross] => 50.00
[mc_currency] => USD
[business] => removed for posting in forum
[payment_type] => instant
[protection_eligibility] => Ineligible
[verify_sign] => AZRbwb-oLtBYiD2XTCBTSMRCqN0iAifjD5knVty0u.PG-1fdL5KfYFvJ
[payer_status] => verified
[tax] => 0.00
[payer_email] => removed for posting in forum
[txn_id] => 1N273370PT639793G
[quantity] => 1
[receiver_email] => removed for posting in forum
[first_name] => Mrs F M
[payer_id] => M7CFNXFKU6M24
[receiver_id] => ZKDJBFMRVEASQ
[item_number] => Nitwit Collections� Purchase
[handling_amount] => 0.00
[payment_status] => Completed
[payment_fee] => 1.90
[mc_fee] => 1.90
[shipping] => 0.00
[mc_gross] => 50.00
[custom] => zenid=a86908cfcf3c7df4bdba03fe21ef42a7
[charset] => windows-1252
[notify_version] => 3.7
[ipn_track_id] => 6f586e15eabcc
)Sep 18 2013 3:41 -- CURL OPTS: Array
(
[10002] => https://www.paypal.com/cgi-bin/webscr
[47] => 1
[10015] => cmd=_notify-validate&transaction_subject=zenid%3Da86908cfcf3c7df4bdba03fe21ef42a7&payment_date=01%3A41%3A11+Sep+18%2C+2013+PDT&txn_type=web_accept&last_name=&residence_country=GB&item_name=All+the+items+in+your+shopping+basket+%28see+details+in+the+store+and+on+your+store+receipt%29.&payment_gross=50.00&mc_currency=USD&business=&payment_type=instant&protection_eligibility=Ineligible&verify_sign=AZRbwb-oLtBYiD2XTCBTSMRCqN0iAifjD5knVty0u.PG-1fdL5KfYFvJ&payer_status=verified&tax=0.00&payer_email=&txn_id=1N273370PT639793G&quantity=1&receiver_email=&first_name=Mrs+F+M&payer_id=M7CFNXFKU6M24&receiver_id=ZKDJBFMRVEASQ&item_number=Nitwit+Collections%EF%BF%BD+Purchase&handling_amount=0.00&payment_status=Completed&payment_fee=1.90&mc_fee=1.90&shipping=0.00&mc_gross=50.00&custom=zenid%3Da86908cfcf3c7df4bdba03fe21ef42a7&charset=windows-1252¬ify_version=3.7&ipn_track_id=6f586e15eabcc
[13] => 45
[78] => 30
[41] => 0
[42] => 0
[52] => 0
[19913] => 1
[64] => 0
[81] => 2
[75] => 1
[74] => 1
[84] => 2
[10018] => Zen Cart(R) - IPN Postback
)Sep 18 2013 3:41 -- CURL response: VERIFIED
Sep 18 2013 3:41 -- IPN INFO (cl) - Confirmation/Validation response VERIFIED
Sep 18 2013 3:41 -- Breakpoint: 1 - Collected data from PayPal notification
Sep 18 2013 3:41 -- IPN INFO :: Transaction email details.
From IPN = Removed for forum posting
From CONFIG = Removed for forum postingSep 18 2013 3:41 -- Breakpoint: 2 - Validated transaction components
Sep 18 2013 3:41 -- Breakpoint: 3 - Communication method verified
Sep 18 2013 3:43 -- IPN NOTICE :: Could not find matched txn_id record in DB. Therefore is new to us.
Sep 18 2013 3:43 -- Breakpoint: 4 - Details: txn_type=unique ordersID = 0 IPN_id=0
Relevant data from POST:
txn_type = unique
parent_txn_id = None
txn_id = 1N273370PT639793GSep 18 2013 3:43 -- Breakpoint: 5 - Transaction type (txn_type) = unique [parentLookup=unique]
Sep 18 2013 3:43 -- IPN INFO :: Currency/Amount Details:
PayPal email address = Removed for forum posting
| mc_currency = USD
| submitted_currency = USD
| order_currency = USD
| mc_gross = 50.00
| converted_amount = 50.00
| order_amount = 50Sep 18 2013 3:43 -- Breakpoint: 5a - built order -- OID: 61766
Sep 18 2013 3:43 -- Breakpoint: 5b - PP table OID: Array
(
[order_id] => 61766
[txn_type] => unique
[module_name] => paypal (ipn-handler)
[module_mode] => IPN
[reason_code] =>
[payment_type] => instant
[payment_status] => Completed
[pending_reason] =>
[invoice] =>
[mc_currency] => USD
[first_name] => Mrs F M
[last_name] =>
[payer_business_name] =>
[address_name] =>
[address_street] =>
[address_city] =>
[address_state] =>
[address_zip] =>
[address_country] =>
[address_status] =>
[payer_email] => removed for forum posting
[payer_id] => M7CFNXFKU6M24
[payer_status] => verified
[payment_date] => 2013-09-18 01:41:11
[business] => Removed for forum posting
[receiver_email] => removed for forum posting
[receiver_id] => ZKDJBFMRVEASQ
[txn_id] => 1N273370PT639793G
[parent_txn_id] =>
[num_cart_items] => 1
[mc_gross] => 50.00
[mc_fee] => 1.90
[settle_amount] => 0
[settle_currency] =>
[exchange_rate] => 1
[notify_version] => 3.7
[verify_sign] => AZRbwb-oLtBYiD2XTCBTSMRCqN0iAifjD5knVty0u.PG-1fdL5KfYFvJ
[date_added] => now()
[memo] => {Record generated by IPN} [ProtectionEligibility:Ineligible]
)Sep 18 2013 3:43 -- Breakpoint: 5c - PP table OID saved
Sep 18 2013 3:43 -- Breakpoint: 5d - PP hist ID: 59279
Sep 18 2013 3:43 -- Breakpoint: 5e - PP hist_data:Array
(
[paypal_ipn_id] => 59279
[txn_id] => 1N273370PT639793G
[parent_txn_id] =>
[payment_status] => Completed
[pending_reason] =>
[date_added] => now()
)Sep 18 2013 3:43 -- Breakpoint: 5f - PP hist saved
Sep 18 2013 3:43 -- Breakpoint: 5g - new status code: 2
Sep 18 2013 3:43 -- Breakpoint: 5j - order stat hist update:Array
(
[orders_id] => 61766
[orders_status_id] => 2
[date_added] => now()
[comments] => PayPal status: Completed @ 01:41:11 Sep 18, 2013 PDT
Trans ID:1N273370PT639793G
Amount: 50.00 USD
[customer_notified] => 0
)Sep 18 2013 3:43 -- Breakpoint: 5k - OSH update done
Sep 18 2013 3:43 -- Breakpoint: 5L - adding products
Sep 18 2013 3:43 -- Breakpoint: 5m - emailing customer
Sep 18 2013 3:43 -- Breakpoint: 5n - emptying cart
Sep 18 2013 3:43 -- Breakpoint: 6 - Completed IPN order add. ordersID = 61766 IPN tracking record = 59279
I am not running any backups or other cron jobs during this time, and according to my host neither are they. I am thinking that it must have something to do with Paypal or with my host but wanted to rule out something in my ZenCart as well.
Thanks in advance for your help,
Jeff