· 7 years ago · Apr 08, 2018, 01:14 PM
12011-11-19 17:01:57 debug New socket accepted <socket._socketobject object at 0x8adced4> from ip 127.0.0.1 (remote port is: 35606)
22011-11-19 17:01:57 debug Processing the request from client #6. Client message is: "?cmd=billacceptor.start&id_account=317952"
32011-11-19 17:01:57 debug RequestController: new request processing
42011-11-19 17:01:57 debug [Cashcode_t1500]: check_status: Status is "[0, 0, 0, 0, 0, 0]"
52011-11-19 17:01:57 debug [Cashcode_t1500]: full_reset
62011-11-19 17:01:57 debug BillAcceptor in use: True
72011-11-19 17:01:57 debug [Cashcode_T1500]: thread has ran
82011-11-19 17:01:57 debug [Cashcode_T1500]: timeout is 120
92011-11-19 17:01:57 debug [Cashcode_t1500->enable_bill_types]: Enable bill types
102011-11-19 17:01:57 debug [Cashcode_t1500]: init_bill_types: Result is "[0]"
112011-11-19 17:01:57 debug [Cashcode_t1500]: init_bill_types: poll
122011-11-19 17:01:57 debug [Cashcode_t1500->wait] start waiting 10
132011-11-19 17:01:58 debug [BillAcceptorController::start]: <r event='bill_accepted' id_trx='0' count='0' value='0' total_amount='0' /> sent to client
142011-11-19 17:01:59 debug Normal response waited
152011-11-19 17:01:59 debug [BillAcceptorController::start]: <r event='bill_accepted' id_trx='0' count='0' value='0' total_amount='0' /> sent to client
162011-11-19 17:01:59 debug [Cashcode_t1500]: check_status: Status is "[0, 0, 252, 0, 0, 0]"
172011-11-19 17:01:59 debug [Cashcode_t1500->wait] start waiting 120
182011-11-19 17:02:00 debug [BillAcceptorController::start]: <r event='bill_accepted' id_trx='0' count='0' value='0' total_amount='0' /> sent to client
192011-11-19 17:02:01 debug [BillAcceptorController::start]: <r event='bill_accepted' id_trx='0' count='0' value='0' total_amount='0' /> sent to client
202011-11-19 17:02:02 debug [BillAcceptorController::start]: <r event='bill_accepted' id_trx='0' count='0' value='0' total_amount='0' /> sent to client
212011-11-19 17:02:03 debug [BillAcceptorController::start]: <r event='bill_accepted' id_trx='0' count='0' value='0' total_amount='0' /> sent to client
222011-11-19 17:02:04 debug [BillAcceptorController::start]: <r event='bill_accepted' id_trx='0' count='0' value='0' total_amount='0' /> sent to client
232011-11-19 17:02:05 debug State is ACCEPTING
242011-11-19 17:02:05 debug State is ACCEPTING
252011-11-19 17:02:05 debug State is ACCEPTING
262011-11-19 17:02:05 debug State is ACCEPTING
272011-11-19 17:02:05 debug State is ACCEPTING
282011-11-19 17:02:05 debug State is ACCEPTING
292011-11-19 17:02:05 debug State is ACCEPTING
302011-11-19 17:02:05 debug State is ACCEPTING
312011-11-19 17:02:05 debug State is ACCEPTING
322011-11-19 17:02:05 debug State is ACCEPTING
332011-11-19 17:02:05 debug State is ACCEPTING
342011-11-19 17:02:05 debug State is ACCEPTING
352011-11-19 17:02:05 debug State is ACCEPTING
362011-11-19 17:02:05 debug State is ACCEPTING
372011-11-19 17:02:05 debug State is ACCEPTING
382011-11-19 17:02:05 debug State is ACCEPTING
392011-11-19 17:02:05 debug State is ACCEPTING
402011-11-19 17:02:05 debug State is ACCEPTING
412011-11-19 17:02:05 debug State is ACCEPTING
422011-11-19 17:02:05 debug State is ACCEPTING
432011-11-19 17:02:05 debug State is ACCEPTING
442011-11-19 17:02:05 debug State is ACCEPTING
452011-11-19 17:02:05 debug State is ACCEPTING
462011-11-19 17:02:05 debug State is ACCEPTING
472011-11-19 17:02:05 debug State is ACCEPTING
482011-11-19 17:02:05 debug State is ACCEPTING
492011-11-19 17:02:05 debug State is ACCEPTING
502011-11-19 17:02:05 debug State is ACCEPTING
512011-11-19 17:02:05 debug State is ACCEPTING
522011-11-19 17:02:05 debug State is ACCEPTING
532011-11-19 17:02:05 debug State is ACCEPTING
542011-11-19 17:02:05 debug State is ACCEPTING
552011-11-19 17:02:05 debug State is ACCEPTING
562011-11-19 17:02:05 debug State is ACCEPTING
572011-11-19 17:02:05 debug State is ACCEPTING
582011-11-19 17:02:05 debug State is ACCEPTING
592011-11-19 17:02:05 debug State is ACCEPTING
602011-11-19 17:02:05 debug State is ACCEPTING
612011-11-19 17:02:05 debug State is ACCEPTING
622011-11-19 17:02:05 debug State is ACCEPTING
632011-11-19 17:02:05 debug State is ACCEPTING
642011-11-19 17:02:05 debug State is ACCEPTING
652011-11-19 17:02:05 debug State is ACCEPTING
662011-11-19 17:02:05 debug State is ACCEPTING
672011-11-19 17:02:05 debug State is ACCEPTING
682011-11-19 17:02:05 debug State is ACCEPTING
692011-11-19 17:02:05 debug State is ACCEPTING
702011-11-19 17:02:05 debug State is ACCEPTING
712011-11-19 17:02:05 debug State is ACCEPTING
722011-11-19 17:02:05 debug State is ACCEPTING
732011-11-19 17:02:05 debug State is ACCEPTING
742011-11-19 17:02:05 debug State is ACCEPTING
752011-11-19 17:02:05 debug State is ACCEPTING
762011-11-19 17:02:05 debug State is ACCEPTING
772011-11-19 17:02:05 debug State is ACCEPTING
782011-11-19 17:02:05 debug State is ACCEPTING
792011-11-19 17:02:05 debug State is ACCEPTING
802011-11-19 17:02:05 debug State is ACCEPTING
812011-11-19 17:02:05 debug State is ACCEPTING
822011-11-19 17:02:05 debug State is ACCEPTING
832011-11-19 17:02:05 debug [BillAcceptorController::start]: <r event='bill_accepted' id_trx='0' count='0' value='0' total_amount='0' /> sent to client
842011-11-19 17:02:05 debug State is ACCEPTING
852011-11-19 17:02:05 debug State is ACCEPTING
862011-11-19 17:02:05 debug State is ACCEPTING
872011-11-19 17:02:05 debug State is ACCEPTING
882011-11-19 17:02:05 debug State is ACCEPTING
892011-11-19 17:02:05 debug State is ACCEPTING
902011-11-19 17:02:05 debug State is ACCEPTING
912011-11-19 17:02:05 debug State is ACCEPTING
922011-11-19 17:02:05 debug State is ACCEPTING
932011-11-19 17:02:05 debug State is ACCEPTING
942011-11-19 17:02:05 debug State is ACCEPTING
952011-11-19 17:02:05 debug State is ACCEPTING
962011-11-19 17:02:05 debug State is ACCEPTING
972011-11-19 17:02:05 debug State is ACCEPTING
982011-11-19 17:02:06 debug State is ACCEPTING
992011-11-19 17:02:06 debug State is ACCEPTING
1002011-11-19 17:02:06 debug State is ACCEPTING
1012011-11-19 17:02:06 debug State is ACCEPTING
1022011-11-19 17:02:06 debug State is ACCEPTING
1032011-11-19 17:02:06 debug State is ACCEPTING
1042011-11-19 17:02:06 debug State is ACCEPTING
1052011-11-19 17:02:06 debug State is ACCEPTING
1062011-11-19 17:02:06 debug State is ACCEPTING
1072011-11-19 17:02:06 debug State is ACCEPTING
1082011-11-19 17:02:06 debug State is ACCEPTING
1092011-11-19 17:02:06 debug State is ACCEPTING
1102011-11-19 17:02:06 debug State is ACCEPTING
1112011-11-19 17:02:06 debug State is ACCEPTING
1122011-11-19 17:02:06 debug State is ACCEPTING
1132011-11-19 17:02:06 debug State is ACCEPTING
1142011-11-19 17:02:06 debug State is ACCEPTING
1152011-11-19 17:02:06 debug State is ACCEPTING
1162011-11-19 17:02:06 debug State is ACCEPTING
1172011-11-19 17:02:06 debug State is ACCEPTING
1182011-11-19 17:02:06 debug State is ACCEPTING
1192011-11-19 17:02:06 debug State is ACCEPTING
1202011-11-19 17:02:06 debug State is ACCEPTING
1212011-11-19 17:02:06 debug State is ACCEPTING
1222011-11-19 17:02:06 debug State is ACCEPTING
1232011-11-19 17:02:06 debug State is ACCEPTING
1242011-11-19 17:02:06 debug State is ACCEPTING
1252011-11-19 17:02:06 debug State is ACCEPTING
1262011-11-19 17:02:06 debug State is ACCEPTING
1272011-11-19 17:02:06 debug State is ACCEPTING
1282011-11-19 17:02:06 debug State is ACCEPTING
1292011-11-19 17:02:06 debug State is ACCEPTING
1302011-11-19 17:02:06 debug State is STACKING
1312011-11-19 17:02:06 debug State is STACKING
1322011-11-19 17:02:06 debug State is STACKING
1332011-11-19 17:02:06 debug State is STACKING
1342011-11-19 17:02:06 debug State is STACKING
1352011-11-19 17:02:06 debug State is STACKING
1362011-11-19 17:02:06 debug State is STACKING
1372011-11-19 17:02:06 debug State is STACKING
1382011-11-19 17:02:06 debug State is STACKING
1392011-11-19 17:02:06 debug State is STACKING
1402011-11-19 17:02:06 debug State is STACKING
1412011-11-19 17:02:06 debug State is STACKING
1422011-11-19 17:02:06 debug State is STACKING
1432011-11-19 17:02:06 debug State is STACKING
1442011-11-19 17:02:06 debug State is STACKING
1452011-11-19 17:02:06 debug State is STACKING
1462011-11-19 17:02:06 debug State is STACKING
1472011-11-19 17:02:06 debug State is STACKING
1482011-11-19 17:02:06 debug State is STACKING
1492011-11-19 17:02:06 debug State is STACKING
1502011-11-19 17:02:06 debug State is STACKING
1512011-11-19 17:02:06 debug State is STACKING
1522011-11-19 17:02:06 debug State is STACKING
1532011-11-19 17:02:06 debug State is STACKING
1542011-11-19 17:02:06 debug State is STACKING
1552011-11-19 17:02:06 debug State is STACKING
1562011-11-19 17:02:06 debug State is STACKING
1572011-11-19 17:02:06 debug State is STACKING
1582011-11-19 17:02:06 debug State is STACKING
1592011-11-19 17:02:06 debug State is STACKING
1602011-11-19 17:02:06 debug State is STACKING
1612011-11-19 17:02:06 debug State is STACKING
1622011-11-19 17:02:06 debug State is STACKING
1632011-11-19 17:02:06 debug State is STACKING
1642011-11-19 17:02:06 debug State is STACKING
1652011-11-19 17:02:06 debug State is STACKING
1662011-11-19 17:02:06 debug State is STACKING
1672011-11-19 17:02:06 debug State is STACKING
1682011-11-19 17:02:06 debug State is STACKING
1692011-11-19 17:02:06 debug State is STACKING
1702011-11-19 17:02:06 debug State is STACKING
1712011-11-19 17:02:06 debug State is STACKING
1722011-11-19 17:02:06 debug State is STACKING
1732011-11-19 17:02:06 debug State is STACKING
1742011-11-19 17:02:06 debug State is STACKING
1752011-11-19 17:02:06 debug State is STACKING
1762011-11-19 17:02:06 debug State is STACKING
1772011-11-19 17:02:06 debug State is STACKING
1782011-11-19 17:02:06 debug State is STACKING
1792011-11-19 17:02:06 debug State is STACKING
1802011-11-19 17:02:06 debug State is STACKING
1812011-11-19 17:02:06 debug State is STACKING
1822011-11-19 17:02:06 debug State is STACKING
1832011-11-19 17:02:06 debug State is STACKING
1842011-11-19 17:02:06 debug [BillAcceptorController::start]: <r event='bill_accepted' id_trx='0' count='0' value='0' total_amount='0' /> sent to client
1852011-11-19 17:02:06 debug State is STACKING
1862011-11-19 17:02:06 debug State is STACKING
1872011-11-19 17:02:06 debug State is STACKING
1882011-11-19 17:02:06 debug State is STACKING
1892011-11-19 17:02:06 debug State is STACKING
1902011-11-19 17:02:06 debug State is STACKING
1912011-11-19 17:02:06 debug State is STACKING
1922011-11-19 17:02:06 debug State is STACKING
1932011-11-19 17:02:06 debug State is STACKING
1942011-11-19 17:02:06 debug State is STACKING
1952011-11-19 17:02:06 debug State is STACKING
1962011-11-19 17:02:06 debug State is STACKING
1972011-11-19 17:02:06 debug State is STACKING
1982011-11-19 17:02:06 debug State is STACKING
1992011-11-19 17:02:07 debug State is STACKING
2002011-11-19 17:02:07 debug State is STACKING
2012011-11-19 17:02:07 debug State is STACKING
2022011-11-19 17:02:07 debug State is STACKING
2032011-11-19 17:02:07 debug State is STACKING
2042011-11-19 17:02:07 debug State is STACKING
2052011-11-19 17:02:07 debug State is STACKING
2062011-11-19 17:02:07 debug State is STACKING
2072011-11-19 17:02:07 debug State is STACKING
2082011-11-19 17:02:07 debug State is STACKING
2092011-11-19 17:02:07 debug State is STACKING
2102011-11-19 17:02:07 debug State is STACKING
2112011-11-19 17:02:07 debug State is STACKING
2122011-11-19 17:02:07 debug State is STACKING
2132011-11-19 17:02:07 debug State is STACKING
2142011-11-19 17:02:07 debug State is STACKING
2152011-11-19 17:02:07 debug State is STACKING
2162011-11-19 17:02:07 debug State is STACKING
2172011-11-19 17:02:07 debug State is STACKING
2182011-11-19 17:02:07 debug State is STACKING
2192011-11-19 17:02:07 debug State is STACKING
2202011-11-19 17:02:07 debug State is STACKING
2212011-11-19 17:02:07 debug State is STACKING
2222011-11-19 17:02:07 debug State is STACKING
2232011-11-19 17:02:07 debug State is STACKING
2242011-11-19 17:02:07 debug State is STACKING
2252011-11-19 17:02:07 debug State is STACKING
2262011-11-19 17:02:07 debug State is STACKING
2272011-11-19 17:02:07 debug State is STACKING
2282011-11-19 17:02:07 debug State is STACKING
2292011-11-19 17:02:07 debug State is STACKING
2302011-11-19 17:02:07 debug State is STACKING
2312011-11-19 17:02:07 debug State is STACKING
2322011-11-19 17:02:07 debug State is STACKING
2332011-11-19 17:02:07 debug State is STACKING
2342011-11-19 17:02:07 debug State is STACKING
2352011-11-19 17:02:07 debug State is STACKING
2362011-11-19 17:02:07 debug State is STACKING
2372011-11-19 17:02:07 debug State is STACKING
2382011-11-19 17:02:07 debug State is STACKING
2392011-11-19 17:02:07 debug State is STACKING
2402011-11-19 17:02:07 debug State is STACKING
2412011-11-19 17:02:07 debug State is STACKING
2422011-11-19 17:02:07 debug State is STACKING
2432011-11-19 17:02:07 debug State is STACKING
2442011-11-19 17:02:07 debug State is STACKING
2452011-11-19 17:02:07 debug State is STACKING
2462011-11-19 17:02:07 debug State is STACKING
2472011-11-19 17:02:07 debug State is STACKING
2482011-11-19 17:02:07 debug State is STACKING
2492011-11-19 17:02:07 debug State is STACKING
2502011-11-19 17:02:07 debug State is STACKING
2512011-11-19 17:02:07 debug State is STACKING
2522011-11-19 17:02:07 debug State is STACKING
2532011-11-19 17:02:07 debug State is STACKING
2542011-11-19 17:02:07 debug State is STACKING
2552011-11-19 17:02:07 debug State is STACKING
2562011-11-19 17:02:07 debug State is STACKING
2572011-11-19 17:02:07 debug State is STACKING
2582011-11-19 17:02:07 debug State is STACKING
2592011-11-19 17:02:07 debug Normal response waited
2602011-11-19 17:02:07 debug Response is [129, 4]
2612011-11-19 17:02:07 debug Accepted amount is 100
2622011-11-19 17:02:07 debug [BillingAdapter::bill_acceptor_in_trx]: Trying to start in trx
2632011-11-19 17:02:07 debug HTTP: Sending request: {'id_terminal': 74, 'amount': 100, 'cmd': 'atm.bill_acceptor_in_trx', 'secret_key': 'spass1234', 'id_account': '317952'}
2642011-11-19 17:02:07 debug [Cashcode_t1500->wait] start waiting 120
2652011-11-19 17:02:08 debug HTTP: Receive: <?xml version="1.0" encoding="UTF-8"?>
266<response request_key="154300" status="28006"><payment id_transaction="29368669" id_transaction_key="29162837" account_name="79517233700" balance_currency="100" balance_sbs="100"/></response>
2672011-11-19 17:02:08 debug [BillingAdapter::bill_acceptor_in_trx]: response is <response request_key="154300" status="28006"><payment id_transaction="29368669" id_transaction_key="29162837" account_name="79517233700" balance_currency="100" balance_sbs="100"></payment></response>
2682011-11-19 17:02:08 debug [BillAcceptorController::start] commit result: {u'status': u'28006', u'balance_sbs': u'100', u'balance_currency': u'100', u'request_key': u'154300', u'id_transaction': u'29368669', u'id_transaction_key': u'29162837', u'account_name': u'79517233700'}
2692011-11-19 17:02:09 debug [BillAcceptorController::start]: <r event='bill_accepted' id_trx='0' count='0' value='0' total_amount='100' /> sent to client
2702011-11-19 17:02:10 debug [BillAcceptorController::start]: <r event='bill_accepted' id_trx='0' count='0' value='0' total_amount='100' /> sent to client
2712011-11-19 17:02:11 debug [BillAcceptorController::start]: socket closed by GUI
2722011-11-19 17:02:11 debug [BillAcceptorController::start]: error type is <class 'socket.error'>
2732011-11-19 17:02:11 debug [BillAcceptorController::start]: error args is (32, 'Broken pipe')
2742011-11-19 17:02:11 debug [Cashcode_T1500]: reset
2752011-11-19 17:02:11 debug [Cashcode_t1500]: full_reset
2762011-11-19 17:02:11 debug [Cashcode_T1500]: run stop operations
2772011-11-19 17:02:11 debug [Cashcode_T1500]: reset
2782011-11-19 17:02:11 debug [Cashcode_t1500]: full_reset
2792011-11-19 17:02:12 debug Header error. Header is []
2802011-11-19 17:02:12 debug [Cashcode_T1500]: stopping with error
2812011-11-19 17:02:12 debug [Cashcode_T1500]: serial port has been closed
2822011-11-19 17:02:14 debug [Cashcode_T1500]: serial port has been closed
2832011-11-19 17:02:14 debug [BillAcceptorController::start]: stopping
2842011-11-19 17:02:14 debug Stopped by flag