Backup PostgreSQL com BPIPE só funciona com o bacula cliente em modo depuração

[Helton Carlos Lima Godoy]

Boa tarde!

Estou com problemas para aplicar restore para um cliente:
Ele só restaura com sucesso se o cliente estiver com o bacula-fd no modo de depuração.

Alguém sabe como resolver isso?

O cliente é um Debian 7 com Postgresql 9.1.

Estou usando o parâmetro para backup via bpipe da seguinte forma:

Plugin = "bpipe:/mnt/fifo/bdhujm.sql:sudo -u postgres pg_dump bdhujm:/usr/bin/tee /backup/bacula-restores/bdhujm.sql"

Mensagem quando tento restaurar com o bacula cliente rodando apenas com o comando /etc/init.d/bacula-fd start:

Using Catalog "MyCatalog"
Run Restore job
JobName:         RestoreFiles
Bootstrap:       /var/lib/bacula/bacula-dir.restore.1.bsr
Where:           /backup/bacula-restores
Replace:         Always
FileSet:         Full Set
Backup Client:   bd-hujmapp-dev-fd
Restore Client:  bd-hujmapp-dev-fd
Storage:         File1
When:            2016-03-08 13:32:19
Catalog:         MyCatalog
Priority:        10
Plugin Options:  
OK to run? (yes/mod/no):

.. o restore está sendo executado agora. Quando completo, o resultado irá ser exibido abaixo ..

08-Mar 13:32 bacula-dir JobId 118: Start Restore Job RestoreFiles.2016-03-08_13.32.19_07
08-Mar 13:32 bacula-dir JobId 118: Using Device "FileChgr1-Dev1" to read.
08-Mar 13:32 bacula-sd JobId 118: Ready to read from volume "Vol-0001" on file device "FileChgr1-Dev1" (/backup).
08-Mar 13:32 bacula-sd JobId 118: Forward spacing Volume "Vol-0001" to file:block 0:2310268997.
08-Mar 13:32 bacula-sd JobId 118: End of Volume at file 0 on device "FileChgr1-Dev1" (/backup), Volume "Vol-0001"
08-Mar 13:32 bacula-sd JobId 118: End of all volumes.
08-Mar 13:32 bacula-sd JobId 118: Elapsed time=00:00:01, Transfer rate=6.133 K Bytes/second
08-Mar 13:32 bd-hujmapp-dev-fd JobId 118: Error: bpipe-fd: Error closing for file /mnt/fifo/bdhujm.sql: 268435457
08-Mar 13:32 bacula-dir JobId 118: Error: Bacula bacula-dir 7.4.0 (16Jan16):
  Build OS:               x86_64-unknown-linux-gnu ubuntu 14.04
  JobId:                  118
  Job:                    RestoreFiles.2016-03-08_13.32.19_07
  Restore Client:         bd-hujmapp-dev-fd
  Start time:             08-Mar-2016 13:32:21
  End time:               08-Mar-2016 13:32:23
  Files Expected:         1
  Files Restored:         1
  Bytes Restored:         32,982
  Rate:                   16.5 KB/s
  FD Errors:              1
  FD termination status:  Error
  SD termination status:  OK
  Termination:            *** Restore Error ***

08-Mar 13:32 bacula-dir JobId 118: Begin pruning Jobs older than 6 months .
08-Mar 13:32 bacula-dir JobId 118: No Jobs found to prune.
08-Mar 13:32 bacula-dir JobId 118: Begin pruning Files.
08-Mar 13:32 bacula-dir JobId 118: No Files found to prune.
08-Mar 13:32 bacula-dir JobId 118: End auto prune.

.. o restore não foi completado com sucesso. Verifique mensagem de erros acima para maiores detalhes.

Agora quando inicio o bacula cliente em modo depuração bacula-fd -d200

Using Catalog "MyCatalog"
Run Restore job
JobName:         RestoreFiles
Bootstrap:       /var/lib/bacula/bacula-dir.restore.2.bsr
Where:           /backup/bacula-restores
Replace:         Always
FileSet:         Full Set
Backup Client:   bd-hujmapp-dev-fd
Restore Client:  bd-hujmapp-dev-fd
Storage:         File1
When:            2016-03-08 13:36:12
Catalog:         MyCatalog
Priority:        10
Plugin Options:  
OK to run? (yes/mod/no):

.. o restore está sendo executado agora. Quando completo, o resultado irá ser exibido abaixo ..

08-Mar 13:36 bacula-dir JobId 119: Start Restore Job RestoreFiles.2016-03-08_13.36.12_13
08-Mar 13:36 bacula-dir JobId 119: Using Device "FileChgr1-Dev1" to read.
08-Mar 13:36 bacula-sd JobId 119: Ready to read from volume "Vol-0001" on file device "FileChgr1-Dev1" (/backup).
08-Mar 13:36 bacula-sd JobId 119: Forward spacing Volume "Vol-0001" to file:block 0:2310268997.
08-Mar 13:36 bacula-sd JobId 119: End of Volume at file 0 on device "FileChgr1-Dev1" (/backup), Volume "Vol-0001"
08-Mar 13:36 bacula-sd JobId 119: End of all volumes.
08-Mar 13:36 bacula-sd JobId 119: Elapsed time=00:00:01, Transfer rate=6.133 K Bytes/second
08-Mar 13:36 bacula-dir JobId 119: Bacula bacula-dir 7.4.0 (16Jan16):
  Build OS:               x86_64-unknown-linux-gnu ubuntu 14.04
  JobId:                  119
  Job:                    RestoreFiles.2016-03-08_13.36.12_13
  Restore Client:         bd-hujmapp-dev-fd
  Start time:             08-Mar-2016 13:36:14
  End time:               08-Mar-2016 13:36:16
  Files Expected:         1
  Files Restored:         1
  Bytes Restored:         32,982
  Rate:                   16.5 KB/s
  FD Errors:              0
  FD termination status:  OK
  SD termination status:  OK
  Termination:            Restore OK

08-Mar 13:36 bacula-dir JobId 119: Begin pruning Jobs older than 6 months .
08-Mar 13:36 bacula-dir JobId 119: No Jobs found to prune.
08-Mar 13:36 bacula-dir JobId 119: Begin pruning Files.
08-Mar 13:36 bacula-dir JobId 119: No Files found to prune.
08-Mar 13:36 bacula-dir JobId 119: End auto prune.

.. restore completo.

[Heitor Faria]

Oi Helton,

A única maneira de visualizar erros do bpipe é rodar o cliente em modo depuração.

Para o processo e execute: bacula-fd -d 200. As mensagens vão para stdout.

Abraços,

--

=======================================================================
Heitor Medrado de Faria  - LPIC-III | ITIL-F |  Bacula Systems Certified Administrator II

Próximas aulas telepresencial ao-vivo - 15 de fevereiro: http://www.bacula.com.br/agenda/

Ministro treinamento e implementação in-company Bacula: http://www.bacula.com.br/in-company/

Ou assista minhas videoaulas on-line: http://www.bacula.com.br/treinamento-bacula-ed/

61 8268-4220

Site: www.bacula.com.br | Facebook: heitor.faria

========================================================================

[Heitor Faria]

Ps.: melhorar isso é um trabalho para os desenvolvedores do grupo que tiveram patches aceitos este ano, Ana Emília e Wanderley. =P

---

--
Você recebeu essa mensagem porque está inscrito no grupo "Bacula Backup-Pt-Br" dos Grupos do Google.
Para cancelar inscrição nesse grupo e parar de receber e-mails dele, envie um e-mail para bacula-backup-p...@googlegroups.com.
Para postar nesse grupo, envie um e-mail para bacula-ba...@googlegroups.com.
Acesse esse grupo em https://groups.google.com/group/bacula-backup-pt-br.
Para ver essa discussão na Web, acesse https://groups.google.com/d/msgid/bacula-backup-pt-br/assp.0875933b5c.1389811344.58796.1457459083297.JavaMail.zimbra%40bacula.com.br.
Para mais opções, acesse https://groups.google.com/d/optout.

[Helton Carlos Lima Godoy]

Olá Heitor!

Eu quis resumir a história acabei esquecendo de postar a depuração do cliente, desculpe a falha ai Heitor. hehe

Abaixo a depuração do cliente:

root@bd-hujmapp-dev ~# bd-hujmapp-dev-fd: bnet.c:566-0 who=client host=10.24.16.130 port=9102
bd-hujmapp-dev-fd: job.c:455-0 Got: Hello Director bacula-dir calling 102
bd-hujmapp-dev-fd: job.c:288-0 <dird: Hello Director bacula-dir calling 102
bd-hujmapp-dev-fd: job.c:311-0 Executing Dir Hello Director bacula-dir calling 102
command.
bd-hujmapp-dev-fd: job.c:496-0 Calling Authenticate
bd-hujmapp-dev-fd: cram-md5.c:64-0 send: auth cram-md5 challenge <1857669450.1457458576@bd-hujmapp-dev-fd> ssl=0
bd-hujmapp-dev-fd: cram-md5.c:123-0 cram-get received: auth cram-md5 <1046766430.1457458575@bacula-dir> ssl=0
bd-hujmapp-dev-fd: cram-md5.c:147-0 sending resp to challenge: GSJ1r//9t//eA5RPA+4aVD
bd-hujmapp-dev-fd: job.c:503-0 OK Authenticate
bd-hujmapp-dev-fd: job.c:288-0 <dird: JobId=119 Job=RestoreFiles.2016-03-08_13.36.12_13 SDid=2 SDtime=1457457877 Authorization=MCKM-JHED-BEBP-AHDM-CNKG-BLLC-PIEP-IMNJ
bd-hujmapp-dev-fd: job.c:311-0 Executing Dir JobId=119 Job=RestoreFiles.2016-03-08_13.36.12_13 SDid=2 SDtime=1457457877 Authorization=MCKM-JHED-BEBP-AHDM-CNKG-BLLC-PIEP-IMNJ
command.
bd-hujmapp-dev-fd: job.c:1833-119 set sd auth key MCKM-JHED-BEBP-AHDM-CNKG-BLLC-PIEP-IMNJ
bd-hujmapp-dev-fd: job.c:686-119 JobId=119 Auth=MCKM-JHED-BEBP-AHDM-CNKG-BLLC-PIEP-IMNJ
bd-hujmapp-dev-fd: fd_plugins.c:1211-119 Instantiate plugin_ctx=a59428 JobId=119
bd-hujmapp-dev-fd: fd_plugins.c:234-119 plugin_ctx=a59428 JobId=119
bd-hujmapp-dev-fd: fd_plugins.c:127-119 name=<NULL> len=0 plugin=bpipe-fd.so plen=5
bd-hujmapp-dev-fd: bpipe-fd.c:219-119 bpipe-fd: JobStart=JobId=119 Job=RestoreFiles.2016-03-08_13.36.12_13
bd-hujmapp-dev-fd: job.c:288-119 <dird: storage address=bacula.hujm.ufmt.br port=9103 ssl=0 Authorization=MCKM-JHED-BEBP-AHDM-CNKG-BLLC-PIEP-IMNJ
bd-hujmapp-dev-fd: job.c:311-119 Executing Dir storage address=bacula.hujm.ufmt.br port=9103 ssl=0 Authorization=MCKM-JHED-BEBP-AHDM-CNKG-BLLC-PIEP-IMNJ
command.
bd-hujmapp-dev-fd: job.c:1848-119 StorageCmd: storage address=bacula.hujm.ufmt.br port=9103 ssl=0 Authorization=MCKM-JHED-BEBP-AHDM-CNKG-BLLC-PIEP-IMNJ
bd-hujmapp-dev-fd: job.c:1852-119 Set auth key MCKM-JHED-BEBP-AHDM-CNKG-BLLC-PIEP-IMNJ
bd-hujmapp-dev-fd: job.c:1827-119 set multi_restore=true
bd-hujmapp-dev-fd: job.c:1833-119 set sd auth key MCKM-JHED-BEBP-AHDM-CNKG-BLLC-PIEP-IMNJ
bd-hujmapp-dev-fd: job.c:1875-119 Connect to storage: bacula.hujm.ufmt.br:9103 ssl=0
bd-hujmapp-dev-fd: bsock.c:203-119 Current 10.24.16.130:9103 All 10.24.16.130:9103
bd-hujmapp-dev-fd: bsock.c:132-119 who=Storage daemon host=bacula.hujm.ufmt.br port=9103
bd-hujmapp-dev-fd: bsock.c:305-119 OK connected to server Storage daemon bacula.hujm.ufmt.br:9103.
bd-hujmapp-dev-fd: job.c:1892-119 Connection OK to SD.
bd-hujmapp-dev-fd: hello.c:211-119 Send to SD: Hello Bacula SD: Start Job RestoreFiles.2016-03-08_13.36.12_13 213

bd-hujmapp-dev-fd: authenticate.c:174-119 ==== respond to SD challenge
bd-hujmapp-dev-fd: cram-md5.c:123-119 cram-get received: auth cram-md5 <319486258.1457458575@bacula-sd> ssl=0
bd-hujmapp-dev-fd: cram-md5.c:147-119 sending resp to challenge: cH+Po1/Mh7syaU+Ql3xqQA
bd-hujmapp-dev-fd: authenticate.c:184-119 ==== Challenge SD
bd-hujmapp-dev-fd: cram-md5.c:71-119 send: auth cram-md5 challenge <429235933.1457458576@bd-hujmapp-dev-fd> ssl=0
bd-hujmapp-dev-fd: cram-md5.c:90-119 Authenticate OK r8+Ov9Z0D6+CLU/1K6+lbD
bd-hujmapp-dev-fd: authenticate.c:196-119 Authorization with SD is OK
bd-hujmapp-dev-fd: job.c:1948-119 Authenticated with SD.
bd-hujmapp-dev-fd: job.c:288-119 <dird: restore files=1 replace=a prelinks=0 where=/backup/bacula-restores
bd-hujmapp-dev-fd: job.c:311-119 Executing Dir restore files=1 replace=a prelinks=0 where=/backup/bacula-restores
command.
bd-hujmapp-dev-fd: job.c:2206-119 restore command
bd-hujmapp-dev-fd: job.c:2221-119 where=restore files=%d replace=%c prelinks=%d where=%67s
rwhere=restore files=%d replace=%c prelinks=%d regexwhere=%67s
bd-hujmapp-dev-fd: job.c:2264-119 Got replace a, where=/backup/bacula-restores
bd-hujmapp-dev-fd: job.c:2286-119 filed>dird: 2000 OK restore
bd-hujmapp-dev-fd: job.c:2374-119 VolSessId=2 VolsessT=1457457877 SF=0 EF=0
bd-hujmapp-dev-fd: job.c:2375-119 JobId=119 vol=DummyVolume
bd-hujmapp-dev-fd: job.c:2382-119 >stored: read open session = DummyVolume 2 1457457877 0 0 0 0
bd-hujmapp-dev-fd: job.c:2388-119 filed<stored: 3000 OK open ticket = 2
bd-hujmapp-dev-fd: job.c:2393-119 filed: got Ticket=2
bd-hujmapp-dev-fd: job.c:2411-119 >stored: read data 2
bd-hujmapp-dev-fd: job.c:2469-119 3000 OK data
bd-hujmapp-dev-fd: fd_plugins.c:234-119 plugin_ctx=a59428 JobId=119
bd-hujmapp-dev-fd: fd_plugins.c:127-119 name=<NULL> len=0 plugin=bpipe-fd.so plen=5
bd-hujmapp-dev-fd: restore.c:970-119 restore stream_plugin_name=1 1 1 bpipe:/mnt/fifo/bdhujm.sql:sudo -u postgres pg_dump bdhujm:tee /backup/bacula-restores/bdhujm.sql
bd-hujmapp-dev-fd: fd_plugins.c:826-119 Read plugin stream string=1 1 1 bpipe:/mnt/fifo/bdhujm.sql:sudo -u postgres pg_dump bdhujm:tee /backup/bacula-restores/bdhujm.sql
bd-hujmapp-dev-fd: fd_plugins.c:329-119 plugin cmd=bpipe:/mnt/fifo/bdhujm.sql:sudo -u postgres pg_dump bdhujm:tee /backup/bacula-restores/bdhujm.sql
bd-hujmapp-dev-fd: fd_plugins.c:872-119 plugin=bpipe-fd.so cmd=bpipe:/mnt/fifo/bdhujm.sql:sudo -u postgres pg_dump bdhujm:tee /backup/bacula-restores/bdhujm.sql len=5
bd-hujmapp-dev-fd: fd_plugins.c:127-119 name=bpipe:/mnt/fifo/bdhujm.sql:sudo -u postgres pg_dump bdhujm:tee /backup/bacula-restores/bdhujm.sql len=5 plugin=bpipe-fd.so plen=5
bd-hujmapp-dev-fd: fd_plugins.c:883-119 Restore Command plugin = bpipe:/mnt/fifo/bdhujm.sql:sudo -u postgres pg_dump bdhujm:tee /backup/bacula-restores/bdhujm.sql
bd-hujmapp-dev-fd: bpipe-fd.c:253-119 bpipe-fd: pluginEvent cmd=bpipe:/mnt/fifo/bdhujm.sql:sudo -u postgres pg_dump bdhujm:tee /backup/bacula-restores/bdhujm.sql
bd-hujmapp-dev-fd: attr.c:70-119 Attr: 1 3 /mnt/fifo/bdhujm.sql
bd-hujmapp-dev-fd: attr.c:76-119 Got Attr: FilInx=1 type=3
bd-hujmapp-dev-fd: attr.c:129-119 unpack_attr FI=1 Type=3 fname=/mnt/fifo/bdhujm.sql attr=A A IHA A A A A -B BAA B BW3wWP BW3wWP BW3wWP A A E lname= attrEx= datastr=0 delta_seq=0
bd-hujmapp-dev-fd: restore.c:531-119 Stream 4: GZIP data, File /mnt/fifo/bdhujm.sql
attrib=A A IHA A A A A -B BAA B BW3wWP BW3wWP BW3wWP A A E
attribsEx=
bd-hujmapp-dev-fd: restore.c:533-119 === msglen=81 attrExlen=0 msg=1 3 /mnt/fifo/bdhujm.sql
bd-hujmapp-dev-fd: fd_plugins.c:957-119 call plugin createFile stream=1 type=3 LinkFI=0 File=/backup/bacula-restores/mnt/fifo/bdhujm.sql
bd-hujmapp-dev-fd: fd_plugins.c:959-119 attrEx=""
bd-hujmapp-dev-fd: fd_plugins.c:999-119 call bopen
bd-hujmapp-dev-fd: fd_plugins.c:1264-119 plugin_bopen flags=241
bd-hujmapp-dev-fd: bpipe-fd.c:338-119 bpipe-fd: IO_OPEN
bd-hujmapp-dev-fd: bpipe-fd.c:343-119 bpipe-fd: IO_OPEN fd=a5e4d8 writer=tee /backup/bacula-restores/bdhujm.sql
bd-hujmapp-dev-fd: fd_plugins.c:1288-119 Return from plugin open status=8
bd-hujmapp-dev-fd: fd_plugins.c:1001-119 bopen status=8
bd-hujmapp-dev-fd: restore.c:566-119 Outfile=/backup/bacula-restores/mnt/fifo/bdhujm.sql create_file stat=3
bd-hujmapp-dev-fd: attr.c:294-119 -rwx------ 0 root root -1 2016-03-08 13:02:07 /backup/bacula-restores/mnt/fifo/bdhujm.sql
bd-hujmapp-dev-fd: restore.c:1170-119 Stream found in decompress_data(): 4
bd-hujmapp-dev-fd: restore.c:1246-119 Comp_len=65714 msglen=5925
bd-hujmapp-dev-fd: restore.c:1263-119 Write uncompressed 32982 bytes, total before write=0
bd-hujmapp-dev-fd: fd_plugins.c:1365-119 plugin_bwrite
bd-hujmapp-dev-fd: restore.c:1431-119 Write 32982 bytes, JobBytes=32982
--
-- PostgreSQL database dump
--

SET statement_timeout = 0;
SET client_encoding = 'UTF8';
SET standard_conforming_strings = on;
SET check_function_bodies = false;
SET client_min_messages = warning;
.
XXXXXXX
INSTRUÇÕES SQL DO BANCO POSTGRES, CORTEI ESSA PARTE.
XXXXXXX
--
-- PostgreSQL database dump complete
--

bd-hujmapp-dev-fd: fd_plugins.c:1320-119 plugin_bclose stat=0
bd-hujmapp-dev-fd: restore.c:1492-119 Stop extracting.
bd-hujmapp-dev-fd: restore.c:970-119 restore stream_plugin_name=1 0
bd-hujmapp-dev-fd: fd_plugins.c:826-119 Read plugin stream string=1 0
bd-hujmapp-dev-fd: fd_plugins.c:842-119 End plugin data plugin=a37288 ctx=a59428
bd-hujmapp-dev-fd: restore.c:1016-119 End Do Restore. Files=1 Bytes=32982
bd-hujmapp-dev-fd: heartbeat.c:145-119 Send kill to heartbeat id
bd-hujmapp-dev-fd: job.c:2318-119 filed>stored: read close session 2
bd-hujmapp-dev-fd: job.c:2332-119 Done in job.c
bd-hujmapp-dev-fd: job.c:2335-119 2000 OK storage end
bd-hujmapp-dev-fd: job.c:288-119 <dird: endrestorebd-hujmapp-dev-fd: job.c:311-119 Executing Dir endrestore command.
bd-hujmapp-dev-fd: job.c:2360-119 end_restore_cmd
bd-hujmapp-dev-fd: fd_plugins.c:234-119 plugin_ctx=a59428 JobId=119
bd-hujmapp-dev-fd: fd_plugins.c:127-119 name=<NULL> len=0 plugin=bpipe-fd.so plen=5
bd-hujmapp-dev-fd: fd_plugins.c:257-119 eventType==bEventEndRestoreJob
bd-hujmapp-dev-fd: job.c:314-119 Quit command loop. Canceled=0
bd-hujmapp-dev-fd: runscript.c:99-119 runscript: running all RUNSCRIPT object (ClientAfterJob) JobStatus=T
bd-hujmapp-dev-fd: fd_plugins.c:234-119 plugin_ctx=a59428 JobId=119
bd-hujmapp-dev-fd: fd_plugins.c:127-119 name=<NULL> len=0 plugin=bpipe-fd.so plen=5
bd-hujmapp-dev-fd: job.c:425-119 Calling term_find_files
bd-hujmapp-dev-fd: job.c:428-119 Done with term_find_files
bd-hujmapp-dev-fd: fd_plugins.c:1246-119 Free instance plugin_ctx=a59428 JobId=119
bd-hujmapp-dev-fd: jcr.c:174-119 write_last_jobs seek to 192
bd-hujmapp-dev-fd: job.c:431-0 Done with free_jcr
bd-hujmapp-dev-fd: mem_pool.c:370-0 garbage collect memory pool

[Heitor Faria]

Helton,

Vc verificou se ele efetivamente não restaurou o arquivo, ainda que terminado em erro o Job?

Abraços,

---

--
Você recebeu essa mensagem porque está inscrito no grupo "Bacula Backup-Pt-Br" dos Grupos do Google.
Para cancelar inscrição nesse grupo e parar de receber e-mails dele, envie um e-mail para bacula-backup-p...@googlegroups.com.
Para postar nesse grupo, envie um e-mail para bacula-ba...@googlegroups.com.
Acesse esse grupo em https://groups.google.com/group/bacula-backup-pt-br.

Para ver essa discussão na Web, acesse https://groups.google.com/d/msgid/bacula-backup-pt-br/2db031b6-5b50-462f-a7fa-a336c18aa6b7%40googlegroups.com.

Para mais opções, acesse https://groups.google.com/d/optout.

[Helton Carlos Lima Godoy]

Bom dia Heitor!

Na verdade postei essa dúvida aqui no fórum porque sei que vc e outros integrantes usam o Bacula há bastante tempo, e pensei que alguém soubesse pq aparece essa mensagem de erro, pensei que pudesse existir alguma configuração que eu não tivesse feito, porque se restauro os arquivos quando o cliente está em modo depuração a mensagem diz que ocorreu com sucesso, a mensagem de falha só ocorre quando não está no modo depuração, não sei se expliquei bem.

Exemplo:

1- O cliente bacula iniciado assim "/etc/init.d/bacula-fd start" apresenta mensagem de erro na restauração, mas aparece o arquivo restaurado.

2- O cliente bacula iniciado assim "bacula-fd -d200" apresenta mensagem realizada com sucesso. Que inclusive foi daí que tirei o log de depuração que postei aqui no forum, mas assim já tinha aparecido restauração concluída com sucesso.


A restauração aparentemente está ocorrendo, mas minha preocupação está nos relatórios que são apresentados pelo Bacula-Web, que instalei pra monitorarmos os Jobs.

Eu tenho a sensação que acabo perdendo a confiabilidade da informação, quando apresento esse relatório pra um gestor, entende?

Ainda estou na fase de implantação do bacula e estou tentando deixá-lo o mais redondo possível, é só uma paranoia minha.

Não consigo entender muito bem esses logs de depuração pra encontrar algum erro, aparentemente no log de depuração está tudo OK.

Desde já agradeço.

[Heitor Faria]

Bom dia Heitor!

Na verdade postei essa dúvida aqui no fórum porque sei que vc e outros integrantes usam o Bacula há bastante tempo, e pensei que alguém soubesse pq aparece essa mensagem de erro, pensei que pudesse existir alguma configuração que eu não tivesse feito, porque se restauro os arquivos quando o cliente está em modo depuração a mensagem diz que ocorreu com sucesso, a mensagem de falha só ocorre quando não está no modo depuração, não sei se expliquei bem.

Exemplo:

1- O cliente bacula iniciado assim "/etc/init.d/bacula-fd start" apresenta mensagem de erro na restauração, mas aparece o arquivo restaurado.

2- O cliente bacula iniciado assim "bacula-fd -d200" apresenta mensagem realizada com sucesso. Que inclusive foi daí que tirei o log de depuração que postei aqui no forum, mas assim já tinha aparecido restauração concluída com sucesso.

Provavelmente seu cliente Bacula está rodando com usuário comum bacula, e não com o usuário root como geralmente oriento nos meus cursos justamente para evitar esse tipo de problema.

Abraços,

[Helton Carlos Lima Godoy]

Então Heitor, foi a primeira coisa que pensei, mas olha só:

root@bd-hujmapp-dev ~# ps -aux |grep bacula
warning: bad ps syntax, perhaps a bogus '-'?
See http://gitorious.org/procps/procps/blobs/master/Documentation/FAQ
root     17745  0.0  0.1  48364  2220 ?        Ssl  07:49   0:00 /usr/sbin/bacula-fd -c /etc/bacula/bacula-fd.conf
root     31078  0.0  0.0   6312   596 pts/0    S+   09:39   0:00 grep --color=auto bacula

Cheguei a modificar o arquivo /etc/init.d/bacula-fd
abaixo um pedaço do arquivo:

NAME="bacula-fd"
DESC="Bacula File Daemon"
DAEMON=/usr/sbin/${NAME}
BUSER="root"
BGROUP="root"
BOPTIONS="-c /etc/bacula/${NAME}.conf"
BPORT=9102

[Heitor Faria]

Helton: tente modificar a últimaa variável da restauração para o dd of=/caminho_dump, ao invés do tee. Talvez o erro ocorra pois o tee é verboso.

Abraços,

[Helton Carlos Lima Godoy]

Heitor matou a pau!

Era isso mesmo. Cara não tinha pensado nisso, mas quando vc falou fez todo sentido.

Por isso no modo depuração ele funcionava bem e não aparecia a mensagem de falha, a falha deve ter sido por não conseguir mostrar o que o tee tentava jogar na saída padrão.

Obrigado mais uma vez.

[Helton Carlos Lima Godoy]

Heitor acho que fiquei feliz rápido de mais.

Observei que quando testei também estava em modo depuração.
Quando voltei a iniciar com "/etc/init.d/bacula-fd start", deu a mesma mensagem de falha ao restaurar o backup.

Mas em todo caso eu vejo que ele está restaurando o arquivo SQL.

Penso que pode ser algum bug, porque o parâmetro que estou usando do BPIPE para o Dump do Postgresql é o mesmo que vc sugere nos seus materiais, mudando apenas o nome da minha base de dados é claro.
A instalação do bacula também foi realizada com orientação dos materiais do seu site.
Inclusive a instalação do cliente usei um script update_client_debian.sh também recomendado no site.

Só pode ser um bug do plugin da versão 7.4.

Mas como está restaurando, vou deixar como concluído. A menos que vc tenha alguma ideia ainda, pq eu não consigo imaginar mais nada. hehe

[Jefferson P. S. Emerick]

Boa tarde. Eu utilizo essa funcionalidade no 7.2 sem problemas. Se for bug mesmo, bom saber que num atualizo ainda.

--

Grato,
Jefferson Parreira dos Santos Emerick

--

Você recebeu essa mensagem porque está inscrito no grupo "Bacula Backup-Pt-Br" dos Grupos do Google.
Para cancelar inscrição nesse grupo e parar de receber e-mails dele, envie um e-mail para bacula-backup-p...@googlegroups.com.
Para postar nesse grupo, envie um e-mail para bacula-ba...@googlegroups.com.
Acesse esse grupo em https://groups.google.com/group/bacula-backup-pt-br.

Para ver essa discussão na Web, acesse https://groups.google.com/d/msgid/bacula-backup-pt-br/7ee80795-f12a-4e33-8ada-9a8ce9b88f08%40googlegroups.com.

[Moisés Vieira]

Olá, está apresentando o mesmo erro quando temto realizar o restore, ele restaura o arquivo, mas ocorre o erro:

 

25-Mar 14:45 baculamp-dir JobId 51: Start Restore Job RestoreFiles.2016-03-25_14.45.14_04

25-Mar 14:45 baculamp-dir JobId 51: Using Device "FileStorage" to read.

25-Mar 14:45 rzimbra-sd JobId 51: Ready to read from volume "Vol8" on file device "FileStorage" (/bkp/).

25-Mar 14:45 rzimbra-sd JobId 51: Forward spacing Volume "Vol8" to file:block 0:1228153465.

25-Mar 14:45 rzimbra-sd JobId 51: End of Volume at file 0 on device "FileStorage" (/bkp/), Volume "Vol8"

25-Mar 14:45 rzimbra-sd JobId 51: End of all volumes.

25-Mar 14:45 rzimbra-sd JobId 51: Elapsed time=00:00:06, Transfer rate=32.55 M Bytes/second

25-Mar 14:45 baculamp-fd JobId 51: Error: bpipe-fd: Error closing for file /var/bacula/working/bacula.sql: 268435457

25-Mar 14:45 baculamp-dir JobId 51: Error: Bacula baculamp-dir 7.4.0 (16Jan16):

  Build OS:               x86_64-unknown-linux-gnu ubuntu 14.04

  JobId:                  51

  Job:                    RestoreFiles.2016-03-25_14.45.14_04

  Restore Client:         baculamp-fd

  Start time:             25-Mar-2016 14:45:16

  End time:               25-Mar-2016 14:45:30

  Files Expected:         1

  Files Restored:         1

  Bytes Restored:         613,103,749

  Rate:                   43793.1 KB/s

  FD Errors:              1

  FD termination status:  Error

  SD termination status:  OK

  Termination:            *** Restore Error ***

 

Quando faço em modo depuração não ocorre:

 

25-Mar 14:38 rzimbra-sd JobId 49: End of Volume at file 0 on device "FileStorage" (/bkp/), Volume "Vol8"

25-Mar 14:38 rzimbra-sd JobId 49: End of all volumes.

25-Mar 14:38 rzimbra-sd JobId 49: Elapsed time=00:16:52, Transfer rate=193.0 K Bytes/second

25-Mar 14:39 baculamp-dir JobId 49: Bacula baculamp-dir 7.4.0 (16Jan16):

  Build OS:               x86_64-unknown-linux-gnu ubuntu 14.04

  JobId:                  49

  Job:                    RestoreFiles.2016-03-25_14.22.07_40

  Restore Client:         baculamp-fd

  Start time:             25-Mar-2016 14:22:09

  End time:               25-Mar-2016 14:39:11

  Files Expected:         1

  Files Restored:         1

  Bytes Restored:         613,103,749

  Rate:                   599.9 KB/s

  FD Errors:              0

  FD termination status:  OK

  SD termination status:  OK

  Termination:            Restore OK

 

 

Estou realizando teste de restore da base de dados do mysql do bacula, no fileset tem a seguinte linha:

 

Plugin = "bpipe:/var/bacula/working/bacula.sql:mysqldump -u USUÁRIO -pSENHA --databases bacula:/usr/bin/tee /tmp/bacula-restores/bacula.sql"

O bacula-fd está sendo executado como root e a opção Plugin Directory = /usr/lib64 está descomentada.

 

 

Estou também utilizando a versão 7.4.0 do bacula.

[Diego Vaz]

Boa tarde a todos.
Estou efetuando backups e restores de VMs Xen através do plugin bpipe, no entanto estou recebendo a seguinte mensagem de erro ao restaurar: Error: bpipe-fd: Error closing for file /var/Srv_Teste.xva: 268435457
O arquivo xva chega a ser restaurado, mas o job apresenta erro. Meu script ClientRunAfterJob também nem chega a ser executado.

Segue meu bpipe_xen.sh para análise:

DATE=`date +%Y-%m-%d-%H-%M`
    for UUID in $(xe vm-list power-state=running is-control-domain=false | grep uuid | cut -d: -f2- | tr -d \ )
      do
        VM_NAME=$(xe vm-param-list uuid=$UUID | grep -i name-label | cut -d: -f2- | tr -d \ )
        SNAP_UUID=`xe vm-snapshot uuid=$UUID new-name-label=$VM_NAME.snps new-name-description="Exportado em "$DATE`
        xe template-param-set is-a-template=false uuid=$SNAP_UUID
        echo "bpipe:/var/$VM_NAME.xva:xe vm-export vm=$SNAP_UUID filename=:dd of=/bacula-restores/$VM_NAME.xva"
     done

Alguém tem idéia do que possa estar causando este problema?

Em terça-feira, 8 de março de 2016 14:39:11 UTC-3, Helton Carlos Lima Godoy escreveu:

[André Fernando]

Diego Vaz,

O meu restaura com sucesso só se estiver em modo depuração. Conseguiu resolver?

[Diego Vaz]

André, desistí de utilizar bpipe.

----------------
Diego Vaz
Tecnólogo em Redes de Computadores

--
Você recebeu essa mensagem porque está inscrito no grupo "Bacula Backup-Pt-Br" dos Grupos do Google.
Para cancelar inscrição nesse grupo e parar de receber e-mails dele, envie um e-mail para bacula-backup-p...@googlegroups.com.
Para postar nesse grupo, envie um e-mail para bacula-ba...@googlegroups.com.
Acesse esse grupo em https://groups.google.com/group/bacula-backup-pt-br.

Para ver essa discussão na Web, acesse https://groups.google.com/d/msgid/bacula-backup-pt-br/cd82382a-ffc4-4660-b635-34cf15b6feef%40googlegroups.com.