API tools faq
paste
Advertisement
fedorm

Untitled

fedorm
Aug 9th, 2019
234
0
Never
Add comment
Not a member of Pastebin yet? Sign Up, it unlocks many cool features!
XML 81.11 KB | None | 0 0
raw download clone embed print report
  1. 08.08 18:52:07.832 INFO  [FiscalPrinter] getLastKpk
  2. 08.08 18:52:07.832 INFO  [FiscalPrinter] LastKpk = 697
  3. 08.08 18:52:07.832 INFO  [FiscalPrinter] Fiscal interrupt: null
  4. 08.08 18:52:07.839 INFO  [FiscalPrinter] Get document template /mnt/sda1/tce/storage/crystal-cash/modules/fiscalPrinter/templates/check-sale.xml
  5. 08.08 18:52:07.840 INFO  [DocumentTemplate] =====logo=====
  6. 08.08 18:52:07.840 INFO  [DocumentTemplate] content: null
  7. 08.08 18:52:07.841 INFO  [DocumentTemplate] =====header=====
  8. 08.08 18:52:07.841 INFO  [DocumentTemplate]                    jr. name                   ||NORMAL
  9. 08.08 18:52:07.841 INFO  [DocumentTemplate]          199100, Spb, Savushkina, 112         ||NORMAL
  10. 08.08 18:52:07.841 INFO  [DocumentTemplate] ----------------------------------------------||NORMAL
  11. 08.08 18:52:07.842 INFO  [DocumentTemplate] ЗВД.N:00000178061         ФН:      f4c2bfe3-0a||NORMAL
  12. 08.08 18:52:07.842 INFO  [DocumentTemplate] РЕГ.N:NFM.1780.61.0.156526ИНН:     7802781104 ||NORMAL
  13. 08.08 18:52:07.842 INFO  [DocumentTemplate] 01    Администраторов Адми     КАССА: 61 ОТД01||NORMAL
  14. 08.08 18:52:07.842 INFO  [DocumentTemplate]   ЧЕК НА ПРОДАЖУ N:          3              ||NORMAL
  15. 08.08 18:52:07.842 INFO  [DocumentTemplate]                                 СМЕНА N:      ||NORMAL
  16. 08.08 18:52:07.847 INFO  [DocumentTemplate] =====text=====
  17. 08.08 18:52:07.847 INFO  [DocumentTemplate] ----------------------------------------------||NORMAL
  18. 08.08 18:52:07.847 INFO  [DocumentTemplate] Кассовый чек (ПРИХОД)                         ||NORMAL
  19. 08.08 18:52:07.847 INFO  [DocumentTemplate]                *ПРОДАЖА ТОВАРА*               ||NORMAL
  20. 08.08 18:52:07.848 INFO  [DocumentTemplate] =====positionSectionWithGoodSets=====
  21. 08.08 18:52:07.850 INFO  [DocumentTemplate] ------------------------------------------||NORMAL
  22. 08.08 18:52:07.850 INFO  [DocumentTemplate] Йогурт лимонный сла   297.63     *1    =297.63||SMALL
  23. 08.08 18:52:07.850 INFO  [DocumentTemplate]     в т.ч. НДС 20%   ||SMALL
  24. 08.08 18:52:07.850 INFO  [DocumentTemplate] Хлеб вишневый солен   845.19     *1    =845.19||SMALL
  25. 08.08 18:52:07.851 INFO  [DocumentTemplate]     в т.ч. НДС 20%   ||SMALL
  26. 08.08 18:52:07.851 INFO  [DocumentTemplate] ------------------------------------------||NORMAL
  27. 08.08 18:52:07.851 INFO  [DocumentTemplate] =====payment=====
  28. 08.08 18:52:07.851 INFO  [DocumentTemplate] ПОДИТОГ                               =1142.82||SMALL
  29. 08.08 18:52:07.851 INFO  [DocumentTemplate] ----------------------------------------------||NORMAL
  30. 08.08 18:52:07.851 INFO  [DocumentTemplate]          ИТОГО к ОПЛАТЕ         =1142.82      ||NORMAL
  31. 08.08 18:52:07.851 INFO  [DocumentTemplate]        БАНКОВСКАЯ КАРТА         =1142.82      ||NORMAL
  32. 08.08 18:52:07.851 INFO  [DocumentTemplate] =====text=====
  33. 08.08 18:52:07.852 INFO  [DocumentTemplate] ----------------------------------------------||NORMAL
  34. 08.08 18:52:07.852 INFO  [DocumentTemplate]  ||NORMAL
  35. 08.08 18:52:07.852 INFO  [DocumentTemplate]                *ПРОДАЖА ТОВАРА*               ||NORMAL
  36. 08.08 18:52:07.852 INFO  [DocumentTemplate]                                               ||NORMAL
  37. 08.08 18:52:07.852 INFO  [DocumentTemplate]              СПАСИБО ЗА ПОКУПКУ!              ||NORMAL
  38. 08.08 18:52:07.852 INFO  [DocumentTemplate]                                               ||NORMAL
  39. 08.08 18:52:07.852 INFO  [DocumentTemplate]                                               ||NORMAL
  40. 08.08 18:52:07.852 INFO  [DocumentTemplate] =====text=====
  41. 08.08 18:52:07.857 INFO  [DocumentTemplate] =====bonuses=====
  42. 08.08 18:52:07.858 INFO  [DocumentTemplate] =====fiscal=====
  43. 08.08 18:52:07.858 INFO  [DocumentTemplate]                                            ||NORMAL
  44. 08.08 18:52:07.858 INFO  [DocumentTemplate]        Вся информация на www.lenta.com     ||NORMAL
  45. 08.08 18:52:07.858 INFO  [DocumentTemplate]           и по тел. 8-800-700-4111         ||NORMAL
  46. 08.08 18:52:07.858 INFO  [DocumentTemplate]          звонок по России бесплатный       ||NORMAL
  47. 08.08 18:52:07.858 INFO  [DocumentTemplate] =====cut=====
  48. 08.08 18:52:07.858 INFO  [DocumentTemplate] content: null
  49. 08.08 18:52:07.896 INFO  [DocumentSender] OD found 0 transactions to register
  50. 08.08 18:52:07.902 INFO  [DocumentSender] response message = Created
  51. 08.08 18:52:07.903 INFO  [TransferManager] Send document status : 20242 > WAIT_ACKNOWLEDGEMENT            file name : 61/Document_20190808185207_898_1780_61.ser
  52. 08.08 18:52:08.083 INFO  [FiscalPrinter] getLastKpk
  53. 08.08 18:52:08.083 INFO  [FiscalPrinter] LastKpk = 698
  54. 08.08 18:52:08.083 INFO  [FiscalPrinter] getLastDocNum
  55. 08.08 18:52:08.118 INFO  [CheckService] Фискальная смена открыта ShiftEntity [cashNum=61, eklzNum=f4c2bfe3-0a28-49dc-8960-33b3512ee050, fiscalNum=NFM.1780.61.0.1565263882098, fiscalSum=null, numShift=18, shiftClose=null, shiftOpen=Thu Aug 08 18:52:08 MSK 2019, toString()=ru.crystals.pos.check.ShiftEntity@1759]
  56. 08.08 18:52:08.143 INFO  [CheckService] fiscalizeCheck: PurchaseEntity [id=20370, number=3, dateCreate=Thu Aug 08 18:51:41 MSK 2019, dateCommit=Thu Aug 08 18:52:08 MSK 2019, fiscalDocNum=698;1315, sentToServerStatus=UNCOMMITED]
  57. 08.08 18:52:08.143 TRACE [ExternalProcessingsImpl] entering purchaseFiscalized(PurchaseEntity)
  58. 08.08 18:52:08.143 TRACE [ExternalProcessingsImpl] Purchase fiscalized: no implementation of PlastekServices.
  59. 08.08 18:52:08.143 TRACE [ExternalProcessingsImpl] Purchase fiscalized: no implementation of externalLoyaltyService.
  60. 08.08 18:52:08.144 TRACE [ExternalProcessingsImpl] about to notify ext-loy-providers that the current receipt [PurchaseEntity [id=20370, number=3, dateCreate=Thu Aug 08 18:51:41 MSK 2019, dateCommit=Thu Aug 08 18:52:08 MSK 2019, fiscalDocNum=698;1315, sentToServerStatus=UNCOMMITED]] was fiscalized...
  61. 08.08 18:52:08.146 INFO  [PrismaBridgeImpl] {"events":[{"prefix":"KKM","shop":1780,"cash":61,"mode":39,"tabNumber":"1","cashier":"Администраторов А.А.","purchase":3,"pos":0,"barcode":"","item":"","name":"","price":0.0,"quant":0.0,"sum":0.0,"sumAll":1142.82,"cardType":"","cardNumber":"","discount":0.0,"discountAll":0.0,"dateTime":"08.08.2019 18:52:08.146","offline":false}]}
  62. 08.08 18:52:08.179 WARN  [SetApiPluginLoyProvider] No LoyaltyPlugin "ru.crystals.loy.plugin.emulator" found for purchase id 20370
  63. 08.08 18:52:08.179 TRACE [LoyPluginEmulator] entering eventReceiptFiscalized(Receipt, LoyaltyResult). The arguments are: receipt [ru.crystals.api.commons.ReceiptPurchaseEntityWrapper@16b5548], loyResults [null]
  64. 08.08 18:52:08.179 TRACE [LoyPluginEmulator] leaving eventReceiptFiscalized(Receipt, LoyaltyResult)
  65. 08.08 18:52:08.182 INFO  [SetApiLoyFeedbackProcessor] Scheduling feedback of provider "ru.crystals.loy.plugin.emulator" for purchase id "20370"
  66. 08.08 18:52:08.252 INFO  [SetApiLoyFeedbackProcessor] Saved feedback for "ru.crystals.loy.plugin.emulator", check id 20370, assigned id 5756
  67. 08.08 18:52:08.252 TRACE [SMServiceImpl] entering getPromise(PurchaseEntity). The argument is: PurchaseEntity [id=20370, number=3, dateCreate=Thu Aug 08 18:51:41 MSK 2019, dateCommit=Thu Aug 08 18:52:08 MSK 2019, fiscalDocNum=698;1315, sentToServerStatus=UNCOMMITED]
  68. 08.08 18:52:08.254 ERROR [SMReceiptConvertor] createPromiseRequestOld: impossible to identify card-holder buying PurchaseEntity [id=20370, number=3, dateCreate=Thu Aug 08 18:51:41 MSK 2019, dateCommit=Thu Aug 08 18:52:08 MSK 2019, fiscalDocNum=698;1315, sentToServerStatus=UNCOMMITED]
  69. 08.08 18:52:08.254 INFO  [SMServiceImpl] leaving getPromise(PurchaseEntity). Seems that no personalized card (with client) was applied in receipt: PurchaseEntity [id=20370, number=3, dateCreate=Thu Aug 08 18:51:41 MSK 2019, dateCommit=Thu Aug 08 18:52:08 MSK 2019, fiscalDocNum=698;1315, sentToServerStatus=UNCOMMITED]
  70. 08.08 18:52:08.254 WARN  [AeroflotBonusesLoyProvider] purchaseFiscalized failed: PurchaseEntity [id=20370, number=3, dateCreate=Thu Aug 08 18:51:41 MSK 2019, dateCommit=Thu Aug 08 18:52:08 MSK 2019, fiscalDocNum=698;1315, sentToServerStatus=UNCOMMITED]. Service is not available
  71. 08.08 18:52:08.258 DEBUG [LoymaxUtils] Loymax request:
  72. <?xml version="1.0" encoding="UTF-8" standalone="yes"?><XMLRequest><Version>3.2</Version><ConfirmPurchases><ConfirmPurchaseRequest PurchaseID="17800611565279508930" OperationID="2f157bf4bcd34275b480d703f027e8d1" OperationDate="2019-08-08T18:52:08.257+03:00" ElementID="1"/></ConfirmPurchases></XMLRequest>
  73.  
  74. 08.08 18:52:08.301 DEBUG [LoymaxUtils] Loymax response:
  75. <?xml version="1.0" encoding="UTF-8" standalone="yes"?><XMLResponse><ErrorCode>0</ErrorCode><ConfirmPurchases><ConfirmPurchaseResponse OperationID="2f157bf4bcd34275b480d703f027e8d1" ErrorCode="0"/></ConfirmPurchases></XMLResponse>
  76.  
  77. 08.08 18:52:08.326 TRACE [ExternalProcessingsImpl] leaving purchaseFiscalized(PurchaseEntity). It took 183 [ms]
  78. 08.08 18:52:14.710 DEBUG [TechProcessImpl] Server online mode
  79. 08.08 18:52:22.928 INFO  [FiscalPrinter] resetException()
  80. 08.08 18:52:22.982 ERROR [TechProcessImpl] TP error: Adding new events is blocked
  81. 08.08 18:52:23.183 ERROR [TechProcessImpl] TP error: Adding new events is blocked
  82. 08.08 18:52:23.384 ERROR [TechProcessImpl] TP error: Adding new events is blocked
  83. 08.08 18:52:23.594 ERROR [TechProcessImpl] TP error: Adding new events is blocked
  84. 08.08 18:52:24.802 ERROR [TechProcessImpl] TP error: Adding new events is blocked
  85. 08.08 18:52:25.003 ERROR [TechProcessImpl] TP error: Adding new events is blocked
  86. 08.08 18:52:25.205 ERROR [TechProcessImpl] TP error: Adding new events is blocked
  87. 08.08 18:52:25.404 ERROR [TechProcessImpl] TP error: Adding new events is blocked
  88. 08.08 18:52:25.605 ERROR [TechProcessImpl] TP error: Adding new events is blocked
  89. 08.08 18:52:25.805 ERROR [TechProcessImpl] TP error: Adding new events is blocked
  90. 08.08 18:52:26.007 ERROR [TechProcessImpl] TP error: Adding new events is blocked
  91. 08.08 18:52:26.207 ERROR [TechProcessImpl] TP error: Adding new events is blocked
  92. 08.08 18:52:34.825 INFO  [CommonLogger] Starting cleaning. All log records older than 10 мая 2019 18:52:34 will be deleted.
  93. 08.08 18:52:34.827 INFO  [CommonLogger] Cleaning done.
  94. 08.08 18:52:35.875 ERROR [TransactionHandler]
  95. java.lang.RuntimeException: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30003ms.
  96.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:180)
  97.     at ru.crystals.pos.datasource.jdbc.TransactionHandler.invoke(TransactionHandler.java:25)
  98.     at com.sun.proxy.$Proxy159.getProperty(Unknown Source)
  99.     at ru.crystals.pos.cards.filetransport.CardsFilesReader2.getPollInterval(CardsFilesReader2.java:901)
  100.     at ru.crystals.pos.cards.filetransport.CardsFilesReader2.scheduleDeferredTask(CardsFilesReader2.java:174)
  101.     at ru.crystals.pos.cards.filetransport.CardsFilesReader2.run(CardsFilesReader2.java:872)
  102.     at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  103.     at java.util.concurrent.FutureTask.run(FutureTask.java:266)
  104.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
  105.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
  106.     at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  107.     at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  108.     at java.lang.Thread.run(Thread.java:745)
  109. Caused by: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30003ms.
  110.     at com.zaxxer.hikari.pool.HikariPool.createTimeoutException(HikariPool.java:676)
  111.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:190)
  112.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:155)
  113.     at com.zaxxer.hikari.HikariDataSource.getConnection(HikariDataSource.java:100)
  114.     at ru.crystals.pos.datasource.jdbc.JDBCMapperDSImpl.getConnection(JDBCMapperDSImpl.java:50)
  115.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:174)
  116.     ... 12 more
  117. 08.08 18:52:35.889 ERROR [JDBCMapperImpl] Cannot rollback transaction
  118. java.lang.NullPointerException
  119.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.closeConnection(JDBCMapperImpl.java:129)
  120.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.rollbackTransaction(JDBCMapperImpl.java:210)
  121.     at ru.crystals.pos.datasource.jdbc.TransactionHandler.invoke(TransactionHandler.java:30)
  122.     at com.sun.proxy.$Proxy159.getProperty(Unknown Source)
  123.     at ru.crystals.pos.cards.filetransport.CardsFilesReader2.getPollInterval(CardsFilesReader2.java:901)
  124.     at ru.crystals.pos.cards.filetransport.CardsFilesReader2.scheduleDeferredTask(CardsFilesReader2.java:174)
  125.     at ru.crystals.pos.cards.filetransport.CardsFilesReader2.run(CardsFilesReader2.java:872)
  126.     at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  127.     at java.util.concurrent.FutureTask.run(FutureTask.java:266)
  128.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
  129.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
  130.     at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  131.     at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  132.     at java.lang.Thread.run(Thread.java:745)
  133. 08.08 18:52:37.333 INFO  [FiscalPrinter] resetException()
  134. 08.08 18:52:37.376 ERROR [TechProcessImpl] TP error: Adding new events is blocked
  135. 08.08 18:52:37.579 ERROR [TechProcessImpl] TP error: Adding new events is blocked
  136. 08.08 18:52:37.777 ERROR [TechProcessImpl] TP error: Adding new events is blocked
  137. 08.08 18:52:37.990 ERROR [TechProcessImpl] TP error: Adding new events is blocked
  138. 08.08 18:52:38.337 ERROR [TransactionHandler]
  139. java.lang.RuntimeException: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30000ms.
  140.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:180)
  141.     at ru.crystals.pos.datasource.jdbc.TransactionHandler.invoke(TransactionHandler.java:25)
  142.     at com.sun.proxy.$Proxy159.getProperty(Unknown Source)
  143.     at ru.crystals.pos.coupon.SetCouponingProcessingConfig.isEnabled(SetCouponingProcessingConfig.java:41)
  144.     at ru.crystals.pos.coupon.ProcessingUniqueCouponManager.isEnabled(ProcessingUniqueCouponManager.java:89)
  145.     at ru.crystals.pos.cards.service.UniqueCouponManagerFacade.issueUniqueCouponsBackground(UniqueCouponManagerFacade.java:56)
  146.     at ru.crystals.pos.cards.service.CardsServiceImpl.issueUniqueCoupons(CardsServiceImpl.java:600)
  147.     at ru.crystals.pos.techprocess.TechProcessImpl.processingUniqueCoupons(TechProcessImpl.java:1449)
  148.     at ru.crystals.pos.techprocess.TechProcessShift.printCheck(TechProcessShift.java:1796)
  149.     at ru.crystals.pos.techprocess.TechProcessShift.fiscalizeCheck(TechProcessShift.java:1538)
  150.     at ru.crystals.pos.techprocess.TechProcessShiftProxy.fiscalizeCheck(TechProcessShiftProxy.java:700)
  151.     at ru.crystals.pos.techprocess.TechProcessImpl.fiscalizeCheck(TechProcessImpl.java:941)
  152.     at ru.crystals.pos.visualization.check.CheckContainer.paymentComplete(CheckContainer.java:2728)
  153.     at ru.crystals.pos.visualization.components.MainWindow.paymentComplete(MainWindow.java:845)
  154.     at ru.crystals.pos.visualization.Factory.eventPaymentComplete(Factory.java:880)
  155.     at ru.crystals.pos.techprocess.TechProcessImpl.paymentComplete(TechProcessImpl.java:4477)
  156.     at ru.crystals.pos.check.service.CheckServiceImpl.addPayment(CheckServiceImpl.java:3972)
  157.     at ru.crystals.pos.techprocess.TechProcessImpl.addPayment(TechProcessImpl.java:3927)
  158.     at ru.crystals.pos.visualization.payments.bankcard.integration.BaseCardPaymentPluginAdapter.processPayment(BaseCardPaymentPluginAdapter.java:92)
  159.     at ru.crystals.pos.visualization.payments.bankcard.controller.BankCardPaymentController.completeDirectTransaction(BankCardPaymentController.java:176)
  160.     at ru.crystals.pos.visualization.payments.bankcard.controller.BankCardPaymentController.processSale(BankCardPaymentController.java:99)
  161.     at ru.crystals.pos.visualization.payments.bankcard.controller.BankCardPaymentController.access$100(BankCardPaymentController.java:38)
  162.     at ru.crystals.pos.visualization.payments.bankcard.controller.BankCardPaymentController$1.run(BankCardPaymentController.java:69)
  163.     at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  164.     at java.util.concurrent.FutureTask.run(FutureTask.java:266)
  165.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
  166.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
  167.     at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  168.     at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  169.     at java.lang.Thread.run(Thread.java:745)
  170. Caused by: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30000ms.
  171.     at com.zaxxer.hikari.pool.HikariPool.createTimeoutException(HikariPool.java:676)
  172.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:190)
  173.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:155)
  174.     at com.zaxxer.hikari.HikariDataSource.getConnection(HikariDataSource.java:100)
  175.     at ru.crystals.pos.datasource.jdbc.JDBCMapperDSImpl.getConnection(JDBCMapperDSImpl.java:50)
  176.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:174)
  177.     ... 29 more
  178. 08.08 18:52:38.371 ERROR [JDBCMapperImpl] Cannot rollback transaction
  179. java.lang.NullPointerException
  180.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.closeConnection(JDBCMapperImpl.java:129)
  181.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.rollbackTransaction(JDBCMapperImpl.java:210)
  182.     at ru.crystals.pos.datasource.jdbc.TransactionHandler.invoke(TransactionHandler.java:30)
  183.     at com.sun.proxy.$Proxy159.getProperty(Unknown Source)
  184.     at ru.crystals.pos.coupon.SetCouponingProcessingConfig.isEnabled(SetCouponingProcessingConfig.java:41)
  185.     at ru.crystals.pos.coupon.ProcessingUniqueCouponManager.isEnabled(ProcessingUniqueCouponManager.java:89)
  186.     at ru.crystals.pos.cards.service.UniqueCouponManagerFacade.issueUniqueCouponsBackground(UniqueCouponManagerFacade.java:56)
  187.     at ru.crystals.pos.cards.service.CardsServiceImpl.issueUniqueCoupons(CardsServiceImpl.java:600)
  188.     at ru.crystals.pos.techprocess.TechProcessImpl.processingUniqueCoupons(TechProcessImpl.java:1449)
  189.     at ru.crystals.pos.techprocess.TechProcessShift.printCheck(TechProcessShift.java:1796)
  190.     at ru.crystals.pos.techprocess.TechProcessShift.fiscalizeCheck(TechProcessShift.java:1538)
  191.     at ru.crystals.pos.techprocess.TechProcessShiftProxy.fiscalizeCheck(TechProcessShiftProxy.java:700)
  192.     at ru.crystals.pos.techprocess.TechProcessImpl.fiscalizeCheck(TechProcessImpl.java:941)
  193.     at ru.crystals.pos.visualization.check.CheckContainer.paymentComplete(CheckContainer.java:2728)
  194.     at ru.crystals.pos.visualization.components.MainWindow.paymentComplete(MainWindow.java:845)
  195.     at ru.crystals.pos.visualization.Factory.eventPaymentComplete(Factory.java:880)
  196.     at ru.crystals.pos.techprocess.TechProcessImpl.paymentComplete(TechProcessImpl.java:4477)
  197.     at ru.crystals.pos.check.service.CheckServiceImpl.addPayment(CheckServiceImpl.java:3972)
  198.     at ru.crystals.pos.techprocess.TechProcessImpl.addPayment(TechProcessImpl.java:3927)
  199.     at ru.crystals.pos.visualization.payments.bankcard.integration.BaseCardPaymentPluginAdapter.processPayment(BaseCardPaymentPluginAdapter.java:92)
  200.     at ru.crystals.pos.visualization.payments.bankcard.controller.BankCardPaymentController.completeDirectTransaction(BankCardPaymentController.java:176)
  201.     at ru.crystals.pos.visualization.payments.bankcard.controller.BankCardPaymentController.processSale(BankCardPaymentController.java:99)
  202.     at ru.crystals.pos.visualization.payments.bankcard.controller.BankCardPaymentController.access$100(BankCardPaymentController.java:38)
  203.     at ru.crystals.pos.visualization.payments.bankcard.controller.BankCardPaymentController$1.run(BankCardPaymentController.java:69)
  204.     at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  205.     at java.util.concurrent.FutureTask.run(FutureTask.java:266)
  206.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
  207.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
  208.     at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  209.     at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  210.     at java.lang.Thread.run(Thread.java:745)
  211. 08.08 18:52:38.372 ERROR [CheckService] java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30000ms.
  212. java.lang.RuntimeException: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30000ms.
  213.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:180)
  214.     at ru.crystals.pos.datasource.jdbc.TransactionHandler.invoke(TransactionHandler.java:25)
  215.     at com.sun.proxy.$Proxy159.getProperty(Unknown Source)
  216.     at ru.crystals.pos.coupon.SetCouponingProcessingConfig.isEnabled(SetCouponingProcessingConfig.java:41)
  217.     at ru.crystals.pos.coupon.ProcessingUniqueCouponManager.isEnabled(ProcessingUniqueCouponManager.java:89)
  218.     at ru.crystals.pos.cards.service.UniqueCouponManagerFacade.issueUniqueCouponsBackground(UniqueCouponManagerFacade.java:56)
  219.     at ru.crystals.pos.cards.service.CardsServiceImpl.issueUniqueCoupons(CardsServiceImpl.java:600)
  220.     at ru.crystals.pos.techprocess.TechProcessImpl.processingUniqueCoupons(TechProcessImpl.java:1449)
  221.     at ru.crystals.pos.techprocess.TechProcessShift.printCheck(TechProcessShift.java:1796)
  222.     at ru.crystals.pos.techprocess.TechProcessShift.fiscalizeCheck(TechProcessShift.java:1538)
  223.     at ru.crystals.pos.techprocess.TechProcessShiftProxy.fiscalizeCheck(TechProcessShiftProxy.java:700)
  224.     at ru.crystals.pos.techprocess.TechProcessImpl.fiscalizeCheck(TechProcessImpl.java:941)
  225.     at ru.crystals.pos.visualization.check.CheckContainer.paymentComplete(CheckContainer.java:2728)
  226.     at ru.crystals.pos.visualization.components.MainWindow.paymentComplete(MainWindow.java:845)
  227.     at ru.crystals.pos.visualization.Factory.eventPaymentComplete(Factory.java:880)
  228.     at ru.crystals.pos.techprocess.TechProcessImpl.paymentComplete(TechProcessImpl.java:4477)
  229.     at ru.crystals.pos.check.service.CheckServiceImpl.addPayment(CheckServiceImpl.java:3972)
  230.     at ru.crystals.pos.techprocess.TechProcessImpl.addPayment(TechProcessImpl.java:3927)
  231.     at ru.crystals.pos.visualization.payments.bankcard.integration.BaseCardPaymentPluginAdapter.processPayment(BaseCardPaymentPluginAdapter.java:92)
  232.     at ru.crystals.pos.visualization.payments.bankcard.controller.BankCardPaymentController.completeDirectTransaction(BankCardPaymentController.java:176)
  233.     at ru.crystals.pos.visualization.payments.bankcard.controller.BankCardPaymentController.processSale(BankCardPaymentController.java:99)
  234.     at ru.crystals.pos.visualization.payments.bankcard.controller.BankCardPaymentController.access$100(BankCardPaymentController.java:38)
  235.     at ru.crystals.pos.visualization.payments.bankcard.controller.BankCardPaymentController$1.run(BankCardPaymentController.java:69)
  236.     at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  237.     at java.util.concurrent.FutureTask.run(FutureTask.java:266)
  238.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
  239.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
  240.     at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  241.     at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  242.     at java.lang.Thread.run(Thread.java:745)
  243. Caused by: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30000ms.
  244.     at com.zaxxer.hikari.pool.HikariPool.createTimeoutException(HikariPool.java:676)
  245.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:190)
  246.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:155)
  247.     at com.zaxxer.hikari.HikariDataSource.getConnection(HikariDataSource.java:100)
  248.     at ru.crystals.pos.datasource.jdbc.JDBCMapperDSImpl.getConnection(JDBCMapperDSImpl.java:50)
  249.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:174)
  250.     ... 29 more
  251. 08.08 18:52:38.384 INFO  [CheckService] SetSentToServerStatus : 20242 > WAIT_ACKNOWLEDGEMENT file name : 61/Document_20190808185207_898_1780_61.ser
  252. 08.08 18:52:38.397 INFO  [DocumentSender] document 61/Document_20190808185207_898_1780_61.ser has been registered
  253. 08.08 18:52:38.397 INFO  [TransferManager] Send document status : 20242 > SENT            file name : 61/Document_20190808185207_898_1780_61.ser
  254. 08.08 18:52:38.416 INFO  [CheckService] SetSentToServerStatus : 20242 > SENT file name : 61/Document_20190808185207_898_1780_61.ser
  255. 08.08 18:52:38.429 INFO  [DocumentSender] response message = Created
  256. 08.08 18:52:38.429 INFO  [TransferManager] Send document status : 20243 > WAIT_ACKNOWLEDGEMENT            file name : 61/Document_20190808185238_422_1780_61.ser
  257. 08.08 18:52:38.459 INFO  [CheckService] SetSentToServerStatus : 20243 > WAIT_ACKNOWLEDGEMENT file name : 61/Document_20190808185238_422_1780_61.ser
  258. 08.08 18:52:38.466 INFO  [DocumentSender] document 61/Document_20190808185238_422_1780_61.ser has been registered
  259. 08.08 18:52:38.466 INFO  [TransferManager] Send document status : 20243 > SENT            file name : 61/Document_20190808185238_422_1780_61.ser
  260. 08.08 18:52:38.498 INFO  [CheckService] SetSentToServerStatus : 20243 > SENT file name : 61/Document_20190808185238_422_1780_61.ser
  261. 08.08 18:52:38.501 INFO  [DocumentSender] response message = Created
  262. 08.08 18:52:38.501 INFO  [TransferManager] Send document status : 20244 > WAIT_ACKNOWLEDGEMENT            file name : 61/Document_20190808185238_499_1780_61.ser
  263. 08.08 18:52:38.509 INFO  [CheckService] SetSentToServerStatus : 20244 > WAIT_ACKNOWLEDGEMENT file name : 61/Document_20190808185238_499_1780_61.ser
  264. 08.08 18:52:38.513 INFO  [DocumentSender] document 61/Document_20190808185238_499_1780_61.ser has been registered
  265. 08.08 18:52:38.513 INFO  [TransferManager] Send document status : 20244 > SENT            file name : 61/Document_20190808185238_499_1780_61.ser
  266. 08.08 18:52:38.517 INFO  [CheckService] SetSentToServerStatus : 20244 > SENT file name : 61/Document_20190808185238_499_1780_61.ser
  267. 08.08 18:52:38.523 INFO  [DocumentSender] response message = Created
  268. 08.08 18:52:38.524 INFO  [TransferManager] Send document status : 20289 > WAIT_ACKNOWLEDGEMENT            file name : 61/Document_20190808185238_518_1780_61.ser
  269. 08.08 18:52:38.529 INFO  [CheckService] SetSentToServerStatus : 20289 > WAIT_ACKNOWLEDGEMENT file name : 61/Document_20190808185238_518_1780_61.ser
  270. 08.08 18:52:38.533 INFO  [DocumentSender] document 61/Document_20190808185238_518_1780_61.ser has been registered
  271. 08.08 18:52:38.533 INFO  [TransferManager] Send document status : 20289 > SENT            file name : 61/Document_20190808185238_518_1780_61.ser
  272. 08.08 18:52:38.540 INFO  [CheckService] SetSentToServerStatus : 20289 > SENT file name : 61/Document_20190808185238_518_1780_61.ser
  273. 08.08 18:52:38.634 INFO  [DocumentSender] OD found 0 payment transactions
  274. 08.08 18:52:39.209 INFO  [WaitComponent] [WaitComponent] MainFrame enabled - false
  275. 08.08 18:52:39.395 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  276. 08.08 18:52:39.595 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  277. 08.08 18:52:39.796 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  278. 08.08 18:52:39.997 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  279. 08.08 18:52:40.198 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  280. 08.08 18:52:40.398 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  281. 08.08 18:52:40.598 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  282. 08.08 18:52:40.850 ERROR [TransactionHandler]
  283. java.lang.RuntimeException: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30000ms.
  284.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:180)
  285.     at ru.crystals.pos.datasource.jdbc.TransactionHandler.invoke(TransactionHandler.java:25)
  286.     at com.sun.proxy.$Proxy159.getProperty(Unknown Source)
  287.     at ru.crystals.pos.transport.ServerCashTransportImpl.getPollInterval(ServerCashTransportImpl.java:158)
  288.     at ru.crystals.pos.transport.ServerCashTransportImpl.scheduleDeferredTask(ServerCashTransportImpl.java:153)
  289.     at ru.crystals.pos.transport.ServerCashTransportImpl.run(ServerCashTransportImpl.java:123)
  290.     at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  291.     at java.util.concurrent.FutureTask.run(FutureTask.java:266)
  292.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
  293.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
  294.     at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  295.     at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  296.     at java.lang.Thread.run(Thread.java:745)
  297. Caused by: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30000ms.
  298.     at com.zaxxer.hikari.pool.HikariPool.createTimeoutException(HikariPool.java:676)
  299.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:190)
  300.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:155)
  301.     at com.zaxxer.hikari.HikariDataSource.getConnection(HikariDataSource.java:100)
  302.     at ru.crystals.pos.datasource.jdbc.JDBCMapperDSImpl.getConnection(JDBCMapperDSImpl.java:50)
  303.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:174)
  304.     ... 12 more
  305. 08.08 18:52:40.860 ERROR [JDBCMapperImpl] Cannot rollback transaction
  306. java.lang.NullPointerException
  307.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.closeConnection(JDBCMapperImpl.java:129)
  308.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.rollbackTransaction(JDBCMapperImpl.java:210)
  309.     at ru.crystals.pos.datasource.jdbc.TransactionHandler.invoke(TransactionHandler.java:30)
  310.     at com.sun.proxy.$Proxy159.getProperty(Unknown Source)
  311.     at ru.crystals.pos.transport.ServerCashTransportImpl.getPollInterval(ServerCashTransportImpl.java:158)
  312.     at ru.crystals.pos.transport.ServerCashTransportImpl.scheduleDeferredTask(ServerCashTransportImpl.java:153)
  313.     at ru.crystals.pos.transport.ServerCashTransportImpl.run(ServerCashTransportImpl.java:123)
  314.     at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  315.     at java.util.concurrent.FutureTask.run(FutureTask.java:266)
  316.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
  317.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
  318.     at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  319.     at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  320.     at java.lang.Thread.run(Thread.java:745)
  321. 08.08 18:52:44.710 DEBUG [TechProcessImpl] Server online mode
  322. 08.08 18:52:45.799 ERROR [TransactionHandler]
  323. java.lang.RuntimeException: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30000ms.
  324.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:180)
  325.     at ru.crystals.pos.datasource.jdbc.TransactionHandler.invoke(TransactionHandler.java:25)
  326.     at com.sun.proxy.$Proxy159.getProperty(Unknown Source)
  327.     at ru.crystals.pos.catalog.service.filestransport.FilesChecker.isTransportAllowed(FilesChecker.java:179)
  328.     at ru.crystals.pos.catalog.service.filestransport.FilesChecker.run(FilesChecker.java:88)
  329.     at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  330.     at java.util.concurrent.FutureTask.run(FutureTask.java:266)
  331.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
  332.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
  333.     at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  334.     at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  335.     at java.lang.Thread.run(Thread.java:745)
  336. Caused by: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30000ms.
  337.     at com.zaxxer.hikari.pool.HikariPool.createTimeoutException(HikariPool.java:676)
  338.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:190)
  339.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:155)
  340.     at com.zaxxer.hikari.HikariDataSource.getConnection(HikariDataSource.java:100)
  341.     at ru.crystals.pos.datasource.jdbc.JDBCMapperDSImpl.getConnection(JDBCMapperDSImpl.java:50)
  342.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:174)
  343.     ... 11 more
  344. 08.08 18:52:45.800 ERROR [JDBCMapperImpl] Cannot rollback transaction
  345. java.lang.NullPointerException
  346.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.closeConnection(JDBCMapperImpl.java:129)
  347.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.rollbackTransaction(JDBCMapperImpl.java:210)
  348.     at ru.crystals.pos.datasource.jdbc.TransactionHandler.invoke(TransactionHandler.java:30)
  349.     at com.sun.proxy.$Proxy159.getProperty(Unknown Source)
  350.     at ru.crystals.pos.catalog.service.filestransport.FilesChecker.isTransportAllowed(FilesChecker.java:179)
  351.     at ru.crystals.pos.catalog.service.filestransport.FilesChecker.run(FilesChecker.java:88)
  352.     at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  353.     at java.util.concurrent.FutureTask.run(FutureTask.java:266)
  354.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
  355.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
  356.     at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  357.     at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  358.     at java.lang.Thread.run(Thread.java:745)
  359. 08.08 18:52:45.800 ERROR [FilesChecker] failed to get ESB ON/OFF status
  360. java.lang.RuntimeException: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30000ms.
  361.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:180)
  362.     at ru.crystals.pos.datasource.jdbc.TransactionHandler.invoke(TransactionHandler.java:25)
  363.     at com.sun.proxy.$Proxy159.getProperty(Unknown Source)
  364.     at ru.crystals.pos.catalog.service.filestransport.FilesChecker.isTransportAllowed(FilesChecker.java:179)
  365.     at ru.crystals.pos.catalog.service.filestransport.FilesChecker.run(FilesChecker.java:88)
  366.     at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  367.     at java.util.concurrent.FutureTask.run(FutureTask.java:266)
  368.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
  369.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
  370.     at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  371.     at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  372.     at java.lang.Thread.run(Thread.java:745)
  373. Caused by: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30000ms.
  374.     at com.zaxxer.hikari.pool.HikariPool.createTimeoutException(HikariPool.java:676)
  375.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:190)
  376.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:155)
  377.     at com.zaxxer.hikari.HikariDataSource.getConnection(HikariDataSource.java:100)
  378.     at ru.crystals.pos.datasource.jdbc.JDBCMapperDSImpl.getConnection(JDBCMapperDSImpl.java:50)
  379.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:174)
  380.     ... 11 more
  381. 08.08 18:52:51.269 INFO  [FiscalPrinter] resetException()
  382. 08.08 18:52:51.303 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  383. 08.08 18:52:51.504 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  384. 08.08 18:52:51.704 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  385. 08.08 18:52:51.917 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  386. 08.08 18:52:53.118 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  387. 08.08 18:52:53.319 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  388. 08.08 18:52:53.519 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  389. 08.08 18:52:53.720 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  390. 08.08 18:52:53.921 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  391. 08.08 18:52:54.121 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  392. 08.08 18:52:54.322 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  393. 08.08 18:52:54.363 INFO  [CashConfigurationUpdateChecker] Current status: IN_WORK
  394. 08.08 18:52:54.370 INFO  [CashConfigurationUpdateChecker] Received patches list: []
  395. 08.08 18:52:54.375 INFO  [CashConfigurationUpdateChecker] isNeedWaitUpdateCommand: false
  396. 08.08 18:52:54.522 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  397. 08.08 18:52:54.872 ERROR [TransactionHandler]
  398. java.lang.RuntimeException: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30007ms.
  399.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:180)
  400.     at ru.crystals.pos.datasource.jdbc.TransactionHandler.invoke(TransactionHandler.java:25)
  401.     at com.sun.proxy.$Proxy159.getProperty(Unknown Source)
  402.     at ru.crystals.pos.esb.KafkaProducerBeanImpl.isEnabled(KafkaProducerBeanImpl.java:65)
  403.     at ru.crystals.pos.check.service.transport.TransferManager.sendByESBEnabled(TransferManager.java:1043)
  404.     at ru.crystals.pos.check.service.transport.DocumentSender.sendObject(DocumentSender.java:309)
  405.     at ru.crystals.pos.check.service.transport.TransferManager$CashStatusSender.run(TransferManager.java:338)
  406.     at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  407.     at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
  408.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
  409.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
  410.     at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  411.     at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  412.     at java.lang.Thread.run(Thread.java:745)
  413. Caused by: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30007ms.
  414.     at com.zaxxer.hikari.pool.HikariPool.createTimeoutException(HikariPool.java:676)
  415.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:190)
  416.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:155)
  417.     at com.zaxxer.hikari.HikariDataSource.getConnection(HikariDataSource.java:100)
  418.     at ru.crystals.pos.datasource.jdbc.JDBCMapperDSImpl.getConnection(JDBCMapperDSImpl.java:50)
  419.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:174)
  420.     ... 13 more
  421. 08.08 18:52:54.874 ERROR [JDBCMapperImpl] Cannot rollback transaction
  422. java.lang.NullPointerException
  423.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.closeConnection(JDBCMapperImpl.java:129)
  424.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.rollbackTransaction(JDBCMapperImpl.java:210)
  425.     at ru.crystals.pos.datasource.jdbc.TransactionHandler.invoke(TransactionHandler.java:30)
  426.     at com.sun.proxy.$Proxy159.getProperty(Unknown Source)
  427.     at ru.crystals.pos.esb.KafkaProducerBeanImpl.isEnabled(KafkaProducerBeanImpl.java:65)
  428.     at ru.crystals.pos.check.service.transport.TransferManager.sendByESBEnabled(TransferManager.java:1043)
  429.     at ru.crystals.pos.check.service.transport.DocumentSender.sendObject(DocumentSender.java:309)
  430.     at ru.crystals.pos.check.service.transport.TransferManager$CashStatusSender.run(TransferManager.java:338)
  431.     at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  432.     at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
  433.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
  434.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
  435.     at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  436.     at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  437.     at java.lang.Thread.run(Thread.java:745)
  438. 08.08 18:52:54.874 WARN  [TransferManager] java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30007ms.
  439. java.lang.RuntimeException: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30007ms.
  440.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:180)
  441.     at ru.crystals.pos.datasource.jdbc.TransactionHandler.invoke(TransactionHandler.java:25)
  442.     at com.sun.proxy.$Proxy159.getProperty(Unknown Source)
  443.     at ru.crystals.pos.esb.KafkaProducerBeanImpl.isEnabled(KafkaProducerBeanImpl.java:65)
  444.     at ru.crystals.pos.check.service.transport.TransferManager.sendByESBEnabled(TransferManager.java:1043)
  445.     at ru.crystals.pos.check.service.transport.DocumentSender.sendObject(DocumentSender.java:309)
  446.     at ru.crystals.pos.check.service.transport.TransferManager$CashStatusSender.run(TransferManager.java:338)
  447.     at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  448.     at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
  449.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
  450.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
  451.     at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  452.     at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  453.     at java.lang.Thread.run(Thread.java:745)
  454. Caused by: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30007ms.
  455.     at com.zaxxer.hikari.pool.HikariPool.createTimeoutException(HikariPool.java:676)
  456.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:190)
  457.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:155)
  458.     at com.zaxxer.hikari.HikariDataSource.getConnection(HikariDataSource.java:100)
  459.     at ru.crystals.pos.datasource.jdbc.JDBCMapperDSImpl.getConnection(JDBCMapperDSImpl.java:50)
  460.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:174)
  461.     ... 13 more
  462. 08.08 18:52:58.599 INFO  [MLServiceImpl] Number of pending operations (DISSOCIATING_CARD_MANZANA): 3
  463. 08.08 18:52:58.599 INFO  [MLServiceImpl] Try to cancel pending operation (DISSOCIATING_CARD_MANZANA):
  464.     Id: MQ==
  465.     Date: 2019-08-08 15:56:59.828
  466. 08.08 18:52:58.599 TRACE [MLServiceImpl] entering getServices()
  467. 08.08 18:52:58.601 TRACE [MLServiceImpl] getting services (IN MEMORY)
  468. 08.08 18:52:58.602 TRACE [MLServiceImpl] leaving getServices(). The result size is: 1
  469. 08.08 18:52:58.602 TRACE [MLServiceImpl] Going to send DissociatingCard:
  470. 08.08 18:52:58.602 TRACE [MLServiceImpl] class ru.crystals.pos.ml.wsclient.DissociatingCard is <?xml version="1.0" encoding="UTF-8" standalone="yes"?>
  471. <DissociatingCard xmlns="http://loyalty.manzanagroup.ru/loyalty.xsd">
  472.     <request>
  473.         <ClientTransactionId>1</ClientTransactionId>
  474.         <Organization>Victoria</Organization>
  475.         <BusinessUnit>1780</BusinessUnit>
  476.         <POS>61</POS>
  477.         <CardNumber>99990002</CardNumber>
  478.         <DateTime>2019-08-08T18:52:58.602+03:00</DateTime>
  479.     </request>
  480. </DissociatingCard>
  481.  
  482. 08.08 18:52:58.678 WARN  [MLServiceImpl] failed to connect to a ML POS web-service
  483. com.sun.xml.internal.ws.fault.ServerSOAPFaultException: Client received SOAP Fault from server: java.lang.NullPointerException Please see the server log to find more detail regarding exact cause of the failure.
  484.     at com.sun.xml.internal.ws.fault.SOAP11Fault.getProtocolException(SOAP11Fault.java:178)
  485.     at com.sun.xml.internal.ws.fault.SOAPFaultBuilder.createException(SOAPFaultBuilder.java:116)
  486.     at com.sun.xml.internal.ws.client.sei.StubHandler.readResponse(StubHandler.java:238)
  487.     at com.sun.xml.internal.ws.db.DatabindingImpl.deserializeResponse(DatabindingImpl.java:189)
  488.     at com.sun.xml.internal.ws.db.DatabindingImpl.deserializeResponse(DatabindingImpl.java:276)
  489.     at com.sun.xml.internal.ws.client.sei.SyncMethodHandler.invoke(SyncMethodHandler.java:104)
  490.     at com.sun.xml.internal.ws.client.sei.SyncMethodHandler.invoke(SyncMethodHandler.java:77)
  491.     at com.sun.xml.internal.ws.client.sei.SEIStub.invoke(SEIStub.java:147)
  492.     at com.sun.proxy.$Proxy244.dissociatingCard(Unknown Source)
  493.     at ru.crystals.pos.ml.MLServiceImpl.dissociatingCard(MLServiceImpl.java:1469)
  494.     at ru.crystals.pos.ml.MLServiceImpl.access$200(MLServiceImpl.java:100)
  495.     at ru.crystals.pos.ml.MLServiceImpl$PendingDissociatingCardOperation.run(MLServiceImpl.java:1542)
  496.     at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  497.     at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
  498.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
  499.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
  500.     at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  501.     at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  502.     at java.lang.Thread.run(Thread.java:745)
  503. 08.08 18:52:58.680 ERROR [MLServiceImpl] leaving unbind(String): failed to connect to any of the servers [1] in spite of spending {}
  504. 08.08 18:52:58.686 ERROR [MLServiceImpl] Could not send pending operation (id: 552; date: 2019-08-08 15:56:59.828)
  505. ru.crystals.pos.ml.exception.MLConnectionException: Все сервера ML POS не доступны
  506.     at ru.crystals.pos.ml.MLServiceImpl.dissociatingCard(MLServiceImpl.java:1485)
  507.     at ru.crystals.pos.ml.MLServiceImpl.access$200(MLServiceImpl.java:100)
  508.     at ru.crystals.pos.ml.MLServiceImpl$PendingDissociatingCardOperation.run(MLServiceImpl.java:1542)
  509.     at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  510.     at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
  511.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
  512.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
  513.     at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  514.     at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  515.     at java.lang.Thread.run(Thread.java:745)
  516. 08.08 18:52:58.686 INFO  [MLServiceImpl] Try to cancel pending operation (DISSOCIATING_CARD_MANZANA):
  517.     Id: MQ==
  518.     Date: 2019-08-08 15:56:15.985
  519. 08.08 18:52:58.687 TRACE [MLServiceImpl] entering getServices()
  520. 08.08 18:52:58.688 TRACE [MLServiceImpl] getting services (IN MEMORY)
  521. 08.08 18:52:58.688 TRACE [MLServiceImpl] leaving getServices(). The result size is: 1
  522. 08.08 18:52:58.688 TRACE [MLServiceImpl] Going to send DissociatingCard:
  523. 08.08 18:52:58.689 TRACE [MLServiceImpl] class ru.crystals.pos.ml.wsclient.DissociatingCard is <?xml version="1.0" encoding="UTF-8" standalone="yes"?>
  524. <DissociatingCard xmlns="http://loyalty.manzanagroup.ru/loyalty.xsd">
  525.     <request>
  526.         <ClientTransactionId>1</ClientTransactionId>
  527.         <Organization>Victoria</Organization>
  528.         <BusinessUnit>1780</BusinessUnit>
  529.         <POS>61</POS>
  530.         <CardNumber>99990002</CardNumber>
  531.         <DateTime>2019-08-08T18:52:58.688+03:00</DateTime>
  532.     </request>
  533. </DissociatingCard>
  534.  
  535. 08.08 18:52:58.781 WARN  [MLServiceImpl] failed to connect to a ML POS web-service
  536. com.sun.xml.internal.ws.fault.ServerSOAPFaultException: Client received SOAP Fault from server: java.lang.NullPointerException Please see the server log to find more detail regarding exact cause of the failure.
  537.     at com.sun.xml.internal.ws.fault.SOAP11Fault.getProtocolException(SOAP11Fault.java:178)
  538.     at com.sun.xml.internal.ws.fault.SOAPFaultBuilder.createException(SOAPFaultBuilder.java:116)
  539.     at com.sun.xml.internal.ws.client.sei.StubHandler.readResponse(StubHandler.java:238)
  540.     at com.sun.xml.internal.ws.db.DatabindingImpl.deserializeResponse(DatabindingImpl.java:189)
  541.     at com.sun.xml.internal.ws.db.DatabindingImpl.deserializeResponse(DatabindingImpl.java:276)
  542.     at com.sun.xml.internal.ws.client.sei.SyncMethodHandler.invoke(SyncMethodHandler.java:104)
  543.     at com.sun.xml.internal.ws.client.sei.SyncMethodHandler.invoke(SyncMethodHandler.java:77)
  544.     at com.sun.xml.internal.ws.client.sei.SEIStub.invoke(SEIStub.java:147)
  545.     at com.sun.proxy.$Proxy244.dissociatingCard(Unknown Source)
  546.     at ru.crystals.pos.ml.MLServiceImpl.dissociatingCard(MLServiceImpl.java:1469)
  547.     at ru.crystals.pos.ml.MLServiceImpl.access$200(MLServiceImpl.java:100)
  548.     at ru.crystals.pos.ml.MLServiceImpl$PendingDissociatingCardOperation.run(MLServiceImpl.java:1542)
  549.     at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  550.     at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
  551.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
  552.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
  553.     at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  554.     at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  555.     at java.lang.Thread.run(Thread.java:745)
  556. 08.08 18:52:58.789 ERROR [MLServiceImpl] leaving unbind(String): failed to connect to any of the servers [1] in spite of spending {}
  557. 08.08 18:52:58.800 ERROR [MLServiceImpl] Could not send pending operation (id: 550; date: 2019-08-08 15:56:15.985)
  558. ru.crystals.pos.ml.exception.MLConnectionException: Все сервера ML POS не доступны
  559.     at ru.crystals.pos.ml.MLServiceImpl.dissociatingCard(MLServiceImpl.java:1485)
  560.     at ru.crystals.pos.ml.MLServiceImpl.access$200(MLServiceImpl.java:100)
  561.     at ru.crystals.pos.ml.MLServiceImpl$PendingDissociatingCardOperation.run(MLServiceImpl.java:1542)
  562.     at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  563.     at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
  564.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
  565.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
  566.     at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  567.     at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  568.     at java.lang.Thread.run(Thread.java:745)
  569. 08.08 18:52:58.800 INFO  [MLServiceImpl] Try to cancel pending operation (DISSOCIATING_CARD_MANZANA):
  570.     Id: MQ==
  571.     Date: 2019-08-08 15:56:26.915
  572. 08.08 18:52:58.800 TRACE [MLServiceImpl] entering getServices()
  573. 08.08 18:52:58.800 TRACE [MLServiceImpl] getting services (IN MEMORY)
  574. 08.08 18:52:58.800 TRACE [MLServiceImpl] leaving getServices(). The result size is: 1
  575. 08.08 18:52:58.801 TRACE [MLServiceImpl] Going to send DissociatingCard:
  576. 08.08 18:52:58.801 TRACE [MLServiceImpl] class ru.crystals.pos.ml.wsclient.DissociatingCard is <?xml version="1.0" encoding="UTF-8" standalone="yes"?>
  577. <DissociatingCard xmlns="http://loyalty.manzanagroup.ru/loyalty.xsd">
  578.     <request>
  579.         <ClientTransactionId>1</ClientTransactionId>
  580.         <Organization>Victoria</Organization>
  581.         <BusinessUnit>1780</BusinessUnit>
  582.         <POS>61</POS>
  583.         <CardNumber>99990005</CardNumber>
  584.         <DateTime>2019-08-08T18:52:58.801+03:00</DateTime>
  585.     </request>
  586. </DissociatingCard>
  587.  
  588. 08.08 18:52:58.862 WARN  [MLServiceImpl] failed to connect to a ML POS web-service
  589. com.sun.xml.internal.ws.fault.ServerSOAPFaultException: Client received SOAP Fault from server: java.lang.NullPointerException Please see the server log to find more detail regarding exact cause of the failure.
  590.     at com.sun.xml.internal.ws.fault.SOAP11Fault.getProtocolException(SOAP11Fault.java:178)
  591.     at com.sun.xml.internal.ws.fault.SOAPFaultBuilder.createException(SOAPFaultBuilder.java:116)
  592.     at com.sun.xml.internal.ws.client.sei.StubHandler.readResponse(StubHandler.java:238)
  593.     at com.sun.xml.internal.ws.db.DatabindingImpl.deserializeResponse(DatabindingImpl.java:189)
  594.     at com.sun.xml.internal.ws.db.DatabindingImpl.deserializeResponse(DatabindingImpl.java:276)
  595.     at com.sun.xml.internal.ws.client.sei.SyncMethodHandler.invoke(SyncMethodHandler.java:104)
  596.     at com.sun.xml.internal.ws.client.sei.SyncMethodHandler.invoke(SyncMethodHandler.java:77)
  597.     at com.sun.xml.internal.ws.client.sei.SEIStub.invoke(SEIStub.java:147)
  598.     at com.sun.proxy.$Proxy244.dissociatingCard(Unknown Source)
  599.     at ru.crystals.pos.ml.MLServiceImpl.dissociatingCard(MLServiceImpl.java:1469)
  600.     at ru.crystals.pos.ml.MLServiceImpl.access$200(MLServiceImpl.java:100)
  601.     at ru.crystals.pos.ml.MLServiceImpl$PendingDissociatingCardOperation.run(MLServiceImpl.java:1542)
  602.     at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  603.     at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
  604.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
  605.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
  606.     at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  607.     at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  608.     at java.lang.Thread.run(Thread.java:745)
  609. 08.08 18:52:58.867 ERROR [MLServiceImpl] leaving unbind(String): failed to connect to any of the servers [1] in spite of spending {}
  610. 08.08 18:52:58.872 ERROR [MLServiceImpl] Could not send pending operation (id: 551; date: 2019-08-08 15:56:26.915)
  611. ru.crystals.pos.ml.exception.MLConnectionException: Все сервера ML POS не доступны
  612.     at ru.crystals.pos.ml.MLServiceImpl.dissociatingCard(MLServiceImpl.java:1485)
  613.     at ru.crystals.pos.ml.MLServiceImpl.access$200(MLServiceImpl.java:100)
  614.     at ru.crystals.pos.ml.MLServiceImpl$PendingDissociatingCardOperation.run(MLServiceImpl.java:1542)
  615.     at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  616.     at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
  617.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
  618.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
  619.     at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  620.     at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  621.     at java.lang.Thread.run(Thread.java:745)
  622. 08.08 18:53:03.918 ERROR [TransactionHandler]
  623. java.lang.RuntimeException: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30005ms.
  624.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:180)
  625.     at ru.crystals.pos.datasource.jdbc.TransactionHandler.invoke(TransactionHandler.java:25)
  626.     at com.sun.proxy.$Proxy159.getProperty(Unknown Source)
  627.     at ru.crystals.pos.catalog.limits.ProductLimitsService.getPollInterval(ProductLimitsService.java:350)
  628.     at ru.crystals.pos.catalog.limits.ProductLimitsService.scheduleDeferredTask(ProductLimitsService.java:345)
  629.     at ru.crystals.pos.catalog.limits.ProductLimitsService.run(ProductLimitsService.java:136)
  630.     at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  631.     at java.util.concurrent.FutureTask.run(FutureTask.java:266)
  632.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
  633.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
  634.     at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  635.     at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  636.     at java.lang.Thread.run(Thread.java:745)
  637. Caused by: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30005ms.
  638.     at com.zaxxer.hikari.pool.HikariPool.createTimeoutException(HikariPool.java:676)
  639.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:190)
  640.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:155)
  641.     at com.zaxxer.hikari.HikariDataSource.getConnection(HikariDataSource.java:100)
  642.     at ru.crystals.pos.datasource.jdbc.JDBCMapperDSImpl.getConnection(JDBCMapperDSImpl.java:50)
  643.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:174)
  644.     ... 12 more
  645. 08.08 18:53:03.919 ERROR [JDBCMapperImpl] Cannot rollback transaction
  646. java.lang.NullPointerException
  647.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.closeConnection(JDBCMapperImpl.java:129)
  648.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.rollbackTransaction(JDBCMapperImpl.java:210)
  649.     at ru.crystals.pos.datasource.jdbc.TransactionHandler.invoke(TransactionHandler.java:30)
  650.     at com.sun.proxy.$Proxy159.getProperty(Unknown Source)
  651.     at ru.crystals.pos.catalog.limits.ProductLimitsService.getPollInterval(ProductLimitsService.java:350)
  652.     at ru.crystals.pos.catalog.limits.ProductLimitsService.scheduleDeferredTask(ProductLimitsService.java:345)
  653.     at ru.crystals.pos.catalog.limits.ProductLimitsService.run(ProductLimitsService.java:136)
  654.     at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  655.     at java.util.concurrent.FutureTask.run(FutureTask.java:266)
  656.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
  657.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
  658.     at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  659.     at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  660.     at java.lang.Thread.run(Thread.java:745)
  661. 08.08 18:53:05.753 INFO  [FiscalPrinter] resetException()
  662. 08.08 18:53:05.832 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  663. 08.08 18:53:06.033 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  664. 08.08 18:53:06.234 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  665. 08.08 18:53:06.459 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  666. 08.08 18:53:07.662 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  667. 08.08 18:53:07.863 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  668. 08.08 18:53:08.064 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  669. 08.08 18:53:08.264 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  670. 08.08 18:53:08.465 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  671. 08.08 18:53:08.665 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  672. 08.08 18:53:08.866 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  673. 08.08 18:53:09.069 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  674. 08.08 18:53:14.710 DEBUG [TechProcessImpl] Server online mode
  675. 08.08 18:53:15.808 ERROR [TransactionHandler]
  676. java.lang.RuntimeException: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30002ms.
  677.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:180)
  678.     at ru.crystals.pos.datasource.jdbc.TransactionHandler.invoke(TransactionHandler.java:25)
  679.     at com.sun.proxy.$Proxy159.getProperty(Unknown Source)
  680.     at ru.crystals.pos.catalog.service.filestransport.FilesChecker.isTransportAllowed(FilesChecker.java:179)
  681.     at ru.crystals.pos.catalog.service.filestransport.AbstractGoodsReceiver.scheduleDeferredTask(AbstractGoodsReceiver.java:69)
  682.     at ru.crystals.pos.catalog.service.filestransport.FilesChecker.iterationComplete(FilesChecker.java:99)
  683.     at ru.crystals.pos.catalog.service.filestransport.FilesChecker.run(FilesChecker.java:92)
  684.     at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  685.     at java.util.concurrent.FutureTask.run(FutureTask.java:266)
  686.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
  687.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
  688.     at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  689.     at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  690.     at java.lang.Thread.run(Thread.java:745)
  691. Caused by: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30002ms.
  692.     at com.zaxxer.hikari.pool.HikariPool.createTimeoutException(HikariPool.java:676)
  693.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:190)
  694.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:155)
  695.     at com.zaxxer.hikari.HikariDataSource.getConnection(HikariDataSource.java:100)
  696.     at ru.crystals.pos.datasource.jdbc.JDBCMapperDSImpl.getConnection(JDBCMapperDSImpl.java:50)
  697.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:174)
  698.     ... 13 more
  699. 08.08 18:53:15.809 ERROR [FilesChecker] failed to get ESB ON/OFF status
  700. java.lang.RuntimeException: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30002ms.
  701.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:180)
  702.     at ru.crystals.pos.datasource.jdbc.TransactionHandler.invoke(TransactionHandler.java:25)
  703.     at com.sun.proxy.$Proxy159.getProperty(Unknown Source)
  704.     at ru.crystals.pos.catalog.service.filestransport.FilesChecker.isTransportAllowed(FilesChecker.java:179)
  705.     at ru.crystals.pos.catalog.service.filestransport.AbstractGoodsReceiver.scheduleDeferredTask(AbstractGoodsReceiver.java:69)
  706.     at ru.crystals.pos.catalog.service.filestransport.FilesChecker.iterationComplete(FilesChecker.java:99)
  707.     at ru.crystals.pos.catalog.service.filestransport.FilesChecker.run(FilesChecker.java:92)
  708.     at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  709.     at java.util.concurrent.FutureTask.run(FutureTask.java:266)
  710.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
  711.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
  712.     at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  713.     at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  714.     at java.lang.Thread.run(Thread.java:745)
  715. Caused by: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30002ms.
  716.     at com.zaxxer.hikari.pool.HikariPool.createTimeoutException(HikariPool.java:676)
  717.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:190)
  718.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:155)
  719.     at com.zaxxer.hikari.HikariDataSource.getConnection(HikariDataSource.java:100)
  720.     at ru.crystals.pos.datasource.jdbc.JDBCMapperDSImpl.getConnection(JDBCMapperDSImpl.java:50)
  721.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:174)
  722.     ... 13 more
  723. 08.08 18:53:19.656 INFO  [FiscalPrinter] resetException()
  724. 08.08 18:53:19.712 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  725. 08.08 18:53:19.913 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  726. 08.08 18:53:20.114 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  727. 08.08 18:53:20.341 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  728. 08.08 18:53:21.543 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  729. 08.08 18:53:21.744 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  730. 08.08 18:53:21.944 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  731. 08.08 18:53:22.145 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  732. 08.08 18:53:22.344 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  733. 08.08 18:53:22.545 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  734. 08.08 18:53:22.745 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  735. 08.08 18:53:22.946 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  736. 08.08 18:53:24.376 ERROR [TransactionHandler]
  737. java.lang.RuntimeException: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30000ms.
  738.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:180)
  739.     at ru.crystals.pos.datasource.jdbc.TransactionHandler.invoke(TransactionHandler.java:25)
  740.     at com.sun.proxy.$Proxy159.getProperty(Unknown Source)
  741.     at ru.crystals.cm.cash.CashConfigurationUpdateChecker.getPollInterval(CashConfigurationUpdateChecker.java:167)
  742.     at ru.crystals.cm.cash.CashConfigurationUpdateChecker.run(CashConfigurationUpdateChecker.java:126)
  743. Caused by: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30000ms.
  744.     at com.zaxxer.hikari.pool.HikariPool.createTimeoutException(HikariPool.java:676)
  745.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:190)
  746.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:155)
  747.     at com.zaxxer.hikari.HikariDataSource.getConnection(HikariDataSource.java:100)
  748.     at ru.crystals.pos.datasource.jdbc.JDBCMapperDSImpl.getConnection(JDBCMapperDSImpl.java:50)
  749.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:174)
  750.     ... 4 more
  751. 08.08 18:53:24.376 ERROR [JDBCMapperImpl] Cannot rollback transaction
  752. java.lang.NullPointerException
  753.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.closeConnection(JDBCMapperImpl.java:129)
  754.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.rollbackTransaction(JDBCMapperImpl.java:210)
  755.     at ru.crystals.pos.datasource.jdbc.TransactionHandler.invoke(TransactionHandler.java:30)
  756.     at com.sun.proxy.$Proxy159.getProperty(Unknown Source)
  757.     at ru.crystals.cm.cash.CashConfigurationUpdateChecker.getPollInterval(CashConfigurationUpdateChecker.java:167)
  758.     at ru.crystals.cm.cash.CashConfigurationUpdateChecker.run(CashConfigurationUpdateChecker.java:126)
  759. 08.08 18:53:24.392 ERROR [CashConfigurationUpdateChecker] CashConfigurationUpdateChecker error: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30000ms.
  760. java.lang.RuntimeException: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30000ms.
  761.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:180)
  762.     at ru.crystals.pos.datasource.jdbc.TransactionHandler.invoke(TransactionHandler.java:25)
  763.     at com.sun.proxy.$Proxy159.getProperty(Unknown Source)
  764.     at ru.crystals.cm.cash.CashConfigurationUpdateChecker.getPollInterval(CashConfigurationUpdateChecker.java:167)
  765.     at ru.crystals.cm.cash.CashConfigurationUpdateChecker.run(CashConfigurationUpdateChecker.java:126)
  766. Caused by: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30000ms.
  767.     at com.zaxxer.hikari.pool.HikariPool.createTimeoutException(HikariPool.java:676)
  768.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:190)
  769.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:155)
  770.     at com.zaxxer.hikari.HikariDataSource.getConnection(HikariDataSource.java:100)
  771.     at ru.crystals.pos.datasource.jdbc.JDBCMapperDSImpl.getConnection(JDBCMapperDSImpl.java:50)
  772.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:174)
  773.     ... 4 more
  774. 08.08 18:53:25.081 ERROR [TransactionHandler]
  775. java.lang.RuntimeException: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30000ms.
  776.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:180)
  777.     at ru.crystals.pos.datasource.jdbc.TransactionHandler.invoke(TransactionHandler.java:25)
  778.     at com.sun.proxy.$Proxy159.getProperty(Unknown Source)
  779.     at ru.crystals.pos.loyal.cash.transport.discountresults.TransferManager.isSendDocsToESBEnabled(TransferManager.java:155)
  780.     at ru.crystals.pos.loyal.cash.transport.discountresults.TransferManager.access$000(TransferManager.java:55)
  781.     at ru.crystals.pos.loyal.cash.transport.discountresults.TransferManager$RepeatSender.run(TransferManager.java:102)
  782.     at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  783.     at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
  784.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
  785.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
  786.     at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  787.     at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  788.     at java.lang.Thread.run(Thread.java:745)
  789. Caused by: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30000ms.
  790.     at com.zaxxer.hikari.pool.HikariPool.createTimeoutException(HikariPool.java:676)
  791.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:190)
  792.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:155)
  793.     at com.zaxxer.hikari.HikariDataSource.getConnection(HikariDataSource.java:100)
  794.     at ru.crystals.pos.datasource.jdbc.JDBCMapperDSImpl.getConnection(JDBCMapperDSImpl.java:50)
  795.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:174)
  796.     ... 12 more
  797. 08.08 18:53:25.083 ERROR [JDBCMapperImpl] Cannot rollback transaction
  798. java.lang.NullPointerException
  799.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.closeConnection(JDBCMapperImpl.java:129)
  800.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.rollbackTransaction(JDBCMapperImpl.java:210)
  801.     at ru.crystals.pos.datasource.jdbc.TransactionHandler.invoke(TransactionHandler.java:30)
  802.     at com.sun.proxy.$Proxy159.getProperty(Unknown Source)
  803.     at ru.crystals.pos.loyal.cash.transport.discountresults.TransferManager.isSendDocsToESBEnabled(TransferManager.java:155)
  804.     at ru.crystals.pos.loyal.cash.transport.discountresults.TransferManager.access$000(TransferManager.java:55)
  805.     at ru.crystals.pos.loyal.cash.transport.discountresults.TransferManager$RepeatSender.run(TransferManager.java:102)
  806.     at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  807.     at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
  808.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
  809.     at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
  810.     at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  811.     at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  812.     at java.lang.Thread.run(Thread.java:745)
  813. 08.08 18:53:34.249 INFO  [FiscalPrinter] resetException()
  814. 08.08 18:53:34.295 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  815. 08.08 18:53:34.495 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  816. 08.08 18:53:34.695 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  817. 08.08 18:53:34.825 INFO  [CommonLogger] Starting cleaning. All log records older than 10 мая 2019 18:53:34 will be deleted.
  818. 08.08 18:53:34.827 INFO  [CommonLogger] Cleaning done.
  819. 08.08 18:53:34.909 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  820. 08.08 18:53:36.111 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  821. 08.08 18:53:36.312 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  822. 08.08 18:53:36.512 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  823. 08.08 18:53:36.713 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  824. 08.08 18:53:36.914 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  825. 08.08 18:53:37.114 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  826. 08.08 18:53:37.315 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  827. 08.08 18:53:37.515 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  828. 08.08 18:53:44.711 DEBUG [TechProcessImpl] Server online mode
  829. 08.08 18:53:48.068 INFO  [FiscalPrinter] resetException()
  830. 08.08 18:53:48.110 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  831. 08.08 18:53:48.310 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  832. 08.08 18:53:48.511 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  833. 08.08 18:53:48.722 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  834. 08.08 18:53:49.927 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  835. 08.08 18:53:50.127 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  836. 08.08 18:53:50.328 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  837. 08.08 18:53:50.528 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  838. 08.08 18:53:50.728 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  839. 08.08 18:53:50.929 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  840. 08.08 18:53:51.129 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  841. 08.08 18:53:51.329 ERROR [KeyboardImpl] Keyboard is disabled - cannot process keys from keyboard :WaitComponent.initForms
  842. 08.08 18:53:54.337 INFO  [PendingOperationQueue] Pending cards operation queue is empty. Populating from DB...
  843. 08.08 18:53:54.340 INFO  [PendingOperationQueue] No pending card operations found.
  844. 08.08 18:53:54.399 ERROR [TransactionHandler]
  845. java.lang.RuntimeException: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30006ms.
  846.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:180)
  847.     at ru.crystals.pos.datasource.jdbc.TransactionHandler.invoke(TransactionHandler.java:25)
  848.     at com.sun.proxy.$Proxy159.getProperty(Unknown Source)
  849.     at ru.crystals.cm.cash.CashConfigurationUpdateChecker.getPollInterval(CashConfigurationUpdateChecker.java:167)
  850.     at ru.crystals.cm.cash.CashConfigurationUpdateChecker.run(CashConfigurationUpdateChecker.java:126)
  851. Caused by: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30006ms.
  852.     at com.zaxxer.hikari.pool.HikariPool.createTimeoutException(HikariPool.java:676)
  853.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:190)
  854.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:155)
  855.     at com.zaxxer.hikari.HikariDataSource.getConnection(HikariDataSource.java:100)
  856.     at ru.crystals.pos.datasource.jdbc.JDBCMapperDSImpl.getConnection(JDBCMapperDSImpl.java:50)
  857.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:174)
  858.     ... 4 more
  859. 08.08 18:53:54.400 ERROR [CashConfigurationUpdateChecker] CashConfigurationUpdateChecker error: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30006ms.
  860. java.lang.RuntimeException: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30006ms.
  861.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:180)
  862.     at ru.crystals.pos.datasource.jdbc.TransactionHandler.invoke(TransactionHandler.java:25)
  863.     at com.sun.proxy.$Proxy159.getProperty(Unknown Source)
  864.     at ru.crystals.cm.cash.CashConfigurationUpdateChecker.getPollInterval(CashConfigurationUpdateChecker.java:167)
  865.     at ru.crystals.cm.cash.CashConfigurationUpdateChecker.run(CashConfigurationUpdateChecker.java:126)
  866. Caused by: java.sql.SQLTransientConnectionException: HikariPool-3 - Connection is not available, request timed out after 30006ms.
  867.     at com.zaxxer.hikari.pool.HikariPool.createTimeoutException(HikariPool.java:676)
  868.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:190)
  869.     at com.zaxxer.hikari.pool.HikariPool.getConnection(HikariPool.java:155)
  870.     at com.zaxxer.hikari.HikariDataSource.getConnection(HikariDataSource.java:100)
  871.     at ru.crystals.pos.datasource.jdbc.JDBCMapperDSImpl.getConnection(JDBCMapperDSImpl.java:50)
  872.     at ru.crystals.pos.datasource.jdbc.JDBCMapperImpl.startTransaction(JDBCMapperImpl.java:174)
  873.     ... 4 more
  874. 08.08 18:53:54.892 INFO  [LoyProvidersRegistryImpl] Resend stale feedback
  875. 08.08 18:53:54.892 INFO  [LoyProvidersRegistryImpl] Search for stale feedbacks provider = SetApiLoyaltyPlugin
  876. 08.08 18:53:54.904 INFO  [LoyProvidersRegistryImpl] Found 5 stale feedbacks for SetApiLoyaltyPlugin. Submit to executor
  877. 08.08 18:53:54.911 INFO  [LoyProvidersRegistryImpl] Search for stale feedbacks provider = sm
  878. 08.08 18:53:54.914 INFO  [LoyProvidersRegistryImpl] There is no stale feedback for sm
  879. 08.08 18:53:54.915 INFO  [LoyProvidersRegistryImpl] Search for stale feedbacks provider = smch
  880. 08.08 18:53:54.917 INFO  [LoyProvidersRegistryImpl] There is no stale feedback for smch
  881. 08.08 18:53:54.917 INFO  [LoyProvidersRegistryImpl] Search for stale feedbacks provider = kopilka
  882. 08.08 18:53:54.925 INFO  [LoyProvidersRegistryImpl] There is no stale feedback for kopilka
  883. 08.08 18:53:54.925 INFO  [LoyProvidersRegistryImpl] Search for stale feedbacks provider = aeroflotBonusesCFT
  884. 08.08 18:53:54.939 INFO  [LoyProvidersRegistryImpl] There is no stale feedback for aeroflotBonusesCFT
  885. 08.08 18:53:54.939 INFO  [LoyProvidersRegistryImpl] Search for stale feedbacks provider = set-loy-provider
  886. 08.08 18:53:54.940 INFO  [LoyProvidersRegistryImpl] There is no stale feedback for set-loy-provider
  887. 08.08 18:53:54.940 INFO  [LoyProvidersRegistryImpl] Search for stale feedbacks provider = ml
  888. 08.08 18:53:54.945 INFO  [LoyProvidersRegistryImpl] There is no stale feedback for ml
  889. 08.08 18:53:54.945 INFO  [LoyProvidersRegistryImpl] Search for stale feedbacks provider = loymax
  890. 08.08 18:53:54.947 INFO  [LoyProvidersRegistryImpl] There is no stale feedback for loymax
  891. 08.08 18:53:55.372 TRACE [LoyPluginEmulator] entering onSendFeedback(LoyProviderFeedback). The argument is: LoyProviderFeedback{attemptsCount=0, savingStrategy=REPLACE, actionOnReceiptCancellation=REMOVE}
  892. 08.08 18:53:55.379 TRACE [LoyPluginEmulator] entering readProperties(IntegrationProperties, Logger)
  893. 08.08 18:53:55.380 TRACE [LoyPluginEmulator] getUrlProperty: the "secondary.calc.url" is not set
  894. 08.08 18:53:55.380 TRACE [LoyPluginEmulator] leaving readProperties(IntegrationProperties, Logger). The result is: LoyPluginEmulatorProperties{primaryCalcUrl=http://127.0.0.1:10065/loy-plugin-processing/emulator/process, secondaryCalcUrl=null, feedbackUrl=http://127.0.0.1:10065/loy-plugin-processing/emulator/feedback, connectionTimeout=1000, readTimeout=1000, cardProcessingId='null'}; it took 1 [ms]
  895. 08.08 18:53:55.380 TRACE [LoyPluginEmulator] entering makeFeedbackCall(URL, String, int, int). The arguments are: url [http://127.0.0.1:10065/loy-plugin-processing/emulator/feedback], feedback [feedback from loyalty plugin emulator], connTimeout [1000], readTimeout [1000]
  896. 08.08 18:53:55.413 ERROR [ConnectionEmulatorUtils] toString(XmlEmulatorException): the argument is null
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!