API tools faq
paste
Advertisement
fedorm

Untitled

fedorm
Aug 21st, 2019
213
0
Never
Add comment
Not a member of Pastebin yet? Sign Up, it unlocks many cool features!
XML 41.08 KB | None | 0 0
raw download clone embed print report
  1. 21.08 17:27:36.112 INFO  [TechProcessImpl] TP searchProduct 9905100100001
  2. 21.08 17:27:36.113 INFO  [CatalogService] getGoodsByBarCode barcode = 9905100100001
  3. 21.08 17:27:36.124 INFO  [CatalogService] get product by barcode '9905100100001' result: null
  4. 21.08 17:27:36.124 INFO  [SpeedLog] CatalogGoods: dataFinder.getProductByBarcode, barcode = 9905100100001 time = 6 ms
  5. 21.08 17:27:36.125 INFO  [SpeedLog] CatalogGoods#getGoodsByBarCode, barcode = 9905100100001 time = 7 ms
  6. 21.08 17:27:36.135 INFO  [CatalogService] Get product by item '9905100100001' result null
  7. 21.08 17:27:36.136 INFO  [SpeedLog] searchProduct time  time = 23 ms
  8. 21.08 17:27:36.140 TRACE [SCService] entering isEnabled()
  9. 21.08 17:27:36.169 TRACE [SCService] leaving isEnabled(). the result is: true
  10. 21.08 17:27:36.169 TRACE [SCService] entering isSmChCoupon(String). The argument is: "9905100100001"
  11. 21.08 17:27:36.169 TRACE [SCService] leaving isSmChCoupon(String). The result is: false
  12. 21.08 17:27:36.169 TRACE [MLServiceImpl] entering isEnabled()
  13. 21.08 17:27:36.178 TRACE [MLServiceImpl] leaving isEnabled(). the result is: true
  14. 21.08 17:27:36.178 TRACE [MLServiceImpl] entering isMlCoupon(String). The argument is: "9905100100001"
  15. 21.08 17:27:36.178 TRACE [MLServiceImpl] leaving isMlCoupon(String). The result is: false
  16. 21.08 17:27:36.179 TRACE [MLServiceImpl] entering isEnabled()
  17. 21.08 17:27:36.179 TRACE [MLServiceImpl] leaving isEnabled(). the result is: true
  18. 21.08 17:27:36.179 TRACE [MLServiceImpl] entering isMlCard(String, boolean). The argument are: "9905100100001"
  19. 21.08 17:27:36.179 TRACE [MLServiceImpl] leaving isMlCard(String, boolean). The result is: false
  20. 21.08 17:27:36.179 TRACE [CardPluginEmulator] entering getCardInfo(String). The argument is: 9905100100001
  21. 21.08 17:27:36.179 TRACE [CardPluginEmulator] entering readProperties(IntegrationProperties, Logger)
  22. 21.08 17:27:36.180 TRACE [CardPluginEmulator] leaving readProperties(IntegrationProperties, Logger). The result is: CardPluginEmulatorProperties{getInfoUrl=http://127.0.0.1:10071/card-plugin-processing/emulator/get-card, writeOffUrl=http://127.0.0.1:10071/card-plugin-processing/emulator/write-off, rollbackUrl=http://127.0.0.1:10071/card-plugin-processing/emulator/rollback, connectionTimeout=1000, readTimeout=1000, cardNoPrefixes=[151, 152], cardNoLength=7}; it took 1 [ms]
  23. 21.08 17:27:36.180 TRACE [CardPluginEmulator] leaving getCardInfo(String). The card (no: "9905100100001") does not belong to our processing for sure!
  24. 21.08 17:27:36.180 DEBUG [ExampleCardPlugin] entering getCardInfo(CardInfoSearchParams). The arguments are: request [ru.crystals.pos.cards.service.PluginCardSearchRequest@96e425]
  25. 21.08 17:27:36.182 DEBUG [ExampleCardPlugin] leaving getCardInfo(CardInfoSearchParams). The card [9905100100001] does not exist in the processing for sure
  26. 21.08 17:27:36.203 WARN  [BonusBalanceSupplier] Processing "CashCardsApplication" has provided no bonus balance for card "9905100100001"
  27. 21.08 17:27:36.458 TRACE [TechProcessImpl] entering applyClientRequisites(ClientEntity). The argument is: holder [ClientEntity [id=110769; guid=110769; deleted=false]]
  28. 21.08 17:27:36.458 TRACE [TechProcessImpl] leaving applyClientRequisites(ClientEntity). Cash template prohibits usage of personal-sensitive data to send e-receipt to a card-ho;der
  29. 21.08 17:27:36.498 ERROR [ExternalEncryptedEventPacket] Thread-48   Ошибка расшифровки пакета
  30. java.security.InvalidKeyException: Unwrapping failed
  31.     at com.sun.crypto.provider.RSACipher.engineUnwrap(RSACipher.java:445)
  32.     at javax.crypto.Cipher.unwrap(Cipher.java:2550)
  33.     at ru.crystals.pos.prismabridge.external.ExternalPacketCipher.encryptAesKey(ExternalPacketCipher.java:57)
  34.     at ru.crystals.pos.prismabridge.external.ExternalPacketCipher.decode(ExternalPacketCipher.java:48)
  35.     at ru.crystals.pos.prismabridge.external.ExternalEncryptedEventPacket.parseEvent(ExternalEncryptedEventPacket.java:44)
  36.     at ru.crystals.pos.emulator.prisma.PrismaEmulatorRunnable.decodePacket(PrismaEmulatorRunnable.java:168)
  37.     at ru.crystals.pos.emulator.prisma.PrismaEmulatorRunnable.readBytes(PrismaEmulatorRunnable.java:91)
  38.     at ru.crystals.pos.emulator.prisma.PrismaEmulatorRunnable.run(PrismaEmulatorRunnable.java:71)
  39.     at java.lang.Thread.run(Thread.java:745)
  40. Caused by: javax.crypto.BadPaddingException: Decryption error
  41.     at sun.security.rsa.RSAPadding.unpadV15(RSAPadding.java:380)
  42.     at sun.security.rsa.RSAPadding.unpad(RSAPadding.java:291)
  43.     at com.sun.crypto.provider.RSACipher.doFinal(RSACipher.java:363)
  44.     at com.sun.crypto.provider.RSACipher.engineUnwrap(RSACipher.java:440)
  45.     ... 8 more
  46. 21.08 17:27:36.505 INFO  [LoyProvidersRegistryImpl] Resend stale feedback
  47. 21.08 17:27:36.505 INFO  [LoyProvidersRegistryImpl] Search for stale feedback provider = SetApiLoyaltyPlugin
  48. 21.08 17:27:36.506 INFO  [LoyProvidersRegistryImpl] There is no stale feedback for SetApiLoyaltyPlugin
  49. 21.08 17:27:36.506 INFO  [LoyProvidersRegistryImpl] Search for stale feedback provider = sm
  50. 21.08 17:27:36.507 INFO  [LoyProvidersRegistryImpl] There is no stale feedback for sm
  51. 21.08 17:27:36.507 INFO  [LoyProvidersRegistryImpl] Search for stale feedback provider = smch
  52. 21.08 17:27:36.508 INFO  [LoyProvidersRegistryImpl] There is no stale feedback for smch
  53. 21.08 17:27:36.508 INFO  [LoyProvidersRegistryImpl] Search for stale feedback provider = ml
  54. 21.08 17:27:36.508 INFO  [LoyProvidersRegistryImpl] There is no stale feedback for ml
  55. 21.08 17:27:36.508 INFO  [LoyProvidersRegistryImpl] Search for stale feedback provider = set-loy-provider
  56. 21.08 17:27:36.508 INFO  [LoyProvidersRegistryImpl] There is no stale feedback for set-loy-provider
  57. 21.08 17:27:36.508 INFO  [LoyProvidersRegistryImpl] Search for stale feedback provider = kopilka
  58. 21.08 17:27:36.508 INFO  [LoyProvidersRegistryImpl] There is no stale feedback for kopilka
  59. 21.08 17:27:36.509 INFO  [LoyProvidersRegistryImpl] Search for stale feedback provider = loymax
  60. 21.08 17:27:36.512 INFO  [LoyProvidersRegistryImpl] There is no stale feedback for loymax
  61. 21.08 17:27:36.512 INFO  [LoyProvidersRegistryImpl] Search for stale feedback provider = aeroflotBonusesCFT
  62. 21.08 17:27:36.512 INFO  [LoyProvidersRegistryImpl] There is no stale feedback for aeroflotBonusesCFT
  63. 21.08 17:27:37.761 INFO  [TechProcessImpl] eventControlKey: ControlKey [scanCode=10, command=kbdEnter]
  64. 21.08 17:27:37.762 INFO  [TechProcessImpl] TP searchProduct 00666
  65. 21.08 17:27:37.770 INFO  [CatalogService] Get product by item '00666' result ProductPieceEntity[name=Напиток грушевый кисло-сладкий (Россия), item=00666]
  66. 21.08 17:27:37.775 INFO  [SpeedLog] getProductRestrictions  time = 1 ms
  67. 21.08 17:27:37.776 INFO  [SpeedLog] searchProduct time  time = 12 ms
  68. 21.08 17:27:37.815 INFO  [SpeedLog] (CHECK_CONTAINER) show product container time = 0,038 sec; average speed = 0,164 sec; position test num = 2.0; product item 00666; <38>
  69. 21.08 17:27:37.815 INFO  [CommonLogger] busy = false
  70. 21.08 17:27:37.821 ERROR [ExternalEncryptedEventPacket] Thread-48   Ошибка расшифровки пакета
  71. java.security.InvalidKeyException: Unwrapping failed
  72.     at com.sun.crypto.provider.RSACipher.engineUnwrap(RSACipher.java:445)
  73.     at javax.crypto.Cipher.unwrap(Cipher.java:2550)
  74.     at ru.crystals.pos.prismabridge.external.ExternalPacketCipher.encryptAesKey(ExternalPacketCipher.java:57)
  75.     at ru.crystals.pos.prismabridge.external.ExternalPacketCipher.decode(ExternalPacketCipher.java:48)
  76.     at ru.crystals.pos.prismabridge.external.ExternalEncryptedEventPacket.parseEvent(ExternalEncryptedEventPacket.java:44)
  77.     at ru.crystals.pos.emulator.prisma.PrismaEmulatorRunnable.decodePacket(PrismaEmulatorRunnable.java:168)
  78.     at ru.crystals.pos.emulator.prisma.PrismaEmulatorRunnable.readBytes(PrismaEmulatorRunnable.java:91)
  79.     at ru.crystals.pos.emulator.prisma.PrismaEmulatorRunnable.run(PrismaEmulatorRunnable.java:71)
  80.     at java.lang.Thread.run(Thread.java:745)
  81. Caused by: javax.crypto.BadPaddingException: Decryption error
  82.     at sun.security.rsa.RSAPadding.unpadV15(RSAPadding.java:380)
  83.     at sun.security.rsa.RSAPadding.unpad(RSAPadding.java:291)
  84.     at com.sun.crypto.provider.RSACipher.doFinal(RSACipher.java:363)
  85.     at com.sun.crypto.provider.RSACipher.engineUnwrap(RSACipher.java:440)
  86.     ... 8 more
  87. 21.08 17:27:37.829 ERROR [ExternalEncryptedEventPacket] Thread-48   Ошибка расшифровки пакета
  88. java.security.InvalidKeyException: Unwrapping failed
  89.     at com.sun.crypto.provider.RSACipher.engineUnwrap(RSACipher.java:445)
  90.     at javax.crypto.Cipher.unwrap(Cipher.java:2550)
  91.     at ru.crystals.pos.prismabridge.external.ExternalPacketCipher.encryptAesKey(ExternalPacketCipher.java:57)
  92.     at ru.crystals.pos.prismabridge.external.ExternalPacketCipher.decode(ExternalPacketCipher.java:48)
  93.     at ru.crystals.pos.prismabridge.external.ExternalEncryptedEventPacket.parseEvent(ExternalEncryptedEventPacket.java:44)
  94.     at ru.crystals.pos.emulator.prisma.PrismaEmulatorRunnable.decodePacket(PrismaEmulatorRunnable.java:168)
  95.     at ru.crystals.pos.emulator.prisma.PrismaEmulatorRunnable.readBytes(PrismaEmulatorRunnable.java:91)
  96.     at ru.crystals.pos.emulator.prisma.PrismaEmulatorRunnable.run(PrismaEmulatorRunnable.java:71)
  97.     at java.lang.Thread.run(Thread.java:745)
  98. Caused by: javax.crypto.BadPaddingException: Decryption error
  99.     at sun.security.rsa.RSAPadding.unpadV15(RSAPadding.java:380)
  100.     at sun.security.rsa.RSAPadding.unpad(RSAPadding.java:291)
  101.     at com.sun.crypto.provider.RSACipher.doFinal(RSACipher.java:363)
  102.     at com.sun.crypto.provider.RSACipher.engineUnwrap(RSACipher.java:440)
  103.     ... 8 more
  104. 21.08 17:27:37.969 INFO  [TechProcessImpl] eventFunctionKey: FunctionKey [scanCode=32, command=kbdSubtotal]
  105. 21.08 17:27:37.985 INFO  [TechProcessImpl] TechProcess add position id: null; number: 1; item: 00666; type: ProductPieceEntity; count: 1000; sum: 8781; sumDiscount: 0; dateTime: (NULL); num-in-original: null
  106. 21.08 17:27:38.014 INFO  [SpeedLog] TP addPosition time = 29 ms
  107. 21.08 17:27:38.055 INFO  [CommonLogger] busy = true
  108. 21.08 17:27:38.066 TRACE [TechProcessImpl] Start warn divide alco
  109. 21.08 17:27:38.066 TRACE [TechProcessImpl] End warn devide alco
  110. 21.08 17:27:38.071 INFO  [TechProcessImpl] goToDiscounts
  111. 21.08 17:27:38.086 INFO  [LoyalBridgeServiceImpl] --------------- begin discount calculation ---------------
  112. 21.08 17:27:38.089 INFO  [LoyalProductFinder] Time finding items (1) = 2 ms
  113. 21.08 17:27:38.089 INFO  [LoyalProductsConverter] Time searching loyal goods for 1 productItems = 2 ms
  114. 21.08 17:27:38.089 INFO  [LoyalCalculatorConverter] Time converting 1 positions = 0 ms
  115. 21.08 17:27:38.090 TRACE [MLServiceImpl] entering getMlCardNo(Purchase). The argument is: Purchase{number=4, dateCreate=Wed Aug 21 17:27:36 MSK 2019, checkSum=8781, operationType=true, discountValueTotal=0}
  116. 21.08 17:27:38.090 TRACE [MLServiceImpl] leaving getMlCardNo(Purchase). The result is: null
  117. 21.08 17:27:38.090 TRACE [MLServiceImpl] entering getMlCouponNo(PurchaseEntity). The argument is: Purchase{number=4, dateCreate=Wed Aug 21 17:27:36 MSK 2019, checkSum=8781, operationType=true, discountValueTotal=0}
  118. 21.08 17:27:38.090 TRACE [MLServiceImpl] leaving getMlCouponNo(PurchaseEntity). The result is: null
  119. 21.08 17:27:38.090 INFO  [DoProcessing] ============ LoyalCalculation: doDiscount start ============
  120. 21.08 17:27:38.090 INFO  [DoProcessing] GeneralInteractionMethod: MAXIMUM_DISCOUNT
  121. 21.08 17:27:38.090 INFO  [DoProcessing] ============ LoyalCalculation: doDiscount success ============
  122. 21.08 17:27:38.090 TRACE [MLServiceImpl] entering getMlCardNo(Purchase). The argument is: Purchase{number=4, dateCreate=Wed Aug 21 17:27:36 MSK 2019, checkSum=8781, operationType=true, discountValueTotal=0}
  123. 21.08 17:27:38.091 TRACE [MLServiceImpl] leaving getMlCardNo(Purchase). The result is: null
  124. 21.08 17:27:38.091 TRACE [MLServiceImpl] entering getMlCouponNo(PurchaseEntity). The argument is: Purchase{number=4, dateCreate=Wed Aug 21 17:27:36 MSK 2019, checkSum=8781, operationType=true, discountValueTotal=0}
  125. 21.08 17:27:38.091 TRACE [MLServiceImpl] leaving getMlCouponNo(PurchaseEntity). The result is: null
  126. 21.08 17:27:38.091 TRACE [SCService] entering isEnabled()
  127. 21.08 17:27:38.091 TRACE [SCService] leaving isEnabled(). the result is: true
  128. 21.08 17:27:38.091 TRACE [SCService] entering calcDiscount(Purchase). The argument is: Purchase{number=4, dateCreate=Wed Aug 21 17:27:36 MSK 2019, checkSum=8781, operationType=true, discountValueTotal=0}
  129. 21.08 17:27:38.091 TRACE [SCService] Send request <?xml version="1.0" encoding="UTF-8" standalone="yes"?>
  130. <ChequeRequest xmlns="http://smartcheckout.ru/xsd/s10ren.xsd" ChequeType="Soft">
  131.     <RequestID>1566397656453</RequestID>
  132.     <Card>
  133.         <CardNumber>9905100100001</CardNumber>
  134.     </Card>
  135.     <DateTime>2019-08-21T17:27:38.091+03:00</DateTime>
  136.     <POS>7</POS>
  137.     <Number>1566397656453</Number>
  138.     <Summ>87.81</Summ>
  139.     <Discount>0.000</Discount>
  140.     <SummDiscounted>87.81</SummDiscounted>
  141.     <Item>
  142.         <PositionNumber>1</PositionNumber>
  143.         <Article>00666</Article>
  144.         <ArticleName>Напиток грушевый кисло-сладкий (Россия)</ArticleName>
  145.         <Price>87.81</Price>
  146.         <Quantity>1.000</Quantity>
  147.         <Summ>87.81</Summ>
  148.         <Discount>0.000</Discount>
  149.         <SummDiscounted>87.81</SummDiscounted>
  150.     </Item>
  151. </ChequeRequest>
  152.  
  153. 21.08 17:27:38.091 TRACE [SCService] entering getServices()
  154. 21.08 17:27:38.091 TRACE [SCService] getting services (IN MEMORY)
  155. 21.08 17:27:38.092 TRACE [SCService] leaving getServices(). The result size is: 2
  156. 21.08 17:27:38.102 TRACE [SCService] Received response: <?xml version="1.0" encoding="UTF-8" standalone="yes"?>
  157. <ChequeRequestResponce xmlns="http://smartcheckout.ru/xsd/s10ren.xsd">
  158.     <RequestID>1566397656453</RequestID>
  159.     <Processed>2019-08-21T17:27:38.100+03:00</Processed>
  160.     <ReturnCode>0</ReturnCode>
  161.     <CashierMessageTO>0</CashierMessageTO>
  162.     <Summ>87.81</Summ>
  163.     <Discount>0.000</Discount>
  164.     <SummDiscounted>87.81</SummDiscounted>
  165.     <Item>
  166.         <PositionNumber>1</PositionNumber>
  167.         <Article>00666</Article>
  168.         <ArticleName>Напиток грушевый кисло-сладкий (Россия)</ArticleName>
  169.         <Price>87.81</Price>
  170.         <MinPrice>0</MinPrice>
  171.         <Quantity>1.000</Quantity>
  172.         <Summ>87.81</Summ>
  173.         <Discount>0.000</Discount>
  174.         <SummDiscounted>87.81</SummDiscounted>
  175.     </Item>
  176. </ChequeRequestResponce>
  177.  
  178. 21.08 17:27:38.102 TRACE [SCReceiptConverter] ml discounts: {position-key [marking: 00666; original-price: 8781]=0}
  179. 21.08 17:27:38.102 TRACE [SCReceiptConverter] it was inferred that no SC POS discounts were given on position [key: position-key [marking: 00666; original-price: 8781]]: SC discount value is: 0
  180. 21.08 17:27:38.102 TRACE [SCService] leaving calcDiscount(Purchase). The result is: Purchase{number=null, dateCreate=null, checkSum=8781, operationType=null, discountValueTotal=0}; it took 11 [ms]
  181. 21.08 17:27:38.103 INFO  [DoProcessing] ============ LoyalCalculation: doDiscount start ============
  182. 21.08 17:27:38.103 INFO  [DoProcessing] GeneralInteractionMethod: MAXIMUM_DISCOUNT
  183. 21.08 17:27:38.103 INFO  [DoProcessing] ============ LoyalCalculation: doDiscount success ============
  184. 21.08 17:27:38.103 INFO  [DoProcessing] ============ LoyalCalculation: doDiscount start ============
  185. 21.08 17:27:38.103 INFO  [DoProcessing] GeneralInteractionMethod: MAXIMUM_DISCOUNT
  186. 21.08 17:27:38.103 INFO  [DoProcessing] ============ LoyalCalculation: doDiscount success ============
  187. 21.08 17:27:38.104 TRACE [MLServiceImpl] entering getMlCardNo(Purchase). The argument is: Purchase{number=4, dateCreate=Wed Aug 21 17:27:36 MSK 2019, checkSum=8781, operationType=true, discountValueTotal=0}
  188. 21.08 17:27:38.104 TRACE [MLServiceImpl] leaving getMlCardNo(Purchase). The result is: null
  189. 21.08 17:27:38.104 TRACE [MLServiceImpl] entering getMlCouponNo(PurchaseEntity). The argument is: Purchase{number=4, dateCreate=Wed Aug 21 17:27:36 MSK 2019, checkSum=8781, operationType=true, discountValueTotal=0}
  190. 21.08 17:27:38.104 TRACE [MLServiceImpl] leaving getMlCouponNo(PurchaseEntity). The result is: null
  191. 21.08 17:27:38.104 INFO  [LoyalServiceImpl] Discount calculation (Purchase #4; Positions: 1
  192. 21.08 17:27:38.104 WARN  [LoyalServiceImpl] extractNonDiscountRelatedFields: the argument is NULL! Null will be returned!
  193. 21.08 17:27:38.128 INFO  [LoyalBridgeServiceImpl] Total time of discount calculation = 41 ms
  194. 21.08 17:27:38.128 INFO  [LoyalBridgeServiceImpl] ---------------- end discount calculation ----------------
  195. 21.08 17:27:38.137 INFO  [SpeedLog] TechProcess discounts processing on cheque with 1 positions [sale] time = 66 ms
  196. 21.08 17:27:38.138 INFO  [CommonLogger] value = 0
  197. 21.08 17:27:38.154 TRACE [TechProcessImpl] Start warn divide amount
  198. 21.08 17:27:38.155 INFO  [TechProcessImpl] goToPayments
  199. 21.08 17:27:38.161 INFO  [CheckContainer] startPayments() surcharge = 8781
  200. 21.08 17:27:38.167 INFO  [CheckContainer] isPaymentComplete = false
  201. 21.08 17:27:38.167 INFO  [CheckContainer] prevState = ADD_POSITION
  202. 21.08 17:27:38.168 INFO  [CheckContainer] paid = 0
  203. 21.08 17:27:38.168 INFO  [CheckContainer] surcharge = 8781
  204. 21.08 17:27:38.168 INFO  [CheckContainer] getPaymentFiscalizeError = NONE
  205. 21.08 17:27:38.168 INFO  [CheckContainer] Current payment container is ru.crystals.pos.visualization.payments.cash.CashPaymentContainer
  206. 21.08 17:27:38.180 INFO  [CommonLogger] busy = false
  207. 21.08 17:27:38.183 INFO  [SpeedLog] (SUBTOTAL) time = 0,127;
  208. 21.08 17:27:38.183 INFO  [CommonLogger] busy = false
  209. 21.08 17:27:38.610 INFO  [TechProcessImpl] eventAlphaNumericKey: AlphaNumericKey [scanCode=56, character=8]
  210. 21.08 17:27:38.768 INFO  [TechProcessImpl] eventAlphaNumericKey: AlphaNumericKey [scanCode=56, character=8]
  211. 21.08 17:27:39.001 INFO  [TechProcessImpl] eventControlKey: ControlKey [scanCode=10, command=kbdEnter]
  212. 21.08 17:27:39.001 INFO  [CommonLogger] doProcessPayment() in class ru.crystals.pos.visualization.payments.cash.CashPaymentContainer
  213. 21.08 17:27:39.002 INFO  [TechProcessImpl] addPayment CashPaymentEntity 8800
  214. 21.08 17:27:39.014 ERROR [ExternalEncryptedEventPacket] Thread-48   Ошибка расшифровки пакета
  215. java.security.InvalidKeyException: Unwrapping failed
  216.     at com.sun.crypto.provider.RSACipher.engineUnwrap(RSACipher.java:445)
  217.     at javax.crypto.Cipher.unwrap(Cipher.java:2550)
  218.     at ru.crystals.pos.prismabridge.external.ExternalPacketCipher.encryptAesKey(ExternalPacketCipher.java:57)
  219.     at ru.crystals.pos.prismabridge.external.ExternalPacketCipher.decode(ExternalPacketCipher.java:48)
  220.     at ru.crystals.pos.prismabridge.external.ExternalEncryptedEventPacket.parseEvent(ExternalEncryptedEventPacket.java:44)
  221.     at ru.crystals.pos.emulator.prisma.PrismaEmulatorRunnable.decodePacket(PrismaEmulatorRunnable.java:168)
  222.     at ru.crystals.pos.emulator.prisma.PrismaEmulatorRunnable.readBytes(PrismaEmulatorRunnable.java:91)
  223.     at ru.crystals.pos.emulator.prisma.PrismaEmulatorRunnable.run(PrismaEmulatorRunnable.java:71)
  224.     at java.lang.Thread.run(Thread.java:745)
  225. Caused by: javax.crypto.BadPaddingException: Decryption error
  226.     at sun.security.rsa.RSAPadding.unpadV15(RSAPadding.java:380)
  227.     at sun.security.rsa.RSAPadding.unpad(RSAPadding.java:291)
  228.     at com.sun.crypto.provider.RSACipher.doFinal(RSACipher.java:363)
  229.     at com.sun.crypto.provider.RSACipher.engineUnwrap(RSACipher.java:440)
  230.     ... 8 more
  231. 21.08 17:27:39.017 TRACE [TechProcessEventsImpl] entering purchaseChangedAtPaymentsStage(PurchaseEntity, List). The arguments are: purchase [PurchaseEntity [id=2571, number=null, dateCreate=Wed Aug 21 17:27:36 MSK 2019, dateCommit=null, fiscalDocNum=null, sentToServerStatus=NO_SENT]], notifications [[]]
  232. 21.08 17:27:39.018 INFO  [CommonLogger] value = 0
  233. 21.08 17:27:39.024 TRACE [TechProcessEventsImpl] leaving purchaseChangedAtPaymentsStage(PurchaseEntity, List). It took 7 [ms]
  234. 21.08 17:27:39.034 ERROR [ExternalEncryptedEventPacket] Thread-48   Ошибка расшифровки пакета
  235. java.security.InvalidKeyException: Unwrapping failed
  236.     at com.sun.crypto.provider.RSACipher.engineUnwrap(RSACipher.java:445)
  237.     at javax.crypto.Cipher.unwrap(Cipher.java:2550)
  238.     at ru.crystals.pos.prismabridge.external.ExternalPacketCipher.encryptAesKey(ExternalPacketCipher.java:57)
  239.     at ru.crystals.pos.prismabridge.external.ExternalPacketCipher.decode(ExternalPacketCipher.java:48)
  240.     at ru.crystals.pos.prismabridge.external.ExternalEncryptedEventPacket.parseEvent(ExternalEncryptedEventPacket.java:44)
  241.     at ru.crystals.pos.emulator.prisma.PrismaEmulatorRunnable.decodePacket(PrismaEmulatorRunnable.java:168)
  242.     at ru.crystals.pos.emulator.prisma.PrismaEmulatorRunnable.readBytes(PrismaEmulatorRunnable.java:91)
  243.     at ru.crystals.pos.emulator.prisma.PrismaEmulatorRunnable.run(PrismaEmulatorRunnable.java:71)
  244.     at java.lang.Thread.run(Thread.java:745)
  245. Caused by: javax.crypto.BadPaddingException: Decryption error
  246.     at sun.security.rsa.RSAPadding.unpadV15(RSAPadding.java:380)
  247.     at sun.security.rsa.RSAPadding.unpad(RSAPadding.java:291)
  248.     at com.sun.crypto.provider.RSACipher.doFinal(RSACipher.java:363)
  249.     at com.sun.crypto.provider.RSACipher.engineUnwrap(RSACipher.java:440)
  250.     ... 8 more
  251. 21.08 17:27:39.038 INFO  [TechProcessShift] fiscalizeCheck PurchaseEntity [id=2571, number=null, dateCreate=Wed Aug 21 17:27:36 MSK 2019, dateCommit=null, fiscalDocNum=null, sentToServerStatus=NO_SENT]
  252. 21.08 17:27:39.068 INFO  [FiscalPrinter] getLastKpk
  253. 21.08 17:27:39.071 INFO  [FiscalPrinter] LastKpk = 3
  254. 21.08 17:27:39.117 INFO  [CFTBridgeImpl] Bonuses can not be charged to the card. Purchase does not contain Sberbank cards. Purchase: PurchaseEntity [id=2571, number=4, dateCreate=Wed Aug 21 17:27:36 MSK 2019, dateCommit=null, fiscalDocNum=null, sentToServerStatus=NO_SENT]
  255. 21.08 17:27:39.153 INFO  [FiscalPrinter] openMoneyDrawer
  256. 21.08 17:27:39.153 INFO  [FiscalPrinter] setCashDrawerOpen(true)
  257. 21.08 17:27:39.162 ERROR [ExternalEncryptedEventPacket] Thread-48   Ошибка расшифровки пакета
  258. java.security.InvalidKeyException: Unwrapping failed
  259.     at com.sun.crypto.provider.RSACipher.engineUnwrap(RSACipher.java:445)
  260.     at javax.crypto.Cipher.unwrap(Cipher.java:2550)
  261.     at ru.crystals.pos.prismabridge.external.ExternalPacketCipher.encryptAesKey(ExternalPacketCipher.java:57)
  262.     at ru.crystals.pos.prismabridge.external.ExternalPacketCipher.decode(ExternalPacketCipher.java:48)
  263.     at ru.crystals.pos.prismabridge.external.ExternalEncryptedEventPacket.parseEvent(ExternalEncryptedEventPacket.java:44)
  264.     at ru.crystals.pos.emulator.prisma.PrismaEmulatorRunnable.decodePacket(PrismaEmulatorRunnable.java:168)
  265.     at ru.crystals.pos.emulator.prisma.PrismaEmulatorRunnable.readBytes(PrismaEmulatorRunnable.java:91)
  266.     at ru.crystals.pos.emulator.prisma.PrismaEmulatorRunnable.run(PrismaEmulatorRunnable.java:71)
  267.     at java.lang.Thread.run(Thread.java:745)
  268. Caused by: javax.crypto.BadPaddingException: Decryption error
  269.     at sun.security.rsa.RSAPadding.unpadV15(RSAPadding.java:380)
  270.     at sun.security.rsa.RSAPadding.unpad(RSAPadding.java:291)
  271.     at com.sun.crypto.provider.RSACipher.doFinal(RSACipher.java:363)
  272.     at com.sun.crypto.provider.RSACipher.engineUnwrap(RSACipher.java:440)
  273.     ... 8 more
  274. 21.08 17:27:39.162 INFO  [TechProcessImpl] Ящик открыт
  275. 21.08 17:27:39.162 INFO  [FiscalPrinter] isMoneyDrawerOpen
  276. 21.08 17:27:39.185 INFO  [FiscalPrinter] printCheck
  277. 21.08 17:27:39.185 INFO  [FiscalPrinter] getLastKpk
  278. 21.08 17:27:39.185 INFO  [FiscalPrinter] LastKpk = 3
  279. 21.08 17:27:39.185 INFO  [FiscalPrinter] Fiscal interrupt: null
  280. 21.08 17:27:39.186 INFO  [FiscalPrinter] Get document template /mnt/sda1/tce/storage/crystal-cash/modules/fiscalPrinter/templates/check-sale.xml
  281. 21.08 17:27:39.186 INFO  [DocumentTemplate] =====logo=====
  282. 21.08 17:27:39.186 INFO  [DocumentTemplate] content: null
  283. 21.08 17:27:39.189 INFO  [DocumentTemplate] =====header=====
  284. 21.08 17:27:39.189 INFO  [DocumentTemplate]                                               ||NORMAL
  285. 21.08 17:27:39.189 INFO  [DocumentTemplate]                                               ||NORMAL
  286. 21.08 17:27:39.189 INFO  [DocumentTemplate] -----------------------------------------     ||NORMAL
  287. 21.08 17:27:39.189 INFO  [DocumentTemplate] Смена:1                      ЭКЛЗ:c1dc8806-216||NORMAL
  288. 21.08 17:27:39.189 INFO  [DocumentTemplate] Номер кассы:7                 ИНН:  7743543761||NORMAL
  289. 21.08 17:27:39.189 INFO  [DocumentTemplate] Кассир:Администраторов Администратор Администр||NORMAL
  290. 21.08 17:27:39.189 INFO  [DocumentTemplate] ----------------------------------------      ||NORMAL
  291. 21.08 17:27:39.189 INFO  [DocumentTemplate] ЧЕК ПРОДАЖИ             4    21-08-2019  17:27||NORMAL
  292. 21.08 17:27:39.189 INFO  [DocumentTemplate] ----------------------------------------      ||NORMAL
  293. 21.08 17:27:39.190 INFO  [DocumentTemplate] =====position=====
  294. 21.08 17:27:39.190 INFO  [DocumentTemplate] ----------------------------------------------||NORMAL
  295. 21.08 17:27:39.190 INFO  [DocumentTemplate] Напиток грушевый кисл  87.81     *1     =87.81||SMALL
  296. 21.08 17:27:39.190 INFO  [DocumentTemplate] ----------------------------------------------||NORMAL
  297. 21.08 17:27:39.190 INFO  [DocumentTemplate] =====payment=====
  298. 21.08 17:27:39.190 INFO  [DocumentTemplate] ----------------------------------------------||NORMAL
  299. 21.08 17:27:39.190 INFO  [DocumentTemplate] НАЛИЧНЫЕ                                =88.00||NORMAL
  300. 21.08 17:27:39.193 INFO  [DocumentTemplate] =====discount=====
  301. 21.08 17:27:39.193 INFO  [DocumentTemplate] ----------------------------------------------||NORMAL
  302. 21.08 17:27:39.193 INFO  [DocumentTemplate]                                               ||NORMAL
  303. 21.08 17:27:39.193 INFO  [DocumentTemplate]              СПАСИБО ЗА ПОКУПКУ!              ||NORMAL
  304. 21.08 17:27:39.193 INFO  [DocumentTemplate]                                               ||NORMAL
  305. 21.08 17:27:39.193 INFO  [DocumentTemplate]                     Цены                      ||NORMAL
  306. 21.08 17:27:39.194 INFO  [DocumentTemplate] указаны с учетом скидки по карте постоянного  ||NORMAL
  307. 21.08 17:27:39.194 INFO  [DocumentTemplate]                  покупателя                   ||NORMAL
  308. 21.08 17:27:39.194 INFO  [DocumentTemplate]                 9905100100001                 ||NORMAL
  309. 21.08 17:27:39.194 INFO  [DocumentTemplate]                                               ||NORMAL
  310. 21.08 17:27:39.194 INFO  [DocumentTemplate] =====tax=====
  311. 21.08 17:27:39.194 INFO  [DocumentTemplate] content: null
  312. 21.08 17:27:39.194 INFO  [DocumentTemplate] =====total=====
  313. 21.08 17:27:39.194 INFO  [DocumentTemplate] ----------------------------------------      ||NORMAL
  314. 21.08 17:27:39.194 INFO  [DocumentTemplate] Итого без скидки          87.81               ||NORMAL
  315. 21.08 17:27:39.196 INFO  [DocumentTemplate] Скидка     0.00                               ||NORMAL
  316. 21.08 17:27:39.196 INFO  [DocumentTemplate] Итого к оплате  87.81                         ||NORMAL
  317. 21.08 17:27:39.196 INFO  [DocumentTemplate] СДАЧА                                    =0.19||NORMAL
  318. 21.08 17:27:39.196 INFO  [DocumentTemplate] =====bonuses=====
  319. 21.08 17:27:39.196 INFO  [DocumentTemplate] =====includedSlips=====
  320. 21.08 17:27:39.196 INFO  [DocumentTemplate] content: null
  321. 21.08 17:27:39.197 INFO  [DocumentTemplate] =====fiscal=====
  322. 21.08 17:27:39.197 INFO  [DocumentTemplate] content: null
  323. 21.08 17:27:39.197 INFO  [DocumentTemplate] =====footer=====
  324. 21.08 17:27:39.197 INFO  [DocumentTemplate] Док N:4                     21-08-2019 17:27  ||NORMAL
  325. 21.08 17:27:39.197 INFO  [DocumentTemplate] Спасибо за покупку!                           ||NORMAL
  326. 21.08 17:27:39.197 INFO  [DocumentTemplate] =====cut=====
  327. 21.08 17:27:39.197 INFO  [DocumentTemplate] content: null
  328. 21.08 17:27:39.298 INFO  [FiscalPrinter] getLastKpk
  329. 21.08 17:27:39.298 INFO  [FiscalPrinter] LastKpk = 4
  330. 21.08 17:27:39.298 TRACE [FiscalPrinter] getFiscalCheckData
  331. 21.08 17:27:39.304 INFO  [CheckService] fiscalizeCheck: PurchaseEntity [id=2571, number=4, dateCreate=Wed Aug 21 17:27:36 MSK 2019, dateCommit=Wed Aug 21 17:27:39 MSK 2019, fiscalDocNum=4;7, sentToServerStatus=UNCOMMITED]
  332. 21.08 17:27:39.311 TRACE [ExternalProcessingsImpl] entering purchaseFiscalized(PurchaseEntity)
  333. 21.08 17:27:39.312 TRACE [ExternalProcessingsImpl] Purchase fiscalized: no implementation of PlastekServices.
  334. 21.08 17:27:39.312 TRACE [ExternalProcessingsImpl] Purchase fiscalized: no implementation of externalLoyaltyService.
  335. 21.08 17:27:39.311 ERROR [ExternalEncryptedEventPacket] Thread-48   Ошибка расшифровки пакета
  336. java.security.InvalidKeyException: Unwrapping failed
  337.     at com.sun.crypto.provider.RSACipher.engineUnwrap(RSACipher.java:445)
  338.     at javax.crypto.Cipher.unwrap(Cipher.java:2550)
  339.     at ru.crystals.pos.prismabridge.external.ExternalPacketCipher.encryptAesKey(ExternalPacketCipher.java:57)
  340.     at ru.crystals.pos.prismabridge.external.ExternalPacketCipher.decode(ExternalPacketCipher.java:48)
  341.     at ru.crystals.pos.prismabridge.external.ExternalEncryptedEventPacket.parseEvent(ExternalEncryptedEventPacket.java:44)
  342.     at ru.crystals.pos.emulator.prisma.PrismaEmulatorRunnable.decodePacket(PrismaEmulatorRunnable.java:168)
  343.     at ru.crystals.pos.emulator.prisma.PrismaEmulatorRunnable.readBytes(PrismaEmulatorRunnable.java:91)
  344.     at ru.crystals.pos.emulator.prisma.PrismaEmulatorRunnable.run(PrismaEmulatorRunnable.java:71)
  345.     at java.lang.Thread.run(Thread.java:745)
  346. Caused by: javax.crypto.BadPaddingException: Decryption error
  347.     at sun.security.rsa.RSAPadding.unpadV15(RSAPadding.java:380)
  348.     at sun.security.rsa.RSAPadding.unpad(RSAPadding.java:291)
  349.     at com.sun.crypto.provider.RSACipher.doFinal(RSACipher.java:363)
  350.     at com.sun.crypto.provider.RSACipher.engineUnwrap(RSACipher.java:440)
  351.     ... 8 more
  352. 21.08 17:27:39.329 TRACE [ExternalProcessingsImpl] about to notify ext-loy-providers that the current receipt [PurchaseEntity [id=2571, number=4, dateCreate=Wed Aug 21 17:27:36 MSK 2019, dateCommit=Wed Aug 21 17:27:39 MSK 2019, fiscalDocNum=4;7, sentToServerStatus=UNCOMMITED]] was fiscalized...
  353. 21.08 17:27:39.334 TRACE [SMServiceImpl] entering getPromise(PurchaseEntity). The argument is: PurchaseEntity [id=2571, number=4, dateCreate=Wed Aug 21 17:27:36 MSK 2019, dateCommit=Wed Aug 21 17:27:39 MSK 2019, fiscalDocNum=4;7, sentToServerStatus=UNCOMMITED]
  354. 21.08 17:27:39.335 ERROR [SMReceiptConvertor] createPromiseRequestOld: impossible to identify card-holder buying PurchaseEntity [id=2571, number=4, dateCreate=Wed Aug 21 17:27:36 MSK 2019, dateCommit=Wed Aug 21 17:27:39 MSK 2019, fiscalDocNum=4;7, sentToServerStatus=UNCOMMITED]
  355. 21.08 17:27:39.335 INFO  [SMServiceImpl] leaving getPromise(PurchaseEntity). Seems that no personalized card (with client) was applied in receipt: PurchaseEntity [id=2571, number=4, dateCreate=Wed Aug 21 17:27:36 MSK 2019, dateCommit=Wed Aug 21 17:27:39 MSK 2019, fiscalDocNum=4;7, sentToServerStatus=UNCOMMITED]
  356. 21.08 17:27:39.335 ERROR [LoymaxLoyProvider] purchaseFiscalized failed: PurchaseEntity [id=2571, number=4, dateCreate=Wed Aug 21 17:27:36 MSK 2019, dateCommit=Wed Aug 21 17:27:39 MSK 2019, fiscalDocNum=4;7, sentToServerStatus=UNCOMMITED]. Service is not available
  357. 21.08 17:27:39.335 WARN  [AeroflotBonusesLoyProvider] purchaseFiscalized failed: PurchaseEntity [id=2571, number=4, dateCreate=Wed Aug 21 17:27:36 MSK 2019, dateCommit=Wed Aug 21 17:27:39 MSK 2019, fiscalDocNum=4;7, sentToServerStatus=UNCOMMITED]. Service is not available
  358. 21.08 17:27:39.342 TRACE [ExternalProcessingsImpl] leaving purchaseFiscalized(PurchaseEntity). It took 31 [ms]
  359. 21.08 17:27:39.346 INFO  [FiscalPrinter] printServiceDocument
  360. 21.08 17:27:39.347 INFO  [AbstractFiscalPrinterEmulator] printServiceDocument
  361. 21.08 17:27:39.370 ERROR [ExternalEncryptedEventPacket] Thread-48   Ошибка расшифровки пакета
  362. java.security.InvalidKeyException: Unwrapping failed
  363.     at com.sun.crypto.provider.RSACipher.engineUnwrap(RSACipher.java:445)
  364.     at javax.crypto.Cipher.unwrap(Cipher.java:2550)
  365.     at ru.crystals.pos.prismabridge.external.ExternalPacketCipher.encryptAesKey(ExternalPacketCipher.java:57)
  366.     at ru.crystals.pos.prismabridge.external.ExternalPacketCipher.decode(ExternalPacketCipher.java:48)
  367.     at ru.crystals.pos.prismabridge.external.ExternalEncryptedEventPacket.parseEvent(ExternalEncryptedEventPacket.java:44)
  368.     at ru.crystals.pos.emulator.prisma.PrismaEmulatorRunnable.decodePacket(PrismaEmulatorRunnable.java:168)
  369.     at ru.crystals.pos.emulator.prisma.PrismaEmulatorRunnable.readBytes(PrismaEmulatorRunnable.java:91)
  370.     at ru.crystals.pos.emulator.prisma.PrismaEmulatorRunnable.run(PrismaEmulatorRunnable.java:71)
  371.     at java.lang.Thread.run(Thread.java:745)
  372. Caused by: javax.crypto.BadPaddingException: Decryption error
  373.     at sun.security.rsa.RSAPadding.unpadV15(RSAPadding.java:380)
  374.     at sun.security.rsa.RSAPadding.unpad(RSAPadding.java:291)
  375.     at com.sun.crypto.provider.RSACipher.doFinal(RSACipher.java:363)
  376.     at com.sun.crypto.provider.RSACipher.engineUnwrap(RSACipher.java:440)
  377.     ... 8 more
  378. 21.08 17:27:39.381 TRACE [SCService] entering isEnabled()
  379. 21.08 17:27:39.381 TRACE [SCService] leaving isEnabled(). the result is: true
  380. 21.08 17:27:39.381 TRACE [SCService] Entering commitDiscounts (LoyTransactionEntity, PurchaseEntity). The arguments are loy-tx [shop: 3388, cash: 7, inn: 7743543761, shift: 1, purchase-number: (NULL), discount-value: 0, discount-positions: []], PurchaseEntity [id=2571, number=4, dateCreate=Wed Aug 21 17:27:36 MSK 2019, dateCommit=Wed Aug 21 17:27:39 MSK 2019, fiscalDocNum=4;7, sentToServerStatus=UNCOMMITED]
  381. 21.08 17:27:39.382 TRACE [SCService] Stop send Personal Offer
  382. 21.08 17:27:39.382 TRACE [SCService] Remove Personal offer feedback
  383. 21.08 17:27:39.383 INFO  [SCReceiptConverter] Entering createFiscalCheque(purchaseEntity, loyTransactionEntity). The arguments are PurchaseEntity [id=2571, number=4, dateCreate=Wed Aug 21 17:27:36 MSK 2019, dateCommit=Wed Aug 21 17:27:39 MSK 2019, fiscalDocNum=4;7, sentToServerStatus=UNCOMMITED] , loy-tx [shop: 3388, cash: 7, inn: 7743543761, shift: 1, purchase-number: (NULL), discount-value: 0, discount-positions: []]
  384. 21.08 17:27:39.383 TRACE [SCService] Send request <?xml version="1.0" encoding="UTF-8" standalone="yes"?>
  385. <ChequeRequest xmlns="http://smartcheckout.ru/xsd/s10ren.xsd" ChequeType="Fiscal">
  386.     <RequestID>1566397656453</RequestID>
  387.     <Defer>false</Defer>
  388.     <Card>
  389.         <CardNumber>9905100100001</CardNumber>
  390.     </Card>
  391.     <DateTime>2019-08-21T17:27:39.383+03:00</DateTime>
  392.     <POS>7</POS>
  393.     <Number>1566397656453</Number>
  394.     <Summ>87.81</Summ>
  395.     <Discount>0.000</Discount>
  396.     <SummDiscounted>87.81</SummDiscounted>
  397.     <Item>
  398.         <PositionNumber>1</PositionNumber>
  399.         <Article>00666</Article>
  400.         <ArticleName>Напиток грушевый кисло-сладкий (Россия)</ArticleName>
  401.         <Price>87.81</Price>
  402.         <Quantity>1.000</Quantity>
  403.         <Summ>87.81</Summ>
  404.         <Discount>0.000</Discount>
  405.         <SummDiscounted>87.81</SummDiscounted>
  406.     </Item>
  407. </ChequeRequest>
  408.  
  409. 21.08 17:27:39.384 TRACE [SCService] entering getServices()
  410. 21.08 17:27:39.384 TRACE [SCService] getting services (IN MEMORY)
  411. 21.08 17:27:39.384 TRACE [SCService] leaving getServices(). The result size is: 2
  412. 21.08 17:27:39.392 TRACE [MLServiceImpl] entering isEnabled()
  413. 21.08 17:27:39.395 TRACE [MLServiceImpl] leaving isEnabled(). the result is: true
  414. 21.08 17:27:39.396 TRACE [MLServiceImpl] entering getMlCardNo(PurchaseEntity). The argument is: PurchaseEntity [id=2571, number=4, dateCreate=Wed Aug 21 17:27:36 MSK 2019, dateCommit=Wed Aug 21 17:27:39 MSK 2019, fiscalDocNum=4;7, sentToServerStatus=UNCOMMITED]
  415. 21.08 17:27:39.396 TRACE [MLServiceImpl] leaving getMlCardNo(PurchaseEntity). The result is: null
  416. 21.08 17:27:39.396 TRACE [MLServiceImpl] entering getMlCouponNo(PurchaseEntity). The argument is: PurchaseEntity [id=2571, number=4, dateCreate=Wed Aug 21 17:27:36 MSK 2019, dateCommit=Wed Aug 21 17:27:39 MSK 2019, fiscalDocNum=4;7, sentToServerStatus=UNCOMMITED]
  417. 21.08 17:27:39.396 TRACE [MLServiceImpl] leaving getMlCouponNo(PurchaseEntity). The result is: null
  418. 21.08 17:27:39.395 TRACE [SCService] Received response: <?xml version="1.0" encoding="UTF-8" standalone="yes"?>
  419. <ChequeRequestResponce xmlns="http://smartcheckout.ru/xsd/s10ren.xsd">
  420.     <RequestID>1566397656453</RequestID>
  421.     <Processed>2019-08-21T17:27:39.392+03:00</Processed>
  422.     <ReturnCode>0</ReturnCode>
  423.     <CashierMessageTO>0</CashierMessageTO>
  424.     <Summ>87.81</Summ>
  425.     <Discount>0.000</Discount>
  426.     <SummDiscounted>87.81</SummDiscounted>
  427.     <Item>
  428.         <PositionNumber>1</PositionNumber>
  429.         <Article>00666</Article>
  430.         <ArticleName>Напиток грушевый кисло-сладкий (Россия)</ArticleName>
  431.         <Price>87.81</Price>
  432.         <MinPrice>0</MinPrice>
  433.         <Quantity>1.000</Quantity>
  434.         <Summ>87.81</Summ>
  435.         <Discount>0.000</Discount>
  436.         <SummDiscounted>87.81</SummDiscounted>
  437.     </Item>
  438. </ChequeRequestResponce>
  439.  
  440. 21.08 17:27:39.401 INFO  [TechProcessShift] Check = PurchaseEntity [id=2571, number=4, dateCreate=Wed Aug 21 17:27:36 MSK 2019, dateCommit=Wed Aug 21 17:27:39 MSK 2019, fiscalDocNum=4;7, sentToServerStatus=NO_SENT]
  441.  checkNum = 0
  442.  checkModule.getCurrentPurchaseEntry().getCurrentState() = REG_CHECK
  443. 21.08 17:27:39.401 TRACE [ExternalProcessingsImpl] afterFiscalize: no implementation of externalLoyaltyService
  444. 21.08 17:27:39.420 INFO  [SpeedLog] TechProcess fiscalizeCheck operationType = true, positions count = 1  time = 382 ms
  445. 21.08 17:27:39.664 INFO  [FiscalPrinter] isMoneyDrawerOpen
  446. 21.08 17:27:39.701 INFO  [CommonLogger] Starting cleaning. All log records older than 23 мая 2019 17:27:39 will be deleted.
  447. 21.08 17:27:39.754 INFO  [CommonLogger] Cleaning done.
  448. 21.08 17:27:40.168 INFO  [FiscalPrinter] isMoneyDrawerOpen
  449. 21.08 17:27:40.500 INFO  [TechProcessImpl] eventControlKey: ControlKey [scanCode=10, command=kbdEnter]
  450. 21.08 17:27:40.522 INFO  [TechProcessImpl] saveCheck PurchaseEntity [id=2571, number=4, dateCreate=Wed Aug 21 17:27:36 MSK 2019, dateCommit=Wed Aug 21 17:27:39 MSK 2019, fiscalDocNum=4;7, sentToServerStatus=NO_SENT]
  451. 21.08 17:27:40.523 INFO  [CheckService] saveCheck: PurchaseEntity [id=2571, number=4, dateCreate=Wed Aug 21 17:27:36 MSK 2019, dateCommit=Wed Aug 21 17:27:39 MSK 2019, fiscalDocNum=4;7, sentToServerStatus=NO_SENT]
  452. 21.08 17:27:40.523 INFO  [FiscalPrinter] isMoneyDrawerOpen
  453. 21.08 17:27:40.527 INFO  [TechProcessImpl] Select seller [null]
  454. 21.08 17:27:40.669 INFO  [FiscalPrinter] isMoneyDrawerOpen
  455. 21.08 17:27:41.169 INFO  [FiscalPrinter] isMoneyDrawerOpen
  456. 21.08 17:27:42.286 INFO  [CashConfigurationUpdateChecker] Current status: IN_WORK
  457. 21.08 17:27:42.296 INFO  [CashConfigurationUpdateChecker] Received patches list: []
  458. 21.08 17:27:42.304 INFO  [CashConfigurationUpdateChecker] isNeedWaitUpdateCommand: false
  459. 21.08 17:27:42.312 INFO  [CashConfigurationUpdateChecker] sleepInt(60000)
  460. 21.08 17:27:44.832 INFO  [DocumentSender] ping = true
  461. 21.08 17:27:54.639 INFO  [TransferManager] OD found 0 documents to register
  462. 21.08 17:27:54.663 INFO  [DocumentSender] OD found 0 transactions to register
  463. 21.08 17:27:54.666 INFO  [DocumentSender] response message = Created
  464. 21.08 17:27:54.667 INFO  [TransferManager] Send document status : 2571 > WAIT_ACKNOWLEDGEMENT            file name : 7/Document_20190821172754_664_3388_7.ser
  465. 21.08 17:27:54.668 INFO  [CheckService] SetSentToServerStatus : 2571 > WAIT_ACKNOWLEDGEMENT file name : 7/Document_20190821172754_664_3388_7.ser
  466. 21.08 17:27:54.675 INFO  [DocumentSender] document 7/Document_20190821172754_664_3388_7.ser has been registered
  467. 21.08 17:27:54.676 INFO  [TransferManager] Send document status : 2571 > SENT            file name : 7/Document_20190821172754_664_3388_7.ser
  468. 21.08 17:27:54.680 INFO  [CheckService] SetSentToServerStatus : 2571 > SENT file name : 7/Document_20190821172754_664_3388_7.ser
  469. 21.08 17:27:54.706 INFO  [DocumentSender] OD found 0 payment transactions
  470. 21.08 17:27:59.691 INFO  [TransferManager] File 7/LoyTransaction_20190821172759_676_3388_7.ser sucessfully registered
  471. 21.08 17:27:59.706 INFO  [TransferManager] 1 transactions processed to upload; 1 transactions processed to register; Time: 31 ms.
  472. 21.08 17:28:05.396 DEBUG [TechProcessImpl] Server online mode
  473. 21.08 17:28:34.840 INFO  [DocumentSender] ping = true
  474. 21.08 17:28:35.398 DEBUG [TechProcessImpl] Server online mode
  475. 21.08 17:28:36.292 INFO  [PendingOperationQueue] Pending cards operation queue is empty. Populating from DB...
  476. 21.08 17:28:36.352 INFO  [PendingOperationQueue] No pending card operations found.
  477. 21.08 17:28:36.513 INFO  [LoyProvidersRegistryImpl] Resend stale feedback
  478. 21.08 17:28:36.513 INFO  [LoyProvidersRegistryImpl] Search for stale feedback provider = SetApiLoyaltyPlugin
  479. 21.08 17:28:36.515 INFO  [LoyProvidersRegistryImpl] There is no stale feedback for SetApiLoyaltyPlugin
  480. 21.08 17:28:36.515 INFO  [LoyProvidersRegistryImpl] Search for stale feedback provider = sm
  481. 21.08 17:28:36.515 INFO  [LoyProvidersRegistryImpl] There is no stale feedback for sm
  482. 21.08 17:28:36.516 INFO  [LoyProvidersRegistryImpl] Search for stale feedback provider = smch
  483. 21.08 17:28:36.516 INFO  [LoyProvidersRegistryImpl] There is no stale feedback for smch
  484. 21.08 17:28:36.516 INFO  [LoyProvidersRegistryImpl] Search for stale feedback provider = ml
  485. 21.08 17:28:36.517 INFO  [LoyProvidersRegistryImpl] There is no stale feedback for ml
  486. 21.08 17:28:36.517 INFO  [LoyProvidersRegistryImpl] Search for stale feedback provider = set-loy-provider
  487. 21.08 17:28:36.518 INFO  [LoyProvidersRegistryImpl] There is no stale feedback for set-loy-provider
  488. 21.08 17:28:36.518 INFO  [LoyProvidersRegistryImpl] Search for stale feedback provider = kopilka
  489. 21.08 17:28:36.519 INFO  [LoyProvidersRegistryImpl] There is no stale feedback for kopilka
  490. 21.08 17:28:36.519 INFO  [LoyProvidersRegistryImpl] Search for stale feedback provider = loymax
  491. 21.08 17:28:36.520 INFO  [LoyProvidersRegistryImpl] There is no stale feedback for loymax
  492. 21.08 17:28:36.520 INFO  [LoyProvidersRegistryImpl] Search for stale feedback provider = aeroflotBonusesCFT
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!