1 Тема от Анна Суровцева

  • Анна Суровцева
  • Посетитель
  • Неактивен

Регулярно ошибка при подписи чеков

Здравствуйте. по несколько раз на день возникают ошибки при подписании чеков.

С чем может быть связано?

лог утм

2019-06-28 14:11:33,622 INFO  es.programador.http.AbstractServlet - Получен чек
2019-06-28 14:11:34,014 INFO  es.programador.http.AbstractServlet - [Future] Результат проверки чека: [Проверка пройдена]
2019-06-28 14:12:25,316 ERROR ru.centerinform.crypto.c - Ошибка подписи документа
java.lang.IllegalStateException: sun.security.pkcs11.wrapper.PKCS11Exception: CKR_SESSION_HANDLE_INVALID
    at ru.centerinform.crypto.m.a(Unknown Source)
    at ru.centerinform.crypto.n.a(Unknown Source)
    at ru.centerinform.crypto.j.b(Unknown Source)
    at ru.centerinform.crypto.j.a(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.doPost(Unknown Source)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
    at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:821)
    at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:583)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
    at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548)
    at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
    at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1158)
    at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
    at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
    at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1090)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
    at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
    at org.eclipse.jetty.server.handler.RequestLogHandler.handle(RequestLogHandler.java:56)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.server.Server.handle(Server.java:517)
    at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:306)
    at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:242)
    at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
    at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
    at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
    at java.lang.Thread.run(Unknown Source)
Caused by: sun.security.pkcs11.wrapper.PKCS11Exception: CKR_SESSION_HANDLE_INVALID
    at sun.security.pkcs11.wrapper.PKCS11.C_SignInit(Native Method)
    at sun.security.pkcs11.wrapper.PKCS11$SynchronizedPKCS11.C_SignInit(PKCS11.java:1721)
    ... 35 more
2019-06-28 14:12:25,319 WARN  ru.centerinform.crypto.j - Ошибка выхода из ключа
sun.security.pkcs11.wrapper.PKCS11Exception: CKR_SESSION_HANDLE_INVALID
    at sun.security.pkcs11.wrapper.PKCS11.C_Logout(Native Method)
    at sun.security.pkcs11.wrapper.PKCS11$SynchronizedPKCS11.C_Logout(PKCS11.java:1603)
    at ru.centerinform.crypto.j.a(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.doPost(Unknown Source)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
    at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:821)
    at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:583)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
    at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548)
    at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
    at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1158)
    at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
    at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
    at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1090)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
    at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
    at org.eclipse.jetty.server.handler.RequestLogHandler.handle(RequestLogHandler.java:56)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.server.Server.handle(Server.java:517)
    at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:306)
    at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:242)
    at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
    at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
    at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
    at java.lang.Thread.run(Unknown Source)
2019-06-28 14:12:25,322 ERROR es.programador.transport.e.b - Проблемы с RSA ключом
java.security.ProviderException: Token has been removed
    at sun.security.pkcs11.Session.id(Session.java:91)
    at sun.security.pkcs11.SessionManager.ensureValid(SessionManager.java:161)
    at sun.security.pkcs11.SessionManager.getOpSession(SessionManager.java:144)
    at sun.security.pkcs11.Token.getOpSession(Token.java:303)
    at sun.security.pkcs11.P11KeyStore.engineGetKey(P11KeyStore.java:307)
    at java.security.KeyStore.getKey(Unknown Source)
    at es.programador.transport.e.b.b(Unknown Source)
    at es.programador.transport.e.b.c(Unknown Source)
    at es.programador.transport.o$a.a(Unknown Source)
    at es.programador.a.c.a(Unknown Source)
    at es.programador.transport.i.e.a(Unknown Source)
    at es.programador.transport.i.d.execute(Unknown Source)
    at org.quartz.core.JobRunShell.run(JobRunShell.java:213)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:557)
2019-06-28 14:12:25,323 WARN  ru.centerinform.crypto.j - Ошибка закрытия сессии
sun.security.pkcs11.wrapper.PKCS11Exception: CKR_SESSION_HANDLE_INVALID
    at sun.security.pkcs11.wrapper.PKCS11.C_CloseSession(Native Method)
    at sun.security.pkcs11.wrapper.PKCS11$SynchronizedPKCS11.C_CloseSession(PKCS11.java:1589)
    at ru.centerinform.crypto.j.a(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.doPost(Unknown Source)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
    at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:821)
    at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:583)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
    at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548)
    at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
    at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1158)
    at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
    at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
    at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1090)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
    at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
    at org.eclipse.jetty.server.handler.RequestLogHandler.handle(RequestLogHandler.java:56)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.server.Server.handle(Server.java:517)
    at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:306)
    at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:242)
    at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
    at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
    at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
    at java.lang.Thread.run(Unknown Source)
2019-06-28 14:12:25,326 INFO  ru.centerinform.crypto.c - Вторая попытка подписать документ
2019-06-28 14:12:25,327 INFO  ru.centerinform.crypto.c - Инициализации криптобиблиотеки
2019-06-28 14:12:25,377 ERROR ru.centerinform.crypto.c - Ошибка переинициализации криптографера
java.lang.IllegalStateException: Ошибка поиска модели
    at ru.centerinform.crypto.j.a(Unknown Source)
    at ru.centerinform.crypto.j.a(Unknown Source)
    at ru.centerinform.crypto.c.k(Unknown Source)
    at ru.centerinform.crypto.c.i(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.doPost(Unknown Source)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
    at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:821)
    at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:583)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
    at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548)
    at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
    at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1158)
    at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
    at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
    at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1090)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
    at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
    at org.eclipse.jetty.server.handler.RequestLogHandler.handle(RequestLogHandler.java:56)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.server.Server.handle(Server.java:517)
    at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:306)
    at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:242)
    at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
    at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
    at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
    at java.lang.Thread.run(Unknown Source)
Caused by: sun.security.pkcs11.wrapper.PKCS11Exception: CKR_TOKEN_NOT_PRESENT
    at sun.security.pkcs11.wrapper.PKCS11.C_GetTokenInfo(Native Method)
    at sun.security.pkcs11.wrapper.PKCS11$SynchronizedPKCS11.C_GetTokenInfo(PKCS11.java:1569)
    ... 36 more
2019-06-28 14:12:25,383 ERROR es.programador.http.AbstractServlet - Некорректное состояние транспортного терминала
java.lang.IllegalStateException: Не удалось подписать документ
    at ru.centerinform.crypto.c.a(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.doPost(Unknown Source)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
    at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:821)
    at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:583)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
    at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548)
    at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
    at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1158)
    at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
    at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
    at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1090)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
    at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
    at org.eclipse.jetty.server.handler.RequestLogHandler.handle(RequestLogHandler.java:56)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.server.Server.handle(Server.java:517)
    at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:306)
    at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:242)
    at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
    at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
    at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
    at java.lang.Thread.run(Unknown Source)
2019-06-28 14:12:25,398 ERROR es.programador.transport.e.b - Ошибка переинициализации RSA
java.security.ProviderException: Initialization failed
    at sun.security.pkcs11.SunPKCS11.<init>(SunPKCS11.java:376)
    at sun.security.pkcs11.SunPKCS11.<init>(SunPKCS11.java:107)
    at es.programador.transport.e.b.b(Unknown Source)
    at es.programador.transport.e.b.d(Unknown Source)
    at es.programador.transport.e.b.b(Unknown Source)
    at es.programador.transport.e.b.c(Unknown Source)
    at es.programador.transport.o$a.a(Unknown Source)
    at es.programador.a.c.a(Unknown Source)
    at es.programador.transport.i.e.a(Unknown Source)
    at es.programador.transport.i.d.execute(Unknown Source)
    at org.quartz.core.JobRunShell.run(JobRunShell.java:213)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:557)
Caused by: java.security.ProviderException: slotListIndex is 0 but token only has 0 slots
    at sun.security.pkcs11.SunPKCS11.<init>(SunPKCS11.java:357)
    ... 11 more
2019-06-28 14:12:25,494 ERROR es.programador.transport.i.e - Ошибка при получении и чтении документов с сервера ЕГАИС
java.io.IOException: Ошибка при проверке ключа
    at es.programador.a.c.a(Unknown Source)
    at es.programador.transport.i.e.a(Unknown Source)
    at es.programador.transport.i.d.execute(Unknown Source)
    at org.quartz.core.JobRunShell.run(JobRunShell.java:213)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:557)
2019-06-28 14:12:25,531 ERROR es.programador.transport.e.b - Проблемы с RSA ключом
java.security.ProviderException: Token has been removed
    at sun.security.pkcs11.Token.ensureValid(Token.java:249)
    at sun.security.pkcs11.P11KeyStore.engineGetKey(P11KeyStore.java:295)
    at java.security.KeyStore.getKey(Unknown Source)
    at es.programador.transport.e.b.b(Unknown Source)
    at es.programador.transport.e.b.c(Unknown Source)
    at es.programador.transport.o$a.a(Unknown Source)
    at es.programador.a.c.a(Unknown Source)
    at es.programador.transport.i.e.a(Unknown Source)
    at es.programador.transport.i.d.execute(Unknown Source)
    at org.quartz.core.JobRunShell.run(JobRunShell.java:213)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:557)
2019-06-28 14:12:25,558 ERROR es.programador.transport.e.b - Ошибка переинициализации RSA
java.security.ProviderException: Initialization failed
    at sun.security.pkcs11.SunPKCS11.<init>(SunPKCS11.java:376)
    at sun.security.pkcs11.SunPKCS11.<init>(SunPKCS11.java:107)
    at es.programador.transport.e.b.b(Unknown Source)
    at es.programador.transport.e.b.d(Unknown Source)
    at es.programador.transport.e.b.b(Unknown Source)
    at es.programador.transport.e.b.c(Unknown Source)
    at es.programador.transport.o$a.a(Unknown Source)
    at es.programador.a.c.a(Unknown Source)
    at es.programador.transport.i.e.a(Unknown Source)
    at es.programador.transport.i.d.execute(Unknown Source)
    at org.quartz.core.JobRunShell.run(JobRunShell.java:213)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:557)
Caused by: java.security.ProviderException: slotListIndex is 0 but token only has 0 slots
    at sun.security.pkcs11.SunPKCS11.<init>(SunPKCS11.java:357)
    ... 11 more
2019-06-28 14:12:25,559 ERROR es.programador.transport.i.e - Ошибка при получении и чтении документов с сервера ЕГАИС
java.io.IOException: Ошибка при проверке ключа
    at es.programador.a.c.a(Unknown Source)
    at es.programador.transport.i.e.a(Unknown Source)
    at es.programador.transport.i.d.execute(Unknown Source)
    at org.quartz.core.JobRunShell.run(JobRunShell.java:213)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:557)
2019-06-28 14:12:25,564 INFO  es.programador.transport.p - Удаление документов скачанных ранее чем 2019-06-27 14:12:25 в статусах [2]
2019-06-28 14:12:25,564 INFO  es.programador.transport.p - Документы DOC_TYPE: [WayBill, WayBill_v2, WayBill_v3, FormBRegInfo, Form2RegInfo, WayBillAct, WayBillAct_v2, WayBillAct_v3, WayBillTicket, Ticket] удалены не будут.
2019-06-28 14:12:25,571 INFO  es.programador.transport.p - Удаление документов скачанных ранее чем 2019-06-21 14:12:25 в статусах [2]
2019-06-28 14:12:25,572 INFO  es.programador.transport.i.e - Завершение задачи получения документов с сервера ЕГАИС
2019-06-28 14:12:25,572 INFO  es.programador.transport.i.d - Завершение задачи получения документов с сервера ЕГАИС по расписанию
2019-06-28 14:12:25,754 INFO  es.programador.transport.i.d - Завершение задачи обмена документами с сервером ЕГАИС по расписанию
2019-06-28 14:13:22,502 INFO  es.programador.transport.i.d - Начало задачи обмена документами с сервером ЕГАИС по расписанию
2019-06-28 14:13:22,502 INFO  es.programador.transport.i.d - Отправка данных на сервер ЕГАИС по расписанию
2019-06-28 14:13:22,503 INFO  es.programador.transport.o - Отправка данных на сервер ЕГАИС
2019-06-28 14:13:22,521 INFO  es.programador.transport.g - Удаление исходящих документов в статусе: [1, 41]
2019-06-28 14:13:22,523 INFO  es.programador.transport.o - Завершение задачи отправки документов на сервер ЕГАИС
2019-06-28 14:13:22,523 INFO  es.programador.transport.i.d - Завершение задачи отправки документов на сервера ЕГАИС по расписанию
2019-06-28 14:13:22,523 INFO  es.programador.transport.i.d - Получение документов с сервера ЕГАИС по расписанию
2019-06-28 14:13:22,523 INFO  es.programador.transport.i.e - Получение документов с сервера ЕГАИС
2019-06-28 14:13:22,528 INFO  es.programador.transport.i.e - Счетчик непогашенных чеков: [4]
2019-06-28 14:13:22,532 INFO  es.programador.transport.i.e - Счетчик непогашенных запросов: [81]
2019-06-28 14:13:23,028 INFO  es.programador.http.AbstractServlet - Получен чек
2019-06-28 14:13:23,100 INFO  ru.centerinform.crypto.c - Инициализации криптобиблиотеки
2019-06-28 14:13:23,381 INFO  es.programador.http.AbstractServlet - [Future] Результат проверки чека: [Проверка пройдена]
2019-06-28 14:13:23,826 INFO  es.programador.transport.i.e - Счетчик непогашенных АСКП: [0]
2019-06-28 14:13:23,848 ERROR es.programador.transport.e.b - Проблемы с RSA ключом
java.security.ProviderException: Token has been removed
    at sun.security.pkcs11.Token.ensureValid(Token.java:249)
    at sun.security.pkcs11.P11KeyStore.engineGetKey(P11KeyStore.java:295)
    at java.security.KeyStore.getKey(Unknown Source)
    at es.programador.transport.e.b.b(Unknown Source)
    at es.programador.transport.e.b.c(Unknown Source)
    at es.programador.transport.o$a.a(Unknown Source)
    at es.programador.a.c.a(Unknown Source)
    at es.programador.transport.i.e.a(Unknown Source)
    at es.programador.transport.i.d.execute(Unknown Source)
    at org.quartz.core.JobRunShell.run(JobRunShell.java:213)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:557)
2019-06-28 14:13:24,010 WARN  ru.centerinform.crypto.c - Не удалось получить сертификат []
java.lang.ArrayIndexOutOfBoundsException: 0
    at ru.centerinform.crypto.j.a(Unknown Source)
    at ru.centerinform.crypto.c.b(Unknown Source)
    at ru.centerinform.crypto.c.k(Unknown Source)
    at ru.centerinform.crypto.c.i(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.doPost(Unknown Source)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
    at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:821)
    at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:583)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
    at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548)
    at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
    at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1158)
    at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
    at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
    at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1090)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
    at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
    at org.eclipse.jetty.server.handler.RequestLogHandler.handle(RequestLogHandler.java:56)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.server.Server.handle(Server.java:517)
    at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:306)
    at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:242)
    at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
    at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
    at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
    at java.lang.Thread.run(Unknown Source)
2019-06-28 14:13:24,186 INFO  es.programador.transport.e.b - Найден слот смарт-карты [0:Rutoken ECP     ]
2019-06-28 14:13:24,996 INFO  ru.centerinform.crypto.c - Используется сертификат SerialNumber: 67d48d0068aa6eab44f72043001f6c9e
2019-06-28 14:13:25,425 INFO  es.programador.http.AbstractServlet - Сохранение данных для последующей отправки: Ticket{inn=1101059370, kpp=110145004, address=г. Сыктывкар, ул. Интернациональная, д.133, cashboxId=9284000100135856, sequenceId=243, ticketId=28466, rawDate=2806191411, products=[Bottle {barcode=22N0000SNF76E8JUSF48TR781218007006805AG2K122BQAH7BVPFQ12R9DFA30NLEAF, price=479.00, ean=, volume=0.5000}]}
2019-06-28 14:13:28,012 INFO  es.programador.transport.e.b - Используется сертификат SerialNumber: 479908a50000000abdaa
2019-06-28 14:13:28,748 INFO  es.programador.transport.i.e - Запрос документов с сервера

2 Ответ от Ксения Шаврова

  • Ксения Шаврова
  • Администратор
  • Неактивен

Re: Регулярно ошибка при подписи чеков

Здравствуйте, Анна.

Предлагаю выполнить следующие действия:

1) Удалить все следы RSA-ключей утилитой DeleteRSA
2) Запустить утилиту Восстановления работы Рутокен
3) Перевыписать RSA-ключ в личном кабинете http://egais.ru/

Посмотрите, будет ли возникать эта ошибка.

3 Ответ от Анна Суровцева

  • Анна Суровцева
  • Посетитель
  • Неактивен

Re: Регулярно ошибка при подписи чеков

возникает. вчера проведи действия описанные выше.

2019-07-02 08:32:07,242 ERROR ru.centerinform.crypto.c - Ошибка подписи документа
java.lang.IllegalStateException: sun.security.pkcs11.wrapper.PKCS11Exception: CKR_SESSION_HANDLE_INVALID
    at ru.centerinform.crypto.m.a(Unknown Source)
    at ru.centerinform.crypto.n.a(Unknown Source)
    at ru.centerinform.crypto.j.b(Unknown Source)
    at ru.centerinform.crypto.j.a(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.doPost(Unknown Source)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
    at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:821)
    at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:583)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
    at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548)
    at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
    at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1158)
    at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
    at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
    at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1090)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
    at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
    at org.eclipse.jetty.server.handler.RequestLogHandler.handle(RequestLogHandler.java:56)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.server.Server.handle(Server.java:517)
    at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:306)
    at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:242)
    at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
    at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
    at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
    at java.lang.Thread.run(Unknown Source)
Caused by: sun.security.pkcs11.wrapper.PKCS11Exception: CKR_SESSION_HANDLE_INVALID
    at sun.security.pkcs11.wrapper.PKCS11.C_SignInit(Native Method)
    at sun.security.pkcs11.wrapper.PKCS11$SynchronizedPKCS11.C_SignInit(PKCS11.java:1721)
    ... 35 more
2019-07-02 08:32:07,252 ERROR es.programador.transport.e.b - Проблемы с RSA ключом
java.security.ProviderException: Token has been removed
    at sun.security.pkcs11.Session.id(Session.java:91)
    at sun.security.pkcs11.SessionManager.ensureValid(SessionManager.java:161)
    at sun.security.pkcs11.SessionManager.getOpSession(SessionManager.java:144)
    at sun.security.pkcs11.Token.getOpSession(Token.java:303)
    at sun.security.pkcs11.P11KeyStore.engineGetKey(P11KeyStore.java:307)
    at java.security.KeyStore.getKey(Unknown Source)
    at es.programador.transport.e.b.b(Unknown Source)
    at es.programador.transport.e.b.c(Unknown Source)
    at es.programador.transport.o$a.a(Unknown Source)
    at es.programador.a.c.a(Unknown Source)
    at es.programador.transport.i.e.a(Unknown Source)
    at es.programador.transport.i.d.execute(Unknown Source)
    at org.quartz.core.JobRunShell.run(JobRunShell.java:213)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:557)
2019-07-02 08:32:07,262 WARN  ru.centerinform.crypto.j - Ошибка выхода из ключа
sun.security.pkcs11.wrapper.PKCS11Exception: CKR_SESSION_HANDLE_INVALID
    at sun.security.pkcs11.wrapper.PKCS11.C_Logout(Native Method)
    at sun.security.pkcs11.wrapper.PKCS11$SynchronizedPKCS11.C_Logout(PKCS11.java:1603)
    at ru.centerinform.crypto.j.a(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.doPost(Unknown Source)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
    at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:821)
    at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:583)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
    at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548)
    at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
    at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1158)
    at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
    at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
    at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1090)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
    at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
    at org.eclipse.jetty.server.handler.RequestLogHandler.handle(RequestLogHandler.java:56)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.server.Server.handle(Server.java:517)
    at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:306)
    at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:242)
    at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
    at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
    at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
    at java.lang.Thread.run(Unknown Source)
2019-07-02 08:32:07,262 WARN  ru.centerinform.crypto.j - Ошибка закрытия сессии
sun.security.pkcs11.wrapper.PKCS11Exception: CKR_SESSION_HANDLE_INVALID
    at sun.security.pkcs11.wrapper.PKCS11.C_CloseSession(Native Method)
    at sun.security.pkcs11.wrapper.PKCS11$SynchronizedPKCS11.C_CloseSession(PKCS11.java:1589)
    at ru.centerinform.crypto.j.a(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.doPost(Unknown Source)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
    at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:821)
    at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:583)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
    at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548)
    at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
    at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1158)
    at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
    at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
    at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1090)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
    at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
    at org.eclipse.jetty.server.handler.RequestLogHandler.handle(RequestLogHandler.java:56)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.server.Server.handle(Server.java:517)
    at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:306)
    at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:242)
    at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
    at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
    at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
    at java.lang.Thread.run(Unknown Source)
2019-07-02 08:32:07,272 INFO  ru.centerinform.crypto.c - Вторая попытка подписать документ
2019-07-02 08:32:07,273 INFO  ru.centerinform.crypto.c - Инициализации криптобиблиотеки
2019-07-02 08:32:07,304 ERROR ru.centerinform.crypto.c - Ошибка переинициализации криптографера
java.lang.IllegalStateException: Ошибка поиска модели
    at ru.centerinform.crypto.j.a(Unknown Source)
    at ru.centerinform.crypto.j.a(Unknown Source)
    at ru.centerinform.crypto.c.k(Unknown Source)
    at ru.centerinform.crypto.c.i(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.doPost(Unknown Source)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
    at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:821)
    at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:583)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
    at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548)
    at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
    at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1158)
    at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
    at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
    at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1090)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
    at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
    at org.eclipse.jetty.server.handler.RequestLogHandler.handle(RequestLogHandler.java:56)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.server.Server.handle(Server.java:517)
    at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:306)
    at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:242)
    at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
    at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
    at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
    at java.lang.Thread.run(Unknown Source)
Caused by: sun.security.pkcs11.wrapper.PKCS11Exception: CKR_TOKEN_NOT_PRESENT
    at sun.security.pkcs11.wrapper.PKCS11.C_GetTokenInfo(Native Method)
    at sun.security.pkcs11.wrapper.PKCS11$SynchronizedPKCS11.C_GetTokenInfo(PKCS11.java:1569)
    ... 36 more
2019-07-02 08:32:07,306 ERROR es.programador.transport.e.b - Ошибка переинициализации RSA
java.security.ProviderException: Initialization failed
    at sun.security.pkcs11.SunPKCS11.<init>(SunPKCS11.java:376)
    at sun.security.pkcs11.SunPKCS11.<init>(SunPKCS11.java:107)
    at es.programador.transport.e.b.b(Unknown Source)
    at es.programador.transport.e.b.d(Unknown Source)
    at es.programador.transport.e.b.b(Unknown Source)
    at es.programador.transport.e.b.c(Unknown Source)
    at es.programador.transport.o$a.a(Unknown Source)
    at es.programador.a.c.a(Unknown Source)
    at es.programador.transport.i.e.a(Unknown Source)
    at es.programador.transport.i.d.execute(Unknown Source)
    at org.quartz.core.JobRunShell.run(JobRunShell.java:213)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:557)
Caused by: java.security.ProviderException: slotListIndex is 0 but token only has 0 slots
    at sun.security.pkcs11.SunPKCS11.<init>(SunPKCS11.java:357)
    ... 11 more
2019-07-02 08:32:07,309 ERROR es.programador.http.AbstractServlet - Некорректное состояние транспортного терминала
java.lang.IllegalStateException: Не удалось подписать документ
    at ru.centerinform.crypto.c.a(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.doPost(Unknown Source)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
    at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:821)
    at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:583)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
    at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548)
    at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
    at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1158)
    at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
    at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
    at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1090)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
    at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
    at org.eclipse.jetty.server.handler.RequestLogHandler.handle(RequestLogHandler.java:56)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.server.Server.handle(Server.java:517)
    at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:306)
    at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:242)
    at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
    at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
    at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
    at java.lang.Thread.run(Unknown Source)
2019-07-02 08:32:07,440 ERROR es.programador.transport.i.e - Ошибка при получении и чтении документов с сервера ЕГАИС
java.io.IOException: Ошибка при проверке ключа
    at es.programador.a.c.a(Unknown Source)
    at es.programador.transport.i.e.a(Unknown Source)
    at es.programador.transport.i.d.execute(Unknown Source)
    at org.quartz.core.JobRunShell.run(JobRunShell.java:213)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:557)
2019-07-02 08:32:07,510 INFO  es.programador.transport.p - Удаление документов скачанных ранее чем 2019-07-01 08:32:07 в статусах [2]
2019-07-02 08:32:07,510 INFO  es.programador.transport.p - Документы DOC_TYPE: [WayBill, WayBill_v2, WayBill_v3, FormBRegInfo, Form2RegInfo, WayBillAct, WayBillAct_v2, WayBillAct_v3, WayBillTicket, Ticket] удалены не будут.
2019-07-02 08:32:07,520 INFO  es.programador.transport.p - Удаление документов скачанных ранее чем 2019-06-25 08:32:07 в статусах [2]
2019-07-02 08:32:07,520 INFO  es.programador.transport.i.e - Завершение задачи получения документов с сервера ЕГАИС
2019-07-02 08:32:07,520 INFO  es.programador.transport.i.d - Завершение задачи получения документов с сервера ЕГАИС по расписанию
2019-07-02 08:32:07,710 INFO  es.programador.transport.i.d - Завершение задачи обмена документами с сервером ЕГАИС по расписанию
2019-07-02 08:32:50,748 INFO  es.programador.transport.i.d - Начало задачи обмена документами с сервером ЕГАИС по расписанию
2019-07-02 08:32:50,748 INFO  es.programador.transport.i.d - Отправка данных на сервер ЕГАИС по расписанию
2019-07-02 08:32:50,748 INFO  es.programador.transport.o - Отправка данных на сервер ЕГАИС
2019-07-02 08:32:50,772 INFO  es.programador.transport.g - Удаление исходящих документов в статусе: [1, 41]
2019-07-02 08:32:50,776 INFO  es.programador.transport.o - Завершение задачи отправки документов на сервер ЕГАИС
2019-07-02 08:32:50,777 INFO  es.programador.transport.i.d - Завершение задачи отправки документов на сервера ЕГАИС по расписанию
2019-07-02 08:32:50,777 INFO  es.programador.transport.i.d - Получение документов с сервера ЕГАИС по расписанию
2019-07-02 08:32:50,777 INFO  es.programador.transport.i.e - Получение документов с сервера ЕГАИС
2019-07-02 08:32:50,782 INFO  es.programador.transport.i.e - Счетчик непогашенных чеков: [0]
2019-07-02 08:32:50,785 INFO  es.programador.transport.i.e - Счетчик непогашенных запросов: [85]
2019-07-02 08:32:51,064 INFO  es.programador.transport.i.e - Счетчик непогашенных АСКП: [0]
2019-07-02 08:32:51,115 ERROR es.programador.transport.e.b - Проблемы с RSA ключом
java.security.ProviderException: Token has been removed
    at sun.security.pkcs11.Token.ensureValid(Token.java:249)
    at sun.security.pkcs11.P11KeyStore.engineGetKey(P11KeyStore.java:295)
    at java.security.KeyStore.getKey(Unknown Source)
    at es.programador.transport.e.b.b(Unknown Source)
    at es.programador.transport.e.b.c(Unknown Source)
    at es.programador.transport.o$a.a(Unknown Source)
    at es.programador.a.c.a(Unknown Source)
    at es.programador.transport.i.e.a(Unknown Source)
    at es.programador.transport.i.d.execute(Unknown Source)
    at org.quartz.core.JobRunShell.run(JobRunShell.java:213)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:557)
2019-07-02 08:32:51,175 INFO  es.programador.transport.e.b - Найден слот смарт-карты [0:Rutoken ECP     ]
2019-07-02 08:32:54,307 INFO  es.programador.transport.e.b - Используется сертификат SerialNumber: 33d648f20000000b3a01
2019-07-02 08:32:55,447 INFO  es.programador.transport.i.e - Запрос документов с сервера
2019-07-02 08:32:57,344 INFO  es.programador.transport.p - Удаление документов скачанных ранее чем 2019-07-01 08:32:57 в статусах [2]
2019-07-02 08:32:57,345 INFO  es.programador.transport.p - Документы DOC_TYPE: [WayBill, WayBill_v2, WayBill_v3, FormBRegInfo, Form2RegInfo, WayBillAct, WayBillAct_v2, WayBillAct_v3, WayBillTicket, Ticket] удалены не будут.
2019-07-02 08:32:57,348 INFO  es.programador.transport.p - Удаление документов скачанных ранее чем 2019-06-25 08:32:57 в статусах [2]
2019-07-02 08:32:57,350 INFO  es.programador.transport.i.e - Завершение задачи получения документов с сервера ЕГАИС
2019-07-02 08:32:57,350 INFO  es.programador.transport.i.d - Завершение задачи получения документов с сервера ЕГАИС по расписанию
2019-07-02 08:32:57,540 INFO  es.programador.transport.i.d - Завершение задачи обмена документами с сервером ЕГАИС по расписанию
2019-07-02 08:33:05,805 INFO  es.programador.http.AbstractServlet - Получен чек
2019-07-02 08:33:05,875 INFO  ru.centerinform.crypto.c - Инициализации криптобиблиотеки
2019-07-02 08:33:06,135 INFO  es.programador.http.AbstractServlet - [Future] Результат проверки чека: [Проверка пройдена]
2019-07-02 08:33:06,863 WARN  ru.centerinform.crypto.c - Не удалось получить сертификат []
java.lang.ArrayIndexOutOfBoundsException: 0
    at ru.centerinform.crypto.j.a(Unknown Source)
    at ru.centerinform.crypto.c.b(Unknown Source)
    at ru.centerinform.crypto.c.k(Unknown Source)
    at ru.centerinform.crypto.c.i(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.doPost(Unknown Source)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
    at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:821)
    at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:583)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
    at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548)
    at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
    at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1158)
    at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
    at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
    at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1090)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
    at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
    at org.eclipse.jetty.server.handler.RequestLogHandler.handle(RequestLogHandler.java:56)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.server.Server.handle(Server.java:517)
    at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:306)
    at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:242)
    at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
    at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
    at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
    at java.lang.Thread.run(Unknown Source)
2019-07-02 08:33:07,522 INFO  ru.centerinform.crypto.c - Используется сертификат SerialNumber: 67d48d0068aa6eab44f72043001f6c9e
2019-07-02 08:33:07,952 INFO  es.programador.http.AbstractServlet - Сохранение данных для последующей отправки: Ticket{inn=1101059370, kpp=110145004, address=г. Сыктывкар, ул. Интернациональная, д.133, cashboxId=9284000100135856, sequenceId=248, ticketId=29224, rawDate=0207190831, products=[Bottle {barcode=136200657955801018001ANNWTMOM3BOKW6KBCDOOB6N6X4QA3PLOES3I6JNBYSIRJ3FKBETN4BVWLP6XECRJHIGDBBI3NMUS46R7Q7TQ7VUOF3X6FR6CQ7LTHOAH4G2MPQU3CLA2JDTRF5LI3H6WA, price=223.00, ean=, volume=0.5000}]}

4 Ответ от Ксения Шаврова

  • Ксения Шаврова
  • Администратор
  • Неактивен

Re: Регулярно ошибка при подписи чеков

Анна, подскажите, я могу подключиться к вам удаленно?
Хочу проверить все ли в порядке с ключом Рутокен.

Подключиться могу через TeamViewer Quick Support.
Если есть другая запущенная версия TeamViewer - перед запуском нашей утилиты её необходимо закрыть.
Иначе, мы не сможем подключиться.
После запуска утилиты сообщите в этой ветке форума или письмом на hotline@rutoken.ru о готовности к подключению.

5 Ответ от Анна Суровцева (2019-07-03 10:42:35 отредактировано Анна Суровцева)

  • Анна Суровцева
  • Посетитель
  • Неактивен

Re: Регулярно ошибка при подписи чеков

Ксения Шаврова, написала на почту. только ошибка была в 10:37

6 Ответ от Ксения Шаврова

  • Ксения Шаврова
  • Администратор
  • Неактивен

Re: Регулярно ошибка при подписи чеков

В ходе удаленного подключения выявлено:
1) Устаревшая версия Драйверов Рутокен (4.2.3) вполне могла давать проблемы при генерации RSA, создавать лишние файлы
2) На Рутокене помимо ГОСТ и RSA сертификата лежала пустая ключевая пара и отдельно сертификат (не подходящие друг к другу)

Что сделано:
1) Обновлены Драйверы Рутокен до актуальной версии
2) Удалены лишние объекты и повторно запущена утилита DeleteRSA
3) Ключ RSA повторно выписан.

7 Ответ от Анна Суровцева

  • Анна Суровцева
  • Посетитель
  • Неактивен

Re: Регулярно ошибка при подписи чеков

не знаю эта проблема или уже другая. есть ли у Рутокена логи?

приведённые вами рекомендации были сделаны. ключа два всего на рутокене. гост и pki


2019-07-03 16:30:08,551 INFO  es.programador.http.AbstractServlet - Получен чек
2019-07-03 16:30:08,892 INFO  es.programador.http.AbstractServlet - [Future] Результат проверки чека: [Проверка пройдена]
2019-07-03 16:34:23,519 INFO  es.programador.http.AbstractServlet - Получен чек
2019-07-03 16:34:23,586 WARN  es.programador.http.AbstractServlet - Подпись предыдущего чека не завершена.
2019-07-03 16:34:31,302 INFO  es.programador.http.AbstractServlet - Получен чек
2019-07-03 16:34:31,369 WARN  es.programador.http.AbstractServlet - Подпись предыдущего чека не завершена.
2019-07-03 16:34:36,942 INFO  es.programador.http.AbstractServlet - Получен чек
2019-07-03 16:34:37,008 WARN  es.programador.http.AbstractServlet - Подпись предыдущего чека не завершена.
2019-07-03 16:34:42,271 INFO  es.programador.http.AbstractServlet - Получен чек
2019-07-03 16:34:42,325 WARN  es.programador.http.AbstractServlet - Подпись предыдущего чека не завершена.
2019-07-03 16:35:08,288 INFO  es.programador.http.AbstractServlet - Получен чек
2019-07-03 16:35:08,334 WARN  es.programador.http.AbstractServlet - Подпись предыдущего чека не завершена.
2019-07-03 16:35:55,305 INFO  es.programador.http.AbstractServlet - Получен чек
2019-07-03 16:35:55,358 WARN  es.programador.http.AbstractServlet - Подпись предыдущего чека не завершена.
2019-07-03 16:36:10,830 INFO  es.programador.http.AbstractServlet - Получен чек
2019-07-03 16:36:10,883 WARN  es.programador.http.AbstractServlet - Подпись предыдущего чека не завершена.
2019-07-03 16:36:15,737 INFO  es.programador.http.AbstractServlet - Получен чек
2019-07-03 16:36:15,797 WARN  es.programador.http.AbstractServlet - Подпись предыдущего чека не завершена.
2019-07-03 16:36:42,843 INFO  es.programador.http.AbstractServlet - Получен чек
2019-07-03 16:36:42,899 WARN  es.programador.http.AbstractServlet - Подпись предыдущего чека не завершена.
2019-07-03 16:37:17,102 INFO  es.programador.http.AbstractServlet - Получен чек
2019-07-03 16:37:17,153 WARN  es.programador.http.AbstractServlet - Подпись предыдущего чека не завершена.
2019-07-03 16:38:40,997 ERROR ru.centerinform.crypto.c - Ошибка подписи документа
java.lang.IllegalStateException: sun.security.pkcs11.wrapper.PKCS11Exception: CKR_KEY_HANDLE_INVALID
    at ru.centerinform.crypto.m.a(Unknown Source)
    at ru.centerinform.crypto.n.a(Unknown Source)
    at ru.centerinform.crypto.j.b(Unknown Source)
    at ru.centerinform.crypto.j.a(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.doPost(Unknown Source)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
    at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:821)
    at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:583)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
    at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548)
    at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
    at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1158)
    at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
    at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
    at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1090)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
    at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
    at org.eclipse.jetty.server.handler.RequestLogHandler.handle(RequestLogHandler.java:56)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.server.Server.handle(Server.java:517)
    at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:306)
    at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:242)
    at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
    at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
    at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
    at java.lang.Thread.run(Unknown Source)
Caused by: sun.security.pkcs11.wrapper.PKCS11Exception: CKR_KEY_HANDLE_INVALID
    at sun.security.pkcs11.wrapper.PKCS11.C_SignInit(Native Method)
    at sun.security.pkcs11.wrapper.PKCS11$SynchronizedPKCS11.C_SignInit(PKCS11.java:1721)
    ... 35 more
2019-07-03 16:38:41,005 ERROR es.programador.transport.e.b - Проблемы с RSA ключом
java.security.ProviderException: sun.security.pkcs11.wrapper.PKCS11Exception: CKR_FUNCTION_FAILED
    at sun.security.pkcs11.P11KeyStore.engineGetKey(P11KeyStore.java:330)
    at java.security.KeyStore.getKey(Unknown Source)
    at es.programador.transport.e.b.b(Unknown Source)
    at es.programador.transport.e.b.c(Unknown Source)
    at es.programador.transport.o$a.a(Unknown Source)
    at es.programador.a.c.a(Unknown Source)
    at es.programador.transport.i.e.a(Unknown Source)
    at es.programador.transport.i.d.execute(Unknown Source)
    at org.quartz.core.JobRunShell.run(JobRunShell.java:213)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:557)
Caused by: sun.security.pkcs11.wrapper.PKCS11Exception: CKR_FUNCTION_FAILED
    at sun.security.pkcs11.wrapper.PKCS11.C_FindObjects(Native Method)
    at sun.security.pkcs11.wrapper.PKCS11$SynchronizedPKCS11.C_FindObjects(PKCS11.java:1638)
    at sun.security.pkcs11.P11KeyStore.findObjects(P11KeyStore.java:2660)
    at sun.security.pkcs11.P11KeyStore.getTokenObject(P11KeyStore.java:2170)
    at sun.security.pkcs11.P11KeyStore.engineGetKey(P11KeyStore.java:310)
    ... 9 more
2019-07-03 16:38:41,014 WARN  ru.centerinform.crypto.j - Ошибка выхода из ключа
sun.security.pkcs11.wrapper.PKCS11Exception: CKR_USER_NOT_LOGGED_IN
    at sun.security.pkcs11.wrapper.PKCS11.C_Logout(Native Method)
    at sun.security.pkcs11.wrapper.PKCS11$SynchronizedPKCS11.C_Logout(PKCS11.java:1603)
    at ru.centerinform.crypto.j.a(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.doPost(Unknown Source)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
    at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:821)
    at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:583)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
    at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548)
    at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
    at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1158)
    at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
    at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
    at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1090)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
    at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
    at org.eclipse.jetty.server.handler.RequestLogHandler.handle(RequestLogHandler.java:56)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.server.Server.handle(Server.java:517)
    at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:306)
    at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:242)
    at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
    at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
    at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
    at java.lang.Thread.run(Unknown Source)
2019-07-03 16:38:41,021 INFO  ru.centerinform.crypto.c - Вторая попытка подписать документ
2019-07-03 16:38:41,021 INFO  ru.centerinform.crypto.c - Инициализации криптобиблиотеки
2019-07-03 16:38:41,025 ERROR es.programador.transport.e.b - Ошибка переинициализации RSA
java.lang.IllegalStateException: Ошибка поиска слота смарт-карты
    at es.programador.transport.e.b.m(Unknown Source)
    at es.programador.transport.e.b.b(Unknown Source)
    at es.programador.transport.e.b.d(Unknown Source)
    at es.programador.transport.e.b.b(Unknown Source)
    at es.programador.transport.e.b.c(Unknown Source)
    at es.programador.transport.o$a.a(Unknown Source)
    at es.programador.a.c.a(Unknown Source)
    at es.programador.transport.i.e.a(Unknown Source)
    at es.programador.transport.i.d.execute(Unknown Source)
    at org.quartz.core.JobRunShell.run(JobRunShell.java:213)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:557)
Caused by: sun.security.pkcs11.wrapper.PKCS11Exception: CKR_DEVICE_ERROR
    at sun.security.pkcs11.wrapper.PKCS11.C_GetTokenInfo(Native Method)
    at sun.security.pkcs11.wrapper.PKCS11$SynchronizedPKCS11.C_GetTokenInfo(PKCS11.java:1569)
    ... 11 more
2019-07-03 16:38:41,048 ERROR ru.centerinform.crypto.c - Ошибка переинициализации криптографера
java.lang.IllegalStateException: Ошибка поиска слота
    at ru.centerinform.crypto.j.b(Unknown Source)
    at ru.centerinform.crypto.c.k(Unknown Source)
    at ru.centerinform.crypto.c.i(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.doPost(Unknown Source)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
    at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:821)
    at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:583)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
    at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548)
    at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
    at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1158)
    at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
    at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
    at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1090)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
    at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
    at org.eclipse.jetty.server.handler.RequestLogHandler.handle(RequestLogHandler.java:56)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.server.Server.handle(Server.java:517)
    at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:306)
    at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:242)
    at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
    at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
    at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
    at java.lang.Thread.run(Unknown Source)
Caused by: sun.security.pkcs11.wrapper.PKCS11Exception: CKR_DEVICE_ERROR
    at sun.security.pkcs11.wrapper.PKCS11.C_GetTokenInfo(Native Method)
    at sun.security.pkcs11.wrapper.PKCS11$SynchronizedPKCS11.C_GetTokenInfo(PKCS11.java:1569)
    ... 35 more
2019-07-03 16:38:41,053 ERROR es.programador.http.AbstractServlet - Некорректное состояние транспортного терминала
java.lang.IllegalStateException: Не удалось подписать документ
    at ru.centerinform.crypto.c.a(Unknown Source)
    at ru.centerinform.crypto.c.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.a(Unknown Source)
    at es.programador.http.AbstractServlet.doPost(Unknown Source)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
    at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:821)
    at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:583)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
    at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548)
    at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
    at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1158)
    at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
    at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
    at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1090)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
    at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
    at org.eclipse.jetty.server.handler.RequestLogHandler.handle(RequestLogHandler.java:56)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.server.Server.handle(Server.java:517)
    at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:306)
    at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:242)
    at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
    at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
    at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
    at java.lang.Thread.run(Unknown Source)
2019-07-03 16:38:41,059 WARN  es.programador.http.AbstractServlet - Касса разорвала соединение. Информация об ошибке не доставлена.
2019-07-03 16:38:41,126 ERROR es.programador.transport.i.e - Ошибка при получении и чтении документов с сервера ЕГАИС
java.io.IOException: Ошибка при проверке ключа
    at es.programador.a.c.a(Unknown Source)
    at es.programador.transport.i.e.a(Unknown Source)
    at es.programador.transport.i.d.execute(Unknown Source)
    at org.quartz.core.JobRunShell.run(JobRunShell.java:213)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:557)
2019-07-03 16:38:41,171 INFO  es.programador.transport.p - Удаление документов скачанных ранее чем 2019-07-02 16:38:41 в статусах [2]
2019-07-03 16:38:41,172 INFO  es.programador.transport.p - Документы DOC_TYPE: [WayBill, WayBill_v2, WayBill_v3, FormBRegInfo, Form2RegInfo, WayBillAct, WayBillAct_v2, WayBillAct_v3, WayBillTicket, Ticket] удалены не будут.
2019-07-03 16:38:41,179 INFO  es.programador.transport.p - Удаление документов скачанных ранее чем 2019-06-26 16:38:41 в статусах [2]
2019-07-03 16:38:41,181 INFO  es.programador.transport.i.e - Завершение задачи получения документов с сервера ЕГАИС
2019-07-03 16:38:41,182 INFO  es.programador.transport.i.d - Завершение задачи получения документов с сервера ЕГАИС по расписанию
2019-07-03 16:38:41,405 INFO  es.programador.transport.i.d - Завершение задачи обмена документами с сервером ЕГАИС по расписанию
2019-07-03 16:40:12,753 INFO  es.programador.transport.i.d - Начало задачи обмена документами с сервером ЕГАИС по расписанию
2019-07-03 16:40:12,754 INFO  es.programador.transport.i.d - Отправка данных на сервер ЕГАИС по расписанию
2019-07-03 16:40:12,754 INFO  es.programador.transport.o - Отправка данных на сервер ЕГАИС
2019-07-03 16:40:12,772 INFO  es.programador.transport.g - Удаление исходящих документов в статусе: 1
2019-07-03 16:40:12,777 INFO  es.programador.transport.o - Завершение задачи отправки документов на сервер ЕГАИС
2019-07-03 16:40:12,777 INFO  es.programador.transport.i.d - Завершение задачи отправки документов на сервера ЕГАИС по расписанию
2019-07-03 16:40:12,778 INFO  es.programador.transport.i.d - Получение документов с сервера ЕГАИС по расписанию
2019-07-03 16:40:12,778 INFO  es.programador.transport.i.e - Получение документов с сервера ЕГАИС
2019-07-03 16:40:12,786 INFO  es.programador.transport.i.e - Счетчик непогашенных чеков: [0]
2019-07-03 16:40:12,790 INFO  es.programador.transport.i.e - Счетчик непогашенных запросов: [363]
2019-07-03 16:40:13,076 INFO  es.programador.transport.i.e - Счетчик непогашенных АСКП: [0]
2019-07-03 16:40:13,141 ERROR es.programador.transport.e.b - Проблемы с RSA ключом
java.security.ProviderException: Token has been removed
    at sun.security.pkcs11.Session.id(Session.java:91)
    at sun.security.pkcs11.SessionManager.ensureValid(SessionManager.java:161)
    at sun.security.pkcs11.SessionManager.getOpSession(SessionManager.java:144)
    at sun.security.pkcs11.Token.getOpSession(Token.java:303)
    at sun.security.pkcs11.P11KeyStore.engineGetKey(P11KeyStore.java:307)
    at java.security.KeyStore.getKey(Unknown Source)
    at es.programador.transport.e.b.b(Unknown Source)
    at es.programador.transport.e.b.c(Unknown Source)
    at es.programador.transport.o$a.a(Unknown Source)
    at es.programador.a.c.a(Unknown Source)
    at es.programador.transport.i.e.a(Unknown Source)
    at es.programador.transport.i.d.execute(Unknown Source)
    at org.quartz.core.JobRunShell.run(JobRunShell.java:213)
    at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:557)
2019-07-03 16:40:13,184 INFO  es.programador.transport.e.b - Найден слот смарт-карты [0:Rutoken ECP     ]
2019-07-03 16:40:13,917 INFO  es.programador.transport.e.b - Используется сертификат SerialNumber: 3ecacd4e0000000b4e49
2019-07-03 16:40:14,305 INFO  es.programador.transport.i.e - Запрос документов с сервера

8 Ответ от Ксения Шаврова

  • Ксения Шаврова
  • Администратор
  • Неактивен

Re: Регулярно ошибка при подписи чеков

Анна, я правильно понимаю, что это логи УТМ с другого компьютера?
Нет, логи Рутокена не ведутся.

9 Ответ от Анна Суровцева

  • Анна Суровцева
  • Посетитель
  • Неактивен

Re: Регулярно ошибка при подписи чеков

да. логи УТМ

10 Ответ от Ксения Шаврова

  • Ксения Шаврова
  • Администратор
  • Неактивен

Re: Регулярно ошибка при подписи чеков

Предлагаю так же организовать удаленное подключение. Посмотрю что с Рутокеном.

11 Ответ от Анна Суровцева

  • Анна Суровцева
  • Посетитель
  • Неактивен

Re: Регулярно ошибка при подписи чеков

давайте в понедельник. в нашем регионе "день тишины" - алкоголь не продаётся. до понедельника ещё посмотрю за работой егаис

12 Ответ от Ксения Шаврова

  • Ксения Шаврова
  • Администратор
  • Неактивен

Re: Регулярно ошибка при подписи чеков

Договорились. В понедельник с 10 до 18 по МСК готовы организовать удаленное подключение.