Hi,
I've been setting up a system to use Bacula for a few weeks now and
I'm having problems with the DVD burning part. I've been following
various threads and had arrived at the point of bacula stopping while
waiting for the resource for ever. However after updating to 1.38.4 I
got a lot further. In fact doing a back-up of about 4GB of data, the
first chunk of 800Mb or so got written to DVD. Then the second 800Mb
was read from the file demon and stored on the server ready for burning
as /tmp/backup/20060111-test.1 - however when it came to time to write
this second chunk something went wrong. I can't really claim to
understand all the output but the part that looks strange to me is the
reference to /dev/fd/3 - all my config files reference /dev/dvd or
/mnt/cdrom and my system doesn't even have a /dev/fd - so I can
understand that this would cause a problem, but not why it is trying to
access this in the first place.
Any help gratefully appreciated!
Andrew.
Below is all the info I could think of supplying:
================================================================================================
I am using a fresh install of Mandrake 10.1 which I have updated with
the following packages to allow me to compile bacula:
depkgs-22Jun05
dvd+rw-tools-5.21.4.10.8 (patched from latest bacula source)
ncurses-5.5
m4-1.4.4
termcap-1.3.1
and finally building bacula-beta-1.38.4-09Jan06
I am just running the storage demon on this machine, to allow use of the
DVD drive, with director and another disk-backed storage demon on a
different machine running redhat.
Here is uname -a for the Mandrake machine:
Linux pc-00001.andrewcouchman.co.uk 2.6.8.1-12mdk #1 Fri Oct 1 12:53:41
CEST 2004 i686 Pentium II (Klamath) unknown GNU/Linux
================================================================================================
Here is the bacula-sd.conf from the Mandrake machine:
#
# Default Bacula Storage Daemon Configuration file
#
# For Bacula release 1.38.2 (20 November 2005) -- mandrake for
#
# You may need to change the name of your tape drive
# on the "Archive Device" directive in the Device
# resource. If you change the Name and/or the
# "Media Type" in the Device resource, please ensure
# that dird.conf has corresponding changes.
#
Storage { # definition of myself
Name = backup-sd
SDPort = 9103 # Director's port
WorkingDirectory = "/var/bacula/working"
Pid Directory = "/var/run"
Maximum Concurrent Jobs = 20
}
#
# List Directors who are permitted to contact Storage daemon
#
Director {
Name = firewall-dir
Password = "rhgFqQxRfFWQMcLCIJIbT9vzdN4NW+BvO9bqraZsIweE"
}
#
# Restricted Director, used by tray-monitor to get the
# status of the storage daemon
#
Director {
Name = backup-mon
Password = "CvwNymV827Z2XI09zPGUl93j8iRUTORsjAsXAnjdDKfg"
Monitor = yes
}
#
# A DVD device
#
Device {
Name = "DVD-Writer"
Media Type = DVD
Archive Device = /dev/dvd
LabelMedia = yes; # lets Bacula label unlabeled media
Random Access = Yes;
AutomaticMount = yes; # when device opened, read it
RemovableMedia = yes;
AlwaysOpen = no;
MaximumPartSize = 800M;
RequiresMount = yes;
MountPoint = /mnt/cdrom;
MountCommand = "/bin/mount -t iso9660 -o ro %a %m";
UnmountCommand = "/bin/umount %m";
SpoolDirectory = /tmp/backup;
WritePartCommand = "/etc/bacula/dvd-handler %a write %e %v"
FreeSpaceCommand = "/etc/bacula/dvd-handler %a free"
}
#
# Send all messages to the Director,
# mount messages also are sent to the email address
#
Messages {
Name = Standard
director = firewall-dir = all
}
================================================================================================
Here is the bacula-dir.conf from the director machine:
#
# Default Bacula Director Configuration file
#
# The only thing that MUST be changed is to add one or more
# file or directory names in the Include directive of the
# FileSet resource.
#
# For Bacula release 1.38.2 (20 November 2005) -- redhat
#
# You might also want to change the default email address
# from root to your address. See the "mail" and "operator"
# directives in the Messages resource.
#
Director { # define myself
Name = firewall-dir
DIRport = 9101 # where we listen for UA connections
QueryFile = "/etc/bacula/query.sql"
WorkingDirectory = "/var/bacula/working"
PidDirectory = "/var/run"
Maximum Concurrent Jobs = 1
Password = "52hgapSeKw/AQVcD3Vqz99ScLe68X3xaYgz67qdDx50a" #
Console password
Messages = Daemon
}
## JobDefs
JobDefs {
Name = "DefaultJob"
Type = Backup
Level = Incremental
Client = firewall-fd
# FileSet = "Full Set"
Schedule = "WeeklyCycle"
Storage = File
Messages = Standard
Pool = Default
Priority = 10
}
## Jobs
Job {
Name = "Andrews laptop"
Client= andrew-laptop-fd
FileSet = "andrew-laptop full set"
JobDefs = "DefaultJob"
Write Bootstrap = "/var/bacula/working/andrew-laptop.bsr"
}
Job {
Name = "Andrews laptop DVD"
Client= andrew-laptop-fd
FileSet = "andrew-laptop full set"
Storage = DVD
JobDefs = "DefaultJob"
Write Bootstrap = "/var/bacula/working/andrew-laptop.bsr"
}
Job {
Name = "Alans laptop"
Client= alan-laptop-fd
FileSet = "andrew-laptop full set"
JobDefs = "DefaultJob"
Write Bootstrap = "/var/bacula/working/alan-laptop.bsr"
}
# Backup the catalog database (after the nightly save)
Job {
Name = "BackupCatalog"
JobDefs = "DefaultJob"
Level = Full
FileSet="Catalog"
Schedule = "WeeklyCycleAfterBackup"
# This creates an ASCII copy of the catalog
RunBeforeJob = "/etc/bacula/make_catalog_backup bacula bacula"
# This deletes the copy of the catalog
RunAfterJob = "/etc/bacula/delete_catalog_backup"
Write Bootstrap = "/var/bacula/working/BackupCatalog.bsr"
Priority = 11 # run after main backup
}
#
# Standard Restore template, to be changed by Console program
# Only one such job is needed for all Jobs/Clients/Storage ...
#
Job {
Name = "RestoreFiles"
Type = Restore
Client=firewall-fd
FileSet="andrew-laptop full set"
Storage = File
Pool = Default
Messages = Standard
Where = /tmp/bacula-restores
}
## FileSets
# List of files to be backed up
FileSet {
Name = "andrew-laptop full set"
Include {
Options {
signature = MD5
}
File = "c:/documents and settings/andrew"
File = c:/data
File = c:/bat
File = c:/media/photos
File = c:/work
}
Exclude {
File = c:/data/not-backed-up
}
}
FileSet {
Name = "alan-laptop full set"
Include {
Options {
signature = MD5
}
File = "c:/documents and settings/alan"
File = e:/
}
}
#
# When to do the backups, full backup on first sunday of the month,
# differential (i.e. incremental since full) every other sunday,
# and incremental backups other days
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
}
# This schedule does the catalog. It starts after the WeeklyCycle
Schedule {
Name = "WeeklyCycleAfterBackup"
Run = Full sun-sat at 23:10
}
# This is the backup of the catalog
FileSet {
Name = "Catalog"
Include {
Options {
signature = MD5
}
File = /var/bacula/working/bacula.sql
}
}
## Clients
Client {
Name = firewall-fd
Address = firewall
FDPort = 9102
Catalog = MyCatalog
Password = "D9RKA5zIVyof9fOi5vwRdm/VI+nYcK+FNKS6kEPrnAgs2" #
password for FileDaemon
File Retention = 30 days # 30 days
Job Retention = 6 months # six months
AutoPrune = yes # Prune expired Jobs/Files
}
Client {
Name = andrew-laptop-fd
Address = andrew-laptop
FDPort = 9102
Catalog = MyCatalog
Password = "p04ELowI8XwBA0k6nqbYztwqTj5vGVcym15LpO+zULbU" #
password for FileDaemon
File Retention = 30 days # 30 days
Job Retention = 6 months # six months
AutoPrune = yes # Prune expired Jobs/Files
}
Client {
Name = alan-laptop-fd
Address = alan
FDPort = 9102
Catalog = MyCatalog
Password = "p04ELowI8XwBA0k6nqbYztwqTj5vGVcym15LpO+zULbU" #
password for FileDaemon
File Retention = 30 days # 30 days
Job Retention = 6 months # six months
AutoPrune = yes # Prune expired Jobs/Files
}
#
# Second Client (File Services) to backup
# You should change Name, Address, and Password before using
#
#Client {
# Name = firewall2-fd
# Address = firewall2
# FDPort = 9102
# Catalog = MyCatalog
# Password = "D9RKA5zIVyof9fOi5vwRdm/VI+nYcK+FNKS6kEPrnAgs2" #
password for FileDaemon 2
# File Retention = 30 days # 30 days
# Job Retention = 6 months # six months
# AutoPrune = yes # Prune expired Jobs/Files
#}
# Definition of file storage device
Storage {
Name = File
# Do not use "localhost" here
Address = firewall # N.B. Use a fully qualified name here
SDPort = 9103
Password = "rhgFqQxRfFWQMcLCIJIbT9vzdN4NW+BvO9bqraZsIweE"
Device = FileStorage
Media Type = File
}
# Definition of DDS tape storage device
#Storage {
# Name = DDS-4
# Do not use "localhost" here
# Address = firewall # N.B. Use a fully qualified name here
# SDPort = 9103
# Password = "rhgFqQxRfFWQMcLCIJIbT9vzdN4NW+BvO9bqraZsIweE" #
password for Storage daemon
# Device = DDS-4 # must be same as Device in
Storage daemon
# Media Type = DDS-4 # must be same as MediaType in
Storage daemon
# Autochanger = yes # enable for autochanger device
#}
# Definition of 8mm tape storage device
#Storage {
# Name = "8mmDrive"
# Do not use "localhost" here
# Address = firewall # N.B. Use a fully qualified name here
# SDPort = 9103
# Password = "rhgFqQxRfFWQMcLCIJIbT9vzdN4NW+BvO9bqraZsIweE"
# Device = "Exabyte 8mm"
# MediaType = "8mm"
#}
# Definition of DVD storage device
Storage {
Name = "DVD"
Address = backup
SDPort = 9103
Password = "rhgFqQxRfFWQMcLCIJIbT9vzdN4NW+BvO9bqraZsIweE"
Device = "DVD-Writer"
MediaType = "DVD"
}
# Generic catalog service
Catalog {
Name = MyCatalog
dbname = bacula; user = bacula; password = ""
}
# Reasonable message delivery -- send most everything to email address
# and to the console
Messages {
Name = Standard
#
# NOTE! If you send to two email or more email addresses, you will need
# to replace the %r in the from field (-f part) with a single valid
# email address in both the mailcommand and the operatorcommand.
#
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 = [EMAIL PROTECTED] = all, !skipped
operator = [EMAIL PROTECTED] = mount
console = all, !skipped, !saved
#
# WARNING! the following will create a file that you must cycle from
# time to time as it will grow indefinitely. However, it will
# also keep all your messages if they scroll off the console.
#
append = "/var/bacula/working/log" = all, !skipped
}
#
# Message delivery for daemon messages (no job).
Messages {
Name = Daemon
mailcommand = "/sbin/bsmtp -h localhost -f \"\(Bacula\) %r\" -s
\"Bacula daemon message\" %r"
mail = [EMAIL PROTECTED] = all, !skipped
console = all, !skipped, !saved
append = "/var/bacula/working/log" = all, !skipped
}
# Default pool definition
Pool {
Name = Default
Pool Type = Backup
Recycle = yes # Bacula can automatically recycle
Volumes
AutoPrune = yes # Prune expired volumes
Volume Retention = 365 days # one year
Accept Any Volume = yes # write on any volume in the pool
}
#
# Restricted console used by tray-monitor to get the status of the director
#
Console {
Name = firewall-mon
Password = "J8/nsrOtApEieD/tCWRtZ/tLvWSp6PB7gX0ChFpXMhxp"
CommandACL = status, .status
}
================================================================================================
And finally here is the debug output from the storage demon when it failed:
[EMAIL PROTECTED] bacula]# ./bacula start -d100
Starting the Bacula Storage daemon
bacula-sd: stored_conf.c:613 Inserting director res: backup-mon
backup-sd: jcr.c:113 read_last_jobs seek to 188
backup-sd: jcr.c:120 Read num_items=2
backup-sd: stored.c:451 calling init_dev /dev/dvd
backup-sd: dev.c:242 init_dev: tape=0 dev_name=/dev/dvd
backup-sd: stored.c:453 SD init done /dev/dvd
backup-sd: bnet_server.c:83 Addresses host[ipv4:0.0.0.0:9103]
backup-sd: bnet.c:1128 who=client host=192.168.91.2 port=36643
backup-sd: cram-md5.c:52 send: auth cram-md5
<[EMAIL PROTECTED]> ssl=0
backup-sd: cram-md5.c:68 Authenticate OK 95lPl9/XSR+7+U/dq4/cSC
backup-sd: cram-md5.c:97 cram-get: auth cram-md5
<[EMAIL PROTECTED]> ssl=0
backup-sd: cram-md5.c:114 sending resp to challenge: fy+Q55ID6mJzh6/G5/5OGC
backup-sd: dircmd.c:187 Message channel init completed.
backup-sd: job.c:70 <dird: JobId=54
job=Andrews_laptop_DVD.2006-01-11_11.12.34 job_name=AndrewslaptopDVD
client_name=andrew-laptop-fd type=66 level=70
FileSet=andrew-laptopfullset NoAttr=0 SpoolAttr=0
FileSetMD5=78/Vx+Vy8QkL57QJTX/c4D SpoolData=0 WritePartAfterJob=0
PreferMountedVols=1
backup-sd: job.c:123 >dird: 3000 OK Job SDid=1 SDtime=1136977947
Authorization=NOCC-OGCB-DALL-FCLB-OJHO-CANL-ALGN-NNFO
backup-sd: reserve.c:319 <dird: use storage=DVD media_type=DVD
pool_name=Default pool_type=Backup append=1 copy=0 stripe=0
backup-sd: reserve.c:342 <dird device: use device=DVD-Writer
backup-sd: reserve.c:359 Storage=DVD media_type=DVD pool=Default
pool_type=Backup
backup-sd: reserve.c:361 Device=DVD-Writer
backup-sd: reserve.c:416 PrefMnt=1 exact=1 suitable=0 chgronly=0 any=0
backup-sd: reserve.c:499 PrefMnt=1 exact=1 suitable=0 chgronly=0
backup-sd: reserve.c:540 Search res for DVD-Writer
backup-sd: reserve.c:628 Try reserve DVD-Writer jobid=54
backup-sd: askdir.c:242 >dird: CatReq
Job=Andrews_laptop_DVD.2006-01-11_11.12.34 FindMedia=1 pool_name=Default
media_type=DVD
backup-sd: askdir.c:165 <dird 1901 No Media.
backup-sd: askdir.c:177 Bad response from Dir fields=-1: 1901 No Media.
backup-sd: reserve.c:648 No next volume found
backup-sd: reserve.c:756 reserve_append device is disk
backup-sd: reserve.c:787 PrefMnt=1 exact=1 suitable=1 chgronly=0 any=0
backup-sd: reserve.c:879 OK Dev avail reserved "DVD-Writer" (/dev/dvd)
JobId=54
backup-sd: reserve.c:766 Inc reserve=1 dev="DVD-Writer" (/dev/dvd) 0x80a7508
backup-sd: reserve.c:657 Reserved=1 dev_name=DVD-Writer mediatype=DVD
pool=Default ok=1
backup-sd: reserve.c:583 >dird dev: 3000 OK use device device=DVD-Writer
backup-sd: reserve.c:510 Suitable device found=DVD-Writer
backup-sd: job.c:155 Andrews_laptop_DVD.2006-01-11_11.12.34 waiting on
FD to contact SD
backup-sd: bnet.c:1128 who=client host=192.168.91.40 port=36643
backup-sd: cram-md5.c:52 send: auth cram-md5
<[EMAIL PROTECTED]> ssl=0
backup-sd: cram-md5.c:68 Authenticate OK pU8oZ4/0s7ZOd1/HCC+BBA
backup-sd: cram-md5.c:97 cram-get: auth cram-md5
<[EMAIL PROTECTED]> ssl=0
backup-sd: cram-md5.c:114 sending resp to challenge: L5/p08+cJ6dCO//w670wKC
backup-sd: job.c:173 Running job Andrews_laptop_DVD.2006-01-11_11.12.34
backup-sd: append.c:58 Start append data. res=1
backup-sd: askdir.c:242 >dird: CatReq
Job=Andrews_laptop_DVD.2006-01-11_11.12.34 FindMedia=1 pool_name=Default
media_type=DVD
backup-sd: askdir.c:165 <dird 1901 No Media.
backup-sd: askdir.c:177 Bad response from Dir fields=-1: 1901 No Media.
backup-sd: askdir.c:242 >dird: CatReq
Job=Andrews_laptop_DVD.2006-01-11_11.12.34 FindMedia=1 pool_name=Default
media_type=DVD
backup-sd: askdir.c:165 <dird 1901 No Media.
backup-sd: askdir.c:177 Bad response from Dir fields=-1: 1901 No Media.
backup-sd: wait.c:51 Enter blocked=BST_DOING_ACQUIRE
backup-sd: bnet.c:1128 who=client host=192.168.91.2 port=36643
backup-sd: cram-md5.c:52 send: auth cram-md5
<[EMAIL PROTECTED]> ssl=0
backup-sd: cram-md5.c:68 Authenticate OK 0D++09ZH8+5MBWg791/XoB
backup-sd: cram-md5.c:97 cram-get: auth cram-md5
<[EMAIL PROTECTED]> ssl=0
backup-sd: cram-md5.c:114 sending resp to challenge: e6/bQ++Gf6/JUDQxkU+69A
backup-sd: dircmd.c:187 Message channel init completed.
backup-sd: dircmd.c:513 Found device DVD-Writer
backup-sd: dircmd.c:551 Found changer device DVD-Writer
backup-sd: dircmd.c:395 Stole device "DVD-Writer" (/dev/dvd) lock,
writing label.
backup-sd: dev.c:277 open dev: tape=0 dev_name="DVD-Writer" (/dev/dvd)
vol=20060111-test mode=OPEN_READ_WRITE
backup-sd: dev.c:283 call open_dvd_device mode=OPEN_READ_WRITE
backup-sd: dev.c:470 Enter: open_dvd_dev: DVD dev= mode=OPEN_READ_WRITE
backup-sd: dev.c:487 open_dvd_device: num_parts=0, VolCatInfo.VolCatParts=0
backup-sd: dvd.c:78 Enter mount_dev
backup-sd: dvd.c:152 Device "DVD-Writer" (/dev/dvd) cannot be mounted.
ERR=mount: wrong fs type, bad option, bad superblock on /dev/dvd,
or too many mounted file systems
backup-sd: dvd.c:196 open_mounted_dev: got 0 files in the mount point
(not counting ., .. and .keep)
backup-sd: dvd.c:78 Enter mount_dev
backup-sd: dvd.c:152 Device "DVD-Writer" (/dev/dvd) cannot be mounted.
ERR=mount: wrong fs type, bad option, bad superblock on /dev/dvd,
or too many mounted file systems
backup-sd: dvd.c:196 open_mounted_dev: got 0 files in the mount point
(not counting ., .. and .keep)
backup-sd: dvd.c:248 update_free_space_dev: cmd=/etc/bacula/dvd-handler
/dev/dvd free
backup-sd: dvd.c:257 Free space program run : 4695588864
No Error reported.
backup-sd: dvd.c:292 update_free_space_dev: free_space=4695588864
freespace_ok=1 free_space_errno=0 have_media=1
backup-sd: dev.c:514 Could not mount device "DVD-Writer" (/dev/dvd),
this is not a problem (num_parts == 0), and have media.
backup-sd: dev.c:533 open dev: DVD dev= mode=OPEN_READ_WRITE part=0
npart=0 volcatnparts=0
backup-sd: dev.c:535 openmode=2 OPEN_READ_WRITE
backup-sd: dvd.c:69 Exit make_dvd_filename: arch=/tmp/backup/20060111-test
backup-sd: dev.c:552 mode=OPEN_READ_WRITE
open(/tmp/backup/20060111-test, 0x42, 0640)
backup-sd: dev.c:576 after open fd=7
backup-sd: dvd.c:559 Enter lseek_dev fd=7 part=0 nparts=0
backup-sd: dvd.c:601 lseek_dev SEEK_CUR to 0
backup-sd: dvd.c:607 lseek_dev SEEK_CUR returns 0
backup-sd: label.c:71 Enter read_volume_label res=1 device="DVD-Writer"
(/dev/dvd) vol=20060111-test dev_Vol=*NULL*
backup-sd: dev.c:621 rewind res=1 fd=7 "DVD-Writer" (/dev/dvd)
backup-sd: dvd.c:559 Enter lseek_dev fd=7 part=0 nparts=0
backup-sd: dvd.c:569 lseek_dev SEEK_SET to 0 (part_start=0)
backup-sd: label.c:138 Big if statement in read_volume_label
backup-sd: label.c:143 Requested Volume "20060111-test" on "DVD-Writer"
(/dev/dvd) is not a Bacula labeled Volume, because: ERR=block.c:953 Read
zero bytes at 0:0 on device "DVD-Writer" (/dev/dvd).
backup-sd: dev.c:621 rewind res=1 fd=7 "DVD-Writer" (/dev/dvd)
backup-sd: dvd.c:559 Enter lseek_dev fd=7 part=0 nparts=0
backup-sd: dvd.c:569 lseek_dev SEEK_SET to 0 (part_start=0)
backup-sd: label.c:299 write_volume_label()
backup-sd: dev.c:621 rewind res=1 fd=7 "DVD-Writer" (/dev/dvd)
backup-sd: dvd.c:559 Enter lseek_dev fd=7 part=0 nparts=0
backup-sd: dvd.c:569 lseek_dev SEEK_SET to 0 (part_start=0)
backup-sd: label.c:538 Start create_volume_label()
Volume Label:
Id : Bacula 1.0 immortal
VerNo : 11
VolName : 20060111-test
PrevVolName :
VolFile : 0
LabelType : PRE_LABEL
LabelSize : 0
PoolName : Default
MediaType : DVD
PoolType : Backup
HostName : pc-00001.andrewcouchman.co.uk
Date label written: 11-Jan-2006 11:13
backup-sd: label.c:341 Wrote label of 191 bytes to "DVD-Writer" (/dev/dvd)
backup-sd: label.c:344 Call write_block_to_dev()
backup-sd: label.c:349 Wrote block to device
backup-sd: dev.c:1504 weof_dev
Volume Label:
Id : Bacula 1.0 immortal
VerNo : 11
VolName : 20060111-test
PrevVolName :
VolFile : 0
LabelType : PRE_LABEL
LabelSize : 0
PoolName : Default
MediaType : DVD
PoolType : Backup
HostName : pc-00001.andrewcouchman.co.uk
Date label written: 11-Jan-2006 11:13
backup-sd: device.c:322 Force close_dev "DVD-Writer" (/dev/dvd)
backup-sd: dev.c:1685 really close_dev "DVD-Writer" (/dev/dvd)
backup-sd: dvd.c:93 Enter unmount_dev
backup-sd: dircmd.c:513 Found device DVD-Writer
backup-sd: dircmd.c:551 Found changer device DVD-Writer
backup-sd: dircmd.c:576 mount cmd blocked=2
backup-sd: dircmd.c:580 Waiting for mount. Attempting to wake thread
backup-sd: askdir.c:451 Back from wait_for_sysop stat=4
backup-sd: askdir.c:473 Someone woke me for device "DVD-Writer" (/dev/dvd)
backup-sd: askdir.c:242 >dird: CatReq
Job=Andrews_laptop_DVD.2006-01-11_11.12.34 FindMedia=1 pool_name=Default
media_type=DVD
backup-sd: askdir.c:165 <dird 1000 OK VolName=20060111-test VolJobs=0
VolFiles=0 VolBlocks=0 VolBytes=1 VolMounts=0 VolErrors=0 VolWrites=0
MaxVolBytes=0 VolCapacityBytes=0 VolStatus=Append Slot=0 MaxVolJobs=0
MaxVolFiles=0 InChanger=1 VolReadTime=0 VolWriteTime=0 EndFile=0
EndBlock=0 VolParts=0 LabelType=0
backup-sd: askdir.c:242 >dird: CatReq
Job=Andrews_laptop_DVD.2006-01-11_11.12.34 FindMedia=1 pool_name=Default
media_type=DVD
backup-sd: askdir.c:165 <dird 1000 OK VolName=20060111-test VolJobs=0
VolFiles=0 VolBlocks=0 VolBytes=1 VolMounts=0 VolErrors=0 VolWrites=0
MaxVolBytes=0 VolCapacityBytes=0 VolStatus=Append Slot=0 MaxVolJobs=0
MaxVolFiles=0 InChanger=1 VolReadTime=0 VolWriteTime=0 EndFile=0
EndBlock=0 VolParts=0 LabelType=0
backup-sd: dev.c:277 open dev: tape=0 dev_name="DVD-Writer" (/dev/dvd)
vol=20060111-test mode=OPEN_READ_WRITE
backup-sd: dev.c:283 call open_dvd_device mode=OPEN_READ_WRITE
backup-sd: dev.c:470 Enter: open_dvd_dev: DVD dev= mode=OPEN_READ_WRITE
backup-sd: dev.c:487 open_dvd_device: num_parts=0, VolCatInfo.VolCatParts=0
backup-sd: dvd.c:78 Enter mount_dev
backup-sd: dvd.c:152 Device "DVD-Writer" (/dev/dvd) cannot be mounted.
ERR=mount: wrong fs type, bad option, bad superblock on /dev/dvd,
or too many mounted file systems
backup-sd: dvd.c:196 open_mounted_dev: got 0 files in the mount point
(not counting ., .. and .keep)
backup-sd: dvd.c:78 Enter mount_dev
backup-sd: dvd.c:152 Device "DVD-Writer" (/dev/dvd) cannot be mounted.
ERR=mount: wrong fs type, bad option, bad superblock on /dev/dvd,
or too many mounted file systems
backup-sd: dvd.c:196 open_mounted_dev: got 0 files in the mount point
(not counting ., .. and .keep)
backup-sd: dvd.c:248 update_free_space_dev: cmd=/etc/bacula/dvd-handler
/dev/dvd free
backup-sd: dvd.c:257 Free space program run : 4695588864
No Error reported.
backup-sd: dvd.c:292 update_free_space_dev: free_space=4695588864
freespace_ok=1 free_space_errno=0 have_media=1
backup-sd: dev.c:514 Could not mount device "DVD-Writer" (/dev/dvd),
this is not a problem (num_parts == 0), and have media.
backup-sd: dev.c:533 open dev: DVD dev= mode=OPEN_READ_WRITE part=0
npart=0 volcatnparts=0
backup-sd: dev.c:535 openmode=2 OPEN_READ_WRITE
backup-sd: dvd.c:69 Exit make_dvd_filename: arch=/tmp/backup/20060111-test
backup-sd: dev.c:552 mode=OPEN_READ_WRITE
open(/tmp/backup/20060111-test, 0x42, 0640)
backup-sd: dev.c:576 after open fd=6
backup-sd: dvd.c:559 Enter lseek_dev fd=6 part=0 nparts=0
backup-sd: dvd.c:601 lseek_dev SEEK_CUR to 0
backup-sd: dvd.c:607 lseek_dev SEEK_CUR returns 0
backup-sd: label.c:71 Enter read_volume_label res=1 device="DVD-Writer"
(/dev/dvd) vol=20060111-test dev_Vol=*NULL*
backup-sd: dev.c:621 rewind res=1 fd=6 "DVD-Writer" (/dev/dvd)
backup-sd: dvd.c:559 Enter lseek_dev fd=6 part=0 nparts=0
backup-sd: dvd.c:569 lseek_dev SEEK_SET to 0 (part_start=0)
backup-sd: label.c:138 Big if statement in read_volume_label
backup-sd: label.c:206 Compare Vol names: VolName=20060111-test
hdr=20060111-test
backup-sd: label.c:222 Copy vol_name=20060111-test
Volume Label:
Id : Bacula 1.0 immortal
VerNo : 11
VolName : 20060111-test
PrevVolName :
VolFile : 0
LabelType : PRE_LABEL
LabelSize : 191
PoolName : Default
MediaType : DVD
PoolType : Backup
HostName : pc-00001.andrewcouchman.co.uk
Date label written: 11-Jan-2006 11:13
backup-sd: label.c:227 Leave read_volume_label() VOL_OK
backup-sd: dev.c:621 rewind res=1 fd=6 "DVD-Writer" (/dev/dvd)
backup-sd: dvd.c:559 Enter lseek_dev fd=6 part=0 nparts=0
backup-sd: dvd.c:569 lseek_dev SEEK_SET to 0 (part_start=0)
backup-sd: label.c:262 write Label in write_volume_label_to_block()
backup-sd: label.c:276 Wrote label of 191 bytes to block
backup-sd: dev.c:621 rewind res=1 fd=6 "DVD-Writer" (/dev/dvd)
backup-sd: dvd.c:559 Enter lseek_dev fd=6 part=0 nparts=0
backup-sd: dvd.c:569 lseek_dev SEEK_SET to 0 (part_start=0)
backup-sd: askdir.c:294 Update cat VolFiles=0
backup-sd: askdir.c:313 >dird: CatReq
Job=Andrews_laptop_DVD.2006-01-11_11.12.34 UpdateMedia
VolName=20060111-test VolJobs=0 VolFiles=0 VolBlocks=0 VolBytes=1
VolMounts=1 VolErrors=0 VolWrites=1 MaxVolBytes=0 EndTime=1136977997
VolStatus=Append Slot=0 relabel=1 InChanger=1 VolReadTime=0
VolWriteTime=0 VolParts=0
backup-sd: askdir.c:165 <dird 1000 OK VolName=20060111-test VolJobs=0
VolFiles=0 VolBlocks=0 VolBytes=1 VolMounts=1 VolErrors=0 VolWrites=1
MaxVolBytes=0 VolCapacityBytes=0 VolStatus=Append Slot=0 MaxVolJobs=0
MaxVolFiles=0 InChanger=1 VolReadTime=0 VolWriteTime=0 EndFile=0
EndBlock=0 VolParts=0 LabelType=0
backup-sd: acquire.c:394 Dec reserve=0
backup-sd: append.c:81 Begin append device="DVD-Writer" (/dev/dvd)
backup-sd: append.c:86 Just after acquire_device_for_append
backup-sd: label.c:636 session_label record=80aa660
backup-sd: label.c:692 Write sesson_label record JobId=54 FI=SOS_LABEL
SessId=1 Strm=54 len=189 remainder=0
backup-sd: label.c:696 Leave write_session_label Block=226 File=0
backup-sd: dvd.c:411 Enter: ==== open_next_part part=0 npart=0
dev="DVD-Writer" (/dev/dvd) vol=20060111-test mode=2 file_addr=838849690
backup-sd: dvd.c:342 dvd_write_part: device is "DVD-Writer" (/dev/dvd),
part is 0, is_mounted=0
backup-sd: dvd.c:69 Exit make_dvd_filename: arch=/tmp/backup/20060111-test
backup-sd: dvd.c:370 dvd_write_part: cmd=/etc/bacula/dvd-handler
/dev/dvd write 1 /tmp/backup/20060111-test timeout=16000
backup-sd: dvd.c:69 Exit make_dvd_filename: arch=/tmp/backup/20060111-test
backup-sd: dvd.c:388 unlink(/tmp/backup/20060111-test)
backup-sd: dvd.c:78 Enter mount_dev
backup-sd: dvd.c:78 Enter mount_dev
backup-sd: dvd.c:248 update_free_space_dev: cmd=/etc/bacula/dvd-handler
/dev/dvd free
backup-sd: dvd.c:257 Free space program run : 3856367616
No Error reported.
backup-sd: dvd.c:292 update_free_space_dev: free_space=3856367616
freespace_ok=1 free_space_errno=0 have_media=1
backup-sd: dvd.c:449 part=1 num_parts=1
backup-sd: dvd.c:500 Call dev->open(vol=20060111-test, mode=2
backup-sd: dev.c:277 open dev: tape=0 dev_name="DVD-Writer" (/dev/dvd)
vol=20060111-test mode=OPEN_READ_WRITE
backup-sd: dev.c:283 call open_dvd_device mode=OPEN_READ_WRITE
backup-sd: dev.c:470 Enter: open_dvd_dev: DVD dev= mode=OPEN_READ_WRITE
backup-sd: dev.c:487 open_dvd_device: num_parts=1, VolCatInfo.VolCatParts=0
backup-sd: dvd.c:78 Enter mount_dev
backup-sd: dev.c:533 open dev: DVD dev= mode=OPEN_READ_WRITE part=1
npart=1 volcatnparts=0
backup-sd: dev.c:535 openmode=2 OPEN_READ_WRITE
backup-sd: dvd.c:69 Exit make_dvd_filename: arch=/tmp/backup/20060111-test.1
backup-sd: dev.c:552 mode=OPEN_READ_WRITE
open(/tmp/backup/20060111-test.1, 0x42, 0640)
backup-sd: dev.c:576 after open fd=6
backup-sd: dvd.c:559 Enter lseek_dev fd=6 part=1 nparts=1
backup-sd: dvd.c:601 lseek_dev SEEK_CUR to 0
backup-sd: dvd.c:607 lseek_dev SEEK_CUR returns 838849917
backup-sd: askdir.c:294 Update cat VolFiles=0
backup-sd: askdir.c:313 >dird: CatReq
Job=Andrews_laptop_DVD.2006-01-11_11.12.34 UpdateMedia
VolName=20060111-test VolJobs=0 VolFiles=0 VolBlocks=13003
VolBytes=838849464 VolMounts=1 VolErrors=0 VolWrites=13004 MaxVolBytes=0
EndTime=1136979013 VolStatus=Append Slot=0 relabel=0 InChanger=1
VolReadTime=0 VolWriteTime=0 VolParts=1
backup-sd: askdir.c:165 <dird 1000 OK VolName=20060111-test VolJobs=0
VolFiles=0 VolBlocks=13003 VolBytes=838849464 VolMounts=1 VolErrors=0
VolWrites=13004 MaxVolBytes=0 VolCapacityBytes=0 VolStatus=Append Slot=0
MaxVolJobs=0 MaxVolFiles=0 InChanger=1 VolReadTime=0 VolWriteTime=0
EndFile=0 EndBlock=0 VolParts=1 LabelType=0
backup-sd: dev.c:1504 weof_dev
backup-sd: askdir.c:346 >dird: CatReq
Job=Andrews_laptop_DVD.2006-01-11_11.12.34 CreateJobMedia FirstIndex=1
LastIndex=15540 StartFile=0 EndFile=0 StartBlock=227 EndBlock=999936362
Copy=0 Strip=0
backup-sd: askdir.c:353 <dir: 1000 OK CreateJobMedia
backup-sd: askdir.c:294 Update cat VolFiles=0
backup-sd: askdir.c:313 >dird: CatReq
Job=Andrews_laptop_DVD.2006-01-11_11.12.34 UpdateMedia
VolName=20060111-test VolJobs=0 VolFiles=0 VolBlocks=15500
VolBytes=999935910 VolMounts=1 VolErrors=0 VolWrites=15501 MaxVolBytes=0
EndTime=1136979161 VolStatus=Append Slot=0 relabel=0 InChanger=1
VolReadTime=0 VolWriteTime=0 VolParts=1
backup-sd: askdir.c:165 <dird 1000 OK VolName=20060111-test VolJobs=0
VolFiles=0 VolBlocks=15500 VolBytes=999935910 VolMounts=1 VolErrors=0
VolWrites=15501 MaxVolBytes=0 VolCapacityBytes=0 VolStatus=Append Slot=0
MaxVolJobs=0 MaxVolFiles=0 InChanger=1 VolReadTime=0 VolWriteTime=0
EndFile=0 EndBlock=999936362 VolParts=1 LabelType=0
backup-sd: block.c:759 dir_update_volume_info max file size -- OK
backup-sd: dvd.c:411 Enter: ==== open_next_part part=1 npart=1
dev="DVD-Writer" (/dev/dvd) vol=20060111-test mode=2 file_addr=1677699402
backup-sd: dvd.c:342 dvd_write_part: device is "DVD-Writer" (/dev/dvd),
part is 1, is_mounted=32768
backup-sd: dvd.c:69 Exit make_dvd_filename: arch=/tmp/backup/20060111-test.1
backup-sd: dvd.c:370 dvd_write_part: cmd=/etc/bacula/dvd-handler
/dev/dvd write 0 /tmp/backup/20060111-test.1 timeout=2727
backup-sd: dvd.c:376 dvd.c:375 Error while writing current part to the
DVD: Running /usr/bin/growisofs -use-the-force-luke=notray -quiet
-use-the-force-luke=4gms -A 'Bacula Data' -input-charset=default
-iso-level 3 -pad -p 'dvd-handler / growisofs' -sysid 'BACULADATA' -R -M
/dev/dvd /tmp/backup/20060111-test.1
Executing 'mkisofs -quiet -A Bacula Data -input-charset=default
-iso-level 3 -pad -p dvd-handler / growisofs -sysid BACULADATA -R -C
16,409776 -M /dev/fd/3 /tmp/backup/20060111-test.1 | builtin_dd
of=/dev/dvd obs=32k seek=25611'
mkisofs: No such file or directory. Cannot open '/dev/fd/3'. Cannot open
SCSI driver.
mkisofs: No such file or directory. Unable to open previous session
image /dev/fd/3
:-( mkisofs has failed: 2
Error while writing part file: /usr/bin/growisofs
-use-the-force-luke=notray -quiet -use-the-force-luke=4gms -A 'Bacula
Data' -input-charset=default -iso-level 3 -pad -p 'dvd-handler /
growisofs' -sysid 'BACULADATA' -R -M /dev/dvd
/tmp/backup/20060111-test.1 exited with status 1, signal/status 256 ||
errno = 1 (Operation not permitted)
backup-sd: askdir.c:294 Update cat VolFiles=0
backup-sd: askdir.c:313 >dird: CatReq
Job=Andrews_laptop_DVD.2006-01-11_11.12.34 UpdateMedia
VolName=20060111-test VolJobs=0 VolFiles=0 VolBlocks=15500
VolBytes=999935910 VolMounts=1 VolErrors=0 VolWrites=15501 MaxVolBytes=0
EndTime=1136979720 VolStatus=Error Slot=0 relabel=0 InChanger=1
VolReadTime=0 VolWriteTime=0 VolParts=1
backup-sd: askdir.c:165 <dird 1000 OK VolName=20060111-test VolJobs=0
VolFiles=0 VolBlocks=15500 VolBytes=999935910 VolMounts=1 VolErrors=0
VolWrites=15501 MaxVolBytes=0 VolCapacityBytes=0 VolStatus=Error Slot=0
MaxVolJobs=0 MaxVolFiles=0 InChanger=1 VolReadTime=0 VolWriteTime=0
EndFile=0 EndBlock=999936362 VolParts=1 LabelType=0
backup-sd: dvd.c:437 Error in dvd_write part.
backup-sd: append.c:205 Got write_block_to_dev error on device
"DVD-Writer" (/dev/dvd). dvd.c:375 Error while writing current part to
the DVD: Running /usr/bin/growisofs -use-the-force-luke=notray -quiet
-use-the-force-luke=4gms -A 'Bacula Data' -input-charset=default
-iso-level 3 -pad -p 'dvd-handler / growisofs' -sysid 'BACULADATA' -R -M
/dev/dvd /tmp/backup/20060111-test.1
Executing 'mkisofs -quiet -A Bacula Data -input-charset=default
-iso-level 3 -pad -p dvd-handler / growisofs -sysid BACULADATA -R -C
16,409776 -M /dev/fd/3 /tmp/backup/20060111-test.1 | builtin_dd
of=/dev/dvd obs=32k seek=25611'
mkisofs: No such file or directory. Cannot open '/dev/fd/3'. Cannot open
SCSI driver.
mkisofs: No such file or directory. Unable to open previous session
image /dev/fd/3
:-( mkisofs has failed: 2
Error while writing part file: /usr/bin/growisofs
-use-the-force-luke=notray -quiet -use-the-force-luke=4gms -A 'Bacula
Data' -input-charset=default -iso-level 3 -pad -p 'dvd-handler /
growisofs' -sysid 'BACULADATA' -R -M /dev/dvd
/tmp/backup/20060111-test.1 exited with status 1, signal/status 256 ||
errno = 1 (Operation not permitted)
backup-sd: acquire.c:430 release_device device is disk
backup-sd: acquire.c:453 There are 0 writers in release_device
backup-sd: acquire.c:455 dir_create_jobmedia_record. Release
backup-sd: askdir.c:346 >dird: CatReq
Job=Andrews_laptop_DVD.2006-01-11_11.12.34 CreateJobMedia
FirstIndex=15540 LastIndex=16060 StartFile=0 EndFile=0
StartBlock=999936363 EndBlock=1677699401 Copy=0 Strip=0
backup-sd: askdir.c:353 <dir: 1000 OK CreateJobMedia
backup-sd: acquire.c:469 dir_update_vol_info. Release0
backup-sd: askdir.c:294 Update cat VolFiles=0
backup-sd: askdir.c:313 >dird: CatReq
Job=Andrews_laptop_DVD.2006-01-11_11.12.34 UpdateMedia
VolName=20060111-test VolJobs=1 VolFiles=0 VolBlocks=15500
VolBytes=999935910 VolMounts=1 VolErrors=0 VolWrites=15501 MaxVolBytes=0
EndTime=1136979720 VolStatus=Error Slot=0 relabel=0 InChanger=1
VolReadTime=0 VolWriteTime=0 VolParts=1
backup-sd: askdir.c:165 <dird 1000 OK VolName=20060111-test VolJobs=1
VolFiles=0 VolBlocks=15500 VolBytes=999935910 VolMounts=1 VolErrors=0
VolWrites=15501 MaxVolBytes=0 VolCapacityBytes=0 VolStatus=Error Slot=0
MaxVolJobs=0 MaxVolFiles=0 InChanger=1 VolReadTime=0 VolWriteTime=0
EndFile=0 EndBlock=1677699401 VolParts=1 LabelType=0
backup-sd: dev.c:1685 really close_dev "DVD-Writer" (/dev/dvd)
backup-sd: dvd.c:93 Enter unmount_dev
backup-sd: dvd.c:152 Device "DVD-Writer" (/dev/dvd) cannot be mounted.
ERR=umount: /mnt/cdrom: not mounted
backup-sd: dvd.c:196 open_mounted_dev: got 0 files in the mount point
(not counting ., .. and .keep)
backup-sd: dev.c:1691 Cannot unmount device "DVD-Writer" (/dev/dvd).
backup-sd: dev.c:1699 Call make_dvd_filename. Vol=20060111-test
backup-sd: dvd.c:69 Exit make_dvd_filename: arch=/tmp/backup/20060111-test.1
backup-sd: append.c:307 return from do_append_data() ok=0
================================================================================================
-------------------------------------------------------
This SF.net email is sponsored by: Splunk Inc. Do you grep through log files
for problems? Stop! Download the new AJAX search engine that makes
searching your log files as easy as surfing the web. DOWNLOAD SPLUNK!
http://ads.osdn.com/?ad_id=7637&alloc_id=16865&op=click
_______________________________________________
Bacula-users mailing list
Bacula-users@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/bacula-users
