Pasted

24.09 17:09:18.396 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] Event to frontend 1: {"type":"form.popap.info","payload":{"imageId":"INFO","text":["Сумма чека, которую можно оплатить милями: 3 миль = 0.90 руб."],"buttons":[{"text":"OK","callback":{"type":"dynamic.9f028ba4-20c3-4e64-8d71-2e8784642c39.dynamic","payload":{}}}],"areaOutside":{"type":"dynamic.9f028ba4-20c3-4e64-8d71-2e8784642c39.dynamic","payload":{}}}}
24.09 17:09:18.399 INFO  [DocumentSender] OD found 0 transactions to register
24.09 17:09:21.509 INFO  [FiscalPrinter] getPrinterState
24.09 17:09:26.125 TRACE [AbstractWSEP] [qtp11858629-398] WS-session receive: {"type":"dynamic.9f028ba4-20c3-4e64-8d71-2e8784642c39.dynamic","payload":{}}
24.09 17:09:26.125 TRACE [AbstractEventProcessor] [Main-event-thread] AEROFLOT_BONUSES_PLUGIN_ID:90095017-0f42-45e8-9116-e386187397fa receive event: dynamic.9f028ba4-20c3-4e64-8d71-2e8784642c39.dynamic
24.09 17:09:26.126 TRACE [AbstractEventProcessor] [Main-event-thread] AEROFLOT_BONUSES_PLUGIN_ID:90095017-0f42-45e8-9116-e386187397fa send event to frontend: FORM_SALE_CHECK_WRITEOFFBONUSES_SHOW
24.09 17:09:26.126 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] Event to frontend 1: {"type":"form.check.writeOffBonuses.show","payload":{"upperHeader":"Списание милей Аэрофлот","bottomHeader":"К списанию (мин. 1)","buttonName":"Списать","maxSum":"3","defaultSum":"3","checkSum":"3","minSum":"1","buttonEnabled":true,"closeEnabled":true,"numpadWithComma":false}}
24.09 17:09:26.510 INFO  [FiscalPrinter] getPrinterState
24.09 17:09:26.731 TRACE [AbstractWSEP] [qtp11858629-535] WS-session receive: {"type":"form.check.writeOffBonuses.put","payload":{"sumToPay":"3"}}
24.09 17:09:26.732 TRACE [AbstractEventProcessor] [Main-event-thread] AEROFLOT_BONUSES_PLUGIN_ID:90095017-0f42-45e8-9116-e386187397fa receive event: FORM_SALE_CHECK_WRITEOFFBONUSES_PUT
24.09 17:09:26.732 TRACE [AbstractEventProcessor] [Main-event-thread] AEROFLOT_BONUSES_PLUGIN_ID:90095017-0f42-45e8-9116-e386187397fa send event to frontend: FORM_SALE_CARD_MANUAL_INPUT_SHOW
24.09 17:09:26.733 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] Event to frontend 1: {"type":"form.sale.card.manualInput.show","payload":{"inputTitle":"Введите пин-код","inputType":"NUMBER","inputLength":4,"buttons":[]}}
24.09 17:09:28.221 DEBUG [TechProcessImpl] Server online mode
24.09 17:09:28.222 TRACE [AbstractEventProcessor] [Main-event-thread] AEROFLOT_BONUSES_PLUGIN_ID:90095017-0f42-45e8-9116-e386187397fa receive event: TechProcessEvent.eventOnlineMode
24.09 17:09:31.510 INFO  [FiscalPrinter] getPrinterState
24.09 17:09:36.239 TRACE [AbstractWSEP] [qtp11858629-527] WS-session receive: {"type":"form.sale.card.manualInput.put","payload":{"data":"2222","inputType":"NUMBER","accepted":true}}
24.09 17:09:36.240 TRACE [AbstractEventProcessor] [Main-event-thread] AEROFLOT_BONUSES_PLUGIN_ID:90095017-0f42-45e8-9116-e386187397fa receive event: FORM_SALE_CARD_MANUAL_INPUT_PUT
24.09 17:09:36.240 TRACE [AbstractEventProcessor] [Main-event-thread] AEROFLOT_BONUSES_PLUGIN_ID:90095017-0f42-45e8-9116-e386187397fa send event to frontend: FORM_WAIT_SHOW
24.09 17:09:36.241 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] Event to frontend 1: {"type":"form.wait.show","payload":{"text":["Ожидайте завершения операции..."],"fadeInTime":1,"timeout":120}}
24.09 17:09:36.243 INFO  [AeroflotBonusesServiceImpl] Send authPoints request = '{"id":"010177200062000021569334176243","terminal":"randomText","location":"randomText","partnerId":0,"track1":null,"track2":null,"track3":null,"barCode":null,"pan":"101735686","hash":null,"gcdata":null,"cardholder":null,"phone":null,"dateTime":"20190924170936","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":"020177200062000021569334176243"},{"name":"PINCODE","value":"de72ffe86d20fb8ca0ec7e87f394fe64b098d627"},{"name":"NONCE","value":"030177200062000021569334176241"},{"name":"MILES","value":"3"}]}}]}}'
24.09 17:09:36.510 INFO  [FiscalPrinter] getPrinterState
24.09 17:09:36.725 INFO  [AeroflotBonusesServiceImpl] Receive authPoints response code = '0', description = 'null'
24.09 17:09:36.733 TRACE [AbstractEventProcessor] [Main-event-thread] AEROFLOT_BONUSES_PLUGIN_ID:90095017-0f42-45e8-9116-e386187397fa send event to frontend: FORM_WAIT_CLOSE
24.09 17:09:36.733 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] Event to frontend 1: {"type":"form.wait.close","payload":{}}
24.09 17:09:36.734 TRACE [AbstractEventProcessor] [Main-event-thread] Exit (imm) from 'AEROFLOT_BONUSES_PLUGIN_ID:90095017-0f42-45e8-9116-e386187397fa' and start (imm) previous 'FUNCTION_MENU'
24.09 17:09:36.734 TRACE [AbstractEventProcessor] [Main-event-thread] AEROFLOT_BONUSES_PLUGIN_ID:90095017-0f42-45e8-9116-e386187397fa start (imm) this FUNCTION_MENU with e=INNER_PROCESSOR_EXIT
24.09 17:09:36.734 TRACE [AbstractEventProcessor] [Main-event-thread] Stop processor: AEROFLOT_BONUSES_PLUGIN_ID:90095017-0f42-45e8-9116-e386187397fa, prevPT=FUNCTION_MENU
24.09 17:09:36.735 TRACE [AbstractEventProcessor] [Main-event-thread] Start processor: Type:FUNCTION_MENU, prevPT=SALE_PAYMENT
24.09 17:09:36.735 TRACE [AbstractEventProcessor] [Main-event-thread] Type:FUNCTION_MENU receive event: INNER_PROCESSOR_EXIT
24.09 17:09:36.735 TRACE [AbstractEventProcessor] [Main-event-thread] Exit from 'Type:FUNCTION_MENU' and start previous 'SALE_PAYMENT'
24.09 17:09:36.735 TRACE [AbstractEventProcessor] [Main-event-thread] Type:FUNCTION_MENU start this SALE_PAYMENT with e=INNER_PROCESSOR_EXIT
24.09 17:09:36.735 TRACE [AbstractEventProcessor] [Main-event-thread] AEROFLOT_BONUSES_PLUGIN_ID:90095017-0f42-45e8-9116-e386187397fa start this SALE_SUBTOTAL with e=FORM_SALE_CHECK_SUBTOTALRUN
24.09 17:09:36.735 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@8d6dfa']
24.09 17:09:36.736 TRACE [AbstractEventProcessor] [Main-event-thread] Stop processor: Type:FUNCTION_MENU, prevPT=SALE_PAYMENT
24.09 17:09:36.736 TRACE [AbstractEventProcessor] [Main-event-thread] Start processor: Type:SALE_SUBTOTAL, prevPT=FUNCTION_MENU
24.09 17:09:36.736 INFO  [AbstractExtraEventProcessor] [Main-event-thread] SaleTabExtraProcessor sends event CashEvent [eventType='sd.show', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.EmptyPld@8d6dfa']
24.09 17:09:36.737 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL send event to frontend: SD_SHOW
24.09 17:09:36.737 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] Event to frontend 1: {"type":"sd.show","payload":{}}
24.09 17:09:36.737 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@6d3bcd']
24.09 17:09:36.737 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL send event to frontend: SD_TAB_PUT
24.09 17:09:36.738 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] Event to frontend 1: {"type":"sd.tab.put","payload":{"tabs":[{"name":"ПРОДАЖА","tabId":"8a4f7479-c538-48d0-843a-23d48af50e29"},{"name":"Кафе","tabId":"699617b2-8893-436e-ba9d-6d610284b79e"}]}}
24.09 17:09:36.748 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductJewelController
24.09 17:09:36.749 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductClothingController
24.09 17:09:36.749 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductCFTGiftCardController
24.09 17:09:36.749 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductBonusPointsController
24.09 17:09:36.749 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductMetricController
24.09 17:09:36.749 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductMobilePayController
24.09 17:09:36.749 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL send event to frontend: FORM_CHECK_PUT
24.09 17:09:36.750 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] Event to frontend 1: {"type":"form.check.put","payload":{"check":{"discount":{"value":"0.00","percentValue":"0.00","cardEnabled":false},"checkSum":"15.01","positions":[{"itemId":1,"name":"Кефир малиновый кисло-сладкий (Россия)","quantity":"1","measure":"Шт","sum":"15.01","item":"00601","barcode":"4600601000001","marked":false,"positionCouponEnabled":false,"manualDiscountEnabled":false}],"positionCouponEnabled":false,"manualDiscountEnabled":false},"buttons":[{"text":"РАССЧИТАТЬ","callback":{"type":"form.sale.check.subtotalRun","payload":{}}}]}}
24.09 17:09:36.752 INFO  [AbstractExtraEventProcessor] [Main-event-thread] CdForwardExtraProcessor sends event CashEvent [eventType='cd.check.put', canProcessed='true', pld='ru.crystals.pos.touch2.customerdisplay.payload.CdCheckPutPld@1a6e4ff']
24.09 17:09:36.752 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL send event to frontend: CD_CHECK_PUT
24.09 17:09:36.752 TRACE [AbstractEventProcessor] [Main-event-thread] Type:CD_PAYMENT_STATE receive event: CD_CHECK_PUT
24.09 17:09:36.753 TRACE [AbstractEventProcessor] [Main-event-thread] Type:CD_PAYMENT_STATE send event to frontend: CD_CHECK_PUT
24.09 17:09:36.754 INFO  [AbstractEventSender] [Internal-Cash-Pool-Executor_24] StatusBarEventSender sends event CashEvent [eventType='form.notice.clear', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.EmptyPld@8d6dfa']
24.09 17:09:36.754 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] Event to frontend 1: {"type":"form.notice.clear","payload":{}}
24.09 17:09:36.756 INFO  [AbstractEventSender] [Internal-Cash-Pool-Executor_24] AdditionalMenuEventSender sends event CashEvent [eventType='additionalMenu.configuration', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.additionalmenu.AdditionalMenuConfigurationPld@153e736']
24.09 17:09:36.756 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] Event to frontend 1: {"type":"additionalMenu.configuration","payload":{"goodsFindIconEnabled":true,"printDocumentIconEnabled":true,"functionMenuIconEnabled":true,"infoMenuIconEnabled":true}}
24.09 17:09:36.756 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL receive event: FORM_SALE_CHECK_SUBTOTALRUN
24.09 17:09:36.757 TRACE [SaleSubtotalProcessor] [Main-event-thread] SaleSubtotalScenario.rollbackLoyTransaction:in
24.09 17:09:36.758 TRACE [SaleSubtotalProcessor] [Main-event-thread] SaleSubtotalScenario.rollbackLoyTransaction:out
24.09 17:09:36.759 TRACE [SaleSubtotalProcessor] [Main-event-thread] SaleSubtotalScenario.updateLoyaltyArguments:in
24.09 17:09:36.760 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL send event to frontend: FORM_POPAP_INFO_CLOSE
24.09 17:09:36.760 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] Event to frontend 1: {"type":"form.popap.info.close","payload":{}}
24.09 17:09:36.761 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL send event to frontend: FORM_WAIT_SHOW
24.09 17:09:36.761 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] Event to frontend 1: {"type":"form.wait.show","payload":{"text":["Подождите, идет расчет скидок"],"fadeInTime":1,"timeout":120}}
24.09 17:09:36.763 TRACE [SaleSubtotalProcessor] [Main-event-thread] SaleSubtotalScenario.updateLoyaltyArguments:out
24.09 17:09:36.763 TRACE [TechProcessImpl] Start warn divide alco
24.09 17:09:36.763 TRACE [TechProcessImpl] End warn devide alco
24.09 17:09:36.764 INFO  [TechProcessImpl] goToDiscounts
24.09 17:09:36.773 INFO  [LoyalBridgeServiceImpl] --------------- begin discount calculation ---------------
24.09 17:09:36.776 INFO  [LoyalProductFinder] Time finding items (1) = 3 ms
24.09 17:09:36.776 INFO  [LoyalProductsConverter] Time searching loyal goods for 1 productItems = 3 ms
24.09 17:09:36.776 INFO  [LoyalCalculatorConverter] Time converting 1 positions = 0 ms
24.09 17:09:36.776 TRACE [MLServiceImpl] entering getMlCardNo(Purchase). The argument is: Purchase{number=15, dateCreate=Tue Sep 24 17:09:12 MSK 2019, checkSum=1501, operationType=true, discountValueTotal=0}
24.09 17:09:36.776 TRACE [MLServiceImpl] leaving getMlCardNo(Purchase). The receipt does not have cards applied
24.09 17:09:36.776 TRACE [MLServiceImpl] entering getMlCouponNo(PurchaseEntity). The argument is: Purchase{number=15, dateCreate=Tue Sep 24 17:09:12 MSK 2019, checkSum=1501, operationType=true, discountValueTotal=0}
24.09 17:09:36.776 TRACE [MLServiceImpl] leaving getMlCouponNo(PurchaseEntity). The receipt does not have cards applied
24.09 17:09:36.777 INFO  [DoProcessing] ============ LoyalCalculation: doDiscount start ============
24.09 17:09:36.777 INFO  [DoProcessing] GeneralInteractionMethod: MAXIMUM_DISCOUNT
24.09 17:09:36.777 INFO  [DoProcessing] ============ LoyalCalculation: doDiscount success ============
24.09 17:09:36.778 TRACE [MLServiceImpl] entering getMlCardNo(Purchase). The argument is: Purchase{number=15, dateCreate=Tue Sep 24 17:09:12 MSK 2019, checkSum=1501, operationType=true, discountValueTotal=0}
24.09 17:09:36.778 TRACE [MLServiceImpl] leaving getMlCardNo(Purchase). The receipt does not have cards applied
24.09 17:09:36.778 TRACE [MLServiceImpl] entering getMlCouponNo(PurchaseEntity). The argument is: Purchase{number=15, dateCreate=Tue Sep 24 17:09:12 MSK 2019, checkSum=1501, operationType=true, discountValueTotal=0}
24.09 17:09:36.778 TRACE [MLServiceImpl] leaving getMlCouponNo(PurchaseEntity). The receipt does not have cards applied
24.09 17:09:36.778 TRACE [SCService] entering isEnabled()
24.09 17:09:36.778 TRACE [SCService] leaving isEnabled(). the result is: true
24.09 17:09:36.778 TRACE [SCService] entering calcDiscount(Purchase). The argument is: Purchase{number=15, dateCreate=Tue Sep 24 17:09:12 MSK 2019, checkSum=1501, operationType=true, discountValueTotal=0}
24.09 17:09:36.779 TRACE [SCService] Send request <?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ChequeRequest xmlns="http://smartcheckout.ru/xsd/s10ren.xsd" ChequeType="Soft">
    <RequestID>1569334152395</RequestID>
    <DateTime>2019-09-24T17:09:36.778+03:00</DateTime>
    <POS>62</POS>
    <Number>1569334152395</Number>
    <Summ>15.01</Summ>
    <Discount>0.000</Discount>
    <SummDiscounted>15.01</SummDiscounted>
    <Item>
        <PositionNumber>1</PositionNumber>
        <Article>00601</Article>
        <ArticleName>Кефир малиновый кисло-сладкий (Россия)</ArticleName>
        <Price>15.01</Price>
        <Quantity>1.000</Quantity>
        <Summ>15.01</Summ>
        <Discount>0.000</Discount>
        <SummDiscounted>15.01</SummDiscounted>
    </Item>
</ChequeRequest>
 
24.09 17:09:36.779 TRACE [SCService] entering getServices()
24.09 17:09:36.779 TRACE [SCService] getting services (IN MEMORY)
24.09 17:09:36.779 TRACE [SCService] leaving getServices(). The result size is: 2
24.09 17:09:36.794 TRACE [SCService] Received response: <?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ChequeRequestResponce xmlns="http://smartcheckout.ru/xsd/s10ren.xsd">
    <RequestID>1569334152395</RequestID>
    <Processed>2019-09-24T17:09:36.787+03:00</Processed>
    <ReturnCode>0</ReturnCode>
    <CashierMessageTO>0</CashierMessageTO>
    <Summ>15.01</Summ>
    <Discount>0.000</Discount>
    <SummDiscounted>15.01</SummDiscounted>
    <Item>
        <PositionNumber>1</PositionNumber>
        <Article>00601</Article>
        <ArticleName>Кефир малиновый кисло-сладкий (Россия)</ArticleName>
        <Price>15.01</Price>
        <MinPrice>0</MinPrice>
        <Quantity>1.000</Quantity>
        <Summ>15.01</Summ>
        <Discount>0.000</Discount>
        <SummDiscounted>15.01</SummDiscounted>
    </Item>
</ChequeRequestResponce>
 
24.09 17:09:36.794 TRACE [SCReceiptConverter] ml discounts: {position-key [marking: 00601; original-price: 1501]=0}
24.09 17:09:36.794 TRACE [SCReceiptConverter] it was inferred that no SC POS discounts were given on position [key: position-key [marking: 00601; original-price: 1501]]: SC discount value is: 0
24.09 17:09:36.794 TRACE [SCService] leaving calcDiscount(Purchase). The result is: Purchase{number=null, dateCreate=null, checkSum=1501, operationType=null, discountValueTotal=0}; it took 16 [ms]
24.09 17:09:36.795 INFO  [DoProcessing] ============ LoyalCalculation: doDiscount start ============
24.09 17:09:36.795 INFO  [DoProcessing] GeneralInteractionMethod: MAXIMUM_DISCOUNT
24.09 17:09:36.806 INFO  [DoProcessing] ============ LoyalCalculation: doDiscount success ============
24.09 17:09:36.807 ERROR [AeroflotBonusesLoyProvider] process failed. Internal error: Unable distribute discount
ru.crystals.pos.cards.aeroflot.exception.AeroflotBonusesServiceException: Unable distribute discount
    at ru.crystals.pos.aeroflot.loyalty.AeroflotBonusesLoyService.distributeBonuses(AeroflotBonusesLoyService.java:91)
    at ru.crystals.pos.aeroflot.loyalty.AeroflotBonusesLoyService.writeOff(AeroflotBonusesLoyService.java:56)
    at ru.crystals.pos.aeroflot.loyalty.AeroflotBonusesLoyProvider.process(AeroflotBonusesLoyProvider.java:75)
    at ru.crystals.loyal.providers.LoyProvidersRegistryImpl.process(LoyProvidersRegistryImpl.java:125)
    at ru.crystals.pos.loyal.cash.service.LoyalServiceImpl.calcDiscounts(LoyalServiceImpl.java:801)
    at ru.crystals.pos.loyal.cash.service.LoyalServiceImpl.doLoyalty(LoyalServiceImpl.java:730)
    at ru.crystals.pos.loyal.cash.service.LoyalServiceImpl.doDiscount(LoyalServiceImpl.java:842)
    at ru.crystals.pos.loyal.bridge.service.LoyalBridgeServiceImpl.doDiscount(LoyalBridgeServiceImpl.java:162)
    at ru.crystals.pos.techprocess.TechProcessImpl.applyDiscountsAndGetResult(TechProcessImpl.java:3872)
    at ru.crystals.pos.techprocess.TechProcessImpl.subtotalScenario(TechProcessImpl.java:3442)
    at ru.crystals.pos.touch2.process.scenarios.SaleSubtotalScenario.subtotalRun(SaleSubtotalScenario.java:223)
    at ru.crystals.pos.touch2.events.processors.impl.sale.SaleSubtotalProcessor.onFormSaleCheckSubtotalRun(SaleSubtotalProcessor.java:363)
    at ru.crystals.pos.touch2.events.processors.impl.sale.SaleSubtotalProcessor.lambda$processCashEvent$0(SaleSubtotalProcessor.java:281)
    at java.util.Optional.ifPresent(Optional.java:159)
    at ru.crystals.pos.touch2.events.processors.impl.sale.SaleSubtotalProcessor.processCashEvent(SaleSubtotalProcessor.java:281)
    at ru.crystals.pos.touch2.events.processors.AbstractEventProcessor.applyCashEvent(AbstractEventProcessor.java:113)
    at ru.crystals.pos.touch2.events.managers.AbstractEventProcessingManager.startProcessorDirect(AbstractEventProcessingManager.java:399)
    at ru.crystals.pos.touch2.events.managers.AbstractEventProcessingManager.startProcessorImmediately(AbstractEventProcessingManager.java:413)
    at ru.crystals.pos.touch2.events.filters.AbstractEventsFilter.startProcessor(AbstractEventsFilter.java:43)
    at ru.crystals.pos.touch2.events.filters.impl.events.ProcessorEventsFilter.processCashEvent(ProcessorEventsFilter.java:21)
    at ru.crystals.pos.touch2.events.filters.AbstractEventsFilter.applyCashEvent(AbstractEventsFilter.java:32)
    at ru.crystals.pos.touch2.events.managers.AbstractEventProcessingManager.listenEventFromFrontend(AbstractEventProcessingManager.java:222)
    at ru.crystals.pos.touch2.events.managers.AbstractEventProcessingManager.processCashEvent(AbstractEventProcessingManager.java:431)
    at ru.crystals.pos.touch2.events.managers.AbstractEventProcessingManager.startMainEventThread(AbstractEventProcessingManager.java:102)
    at ru.crystals.pos.touch2.events.managers.AbstractEventProcessingManager.lambda$start$0(AbstractEventProcessingManager.java:81)
    at ru.crystals.pos.InternalCashPoolExecutorImpl.lambda$submit$2(InternalCashPoolExecutorImpl.java:118)
    at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
    at java.util.concurrent.FutureTask.run(FutureTask.java:266)
    at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
    at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
    at java.lang.Thread.run(Thread.java:745)
24.09 17:09:36.823 INFO  [AeroflotBonusesServiceImpl] Send reverse request with txId = '010177200062000021569334176243'
24.09 17:09:37.260 INFO  [AeroflotBonusesServiceImpl] Receive reverse response code = '0', description = 'null'
24.09 17:09:37.261 ERROR [LoyalServiceImpl] One of the calculation step throws Try again exception! Discount calculation will be canceled
ru.crystals.loyal.providers.LoyProcessingTryItAgainException: Применение Аэрофлот Бонусы невозможно
    at ru.crystals.pos.aeroflot.loyalty.AeroflotBonusesLoyProvider.process(AeroflotBonusesLoyProvider.java:80)
    at ru.crystals.loyal.providers.LoyProvidersRegistryImpl.process(LoyProvidersRegistryImpl.java:125)
    at ru.crystals.pos.loyal.cash.service.LoyalServiceImpl.calcDiscounts(LoyalServiceImpl.java:801)
    at ru.crystals.pos.loyal.cash.service.LoyalServiceImpl.doLoyalty(LoyalServiceImpl.java:730)
    at ru.crystals.pos.loyal.cash.service.LoyalServiceImpl.doDiscount(LoyalServiceImpl.java:842)
    at ru.crystals.pos.loyal.bridge.service.LoyalBridgeServiceImpl.doDiscount(LoyalBridgeServiceImpl.java:162)
    at ru.crystals.pos.techprocess.TechProcessImpl.applyDiscountsAndGetResult(TechProcessImpl.java:3872)
    at ru.crystals.pos.techprocess.TechProcessImpl.subtotalScenario(TechProcessImpl.java:3442)
    at ru.crystals.pos.touch2.process.scenarios.SaleSubtotalScenario.subtotalRun(SaleSubtotalScenario.java:223)
    at ru.crystals.pos.touch2.events.processors.impl.sale.SaleSubtotalProcessor.onFormSaleCheckSubtotalRun(SaleSubtotalProcessor.java:363)
    at ru.crystals.pos.touch2.events.processors.impl.sale.SaleSubtotalProcessor.lambda$processCashEvent$0(SaleSubtotalProcessor.java:281)
    at java.util.Optional.ifPresent(Optional.java:159)
    at ru.crystals.pos.touch2.events.processors.impl.sale.SaleSubtotalProcessor.processCashEvent(SaleSubtotalProcessor.java:281)
    at ru.crystals.pos.touch2.events.processors.AbstractEventProcessor.applyCashEvent(AbstractEventProcessor.java:113)
    at ru.crystals.pos.touch2.events.managers.AbstractEventProcessingManager.startProcessorDirect(AbstractEventProcessingManager.java:399)
    at ru.crystals.pos.touch2.events.managers.AbstractEventProcessingManager.startProcessorImmediately(AbstractEventProcessingManager.java:413)
    at ru.crystals.pos.touch2.events.filters.AbstractEventsFilter.startProcessor(AbstractEventsFilter.java:43)
    at ru.crystals.pos.touch2.events.filters.impl.events.ProcessorEventsFilter.processCashEvent(ProcessorEventsFilter.java:21)
    at ru.crystals.pos.touch2.events.filters.AbstractEventsFilter.applyCashEvent(AbstractEventsFilter.java:32)
    at ru.crystals.pos.touch2.events.managers.AbstractEventProcessingManager.listenEventFromFrontend(AbstractEventProcessingManager.java:222)
    at ru.crystals.pos.touch2.events.managers.AbstractEventProcessingManager.processCashEvent(AbstractEventProcessingManager.java:431)
    at ru.crystals.pos.touch2.events.managers.AbstractEventProcessingManager.startMainEventThread(AbstractEventProcessingManager.java:102)
    at ru.crystals.pos.touch2.events.managers.AbstractEventProcessingManager.lambda$start$0(AbstractEventProcessingManager.java:81)
    at ru.crystals.pos.InternalCashPoolExecutorImpl.lambda$submit$2(InternalCashPoolExecutorImpl.java:118)
    at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
    at java.util.concurrent.FutureTask.run(FutureTask.java:266)
    at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
    at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
    at java.lang.Thread.run(Thread.java:745)
24.09 17:09:37.262 INFO  [TechProcessImpl] goToWaitGoods
24.09 17:09:37.264 TRACE [ExternalProcessingsImpl] seems that this cash is not aware of existence of CFT-backed loyality programms. So, there is no need to cancel CFT-backed bonuses charge-offs
24.09 17:09:37.264 TRACE [ExternalProcessingsImpl] seems that this cash is not aware of existence of CFT-backed loyality programms. So, there is no need to cancel CFT-backed bonuses charge-offs
24.09 17:09:37.264 TRACE [ExternalProcessingsImpl] Discounts cancelled: no implementation of PlastekServices.
24.09 17:09:37.264 TRACE [ExternalProcessingsImpl] entering discountCancelledToSet5(PurchaseEntity)
24.09 17:09:37.264 TRACE [ExternalProcessingsImpl] leaving discountCancelledToSet5(PurchaseEntity): the SET5 loy processing is disabled
24.09 17:09:37.275 WARN  [AeroflotBonusesServiceImpl] Unable reverse Tx, none = 'Optional.empty', pinCode = 'Optional.empty'
24.09 17:09:37.310 TRACE [TechProcessImpl] entering updateCheck(PurchaseEntity, int). The arguments are: check [PurchaseEntity [id=353, number=null, dateCreate=Tue Sep 24 17:09:12 MSK 2019, dateCommit=null, fiscalDocNum=null, sentToServerStatus=NO_SENT]], checkNum [15]
24.09 17:09:37.311 TRACE [TechProcessImpl] trying to recover transient bonus discount cards of receipt [PurchaseEntity [id=353, number=null, dateCreate=Tue Sep 24 17:09:12 MSK 2019, dateCommit=null, fiscalDocNum=null, sentToServerStatus=NO_SENT]] if any
24.09 17:09:37.312 WARN  [LoyalServiceImpl] The receipt [PurchaseEntity [id=353, number=null, dateCreate=Tue Sep 24 17:09:12 MSK 2019, dateCommit=null, fiscalDocNum=null, sentToServerStatus=NO_SENT]] point to non-existent loy-tx (by id: 23681)
24.09 17:09:37.312 TRACE [TechProcessImpl] attaching [{}] bonus discount cards to the receipt [PurchaseEntity [id=353, number=null, dateCreate=Tue Sep 24 17:09:12 MSK 2019, dateCommit=null, fiscalDocNum=null, sentToServerStatus=NO_SENT]]
24.09 17:09:37.312 TRACE [TechProcessImpl] leaving updateCheck(PurchaseEntity, int)
24.09 17:09:37.313 ERROR [TechProcessImpl] TP error: Применение Аэрофлот Бонусы невозможно
24.09 17:09:37.313 TRACE [SaleSubtotalProcessor] [Main-event-thread] SaleSubtotalScenario.rollbackLoyTransaction:in
24.09 17:09:37.314 TRACE [SaleSubtotalProcessor] [Main-event-thread] SaleSubtotalScenario.rollbackLoyTransaction:out
24.09 17:09:37.314 INFO  [TechProcessImpl] goToWaitGoods
24.09 17:09:37.314 ERROR [TechProcessImpl] Can't execute goToWaitGoods(). Check state is: WAIT_GOODS
24.09 17:09:37.314 TRACE [SaleSubtotalProcessor] [Main-event-thread] SaleSubtotalScenario.onSubtotalFail:in
24.09 17:09:37.315 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL send event to frontend: FORM_WAIT_CLOSE
24.09 17:09:37.315 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] Event to frontend 1: {"type":"form.wait.close","payload":{}}
24.09 17:09:37.316 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL send event to frontend: FORM_POPAP_INFO
24.09 17:09:37.316 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] Event to frontend 1: {"type":"form.popap.info","payload":{"imageId":"ERROR","text":["Применение Аэрофлот Бонусы невозможно"],"buttons":[{"text":"OK","callback":{"type":"dynamic.3bee3d97-0084-42ec-9446-b9c6cc73bfeb.dynamic","payload":{}}}],"areaOutside":{"type":"dynamic.3bee3d97-0084-42ec-9446-b9c6cc73bfeb.dynamic","payload":{}}}}
24.09 17:09:37.317 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_SUBTOTAL start this SALE with e=null
24.09 17:09:37.317 TRACE [SaleSubtotalProcessor] [Main-event-thread] SaleSubtotalScenario.onSubtotalFail:out
24.09 17:09:37.317 INFO  [AbstractEventsFilter] [Main-event-thread] ProcessorEventsFilter starts processor SALE with event null
24.09 17:09:37.317 TRACE [AbstractEventProcessor] [Main-event-thread] Stop processor: Type:SALE_SUBTOTAL, prevPT=FUNCTION_MENU
24.09 17:09:37.318 TRACE [AbstractEventProcessor] [Main-event-thread] Start processor: Type:SALE, prevPT=SALE_SUBTOTAL
24.09 17:09:37.326 INFO  [AbstractExtraEventProcessor] [Main-event-thread] SaleTabExtraProcessor sends event CashEvent [eventType='sd.show', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.EmptyPld@8d6dfa']
24.09 17:09:37.326 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE send event to frontend: SD_SHOW
24.09 17:09:37.326 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] Event to frontend 1: {"type":"sd.show","payload":{}}
24.09 17:09:37.327 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@5c9cdd']
24.09 17:09:37.327 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE send event to frontend: SD_TAB_PUT
24.09 17:09:37.327 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] Event to frontend 1: {"type":"sd.tab.put","payload":{"tabs":[{"name":"ПРОДАЖА","tabId":"8a4f7479-c538-48d0-843a-23d48af50e29"},{"name":"Кафе","tabId":"699617b2-8893-436e-ba9d-6d610284b79e"}]}}
24.09 17:09:37.330 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@145b424']
24.09 17:09:37.331 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE send event to frontend: SD_TAB_TILE_PUT
24.09 17:09:37.331 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] 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":true,"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}}
24.09 17:09:37.334 INFO  [AbstractExtraEventProcessor] [Main-event-thread] AvCardInfoExtraProcessor sends event CashEvent [eventType='av.sale.card.text', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.sale.avcard.FormSaleCardTextPld@1924a7']
24.09 17:09:37.334 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE send event to frontend: AV_SALE_CARD_TEXT
24.09 17:09:37.335 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] Event to frontend 1: {"type":"av.sale.card.text","payload":{"text":"Добавить карту или купон","cardType":0}}
24.09 17:09:37.335 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE start this CD_SALE with e=null
24.09 17:09:37.335 INFO  [AbstractEventsFilter] [Main-event-thread] ProcessorEventsFilter starts processor CD_SALE with event null
24.09 17:09:37.336 TRACE [AbstractEventProcessor] [Main-event-thread] Stop processor: Type:CD_PAYMENT_STATE, prevPT=CD_SALE
24.09 17:09:37.336 TRACE [AbstractEventProcessor] [Main-event-thread] Start processor: Type:CD_SALE, prevPT=CD_PAYMENT_STATE
24.09 17:09:37.336 TRACE [AbstractEventProcessor] [Main-event-thread] Type:CD_SALE send event to frontend: CD_SALE_SHOW
24.09 17:09:37.336 TRACE [AbstractEventProcessor] [Main-event-thread] Type:CD_SALE send event to frontend: CD_CONTENT_SALE_SHOW
24.09 17:09:37.345 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductJewelController
24.09 17:09:37.345 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductClothingController
24.09 17:09:37.345 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductCFTGiftCardController
24.09 17:09:37.345 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductBonusPointsController
24.09 17:09:37.346 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductMetricController
24.09 17:09:37.346 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductMobilePayController
24.09 17:09:37.346 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE send event to frontend: FORM_CHECK_PUT
24.09 17:09:37.346 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] Event to frontend 1: {"type":"form.check.put","payload":{"check":{"discount":{"cardEnabled":false},"checkSum":"15.01","positions":[{"itemId":1,"name":"Кефир малиновый кисло-сладкий (Россия)","quantity":"1","measure":"Шт","sum":"15.01","item":"00601","barcode":"4600601000001","marked":false,"positionCouponEnabled":false,"manualDiscountEnabled":false}],"positionCouponEnabled":false,"manualDiscountEnabled":false},"buttons":[{"text":"РАССЧИТАТЬ","callback":{"type":"form.sale.check.subtotalRun","payload":{}}}]}}
24.09 17:09:37.348 INFO  [AbstractExtraEventProcessor] [Main-event-thread] CdForwardExtraProcessor sends event CashEvent [eventType='cd.check.put', canProcessed='true', pld='ru.crystals.pos.touch2.customerdisplay.payload.CdCheckPutPld@10262fc']
24.09 17:09:37.348 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE send event to frontend: CD_CHECK_PUT
24.09 17:09:37.349 TRACE [AbstractEventProcessor] [Main-event-thread] Type:CD_SALE receive event: CD_CHECK_PUT
24.09 17:09:37.349 TRACE [AbstractEventProcessor] [Main-event-thread] Type:CD_SALE send event to frontend: CD_CHECK_PUT
24.09 17:09:37.350 INFO  [AbstractEventSender] [Internal-Cash-Pool-Executor_27] StatusBarEventSender sends event CashEvent [eventType='form.notice.clear', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.EmptyPld@8d6dfa']
24.09 17:09:37.351 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] Event to frontend 1: {"type":"form.notice.clear","payload":{}}
24.09 17:09:37.353 INFO  [AbstractEventSender] [Internal-Cash-Pool-Executor_27] AdditionalMenuEventSender sends event CashEvent [eventType='additionalMenu.configuration', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.additionalmenu.AdditionalMenuConfigurationPld@a07740']
24.09 17:09:37.353 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] Event to frontend 1: {"type":"additionalMenu.configuration","payload":{"goodsFindIconEnabled":true,"printDocumentIconEnabled":true,"functionMenuIconEnabled":true,"infoMenuIconEnabled":true}}
24.09 17:09:37.353 INFO  [AbstractEventsFilter] [Main-event-thread] ProcessorEventsFilter starts processor SALE_PAYMENT with event CashEvent [eventType='inner.processor.exit', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.ProcessorExitPld@c7eca3']
24.09 17:09:37.353 INFO  [AbstractEventProcessor] [Main-event-thread] Stop to ignore events.
24.09 17:09:37.353 DEBUG [CashEventDequeue] [Main-event-thread] Remove ignorable event: TechProcessEvent.eventBarcode
24.09 17:09:37.354 DEBUG [CashEventDequeue] [Main-event-thread] Remove ignorable event: TechProcessEvent.showMessage
24.09 17:09:37.354 TRACE [AbstractEventProcessor] [Main-event-thread] Stop processor: Type:SALE, prevPT=SALE_SUBTOTAL
24.09 17:09:37.354 TRACE [AbstractEventProcessor] [Main-event-thread] Start processor: Type:SALE_PAYMENT, prevPT=SALE_SUBTOTAL
24.09 17:09:37.370 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductJewelController
24.09 17:09:37.371 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductClothingController
24.09 17:09:37.371 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductCFTGiftCardController
24.09 17:09:37.371 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductBonusPointsController
24.09 17:09:37.371 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductMetricController
24.09 17:09:37.371 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductMobilePayController
24.09 17:09:37.371 INFO  [AbstractExtraEventProcessor] [Main-event-thread] SaleTabExtraProcessor sends event CashEvent [eventType='sd.show', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.EmptyPld@8d6dfa']
24.09 17:09:37.371 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_PAYMENT send event to frontend: SD_SHOW
24.09 17:09:37.372 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] Event to frontend 1: {"type":"sd.show","payload":{}}
24.09 17:09:37.374 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@1c5a8f0']
24.09 17:09:37.375 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_PAYMENT send event to frontend: SD_TAB_PUT
24.09 17:09:37.375 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] Event to frontend 1: {"type":"sd.tab.put","payload":{"tabs":[{"name":"ПРОДАЖА","tabId":"8a4f7479-c538-48d0-843a-23d48af50e29"},{"name":"Кафе","tabId":"699617b2-8893-436e-ba9d-6d610284b79e"}]}}
24.09 17:09:37.381 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@f03220']
24.09 17:09:37.381 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_PAYMENT send event to frontend: SD_TAB_TILE_PUT
24.09 17:09:37.381 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] 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}}
24.09 17:09:37.382 INFO  [AbstractExtraEventProcessor] [Main-event-thread] AvCardInfoExtraProcessor sends event CashEvent [eventType='av.sale.card.text', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.sale.avcard.FormSaleCardTextPld@3bf5de']
24.09 17:09:37.382 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_PAYMENT send event to frontend: AV_SALE_CARD_TEXT
24.09 17:09:37.383 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] Event to frontend 1: {"type":"av.sale.card.text","payload":{"text":"Добавить карту или купон","cardType":0}}
24.09 17:09:37.393 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductJewelController
24.09 17:09:37.393 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductClothingController
24.09 17:09:37.393 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductCFTGiftCardController
24.09 17:09:37.393 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductBonusPointsController
24.09 17:09:37.393 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductMetricController
24.09 17:09:37.394 ERROR [catalog] Not found productContainerClass for: ru.crystals.pos.catalog.ProductMobilePayController
24.09 17:09:37.394 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_PAYMENT send event to frontend: FORM_CHECK_PUT
24.09 17:09:37.394 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] Event to frontend 1: {"type":"form.check.put","payload":{"check":{"discount":{"cardEnabled":false},"checkSum":"15.01","positions":[{"itemId":1,"name":"Кефир малиновый кисло-сладкий (Россия)","quantity":"1","measure":"Шт","sum":"15.01","item":"00601","barcode":"4600601000001","marked":false,"positionCouponEnabled":false,"manualDiscountEnabled":false}],"positionCouponEnabled":false,"manualDiscountEnabled":false},"buttons":[{"text":"ОПЛАТИТЬ","callback":{"type":"form.sale.check.paymentRun","payload":{}}}]}}
24.09 17:09:37.396 INFO  [AbstractExtraEventProcessor] [Main-event-thread] CdForwardExtraProcessor sends event CashEvent [eventType='cd.check.put', canProcessed='true', pld='ru.crystals.pos.touch2.customerdisplay.payload.CdCheckPutPld@894d6a']
24.09 17:09:37.396 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_PAYMENT send event to frontend: CD_CHECK_PUT
24.09 17:09:37.396 TRACE [AbstractEventProcessor] [Main-event-thread] Type:CD_SALE receive event: CD_CHECK_PUT
24.09 17:09:37.396 TRACE [AbstractEventProcessor] [Main-event-thread] Type:CD_SALE send event to frontend: CD_CHECK_PUT
24.09 17:09:37.397 INFO  [AbstractEventSender] [Internal-Cash-Pool-Executor_38] StatusBarEventSender sends event CashEvent [eventType='form.notice.clear', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.EmptyPld@8d6dfa']
24.09 17:09:37.398 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] Event to frontend 1: {"type":"form.notice.clear","payload":{}}
24.09 17:09:37.399 INFO  [AbstractEventSender] [Internal-Cash-Pool-Executor_38] AdditionalMenuEventSender sends event CashEvent [eventType='additionalMenu.configuration', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.additionalmenu.AdditionalMenuConfigurationPld@20285a']
24.09 17:09:37.399 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] Event to frontend 1: {"type":"additionalMenu.configuration","payload":{"goodsFindIconEnabled":true,"printDocumentIconEnabled":true,"functionMenuIconEnabled":true,"infoMenuIconEnabled":true}}
24.09 17:09:37.400 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_PAYMENT receive event: INNER_PROCESSOR_EXIT
24.09 17:09:37.400 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_PAYMENT receive event: PositionOperationsListener.eventWaitGoods
24.09 17:09:37.401 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_PAYMENT receive event: TechProcessEvent.eventUpdateCheck
24.09 17:09:37.402 INFO  [AbstractEventSender] [Internal-Cash-Pool-Executor_24] AdditionalMenuEventSender sends event CashEvent [eventType='additionalMenu.configuration', canProcessed='true', pld='ru.crystals.pos.touch2.events.payload.impl.additionalmenu.AdditionalMenuConfigurationPld@1780a19']
24.09 17:09:37.402 TRACE [PrimaryWSEP] [Internal-Cash-Pool-Executor_31] Event to frontend 1: {"type":"additionalMenu.configuration","payload":{"goodsFindIconEnabled":true,"printDocumentIconEnabled":true,"functionMenuIconEnabled":true,"infoMenuIconEnabled":true}}
24.09 17:09:37.403 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_PAYMENT receive event: TechProcessEvent.eventErrorCall
24.09 17:09:41.511 INFO  [FiscalPrinter] getPrinterState
24.09 17:09:46.512 INFO  [FiscalPrinter] getPrinterState
24.09 17:09:51.512 INFO  [FiscalPrinter] getPrinterState
24.09 17:09:56.512 INFO  [FiscalPrinter] getPrinterState
24.09 17:09:58.221 DEBUG [TechProcessImpl] Server online mode
24.09 17:09:58.222 TRACE [AbstractEventProcessor] [Main-event-thread] Type:SALE_PAYMENT receive event: TechProcessEvent.eventOnlineMode
24.09 17:09:58.924 INFO  [PendingOperationQueue] Pending cards operation queue is empty. Populating from DB...
24.09 17:09:58.926 INFO  [PendingOperationQueue] No pending card operations found.
24.09 17:09:59.168 INFO  [LoyProvidersRegistryImpl] Resend stale feedback
24.09 17:09:59.169 INFO  [LoyProvidersRegistryImpl] Search for stale feedback provider = aeroflotBonusesCFT
24.09 17:09:59.170 INFO  [LoyProvidersRegistryImpl] There is no stale feedback for aeroflotBonusesCFT
24.09 17:09:59.170 INFO  [LoyProvidersRegistryImpl] Search for stale feedback provider = smch
24.09 17:09:59.170 INFO  [LoyProvidersRegistryImpl] There is no stale feedback for smch
24.09 17:09:59.170 INFO  [LoyProvidersRegistryImpl] Search for stale feedback provider = sm
24.09 17:09:59.171 INFO  [LoyProvidersRegistryImpl] There is no stale feedback for sm
24.09 17:09:59.171 INFO  [LoyProvidersRegistryImpl] Search for stale feedback provider = ml