Bacula-users

[Bacula-users] Bacula 5.0.3 DVD backup (SD Segfaults)

2010-09-14 06:52:07
Subject: [Bacula-users] Bacula 5.0.3 DVD backup (SD Segfaults)
From: Ben Draper <ben.draper AT ymail DOT com>
To: bacula-users AT lists.sourceforge DOT net
Date: Tue, 14 Sep 2010 10:22:35 +0000 (GMT)
Hello All,

I am having issues with DVD backup with bacula. Once it has written the Part file ready
for writing, the SD segfaults Then dies shortly after.

I have tested that the [/etc/bacula/dvd-handler] and growisofs commands can write to
DVD's and I can read them afterwards.

Below is all the debugging/configuration information.

Below is a list of messages from bconsole and /var/log/messages

[root@virtualbox bacula]# ./bconsole Connecting to Director virtualbox:9101 1000 OK: virtualbox-dir Version: 5.0.3 (04 August 2010) Enter a period to cancel a command. *run Automatically selected Catalog: MyCatalog Using Catalog "MyCatalog" A job name must be specified. Automatically selected Job: BackupClient1 Run Backup job JobName: BackupClient1 Level: Incremental Client: virtualbox-fd FileSet: Full Set Pool: DVDPool (From Job resource) Storage: DVD (From Pool resource) When: 2010-09-08 14:26:29 Priority: 10 OK to run? (yes/mod/no): yes Job queued. JobId=1 You have messages. * * * *messages 08-Sep 14:26 virtualbox-dir JobId 1: No prior Full backup Job record found. 08-Sep 14:26 virtualbox-dir JobId 1: No prior or suitable Full backup found in catalog. Doing FULL backup. 08-Sep 14:26 virtualbox-dir JobId 1: Start Backup JobId 1, Job=BackupClient1.2010-09-08_14.26.33_03 08-Sep 14:26 virtualbox-dir JobId 1: Created new Volume "BaculaDVD0001" in catalog. 08-Sep 14:26 virtualbox-dir JobId 1: Using Device "DVDStorage" *messages 08-Sep 14:26 virtualbox-sd JobId 1: Labeled new Volume "BaculaDVD0001" on device "DVDStorage" (/dev/cdrw). 08-Sep 14:26 virtualbox-sd JobId 1: Wrote label to prelabeled Volume "BaculaDVD0001" on device "DVDStorage" (/dev/cdrw) *messages 08-Sep 14:29 virtualbox-fd JobId 1: Error: bsock.c:393 Write error sending 34127 bytes to Storage daemon:127.0.0.1:9103: ERR=Broken pipe 08-Sep 14:29 virtualbox-fd JobId 1: Fatal error: backup.c:1024 Network send error to SD. ERR=Broken pipe *status Status available for: 1: Director 2: Storage 3: Client 4: All Select daemon type for status (1-4): 4 virtualbox-dir Version: 5.0.3 (04 August 2010) i686-pc-linux-gnu redhat Daemon started 08-Sep-10 14:25, 0 Jobs run since started. Heap: heap=135,168 smbytes=62,524 max_bytes=90,174 bufs=252 max_bufs=257 Scheduled Jobs: Level Type Pri Scheduled Name Volume =================================================================================== Incremental Backup 10 08-Sep-10 23:05 BackupClient1 BaculaDVD0001 ==== Running Jobs: Console connected at 08-Sep-10 14:26 JobId Level Name Status ====================================================================== 1 Full BackupClient1.2010-09-08_14.26.33_03 has a fatal error ==== Terminated Jobs: JobId Level Files Bytes Status Finished Name ==================================================================== 1 Full 281 41.58 M OK 31-Aug-10 20:42 BackupClient1 2 2 25.41 K OK 31-Aug-10 20:47 RestoreFiles 1 Full 0 0 Error 07-Sep-10 11:08 BackupClient1 2 Full 0 0 Error 07-Sep-10 11:28 BackupClient1 3 Full 0 0 Error 07-Sep-10 15:30 BackupClient1 ==== Connecting to Storage daemon DVD at 127.0.0.1:9103 Failed to connect to Storage daemon DVD. ==== Connecting to Client virtualbox-fd at virtualbox:9102 virtualbox-fd Version: 5.0.3 (04 August 2010) i686-pc-linux-gnu redhat Daemon started 08-Sep-10 14:25. Jobs: run=1 running=0. Heap: heap=868,352 smbytes=85,278 max_bytes=506,524 bufs=78 max_bufs=835 Sizeof: boffset_t=8 size_t=4 debug=0 trace=0 Running Jobs: Director connected at: 08-Sep-10 14:30 No Jobs running. ==== Terminated Jobs: JobId Level Files Bytes Status Finished Name ====================================================================== 1 Full 28,197 835.6 M Error 07-Sep-10 22:32 BackupClient1 2 Full 0 0 Error 07-Sep-10 22:43 BackupClient1 1 Full 28,214 836.0 M Error 07-Sep-10 22:48 BackupClient1 1 Full 77,689 1.562 G Error 07-Sep-10 23:01 BackupClient1 2 Full 0 0 Error 07-Sep-10 23:05 BackupClient1 1 Full 0 0 Error 07-Sep-10 23:09 BackupClient1 1 Full 13,090 102.8 M Error 07-Sep-10 23:13 BackupClient1 2 Full 0 0 Error 07-Sep-10 23:15 BackupClient1 1 Full 125 11.38 M Error 07-Sep-10 23:17 BackupClient1 1 Full 77,699 1.562 G Error 08-Sep-10 14:29 BackupClient1 ==== You have messages. *** *quit You have new mail in /var/spool/mail/root [root@virtualbox bacula]# ./bacula status bacula-sd dead but pid file exists bacula-fd (pid 10801) is running... bacula-dir (pid 10809) is running... [root@virtualbox bacula-dvd-spool]# tail -f /var/log/messages Sep 8 14:26:53 virtualbox kernel: isofs_fill_super: bread failed, dev=sr0, iso_blknum=16, block=16 Sep 8 14:26:54 virtualbox kernel: attempt to access beyond end of device Sep 8 14:26:54 virtualbox kernel: sr0: rw=0, want=68, limit=4 Sep 8 14:26:54 virtualbox kernel: isofs_fill_super: bread failed, dev=sr0, iso_blknum=16, block=16 Sep 8 14:26:55 virtualbox kernel: attempt to access beyond end of device Sep 8 14:26:55 virtualbox kernel: sr0: rw=0, want=68, limit=4 Sep 8 14:26:55 virtualbox kernel: isofs_fill_super: bread failed, dev=sr0, iso_blknum=16, block=16 Sep 8 14:26:56 virtualbox kernel: attempt to access beyond end of device Sep 8 14:26:56 virtualbox kernel: sr0: rw=0, want=68, limit=4 Sep 8 14:26:56 virtualbox kernel: isofs_fill_super: bread failed, dev=sr0, iso_blknum=16, block=16 Sep 8 14:29:33 virtualbox bacula-sd: Bacula interrupted by signal 11: Segmentation violation [root@virtualbox bacula-dvd-spool]# pwd /export/backup/bacula-dvd-spool [root@virtualbox bacula-dvd-spool]# du -h * 1.5G BaculaDVD0001 [root@virtualbox bacula]#

Below is gdb output of bacula-sd

(gdb) cont Continuing. [New Thread 0xb7dddb90 (LWP 12336)] [New Thread 0xb69dbb90 (LWP 12339)] Detaching after fork from child process 12340. Detaching after fork from child process 12342. Detaching after fork from child process 12343. Detaching after fork from child process 12345. [Thread 0xb69dbb90 (LWP 12339) exited] Detaching after fork from child process 12346. Detaching after fork from child process 12348. Detaching after fork from child process 12349. Detaching after fork from child process 12351. Detaching after fork from child process 12352. Detaching after fork from child process 12354. Detaching after fork from child process 12355. Detaching after fork from child process 12357. Detaching after fork from child process 12358. Detaching after fork from child process 12360. Detaching after fork from child process 12361. Detaching after fork from child process 12363. Detaching after fork from child process 12364. Detaching after fork from child process 12366. Detaching after fork from child process 12367. Detaching after fork from child process 12369. Detaching after fork from child process 12370. Detaching after fork from child process 12372. Detaching after fork from child process 12374. Detaching after fork from child process 12375. Detaching after fork from child process 12377. Detaching after fork from child process 12378. Detaching after fork from child process 12380. Detaching after fork from child process 12381. Detaching after fork from child process 12383. Detaching after fork from child process 12384. Detaching after fork from child process 12386. Detaching after fork from child process 12387. Detaching after fork from child process 12389. Detaching after fork from child process 12390. Detaching after fork from child process 12392. Detaching after fork from child process 12393. Detaching after fork from child process 12395. Detaching after fork from child process 12396. Detaching after fork from child process 12398. Detaching after fork from child process 12399. Detaching after fork from child process 12401. Detaching after fork from child process 12402. Detaching after fork from child process 12404. Program received signal SIGSEGV, Segmentation fault. [Switching to Thread 0xb7dddb90 (LWP 12336)] lseek_dvd (dcr=0x0, offset=0, whence=0) at dvd.c:433 433 DEVICE *dev = dcr->dev; (gdb) bt #0 lseek_dvd (dcr=0x0, offset=0, whence=0) at dvd.c:433 #1 0x0806406b in DEVICE::rewind (this=0x827ea08, dcr=0x0) at dev.c:836 #2 0x080649ab in DEVICE::offline_or_rewind (this=0x827ea08) at dev.c:1282 #3 0x080649ef in DEVICE::close (this=0x827ea08) at dev.c:1926 #4 0x08064d5d in DEVICE::close_part (this=0x827ea08) at dev.c:1985 #5 0x0806b6c2 in dvd_open_next_part (dcr=0x8280c20) at dvd.c:323 #6 0x0805d753 in do_dvd_size_checks (dcr=0x8280c20) at block.c:868 #7 write_block_to_dev (dcr=0x8280c20) at block.c:522 #8 0x0805dcdd in write_block_to_device (dcr=0x8280c20) at block.c:382 #9 0x08056acf in do_append_data (jcr=0x827f390) at append.c:198 #10 0x0806d820 in append_data_cmd (jcr=0x827f390) at fd_cmds.c:203 #11 0x0806ce6a in do_fd_commands (jcr=0x827f390) at fd_cmds.c:162 #12 0x0806d72b in run_job (jcr=0x827f390) at fd_cmds.c:124 #13 0x0806dee7 in run_cmd (jcr=0x827f390) at job.c:229 #14 0x08069dc3 in handle_connection_request (arg=0x827e5c8) at dircmd.c:233 #15 0x004d32c3 in workq_server (arg=0x8098ea0) at workq.c:346 #16 0x00280832 in start_thread () from /lib/libpthread.so.0 #17 0x0040ee0e in clone () from /lib/libc.so.6 (gdb)

./configure output [config.out]

Configuration on Tue Aug 31 20:02:00 BST 2010: Host: i686-pc-linux-gnu -- redhat Bacula version: Bacula 5.0.3 (04 August 2010) Source code location: . Install binaries: /sbin Install libraries: /usr/lib Install config files: /etc/bacula Scripts directory: /etc/bacula Archive directory: /tmp Working directory: /var/bacula/working PID directory: /var/run Subsys directory: /var/lock/subsys Man directory: ${datarootdir}/man Data directory: /usr/share Plugin directory: /usr/lib C Compiler: gcc 4.1.2 C++ Compiler: /usr/bin/g++ 4.1.2 Compiler flags: -g -O2 -Wall -fno-strict-aliasing -fno-exceptions -fno-rtti Linker flags: Libraries: -lpthread -ldl Statically Linked Tools: no Statically Linked FD: no Statically Linked SD: no Statically Linked DIR: no Statically Linked CONS: no Database type: MySQL Database port: Database lib: -L/usr/lib/mysql -lmysqlclient_r -lz Database name: bacula Database user: bacula Job Output Email: root@localhost Traceback Email: root@localhost SMTP Host Address: localhost Director Port: 9101 File daemon Port: 9102 Storage daemon Port: 9103 Director User: Director Group: Storage Daemon User: Storage DaemonGroup: File Daemon User: File Daemon Group: SQL binaries Directory /usr/bin Large file support: yes Bacula conio support: yes -lncurses readline support: no TCP Wrappers support: no TLS support: yes Encryption support: yes ZLIB support: yes enable-smartalloc: yes enable-lockmgr: no bat support: no enable-gnome: no enable-bwx-console: no enable-tray-monitor: no client-only: no build-dird: yes build-stored: yes Plugin support: yes AFS support: no ACL support: yes XATTR support: yes Python support: no Batch insert enabled: yes

Also below are all my configuration files

~~~~~~~~~~~~~~~~~~~~~ bacula-dir.conf ~~~~~~~~~~~~~~~~~~~~~ # # DIR Section # Director { Name = virtualbox-dir DIRport = 9101 QueryFile = "/etc/bacula/query.sql" WorkingDirectory = "/var/bacula/working" PidDirectory = "/var/run" Maximum Concurrent Jobs = 1 Password = "s93UQTCK+F8wWn5LPwctGjArfSXxrzVTifwaYilhtGy9" Messages = Daemon } # # Job Defs / File Sets # JobDefs { Name = "DefaultJob" Type = Backup Level = Incremental Client = virtualbox-fd FileSet = "Full Set" Schedule = "WeeklyCycle" Storage = DVD Messages = Standard Pool = DVDPool Priority = 10 Write Bootstrap = "/var/bacula/working/%c.bsr" } FileSet { Name = "Full Set" Include { Options { signature = MD5 } File = /usr } Exclude { File = /var/bacula/working File = /tmp File = /proc File = /tmp File = /.journal File = /.fsck } } # # Client 1 # Job { Name = "BackupClient1" JobDefs = "DefaultJob" } Client { Name = virtualbox-fd Address = virtualbox FDPort = 9102 Catalog = MyCatalog Password = "733W3Yrl4k1eFLTH6StScNm9dbtytE43n8WydTClhFJZ" File Retention = 30 days Job Retention = 6 months AutoPrune = yes Heartbeat interval = 15 Seconds } # # Schedule # Schedule { Name = "WeeklyCycle" Run = Full 1st sun at 23:05 Run = Differential 2nd-5th sun at 23:05 Run = Incremental mon-sat at 23:05 } # # Storage Deamons # Storage { Name = DVD Address = 127.0.0.1 SDPort = 9103 Password = "pb6GVBRFMHB4chitfVQTm1iRBMdMRw0O9TXrQ314x7ZT" Device = DVDStorage Media Type = DVDStor Heartbeat interval = 1 minute } # # Pools # Pool { Name = DVDPool LabelFormat = "BaculaDVD" Pool Type = Backup Recycle = no # Bacula can automatically recycle Volumes AutoPrune = yes # Prune expired volumes Volume Retention = 365 days # one year Storage = DVD } # # Defualt Catalof # Catalog { Name = MyCatalog dbname = "bacula"; dbuser = "bacula"; dbpassword = "" } # # Message Types # Messages { Name = Standard mailcommand = "/sbin/bsmtp -h localhost -f \"\(Bacula\) \<%r\>\" -s \"Bacula: %t %e of %c %l\" %r" operatorcommand = "/sbin/bsmtp -h localhost -f \"\(Bacula\) \<%r\>\" -s \"Bacula: Intervention needed for %j\" %r" mail = root@localhost = all, !skipped operator = root@localhost = mount console = all, !skipped, !saved append = "/var/bacula/working/log" = all, !skipped catalog = all } Messages { Name = Daemon mailcommand = "/sbin/bsmtp -h localhost -f \"\(Bacula\) \<%r\>\" -s \"Bacula daemon message\" %r" mail = root@localhost = all, !skipped console = all, !skipped, !saved append = "/var/bacula/working/log" = all, !skipped } # # Console Section # Console { Name = virtualbox-mon Password = "iHDZnYflxiI9vruyEG9T5lsFAD65J1Ac7GSCnkaQZXXQ" CommandACL = status, .status } ~~~~~~~~~~~~~~~~~~~~~ bacula-sd.conf ~~~~~~~~~~~~~~~~~~~~~ # # Storage # Storage { Name = virtualbox-sd SDPort = 9103 WorkingDirectory = "/var/bacula/working" Pid Directory = "/var/run" Maximum Concurrent Jobs = 20 Heartbeat interval = 1 minute } # # Which Director # Director { Name = virtualbox-dir Password = "pb6GVBRFMHB4chitfVQTm1iRBMdMRw0O9TXrQ314x7ZT" } Director { Name = virtualbox-mon Password = "iHDZnYflxiI9vruyEG9T5lsFAD65J1Ac7GSCnkaQZXXQ" Monitor = yes } # # Devices # Device { Name = DVDStorage Media Type = DVDStor Archive Device = /dev/cdrw LabelMedia = yes; Random Access = Yes; AutomaticMount = yes; RemovableMedia = yes; AlwaysOpen = no; MaximumPartSize = 1500M; RequiresMount = yes; MountPoint = /export/bacula-dvd; MountCommand = "/bin/mount -t iso9660 -o ro %a %m"; UnmountCommand = "/bin/umount %m"; SpoolDirectory = "/export/backup/bacula-dvd-spool"; WritePartCommand = "/etc/bacula/dvd-handler %a write %e %v" FreeSpaceCommand = "/etc/bacula/dvd-handler %a free" } # # Messages # Messages { Name = Standard director = virtualbox-dir = all } ~~~~~~~~~~~~~~~~~~~~~ bacula-fd.conf ~~~~~~~~~~~~~~~~~~~~~ # # Director # Director { Name = virtualbox-dir Password = "733W3Yrl4k1eFLTH6StScNm9dbtytE43n8WydTClhFJZ" } Director { Name = virtualbox-mon Password = "iHDZnYflxiI9vruyEG9T5lsFAD65J1Ac7GSCnkaQZXXQ" Monitor = yes } # # FileDaemon # FileDaemon { Name = virtualbox-fd FDport = 9102 WorkingDirectory = /var/bacula/working Pid Directory = /var/run Maximum Concurrent Jobs = 20 Heartbeat Interval = 5 seconds } # # Messages # Messages { Name = Standard director = virtualbox-dir = all, !skipped, !restored } ~~~~~~~~~~~~~~~~~~~~~ bconsole.conf ~~~~~~~~~~~~~~~~~~~~~ # # Bacula User Agent (or Console) Configuration File # Director { Name = virtualbox-dir DIRport = 9101 address = virtualbox Password = "s93UQTCK+F8wWn5LPwctGjArfSXxrzVTifwaYilhtGy9" }

All versions of software is below

[root@virtualbox ~]# lsb_release -a LSB Version: :core-3.1-ia32:core-3.1-noarch:graphics-3.1-ia32:graphics-3.1-noarch Distributor ID: CentOS Description: CentOS release 5.5 (Final) Release: 5.5 Codename: Final [root@virtualbox bacula]# uname -a Linux virtualbox 2.6.18-194.11.3.el5 #1 SMP Mon Aug 30 16:23:24 EDT 2010 i686 i686 i386 GNU/Linux [root@virtualbox bacula]# ls -l /root/bacula-5.0.3.tar.gz -rw-r--r-- 1 root root 3800556 Aug 6 08:59 /root/bacula-5.0.3.tar.gz [root@virtualbox bacula]# yum info "dvd+rw-tools" Loaded plugins: fastestmirror, priorities, protectbase Loading mirror speeds from cached hostfile * addons: mirrors.ukfast.co.uk * base: mirrors.ukfast.co.uk * extras: mirrors.ukfast.co.uk * rpmforge: fr2.rpmfind.net * updates: mirrors.ukfast.co.uk 0 packages excluded due to repository protections Installed Packages Name : dvd+rw-tools Arch : i386 Version : 7.0 Release : 1.el5 Size : 258 k Repo : installed Summary : Toolchain to master DVD+RW/+R media URL : http://fy.chalmers.se/~appro/linux/DVD+RW/ License : GPL Description: Collection of tools to master DVD+RW/+R media. For further : information see http://fy.chalmers.se/~appro/linux/DVD+RW/. [root@virtualbox bacula]#


Any Ideas? Regards,
Ben Draper

------------------------------------------------------------------------------
Start uncovering the many advantages of virtual appliances
and start using them to simplify application deployment and
accelerate your shift to cloud computing.
http://p.sf.net/sfu/novell-sfdev2dev
_______________________________________________
Bacula-users mailing list
Bacula-users AT lists.sourceforge DOT net
https://lists.sourceforge.net/lists/listinfo/bacula-users
<Prev in Thread] Current Thread [Next in Thread>