Aw: Problem with payment Sofortüberweisung
Ich habe alles so eingetragen wie oben beschrieben. Leider funktioniert es immer noch nicht. Ich habe ein paar zusätzliche Log-Ausgaben eingebaut und etwas verwunderliches gefunden.
Hier ein (erweitertes) Log aus der Datei "jshopping.php", welches ausgibt, was genau gerade aufgerufen wird:
2015-04-13 13:52:20 #JAS - Controller: checkout
2015-04-13 13:52:20 #JAS - Task: step4
2015-04-13 13:52:20 #JAS - Act:
2015-04-13 13:52:20 #JAS - Self: /index.php/shop/checkout/step4
2015-04-13 13:52:20 #JAS - Method: GET
2015-04-13 13:52:21 #JAS - ------------------------
2015-04-13 13:52:21 #JAS - Controller: checkout
2015-04-13 13:52:21 #JAS - Task: step4save
2015-04-13 13:52:21 #JAS - Act:
2015-04-13 13:52:21 #JAS - Self: /index.php/shop/checkout/step4save
2015-04-13 13:52:21 #JAS - Method: POST
2015-04-13 13:52:21 #JAS - ------------------------
2015-04-13 13:52:21 #JAS - Controller: checkout
2015-04-13 13:52:21 #JAS - Task: step3
2015-04-13 13:52:21 #JAS - Act:
2015-04-13 13:52:21 #JAS - Self: /index.php/shop/checkout/step3
2015-04-13 13:52:21 #JAS - Method: GET
2015-04-13 13:52:23 #JAS - ------------------------
2015-04-13 13:52:23 #JAS - Controller: checkout
2015-04-13 13:52:23 #JAS - Task: step3save
2015-04-13 13:52:23 #JAS - Act:
2015-04-13 13:52:23 #JAS - Self: /index.php/shop/checkout/step3save
2015-04-13 13:52:23 #JAS - Method: POST
2015-04-13 13:52:23 #JAS - ------------------------
2015-04-13 13:52:23 #JAS - Controller: checkout
2015-04-13 13:52:23 #JAS - Task: step5
2015-04-13 13:52:23 #JAS - Act:
2015-04-13 13:52:23 #JAS - Self: /index.php/shop/checkout/step5
2015-04-13 13:52:23 #JAS - Method: GET
2015-04-13 13:52:26 #JAS - ------------------------
2015-04-13 13:52:26 #JAS - Controller: checkout
2015-04-13 13:52:26 #JAS - Task: step5save
2015-04-13 13:52:26 #JAS - Act:
2015-04-13 13:52:26 #JAS - Self: /index.php/shop/checkout/step5save
2015-04-13 13:52:26 #JAS - Method: POST
2015-04-13 13:52:26 #JAS - ------------------------
2015-04-13 13:52:26 #JAS - Controller: checkout
2015-04-13 13:52:26 #JAS - Task: step6
2015-04-13 13:52:26 #JAS - Act:
2015-04-13 13:52:26 #JAS - Self: /index.php/shop/checkout/step6
2015-04-13 13:52:26 #JAS - Method: GET
2015-04-13 13:52:42 #JAS - ------------------------
2015-04-13 13:52:42 #JAS - Controller: category
2015-04-13 13:52:42 #JAS - Task:
2015-04-13 13:52:42 #JAS - Act:
2015-04-13 13:52:42 #JAS - Self: /index.php
2015-04-13 13:52:42 #JAS - Method: GET
2015-04-13 13:52:43 #JAS - ------------------------
2015-04-13 13:52:43 #JAS - Controller: checkout
2015-04-13 13:52:43 #JAS - Task: step7
2015-04-13 13:52:43 #JAS - Act: return
2015-04-13 13:52:43 #JAS - Self: /index.php
2015-04-13 13:52:43 #JAS - Method: GET
2015-04-13 13:52:43 #JAS - step7
2015-04-13 13:52:43 #JAS - step7 - 2
2015-04-13 13:52:43 #JAS - step7 - act: return
2015-04-13 13:52:43 #JAS - ------------------------
2015-04-13 13:52:43 #JAS - Controller: checkout
2015-04-13 13:52:43 #JAS - Task: finish
2015-04-13 13:52:43 #JAS - Act:
2015-04-13 13:52:43 #JAS - Self: /index.php/shop/checkout/finish
2015-04-13 13:52:43 #JAS - Method: GET
Pasend dazu das Log vom Apache:
[13/Apr/2015:13:52:20 +0200] "GET /index.php/shop/checkout/step4 HTTP/1.1" 200 46122 "https://www.meine-url.de/index.php/shop/checkout/step2?check_login=1" "Mozilla/5.0 (Windows NT 6.3; WOW64; rv:37.0) Gecko/20100101 Firefox/37.0"
[13/Apr/2015:13:52:20 +0200] "GET /plugins/content/jooag_shariff/backend/?url=https%3A%2F%2Fwww.meine-url.de%2Findex.php%2Fshop%2Fcheckout%2Fstep4 HTTP/1.1" 200 41 "https://www.meine-url.de/index.php/shop/checkout/step4" "Mozilla/5.0 (Windows NT 6.3; WOW64; rv:37.0) Gecko/20100101 Firefox/37.0"
[13/Apr/2015:13:52:21 +0200] "POST /index.php/shop/checkout/step4save HTTP/1.1" 303 - "https://www.meine-url.de/index.php/shop/checkout/step4" "Mozilla/5.0 (Windows NT 6.3; WOW64; rv:37.0) Gecko/20100101 Firefox/37.0"
[13/Apr/2015:13:52:21 +0200] "GET /index.php/shop/checkout/step3 HTTP/1.1" 200 48769 "https://www.meine-url.de/index.php/shop/checkout/step4" "Mozilla/5.0 (Windows NT 6.3; WOW64; rv:37.0) Gecko/20100101 Firefox/37.0"
[13/Apr/2015:13:52:22 +0200] "GET /plugins/content/jooag_shariff/backend/?url=https%3A%2F%2Fwww.meine-url.de%2Findex.php%2Fshop%2Fcheckout%2Fstep3 HTTP/1.1" 200 41 "https://www.meine-url.de/index.php/shop/checkout/step3" "Mozilla/5.0 (Windows NT 6.3; WOW64; rv:37.0) Gecko/20100101 Firefox/37.0"
[13/Apr/2015:13:52:23 +0200] "POST /index.php/shop/checkout/step3save HTTP/1.1" 303 - "https://www.meine-url.de/index.php/shop/checkout/step3" "Mozilla/5.0 (Windows NT 6.3; WOW64; rv:37.0) Gecko/20100101 Firefox/37.0"
[13/Apr/2015:13:52:23 +0200] "GET /index.php/shop/checkout/step5 HTTP/1.1" 200 50929 "https://www.meine-url.de/index.php/shop/checkout/step3" "Mozilla/5.0 (Windows NT 6.3; WOW64; rv:37.0) Gecko/20100101 Firefox/37.0"
[13/Apr/2015:13:52:23 +0200] "GET /plugins/content/jooag_shariff/backend/?url=https%3A%2F%2Fwww.meine-url.de%2Findex.php%2Fshop%2Fcheckout%2Fstep5 HTTP/1.1" 200 41 "https://www.meine-url.de/index.php/shop/checkout/step5" "Mozilla/5.0 (Windows NT 6.3; WOW64; rv:37.0) Gecko/20100101 Firefox/37.0"
[13/Apr/2015:13:52:26 +0200] "POST /index.php/shop/checkout/step5save HTTP/1.1" 303 - "https://www.meine-url.de/index.php/shop/checkout/step5" "Mozilla/5.0 (Windows NT 6.3; WOW64; rv:37.0) Gecko/20100101 Firefox/37.0"
[13/Apr/2015:13:52:26 +0200] "GET /index.php/shop/checkout/step6 HTTP/1.1" 200 874 "https://www.meine-url.de/index.php/shop/checkout/step5" "Mozilla/5.0 (Windows NT 6.3; WOW64; rv:37.0) Gecko/20100101 Firefox/37.0"
[13/Apr/2015:13:52:41 +0200] "POST /index.php?option=com_jshopping&controller=checkout&task=step7&act=notify&js_paymentclass=pm_sofortueberweisung&no_lang=1 HTTP/1.1" 303 - "-" "Payment Network AG notification-request"
[13/Apr/2015:13:52:43 +0200] "GET /index.php?option=com_jshopping&controller=checkout&task=step7&act=return&js_paymentclass=pm_sofortueberweisung HTTP/1.1" 303 - "https://www.sofort.com/payment/payment/go/provide_tan" "Mozilla/5.0 (Windows NT 6.3; WOW64; rv:37.0) Gecko/20100101 Firefox/37.0"
[13/Apr/2015:13:52:43 +0200] "GET /index.php/shop/checkout/finish HTTP/1.1" 200 44210 "-" "Mozilla/5.0 (Windows NT 6.3; WOW64; rv:37.0) Gecko/20100101 Firefox/37.0"
[13/Apr/2015:13:52:43 +0200] "GET /plugins/content/jooag_shariff/backend/?url=https%3A%2F%2Fwww.meine-url.de%2Findex.php%2Fshop%2Fcheckout%2Ffinish HTTP/1.1" 200 41 "https://www.meine-url.de/index.php/shop/checkout/finish" "Mozilla/5.0 (Windows NT 6.3; WOW64; rv:37.0) Gecko/20100101 Firefox/37.0"
Interessant ist jeweils der Zeitpunkt "13/Apr/2015:13:52:41". Hier wird von der Sofort AG der POST Request zum step7 act=notify gesendet. Im selbst erstellten payment.log steht aber an der Stelle ganz was anderes (controller=category, ...)?!
Das Problem ist bei mir eben auch, dass die Notify Nachricht nicht verarbeitet wird.
Hier die Ausgabe der HTTP Benachrichtigung der Sofort AG (sieht alles OK aus):
13.04.2015 13:52:42: Response body will be truncated if it is longer than 51200 bytes.
13.04.2015 13:52:42: URL parsed: protocol:
https user: pass: host:www.meine-url.de port: path:/index.php query:option=com_jshopping&controller=checkout&task=step7&act=notify&js_paymentclass=pm_sofortueberweisung&no_lang=1 anchor:
13.04.2015 13:52:42: HashCheck information - .............
13.04.2015 13:52:42: Starting request to https://www.meine-url.de/index.php with method POST
13.04.2015 13:52:42: Valid server remote IP: 195.30.107.89
13.04.2015 13:52:43: Response code of this request: 303
13.04.2015 13:52:43: Redirecting to new location...
13.04.2015 13:52:43: HashCheck information - .............
13.04.2015 13:52:43: Starting request to http://www.meine-url.de/index.php with method GET
13.04.2015 13:52:43: Valid server remote IP: 195.30.107.89
13.04.2015 13:52:43: Response code of this request: 200
13.04.2015 13:52:43: Notification 160679456 successful
Danke für die Mithilfe.
Viele Grüße
Jirka
Joomla: 3.4.1
JoomShopping: 4.9.2
Letzte Änderung: 13.04.2015 14:13