API tools faq
paste
Advertisement
fedorm

Untitled

fedorm
Jul 17th, 2019
215
0
Never
Add comment
Not a member of Pastebin yet? Sign Up, it unlocks many cool features!
XML 95.13 KB | None | 0 0
raw download clone embed print report
  1. 17.07 14:58:00.310 INFO  [SiebelServiceImpl] calculateOrder response: Order[
  2.   orderHeader=OrderHeader[
  3.       shopIndex=902
  4.       slipText=<null>
  5.       shiftNumber=40
  6.       cardNumber=<null>
  7.       cardPayment=<null>
  8.       posType=<null>
  9.       cashNumber=4
  10.       chequeSum=3000.00
  11.       operation=0
  12.       issueCard=<null>
  13.       chequeNumber=6
  14.       errorText=<null>
  15.       errorCode=<null>
  16.       dateOperation="17/07/2019 14:57"
  17.       cashierNumber=<null>
  18.       cashierMessage=<null>
  19.       bonusAmt=<null>
  20.       listOfOrderItem=ListOfOrderItem[
  21.           orderItem=[OrderItem[
  22.               item="ТОВ370155"
  23.               quant=1.000
  24.               priceDisc=3000.00
  25.               price=3000.00
  26.               numKit=<null>
  27.               minPrice=0
  28.               posNumber=1
  29.               posSum=3000.00
  30.               discSum=0.00
  31.               bonusSum=<null>
  32.               barcode="0686603100493"
  33.             ]]
  34.         ]
  35.       listOfPayments=<null>
  36.       listOfCard=ListOfCard[
  37.           cards=[Cards[
  38.               cardNum="0003000189254565"
  39.               cardType=1
  40.             ]]
  41.         ]
  42.       listOfDisc=ListOfDisc[
  43.           orderDisc=[
  44.         ]
  45.       listOfLoyOptionProduct=<null>
  46.       mainOrder=<null>
  47.     ]
  48. ]
  49. 17.07 14:58:00.310 INFO  [SiebelServiceImpl] Need determ tokens for check [PurchaseEntity [id=651, number=null, dateCreate=Wed Jul 17 14:57:20 MSK 2019, dateCommit=null, fiscalDocNum=null, sentToServerStatus=NO_SENT]]
  50. 17.07 14:58:00.311 INFO  [SiebelTokenService] determBonusSum(tokens) orderRequest: Order[
  51.   orderHeader=OrderHeader[
  52.       shopIndex=902
  53.       slipText=<null>
  54.       shiftNumber=40
  55.       cardNumber=<null>
  56.       cardPayment=<null>
  57.       posType=<null>
  58.       cashNumber=4
  59.       chequeSum=3000
  60.       operation=1
  61.       issueCard=<null>
  62.       chequeNumber=6
  63.       errorText=<null>
  64.       errorCode=<null>
  65.       dateOperation="17/07/2019 14:57"
  66.       cashierNumber=<null>
  67.       cashierMessage="
  68. Подарки со след. чека:
  69. Бесплатный кофе: 1000"
  70.       bonusAmt=<null>
  71.       listOfOrderItem=ListOfOrderItem[
  72.           orderItem=[OrderItem[
  73.               item="ТОВ370155"
  74.               quant=1
  75.               priceDisc=3000
  76.               price=3000
  77.               numKit=<null>
  78.               minPrice=0
  79.               posNumber=1
  80.               posSum=3000
  81.               discSum=0
  82.               bonusSum=<null>
  83.               barcode="0686603100493"
  84.             ]]
  85.         ]
  86.       listOfPayments=<null>
  87.       listOfCard=ListOfCard[
  88.           cards=[Cards[
  89.               cardNum="0003000189254565"
  90.               cardType=1
  91.             ]]
  92.         ]
  93.       listOfDisc=<null>
  94.       listOfLoyOptionProduct=<null>
  95.       mainOrder=<null>
  96.     ]
  97. ]
  98. 17.07 14:58:00.916 INFO  [SiebelTokenService] determBonusSum(tokens) orderResponse: Order[
  99.   orderHeader=OrderHeader[
  100.       shopIndex=902
  101.       slipText="
  102.  
  103. "
  104.       shiftNumber=40
  105.       cardNumber=<null>
  106.       cardPayment=0
  107.       posType=<null>
  108.       cashNumber=4
  109.       chequeSum=3000
  110.       operation=1
  111.       issueCard=<null>
  112.       chequeNumber=6
  113.       errorText=""
  114.       errorCode="0"
  115.       dateOperation="17/07/2019 14:57"
  116.       cashierNumber=<null>
  117.       cashierMessage=""
  118.       bonusAmt=<null>
  119.       listOfOrderItem=ListOfOrderItem[
  120.           orderItem=[OrderItem[
  121.               item="ТОВ370155"
  122.               quant=1
  123.               priceDisc=3000
  124.               price=3000
  125.               numKit=<null>
  126.               minPrice=0
  127.               posNumber=1
  128.               posSum=3000
  129.               discSum=0
  130.               bonusSum=<null>
  131.               barcode="0686603100493"
  132.             ]]
  133.         ]
  134.       listOfPayments=<null>
  135.       listOfCard=ListOfCard[
  136.           cards=[Cards[
  137.               cardNum="0003000189254565"
  138.               cardType=1
  139.             ]]
  140.         ]
  141.       listOfDisc=<null>
  142.       listOfLoyOptionProduct=<null>
  143.       mainOrder=<null>
  144.     ]
  145. ]
  146. 17.07 14:58:00.917 INFO  [SiebelServiceImpl] Mapping order [ru.crystals.siebel.wsclient.Order@186d563] to check
  147. 17.07 14:58:00.917 INFO  [SiebelServiceImpl] orderResponse: Order[
  148.   orderHeader=OrderHeader[
  149.       shopIndex=902
  150.       slipText=<null>
  151.       shiftNumber=40
  152.       cardNumber=<null>
  153.       cardPayment=<null>
  154.       posType=<null>
  155.       cashNumber=4
  156.       chequeSum=3000
  157.       operation=1
  158.       issueCard=<null>
  159.       chequeNumber=6
  160.       errorText=<null>
  161.       errorCode=<null>
  162.       dateOperation="17/07/2019 14:57"
  163.       cashierNumber=<null>
  164.       cashierMessage="
  165. Подарки со след. чека:
  166. Бесплатный кофе: 1000"
  167.       bonusAmt=<null>
  168.       listOfOrderItem=ListOfOrderItem[
  169.           orderItem=[OrderItem[
  170.               item="ТОВ370155"
  171.               quant=1
  172.               priceDisc=3000
  173.               price=3000
  174.               numKit=<null>
  175.               minPrice=0
  176.               posNumber=1
  177.               posSum=3000
  178.               discSum=0
  179.               bonusSum=<null>
  180.               barcode="0686603100493"
  181.             ]]
  182.         ]
  183.       listOfPayments=<null>
  184.       listOfCard=ListOfCard[
  185.           cards=[Cards[
  186.               cardNum="0003000189254565"
  187.               cardType=1
  188.             ]]
  189.         ]
  190.       listOfDisc=<null>
  191.       listOfLoyOptionProduct=<null>
  192.       mainOrder=<null>
  193.     ]
  194. ]
  195. 17.07 14:58:00.919 INFO  [DoProcessing] ============ LoyalCalculation: doDiscount start ============
  196. 17.07 14:58:00.919 INFO  [DoProcessing] GeneralInteractionMethod: MAXIMUM_DISCOUNT
  197. 17.07 14:58:00.920 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  198. 17.07 14:58:00.926 INFO  [DoProcessing] ============ LoyalCalculation: doDiscount success ============
  199. 17.07 14:58:00.927 TRACE [LoyPluginEmulator] entering doDiscount(Receipt). The argument is: ru.crystals.api.commons.ReceiptPurchaseWrapper@8efb73
  200. 17.07 14:58:00.927 TRACE [LoyPluginEmulator] entering readProperties(IntegrationProperties, Logger)
  201. 17.07 14:58:00.927 TRACE [LoyPluginEmulator] getUrlProperty: the "secondary.calc.url" is not set
  202. 17.07 14:58:00.928 TRACE [LoyPluginEmulator] leaving readProperties(IntegrationProperties, Logger). The result is: LoyPluginEmulatorProperties{primaryCalcUrl=http://127.0.0.1:10065/loy-plugin-processing/emulator/process, secondaryCalcUrl=null, feedbackUrl=http://127.0.0.1:10065/loy-plugin-processing/emulator/feedback, connectionTimeout=1000, readTimeout=1000, cardProcessingId='null'}; it took 1 [ms]
  203. 17.07 14:58:00.928 TRACE [LoyPluginEmulator] entering makeCalcCalls(List, EmulatorReceipt). The arguments are: urls: [http://127.0.0.1:10065/loy-plugin-processing/emulator/process], emulatorReceipt: emul-receipt [card: emul-card [no: "0003000189254565"; available: 3920074; to-write-off: null]; positions: [emul-pos [no: 1; marking: "ТОВ370155"; qnty: 1000; sum: 300000; min-sum: 0; discountable: true]]]
  204. 17.07 14:58:01.453 ERROR [ConnectionEmulatorUtils] toString(XmlEmulatorException): the argument is null
  205. 17.07 14:58:01.463 TRACE [LoyPluginEmulator] leaving makeCalcCalls(List, EmulatorReceipt). The result is: emul-loy-result [discounts: []; limit: null; taken-into-account: null]; it took 535 [ms]
  206. 17.07 14:58:01.463 TRACE [LoyPluginEmulator] leaving doDiscount(Receipt). The result is: LoyaltyResult{discounts=null, bonusWriteOffsLimits=null, bonusesTakenIntoAccount=null, bonusAccrualResults=null, printDocuments=null, messagesToCashier=null, extendedAttributeMap=null}; it took 536 [ms]
  207. 17.07 14:58:01.463 INFO  [LoyaltyResultSanityChecker] Checking MRP restrictions
  208. Quantity 1000
  209. Position sum 3000.00
  210. Value 0
  211. Min price 0.00
  212. 17.07 14:58:01.463 INFO  [LoyaltyResultSanityChecker] Unable to check MRP restriction: no MRP provided
  213. 17.07 14:58:01.463 TRACE [MLServiceImpl] entering getMlCardNo(Purchase). The argument is: Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}
  214. 17.07 14:58:01.464 TRACE [MLServiceImpl] leaving getMlCardNo(Purchase). The result is: null
  215. 17.07 14:58:01.464 TRACE [MLServiceImpl] entering getMlCouponNo(PurchaseEntity). The argument is: Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}
  216. 17.07 14:58:01.464 TRACE [MLServiceImpl] leaving getMlCouponNo(PurchaseEntity). The result is: null
  217. 17.07 14:58:01.464 TRACE [SCService] entering isEnabled()
  218. 17.07 14:58:01.464 TRACE [SCService] leaving isEnabled(). the result is: true
  219. 17.07 14:58:01.464 TRACE [SCService] entering calcDiscount(Purchase). The argument is: Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}
  220. 17.07 14:58:01.465 TRACE [SCService] Send request <?xml version="1.0" encoding="UTF-8" standalone="yes"?>
  221. <ChequeRequest xmlns="http://smartcheckout.ru/xsd/s10ren.xsd" ChequeType="Soft">
  222.     <RequestID>1563364640569</RequestID>
  223.     <Card>
  224.         <CardNumber>0003000189254565</CardNumber>
  225.     </Card>
  226.     <DateTime>2019-07-17T14:58:01.464+03:00</DateTime>
  227.     <POS>4</POS>
  228.     <Number>1563364640569</Number>
  229.     <Summ>3000.00</Summ>
  230.     <Discount>0.000</Discount>
  231.     <SummDiscounted>3000.00</SummDiscounted>
  232.     <Item>
  233.         <PositionNumber>1</PositionNumber>
  234.         <Article>ТОВ370155</Article>
  235.         <ArticleName>ТОВ370155</ArticleName>
  236.         <Price>3000.00</Price>
  237.         <Quantity>1.000</Quantity>
  238.         <Summ>3000.00</Summ>
  239.         <Discount>0.000</Discount>
  240.         <SummDiscounted>3000.00</SummDiscounted>
  241.     </Item>
  242. </ChequeRequest>
  243.  
  244. 17.07 14:58:01.465 TRACE [SCService] entering getServices()
  245. 17.07 14:58:01.465 TRACE [SCService] getting services (IN MEMORY)
  246. 17.07 14:58:01.465 TRACE [SCService] leaving getServices(). The result size is: 2
  247. 17.07 14:58:01.478 TRACE [SCService] Received response: <?xml version="1.0" encoding="UTF-8" standalone="yes"?>
  248. <ChequeRequestResponce xmlns="http://smartcheckout.ru/xsd/s10ren.xsd">
  249.     <RequestID>1563364640569</RequestID>
  250.     <Processed>2019-07-17T14:58:01.470+03:00</Processed>
  251.     <ReturnCode>0</ReturnCode>
  252.     <CashierMessageTO>0</CashierMessageTO>
  253.     <Summ>3000.00</Summ>
  254.     <Discount>0.000</Discount>
  255.     <SummDiscounted>3000.00</SummDiscounted>
  256.     <Item>
  257.         <PositionNumber>1</PositionNumber>
  258.         <Article>ТОВ370155</Article>
  259.         <ArticleName>ТОВ370155</ArticleName>
  260.         <Price>3000.00</Price>
  261.         <MinPrice>0</MinPrice>
  262.         <Quantity>1.000</Quantity>
  263.         <Summ>3000.00</Summ>
  264.         <Discount>0.000</Discount>
  265.         <SummDiscounted>3000.00</SummDiscounted>
  266.     </Item>
  267. </ChequeRequestResponce>
  268.  
  269. 17.07 14:58:01.478 TRACE [SCReceiptConverter] ml discounts: {position-key [marking: ТОВ370155; original-price: 300000]=0}
  270. 17.07 14:58:01.479 TRACE [SCReceiptConverter] it was inferred that no SC POS discounts were given on position [key: position-key [marking: ТОВ370155; original-price: 300000]]: SC discount value is: 0
  271. 17.07 14:58:01.479 TRACE [SCService] leaving calcDiscount(Purchase). The result is: Purchase{number=null, dateCreate=null, checkSum=300000, operationType=null, discountValueTotal=0}; it took 15 [ms]
  272. 17.07 14:58:01.481 INFO  [DoProcessing] ============ LoyalCalculation: doDiscount start ============
  273. 17.07 14:58:01.481 INFO  [DoProcessing] GeneralInteractionMethod: MAXIMUM_DISCOUNT
  274. 17.07 14:58:01.486 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  275. 17.07 14:58:01.486 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  276. 17.07 14:58:01.487 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  277. 17.07 14:58:01.488 WARN  [AdvancedMessagesActionResult] Calculator returns empty result. Do not generate slips or messages
  278. 17.07 14:58:01.489 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  279. 17.07 14:58:01.489 WARN  [AdvancedMessagesActionResult] Calculator returns empty result. Do not generate slips or messages
  280. 17.07 14:58:01.490 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  281. 17.07 14:58:01.491 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  282. 17.07 14:58:01.491 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  283. 17.07 14:58:01.492 WARN  [AdvancedMessagesActionResult] Calculator returns empty result. Do not generate slips or messages
  284. 17.07 14:58:01.492 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  285. 17.07 14:58:01.493 WARN  [AdvancedMessagesActionResult] Calculator returns empty result. Do not generate slips or messages
  286. 17.07 14:58:01.494 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  287. 17.07 14:58:01.494 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  288. 17.07 14:58:01.495 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  289. 17.07 14:58:01.496 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  290. 17.07 14:58:01.497 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  291. 17.07 14:58:01.497 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  292. 17.07 14:58:01.498 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  293. 17.07 14:58:01.499 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  294. 17.07 14:58:01.500 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  295. 17.07 14:58:01.500 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  296. 17.07 14:58:01.501 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  297. 17.07 14:58:01.502 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  298. 17.07 14:58:01.502 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  299. 17.07 14:58:01.503 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  300. 17.07 14:58:01.504 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  301. 17.07 14:58:01.504 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  302. 17.07 14:58:01.505 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  303. 17.07 14:58:01.506 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  304. 17.07 14:58:01.507 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  305. 17.07 14:58:01.508 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  306. 17.07 14:58:01.508 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  307. 17.07 14:58:01.509 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  308. 17.07 14:58:01.510 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  309. 17.07 14:58:01.510 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  310. 17.07 14:58:01.511 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  311. 17.07 14:58:01.512 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  312. 17.07 14:58:01.512 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  313. 17.07 14:58:01.513 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  314. 17.07 14:58:01.514 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  315. 17.07 14:58:01.515 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  316. 17.07 14:58:01.515 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  317. 17.07 14:58:01.516 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  318. 17.07 14:58:01.517 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  319. 17.07 14:58:01.517 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  320. 17.07 14:58:01.518 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  321. 17.07 14:58:01.519 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  322. 17.07 14:58:01.520 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  323. 17.07 14:58:01.520 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  324. 17.07 14:58:01.521 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  325. 17.07 14:58:01.522 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  326. 17.07 14:58:01.523 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  327. 17.07 14:58:01.523 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  328. 17.07 14:58:01.524 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  329. 17.07 14:58:01.525 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  330. 17.07 14:58:01.526 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  331. 17.07 14:58:01.527 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  332. 17.07 14:58:01.527 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  333. 17.07 14:58:01.528 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  334. 17.07 14:58:01.529 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  335. 17.07 14:58:01.530 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  336. 17.07 14:58:01.530 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  337. 17.07 14:58:01.531 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  338. 17.07 14:58:01.532 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  339. 17.07 14:58:01.534 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  340. 17.07 14:58:01.534 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  341. 17.07 14:58:01.535 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  342. 17.07 14:58:01.536 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  343. 17.07 14:58:01.536 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  344. 17.07 14:58:01.537 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  345. 17.07 14:58:01.538 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  346. 17.07 14:58:01.539 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  347. 17.07 14:58:01.539 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  348. 17.07 14:58:01.540 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  349. 17.07 14:58:01.541 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  350. 17.07 14:58:01.541 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  351. 17.07 14:58:01.542 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  352. 17.07 14:58:01.543 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  353. 17.07 14:58:01.543 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  354. 17.07 14:58:01.544 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  355. 17.07 14:58:01.545 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  356. 17.07 14:58:01.546 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  357. 17.07 14:58:01.547 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  358. 17.07 14:58:01.547 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  359. 17.07 14:58:01.548 INFO  [DoProcessing] ============ LoyalCalculation: doDiscount success ============
  360. 17.07 14:58:01.548 ERROR [DiscountCalculationUtils] Loyalty provider purchase post process failed!
  361. 17.07 14:58:01.550 INFO  [DoProcessing] ============ LoyalCalculation: doDiscount start ============
  362. 17.07 14:58:01.550 INFO  [DoProcessing] GeneralInteractionMethod: MAXIMUM_DISCOUNT
  363. 17.07 14:58:01.550 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  364. 17.07 14:58:01.551 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  365. 17.07 14:58:01.551 INFO  [DoProcessing] ============ LoyalCalculation: doDiscount success ============
  366. 17.07 14:58:01.553 INFO  [SetApiPluginLoyProvider] Plugin "ru.crystals.loy.plugin.emulator" does not do post discount tuning
  367. 17.07 14:58:01.553 TRACE [MLServiceImpl] entering getMlCardNo(Purchase). The argument is: Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}
  368. 17.07 14:58:01.553 TRACE [MLServiceImpl] leaving getMlCardNo(Purchase). The result is: null
  369. 17.07 14:58:01.554 TRACE [MLServiceImpl] entering getMlCouponNo(PurchaseEntity). The argument is: Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}
  370. 17.07 14:58:01.554 TRACE [MLServiceImpl] leaving getMlCouponNo(PurchaseEntity). The result is: null
  371. 17.07 14:58:01.554 INFO  [LoyalServiceImpl] Discount calculation (Purchase #6; Positions: 1
  372. 17.07 14:58:01.555 WARN  [LoyalServiceImpl] extractNonDiscountRelatedFields: the argument is NULL! Null will be returned!
  373. 17.07 14:58:01.560 INFO  [LoyalBridgeServiceImpl] Total time of discount calculation = 3100 ms
  374. 17.07 14:58:01.560 INFO  [LoyalBridgeServiceImpl] ---------------- end discount calculation ----------------
  375. 17.07 14:58:01.570 INFO  [SpeedLog] TechProcess discounts processing on cheque with 1 positions [sale] time = 3116 ms
  376. 17.07 14:58:01.583 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductJewelController
  377. 17.07 14:58:01.583 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductClothingController
  378. 17.07 14:58:01.583 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductCFTGiftCardController
  379. 17.07 14:58:01.584 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductBonusPointsController
  380. 17.07 14:58:01.584 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductMetricController
  381. 17.07 14:58:01.584 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductMobilePayController
  382. 17.07 14:58:01.584 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL send event to frontend: FORM_CHECK_PUT
  383. 17.07 14:58:01.585 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"form.check.put","payload":{"check":{"discount":{"value":"0.00","percentValue":"0.00","cardEnabled":true},"checkSum":"3000.00","positions":[{"itemId":1,"name":"ТОВ370155","quantity":"1","measure":"Шт.","sum":"3000.00","item":"ТОВ370155","barcode":"0686603100493","marked":false,"positionCouponEnabled":false,"manualDiscountEnabled":false}],"positionCouponEnabled":false,"manualDiscountEnabled":false},"buttons":[{"text":"РАССЧИТАТЬ","callback":{"type":"form.sale.check.subtotalRun","payload":{}}}]}}
  384. 17.07 14:58:01.585 INFO  [AbstractExtraEventProcessor] [Main-event-thread] CdForwardExtraProcessor sends event CashEvent [eventType='cd.check.put', canProcessed='true', pld='ru.crystals.pos.touch2.customerdisplay.payload.CdCheckPutPld@13c35bc']
  385. 17.07 14:58:01.586 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL send event to frontend: CD_CHECK_PUT
  386. 17.07 14:58:01.596 TRACE [SaleSubtotalProcessor] [Main-event-thread] SaleSubtotalScenario.updateLoyaltyResults:in
  387. 17.07 14:58:01.596 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL send event to frontend: FORM_WAIT_CLOSE
  388. 17.07 14:58:01.597 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"form.wait.close","payload":{}}
  389. 17.07 14:58:01.597 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL start (imm) this SIEBEL_RANGES with e=null
  390. 17.07 14:58:01.598 DEBUG [SiebelRangesPlugin] [Main-event-thread] Siebel loyalty (ranges): process results, step No1, Start
  391. 17.07 14:58:01.608 TRACE [SiebelRangesPlugin] [Main-event-thread] Siebel loyalty (ranges): process results, step No1, abortSubtotal=false
  392. 17.07 14:58:01.608 TRACE [AbstractEventProcessor] [Main-event-thread] Exit (imm) from '[SIEBEL_RANGES]' and start (imm) previous 'SALE_SUBTOTAL'
  393. 17.07 14:58:01.609 TRACE [AbstractEventProcessor] [Main-event-thread] [SIEBEL_RANGES] start (imm) this SALE_SUBTOTAL with e=INNER_PROCESSOR_EXIT
  394. 17.07 14:58:01.609 TRACE [AbstractEventProcessor] [Main-event-thread] Stop processor: [SIEBEL_RANGES], prevPT=SALE_SUBTOTAL
  395. 17.07 14:58:01.609 TRACE [AbstractEventProcessor] [Main-event-thread] Start processor: Type:SALE_SUBTOTAL, prevPT=SALE
  396. 17.07 14:58:01.609 INFO  [AbstractExtraEventProcessor] [Main-event-thread] SaleTabExtraProcessor sends event CashEvent [eventType='sd.show', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.EmptyPld@c2c5da']
  397. 17.07 14:58:01.609 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL send event to frontend: SD_SHOW
  398. 17.07 14:58:01.610 INFO  [AbstractExtraEventProcessor] [Main-event-thread] SaleTabExtraProcessor sends event CashEvent [eventType='sd.tab.put', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.tab.SdTabPutPld@6802a1']
  399. 17.07 14:58:01.610 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"sd.show","payload":{}}
  400. 17.07 14:58:01.610 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL send event to frontend: SD_TAB_PUT
  401. 17.07 14:58:01.610 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"sd.tab.put","payload":{"tabs":[{"name":"ПРОДАЖА","tabId":"7d7eff3f-4033-421f-b853-3635be8129bc"},{"name":"Кафе","tabId":"fbe54aae-58b5-460c-b4cd-461a531f9f82"}]}}
  402. 17.07 14:58:01.620 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductJewelController
  403. 17.07 14:58:01.620 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductClothingController
  404. 17.07 14:58:01.620 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductCFTGiftCardController
  405. 17.07 14:58:01.620 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductBonusPointsController
  406. 17.07 14:58:01.621 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductMetricController
  407. 17.07 14:58:01.621 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductMobilePayController
  408. 17.07 14:58:01.621 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL send event to frontend: FORM_CHECK_PUT
  409. 17.07 14:58:01.622 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"form.check.put","payload":{"check":{"discount":{"value":"0.00","percentValue":"0.00","cardEnabled":true},"checkSum":"3000.00","positions":[{"itemId":1,"name":"ТОВ370155","quantity":"1","measure":"Шт.","sum":"3000.00","item":"ТОВ370155","barcode":"0686603100493","marked":false,"positionCouponEnabled":false,"manualDiscountEnabled":false}],"positionCouponEnabled":false,"manualDiscountEnabled":false},"buttons":[{"text":"РАССЧИТАТЬ","callback":{"type":"form.sale.check.subtotalRun","payload":{}}}]}}
  410. 17.07 14:58:01.622 INFO  [AbstractExtraEventProcessor] [Main-event-thread] CdForwardExtraProcessor sends event CashEvent [eventType='cd.check.put', canProcessed='true', pld='ru.crystals.pos.touch2.customerdisplay.payload.CdCheckPutPld@f76f14']
  411. 17.07 14:58:01.622 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL send event to frontend: CD_CHECK_PUT
  412. 17.07 14:58:01.623 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL receive event: INNER_PROCESSOR_EXIT
  413. 17.07 14:58:01.623 DEBUG [SiebelRangesPlugin] [Main-event-thread] Siebel loyalty (ranges): process results, step No1, End
  414. 17.07 14:58:01.623 TRACE [SaleSubtotalProcessor] [Main-event-thread] SaleSubtotalScenario.updateLoyaltyResults:out
  415. 17.07 14:58:01.623 TRACE [TechProcessImpl] Start warn divide amount
  416. 17.07 14:58:01.623 INFO  [AbstractEventSender] [Internal-Cash-Pool-Executor_36] StatusBarEventSender sends event CashEvent [eventType='form.notice.clear', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.EmptyPld@c2c5da']
  417. 17.07 14:58:01.623 INFO  [TechProcessImpl] goToPayments
  418. 17.07 14:58:01.624 TRACE [SaleSubtotalProcessor] [Main-event-thread] SaleSubtotalScenario.onSubtotalSuccess:in
  419. 17.07 14:58:01.624 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL start this SALE_PAYMENT with e=null
  420. 17.07 14:58:01.624 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL start this CD_PAYMENT_STATE with e=null
  421. 17.07 14:58:01.624 TRACE [SaleSubtotalProcessor] [Main-event-thread] SaleSubtotalScenario.onSubtotalSuccess:out
  422. 17.07 14:58:01.624 INFO  [SpeedLog] (SUBTOTAL) time = 3,175;
  423. 17.07 14:58:01.624 INFO  [AbstractEventSender] [Internal-Cash-Pool-Executor_36] AdditionalMenuEventSender sends event CashEvent [eventType='additionalMenu.configuration', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.additionalmenu.AdditionalMenuConfigurationPld@b15869']
  424. 17.07 14:58:01.624 INFO  [AbstractEventsFilter] [Main-event-thread] ProcessorEventsFilter starts processor SALE_PAYMENT with event null
  425. 17.07 14:58:01.625 TRACE [AbstractEventProcessor] [Main-event-thread] Stop processor: Type:SALE_SUBTOTAL, prevPT=SALE
  426. 17.07 14:58:01.625 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"form.notice.clear","payload":{}}
  427. 17.07 14:58:01.625 TRACE [AbstractEventProcessor] [Main-event-thread] Start processor: Type:SALE_PAYMENT, prevPT=SALE_SUBTOTAL
  428. 17.07 14:58:01.625 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"additionalMenu.configuration","payload":{"goodsFindIconEnabled":true,"printDocumentIconEnabled":true,"functionMenuIconEnabled":true,"infoMenuIconEnabled":true}}
  429. 17.07 14:58:01.635 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductJewelController
  430. 17.07 14:58:01.635 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductClothingController
  431. 17.07 14:58:01.636 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductCFTGiftCardController
  432. 17.07 14:58:01.636 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductBonusPointsController
  433. 17.07 14:58:01.636 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductMetricController
  434. 17.07 14:58:01.636 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductMobilePayController
  435. 17.07 14:58:01.636 INFO  [AbstractExtraEventProcessor] [Main-event-thread] SaleTabExtraProcessor sends event CashEvent [eventType='sd.show', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.EmptyPld@c2c5da']
  436. 17.07 14:58:01.637 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_PAYMENT send event to frontend: SD_SHOW
  437. 17.07 14:58:01.637 INFO  [AbstractExtraEventProcessor] [Main-event-thread] SaleTabExtraProcessor sends event CashEvent [eventType='sd.tab.put', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.tab.SdTabPutPld@196bc63']
  438. 17.07 14:58:01.637 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"sd.show","payload":{}}
  439. 17.07 14:58:01.637 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_PAYMENT send event to frontend: SD_TAB_PUT
  440. 17.07 14:58:01.638 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"sd.tab.put","payload":{"tabs":[{"name":"ПРОДАЖА","tabId":"7d7eff3f-4033-421f-b853-3635be8129bc"},{"name":"Кафе","tabId":"fbe54aae-58b5-460c-b4cd-461a531f9f82"}]}}
  441. 17.07 14:58:01.641 INFO  [AbstractExtraEventProcessor] [Main-event-thread] SaleTabExtraProcessor sends event CashEvent [eventType='sd.tab.tile.put', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.tab.SdTabTilePutPld@1d7524e']
  442. 17.07 14:58:01.641 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_PAYMENT send event to frontend: SD_TAB_TILE_PUT
  443. 17.07 14:58:01.642 INFO  [AbstractExtraEventProcessor] [Main-event-thread] AvCardInfoExtraProcessor sends event CashEvent [eventType='av.sale.card.info', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.sale.avcard.FormSaleCardInfoPld@165ea58']
  444. 17.07 14:58:01.642 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"sd.tab.tile.put","payload":{"type":"F","client":"AV","tiles":[{"tileId":"CARD_CHECK_SIEBEL","index":2,"name":"Проверка карты Вкусомания","iconId":"CARD","enabled":true,"callback":{"type":"sd.tab.ftile.click","payload":{"tileId":"CARD_CHECK_SIEBEL"}},"state":"none"},{"tileId":"SEARCH","index":3,"name":"Поиск товаров","iconId":"SEARCH","enabled":true,"callback":{"type":"sd.tab.ftile.click","payload":{"tileId":"SEARCH"}},"state":"none"},{"tileId":"SOFT_CHECK_PLUGIN_ID","index":6,"name":"Вызов мягкого чека","iconId":"DOCUMENT","enabled":false,"callback":{"type":"sd.tab.ftile.click","payload":{"tileId":"SOFT_CHECK_PLUGIN_ID"}},"state":"none"},{"tileId":"OFD_CLIENT_PLUGIN","index":7,"name":"Отправить чек покупателю","iconId":"PAPER_PLANE","enabled":true,"callback":{"type":"sd.tab.ftile.click","payload":{"tileId":"OFD_CLIENT_PLUGIN"}},"state":"none"},{"tileId":"PURCHASE_CANCEL_PLUGIN_ID","index":12,"name":"Аннулировать чек","iconId":"CANCEL","enabled":true,"callback":{"type":"sd.tab.ftile.click","payload":{"tileId":"PURCHASE_CANCEL_PLUGIN_ID"}},"state":"none"},{"tileId":"CASH_DRAWER_OPEN_PLUGIN_ID","index":14,"name":"Открыть денежный ящик","iconId":"LOCK","enabled":false,"callback":{"type":"sd.tab.ftile.click","payload":{"tileId":"CASH_DRAWER_OPEN_PLUGIN_ID"}},"state":"none"},{"tileId":"AEROFLOT_BONUSES_PLUGIN_ID","index":15,"name":"Списать мили","iconId":"AEROFLOT_BONUSES","enabled":true,"callback":{"type":"sd.tab.ftile.click","payload":{"tileId":"AEROFLOT_BONUSES_PLUGIN_ID"}},"state":"none"}],"showCard":true}}
  445. 17.07 14:58:01.642 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_PAYMENT send event to frontend: AV_SALE_CARD_INFO
  446. 17.07 14:58:01.643 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"av.sale.card.info","payload":{"cardNumber":"000100******7670","bonusVal":"3920074.74","bonusRub":"39200.74","mark":"4024.85"}}
  447. 17.07 14:58:01.655 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductJewelController
  448. 17.07 14:58:01.655 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductClothingController
  449. 17.07 14:58:01.655 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductCFTGiftCardController
  450. 17.07 14:58:01.656 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductBonusPointsController
  451. 17.07 14:58:01.656 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductMetricController
  452. 17.07 14:58:01.656 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductMobilePayController
  453. 17.07 14:58:01.662 INFO  [LoyalProductFinder] Time finding items (1) = 4 ms
  454. 17.07 14:58:01.662 INFO  [LoyalProductsConverter] Time searching loyal goods for 1 productItems = 4 ms
  455. 17.07 14:58:01.662 INFO  [LoyalCalculatorConverter] Time converting 1 positions = 0 ms
  456. 17.07 14:58:01.663 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_PAYMENT send event to frontend: FORM_CHECK_PUT
  457. 17.07 14:58:01.663 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"form.check.put","payload":{"check":{"discount":{"value":"0.00","percentValue":"0.00","cardEnabled":true},"checkSum":"3000.00","positions":[{"itemId":1,"name":"ТОВ370155","quantity":"1","measure":"Шт.","sum":"3000.00","item":"ТОВ370155","barcode":"0686603100493","marked":false,"positionCouponEnabled":false,"manualDiscountEnabled":false}],"positionCouponEnabled":false,"manualDiscountEnabled":false},"buttons":[{"text":"ОПЛАТИТЬ","callback":{"type":"form.sale.check.paymentRun","payload":{}}}]}}
  458. 17.07 14:58:01.664 INFO  [AbstractExtraEventProcessor] [Main-event-thread] CdForwardExtraProcessor sends event CashEvent [eventType='cd.check.put', canProcessed='true', pld='ru.crystals.pos.touch2.customerdisplay.payload.CdCheckPutPld@e4ca00']
  459. 17.07 14:58:01.664 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_PAYMENT send event to frontend: CD_CHECK_PUT
  460. 17.07 14:58:01.664 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_PAYMENT receive event: TechProcessEvent.eventOnlineMode
  461. 17.07 14:58:01.665 INFO  [AbstractEventSender] [Internal-Cash-Pool-Executor_34] StatusBarEventSender sends event CashEvent [eventType='form.notice.clear', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.EmptyPld@c2c5da']
  462. 17.07 14:58:01.694 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"form.notice.clear","payload":{}}
  463. 17.07 14:58:01.695 INFO  [AbstractEventSender] [Internal-Cash-Pool-Executor_34] AdditionalMenuEventSender sends event CashEvent [eventType='additionalMenu.configuration', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.additionalmenu.AdditionalMenuConfigurationPld@e4f49e']
  464. 17.07 14:58:01.695 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"additionalMenu.configuration","payload":{"goodsFindIconEnabled":true,"printDocumentIconEnabled":true,"functionMenuIconEnabled":true,"infoMenuIconEnabled":true}}
  465. 17.07 14:58:02.925 INFO  [FiscalPrinter] getPrinterState
  466. 17.07 14:58:02.925 DEBUG [BaseConnector] --> PiritRequestPacket{Id=37, Cmd=GET_PRINTER_STATE(04), data={1C}}
  467. 17.07 14:58:02.966 DEBUG [BaseConnector] <-- PiritResponsePacket{Id=37, Cmd=GET_PRINTER_STATE(04), data=new String[]{"04000"}}
  468. 17.07 14:58:06.627 TRACE [AbstractWSEP] [qtp9446531-325] WS-session receive: {"type":"sd.tab.ftile.click","payload":{"tileId":"AEROFLOT_BONUSES_PLUGIN_ID"}}
  469. 17.07 14:58:06.628 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_PAYMENT receive event: SD_TAB_FTILE_CLICK
  470. 17.07 14:58:06.630 INFO  [AbstractEventsFilter] [Main-event-thread] ProcessorEventsFilter starts processor 63dd538d-7319-4ec7-b8cc-8623287be0e2 with event CashEvent [eventType='form.functionMenu.menu.selected', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.functionmenu.FunctionMenuMenuSelectedPld@198f54d']
  471. 17.07 14:58:06.630 TRACE [AbstractEventProcessor] [Main-event-thread] Stop processor: Type:SALE_PAYMENT, prevPT=SALE_SUBTOTAL
  472. 17.07 14:58:06.630 TRACE [AbstractEventProcessor] [Main-event-thread] Start processor: AEROFLOT_BONUSES_PLUGIN_ID:63dd538d-7319-4ec7-b8cc-8623287be0e2, prevPT=SALE_PAYMENT
  473. 17.07 14:58:06.631 TRACE [AbstractEventProcessor] [Main-event-thread] AEROFLOT_BONUSES_PLUGIN_ID:63dd538d-7319-4ec7-b8cc-8623287be0e2 receive event: FORM_FUNCTIONMENU_MENU_SELECTED
  474. 17.07 14:58:06.631 TRACE [AbstractEventProcessor] [Main-event-thread] AEROFLOT_BONUSES_PLUGIN_ID:63dd538d-7319-4ec7-b8cc-8623287be0e2 send event to frontend: FORM_SALE_CARD_MANUAL_INPUT_SHOW
  475. 17.07 14:58:06.631 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"form.sale.card.manualInput.show","payload":{"inputTitle":"Введите номер карты Аэрофлот Бонус","inputType":"NUMBER","inputLength":10,"buttons":[],"text":"Или отсканируйте карту."}}
  476. 17.07 14:58:07.925 INFO  [FiscalPrinter] getPrinterState
  477. 17.07 14:58:07.926 DEBUG [BaseConnector] --> PiritRequestPacket{Id=38, Cmd=GET_PRINTER_STATE(04), data={1C}}
  478. 17.07 14:58:07.965 DEBUG [BaseConnector] <-- PiritResponsePacket{Id=38, Cmd=GET_PRINTER_STATE(04), data=new String[]{"04000"}}
  479. 17.07 14:58:12.926 INFO  [FiscalPrinter] getPrinterState
  480. 17.07 14:58:12.927 DEBUG [BaseConnector] --> PiritRequestPacket{Id=39, Cmd=GET_PRINTER_STATE(04), data={1C}}
  481. 17.07 14:58:12.960 DEBUG [BaseConnector] <-- PiritResponsePacket{Id=39, Cmd=GET_PRINTER_STATE(04), data=new String[]{"04000"}}
  482. 17.07 14:58:17.927 INFO  [FiscalPrinter] getPrinterState
  483. 17.07 14:58:17.949 DEBUG [BaseConnector] --> PiritRequestPacket{Id=40, Cmd=GET_PRINTER_STATE(04), data={1C}}
  484. 17.07 14:58:17.992 DEBUG [BaseConnector] <-- PiritResponsePacket{Id=40, Cmd=GET_PRINTER_STATE(04), data=new String[]{"04000"}}
  485. 17.07 14:58:19.009 TRACE [AbstractWSEP] [qtp9446531-283] WS-session receive: {"type":"form.sale.card.manualInput.put","payload":{"data":"101735686","inputType":"NUMBER","accepted":true}}
  486. 17.07 14:58:19.010 TRACE [AbstractEventProcessor] [Main-event-thread] AEROFLOT_BONUSES_PLUGIN_ID:63dd538d-7319-4ec7-b8cc-8623287be0e2 receive event: FORM_SALE_CARD_MANUAL_INPUT_PUT
  487. 17.07 14:58:19.011 INFO  [AeroflotBonusesPlugin] [Main-event-thread] onCardInput 101735686
  488. 17.07 14:58:19.011 TRACE [AbstractEventProcessor] [Main-event-thread] AEROFLOT_BONUSES_PLUGIN_ID:63dd538d-7319-4ec7-b8cc-8623287be0e2 send event to frontend: FORM_WAIT_SHOW
  489. 17.07 14:58:19.012 INFO  [AeroflotBonusesServiceImpl] Receive aeroflot bonuses for card = '101735686' from processing = 'SiebelServiceImpl'
  490. 17.07 14:58:19.012 INFO  [PurchaseToOrderMapper] Updating Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0} to ru.crystals.siebel.wsclient.Order@12615eb
  491. 17.07 14:58:19.012 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"form.wait.show","payload":{"text":["Ожидайте завершения операции..."],"fadeInTime":1,"timeout":120}}
  492. 17.07 14:58:19.012 INFO  [PositionToOrderItemMapper] Updating Position:[id=663;number=1;item=ТОВ370155;count=1000;sum=300000] to ru.crystals.siebel.wsclient.OrderItem@66f04e
  493. 17.07 14:58:19.013 INFO  [PurchaseToOrderMapper] Can't get discount list: no discount position.
  494. 17.07 14:58:19.013 INFO  [SiebelAeroflotBonusService] determMileSum orderRequest: Order[
  495.  orderHeader=OrderHeader[
  496.       shopIndex=902
  497.       slipText=<null>
  498.       shiftNumber=40
  499.       cardNumber="101735686"
  500.       cardPayment=<null>
  501.       posType="POS"
  502.       cashNumber=4
  503.       chequeSum=3000.00
  504.       operation=0
  505.       issueCard=<null>
  506.       chequeNumber=6
  507.       errorText=<null>
  508.       errorCode=<null>
  509.       dateOperation="17/07/2019 14:57"
  510.       cashierNumber=<null>
  511.       cashierMessage=<null>
  512.       bonusAmt=<null>
  513.       listOfOrderItem=ListOfOrderItem[
  514.           orderItem=[OrderItem[
  515.               item="ТОВ370155"
  516.               quant=1.000
  517.               priceDisc=3000.00
  518.               price=3000.00
  519.               numKit=<null>
  520.               minPrice=0
  521.               posNumber=1
  522.               posSum=3000.00
  523.               discSum=0.00
  524.               bonusSum=<null>
  525.               barcode="0686603100493"
  526.             ]]
  527.         ]
  528.       listOfPayments=ListOfPayments[
  529.           orderPay=[
  530.         ]
  531.       listOfCard=ListOfCard[
  532.           cards=[Cards[
  533.               cardNum="0003000189254565"
  534.               cardType=1
  535.             ]]
  536.         ]
  537.       listOfDisc=ListOfDisc[
  538.           orderDisc=<null>
  539.         ]
  540.       listOfLoyOptionProduct=<null>
  541.       mainOrder=<null>
  542.     ]
  543. ]
  544. 17.07 14:58:19.584 INFO  [SiebelAeroflotBonusService] determMileSum orderResponse: Order[
  545.   orderHeader=OrderHeader[
  546.       shopIndex=902
  547.       slipText=<null>
  548.       shiftNumber=40
  549.       cardNumber="101735686"
  550.       cardPayment=2999
  551.       posType="POS"
  552.       cashNumber=4
  553.       chequeSum=3000.00
  554.       operation=0
  555.       issueCard=<null>
  556.       chequeNumber=6
  557.       errorText=<null>
  558.       errorCode=<null>
  559.       dateOperation="17/07/2019 14:57"
  560.       cashierNumber=<null>
  561.       cashierMessage="Сумма чека, которую можно оплатить милями:
  562. 9987 миль = 2999 руб."
  563.       bonusAmt=3.33
  564.       listOfOrderItem=ListOfOrderItem[
  565.           orderItem=[OrderItem[
  566.               item="ТОВ370155"
  567.               quant=1.000
  568.               priceDisc=3000.00
  569.               price=3000.00
  570.               numKit=<null>
  571.               minPrice=0
  572.               posNumber=1
  573.               posSum=3000.00
  574.               discSum=0.00
  575.               bonusSum=2999
  576.               barcode="0686603100493"
  577.             ]]
  578.         ]
  579.       listOfPayments=<null>
  580.       listOfCard=ListOfCard[
  581.           cards=[Cards[
  582.               cardNum="0003000189254565"
  583.               cardType=1
  584.             ]]
  585.         ]
  586.       listOfDisc=<null>
  587.       listOfLoyOptionProduct=<null>
  588.       mainOrder=<null>
  589.     ]
  590. ]
  591. 17.07 14:58:19.585 TRACE [AbstractEventProcessor] [Main-event-thread] AEROFLOT_BONUSES_PLUGIN_ID:63dd538d-7319-4ec7-b8cc-8623287be0e2 send event to frontend: FORM_WAIT_CLOSE
  592. 17.07 14:58:19.585 TRACE [AbstractEventProcessor] [Main-event-thread] AEROFLOT_BONUSES_PLUGIN_ID:63dd538d-7319-4ec7-b8cc-8623287be0e2 send event to frontend: FORM_POPAP_INFO
  593. 17.07 14:58:19.586 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"form.wait.close","payload":{}}
  594. 17.07 14:58:19.587 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"form.popap.info","payload":{"imageId":"INFO","text":["Сумма чека, которую можно оплатить милями: 9986 миль = 2998.80 руб."],"buttons":[{"text":"OK","callback":{"type":"dynamic.803730ab-d2e5-4c48-9237-032e96c71e51.dynamic","payload":{}}}],"areaOutside":{"type":"dynamic.803730ab-d2e5-4c48-9237-032e96c71e51.dynamic","payload":{}}}}
  595. 17.07 14:58:21.803 TRACE [AbstractWSEP] [qtp9446531-285] WS-session receive: {"type":"dynamic.803730ab-d2e5-4c48-9237-032e96c71e51.dynamic","payload":{}}
  596. 17.07 14:58:21.805 TRACE [AbstractEventProcessor] [Main-event-thread] AEROFLOT_BONUSES_PLUGIN_ID:63dd538d-7319-4ec7-b8cc-8623287be0e2 receive event: dynamic.803730ab-d2e5-4c48-9237-032e96c71e51.dynamic
  597. 17.07 14:58:21.805 TRACE [AbstractEventProcessor] [Main-event-thread] AEROFLOT_BONUSES_PLUGIN_ID:63dd538d-7319-4ec7-b8cc-8623287be0e2 send event to frontend: FORM_SALE_CHECK_WRITEOFFBONUSES_SHOW
  598. 17.07 14:58:21.806 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"form.check.writeOffBonuses.show","payload":{"upperHeader":"Списание милей Аэрофлот","bottomHeader":"К списанию (мин. 1)","buttonName":"Списать","maxSum":"9986","defaultSum":"9986","checkSum":"9986","minSum":"1","buttonEnabled":true,"closeEnabled":true,"numpadWithComma":false}}
  599. 17.07 14:58:22.546 INFO  [DocumentSender] ping = true
  600. 17.07 14:58:22.927 INFO  [FiscalPrinter] getPrinterState
  601. 17.07 14:58:22.928 DEBUG [BaseConnector] --> PiritRequestPacket{Id=41, Cmd=GET_PRINTER_STATE(04), data={1C}}
  602. 17.07 14:58:22.958 DEBUG [BaseConnector] <-- PiritResponsePacket{Id=41, Cmd=GET_PRINTER_STATE(04), data=new String[]{"04000"}}
  603. 17.07 14:58:23.436 TRACE [AbstractWSEP] [qtp9446531-289] WS-session receive: {"type":"form.check.writeOffBonuses.put","payload":{"sumToPay":"9986"}}
  604. 17.07 14:58:23.438 TRACE [AbstractEventProcessor] [Main-event-thread] AEROFLOT_BONUSES_PLUGIN_ID:63dd538d-7319-4ec7-b8cc-8623287be0e2 receive event: FORM_SALE_CHECK_WRITEOFFBONUSES_PUT
  605. 17.07 14:58:23.438 TRACE [AbstractEventProcessor] [Main-event-thread] AEROFLOT_BONUSES_PLUGIN_ID:63dd538d-7319-4ec7-b8cc-8623287be0e2 send event to frontend: FORM_SALE_CARD_MANUAL_INPUT_SHOW
  606. 17.07 14:58:23.439 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"form.sale.card.manualInput.show","payload":{"inputTitle":"Введите пин-код","inputType":"NUMBER","inputLength":4,"buttons":[]}}
  607. 17.07 14:58:26.615 TRACE [AbstractWSEP] [qtp9446531-288] WS-session receive: {"type":"form.sale.card.manualInput.put","payload":{"data":"6258","inputType":"NUMBER","accepted":true}}
  608. 17.07 14:58:26.616 TRACE [AbstractEventProcessor] [Main-event-thread] AEROFLOT_BONUSES_PLUGIN_ID:63dd538d-7319-4ec7-b8cc-8623287be0e2 receive event: FORM_SALE_CARD_MANUAL_INPUT_PUT
  609. 17.07 14:58:26.617 TRACE [AbstractEventProcessor] [Main-event-thread] AEROFLOT_BONUSES_PLUGIN_ID:63dd538d-7319-4ec7-b8cc-8623287be0e2 send event to frontend: FORM_WAIT_SHOW
  610. 17.07 14:58:26.617 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"form.wait.show","payload":{"text":["Ожидайте завершения операции..."],"fadeInTime":1,"timeout":120}}
  611. 17.07 14:58:26.620 INFO  [AeroflotBonusesServiceImpl] Send authPoints request = '{"id":"010090200004000401563364706618","terminal":"crystal","location":"azbukavkusa","partnerId":1416961,"track1":null,"track2":null,"track3":null,"barCode":null,"pan":"101735686","hash":null,"gcdata":null,"cardholder":null,"phone":null,"dateTime":"20190717145826","extensions":{"item":[{"type":"CHEQUE_MSG_REQ","critical":"Y","params":{"item":[{"name":"MSG_REQ","value":"Y"}]}},{"type":"PURCHASE_EXT_PARAMS","critical":"Y","params":{"item":[{"name":"RECEIPT","value":"020090200004000401563364706618"},{"name":"PINCODE","value":"f3df74b7c45eb1d20cd862ed9401896ea55ab8b9"},{"name":"NONCE","value":"030090200004000401563364706617"},{"name":"MILES","value":"9986"}]}}]}}'
  612. 17.07 14:58:27.928 INFO  [FiscalPrinter] getPrinterState
  613. 17.07 14:58:27.928 DEBUG [BaseConnector] --> PiritRequestPacket{Id=42, Cmd=GET_PRINTER_STATE(04), data={1C}}
  614. 17.07 14:58:27.970 DEBUG [BaseConnector] <-- PiritResponsePacket{Id=42, Cmd=GET_PRINTER_STATE(04), data=new String[]{"04000"}}
  615. 17.07 14:58:28.822 DEBUG [TechProcessImpl] Server online mode
  616. 17.07 14:58:29.363 INFO  [AeroflotBonusesServiceImpl] Receive authPoints response code = '0', description = 'null'
  617. 17.07 14:58:29.396 TRACE [AbstractEventProcessor] [Main-event-thread] AEROFLOT_BONUSES_PLUGIN_ID:63dd538d-7319-4ec7-b8cc-8623287be0e2 send event to frontend: FORM_WAIT_CLOSE
  618. 17.07 14:58:29.396 TRACE [AbstractEventProcessor] [Main-event-thread] Exit (imm) from 'AEROFLOT_BONUSES_PLUGIN_ID:63dd538d-7319-4ec7-b8cc-8623287be0e2' and start (imm) previous 'SALE_PAYMENT'
  619. 17.07 14:58:29.396 TRACE [AbstractEventProcessor] [Main-event-thread] AEROFLOT_BONUSES_PLUGIN_ID:63dd538d-7319-4ec7-b8cc-8623287be0e2 start (imm) this SALE_PAYMENT with e=INNER_PROCESSOR_EXIT
  620. 17.07 14:58:29.396 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"form.wait.close","payload":{}}
  621. 17.07 14:58:29.397 TRACE [AbstractEventProcessor] [Main-event-thread] Stop processor: AEROFLOT_BONUSES_PLUGIN_ID:63dd538d-7319-4ec7-b8cc-8623287be0e2, prevPT=SALE_PAYMENT
  622. 17.07 14:58:29.397 TRACE [AbstractEventProcessor] [Main-event-thread] Start processor: Type:SALE_PAYMENT, prevPT=SALE_SUBTOTAL
  623. 17.07 14:58:29.408 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductJewelController
  624. 17.07 14:58:29.408 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductClothingController
  625. 17.07 14:58:29.408 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductCFTGiftCardController
  626. 17.07 14:58:29.409 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductBonusPointsController
  627. 17.07 14:58:29.409 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductMetricController
  628. 17.07 14:58:29.409 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductMobilePayController
  629. 17.07 14:58:29.409 INFO  [AbstractExtraEventProcessor] [Main-event-thread] SaleTabExtraProcessor sends event CashEvent [eventType='sd.show', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.EmptyPld@c2c5da']
  630. 17.07 14:58:29.409 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_PAYMENT send event to frontend: SD_SHOW
  631. 17.07 14:58:29.410 INFO  [AbstractExtraEventProcessor] [Main-event-thread] SaleTabExtraProcessor sends event CashEvent [eventType='sd.tab.put', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.tab.SdTabPutPld@18b63bc']
  632. 17.07 14:58:29.410 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_PAYMENT send event to frontend: SD_TAB_PUT
  633. 17.07 14:58:29.410 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"sd.show","payload":{}}
  634. 17.07 14:58:29.410 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"sd.tab.put","payload":{"tabs":[{"name":"ПРОДАЖА","tabId":"7d7eff3f-4033-421f-b853-3635be8129bc"},{"name":"Кафе","tabId":"fbe54aae-58b5-460c-b4cd-461a531f9f82"}]}}
  635. 17.07 14:58:29.412 INFO  [AbstractExtraEventProcessor] [Main-event-thread] SaleTabExtraProcessor sends event CashEvent [eventType='sd.tab.tile.put', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.tab.SdTabTilePutPld@c6098a']
  636. 17.07 14:58:29.412 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_PAYMENT send event to frontend: SD_TAB_TILE_PUT
  637. 17.07 14:58:29.412 INFO  [AbstractExtraEventProcessor] [Main-event-thread] AvCardInfoExtraProcessor sends event CashEvent [eventType='av.sale.card.info', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.sale.avcard.FormSaleCardInfoPld@2de7d8']
  638. 17.07 14:58:29.413 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_PAYMENT send event to frontend: AV_SALE_CARD_INFO
  639. 17.07 14:58:29.412 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"sd.tab.tile.put","payload":{"type":"F","client":"AV","tiles":[{"tileId":"CARD_CHECK_SIEBEL","index":2,"name":"Проверка карты Вкусомания","iconId":"CARD","enabled":true,"callback":{"type":"sd.tab.ftile.click","payload":{"tileId":"CARD_CHECK_SIEBEL"}},"state":"none"},{"tileId":"SEARCH","index":3,"name":"Поиск товаров","iconId":"SEARCH","enabled":true,"callback":{"type":"sd.tab.ftile.click","payload":{"tileId":"SEARCH"}},"state":"none"},{"tileId":"SOFT_CHECK_PLUGIN_ID","index":6,"name":"Вызов мягкого чека","iconId":"DOCUMENT","enabled":false,"callback":{"type":"sd.tab.ftile.click","payload":{"tileId":"SOFT_CHECK_PLUGIN_ID"}},"state":"none"},{"tileId":"OFD_CLIENT_PLUGIN","index":7,"name":"Отправить чек покупателю","iconId":"PAPER_PLANE","enabled":true,"callback":{"type":"sd.tab.ftile.click","payload":{"tileId":"OFD_CLIENT_PLUGIN"}},"state":"none"},{"tileId":"PURCHASE_CANCEL_PLUGIN_ID","index":12,"name":"Аннулировать чек","iconId":"CANCEL","enabled":true,"callback":{"type":"sd.tab.ftile.click","payload":{"tileId":"PURCHASE_CANCEL_PLUGIN_ID"}},"state":"none"},{"tileId":"CASH_DRAWER_OPEN_PLUGIN_ID","index":14,"name":"Открыть денежный ящик","iconId":"LOCK","enabled":false,"callback":{"type":"sd.tab.ftile.click","payload":{"tileId":"CASH_DRAWER_OPEN_PLUGIN_ID"}},"state":"none"},{"tileId":"AEROFLOT_BONUSES_PLUGIN_ID","index":15,"name":"Списать мили","iconId":"AEROFLOT_BONUSES","enabled":false,"callback":{"type":"sd.tab.ftile.click","payload":{"tileId":"AEROFLOT_BONUSES_PLUGIN_ID"}},"state":"none"}],"showCard":true}}
  640. 17.07 14:58:29.413 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"av.sale.card.info","payload":{"cardNumber":"000100******7670","bonusVal":"3920074.74","bonusRub":"39200.74","mark":"4024.85"}}
  641. 17.07 14:58:29.421 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductJewelController
  642. 17.07 14:58:29.422 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductClothingController
  643. 17.07 14:58:29.422 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductCFTGiftCardController
  644. 17.07 14:58:29.422 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductBonusPointsController
  645. 17.07 14:58:29.422 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductMetricController
  646. 17.07 14:58:29.423 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductMobilePayController
  647. 17.07 14:58:29.423 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_PAYMENT send event to frontend: FORM_CHECK_PUT
  648. 17.07 14:58:29.424 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"form.check.put","payload":{"check":{"discount":{"value":"0.00","percentValue":"0.00","cardEnabled":true},"checkSum":"3000.00","positions":[{"itemId":1,"name":"ТОВ370155","quantity":"1","measure":"Шт.","sum":"3000.00","item":"ТОВ370155","barcode":"0686603100493","marked":false,"positionCouponEnabled":false,"manualDiscountEnabled":false}],"positionCouponEnabled":false,"manualDiscountEnabled":false},"buttons":[{"text":"ОПЛАТИТЬ","callback":{"type":"form.sale.check.paymentRun","payload":{}}}]}}
  649. 17.07 14:58:29.424 INFO  [AbstractExtraEventProcessor] [Main-event-thread] CdForwardExtraProcessor sends event CashEvent [eventType='cd.check.put', canProcessed='true', pld='ru.crystals.pos.touch2.customerdisplay.payload.CdCheckPutPld@1cf3359']
  650. 17.07 14:58:29.424 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_PAYMENT send event to frontend: CD_CHECK_PUT
  651. 17.07 14:58:29.424 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_PAYMENT receive event: INNER_PROCESSOR_EXIT
  652. 17.07 14:58:29.425 TRACE [AbstractEventProcessor] [Main-event-thread] AEROFLOT_BONUSES_PLUGIN_ID:63dd538d-7319-4ec7-b8cc-8623287be0e2 start this SALE_SUBTOTAL with e=FORM_SALE_CHECK_SUBTOTALRUN
  653. 17.07 14:58:29.425 INFO  [AbstractEventsFilter] [Main-event-thread] ProcessorEventsFilter starts processor SALE_SUBTOTAL with event CashEvent [eventType='form.sale.check.subtotalRun', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.EmptyPld@c2c5da']
  654. 17.07 14:58:29.425 INFO  [AbstractEventSender] [Internal-Cash-Pool-Executor_30] StatusBarEventSender sends event CashEvent [eventType='form.notice.clear', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.EmptyPld@c2c5da']
  655. 17.07 14:58:29.425 TRACE [AbstractEventProcessor] [Main-event-thread] Stop processor: Type:SALE_PAYMENT, prevPT=SALE_SUBTOTAL
  656. 17.07 14:58:29.425 TRACE [AbstractEventProcessor] [Main-event-thread] Start processor: Type:SALE_SUBTOTAL, prevPT=SALE_PAYMENT
  657. 17.07 14:58:29.426 INFO  [AbstractExtraEventProcessor] [Main-event-thread] SaleTabExtraProcessor sends event CashEvent [eventType='sd.show', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.EmptyPld@c2c5da']
  658. 17.07 14:58:29.426 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL send event to frontend: SD_SHOW
  659. 17.07 14:58:29.426 INFO  [AbstractEventSender] [Internal-Cash-Pool-Executor_30] AdditionalMenuEventSender sends event CashEvent [eventType='additionalMenu.configuration', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.additionalmenu.AdditionalMenuConfigurationPld@6f606f']
  660. 17.07 14:58:29.426 INFO  [AbstractExtraEventProcessor] [Main-event-thread] SaleTabExtraProcessor sends event CashEvent [eventType='sd.tab.put', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.tab.SdTabPutPld@1c833']
  661. 17.07 14:58:29.426 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL send event to frontend: SD_TAB_PUT
  662. 17.07 14:58:29.426 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"form.notice.clear","payload":{}}
  663. 17.07 14:58:29.427 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"sd.show","payload":{}}
  664. 17.07 14:58:29.427 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"additionalMenu.configuration","payload":{"goodsFindIconEnabled":true,"printDocumentIconEnabled":true,"functionMenuIconEnabled":true,"infoMenuIconEnabled":true}}
  665. 17.07 14:58:29.428 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"sd.tab.put","payload":{"tabs":[{"name":"ПРОДАЖА","tabId":"7d7eff3f-4033-421f-b853-3635be8129bc"},{"name":"Кафе","tabId":"fbe54aae-58b5-460c-b4cd-461a531f9f82"}]}}
  666. 17.07 14:58:29.435 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductJewelController
  667. 17.07 14:58:29.436 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductClothingController
  668. 17.07 14:58:29.436 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductCFTGiftCardController
  669. 17.07 14:58:29.436 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductBonusPointsController
  670. 17.07 14:58:29.436 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductMetricController
  671. 17.07 14:58:29.437 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductMobilePayController
  672. 17.07 14:58:29.437 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL send event to frontend: FORM_CHECK_PUT
  673. 17.07 14:58:29.437 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"form.check.put","payload":{"check":{"discount":{"value":"0.00","percentValue":"0.00","cardEnabled":true},"checkSum":"3000.00","positions":[{"itemId":1,"name":"ТОВ370155","quantity":"1","measure":"Шт.","sum":"3000.00","item":"ТОВ370155","barcode":"0686603100493","marked":false,"positionCouponEnabled":false,"manualDiscountEnabled":false}],"positionCouponEnabled":false,"manualDiscountEnabled":false},"buttons":[{"text":"РАССЧИТАТЬ","callback":{"type":"form.sale.check.subtotalRun","payload":{}}}]}}
  674. 17.07 14:58:29.438 INFO  [AbstractExtraEventProcessor] [Main-event-thread] CdForwardExtraProcessor sends event CashEvent [eventType='cd.check.put', canProcessed='true', pld='ru.crystals.pos.touch2.customerdisplay.payload.CdCheckPutPld@13c452d']
  675. 17.07 14:58:29.438 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL send event to frontend: CD_CHECK_PUT
  676. 17.07 14:58:29.438 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL receive event: FORM_SALE_CHECK_SUBTOTALRUN
  677. 17.07 14:58:29.439 TRACE [SaleSubtotalProcessor] [Main-event-thread] SaleSubtotalScenario.rollbackLoyTransaction:in
  678. 17.07 14:58:29.439 INFO  [AbstractEventSender] [Internal-Cash-Pool-Executor_25] StatusBarEventSender sends event CashEvent [eventType='form.notice.clear', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.EmptyPld@c2c5da']
  679. 17.07 14:58:29.440 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"form.notice.clear","payload":{}}
  680. 17.07 14:58:29.442 INFO  [AbstractEventSender] [Internal-Cash-Pool-Executor_25] AdditionalMenuEventSender sends event CashEvent [eventType='additionalMenu.configuration', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.additionalmenu.AdditionalMenuConfigurationPld@1ef78bf']
  681. 17.07 14:58:29.443 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"additionalMenu.configuration","payload":{"goodsFindIconEnabled":true,"printDocumentIconEnabled":true,"functionMenuIconEnabled":true,"infoMenuIconEnabled":true}}
  682. 17.07 14:58:29.451 TRACE [SaleSubtotalProcessor] [Main-event-thread] SaleSubtotalScenario.rollbackLoyTransaction:out
  683. 17.07 14:58:29.452 TRACE [SaleSubtotalProcessor] [Main-event-thread] SaleSubtotalScenario.updateLoyaltyArguments:in
  684. 17.07 14:58:29.452 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL send event to frontend: FORM_POPAP_INFO_CLOSE
  685. 17.07 14:58:29.452 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL send event to frontend: FORM_WAIT_SHOW
  686. 17.07 14:58:29.452 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"form.popap.info.close","payload":{}}
  687. 17.07 14:58:29.453 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL start (imm) this SIEBEL_RANGES with e=null
  688. 17.07 14:58:29.453 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_6] Event to frontend 1: {"type":"form.wait.show","payload":{"text":["Подождите, идет расчет скидок"],"fadeInTime":1,"timeout":120}}
  689. 17.07 14:58:29.453 TRACE [AbstractEventProcessor] [Main-event-thread] Stop processor: Type:SALE_SUBTOTAL, prevPT=SALE_PAYMENT
  690. 17.07 14:58:29.453 TRACE [AbstractEventProcessor] [Main-event-thread] Start processor: [SIEBEL_RANGES], prevPT=SALE_SUBTOTAL
  691. 17.07 14:58:29.464 DEBUG [SiebelRangesPlugin] [Main-event-thread] Siebel loyalty (ranges): process arguments, step No1, Start
  692. 17.07 14:58:29.464 DEBUG [SiebelRangesPlugin] [Main-event-thread] Siebel loyalty (ranges): process arguments, step No1, End
  693. 17.07 14:58:29.465 TRACE [SaleSubtotalProcessor] [Main-event-thread] SaleSubtotalScenario.updateLoyaltyArguments:out
  694. 17.07 14:58:29.465 TRACE [TechProcessImpl] Start warn divide alco
  695. 17.07 14:58:29.465 TRACE [TechProcessImpl] End warn devide alco
  696. 17.07 14:58:29.465 INFO  [TechProcessImpl] goToDiscounts
  697. 17.07 14:58:29.476 INFO  [LoyalBridgeServiceImpl] --------------- begin discount calculation ---------------
  698. 17.07 14:58:29.481 INFO  [LoyalProductFinder] Time finding items (1) = 5 ms
  699. 17.07 14:58:29.481 INFO  [LoyalProductsConverter] Time searching loyal goods for 1 productItems = 5 ms
  700. 17.07 14:58:29.481 INFO  [LoyalCalculatorConverter] Time converting 1 positions = 0 ms
  701. 17.07 14:58:29.481 INFO  [SiebelServiceImpl] Trying to calculate discounts via Siebel CRM. Purchase: PurchaseEntity [id=651, number=null, dateCreate=Wed Jul 17 14:57:20 MSK 2019, dateCommit=null, fiscalDocNum=null, sentToServerStatus=NO_SENT]
  702. 17.07 14:58:29.482 INFO  [SiebelServiceImpl] Mapping check [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}] to order
  703. 17.07 14:58:29.482 INFO  [PurchaseToOrderMapper] Updating Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0} to ru.crystals.siebel.wsclient.Order@1d762d9
  704. 17.07 14:58:29.483 INFO  [PositionToOrderItemMapper] Updating Position:[id=663;number=1;item=ТОВ370155;count=1000;sum=300000] to ru.crystals.siebel.wsclient.OrderItem@1cb1f4c
  705. 17.07 14:58:29.483 INFO  [PurchaseToOrderMapper] Can't get discount list: no discount position.
  706. 17.07 14:58:29.483 INFO  [SiebelServiceImpl] orderRequest: Order[
  707.  orderHeader=OrderHeader[
  708.       shopIndex=902
  709.       slipText=<null>
  710.       shiftNumber=40
  711.       cardNumber=<null>
  712.       cardPayment=<null>
  713.       posType=<null>
  714.       cashNumber=4
  715.       chequeSum=3000.00
  716.       operation=0
  717.       issueCard=<null>
  718.       chequeNumber=6
  719.       errorText=<null>
  720.       errorCode=<null>
  721.       dateOperation="17/07/2019 14:57"
  722.       cashierNumber=<null>
  723.       cashierMessage=<null>
  724.       bonusAmt=<null>
  725.       listOfOrderItem=ListOfOrderItem[
  726.           orderItem=[OrderItem[
  727.               item="ТОВ370155"
  728.               quant=1.000
  729.               priceDisc=3000.00
  730.               price=3000.00
  731.               numKit=<null>
  732.               minPrice=0
  733.               posNumber=1
  734.               posSum=3000.00
  735.               discSum=0.00
  736.               bonusSum=<null>
  737.               barcode="0686603100493"
  738.             ]]
  739.         ]
  740.       listOfPayments=<null>
  741.       listOfCard=ListOfCard[
  742.           cards=[Cards[
  743.               cardNum="0003000189254565"
  744.               cardType=1
  745.             ]]
  746.         ]
  747.       listOfDisc=ListOfDisc[
  748.           orderDisc=<null>
  749.         ]
  750.       listOfLoyOptionProduct=<null>
  751.       mainOrder=<null>
  752.     ]
  753. ]
  754. 17.07 14:58:29.484 INFO  [SiebelServiceImpl] calculateOrder request: Order[
  755.   orderHeader=OrderHeader[
  756.       shopIndex=902
  757.       slipText=<null>
  758.       shiftNumber=40
  759.       cardNumber=<null>
  760.       cardPayment=<null>
  761.       posType=<null>
  762.       cashNumber=4
  763.       chequeSum=3000.00
  764.       operation=0
  765.       issueCard=<null>
  766.       chequeNumber=6
  767.       errorText=<null>
  768.       errorCode=<null>
  769.       dateOperation="17/07/2019 14:57"
  770.       cashierNumber=<null>
  771.       cashierMessage=<null>
  772.       bonusAmt=<null>
  773.       listOfOrderItem=ListOfOrderItem[
  774.           orderItem=[OrderItem[
  775.               item="ТОВ370155"
  776.               quant=1.000
  777.               priceDisc=3000.00
  778.               price=3000.00
  779.               numKit=<null>
  780.               minPrice=0
  781.               posNumber=1
  782.               posSum=3000.00
  783.               discSum=0.00
  784.               bonusSum=<null>
  785.               barcode="0686603100493"
  786.             ]]
  787.         ]
  788.       listOfPayments=<null>
  789.       listOfCard=ListOfCard[
  790.           cards=[Cards[
  791.               cardNum="0003000189254565"
  792.               cardType=1
  793.             ]]
  794.         ]
  795.       listOfDisc=ListOfDisc[
  796.           orderDisc=<null>
  797.         ]
  798.       listOfLoyOptionProduct=<null>
  799.       mainOrder=<null>
  800.     ]
  801. ]
  802. 17.07 14:58:29.484 INFO  [SiebelServiceImpl] calculateOrder response: Order[
  803.   orderHeader=OrderHeader[
  804.       shopIndex=902
  805.       slipText=<null>
  806.       shiftNumber=40
  807.       cardNumber=<null>
  808.       cardPayment=<null>
  809.       posType=<null>
  810.       cashNumber=4
  811.       chequeSum=3000.00
  812.       operation=0
  813.       issueCard=<null>
  814.       chequeNumber=6
  815.       errorText=<null>
  816.       errorCode=<null>
  817.       dateOperation="17/07/2019 14:57"
  818.       cashierNumber=<null>
  819.       cashierMessage=<null>
  820.       bonusAmt=<null>
  821.       listOfOrderItem=ListOfOrderItem[
  822.           orderItem=[OrderItem[
  823.               item="ТОВ370155"
  824.               quant=1.000
  825.               priceDisc=3000.00
  826.               price=3000.00
  827.               numKit=<null>
  828.               minPrice=0
  829.               posNumber=1
  830.               posSum=3000.00
  831.               discSum=0.00
  832.               bonusSum=<null>
  833.               barcode="0686603100493"
  834.             ]]
  835.         ]
  836.       listOfPayments=<null>
  837.       listOfCard=ListOfCard[
  838.           cards=[Cards[
  839.               cardNum="0003000189254565"
  840.               cardType=1
  841.             ]]
  842.         ]
  843.       listOfDisc=ListOfDisc[
  844.           orderDisc=[
  845.         ]
  846.       listOfLoyOptionProduct=<null>
  847.       mainOrder=<null>
  848.     ]
  849. ]
  850. 17.07 14:58:29.485 INFO  [SiebelServiceImpl] Need determ tokens for check [PurchaseEntity [id=651, number=null, dateCreate=Wed Jul 17 14:57:20 MSK 2019, dateCommit=null, fiscalDocNum=null, sentToServerStatus=NO_SENT]]
  851. 17.07 14:58:29.485 INFO  [SiebelTokenService] determBonusSum(tokens) orderRequest: Order[
  852.   orderHeader=OrderHeader[
  853.       shopIndex=902
  854.       slipText=<null>
  855.       shiftNumber=40
  856.       cardNumber=<null>
  857.       cardPayment=<null>
  858.       posType=<null>
  859.       cashNumber=4
  860.       chequeSum=3000
  861.       operation=1
  862.       issueCard=<null>
  863.       chequeNumber=6
  864.       errorText=<null>
  865.       errorCode=<null>
  866.       dateOperation="17/07/2019 14:57"
  867.       cashierNumber=<null>
  868.       cashierMessage="
  869. Подарки со след. чека:
  870. Бесплатный кофе: 1000"
  871.       bonusAmt=<null>
  872.       listOfOrderItem=ListOfOrderItem[
  873.           orderItem=[OrderItem[
  874.               item="ТОВ370155"
  875.               quant=1
  876.               priceDisc=3000
  877.               price=3000
  878.               numKit=<null>
  879.               minPrice=0
  880.               posNumber=1
  881.               posSum=3000
  882.               discSum=0
  883.               bonusSum=<null>
  884.               barcode="0686603100493"
  885.             ]]
  886.         ]
  887.       listOfPayments=<null>
  888.       listOfCard=ListOfCard[
  889.           cards=[Cards[
  890.               cardNum="0003000189254565"
  891.               cardType=1
  892.             ]]
  893.         ]
  894.       listOfDisc=<null>
  895.       listOfLoyOptionProduct=<null>
  896.       mainOrder=<null>
  897.     ]
  898. ]
  899. 17.07 14:58:29.486 INFO  [SiebelTokenService] determBonusSum(tokens) orderResponse: Order[
  900.   orderHeader=OrderHeader[
  901.       shopIndex=902
  902.       slipText="
  903.  
  904. "
  905.       shiftNumber=40
  906.       cardNumber=<null>
  907.       cardPayment=0
  908.       posType=<null>
  909.       cashNumber=4
  910.       chequeSum=3000
  911.       operation=1
  912.       issueCard=<null>
  913.       chequeNumber=6
  914.       errorText=""
  915.       errorCode="0"
  916.       dateOperation="17/07/2019 14:57"
  917.       cashierNumber=<null>
  918.       cashierMessage=""
  919.       bonusAmt=<null>
  920.       listOfOrderItem=ListOfOrderItem[
  921.           orderItem=[OrderItem[
  922.               item="ТОВ370155"
  923.               quant=1
  924.               priceDisc=3000
  925.               price=3000
  926.               numKit=<null>
  927.               minPrice=0
  928.               posNumber=1
  929.               posSum=3000
  930.               discSum=0
  931.               bonusSum=<null>
  932.               barcode="0686603100493"
  933.             ]]
  934.         ]
  935.       listOfPayments=<null>
  936.       listOfCard=ListOfCard[
  937.           cards=[Cards[
  938.               cardNum="0003000189254565"
  939.               cardType=1
  940.             ]]
  941.         ]
  942.       listOfDisc=<null>
  943.       listOfLoyOptionProduct=<null>
  944.       mainOrder=<null>
  945.     ]
  946. ]
  947. 17.07 14:58:29.486 INFO  [SiebelServiceImpl] Mapping order [ru.crystals.siebel.wsclient.Order@186d563] to check
  948. 17.07 14:58:29.486 INFO  [SiebelServiceImpl] orderResponse: Order[
  949.   orderHeader=OrderHeader[
  950.       shopIndex=902
  951.       slipText=<null>
  952.       shiftNumber=40
  953.       cardNumber=<null>
  954.       cardPayment=<null>
  955.       posType=<null>
  956.       cashNumber=4
  957.       chequeSum=3000
  958.       operation=1
  959.       issueCard=<null>
  960.       chequeNumber=6
  961.       errorText=<null>
  962.       errorCode=<null>
  963.       dateOperation="17/07/2019 14:57"
  964.       cashierNumber=<null>
  965.       cashierMessage="
  966. Подарки со след. чека:
  967. Бесплатный кофе: 1000"
  968.       bonusAmt=<null>
  969.       listOfOrderItem=ListOfOrderItem[
  970.           orderItem=[OrderItem[
  971.               item="ТОВ370155"
  972.               quant=1
  973.               priceDisc=3000
  974.               price=3000
  975.               numKit=<null>
  976.               minPrice=0
  977.               posNumber=1
  978.               posSum=3000
  979.               discSum=0
  980.               bonusSum=<null>
  981.               barcode="0686603100493"
  982.             ]]
  983.         ]
  984.       listOfPayments=<null>
  985.       listOfCard=ListOfCard[
  986.           cards=[Cards[
  987.               cardNum="0003000189254565"
  988.               cardType=1
  989.             ]]
  990.         ]
  991.       listOfDisc=<null>
  992.       listOfLoyOptionProduct=<null>
  993.       mainOrder=<null>
  994.     ]
  995. ]
  996. 17.07 14:58:29.488 INFO  [DoProcessing] ============ LoyalCalculation: doDiscount start ============
  997. 17.07 14:58:29.488 INFO  [DoProcessing] GeneralInteractionMethod: MAXIMUM_DISCOUNT
  998. 17.07 14:58:29.489 WARN  [DirectProcessing] no suitable bonus action (sponsor: CRM) was found for card [CardEntity: card-number: 0003000189254565, card-number-hash: null, [id=null; guid=null; deleted=false]] in receipt [Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}]
  999. 17.07 14:58:29.494 INFO  [DoProcessing] ============ LoyalCalculation: doDiscount success ============
  1000. 17.07 14:58:29.495 TRACE [LoyPluginEmulator] entering doDiscount(Receipt). The argument is: ru.crystals.api.commons.ReceiptPurchaseWrapper@c00076
  1001. 17.07 14:58:29.495 TRACE [LoyPluginEmulator] entering readProperties(IntegrationProperties, Logger)
  1002. 17.07 14:58:29.495 TRACE [LoyPluginEmulator] getUrlProperty: the "secondary.calc.url" is not set
  1003. 17.07 14:58:29.495 TRACE [LoyPluginEmulator] leaving readProperties(IntegrationProperties, Logger). The result is: LoyPluginEmulatorProperties{primaryCalcUrl=http://127.0.0.1:10065/loy-plugin-processing/emulator/process, secondaryCalcUrl=null, feedbackUrl=http://127.0.0.1:10065/loy-plugin-processing/emulator/feedback, connectionTimeout=1000, readTimeout=1000, cardProcessingId='null'}; it took 0 [ms]
  1004. 17.07 14:58:29.496 TRACE [LoyPluginEmulator] entering makeCalcCalls(List, EmulatorReceipt). The arguments are: urls: [http://127.0.0.1:10065/loy-plugin-processing/emulator/process], emulatorReceipt: emul-receipt [card: emul-card [no: "0003000189254565"; available: 3920074; to-write-off: null]; positions: [emul-pos [no: 1; marking: "ТОВ370155"; qnty: 1000; sum: 300000; min-sum: 0; discountable: true]]]
  1005. 17.07 14:58:30.017 ERROR [ConnectionEmulatorUtils] toString(XmlEmulatorException): the argument is null
  1006. 17.07 14:58:30.026 TRACE [LoyPluginEmulator] leaving makeCalcCalls(List, EmulatorReceipt). The result is: emul-loy-result [discounts: []; limit: null; taken-into-account: null]; it took 530 [ms]
  1007. 17.07 14:58:30.026 TRACE [LoyPluginEmulator] leaving doDiscount(Receipt). The result is: LoyaltyResult{discounts=null, bonusWriteOffsLimits=null, bonusesTakenIntoAccount=null, bonusAccrualResults=null, printDocuments=null, messagesToCashier=null, extendedAttributeMap=null}; it took 531 [ms]
  1008. 17.07 14:58:30.027 INFO  [LoyaltyResultSanityChecker] Checking MRP restrictions
  1009. Quantity 1000
  1010. Position sum 3000.00
  1011. Value 0
  1012. Min price 0.00
  1013. 17.07 14:58:30.027 INFO  [LoyaltyResultSanityChecker] Unable to check MRP restriction: no MRP provided
  1014. 17.07 14:58:30.027 TRACE [MLServiceImpl] entering getMlCardNo(Purchase). The argument is: Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}
  1015. 17.07 14:58:30.027 TRACE [MLServiceImpl] leaving getMlCardNo(Purchase). The result is: null
  1016. 17.07 14:58:30.027 TRACE [MLServiceImpl] entering getMlCouponNo(PurchaseEntity). The argument is: Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}
  1017. 17.07 14:58:30.027 TRACE [MLServiceImpl] leaving getMlCouponNo(PurchaseEntity). The result is: null
  1018. 17.07 14:58:30.028 TRACE [SCService] entering isEnabled()
  1019. 17.07 14:58:30.028 TRACE [SCService] leaving isEnabled(). the result is: true
  1020. 17.07 14:58:30.028 TRACE [SCService] entering calcDiscount(Purchase). The argument is: Purchase{number=6, dateCreate=Wed Jul 17 14:57:20 MSK 2019, checkSum=300000, operationType=true, discountValueTotal=0}
  1021. 17.07 14:58:30.029 TRACE [SCService] Send request <?xml version="1.0" encoding="UTF-8" standalone="yes"?>
  1022. <ChequeRequest xmlns="http://smartcheckout.ru/xsd/s10ren.xsd" ChequeType="Soft">
  1023.     <RequestID>1563364640569</RequestID>
  1024.     <Card>
  1025.         <CardNumber>0003000189254565</CardNumber>
  1026.     </Card>
  1027.     <DateTime>2019-07-17T14:58:30.028+03:00</DateTime>
  1028.     <POS>4</POS>
  1029.     <Number>1563364640569</Number>
  1030.     <Summ>3000.00</Summ>
  1031.     <Discount>0.000</Discount>
  1032.     <SummDiscounted>3000.00</SummDiscounted>
  1033.     <Item>
  1034.         <PositionNumber>1</PositionNumber>
  1035.         <Article>ТОВ370155</Article>
  1036.         <ArticleName>ТОВ370155</ArticleName>
  1037.         <Price>3000.00</Price>
  1038.         <Quantity>1.000</Quantity>
  1039.         <Summ>3000.00</Summ>
  1040.         <Discount>0.000</Discount>
  1041.         <SummDiscounted>3000.00</SummDiscounted>
  1042.     </Item>
  1043. </ChequeRequest>
  1044.  
  1045. 17.07 14:58:30.029 TRACE [SCService] entering getServices()
  1046. 17.07 14:58:30.029 TRACE [SCService] getting services (IN MEMORY)
  1047. 17.07 14:58:30.029 TRACE [SCService] leaving getServices(). The result size is: 2
  1048. 17.07 14:58:30.041 TRACE [SCService] Received response: <?xml version="1.0" encoding="UTF-8" standalone="yes"?>
  1049. <ChequeRequestResponce xmlns="http://smartcheckout.ru/xsd/s10ren.xsd">
  1050.     <RequestID>1563364640569</RequestID>
  1051.     <Processed>2019-07-17T14:58:30.035+03:00</Processed>
  1052.     <ReturnCode>0</ReturnCode>
  1053.     <CashierMessageTO>0</CashierMessageTO>
  1054.     <Summ>3000.00</Summ>
  1055.     <Discount>0.000</Discount>
  1056.     <SummDiscounted>3000.00</SummDiscounted>
  1057.     <Item>
  1058.         <PositionNumber>1</PositionNumber>
  1059.         <Article>ТОВ370155</Article>
  1060.         <ArticleName>ТОВ370155</ArticleName>
  1061.         <Price>3000.00</Price>
  1062.         <MinPrice>0</MinPrice>
  1063.         <Quantity>1.000</Quantity>
  1064.         <Summ>3000.00</Summ>
  1065.         <Discount>0.000</Discount>
  1066.         <SummDiscounted>3000.00</SummDiscounted>
  1067.     </Item>
  1068. </ChequeRequestResponce>
  1069.  
  1070. 17.07 14:58:30.042 TRACE [SCReceiptConverter] ml discounts: {position-key [marking: ТОВ370155; original-price: 300000]=0}
  1071. 17.07 14:58:30.042 TRACE [SCReceiptConverter] it was inferred that no SC POS discounts were given on position [key: position-key [marking: ТОВ370155; original-price: 300000]]: SC discount value is: 0
  1072. 17.07 14:58:30.042 TRACE [SCService] leaving calcDiscount(Purchase). The result is: Purchase{number=null, dateCreate=null, checkSum=300000, operationType=null, discountValueTotal=0}; it took 14 [ms]
  1073. 17.07 14:58:30.044 INFO  [DoProcessing] ============ LoyalCalculation: doDiscount start ============
  1074. 17.07 14:58:30.044 INFO  [DoProcessing] GeneralInteractionMethod: MAXIMUM_DISCOUNT
Advertisement
Add Comment
Please, Sign In to add comment
Advertisement
Public Pastes
Advertisement
We use cookies for various purposes including analytics. By continuing to use Pastebin, you agree to our use of cookies as described in the Cookies Policy.  OK, I Understand
Not a member of Pastebin yet?
Sign Up, it unlocks many cool features!