Error creating snapshot root /var/backups/0002/0002. Aborting backup.

512 views
Skip to first unread message

vilc...@gmail.com

unread,
Aug 26, 2015, 9:32:34 AM8/26/15
to elkarbackup-users
Buenas;

Espero que me puedan ayudar, he instalado esta solucion para BK y he dado de alta un cliente windows y siempre obtengo este error:

Error creating snapshot root /var/backups/0002/0002. Aborting backup.

He probado con diferentes rutas y siempre obtengo dicho error. En los logs en la parte de cliente esta activo y ok.

Hago un telnet desde el servidor donde esta el ElKar y funciona correctamente.

Podrían darme alguna idea.

Pedro Arreitunandia

unread,
Aug 26, 2015, 11:34:06 AM8/26/15
to elkarbac...@googlegroups.com
Aupa !!

Por tener más información, ...,imagino que ya has instalado el servicion rsync en el cliente windows, ¿ verdad ?  

http://docs.elkarbackup.org/es/clientes_y_tareas/anadiendo_clientes_windows.html

Ten en cuenta que el usuario con el que ejecutas el servicio cwRsyncServer (por defecto cwRsyncServer) tiene que tener permisos en la ruta que quieres copiar, es decir, la carpeta que has definido en el parámetro path del fichero rsyncd.conf del cliente Windows.

Mira si lo que se comenta aquí te da alguna otra pista:  https://groups.google.com/forum/#!searchin/elkarbackup-users/windows/elkarbackup-users/xXBci5CWw80/S9WDmN2bWc4J

Ya nos dirás como te va ...



--
Has recibido este mensaje porque estás suscrito al grupo "elkarbackup-users" de Grupos de Google.
Para anular la suscripción a este grupo y dejar de recibir sus mensajes, envía un correo electrónico a elkarbackup-us...@googlegroups.com.
Visita este grupo en http://groups.google.com/group/elkarbackup-users.
Para obtener más opciones, visita https://groups.google.com/d/optout.

David Murciego

unread,
Aug 27, 2015, 6:40:54 AM8/27/15
to elkarbac...@googlegroups.com
Buenas;

Lo primero gracias Pedro y si tenias razon el problema era permisos en la carpeta de destino.

Si selecciono como destino una carpeta local funciona sin problemas, lo que pasa que un NAS que lo tengo montado por cifs si selecciono dicho directorio obtengo el siguiente error:

Command "/usr/bin/rsnapshot" -c "/tmp/rsnapshot.4_7.cfg" Daily 2>&1 failed. Diagnostic information follows: /bin/cp: fallo al conservar el propietario de «/media/nas/0004/0007/Daily.0»: Permiso denegado ---------------------------------------------------------------------------- rsnapshot encountered an error! The program was invoked with these options: /usr/bin/rsnapshot -c /tmp/rsnapshot.4_7.cfg Daily ---------------------------------------------------------------------------- ERROR: /bin/cp -al /media/nas/0004/0007/.sync /media/nas/0004/0007/Daily.0 failed (result 256, exit status 1). Perhaps your cp does not support -al options? ERROR: Error! cp_al("/media/nas/0004/0007/.sync", "/media/nas/0004/0007/Daily.0")

Por lo que he probado y he podido ver el problema es el comando que usa cp -al la opción l es la que me da el error, habría manera de poder solucionar esto.

Un Saludo y gracias por adelantado.

--
Has recibido este mensaje porque estás suscrito a un tema del grupo "elkarbackup-users" de Grupos de Google.
Para anular la suscripción a este tema, visita https://groups.google.com/d/topic/elkarbackup-users/1qQ6BbqkgR4/unsubscribe.
Para anular la suscripción a este grupo y a todos sus temas, envía un correo electrónico a elkarbackup-us...@googlegroups.com.
Para acceder a más opciones, visita https://groups.google.com/d/optout.

Eneko Lacunza

unread,
Aug 27, 2015, 6:44:53 AM8/27/15
to elkarbac...@googlegroups.com
Hola David,

La ubicación donde vayas a guardar los backups debe soportar crear hardlinks. Esto no es posible con los puntos de montaje CIFS.

Usa NFS.

Saludos
Eneko

El 27/08/15 a las 12:40, David Murciego escribió:
-- 
Zuzendari Teknikoa / Director Técnico
Binovo IT Human Project, S.L.
Telf. 943575997
      943493611
Astigarraga bidea 2, planta 6 dcha., ofi. 3-2; 20180 Oiartzun (Gipuzkoa)
www.binovo.es

David Murciego

unread,
Aug 28, 2015, 3:40:34 AM8/28/15
to elkarbac...@googlegroups.com
Buenas;

Perfecto, monte la unidad en NFS y sin problema, los BK de la máquina Windows han funcionado sin problemas, pero tengo un problema con los BK en Linux y no consigo corregirlo.

El problema viene con la conexión a la máquina linux para realizar los BK, en las instrucciones no me queda muy claro el primer paso:


"Config" -> "Manage Parameters" -> "Download" Public Key

ssh-copy-id -i Publickey.pub ro...@192.168.1.12

Esto se haría en el servidor? Tanto descargar como la copia.

El caso que lo he realizado en el servidor y el error que obtengo a la hora de realizar el BK me da el siguiente error:

Command "/usr/bin/rsnapshot" -c "/tmp/rsnapshot.2_2.cfg" sync 2>&1 failed. Diagnostic information follows: Permission denied (publickey,password). rsync: connection unexpectedly closed (0 bytes received so far) [Receiver] rsync error: error in rsync protocol data stream (code 12) at io.c(226) [Receiver=3.1.1]
----------------------------------------------------------------------------
rsnapshot encountered an error! The program was invoked with these options: /usr/bin/rsnapshot -c /tmp/rsnapshot.2_2.cfg sync
----------------------------------------------------------------------------
ERROR: /usr/bin/rsync returned 12 while processing ro...@10.0.2.32:/home

Nuevamente muchas gracias por su ayuda.

Un Saludo;

Eneko Lacunza

unread,
Aug 28, 2015, 3:44:19 AM8/28/15
to elkarbac...@googlegroups.com
Hola David,

Este paso es para dar permiso a elkarbackup para conectarse via SSH como root.

Con el Download te descargas la clave pública SSH de elkarbackup.

El comando ssh-copy-id lo puedes hacer desde donde quieras (tu workstation por ejemplo), lo que hace es instalar la clave pública de elkarbackup en la configuración de claves permitidas para root de SSH del servidor que le indiques al comando.

Saludos

El 28/08/15 a las 09:40, David Murciego escribió:

David Murciego

unread,
Aug 28, 2015, 4:52:00 AM8/28/15
to elkarbac...@googlegroups.com
Buenas Eneko

Mi servidor tiene la IP 192.168.1.55

El servidor Linux del que quiero hacer BK tiene la IP 192.168.1.32.

Desde el servidor con IP 192.168.1.32 me he descargado la clave pública y he ejecutado:

ssh-copy-id -i Publickey.pub ro...@192.168.1.32

Despues he probado ha realizar el BK y he obtenido el mismo problema.

He ejecutado tambien en el cliente:

ssh-copy-id -i Publickey.pub ro...@192.168.1.55

Y obtengo el mismo resultado.

Siento molestar y muchas gracias de antemano.

Eneko Lacunza

unread,
Aug 28, 2015, 5:04:38 AM8/28/15
to elkarbac...@googlegroups.com
Hola David,

No te estoy entendiendo bien. En qué IP tienes elkarbackup?

En el Linux del que quieres hacer backup, comprueba en /root/.ssh/authorized_keys que tengas una línea con el contenido de Publickey.pub .

Comprueba tambien en el Linux, que en el fichero /etc/ssh/sshd_config tengas esta línea:
PermitRootLogin yes

El 28/08/15 a las 10:51, David Murciego escribió:

David Murciego

unread,
Aug 28, 2015, 5:14:29 AM8/28/15
to elkarbac...@googlegroups.com
Hola Eneko;

El elkarBackup lo tengo en la IP 192.168.1.55.

En el equipo linux he ejecutado:

ssh-copy-id -i Publickey.pub ro...@192.168.1.55

y veo que en .ssh/authorized_keys veo una linea con la entrada de PublicKey.pub

El caso que sigo teniendo el mismo error en el elkarbackup.

Un Saludo;

Eneko Lacunza

unread,
Aug 28, 2015, 5:21:37 AM8/28/15
to elkarbac...@googlegroups.com
Y la configuración de sshd?

El 28/08/15 a las 11:14, David Murciego escribió:

David Murciego

unread,
Aug 28, 2015, 5:29:17 AM8/28/15
to elkarbac...@googlegroups.com
Si esta el PermitRoot a yes

Antton Rodriguez

unread,
Aug 28, 2015, 6:01:14 AM8/28/15
to elkarbac...@googlegroups.com
Kaixo,

Puedes hacer ssh root@IP hasta la maquina?

Te pide introducir el password?

David Murciego

unread,
Aug 28, 2015, 6:05:59 AM8/28/15
to elkarbac...@googlegroups.com
Desde la máquina linux hago

ssh ro...@192.168.1.55 (IP de elkarbackup) y no me pide password

Desde el servidor ElkarBackup hago

ssh ro...@192.168.1.32 (IP de servidor que quiero coger los BK) y me pide pass.

Un Saludo;

Eneko Lacunza

unread,
Aug 28, 2015, 6:13:52 AM8/28/15
to elkarbac...@googlegroups.com


Elkarbackup no se conecta con el usuario root para hacer backup, prueba lo siguiente en el servidor elkarbackup:

ssh -i /var/lib/elkarbackup/.ssh/id_rsa ro...@192.168.1.32

Esto te tiene que dar login directo, si no funciona hay que arregarlo primero.

Si lo anterior funciona bien (por lo que has dicho hasta ahora debería), puede que el servidor destino esté mal puesto en la interfaz, la cadena de servidor es ligeramente diferente para rsync y ssh


El 28/08/15 a las 12:05, David Murciego escribió:

David Murciego

unread,
Aug 28, 2015, 6:28:22 AM8/28/15
to elkarbac...@googlegroups.com
Pues ejecuto eso desde elkarbackup y me pide contraseña, por lo que algo raro hay.

Gracias nuevamente

Xabi Ezpeleta

unread,
Aug 28, 2015, 7:11:36 AM8/28/15
to elkarbac...@googlegroups.com
Probemos otra cosa. Desde el servidor de Elkarbackup, prueba a ejecutar el siguiente comando:

ssh-copy-id -i /var/lib/elkarbacku/.ssh/id_rsa.pub ro...@192.168.1.32

Supongo que te pedirá la clave; introdúcela. Después, intenta de nuevo el mismo comando que te ha dicho Eneko:

ssh -i /var/lib/elkarbackup/.ssh/id_rsa ro...@192.168.1.32

Ahora debería acceder sin clave... Si es así, prueba de nuevo a ejecutar el backup (asegúrate de que en la URL del cliente has indicado correctamente el usuario: ro...@192.168.1.32)


Xabi Ezpeleta

unread,
Aug 28, 2015, 7:12:37 AM8/28/15
to elkarbac...@googlegroups.com
Se ma ha olvidado una p :)

ssh-copy-id -i /var/lib/elkarbackup/.ssh/id_rsa.pub ro...@192.168.1.32

David Murciego

unread,
Sep 3, 2015, 2:46:58 AM9/3/15
to elkarbac...@googlegroups.com
Buenas Xabi;

Disculpa la demora pero me mandaron a un cliente y no he podido seguir con las pruebas.

Si ya me percate lo ejecute y se loga ya sin necesidad de password.

He ejecutado el bk, y se queda ahora mismo en running, se ha quedado asi durante mas de 5 días para un BK de 16Gb, viendo que no se detenia y lógicamente algo pasaba he procedido a cancelarlo y veo esto en los logs:

2015-09-03 08:12:34WARNINGStopJobCommandCannot abort job backup: not running/client/2/job/2

Pero en la parte de los Job esta Running y no se ejecutan el resto, alguna idea al respecto.

Un Saludo;

Xabi Ezpeleta

unread,
Sep 3, 2015, 3:11:02 AM9/3/15
to elkarbac...@googlegroups.com
Prueba a ejecutar la tarea de forma manual (mediante el botón "Ejecutar ahora").

Si no funciona correctamente, muéstranos un screenshots de los logs: si es posible filtra los mensajes de los logs de ese cliente (si el ID del cliente es 18, en la columna Object escribe "/client/18")

David Murciego

unread,
Sep 3, 2015, 7:14:27 AM9/3/15
to elkarbac...@googlegroups.com
Buenas Xabi;

Nada trato de ejecutarlo manualmente y se queda en Queue, el log es este

2015-09-03 13:11:16INFODefaultControllerrootView client 2/elkarbackup/app.php/client/2
2015-09-03 13:11:16INFODefaultControllerrootView client 2/elkarbackup/app.php/client/2
2015-09-03 13:11:07INFOStatusReportrootQUEUED/elkarbackup/app.php/client/2/job/9
2015-09-03 08:12:34WARNINGStopJobCommandCannot abort job backup: not running/client/2/job/2
2015-09-02 21:00:02INFOStatusReportRUNNING/client/2/job/2
2015-09-02 21:00:02INFOStatusReportRUNNING/client/2
2015-09-02 21:00:02INFOStatusReportQUEUED/client/2/job/9
2015-09-02 21:00:02INFOStatusReportQUEUED/client/2/job/2
2015-09-02 21:00:02INFOStatusReportQUEUED/client/2
2015-09-01 21:00:01INFOStatusReportRUNNING/client/2/job/2
2015-09-01 21:00:01INFOStatusReportRUNNING/client/2
2015-09-01 21:00:01INFOStatusReportQUEUED/client/2/job/9
2015-09-01 21:00:01INFOStatusReportQUEUED/client/2/job/2
2015-09-01 21:00:01INFOStatusReportQUEUED/client/2
2015-08-31 21:00:01INFOStatusReportRUNNING/client/2/job/2
2015-08-31 21:00:01INFOStatusReportRUNNING/client/2
2015-08-31 21:00:01INFOStatusReportQUEUED/client/2/job/9
2015-08-31 21:00:01INFOStatusReportQUEUED/client/2/job/2
2015-08-31 21:00:01INFOStatusReportQUEUED/client/2
2015-08-28 21:00:01INFOStatusReportRUNNING

/client/2/job/2



Gracias por adelantado;

Xabi Ezpeleta

unread,
Sep 3, 2015, 7:26:20 AM9/3/15
to elkarbac...@googlegroups.com
Cuando ejecutas una tarea manualmente, la copia no es instantánea. La tarea pasa inmediatamente a estado QUEUED y tras un minuto debería pasar al estado RUNNING.

Es entonces cuando debería empezar la copia y tendría que aportar algún mensaje si ha habido algún error. ¿Puedes volver a mirar el log para confirmar si es así?

Gracias

Antton Rodriguez

unread,
Sep 3, 2015, 7:31:43 AM9/3/15
to elkarbac...@googlegroups.com
De todos modos, si nos pegas lo que te da un.

ps aux | grep -E '(rsync|rsnapshot)' | grep -v grep
 
en tu terminal, tal vez podamos ver los procesos derivados y si alguno se ha quedado dormido por el camino.

saludos

David Murciego

unread,
Sep 3, 2015, 7:32:12 AM9/3/15
to elkarbac...@googlegroups.com
Correcto Xavi;

Ahora si que veo que ya ha hecho el BK y esta Ok:

2015-09-03 13:29:26INFODefaultControllerrootView clients/elkarbackup/app.php/clients
2015-09-03 13:13:45INFODefaultControllerrootView logs/elkarbackup/app.php/logs
2015-09-03 13:12:02ERRORTickCommandException Address in mailbox given [] does not comply with RFC 2822, 3.6.2. running command {"command":"elkarbackup:run_job","client":"2","job":"9"}:
2015-09-03 13:12:02INFOStatusReportOK/client/2/job/9
2015-09-03 13:12:02INFORunJobCommandClient "2", Job "9" ok./client/2/job/9
2015-09-03 13:12:02INFORunJobCommandClient "2", Job "9" du end./client/2/job/9
2015-09-03 13:12:02INFORunJobCommandClient "2", Job "9" du begin./client/2/job/9
2015-09-03 13:12:02INFORunJobCommandCommand "/usr/bin/rsnapshot" -c "/tmp/rsnapshot.2_9.cfg" Daily 2>&1 succeeded with output: /client/2/job/9
2015-09-03 13:12:02INFORunJobCommandRunning "/usr/bin/rsnapshot" -c "/tmp/rsnapshot.2_9.cfg" Daily 2>&1/client/2/job/9
2015-09-03 13:12:02INFORunJobCommandCommand "/usr/bin/rsnapshot" -c "/tmp/rsnapshot.2_9.cfg" sync 2>&1 succeeded with output: /client/2/job/9
2015-09-03 13:12:01INFORunJobCommandRunning "/usr/bin/rsnapshot" -c "/tmp/rsnapshot.2_9.cfg" sync 2>&1/client/2/job/9
2015-09-03 13:12:01INFOStatusReportRUNNING/client/2/job/9
2015-09-03 13:12:01INFOStatusReportRUNNING/client/2
2015-09-03 13:12:01INFOStatusReportQUEUED/client/2/job/9
2015-09-03 13:12:01INFOStatusReportQUEUED/client/2
2015-09-03 13:12:01INFOTickCommandAbout to run command: {"command":"elkarbackup:run_job","client":"2","job":"9"}
2015-09-03 13:12:01INFOTickCommandNothing to run.
2015-09-03 13:11:37INFODefaultControllerrootView logs/elkarbackup/app.php/logs
2015-09-03 13:11:28INFODefaultControllerrootView logs

/elkarbackup/app.php/logs




El problema que tengon entonces es que se queda en RUNNING cuando se ejecuta ese trabajo y no finaliza, y los otros BK se quedan en QUEUE.


El 3 de septiembre de 2015, 13:26, Xabi Ezpeleta <xezp...@gmail.com> escribió:

Antton Rodriguez

unread,
Sep 3, 2015, 7:42:46 AM9/3/15
to elkarbac...@googlegroups.com
Y probablemente siga en ahi el proceso, mira los procesos con el comando que te he pasado para ver como esta tu servidor linux. 

Xabi Ezpeleta

unread,
Sep 3, 2015, 7:43:24 AM9/3/15
to elkarbac...@googlegroups.com
En los logs se indica que todo ha ido bien y la tarea ha terminado satisfactoriamente. Por lo que nos cuentas, diría que tu problema coincide con este issue: https://github.com/elkarbackup/elkarbackup/issues/82

Espera a la hora programada para el próximo backup, y comprueba después que todos los clientes/tareas han quedado en estado OK.

Gracias.

David Murciego

unread,
Sep 4, 2015, 2:46:02 AM9/4/15
to elkarbac...@googlegroups.com
Buenas nuevamente;

Pues parecía al lanzarlo manualmente se había resuelto el problema pero esta noche ha sucedido lo mismo.

Os adjunto un pantallazo de como se queda en la web y los logs que deja en /var/logs/elkarbackup

Un saludo y gracias por vuestra infinita paciencia.
BnvLog.log
Captura.JPG

Xabi Ezpeleta

unread,
Sep 4, 2015, 4:25:51 AM9/4/15
to elkarbac...@googlegroups.com
Por lo que veo en el log, la tarea 2.2 ha terminado correctamente tras 10 minutos de ejecución. Tendría que haber cambiado el estado de RUNNING a OK y después tendría que haber seguido con la próxima tarea en cola (2.9, si no has cambiado el orden).

¿Puedes mandarnos la siguiente información del servidor para ver qué está ocurriendo?


1- Envíanos el log del symfony "/var/log/elkarbackup/prod.log"

2- Los últimos logs del sistema sobre elkarbackup: tail -f /var/log/messages|grep elkarbackup

3- El último estado del job según la BBDD:  mysql --defaults-file=/etc/mysql/debian.cnf -e "use elkarbackup; select * from LogRecord"|grep /client/2/job/2 | tail -n 10

4- Las políticas que tienes definidas: mysql --defaults-file=/etc/mysql/debian.cnf -e "use elkarbackup; select * from Policy\G"

5- Qué política usa cada job: mysql --defaults-file=/etc/mysql/debian.cnf -e "use elkarbackup; select id,policy_id from Job"


Gracias

...

[Erantsitako mezua]  

David Murciego

unread,
Sep 4, 2015, 7:21:52 AM9/4/15
to elkarbac...@googlegroups.com
Buenas Xavi;

1- Envíanos el log del symfony "/var/log/elkarbackup/prod.log"

No tengo este fichero

2- Los últimos logs del sistema sobre elkarbackup: tail -f /var/log/messages|grep elkarbackup

Esto es lo que hay en el messages:

Aug 30 06:25:03 ElKarBackUp rsyslogd: [origin software="rsyslogd" swVersion="8.4.2" x-pid="513" x-info="http://www.rsyslog.com"] rsyslogd was HUPed
Aug 30 06:27:01 ElKarBackUp rsyslogd0: action 'action 17' resumed (module 'builtin:ompipe') [try http://www.rsyslog.com/e/0 ]
Aug 30 06:27:01 ElKarBackUp rsyslogd-2359: action 'action 17' resumed (module 'builtin:ompipe') [try http://www.rsyslog.com/e/2359 ]
Aug 30 09:09:01 ElKarBackUp rsyslogd-2007: action 'action 17' suspended, next retry is Sun Aug 30 09:09:31 2015 [try http://www.rsyslog.com/e/2007 ]
Aug 31 06:25:03 ElKarBackUp rsyslogd: [origin software="rsyslogd" swVersion="8.4.2" x-pid="513" x-info="http://www.rsyslog.com"] rsyslogd was HUPed
Aug 31 06:27:01 ElKarBackUp rsyslogd0: action 'action 17' resumed (module 'builtin:ompipe') [try http://www.rsyslog.com/e/0 ]
Aug 31 06:27:01 ElKarBackUp rsyslogd-2359: action 'action 17' resumed (module 'builtin:ompipe') [try http://www.rsyslog.com/e/2359 ]
Aug 31 09:09:01 ElKarBackUp rsyslogd-2007: action 'action 17' suspended, next retry is Mon Aug 31 09:09:31 2015 [try http://www.rsyslog.com/e/2007 ]
Aug 31 21:01:51 ElKarBackUp rsnapshot[12862]: /usr/bin/rsnapshot -c /tmp/rsnapshot.2_2.cfg sync: completed successfully
Aug 31 21:06:55 ElKarBackUp rsnapshot[12896]: /usr/bin/rsnapshot -c /tmp/rsnapshot.2_2.cfg Daily: completed successfully
Sep  1 06:25:02 ElKarBackUp rsyslogd: [origin software="rsyslogd" swVersion="8.4.2" x-pid="513" x-info="http://www.rsyslog.com"] rsyslogd was HUPed
Sep  1 06:27:01 ElKarBackUp rsyslogd0: action 'action 17' resumed (module 'builtin:ompipe') [try http://www.rsyslog.com/e/0 ]
Sep  1 06:27:01 ElKarBackUp rsyslogd-2359: action 'action 17' resumed (module 'builtin:ompipe') [try http://www.rsyslog.com/e/2359 ]
Sep  1 09:08:01 ElKarBackUp rsyslogd-2007: action 'action 17' suspended, next retry is Tue Sep  1 09:08:31 2015 [try http://www.rsyslog.com/e/2007 ]
Sep  1 21:00:53 ElKarBackUp rsnapshot[23118]: /usr/bin/rsnapshot -c /tmp/rsnapshot.2_2.cfg sync: completed successfully
Sep  1 21:10:59 ElKarBackUp rsnapshot[23206]: /usr/bin/rsnapshot -c /tmp/rsnapshot.2_2.cfg Daily: completed successfully
Sep  2 06:25:03 ElKarBackUp rsyslogd: [origin software="rsyslogd" swVersion="8.4.2" x-pid="513" x-info="http://www.rsyslog.com"] rsyslogd was HUPed
Sep  2 06:26:01 ElKarBackUp rsyslogd0: action 'action 17' resumed (module 'builtin:ompipe') [try http://www.rsyslog.com/e/0 ]
Sep  2 06:26:01 ElKarBackUp rsyslogd-2359: action 'action 17' resumed (module 'builtin:ompipe') [try http://www.rsyslog.com/e/2359 ]
Sep  2 09:09:01 ElKarBackUp rsyslogd-2007: action 'action 17' suspended, next retry is Wed Sep  2 09:09:31 2015 [try http://www.rsyslog.com/e/2007 ]
Sep  2 21:00:51 ElKarBackUp rsnapshot[934]: /usr/bin/rsnapshot -c /tmp/rsnapshot.2_2.cfg sync: completed successfully
Sep  2 21:10:29 ElKarBackUp rsnapshot[1044]: /usr/bin/rsnapshot -c /tmp/rsnapshot.2_2.cfg Daily: completed successfully
Sep  3 06:25:03 ElKarBackUp rsyslogd: [origin software="rsyslogd" swVersion="8.4.2" x-pid="513" x-info="http://www.rsyslog.com"] rsyslogd was HUPed
Sep  3 06:26:01 ElKarBackUp rsyslogd0: action 'action 17' resumed (module 'builtin:ompipe') [try http://www.rsyslog.com/e/0 ]
Sep  3 06:26:01 ElKarBackUp rsyslogd-2359: action 'action 17' resumed (module 'builtin:ompipe') [try http://www.rsyslog.com/e/2359 ]
Sep  3 09:09:01 ElKarBackUp rsyslogd-2007: action 'action 17' suspended, next retry is Thu Sep  3 09:09:31 2015 [try http://www.rsyslog.com/e/2007 ]
Sep  3 13:12:02 ElKarBackUp rsnapshot[8159]: /usr/bin/rsnapshot -c /tmp/rsnapshot.2_9.cfg sync: completed successfully
Sep  3 13:12:02 ElKarBackUp rsnapshot[8163]: /usr/bin/rsnapshot -c /tmp/rsnapshot.2_9.cfg Daily: completed successfully
Sep  3 14:23:51 ElKarBackUp rsnapshot[8682]: /usr/bin/rsnapshot -c /tmp/rsnapshot.2_2.cfg sync: completed successfully
Sep  3 14:34:02 ElKarBackUp rsnapshot[8754]: /usr/bin/rsnapshot -c /tmp/rsnapshot.2_2.cfg Daily: completed successfully
Sep  3 21:00:50 ElKarBackUp rsnapshot[11491]: /usr/bin/rsnapshot -c /tmp/rsnapshot.2_2.cfg sync: completed successfully
Sep  3 21:10:27 ElKarBackUp rsnapshot[11611]: /usr/bin/rsnapshot -c /tmp/rsnapshot.2_2.cfg Daily: completed successfully
Sep  4 06:25:03 ElKarBackUp rsyslogd: [origin software="rsyslogd" swVersion="8.4.2" x-pid="513" x-info="http://www.rsyslog.com"] rsyslogd was HUPed
Sep  4 06:27:01 ElKarBackUp rsyslogd0: action 'action 17' resumed (module 'builtin:ompipe') [try http://www.rsyslog.com/e/0 ]
Sep  4 06:27:01 ElKarBackUp rsyslogd-2359: action 'action 17' resumed (module 'builtin:ompipe') [try http://www.rsyslog.com/e/2359 ]
Sep  4 09:08:01 ElKarBackUp rsyslogd-2007: action 'action 17' suspended, next retry is Fri Sep  4 09:08:31 2015 [try http://www.rsyslog.com/e/2007 ]
Sep  4 09:50:51 ElKarBackUp rsnapshot[17187]: /usr/bin/rsnapshot -c /tmp/rsnapshot.2_2.cfg sync: completed successfully
Sep  4 10:01:33 ElKarBackUp rsnapshot[17262]: /usr/bin/rsnapshot -c /tmp/rsnapshot.2_2.cfg Daily: completed successfully
~


3- El último estado del job según la BBDD:  mysql --defaults-file=/etc/mysql/debian.cnf -e "use elkarbackup; select * from LogRecord"|grep /client/2/job/2 | tail -n 10

1879    BnvWeb  2015-09-04 09:50:01     200     INFO    /client/2/job/2 QUEUED  StatusReport    0
1881    BnvWeb  2015-09-04 09:50:01     200     INFO    /client/2/job/2 RUNNING StatusReport    0
1882    BnvWeb  2015-09-04 09:50:01     200     INFO    /client/2/job/2 Running "/usr/bin/rsnapshot" -c "/tmp/rsnapshot.2_2.cfg" sync 2>&1      RunJobCommand0
1883    BnvWeb  2015-09-04 09:50:51     200     INFO    /client/2/job/2 Command "/usr/bin/rsnapshot" -c "/tmp/rsnapshot.2_2.cfg" sync 2>&1 succeeded with output:    RunJobCommand   0
1884    BnvWeb  2015-09-04 09:50:51     200     INFO    /client/2/job/2 Running "/usr/bin/rsnapshot" -c "/tmp/rsnapshot.2_2.cfg" Daily 2>&1     RunJobCommand0
1885    BnvWeb  2015-09-04 10:01:33     200     INFO    /client/2/job/2 Command "/usr/bin/rsnapshot" -c "/tmp/rsnapshot.2_2.cfg" Daily 2>&1 succeeded with output:   RunJobCommand   0
1886    BnvWeb  2015-09-04 10:01:33     200     INFO    /client/2/job/2 Client "2", Job "2" du begin.   RunJobCommand   0
1887    BnvWeb  2015-09-04 10:07:07     200     INFO    /client/2/job/2 Client "2", Job "2" du end.     RunJobCommand   0
1888    BnvWeb  2015-09-04 10:07:07     200     INFO    /client/2/job/2 Client "2", Job "2" ok. RunJobCommand   0
1889    BnvWeb  2015-09-04 10:07:07     200     INFO    /client/2/job/2 OK      StatusReport    0


4- Las políticas que tienes definidas: mysql --defaults-file=/etc/mysql/debian.cnf -e "use elkarbackup; select * from Policy\G" (Son las que vienen por defecto)

*************************** 1. row ***************************
                id: 1
       description: Example policy
              name: Default policy
       hourlyHours: 12:00|15:00|21:00
 hourlyDaysOfMonth: NULL
  hourlyDaysOfWeek: 1|2|3|4|5
      hourlyMonths: NULL
       hourlyCount: 0
        dailyHours: 21:00
  dailyDaysOfMonth: NULL
   dailyDaysOfWeek: 1|2|3|4|5
       dailyMonths: NULL
        dailyCount: 3
       weeklyHours: 21:00
 weeklyDaysOfMonth: NULL
  weeklyDaysOfWeek: 1
      weeklyMonths: NULL
       weeklyCount: 0
      monthlyHours: 21:00
monthlyDaysOfMonth: 1
 monthlyDaysOfWeek: NULL
     monthlyMonths: NULL
      monthlyCount: 0
       yearlyHours: 21:00
 yearlyDaysOfMonth: NULL
  yearlyDaysOfWeek: NULL
      yearlyMonths: NULL
       yearlyCount: 0
           include: NULL
           exclude: NULL
         syncFirst: 1
*************************** 2. row ***************************
                id: 2
       description: NULL
              name: Three times a day, monday to friday
       hourlyHours: 11:00|14:00|17:00
 hourlyDaysOfMonth: NULL
  hourlyDaysOfWeek: 1|2|3|4|5
      hourlyMonths: NULL
       hourlyCount: 3
        dailyHours: 11:00
  dailyDaysOfMonth: NULL
   dailyDaysOfWeek: 1|2|3|4|5
       dailyMonths: NULL
        dailyCount: 5
       weeklyHours: 11:00
 weeklyDaysOfMonth: NULL
  weeklyDaysOfWeek: NULL
      weeklyMonths: NULL
       weeklyCount: 0
      monthlyHours: 11:00
monthlyDaysOfMonth: NULL
 monthlyDaysOfWeek: NULL
     monthlyMonths: NULL
      monthlyCount: 0
       yearlyHours: 11:00
 yearlyDaysOfMonth: NULL
  yearlyDaysOfWeek: NULL
      yearlyMonths: NULL
       yearlyCount: 0
           include: NULL
           exclude: NULL
         syncFirst: 1
*************************** 3. row ***************************
                id: 3
       description: NULL
              name: At 21:00, 7 days a week
       hourlyHours: NULL
 hourlyDaysOfMonth: NULL
  hourlyDaysOfWeek: NULL
      hourlyMonths: NULL
       hourlyCount: 0
        dailyHours: 21:00
  dailyDaysOfMonth: NULL
   dailyDaysOfWeek: 1|2|3|4|5|6|7
       dailyMonths: NULL
        dailyCount: 7
       weeklyHours: 21:00
 weeklyDaysOfMonth: NULL
  weeklyDaysOfWeek: NULL
      weeklyMonths: NULL
       weeklyCount: 0
      monthlyHours: 21:00
monthlyDaysOfMonth: NULL
 monthlyDaysOfWeek: NULL
     monthlyMonths: NULL
      monthlyCount: 0
       yearlyHours: 21:00
 yearlyDaysOfMonth: NULL
  yearlyDaysOfWeek: NULL
      yearlyMonths: NULL
       yearlyCount: 0
           include: NULL
           exclude: NULL
         syncFirst: 1
*************************** 4. row ***************************
                id: 4
       description: NULL
              name: At 21:00, monday to friday, long time storage
       hourlyHours: NULL
 hourlyDaysOfMonth: NULL
  hourlyDaysOfWeek: NULL
      hourlyMonths: NULL
       hourlyCount: 0
        dailyHours: 21:00
  dailyDaysOfMonth: NULL
   dailyDaysOfWeek: 1|2|3|4|5
       dailyMonths: NULL
        dailyCount: 5
       weeklyHours: 21:00
 weeklyDaysOfMonth: NULL
  weeklyDaysOfWeek: 6
      weeklyMonths: NULL
       weeklyCount: 4
      monthlyHours: 21:00
monthlyDaysOfMonth: 28
 monthlyDaysOfWeek: NULL
     monthlyMonths: NULL
      monthlyCount: 22
       yearlyHours: 21:00
 yearlyDaysOfMonth: NULL
  yearlyDaysOfWeek: NULL
      yearlyMonths: NULL
       yearlyCount: 0
           include: NULL
           exclude: NULL
         syncFirst: 1

5- Qué política usa cada job: mysql --defaults-file=/etc/mysql/debian.cnf -e "use elkarbackup; select id,policy_id from Job"

+----+-----------+
| id | policy_id |
+----+-----------+
|  2 |         1 |
|  7 |         1 |
|  8 |         1 |
|  9 |         1 |
+----+-----------+

Xabi Ezpeleta

unread,
Sep 4, 2015, 11:31:06 AM9/4/15
to elkarbac...@googlegroups.com
Aparentemente está todo correcto.

Aun así, hay algo sospechoso. Por lo visto, tras configurar correctamente la llave SSH en el cliente, la primera vez que lanzaste la tarea de backup, la abortaste de forma brusca antes de su finalización. Es posible que esto te esté generando algún conflicto.

Te aconsejo que sigas los siguientes pasos:

1- Si es posible, elimina esa tarea (2.2)
2- Espera a la próxima programación y observa si el resto de tareas terminan correctamente
3- Vuelve a crear una tarea nueva con la misma configuración que tenías en el (2.2)
4- Ejecútala a mano si quieres (mediante "Ejecutar ahora"), pero no lo abortes
5- Una vez finalizada esa tarea, la próxima programación debería realizarse también correctamente

Ya nos dirás si esto te funciona.

David Murciego

unread,
Sep 9, 2015, 4:17:40 AM9/9/15
to elkarbac...@googlegroups.com
Buenas Xavi;

como me pediste borre la tarea 2 y espere a la siguiente ejecución.

Y la tarea que se ejecuta en primer lugar se queda en RUNNING pero mirando los logs se ve que ha terminado como ok.

Alguna idea?

Quizas debiera reinstalar todo para comprobar que no haya habido algún problema en la instalación?

Un Saludo;

Xabi Ezpeleta

unread,
Sep 9, 2015, 4:27:30 PM9/9/15
to elkarbac...@googlegroups.com
Hola David,

Me parece una buena idea realizar una nueva instalación limpia, si es posible en otra máquina.

Esto debería solucionar tus problemas, pero tras la instalación no estaría de más que realices pruebas de backup poco a poco; a medida que vas haciendo cambios y añades nuevos clientes/tareas.

De esta forma, si vuelves a dar con el mismo error, tal vez puedas decirnos en qué momento aparece y cómo reproducirlo. Esto nos ayudaría a dar con el origen del posible fallo.

Gracias!
Reply all
Reply to author
Forward
0 new messages