Alfresco empêche l'authentification après le redémarrage du serveur

[s_tanjaoui]

Bonjour,

J'ai redémarré le serveur contenant ALFRESCO,

par la suite, aucun utilisateur ne peut accéder à la GED.

Il affiche "Vos informations d'authentification n'ont pas été reconnues ou ALFRESCO n'est peut être pas disponible actuellement"

Je copie ci dessous des extraits des fichiers logs :

le fichier localhost_access_log (des lignes de ce type qui se répétent):

127.0.0.1 - - [29/Nov/2016:00:00:00 +0000] "GET /alfresco/service/api/solr/aclchangesets?fromId=0&toId=2000&maxResults=1 HTTP/1.1" 404 -
127.0.0.1 - - [29/Nov/2016:00:00:00 +0000] "POST /alfresco/service/api/solr/modelsdiff HTTP/1.1" 404 -
127.0.0.1 - - [29/Nov/2016:00:00:00 +0000] "GET /alfresco/service/api/solr/aclchangesets?fromId=0&toId=2000&maxResults=1 HTTP/1.1" 404 -
127.0.0.1 - - [29/Nov/2016:00:00:15 +0000] "GET /alfresco/service/api/solr/aclchangesets?fromId=0&toId=2000&maxResults=1 HTTP/1.1" 404 -
127.0.0.1 - - [29/Nov/2016:00:00:15 +0000] "GET /alfresco/service/api/solr/aclchangesets?fromId=0&toId=2000&maxResults=1 HTTP/1.1" 404 -
127.0.0.1 - - [29/Nov/2016:00:00:15 +0000] "POST /alfresco/service/api/solr/modelsdiff HTTP/1.1" 404 -
127.0.0.1 - - [29/Nov/2016:00:00:30 +0000] "GET /alfresco/service/api/solr/aclchangesets?fromId=0&toId=2000&maxResults=1 HTTP/1.1" 404 -
127.0.0.1 - - [29/Nov/2016:00:00:30 +0000] "GET /alfresco/service/api/solr/aclchangesets?fromId=0&toId=2000&maxResults=1 HTTP/1.1" 404 -
127.0.0.1 - - [29/Nov/2016:00:00:30 +0000] "POST /alfresco/service/api/solr/modelsdiff HTTP/1.1" 404 -
127.0.0.1 - - [29/Nov/2016:00:00:45 +0000] "GET /alfresco/service/api/solr/aclchangesets?fromId=0&toId=2000&maxResults=1 HTTP/1.1" 404 -
127.0.0.1 - - [29/Nov/2016:00:00:45 +0000] "GET /alfresco/service/api/solr/aclchangesets?fromId=0&toId=2000&maxResults=1 HTTP/1.1" 404 -
127.0.0.1 - - [29/Nov/2016:00:00:45 +0000] "POST /alfresco/service/api/solr/modelsdiff HTTP/1.1" 404 -
127.0.0.1 - - [29/Nov/2016:00:01:00 +0000] "GET /alfresco/service/api/solr/aclchangesets?fromId=0&toId=2000&maxResults=1 HTTP/1.1" 404 -
127.0.0.1 - - [29/Nov/2016:00:01:00 +0000] "POST /alfresco/service/api/solr/modelsdiff HTTP/1.1" 404 -
127.0.0.1 - - [29/Nov/2016:00:01:00 +0000] "GET /alfresco/service/api/solr/aclchangesets?fromId=0&toId=2000&maxResults=1 HTTP/1.1" 404 -
127.0.0.1 - - [29/Nov/2016:00:01:15 +0000] "GET /alfresco/service/api/solr/aclchangesets?fromId=0&toId=2000&maxResults=1 HTTP/1.1" 404 -
127.0.0.1 - - [29/Nov/2016:00:01:15 +0000] "GET /alfresco/service/api/solr/aclchangesets?fromId=0&toId=2

un extrait du fichier :alfrescotomcat-stderr

INFOS: Stopping ProtocolHandler ["http-bio-8444"]
pp.ContextLoaderListener
org.alfresco.error.AlfrescoRuntimeException: 10290012 Unable to start the VtiServer, as the port 7070 is already in use
    at org.alfresco.module.vti.VtiServer.onBootstrap(VtiServer.java:223)
    at org.springframework.extensions.surf.util.AbstractLifecycleBean.onApplicationEvent(AbstractLifecycleBean.java:56)
    at org.alfresco.repo.management.SafeApplicationEventMulticaster.multicastEventInternal(SafeApplicationEventMulticaster.java:209)
    at org.alfresco.repo.management.SafeApplicationEventMulticaster.multicastEvent(SafeApplicationEventMulticaster.java:180)
    at org.springframework.context.support.AbstractApplicationContext.publishEvent(AbstractApplicationContext.java:334)
    at org.springframework.context.support.AbstractApplicationContext.finishRefresh(AbstractApplicationContext.java:948)
    at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:482)
    at org.springframework.web.context.ContextLoader.configureAndRefreshWebApplicationContext(ContextLoader.java:410)
    at org.springframework.web.context.ContextLoader.initWebApplicationContext(ContextLoader.java:306)
    at org.springframework.web.context.ContextLoaderListener.contextInitialized(ContextLoaderListener.java:112)
    at org.alfresco.web.app.ContextLoaderListener.contextInitialized(ContextLoaderListener.java:63)
    at org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:5016)
    at org.apache.catalina.core.StandardContext.startInternal(StandardContext.java:5524)
    at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:150)
    at org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:901)
    at org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:877)
    at org.apache.catalina.core.StandardHost.addChild(StandardHost.java:649)
    at org.apache.catalina.startup.HostConfig.deployWAR(HostConfig.java:1081)
    at org.apache.catalina.startup.HostConfig$DeployWar.run(HostConfig.java:1877)
    at java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source)
    at java.util.concurrent.FutureTask.run(Unknown Source)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
    at java.lang.Thread.run(Unknown Source)
Caused by: java.net.BindException: Address already in use: JVM_Bind
    at java.net.DualStackPlainSocketImpl.bind0(Native Method)
    at java.net.DualStackPlainSocketImpl.socketBind(Unknown Source)
    at java.net.AbstractPlainSocketImpl.bind(Unknown Source)
    at java.net.PlainSocketImpl.bind(Unknown Source)
    at java.net.ServerSocket.bind(Unknown Source)
    at java.net.ServerSocket.<init>(Unknown Source)
    at java.net.ServerSocket.<init>(Unknown Source)
    at org.mortbay.jetty.bio.SocketConnector.newServerSocket(SocketConnector.java:80)
    at org.mortbay.jetty.bio.SocketConnector.open(SocketConnector.java:73)
    at org.mortbay.jetty.AbstractConnector.doStart(AbstractConnector.java:283)
    at org.mortbay.jetty.bio.SocketConnector.doStart(SocketConnector.java:147)
    at org.mortbay.component.AbstractLifeCycle.start(AbstractLifeCycle.java:50)
    at org.mortbay.jetty.Server.doStart(Server.java:235)
    at org.mortbay.component.AbstractLifeCycle.start(AbstractLifeCycle.java:50)
    at org.alfresco.module.vti.VtiServer.onBootstrap(VtiServer.java:214)
    ... 23 more

nov. 29, 2016 11:28:27 AM org.apache.catalina.core.StandardContext listenerStart
GRAVE: Exception lors de l'envoi de l'évènement contexte initialisé (context initialized) à l'instance de classe d'écoute (listener) org.alfresco.web.app.ContextListener
org.alfresco.error.AlfrescoRuntimeException: 10290012 Unable to start the VtiServer, as the port 7070 is already in use
    at org.alfresco.module.vti.VtiServer.onBootstrap(VtiServer.java:223)
    at org.springframework.extensions.surf.util.AbstractLifecycleBean.onApplicationEvent(AbstractLifecycleBean.java:56)
    at org.alfresco.repo.management.SafeApplicationEventMulticaster.multicastEventInternal(SafeApplicationEventMulticaster.java:209)
    at org.alfresco.repo.management.SafeApplicationEventMulticaster.multicastEvent(SafeApplicationEventMulticaster.java:180)
    at org.springframework.context.support.AbstractApplicationContext.publishEvent(AbstractApplicationContext.java:334)
    at org.springframework.context.support.AbstractApplicationContext.finishRefresh(AbstractApplicationContext.java:948)
    at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:482)
    at org.springframework.web.context.ContextLoader.configureAndRefreshWebApplicationContext(ContextLoader.java:410)
    at org.springframework.web.context.ContextLoader.initWebApplicationContext(ContextLoader.java:306)
    at org.springframework.web.context.ContextLoaderListener.contextInitialized(ContextLoaderListener.java:112)
    at org.alfresco.web.app.ContextLoaderListener.contextInitialized(ContextLoaderListener.java:63)
    at org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:5016)
    at org.apache.catalina.core.StandardContext.startInternal(StandardContext.java:5524)
    at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:150)
    at org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:901)
    at org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:877)
    at org.apache.catalina.core.StandardHost.addChild(StandardHost.java:649)
    at org.apache.catalina.startup.HostConfig.deployWAR(HostConfig.java:1081)
    at org.apache.catalina.startup.HostConfig$DeployWar.run(HostConfig.java:1877)
    at java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source)
    at java.util.concurrent.FutureTask.run(Unknown Source)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)

[ycoulon]

Bonjour,

Les traces contenu dans votre fichier stderr indique que Alfresco n'a pas pu démarrer correctement.
L'erreur concerne le port 7070 utilise par vti (édition en ligne) qui est déjà utilisé.
Alfresco n'a peut être pas été éteint correctement ou une autre application utilise ce port.
Avez vous une autre application tournant sur le même serveur susceptible d'écouter sur ce port ?

Sur quel système d'exploitation êtes vous ? Windows ? linux ?
Dans le cas de linux la commande netstat vous permettra d'obtenir le PID occupants le port 7070:
netstat -plnt | grep 7070

Yann

[s_tanjaoui]

C'est ce que j'ai compris moi aussi,

J'ai déjà essayé d' exécuter la commande Netstat,

aucun processus n'utilise le port 7070 ..

Je suis sur Windows Sever 2008

[ycoulon]

Quels sont les services hébergé par le serveur ?
Votre problème concerne plus l'administration du système qu'Alfresco lui même. Sans plus d'informations sur le système nous ne pourrons pas vous venir en aide.

Ce que vous pouvez essayé:
Éteignez Alfresco via le manager (ou les services si vous les avez installé)
Assurez vous de n'avoir plus aucun processus "java" s'exécutant. Il est à noté que tomcat à tendance à se bloquer dans ce genre de cas et à continuer de s'exécuter en partie.
Purger les logs tomcat, pour y voir clair.
Relancer Alfresc à l'aide du manager ou des services.

Si cela ne suffit pas vous pouvez tenter de redémarrer votre serveur et de relancer Alfresco.

Yann

[s_tanjaoui]

J'ai arrêté les services ALFRESCO et je les ai démarré encore une fois mais toujours le même message.

Il n'y a aucun processus Java exécuté ..

Le serveur contient uniquement le logiciel SAGE et ALFRESCO ..

Je redémarre le serveur maintenant et je vous réponds .

Merci beaucoup de l'intérêt porté à ma question *

[s_tanjaoui]

J'ai redémarré le serveur,

l'erreur persiste

"Vos informations d'authentification n'ont pas été reconnues ou Alfresco n'est peut-être pas disponible actuellement."

[s_tanjaoui]

J'ai remarqué une chose dans les fichiers localhost_access_log, je ne sais pas si cela s'avère utile ou pas mais je vais vous la dire quand même

Les lignes du fichier commencent par :

127.0.0.1 - - [30/Nov/2016:00:00:00 +0000]

Alors que dans les anciens fichiers localhost_access_log, les lignes commencent par :

127.0.0.1 - CN=Alfresco Repository Client, OU=Unknown, O=Alfresco Software Ltd., L=Maidenhead, ST=UK, C=GB [26/Oct/2016:00:00:00 +0100]

Je ne vois plus la chaine "CN=Alfresco Repository Client, OU=Unknown, O=Alfresco Software Ltd., L=Maidenhead, ST=UK, C=GB"

[ycoulon]

Bonjour

Pourriez-vous fournir l'ensemble du fichier catalina.out ?

Les fichiers acces log ne sont pas très utile pour identifier la cause de l'indisponibilité d'Alfresco.

Quels sont les ports suceptible d'être utilisé par l'application SAGE ? Avez vous tenté de lancer Alfresco en ayant éteint cette application ?

Yann

[s_tanjaoui]

Bonjour,

Je n'ai trouvé aucun fichier catalina.out dans mon arborescence ..

SAGE utilise le port 13531 et 13540 ..

Merci de votre interaction

[s_tanjaoui]

Peut-on éviter ce problème en modifiant le port utilisé par "vti" ? Si oui, comment ?