Problemas al extraer auditoría alfresco

[rublape]

Buenas tardes,

Tengo un problema al sacar los datos de auditoria de mi servidor Alfresco Community. Tengo la auditoría activada y por tanto se están recogiendo datos de los accesos y archivos eliminados, pero desde hace unos meses no puedo sacar los datos de la auditoría. Al principio si que podía hacer las peticiones via API o curl y me aparecían correctamente. El problema que tengo, es que actualmente da un error de timeout ya que tarda mucho en recoger los datos. Si subo el tiempo de timeout Alfresco se bloquea y tengo que reiniciar los procesos (sobretodo el de java).

Para comprobar el estado de la auditoría he realizado las mismas peticiones pero limitando a 1 los resultados que quiero que me aparezcan y me saca los resultados correctamente:

curl -u admin:admin "http://127.0.0.1:8080/alfresco/service/api/audit/query/alfresco-access/alfresco-access/transaction/a..."
{
"count":1,
"entries":
[
{
"id":2122,
"application":"alfresco-access",
"user":"user1",
"time":"2017-04-30T17:15:32.687+02:00",
"values":
{
"\/alfresco-access\/transaction\/sub-actions":"readContent"
,"\/alfresco-access\/transaction\/action":"READ"
,"\/alfresco-access\/transaction\/type":"cm:content"
,"\/alfresco-access\/transaction\/path":"\/app:company_home\/st:sites\/cm:1469705278493_logo.png"
,"\/alfresco-access\/transaction\/user":"user1"
}

}
]
}

El problema viene cuando intento sacar los resultados que tiene almacenados toda la auditoría. 

El caso es que necesito sacar los datos de accesos a Alfresco y de archivos eliminados trimestralmente, por lo tanto he pensado que filtrando por fechas podría servirme la solución. El problema es que si filtro por fecha siguiendo las guias de Alfresco no me aparece ningún resultado. Las guías que he seguido son: 

Audit Log | Alfresco Documentation 

Simple audit query | Alfresco Documentation 

Using the auditing REST API | Alfresco Documentation 

Key tools and files | Alfresco Documentation 

Si sigo la primera guia indica que en la query tengo que añadir fromTime=1472018400000&toTime=1472021999000 pasando la fecha a timestamp de linux. Por lo tanto, he probado transformando la fecha desde 1 de octubre 2018 a 31 de diciembre 2018 a timestamp y la query me ha quedado de la siguiente manera:

curl -u admin:admin "http://127.0.0.1:8080/alfresco/service/api/audit/query/alfresco-access/alfresco-access/transaction/a..."
{
"count":0,
"entries":
[
]
}

Como veis no me devuelve ningún resultado a pesar que si hay datos. También he probado a indicar todo 2018 y tampoco devuelve nada e incluso 2017 y tampoco devuelve nada. ¿Estoy haciendo mal la query? ¿Alguna idea sobre como puedo sacar estos datos?

También agradecería si alguien me pudiera indicar como poder sacar los datos de auditoría de una manera mejor (mas eficiente) ya que parece que al tener tantos datos de auditoría el servidor bloquea al intentar mostrar todos los resultados.

Tengo instalada la versión Alfresco Community - 5.1.0 (r122274-b3) sobre una máquina virtual con Centos 6.8. 

Muchas gracias por adelantado.

Un saludo

[angelborroy]

Quizá esto te sirve de ayuda:

How to solve the audit data explosion in Alfresco 

Probablemente lo mejor en tu caso sea realizar directamente consultas SQL a la base de datos.

[rublape]

Buenas tardes Angel,

Gracias por la respuesta. He estado revisando el link que indicas y en mi caso no me ayuda ya que no quiero borrar los datos de auditoría a no ser que los pueda sacar antes.

He intentado por todos los medios hacer consultas a la base de datos y el problema es que no me aparecen los datos de auditoría ni en la tabla "alf_audit_entry" ni en "alf_prop_ tables". ¿Sabes si están en otra tabla o tablas?

No sé si se os ocurre alguna otra idea sobre cómo podría sacar estos datos. Además si me podríais guiar sobre cómo guardar estos datos para que no vuelva a ocurrir que se bloquee el servicio por el volumen de datos, sería de gran ayuda.

Muchas gracias

Un saludo

[angelborroy]

No es un módulo con el que haya trabajado mucho, así que no puedo orientarte demasiado.

La información más completa sobre el módulo la tienes en  

[rublape]

Al final para poder sacar la auditoría he recurrido a sacar la información con curl. He dejado toda la noche el proceso corriendo hasta que ha sacado la información.

El problema ha sido que esta mañana he tenido que volver a reiniciar el proceso de Alfresco ya que ha comenzado a ir lento a pesar que el proceso ya había terminado...

Muchas gracias!

Un saludo

[hzestrada]

Buenas estimado me guataria saber como lograstes resolver el problema de la auditoria estoy pasando por lo mismo hzestrada@gmail.com  quizas me puedas ayudar 

gracias 

[hzestrada]

Buenas estimado me gustaria saber si logro resolver el impase de la auditoria de alfresco estoy pasando por una situacion similar me guastaria poder tener ayuda 

gracias de antemano .

comento un poco , no logro ver la auditoria he  probado habilitar varas cosas pero nada 

### Audit Configuration

audit.enabled=true
audit.alfresco-access.enabled=true
audit.alfresco-access.sub-actions.enabled=false

pero no logro ver nada actualizado 

http://192.168.1.14/alfresco/service/api/audit/query/alfresco-access/alfresco-access/transaction/act...

{
   "count":100,
   "entries": 
   [
      {
         "id":579,
         "application":"alfresco-access",
         "user":"wandino",
         "time":"2019-09-30T14:33:30.599-06:00",
         "values":
         {
                     "\/alfresco-access\/transaction\/sub-actions":"deleteNode"
                     ,"\/alfresco-access\/transaction\/action":"DELETE"
                     ,"\/alfresco-access\/transaction\/type":"fm:post"
                     ,"\/alfresco-access\/transaction\/path":"\/app:company_home\/st:sites\/cm:tecnpolis\/cm:documentLibrary\/cm:TECN\u00d3POLIS 2019\/cm:Insumos Gr\u00e1ficos RRPP\/cm:Invitacion Digital_1.png\/fm:discussion\/cm:Comments\/cm:comment-1569875539776"
                     ,"\/alfresco-access\/transaction\/user":"wandino"
         }
         
      },
      {
         "id":580,
         "application":"alfresco-access",
         "user":"wandino",
         "time":"2019-09-30T14:33:30.616-06:00",
         "values":
         {
                     "\/alfresco-access\/transaction\/sub-actions":"updateNodeProperties deleteNode"
                     ,"\/alfresco-access\/transaction\/properties\/from":"{{http:\/\/www.alfresco.org\/model\/content\/1.0}modified=Thu Sep 26 15:42:33 CST 2019, {http:\/\/www.alfresco.org\/model\/forum\/1.0}commentCount=1}"
                     ,"\/alfresco-access\/transaction\/properties\/to":"{{http:\/\/www.alfresco.org\/model\/content\/1.0}modified=Mon Sep 30 14:33:30 CST 2019, {http:\/\/www.alfresco.org\/model\/forum\/1.0}commentCount=0}"
                     ,"\/alfresco-access\/transaction\/path":"\/app:company_home\/st:sites\/cm:tecnpolis\/cm:documentLibrary\/cm:TECN\u00d3POLIS 2019\/cm:Insumos Gr\u00e1ficos RRPP\/cm:Invitacion Digital_1.png"
                     ,"\/alfresco-access\/transaction\/action":"DELETE"
                     ,"\/alfresco-access\/transaction\/type":"cm:content"
                     ,"\/alfresco-access\/transaction\/user":"wandino"
         }

me birnda resultados pero anteriores nada a la fecha 

quedo a la espera de sus comentarios 

atte

Hector 

[cristinamr]

Buenos días.

Para poder ayudarte necesitamos más detalles: ¿Qué versión de Alfresco usas?Habilita el log de la auditoria a debug y dinos qué lineas te pinta.

Si puedes haz la prueba en un servidor no productivo porque dependiento del volumen de auditoria habilitar los logs puede penalizar el rendimiento del servidor.

Un saludo.

[hzestrada]

Buenas estimada

Gracias por su tiempo 

ya habilite el debug pero cual log necesita el catalina o el localhost_access_log

para adjuntarlo 

voy a poner el Catalina 

abr 05, 2021 11:52:40 AM org.apache.catalina.core.AprLifecycleListener lifecycleEvent
INFORMACIÓN: Se encuentra instalada una versión muy vieja 1.2.2 de la biblioteca nativa APR de Apache Tomcat, mientras que Tomcat recomienda una versión mayor de 1.2.8
abr 05, 2021 11:52:40 AM org.apache.catalina.core.AprLifecycleListener lifecycleEvent
INFORMACIÓN: Cargada la biblioteca nativa APR de Apache Tomcat 1.2.2 con la versión APR 1.5.2.
abr 05, 2021 11:52:40 AM org.apache.catalina.core.AprLifecycleListener lifecycleEvent
INFORMACIÓN: Capacidades APR: IPv6 [true], enviar fichero [true], aceptar filtros [false], aleatorio [true].
abr 05, 2021 11:52:40 AM org.apache.catalina.core.AprLifecycleListener initializeSSL
INFORMACIÓN: OpenSSL inicializado correctamente (OpenSSL 1.0.1s 1 Mar 2016)
abr 05, 2021 11:52:40 AM org.apache.coyote.AbstractProtocol init
INFORMACIÓN: Initializing ProtocolHandler ["http-apr-80"]
abr 05, 2021 11:52:40 AM org.apache.coyote.AbstractProtocol init
INFORMACIÓN: Initializing ProtocolHandler ["ajp-apr-444"]
abr 05, 2021 11:52:40 AM org.apache.coyote.AbstractProtocol init
INFORMACIÓN: Initializing ProtocolHandler ["http-bio-443"]
abr 05, 2021 11:52:40 AM org.apache.catalina.startup.Catalina load
INFORMACIÓN: Initialization processed in 1164 ms
abr 05, 2021 11:52:40 AM org.apache.catalina.core.StandardService startInternal
INFORMACIÓN: Arrancando servicio Catalina
abr 05, 2021 11:52:40 AM org.apache.catalina.core.StandardEngine startInternal
INFORMACIÓN: Starting Servlet Engine: Apache Tomcat/7.0.x
abr 05, 2021 11:52:40 AM org.apache.catalina.startup.HostConfig deployDescriptor
INFORMACIÓN: Desplieque del descriptor de configuración /var/www/html/alfresco/tomcat/conf/Catalina/localhost/solr4.xml
abr 05, 2021 11:52:40 AM org.apache.catalina.startup.SetContextPropertiesRule begin
ADVERTENCIA: [SetContextPropertiesRule]{Context} Setting property 'debug' to '0' did not find a matching property.
abr 05, 2021 11:52:46 AM org.apache.catalina.startup.TldConfig execute
INFORMACIÓN: At least one JAR was scanned for TLDs yet contained no TLDs. Enable debug logging for this logger for a complete list of JARs that were scanned but no TLDs were found in them. Skipping unneeded JARs during scanning can improve startup time and JSP compilation time.
abr 05, 2021 11:52:50 AM org.apache.catalina.startup.HostConfig deployDescriptor
INFORMACIÓN: Deployment of configuration descriptor /var/www/html/alfresco/tomcat/conf/Catalina/localhost/solr4.xml has finished in 9.519 ms
abr 05, 2021 11:52:50 AM org.apache.catalina.startup.HostConfig deployDescriptor
INFORMACIÓN: Desplieque del descriptor de configuración /var/www/html/alfresco/tomcat/conf/Catalina/localhost/alfresco.xml
abr 05, 2021 11:53:00 AM org.apache.catalina.startup.TldConfig execute
INFORMACIÓN: At least one JAR was scanned for TLDs yet contained no TLDs. Enable debug logging for this logger for a complete list of JARs that were scanned but no TLDs were found in them. Skipping unneeded JARs during scanning can improve startup time and JSP compilation time.
abr 05, 2021 11:54:15 AM org.apache.catalina.startup.HostConfig deployDescriptor
INFORMACIÓN: Deployment of configuration descriptor /var/www/html/alfresco/tomcat/conf/Catalina/localhost/alfresco.xml has finished in 84.926 ms
abr 05, 2021 11:54:15 AM org.apache.catalina.startup.HostConfig deployDescriptor
INFORMACIÓN: Desplieque del descriptor de configuración /var/www/html/alfresco/tomcat/conf/Catalina/localhost/share.xml
abr 05, 2021 11:54:17 AM org.apache.catalina.startup.TldConfig execute
INFORMACIÓN: At least one JAR was scanned for TLDs yet contained no TLDs. Enable debug logging for this logger for a complete list of JARs that were scanned but no TLDs were found in them. Skipping unneeded JARs during scanning can improve startup time and JSP compilation time.
abr 05, 2021 11:54:24 AM org.apache.catalina.startup.HostConfig deployDescriptor
INFORMACIÓN: Deployment of configuration descriptor /var/www/html/alfresco/tomcat/conf/Catalina/localhost/share.xml has finished in 9.614 ms
abr 05, 2021 11:54:24 AM org.apache.catalina.startup.HostConfig deployWAR
INFORMACIÓN: Despliegue del archivo /var/www/html/alfresco/tomcat/webapps/_vti_bin.war de la aplicación web
abr 05, 2021 11:54:24 AM org.apache.catalina.startup.TldConfig execute
INFORMACIÓN: At least one JAR was scanned for TLDs yet contained no TLDs. Enable debug logging for this logger for a complete list of JARs that were scanned but no TLDs were found in them. Skipping unneeded JARs during scanning can improve startup time and JSP compilation time.
abr 05, 2021 11:54:24 AM org.apache.catalina.startup.HostConfig deployWAR
INFORMACIÓN: Deployment of web application archive /var/www/html/alfresco/tomcat/webapps/_vti_bin.war has finished in 106 ms
abr 05, 2021 11:54:24 AM org.apache.catalina.startup.HostConfig deployWAR
INFORMACIÓN: Despliegue del archivo /var/www/html/alfresco/tomcat/webapps/ROOT.war de la aplicación web
abr 05, 2021 11:54:24 AM org.apache.catalina.startup.SetContextPropertiesRule begin
ADVERTENCIA: [SetContextPropertiesRule]{Context} Setting property 'debug' to '100' did not find a matching property.
abr 05, 2021 11:54:25 AM org.apache.catalina.startup.TldConfig execute
INFORMACIÓN: At least one JAR was scanned for TLDs yet contained no TLDs. Enable debug logging for this logger for a complete list of JARs that were scanned but no TLDs were found in them. Skipping unneeded JARs during scanning can improve startup time and JSP compilation time.
abr 05, 2021 11:54:25 AM org.apache.catalina.startup.HostConfig deployWAR
INFORMACIÓN: Deployment of web application archive /var/www/html/alfresco/tomcat/webapps/ROOT.war has finished in 80 ms
abr 05, 2021 11:54:25 AM org.apache.catalina.startup.HostConfig deployDirectory
INFORMACIÓN: Despliegue del directorio /var/www/html/alfresco/tomcat/webapps/host-manager de la aplicación web
abr 05, 2021 11:54:25 AM org.apache.catalina.startup.TldConfig execute
INFORMACIÓN: At least one JAR was scanned for TLDs yet contained no TLDs. Enable debug logging for this logger for a complete list of JARs that were scanned but no TLDs were found in them. Skipping unneeded JARs during scanning can improve startup time and JSP compilation time.
abr 05, 2021 11:54:25 AM org.apache.catalina.startup.HostConfig deployDirectory
INFORMACIÓN: Deployment of web application directory /var/www/html/alfresco/tomcat/webapps/host-manager has finished in 72 ms
abr 05, 2021 11:54:25 AM org.apache.catalina.startup.HostConfig deployDirectory
INFORMACIÓN: Despliegue del directorio /var/www/html/alfresco/tomcat/webapps/manager de la aplicación web
abr 05, 2021 11:54:25 AM org.apache.catalina.startup.TldConfig execute
INFORMACIÓN: At least one JAR was scanned for TLDs yet contained no TLDs. Enable debug logging for this logger for a complete list of JARs that were scanned but no TLDs were found in them. Skipping unneeded JARs during scanning can improve startup time and JSP compilation time.
abr 05, 2021 11:54:25 AM org.apache.catalina.startup.HostConfig deployDirectory
INFORMACIÓN: Deployment of web application directory /var/www/html/alfresco/tomcat/webapps/manager has finished in 78 ms
abr 05, 2021 11:54:25 AM org.apache.coyote.AbstractProtocol start
INFORMACIÓN: Starting ProtocolHandler ["http-apr-80"]
abr 05, 2021 11:54:25 AM org.apache.coyote.AbstractProtocol start
INFORMACIÓN: Starting ProtocolHandler ["ajp-apr-444"]
abr 05, 2021 11:54:25 AM org.apache.coyote.AbstractProtocol start
INFORMACIÓN: Starting ProtocolHandler ["http-bio-443"]
abr 05, 2021 11:54:25 AM org.apache.catalina.startup.Catalina start
INFORMACIÓN: Server startup in 104533 ms

quedo a la espera de sus cometarios Gracias 

[cristinamr]

Tienes un warning en el log:

ADVERTENCIA: [SetContextPropertiesRule]{Context} Setting property 'debug' to '100' did not find a matching property.

Ojea aquí para más detalles:

The debug attribute seems to come from older Tomcat versions and is no longer an supported context.xml attribute for Tomcat 8: https://tomcat.apache.org/tomcat-8.0-doc/config/context.html#Attributes

Debes buscar la apropiada para la versión que uses. ¿Qué hiciste para habilitar el debug? Una vez lo tengas corregido la idea es reiniciar y lanzar la auditoría para ver qué da el log.

Un saludo.