ERROR: Cache failed - dlibra 5.8.4

Question

Witam,

od jakiegoś czasu w wrapper.log pojawia się komunikat:

 SimpleFileCache
INFO   | jvm 1    | 2019/05/17 23:52:58 | ERROR: Cache failed. Trying to send file directly.
INFO   | jvm 1    | 2019/05/17 23:52:58 | java.rmi.RemoteException: Error while preparing image; nested exception is:
INFO   | jvm 1    | 2019/05/17 23:52:58 |     null
INFO   | jvm 1    | 2019/05/17 23:52:58 | ElementId='88034'
INFO   | jvm 1    | 2019/05/17 23:52:58 | Service: null
INFO   | jvm 1    | 2019/05/17 23:52:58 |     at pl.psnc.dlibra.content.server.JPGToJPGSource.getFile(JPGToJPGSource.java:112)
INFO   | jvm 1    | 2019/05/17 23:52:58 |     at pl.psnc.dlibra.content.server.JPGSource.getFile(JPGSource.java:55)
INFO   | jvm 1    | 2019/05/17 23:52:58 |     at pl.psnc.dlibra.content.server.JPGSource.getFile(JPGSource.java:21)
INFO   | jvm 1    | 2019/05/17 23:52:58 |     at pl.psnc.util.filecache.SimpleFileCache.cacheFile(SimpleFileCache.java:94)
INFO   | jvm 1    | 2019/05/17 23:52:58 |     at pl.psnc.util.filecache.FileCacheWithConcurrentAccess.cacheAndWrite(FileCacheWithConcurrentAccess.java:69)
INFO   | jvm 1    | 2019/05/17 23:52:58 |     at pl.psnc.util.filecache.SimpleFileCache.writeFileToStream(SimpleFileCache.java:389)
INFO   | jvm 1    | 2019/05/17 23:52:58 |     at pl.psnc.dlibra.content.server.ContentServerImpl.writeConvertedSlicedJPG(ContentServerImpl.java:3305)
INFO   | jvm 1    | 2019/05/17 23:52:58 |     at pl.psnc.dlibra.content.server.ContentServerImpl.doGetContent(ContentServerImpl.java:3296)
INFO   | jvm 1    | 2019/05/17 23:52:58 |     at pl.psnc.dlibra.content.server.ContentServerImpl.getContent(ContentServerImpl.java:3269)
INFO   | jvm 1    | 2019/05/17 23:52:58 |     at sun.reflect.GeneratedMethodAccessor94.invoke(Unknown Source)
INFO   | jvm 1    | 2019/05/17 23:52:58 |     at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
INFO   | jvm 1    | 2019/05/17 23:52:58 |     at java.lang.reflect.Method.invoke(Method.java:606)
INFO   | jvm 1    | 2019/05/17 23:52:58 |     at sun.rmi.server.UnicastServerRef.dispatch(UnicastServerRef.java:322)
INFO   | jvm 1    | 2019/05/17 23:52:58 |     at sun.rmi.transport.Transport$2.run(Transport.java:202)
INFO   | jvm 1    | 2019/05/17 23:52:58 |     at sun.rmi.transport.Transport$2.run(Transport.java:199)
INFO   | jvm 1    | 2019/05/17 23:52:58 |     at java.security.AccessController.doPrivileged(Native Method)
INFO   | jvm 1    | 2019/05/17 23:52:58 |     at sun.rmi.transport.Transport.serviceCall(Transport.java:198)
INFO   | jvm 1    | 2019/05/17 23:52:58 |     at sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:567)
INFO   | jvm 1    | 2019/05/17 23:52:58 |     at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run0(TCPTransport.java:828)
INFO   | jvm 1    | 2019/05/17 23:52:58 |     at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.access$400(TCPTransport.java:619)
INFO   | jvm 1    | 2019/05/17 23:52:58 |     at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler$1.run(TCPTransport.java:684)
INFO   | jvm 1    | 2019/05/17 23:52:58 |     at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler$1.run(TCPTransport.java:681)
INFO   | jvm 1    | 2019/05/17 23:52:58 |     at java.security.AccessController.doPrivileged(Native Method)
INFO   | jvm 1    | 2019/05/17 23:52:58 |     at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:681)
INFO   | jvm 1    | 2019/05/17 23:52:58 |     at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
INFO   | jvm 1    | 2019/05/17 23:52:58 |     at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
INFO   | jvm 1    | 2019/05/17 23:52:58 |     at java.lang.Thread.run(Thread.java:745)
INFO   | jvm 1    | 2019/05/17 23:52:58 | Caused by: null

 

Po czym dlibra zaczyna działać niestabilnie. W czym może być problem i jak go rozwiązać?

Z góry dziekuję.

Pozdrawiam

Answer 1

Dzień dobry.

Proszę wykonać aktualizację systemu dLibra do najnowszej wersji 5. Poniżej zamieszczam link do informacji o wydaniu, gdzie jednym z usprawnień była ulepszona obsługa przepełniania katalogów cache.

https://docs.psnc.pl/display/DLI/Nota+Do+Wydania+-+dLibra+-+Wersja+5.8.5

Pozdrawiam

Comments

Dziękuje serdecznie za odpowiedź.
Chciałbym nadmienić, że wersja 5.8.4 działa przez ponad rok bez problemów.
Zanim spróbuje przeprowadzić aktualizację do nowszej wersji chciałbym zapytać o pewne błędy.
Mianowicie co pewien czas dlibra serwer musi być uruchamiany, w logu widać taki zapis
INFO   | jvm 3    | 2019/06/15 01:00:03 | INFO: Collect attribute values finished in 2 ms. Language: 4. AttributeIds: 1,3,4,5,7,10,20,21,30,31,34,37,38,39,53,56,57,60,6,8,9,11,12,13,14,15,55,58,59,2,22,23,24,25,26,27,28,29,32,33,35,36,40,41,42,43,44,45,46,47,48,49,50,51,52,54,16,17,18,19, ElementsClass: pl.psnc.dlibra.metadata.EditionId
ERROR  | wrapper  | 2019/06/15 01:02:40 | JVM appears hung: Timed out waiting for signal from JVM.
ERROR  | wrapper  | 2019/06/15 01:02:40 | JVM did not exit on request, terminated
STATUS | wrapper  | 2019/06/15 01:02:41 | JVM exited in response to signal SIGKILL (9).
ERROR  | wrapper  | 2019/06/15 01:02:41 | Unable to start a JVM
STATUS | wrapper  | 2019/06/15 01:02:41 | <-- Wrapper Stopped

Dodatkowo nieraz pojawiają się błędy w logu:
INFO   | jvm 1    | 2019/06/12 08:00:00 | 2019.06.17 08:00:00 [System services dLibra Service Jobs Scheduler_Worker-0] AbstractServiceResolver
INFO   | jvm 1    | 2019/06/12 08:00:00 | ERROR: ps
INFO   | jvm 1    | 2019/06/12 08:00:00 | java.rmi.NotBoundException: ps
INFO   | jvm 1    | 2019/06/12 08:00:00 |     at sun.rmi.registry.RegistryImpl.lookup(RegistryImpl.java:136)
INFO   | jvm 1    | 2019/06/12 08:00:00 |     at sun.rmi.registry.RegistryImpl_Skel.dispatch(Unknown Source)
INFO   | jvm 1    | 2019/06/12 08:00:00 |     at sun.rmi.server.UnicastServerRef.oldDispatch(UnicastServerRef.java:409)
INFO   | jvm 1    | 2019/06/12 08:00:00 |     at sun.rmi.server.UnicastServerRef.dispatch(UnicastServerRef.java:267)
INFO   | jvm 1    | 2019/06/12 08:00:00 |     at sun.rmi.transport.Transport$2.run(Transport.java:202)
INFO   | jvm 1    | 2019/06/12 08:00:00 |     at sun.rmi.transport.Transport$2.run(Transport.java:199)
INFO   | jvm 1    | 2019/06/12 08:00:00 |     at java.security.AccessController.doPrivileged(Native Method)
INFO   | jvm 1    | 2019/06/12 08:00:00 |     at sun.rmi.transport.Transport.serviceCall(Transport.java:198)

W czym może być problem? Z góry dziękuje za odpowiedź.