Erreur au lancement devpack depuis Eclipse

Paul Morel · le 25/10/16 à 14:12

Bonjour j'ai installer un devpack il y a quelques jours et jusqu'ici tout fonctionnait très bien. J'ai redémarré mon ordinateur ce matin car il commencé à chauffer et là, je tente de relancer jcms (9 sp3) depuis eclipse mais j'ai une erreur et je n'atteins pas le site : Erreur 500.

Voici l'erreur :

oct. 25, 2016 2:06:33 PM org.apache.catalina.core.StandardContext loadOnStartup
GRAVE: La servlet /jcms a généré une exception "load()"
javax.servlet.ServletException: An exception occured while initializing JCMS. The site is not available.
at com.jalios.jcms.ChannelInitServlet.init(ChannelInitServlet.java:187)
at com.jalios.jcms.ChannelInitServlet.init(ChannelInitServlet.java:81)
at org.apache.catalina.core.StandardWrapper.initServlet(StandardWrapper.java:1284)
at org.apache.catalina.core.StandardWrapper.loadServlet(StandardWrapper.java:1197)
at org.apache.catalina.core.StandardWrapper.load(StandardWrapper.java:1087)
at org.apache.catalina.core.StandardContext.loadOnStartup(StandardContext.java:5231)
at org.apache.catalina.core.StandardContext.startInternal(StandardContext.java:5518)
at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:150)
at org.apache.catalina.core.ContainerBase$StartChild.call(ContainerBase.java:1575)
at org.apache.catalina.core.ContainerBase$StartChild.call(ContainerBase.java:1565)
at java.util.concurrent.FutureTask.run(FutureTask.java:262)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
oct. 25, 2016 2:06:33 PM org.apache.catalina.startup.HostConfig deployDirectory
INFOS: Déploiement du répertoire C:\Users\pmorel\Desktop\DevPack-JCMS-9.0.3\tomcat\bin de l'application web
oct. 25, 2016 2:06:33 PM org.apache.catalina.startup.HostConfig deployDirectory
INFOS: Deployment of web application directory C:\Users\pmorel\Desktop\DevPack-JCMS-9.0.3\tomcat\bin has finished in 32 ms
oct. 25, 2016 2:06:33 PM org.apache.catalina.startup.HostConfig deployDirectory
INFOS: Déploiement du répertoire C:\Users\pmorel\Desktop\DevPack-JCMS-9.0.3\tomcat\conf de l'application web
oct. 25, 2016 2:06:34 PM org.apache.catalina.startup.HostConfig deployDirectory
INFOS: Deployment of web application directory C:\Users\pmorel\Desktop\DevPack-JCMS-9.0.3\tomcat\conf has finished in 31 ms
oct. 25, 2016 2:06:34 PM org.apache.catalina.startup.HostConfig deployDirectory
INFOS: Déploiement du répertoire C:\Users\pmorel\Desktop\DevPack-JCMS-9.0.3\tomcat\lib de l'application web
oct. 25, 2016 2:06:34 PM org.apache.catalina.startup.HostConfig deployDirectory
INFOS: Deployment of web application directory C:\Users\pmorel\Desktop\DevPack-JCMS-9.0.3\tomcat\lib has finished in 31 ms
oct. 25, 2016 2:06:34 PM org.apache.catalina.startup.HostConfig deployDirectory
INFOS: Déploiement du répertoire C:\Users\pmorel\Desktop\DevPack-JCMS-9.0.3\tomcat\logs de l'application web
oct. 25, 2016 2:06:34 PM org.apache.catalina.startup.HostConfig deployDirectory
INFOS: Deployment of web application directory C:\Users\pmorel\Desktop\DevPack-JCMS-9.0.3\tomcat\logs has finished in 32 ms
oct. 25, 2016 2:06:34 PM org.apache.catalina.startup.HostConfig deployDirectory
INFOS: Déploiement du répertoire C:\Users\pmorel\Desktop\DevPack-JCMS-9.0.3\tomcat\temp de l'application web
oct. 25, 2016 2:06:34 PM org.apache.catalina.startup.HostConfig deployDirectory
INFOS: Deployment of web application directory C:\Users\pmorel\Desktop\DevPack-JCMS-9.0.3\tomcat\temp has finished in 15 ms
oct. 25, 2016 2:06:34 PM org.apache.catalina.startup.HostConfig deployDirectory
INFOS: Déploiement du répertoire C:\Users\pmorel\Desktop\DevPack-JCMS-9.0.3\tomcat\webapps de l'application web
oct. 25, 2016 2:06:34 PM org.apache.catalina.startup.HostConfig deployDirectory
INFOS: Deployment of web application directory C:\Users\pmorel\Desktop\DevPack-JCMS-9.0.3\tomcat\webapps has finished in 31 ms
oct. 25, 2016 2:06:34 PM org.apache.catalina.startup.HostConfig deployDirectory
INFOS: Déploiement du répertoire C:\Users\pmorel\Desktop\DevPack-JCMS-9.0.3\tomcat\work de l'application web
oct. 25, 2016 2:06:34 PM org.apache.catalina.startup.HostConfig deployDirectory
INFOS: Deployment of web application directory C:\Users\pmorel\Desktop\DevPack-JCMS-9.0.3\tomcat\work has finished in 16 ms
oct. 25, 2016 2:06:34 PM org.apache.coyote.AbstractProtocol start
INFOS: Starting ProtocolHandler ["http-bio-8080"]
oct. 25, 2016 2:06:34 PM org.apache.coyote.AbstractProtocol start
INFOS: Starting ProtocolHandler ["ajp-bio-8009"]
oct. 25, 2016 2:06:34 PM org.apache.catalina.startup.Catalina start
INFOS: Server startup in 7642 ms

Est-ce quelqu'un pourrait m'aider ? Je ne comprends pas d'où peut venir le problème.

Merci d'avance,

Paul

12 pts
Paul Morel - le 02/11/16 à 09:15
Meilleure réponse

Voici les logs du dernier plantage log-demarrage-eclipse

#1

l'erreur "Bad type on operand stack" est généralement liée à un problème de compilation entre différentes versions de Java. Il faudrait comprendre ce qu'il se passe sur votre machine, peut être que votre eclipse se met à utiliser un JDK 8 installé sur votre PC pour recompiler les classes ? la configuration attendue est JDK 7 en mode compatibilité Java 6.

Ronan Kerdudou · le 07/11/16 à 10:09
#2

Bonjour, j'ai finalement trouvé d'où provenait le plantage. Je n'avais pas correctement rafraîchis le projet au bon moment, du coup il manquait des jars. Une fois ces derniers ajoutés, tout repart correctement. Merci de votre disponibilité. Le sujet est dorénavant clos.

Paul Morel · le 07/11/16 à 10:11
8 pts
Ronan Kerdudou · le 26/10/16 à 15:03

Pour vous aider il faudrait les logs complet, pour voir ce qui a provoqué l'erreur de démarrage de la plateforme

#2

J'avais fais une réinstallation complète de mon devpack et le problème vient à nouveau de se produire.

Paul Morel · le 26/10/16 à 16:09
#3

Dans tomcat/logs je n'ai que des fichiers datant du 27/03/2015...

Paul Morel · le 26/10/16 à 16:11
#4

Dans mon eclipse les logs s'affichent dans la fenêtre Console (et ne sont pas transférés dans le répertoire logs de tomcat). Vous pouvez aussi retrouver les logs de JCMS dans le répertoire WEB-INF/data/logs de la webapp.

Ronan Kerdudou · le 26/10/16 à 18:24
0 pt
Paul Morel · le 27/10/16 à 09:09

log-demarrage-eclipse

jcms

Bonjour,

 

Voici en PJ les logs d'Eclipse ainsi que ceux de JCMS.

#1

Donc j'y vois 3 erreurs, la première est souvent la plus importante, en la traitant on résous généralement le problème. Ici elle indique :

WARN [localhost-startStop-1] [JCMS 9] [jcmsplugin.ESNPlugin]  - Exception while creating plugin component com.jalios.jcmsplugin.esn.ESNQueryFilter : Bad type on operand stack
Exception Details:
  Location:
    com/jalios/jcmsplugin/esn/ESNQueryFilter.filterResultSet(Lcom/jalios/jcms/handler/QueryHandler;Lcom/jalios/jcms/QueryResultSet;Ljava/util/Map;)Lcom/jalios/jcms/QueryResultSet; @103: invokevirtual
  Reason:
    Type 'generated/MemberProfile' (current frame, stack[1]) is not assignable to 'com/jalios/jcms/Publication'
  Current Frame:
    bci: @103
    flags: { }
    locals: { 'com/jalios/jcmsplugin/esn/ESNQueryFilter', 'com/jalios/jcms/handler/QueryHandler', 'com/jalios/jcms/QueryResultSet', 'java/util/Map', 'com/jalios/jcmsplugin/esn/ESNManager', 'com/jalios/jcms/QueryResultSet', 'java/util/Iterator', 'com/jalios/jcms/Publication', 'generated/MemberProfile' }
    stack: { 'com/jalios/jcms/QueryResultSet', 'generated/MemberProfile', float }
  Bytecode:
    0000000: 2bb8 0002 9a00 052c b0b8 0003 3a04 bb00
    0000010: 0459 b700 053a 052c b600 063a 0619 06b9
    0000020: 0007 0100 9900 5119 06b9 0008 0100 c000
    0000030: 093a 0719 07c1 000a 9a00 06a7 ffe2 1907
    0000040: c100 0b99 0006 a7ff d719 0419 07b6 000c
    0000050: b600 0d3a 0819 08c7 0006 a7ff c319 0519
    0000060: 082c 1907 b600 0eb6 000f 5719 06b9 0010
    0000070: 0100 a7ff ab2c 1905 b600 1157 2cb0     
  Stackmap Table:
    same_frame(@9)
    append_frame(@29,Object[#27],Object[#28],Object[#29])
    append_frame(@62,Object[#30])
    same_frame(@73)
    append_frame(@93,Object[#31])
    chop_frame(@117,3)

java.lang.VerifyError: Bad type on operand stack
	at java.lang.Class.forName0(Native Method)
	at java.lang.Class.forName(Class.java:274)
	at com.jalios.jcms.Channel.getClassInternal(Channel.java:6200)
	at com.jalios.jcms.Channel.getClass(Channel.java:6162)
	at com.jalios.jcms.plugin.Plugin.resolveClass(Plugin.java:2473)
	at com.jalios.jcms.plugin.Plugin.createPluginComponent(Plugin.java:1342)
	at com.jalios.jcms.plugin.Plugin.getPluginComponents(Plugin.java:1323)
	at com.jalios.jcms.plugin.Plugin.getPluginComponents(Plugin.java:1279)
	at com.jalios.jcms.plugin.Plugin.registerQueryFilter(Plugin.java:1207)
	at com.jalios.jcms.plugin.PluginManager.registerQueryFilter(PluginManager.java:1369)
	at com.jalios.jcms.plugin.PluginManager.registerQueryFilter(PluginManager.java:1350)
	at com.jalios.jcms.Channel.initBeforeLoad(Channel.java:1301)
	at com.jalios.jcms.ChannelInitServlet.init(ChannelInitServlet.java:121)
	at com.jalios.jcms.ChannelInitServlet.init(ChannelInitServlet.java:81)
	at org.apache.catalina.core.StandardWrapper.initServlet(StandardWrapper.java:1284)
	at org.apache.catalina.core.StandardWrapper.loadServlet(StandardWrapper.java:1197)
	at org.apache.catalina.core.StandardWrapper.load(StandardWrapper.java:1087)
	at org.apache.catalina.core.StandardContext.loadOnStartup(StandardContext.java:5231)
	at org.apache.catalina.core.StandardContext.startInternal(StandardContext.java:5518)
	at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:150)
	at org.apache.catalina.core.ContainerBase$StartChild.call(ContainerBase.java:1575)
	at org.apache.catalina.core.ContainerBase$StartChild.call(ContainerBase.java:1565)
	at java.util.concurrent.FutureTask.run(FutureTask.java:262)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
	at java.lang.Thread.run(Thread.java:745)

les autres erreurs sont probablement juste des conséquences.

Pouvez vous identifier ce que vous avez effectué avant que ce problème survienne ? Mise à jour du "coeur", ajout/màj/suppression de modules, modification d'autres composants (jdk, tomcat) ?

La cause technique du plantage ici est Type 'generated/MemberProfile' is not assignable to 'com/jalios/jcms/Publication' provoqué lors du chargement du module ESN, dans le ESNQueryFilter.

L'idée qui me viens en tête serait que la version du module ESN utilisé ne soit pas en accord avec la version du coeur. Mais c'est peut-être autre chose.

Ronan Kerdudou · le 27/10/16 à 15:37
#2

A priori non, pas de maj/supp/ajout de module ni sur le coeur. Je n'ai pas non plus touché à tomcat ou au jdk... Par contre, comme je vous le disais dans ma dernière réponse, je me suis aperçu que le module explorer installé est en version 3.1.1 et mon coeur est en SP3. Est-ce que ça peut être lié ?

Paul Morel · le 27/10/16 à 15:42
0 pt
Paul Morel · le 27/10/16 à 14:53

Je me suis rendu compte que mon module Explorer n'est pas à jour, j'ai installé la version 3.1.1, est-ce que cela peut être lié ?

#1

Difficile de le dire.

Pour résoudre le problème je pense que vous pouvez essayer la procédure suivante :

  1. s'assurer que l'application est bien une 9 SP3
  2. vérifier que tous les modules sont dans la dernière version compatible avec la 9 SP3
  3. nettoyer les répertoires 'work' et 'temp' de tomcat (si le serveur est configuré sous eclipse : clic droit "clean tomcat work directory..." et "clean...")
  4. vérifier la configuration d'éclipse "General > Workspace" : "build automatically", "refresh using native hooks or polling" et "refresh on access" qui doivent être cochés.
  5. nettoyer le répertoire "generated" de la webapp ( WEB-INF/classes/generated )
  6. démarrer tomcat, il va alors reconstruire les classes "generated", et potentiellement remonter des erreurs "normales" (genre "class not found" car elles sont justement en train d'être générées)
  7. redémarrer tomcat.
Ronan Kerdudou · le 27/10/16 à 16:08
#2

Ok merci pour votre aide, je vais essayer mais du coup votre point 2. n'est pas vérifié chez moi, vu qu'Explorer n'est pas compatible avec SP3 à priori.

Paul Morel · le 27/10/16 à 16:13
0 pt
Paul Morel · le 28/10/16 à 16:48

Bonjour je viens à nouveau de reproduire le bug. La dernière opération que j'ai faite est que j'ai voulu ajouter un évènement à planifier. Je reçois alors une alerte du type "Localhost:80 : La connexion au serveur a échoué ou une erreur est survenue..." Après cela, je tente de redémarrer le serveur et l'application ne se lance plus. Voilà les logs au redemarrage du serveur en PJ.

La version du module Calendrier utilisée est 4.3 et ma webapp est en V9 SP3. Est-ce qu'il y a des problèmes de compatibilité ?

Merci par avance

 

#1

J'avais déjà tenté cette opération un peu avant le dernier bug que j'ai eu hier.

Paul Morel · le 28/10/16 à 16:48
0 pt