Hi Philipp, her is the SD Trace.
bareos-sd: stored/stored_conf.c:917-0 Inserting director res: backup2-mon bareos-sd: stored/stored_conf.c:917-0 Inserting device res: FileStorageConvent bareos-sd: stored/stored_conf.c:917-0 Inserting device res: FileStorageVerwaltung backup2-sd: lib/jcr.c:141-0 read_last_jobs seek to 192 backup2-sd: lib/jcr.c:148-0 Read num_items=10 backup2-sd: lib/crypto_cache.c:55-0 Could not open crypto cache file. C:\Windows\TEMP/bareos-sd.9103.cryptoc ERR=No such file or directory backup2-sd: lib/bnet_server_tcp.c:166-0 Addresses host[ipv4;0.0.0.0;9103] backup2-sd: stored/stored.c:609-0 calling init_dev G:/bareos-storage backup2-sd: stored/dev.c:377-0 init_dev: tape=0 dev_name=G:/bareos-storage backup2-sd: stored/dev.c:379-0 dev=G:/bareos-storage dev_max_bs=0 max_bs=0 backup2-sd: stored/stored.c:611-0 SD init done G:/bareos-storage backup2-sd: stored/block.c:127-0 created new block of blocksize 64512 (dev->device->label_block_size) as dev->max_block_size is zero backup2-sd: stored/stored.c:609-0 calling init_dev H:/bareos-storage/ConVent backup2-sd: stored/dev.c:377-0 init_dev: tape=0 dev_name=H:/bareos-storage/ConVent backup2-sd: stored/dev.c:379-0 dev=H:/bareos-storage/ConVent dev_max_bs=0 max_bs=0 backup2-sd: stored/stored.c:611-0 SD init done H:/bareos-storage/ConVent backup2-sd: stored/block.c:127-0 created new block of blocksize 64512 (dev->device->label_block_size) as dev->max_block_size is zero backup2-sd: stored/stored.c:609-0 calling init_dev H:/bareos-storage/Verwaltung backup2-sd: stored/dev.c:377-0 init_dev: tape=0 dev_name=H:/bareos-storage/Verwaltung backup2-sd: stored/dev.c:379-0 dev=H:/bareos-storage/Verwaltung dev_max_bs=0 max_bs=0 backup2-sd: stored/stored.c:611-0 SD init done H:/bareos-storage/Verwaltung backup2-sd: stored/block.c:127-0 created new block of blocksize 64512 (dev->device->label_block_size) as dev->max_block_size is zero backup2-sd: stored/job.c:457-0 Start stored free_jcr backup2-sd: stored/job.c:584-0 End stored free_jcr backup2-sd: stored/dir_cmd.c:342-0 Conn: Hello Director backup2-dir calling backup2-sd: stored/dir_cmd.c:360-0 Got a DIR connection at 29-Apr-2015 20:45:03 backup2-sd: lib/bsys.c:120-0 pthread_cond_timedwait sec=0 usec=100 backup2-sd: lib/cram-md5.c:68-0 send: auth cram-md5 <25251.1430333103@backup2-sd> ssl=0 backup2-sd: lib/cram-md5.c:123-0 cram-get received: auth cram-md5 <25251.1430333103@backup2-dir> ssl=0 backup2-sd: lib/cram-md5.c:143-0 sending resp to challenge: Zx/AcjNI0/1k88UB7C/63A backup2-sd: lib/bsys.c:120-0 pthread_cond_timedwait sec=0 usec=100 backup2-sd: stored/dir_cmd.c:251-0 Message channel init completed. backup2-sd: stored/dir_cmd.c:262-0 <dird: JobId=625 job=Fileserver.2015-04-29_20.45.00_59 job_name=Fileserver client_name=fileserver2-fd type=66 level=73 FileSet=Fileserver NoAttr=0 SpoolAttr=0 FileSetMD5=iF/If6wtk+Jprwpal5+l9C SpoolData=0 PreferMountedVols=1 SpoolSize=0 rerunning=0 VolSessionId=0 VolSessionTime=0 Quota=0 Protocol=0 BackupFormat=Native DumpLevel=0 backup2-sd: stored/dir_cmd.c:280-0 Do command: JobId= backup2-sd: stored/job.c:85-0 <dird: JobId=625 job=Fileserver.2015-04-29_20.45.00_59 job_name=Fileserver client_name=fileserver2-fd type=66 level=73 FileSet=Fileserver NoAttr=0 SpoolAttr=0 FileSetMD5=iF/If6wtk+Jprwpal5+l9C SpoolData=0 PreferMountedVols=1 SpoolSize=0 rerunning=0 VolSessionId=0 VolSessionTime=0 Quota=0 Protocol=0 BackupFormat=Native DumpLevel=0 backup2-sd: stored/job.c:105-0 rerunning=0 VolSesId=0 VolSesTime=0 Protocol=0 backup2-sd: stored/job.c:153-0 Quota set as 0 backup2-sd: stored/job.c:161-0 >dird jid=625: 3000 OK Job SDid=1 SDtime=1430301668 Authorization=JPGM-NAJM-FBME-AEBE-GJFL-MPOO-LENH-MFLD backup2-sd: stored/dir_cmd.c:262-0 <dird: use storage=File media_type=File pool_name=Fileserver pool_type=Backup append=1 copy=0 stripe=0 backup2-sd: stored/dir_cmd.c:280-0 Do command: use storage= backup2-sd: stored/reserve.c:195-0 <dird: use storage=File media_type=File pool_name=Fileserver pool_type=Backup append=1 copy=0 stripe=0 backup2-sd: stored/reserve.c:224-0 <dird device: use device=FileStorage backup2-sd: stored/reserve.c:432-0 Start find_suit_dev PrefMnt=1 exact=1 suitable=0 chgronly=0 any=0 backup2-sd: stored/reserve.c:557-0 search res for FileStorage backup2-sd: stored/reserve.c:591-0 Try match res=FileStorageIQB backup2-sd: stored/reserve.c:591-0 Try match res=FileStorageConvent backup2-sd: stored/reserve.c:591-0 Try match res=FileStorageVerwaltung backup2-sd: stored/reserve.c:533-0 No usable device found. backup2-sd: stored/reserve.c:543-0 Leave find_suit_dev: no dev found. backup2-sd: stored/reserve.c:432-0 Start find_suit_dev PrefMnt=1 exact=0 suitable=0 chgronly=0 any=0 backup2-sd: stored/reserve.c:557-0 search res for FileStorage backup2-sd: stored/reserve.c:591-0 Try match res=FileStorageIQB backup2-sd: stored/reserve.c:591-0 Try match res=FileStorageConvent backup2-sd: stored/reserve.c:591-0 Try match res=FileStorageVerwaltung backup2-sd: stored/reserve.c:533-0 No usable device found. backup2-sd: stored/reserve.c:543-0 Leave find_suit_dev: no dev found. backup2-sd: stored/reserve.c:432-0 Start find_suit_dev PrefMnt=1 exact=0 suitable=0 chgronly=0 any=1 backup2-sd: stored/reserve.c:557-0 search res for FileStorage backup2-sd: stored/reserve.c:591-0 Try match res=FileStorageIQB backup2-sd: stored/reserve.c:591-0 Try match res=FileStorageConvent backup2-sd: stored/reserve.c:591-0 Try match res=FileStorageVerwaltung backup2-sd: stored/reserve.c:533-0 No usable device found. backup2-sd: stored/reserve.c:543-0 Leave find_suit_dev: no dev found. backup2-sd: stored/reserve.c:351-0 Fail. !suitable_device || !wait_for_device backup2-sd: stored/reserve.c:370-0 >dird: 3924 Device "FileStorage" not in SD Device resources or no matching Media Type. backup2-sd: stored/dir_cmd.c:283-0 Command use storage= requests quit backup2-sd: stored/job.c:457-0 Start stored free_jcr backup2-sd: lib/jcr.c:184-0 write_last_jobs seek to 192 backup2-sd: stored/job.c:584-0 End stored free_jcr backup2-sd: stored/dir_cmd.c:342-0 Conn: Hello Director backup2-dir calling backup2-sd: stored/dir_cmd.c:360-0 Got a DIR connection at 29-Apr-2015 20:45:06 backup2-sd: lib/bsys.c:120-0 pthread_cond_timedwait sec=0 usec=100 backup2-sd: lib/cram-md5.c:68-0 send: auth cram-md5 <27575.1430333106@backup2-sd> ssl=0 backup2-sd: lib/cram-md5.c:123-0 cram-get received: auth cram-md5 <27575.1430333106@backup2-dir> ssl=0 backup2-sd: lib/cram-md5.c:143-0 sending resp to challenge: tykRK0+XwQBtHh/jOkkx1A backup2-sd: lib/bsys.c:120-0 pthread_cond_timedwait sec=0 usec=100 backup2-sd: stored/dir_cmd.c:251-0 Message channel init completed. backup2-sd: stored/dir_cmd.c:262-0 <dird: JobId=626 job=FileserverIQB.2015-04-29_20.45.01_00 job_name=FileserverIQB client_name=fileserver2-fd type=66 level=73 FileSet=FileserverIQB NoAttr=0 SpoolAttr=0 FileSetMD5=K6/IF7+JA6wRM5/66DEEkD SpoolData=0 PreferMountedVols=1 SpoolSize=0 rerunning=0 VolSessionId=0 VolSessionTime=0 Quota=0 Protocol=0 BackupFormat=Native DumpLevel=0 backup2-sd: stored/dir_cmd.c:280-0 Do command: JobId= backup2-sd: stored/job.c:85-0 <dird: JobId=626 job=FileserverIQB.2015-04-29_20.45.01_00 job_name=FileserverIQB client_name=fileserver2-fd type=66 level=73 FileSet=FileserverIQB NoAttr=0 SpoolAttr=0 FileSetMD5=K6/IF7+JA6wRM5/66DEEkD SpoolData=0 PreferMountedVols=1 SpoolSize=0 rerunning=0 VolSessionId=0 VolSessionTime=0 Quota=0 Protocol=0 BackupFormat=Native DumpLevel=0 backup2-sd: stored/job.c:105-0 rerunning=0 VolSesId=0 VolSesTime=0 Protocol=0 backup2-sd: stored/job.c:153-0 Quota set as 0 backup2-sd: stored/job.c:161-0 >dird jid=626: 3000 OK Job SDid=2 SDtime=1430301668 Authorization=EKJA-ILLG-DNNC-CLBA-KKOH-CAEE-LBNJ-MIPF backup2-sd: stored/dir_cmd.c:262-0 <dird: use storage=FileIQB media_type=File pool_name=IncrIQB pool_type=Backup append=1 copy=0 stripe=0 backup2-sd: stored/dir_cmd.c:280-0 Do command: use storage= backup2-sd: stored/reserve.c:195-0 <dird: use storage=FileIQB media_type=File pool_name=IncrIQB pool_type=Backup append=1 copy=0 stripe=0 backup2-sd: stored/reserve.c:224-0 <dird device: use device=FileStorageIQB backup2-sd: stored/reserve.c:432-0 Start find_suit_dev PrefMnt=1 exact=1 suitable=0 chgronly=0 any=0 backup2-sd: stored/reserve.c:557-0 search res for FileStorageIQB backup2-sd: stored/reserve.c:591-0 Try match res=FileStorageIQB backup2-sd: stored/reserve.c:628-0 chk MediaType device=File request=File backup2-sd: stored/reserve.c:651-0 try reserve FileStorageIQB backup2-sd: stored/block.c:127-0 created new block of blocksize 64512 (dev->device->label_block_size) as dev->max_block_size is zero backup2-sd: stored/acquire.c:760-0 Attach Jid=626 dcr=875da8 size=0 dev="FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/reserve.c:678-0 call reserve for append: have_vol=0 vol= backup2-sd: stored/reserve.c:873-0 reserve_append device is "FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/reserve.c:964-0 PrefMnt=1 exact=1 suitable=1 chgronly=0 any=0 backup2-sd: stored/reserve.c:926-0 MaxJobs=0 Jobs=0 reserves=0 Status= Vol= backup2-sd: stored/reserve.c:1068-0 OK Dev avail reserved "FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/reserve.c:125-0 Inc reserve=0 dev="FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/reserve.c:687-0 Reserved=1 dev_name=FileStorageIQB mediatype=File pool=IncrIQB ok=1 backup2-sd: stored/reserve.c:689-0 Vol= num_writers=0, have_vol=0 backup2-sd: stored/reserve.c:700-0 no vol, call find_next_appendable_vol. backup2-sd: stored/askdir.c:271-0 dir_find_next_appendable_volume: reserved=1 Vol= backup2-sd: stored/askdir.c:288-0 >dird CatReq Job=FileserverIQB.2015-04-29_20.45.01_00 FindMedia=1 pool_name=IncrIQB media_type=File backup2-sd: stored/askdir.c:175-0 <dird 1000 OK VolName=Fileserver-Incr-IQB-0571 VolJobs=2 VolFiles=0 VolBlocks=11990 VolBytes=773437175 VolMounts=2 VolErrors=0 VolWrites=11991 MaxVolBytes=5368709120 VolCapacityBytes=0 VolStatus=Append Slot=0 MaxVolJobs=0 MaxVolFiles=0 InChanger=0 VolReadTime=0 VolWriteTime=849605 EndFile=0 EndBlock=773437174 LabelType=0 MediaId=571 EncryptionKey= MinBlocksize=0 MaxBlocksize=0 backup2-sd: stored/askdir.c:211-0 do_get_volume_info return true slot=0 Volume=Fileserver-Incr-IQB-0571, VolminBlocksize=0 VolMaxBlocksize=0 backup2-sd: stored/askdir.c:213-0 setting dcr->VolMinBlocksize(0) to vol.VolMinBlocksize(0) backup2-sd: stored/askdir.c:215-0 setting dcr->VolMaxBlocksize(0) to vol.VolMaxBlocksize(0) backup2-sd: stored/vol_mgr.c:653-0 find_read_vol: read_vol_list empty. backup2-sd: stored/vol_mgr.c:848-0 Vol=Fileserver-Incr-IQB-0571 not in use. backup2-sd: stored/askdir.c:299-0 Call reserve_volume for write. Vol=Fileserver-Incr-IQB-0571 backup2-sd: stored/vol_mgr.c:373-0 enter reserve_volume=Fileserver-Incr-IQB-0571 drive="FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/vol_mgr.c:283-0 new Vol=Fileserver-Incr-IQB-0571 at 849358 dev="FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/vol_mgr.c:533-0 === set in_use. vol=Fileserver-Incr-IQB-0571 dev="FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/vol_mgr.c:571-0 Inc walk_start use_count=2 volname=Fileserver-Incr-IQB-0571 backup2-sd: stored/vol_mgr.c:219-0 List end new volume: Fileserver-Incr-IQB-0571 in_use=1 swap=0 on device "FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/askdir.c:304-0 dir_find_next_appendable_volume return true. vol=Fileserver-Incr-IQB-0571 backup2-sd: stored/reserve.c:704-0 looking for Volume=Fileserver-Incr-IQB-0571 backup2-sd: stored/reserve.c:761-0 >dird: 3000 OK use device device=FileStorageIQB backup2-sd: stored/reserve.c:601-0 Device FileStorageIQB reserved=1 for append. backup2-sd: stored/reserve.c:526-0 available device found=FileStorageIQB backup2-sd: stored/reserve.c:541-0 OK dev found. Vol=Fileserver-Incr-IQB-0571 backup2-sd: stored/dir_cmd.c:262-0 <dird: runbackup2-sd: stored/dir_cmd.c:280-0 Do command: run backup2-sd: stored/dir_cmd.c:1610-0 Run_cmd: run backup2-sd: stored/job.c:185-0 FileserverIQB.2015-04-29_20.45.01_00 waiting 1800 sec for FD to contact SD key=EKJA-ILLG-DNNC-CLBA-KKOH-CAEE-LBNJ-MIPF backup2-sd: stored/dir_cmd.c:342-0 Conn: Hello Start Job FileserverIQB.2015-04-29_20.45.01_00 backup2-sd: stored/dir_cmd.c:348-0 Got a FD connection at 29-Apr-2015 20:45:28 backup2-sd: stored/fd_cmds.c:120-0 Found Job FileserverIQB.2015-04-29_20.45.01_00 backup2-sd: lib/bsys.c:120-0 pthread_cond_timedwait sec=0 usec=100 backup2-sd: lib/cram-md5.c:68-0 send: auth cram-md5 <28063.1430333128@backup2-sd> ssl=0 backup2-sd: lib/cram-md5.c:123-0 cram-get received: auth cram-md5 <18456.1430333128@fileserver2-fd> ssl=0 backup2-sd: lib/cram-md5.c:143-0 sending resp to challenge: G++Qm59X41+G05Zc/4EKCB backup2-sd: lib/bsys.c:120-0 pthread_cond_timedwait sec=0 usec=100 backup2-sd: stored/fd_cmds.c:146-0 OK Authentication jid=626 Job FileserverIQB.2015-04-29_20.45.01_00 backup2-sd: stored/job.c:202-0 Auth=1 canceled=0 errstat=0 backup2-sd: stored/fd_cmds.c:175-0 Start run Job=FileserverIQB.2015-04-29_20.45.01_00 backup2-sd: stored/fd_cmds.c:219-0 <filed: append open session backup2-sd: stored/fd_cmds.c:303-0 Append open session: append open session backup2-sd: stored/fd_cmds.c:314-0 >filed: 3000 OK open ticket = 2 backup2-sd: stored/fd_cmds.c:219-0 <filed: append data 2 backup2-sd: stored/fd_cmds.c:265-0 Append data: append data 2 backup2-sd: stored/fd_cmds.c:267-0 <filed: append data 2 backup2-sd: stored/append.c:69-0 Start append data. res=1 backup2-sd: stored/acquire.c:369-0 acquire_append device is disk backup2-sd: stored/acquire.c:404-0 jid=626 Do mount_next_write_vol backup2-sd: stored/mount.c:71-0 Enter mount_next_volume(release=0) dev="FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/mount.c:84-0 mount_next_vol retry=0 backup2-sd: stored/mount.c:604-0 No swap_dev set backup2-sd: stored/askdir.c:246-0 >dird CatReq Job=FileserverIQB.2015-04-29_20.45.01_00 GetVolInfo VolName=Fileserver-Incr-IQB-0571 write=1 backup2-sd: stored/askdir.c:175-0 <dird 1000 OK VolName=Fileserver-Incr-IQB-0571 VolJobs=2 VolFiles=0 VolBlocks=11990 VolBytes=773437175 VolMounts=2 VolErrors=0 VolWrites=11991 MaxVolBytes=5368709120 VolCapacityBytes=0 VolStatus=Append Slot=0 MaxVolJobs=0 MaxVolFiles=0 InChanger=0 VolReadTime=0 VolWriteTime=849605 EndFile=0 EndBlock=773437174 LabelType=0 MediaId=571 EncryptionKey= MinBlocksize=0 MaxBlocksize=0 backup2-sd: stored/askdir.c:211-0 do_get_volume_info return true slot=0 Volume=Fileserver-Incr-IQB-0571, VolminBlocksize=0 VolMaxBlocksize=0 backup2-sd: stored/askdir.c:213-0 setting dcr->VolMinBlocksize(0) to vol.VolMinBlocksize(0) backup2-sd: stored/askdir.c:215-0 setting dcr->VolMaxBlocksize(0) to vol.VolMaxBlocksize(0) backup2-sd: stored/mount.c:122-0 After find_next_append. Vol=Fileserver-Incr-IQB-0571 Slot=0 backup2-sd: stored/autochanger.c:99-0 Device "FileStorageIQB" (G:/bareos-storage) is not an autochanger backup2-sd: stored/mount.c:144-0 autoload_dev returns 0 backup2-sd: stored/mount.c:175-0 want vol=Fileserver-Incr-IQB-0571 devvol= dev="FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/dev.c:536-0 open dev: type=1 dev_name="FileStorageIQB" (G:/bareos-storage) vol=Fileserver-Incr-IQB-0571 mode=OPEN_READ_WRITE backup2-sd: stored/dev.c:540-0 call open_device mode=OPEN_READ_WRITE backup2-sd: stored/dev.c:941-0 Enter mount backup2-sd: stored/dev.c:610-0 open disk: mode=OPEN_READ_WRITE open(G:/bareos-storage/Fileserver-Incr-IQB-0571, 0x8002, 0640) backup2-sd: stored/dev.c:626-0 open dev: disk fd=3 opened backup2-sd: stored/dev.c:544-0 preserve=0x0 fd=3 backup2-sd: stored/dev.c:486-0 setting minblocksize to 64512, maxblocksize to label_block_size=64512, on device "FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/label.c:82-0 Enter read_volume_label res=1 device="FileStorageIQB" (G:/bareos-storage) vol=Fileserver-Incr-IQB-0571 dev_Vol=*NULL* max_blocksize=64512 backup2-sd: stored/label.c:146-0 Big if statement in read_volume_label backup2-sd: stored/label.c:909-0 unser_vol_label Volume Label: Id : Bacula 1.0 immortal VerNo : 11 VolName : Fileserver-Incr-IQB-0571 PrevVolName : VolFile : 0 LabelType : VOL_LABEL LabelSize : 178 PoolName : IncrIQB MediaType : File PoolType : Backup HostName : Backup2 Date label written: 28-Apr-2015 11:17 backup2-sd: stored/label.c:219-0 Compare Vol names: VolName=Fileserver-Incr-IQB-0571 hdr=Fileserver-Incr-IQB-0571 Volume Label: Id : Bacula 1.0 immortal VerNo : 11 VolName : Fileserver-Incr-IQB-0571 PrevVolName : VolFile : 0 LabelType : VOL_LABEL LabelSize : 178 PoolName : IncrIQB MediaType : File PoolType : Backup HostName : Backup2 Date label written: 28-Apr-2015 11:17 backup2-sd: stored/label.c:240-0 Leave read_volume_label() VOL_OK backup2-sd: stored/label.c:257-0 Call reserve_volume=Fileserver-Incr-IQB-0571 backup2-sd: stored/vol_mgr.c:373-0 enter reserve_volume=Fileserver-Incr-IQB-0571 drive="FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/vol_mgr.c:571-0 Inc walk_start use_count=2 volname=Fileserver-Incr-IQB-0571 backup2-sd: stored/vol_mgr.c:219-0 List begin reserve_volume: Fileserver-Incr-IQB-0571 in_use=1 swap=0 on device "FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/vol_mgr.c:400-0 Vol attached=Fileserver-Incr-IQB-0571, newvol=Fileserver-Incr-IQB-0571 volinuse=1 on "FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/vol_mgr.c:408-0 === set reserved vol=Fileserver-Incr-IQB-0571 dev="FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/vol_mgr.c:533-0 === set in_use. vol=Fileserver-Incr-IQB-0571 dev="FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/vol_mgr.c:571-0 Inc walk_start use_count=2 volname=Fileserver-Incr-IQB-0571 backup2-sd: stored/vol_mgr.c:219-0 List end new volume: Fileserver-Incr-IQB-0571 in_use=1 swap=0 on device "FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/dev.c:416-0 Device "FileStorageIQB" (G:/bareos-storage) has dev->device->max_block_size of 0 and dev->max_block_size of 64512, dcr->VolMaxBlocksize is 0 backup2-sd: stored/dev.c:458-0 set minblocksize to 64512, maxblocksize to 64512 on device "FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/mount.c:392-0 Want dirVol=Fileserver-Incr-IQB-0571 dirStat=Append backup2-sd: stored/mount.c:400-0 Vol OK name=Fileserver-Incr-IQB-0571 backup2-sd: stored/askdir.c:246-0 >dird CatReq Job=FileserverIQB.2015-04-29_20.45.01_00 GetVolInfo VolName=Fileserver-Incr-IQB-0571 write=1 backup2-sd: stored/askdir.c:175-0 <dird 1000 OK VolName=Fileserver-Incr-IQB-0571 VolJobs=2 VolFiles=0 VolBlocks=11990 VolBytes=773437175 VolMounts=2 VolErrors=0 VolWrites=11991 MaxVolBytes=5368709120 VolCapacityBytes=0 VolStatus=Append Slot=0 MaxVolJobs=0 MaxVolFiles=0 InChanger=0 VolReadTime=0 VolWriteTime=849605 EndFile=0 EndBlock=773437174 LabelType=0 MediaId=571 EncryptionKey= MinBlocksize=0 MaxBlocksize=0 backup2-sd: stored/askdir.c:211-0 do_get_volume_info return true slot=0 Volume=Fileserver-Incr-IQB-0571, VolminBlocksize=0 VolMaxBlocksize=0 backup2-sd: stored/askdir.c:213-0 setting dcr->VolMinBlocksize(0) to vol.VolMinBlocksize(0) backup2-sd: stored/askdir.c:215-0 setting dcr->VolMaxBlocksize(0) to vol.VolMaxBlocksize(0) backup2-sd: stored/mount.c:249-0 applying vol block sizes to device "FileStorageIQB" (G:/bareos-storage): dcr->VolMinBlocksize set to 0, dcr->VolMaxBlocksize set to 0 backup2-sd: stored/dev.c:416-0 Device "FileStorageIQB" (G:/bareos-storage) has dev->device->max_block_size of 0 and dev->max_block_size of 64512, dcr->VolMaxBlocksize is 0 backup2-sd: stored/dev.c:458-0 set minblocksize to 64512, maxblocksize to 64512 on device "FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/mount.c:283-0 Device previously written, moving to end of data. Expect 773437175 bytes backup2-sd: stored/dev.c:704-0 Enter eod backup2-sd: stored/dev.c:716-0 ====== Seek to 773437175 backup2-sd: stored/mount.c:301-0 update volinfo mounts=3 backup2-sd: stored/askdir.c:353-0 Update cat VolBytes=773437175 backup2-sd: stored/askdir.c:375-0 >dird CatReq Job=FileserverIQB.2015-04-29_20.45.01_00 UpdateMedia VolName=Fileserver-Incr-IQB-0571 VolJobs=2 VolFiles=0 VolBlocks=11990 VolBytes=773437175 VolMounts=3 VolErrors=0 VolWrites=11991 MaxVolBytes=5368709120 EndTime=1430333162 VolStatus=Append Slot=0 relabel=0 InChanger=0 VolReadTime=0 VolWriteTime=849605 VolFirstWritten=0 backup2-sd: stored/askdir.c:175-0 <dird 1000 OK VolName=Fileserver-Incr-IQB-0571 VolJobs=2 VolFiles=0 VolBlocks=11990 VolBytes=773437175 VolMounts=3 VolErrors=0 VolWrites=11991 MaxVolBytes=5368709120 VolCapacityBytes=0 VolStatus=Append Slot=0 MaxVolJobs=0 MaxVolFiles=0 InChanger=0 VolReadTime=0 VolWriteTime=849605 EndFile=0 EndBlock=773437174 LabelType=0 MediaId=571 EncryptionKey= MinBlocksize=0 MaxBlocksize=0 backup2-sd: stored/askdir.c:211-0 do_get_volume_info return true slot=0 Volume=Fileserver-Incr-IQB-0571, VolminBlocksize=0 VolMaxBlocksize=0 backup2-sd: stored/askdir.c:213-0 setting dcr->VolMinBlocksize(0) to vol.VolMinBlocksize(0) backup2-sd: stored/askdir.c:215-0 setting dcr->VolMaxBlocksize(0) to vol.VolMaxBlocksize(0) backup2-sd: stored/mount.c:311-0 set APPEND, normal return from mount_next_write_volume. dev="FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/acquire.c:417-0 Output pos=0:773437175 backup2-sd: stored/acquire.c:428-0 === nwriters=1 nres=1 vcatjob=3 dev="FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/askdir.c:353-0 Update cat VolBytes=773437175 backup2-sd: stored/askdir.c:375-0 >dird CatReq Job=FileserverIQB.2015-04-29_20.45.01_00 UpdateMedia VolName=Fileserver-Incr-IQB-0571 VolJobs=3 VolFiles=0 VolBlocks=11990 VolBytes=773437175 VolMounts=3 VolErrors=0 VolWrites=11991 MaxVolBytes=5368709120 EndTime=1430333162 VolStatus=Append Slot=0 relabel=0 InChanger=0 VolReadTime=0 VolWriteTime=849605 VolFirstWritten=0 backup2-sd: stored/askdir.c:175-0 <dird 1000 OK VolName=Fileserver-Incr-IQB-0571 VolJobs=3 VolFiles=0 VolBlocks=11990 VolBytes=773437175 VolMounts=3 VolErrors=0 VolWrites=11991 MaxVolBytes=5368709120 VolCapacityBytes=0 VolStatus=Append Slot=0 MaxVolJobs=0 MaxVolFiles=0 InChanger=0 VolReadTime=0 VolWriteTime=849605 EndFile=0 EndBlock=773437174 LabelType=0 MediaId=571 EncryptionKey= MinBlocksize=0 MaxBlocksize=0 backup2-sd: stored/askdir.c:211-0 do_get_volume_info return true slot=0 Volume=Fileserver-Incr-IQB-0571, VolminBlocksize=0 VolMaxBlocksize=0 backup2-sd: stored/askdir.c:213-0 setting dcr->VolMinBlocksize(0) to vol.VolMinBlocksize(0) backup2-sd: stored/askdir.c:215-0 setting dcr->VolMaxBlocksize(0) to vol.VolMaxBlocksize(0) backup2-sd: stored/reserve.c:134-0 Dec reserve=0 dev="FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/append.c:89-0 Begin append device="FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/append.c:100-0 Just after acquire_device_for_append backup2-sd: stored/label.c:799-0 session_label record=8861a0 backup2-sd: stored/label.c:844-0 Write sesson_label record JobId=626 FI=SOS_LABEL SessId=2 Strm=626 len=171 remainder=0 backup2-sd: stored/label.c:848-0 Leave write_session_label Block=773437175d File=0d backup2-sd: stored/fd_cmds.c:219-0 <filed: append end session 2 backup2-sd: stored/fd_cmds.c:287-0 stored<filed: append end session 2 backup2-sd: stored/fd_cmds.c:219-0 <filed: append close session 2 backup2-sd: stored/fd_cmds.c:328-0 <filed: append close session 2 backup2-sd: stored/fd_cmds.c:339-0 >filed: 3000 OK close Status = 84 backup2-sd: stored/append.c:269-0 Write EOS label JobStatus=T backup2-sd: stored/label.c:799-0 session_label record=8861a0 backup2-sd: stored/label.c:844-0 Write sesson_label record JobId=626 FI=EOS_LABEL SessId=2 Strm=626 len=207 remainder=0 backup2-sd: stored/label.c:848-0 Leave write_session_label Block=1266695922d File=0d backup2-sd: stored/append.c:288-0 back from write_end_session_label() backup2-sd: stored/acquire.c:473-0 release_device device "FileStorageIQB" (G:/bareos-storage) is disk backup2-sd: stored/acquire.c:497-0 There are 0 writers in release_device backup2-sd: stored/acquire.c:500-0 dir_create_jobmedia. Release vol=Fileserver-Incr-IQB-0571 dev="FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/askdir.c:433-0 >dird CatReq Job=FileserverIQB.2015-04-29_20.45.01_00 CreateJobMedia FirstIndex=1 LastIndex=488 StartFile=0 EndFile=0 StartBlock=773437175 EndBlock=1266708308 Copy=0 Strip=0 MediaId=571 backup2-sd: stored/askdir.c:440-0 <dird 1000 OK CreateJobMedia backup2-sd: stored/askdir.c:353-0 Update cat VolBytes=1266708309 backup2-sd: stored/askdir.c:375-0 >dird CatReq Job=FileserverIQB.2015-04-29_20.45.01_00 UpdateMedia VolName=Fileserver-Incr-IQB-0571 VolJobs=3 VolFiles=0 VolBlocks=19637 VolBytes=1266708309 VolMounts=3 VolErrors=0 VolWrites=19638 MaxVolBytes=5368709120 EndTime=1430333879 VolStatus=Append Slot=0 relabel=0 InChanger=0 VolReadTime=0 VolWriteTime=1504822 VolFirstWritten=0 backup2-sd: stored/askdir.c:175-0 <dird 1000 OK VolName=Fileserver-Incr-IQB-0571 VolJobs=3 VolFiles=0 VolBlocks=19637 VolBytes=1266708309 VolMounts=3 VolErrors=0 VolWrites=19638 MaxVolBytes=5368709120 VolCapacityBytes=0 VolStatus=Append Slot=0 MaxVolJobs=0 MaxVolFiles=0 InChanger=0 VolReadTime=0 VolWriteTime=1504822 EndFile=0 EndBlock=1266708308 LabelType=0 MediaId=571 EncryptionKey= MinBlocksize=0 MaxBlocksize=0 backup2-sd: stored/askdir.c:211-0 do_get_volume_info return true slot=0 Volume=Fileserver-Incr-IQB-0571, VolminBlocksize=0 VolMaxBlocksize=0 backup2-sd: stored/askdir.c:213-0 setting dcr->VolMinBlocksize(0) to vol.VolMinBlocksize(0) backup2-sd: stored/askdir.c:215-0 setting dcr->VolMaxBlocksize(0) to vol.VolMaxBlocksize(0) backup2-sd: stored/acquire.c:521-0 dir_update_vol_info. Release vol=Fileserver-Incr-IQB-0571 dev="FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/vol_mgr.c:691-0 === clear in_use vol=Fileserver-Incr-IQB-0571 backup2-sd: stored/vol_mgr.c:710-0 === set not reserved vol=Fileserver-Incr-IQB-0571 num_writers=0 dev_reserved=0 dev="FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/vol_mgr.c:738-0 === clear in_use vol=Fileserver-Incr-IQB-0571 backup2-sd: stored/vol_mgr.c:743-0 === remove volume Fileserver-Incr-IQB-0571 dev="FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/acquire.c:537-0 0 writers, 0 reserve, dev="FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/dev.c:883-0 close_dev "FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/dev.c:978-0 Enter unmount backup2-sd: stored/dev.c:872-0 Clear volhdr vol=Fileserver-Incr-IQB-0571 backup2-sd: stored/vol_mgr.c:732-0 No vol on dev "FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/acquire.c:595-0 JobId=626 broadcast wait_device_release at 29-Apr-2015 20:57:59 backup2-sd: stored/acquire.c:781-0 Detach Jid=626 dcr=875da8 size=1 to dev="FileStorageIQB" (G:/bareos-storage) backup2-sd: stored/acquire.c:617-0 Device "FileStorageIQB" (G:/bareos-storage) released by JobId=626 backup2-sd: stored/spool.c:695-0 Commit attributes at 29-Apr-2015 20:57:59 backup2-sd: stored/append.c:343-0 return from do_append_data() ok=1 backup2-sd: stored/dir_cmd.c:283-0 Command run requests quit backup2-sd: stored/job.c:457-0 Start stored free_jcr backup2-sd: lib/jcr.c:184-0 write_last_jobs seek to 192 backup2-sd: stored/job.c:584-0 End stored free_jcr backup2-sd: stored/dir_cmd.c:342-0 Conn: Hello Director backup2-dir calling backup2-sd: stored/dir_cmd.c:360-0 Got a DIR connection at 29-Apr-2015 20:58:02 backup2-sd: lib/bsys.c:120-0 pthread_cond_timedwait sec=0 usec=100 backup2-sd: lib/cram-md5.c:68-0 send: auth cram-md5 <13957.1430333882@backup2-sd> ssl=0 backup2-sd: lib/cram-md5.c:123-0 cram-get received: auth cram-md5 <13957.1430333882@backup2-dir> ssl=0 backup2-sd: lib/cram-md5.c:143-0 sending resp to challenge: qj5hXy+JPl/4Vw/PX7/VzC backup2-sd: lib/bsys.c:120-0 pthread_cond_timedwait sec=0 usec=100 backup2-sd: stored/dir_cmd.c:251-0 Message channel init completed. backup2-sd: stored/dir_cmd.c:262-0 <dird: JobId=627 job=FileserverConVent.2015-04-29_20.45.01_01 job_name=FileserverConVent client_name=fileserver2-fd type=66 level=73 FileSet=FileserverConVent NoAttr=0 SpoolAttr=0 FileSetMD5=Z9/wbg+rk99YE/ZlZ4Q/KD SpoolData=0 PreferMountedVols=1 SpoolSize=0 rerunning=0 VolSessionId=0 VolSessionTime=0 Quota=0 Protocol=0 BackupFormat=Native DumpLevel=0 backup2-sd: stored/dir_cmd.c:280-0 Do command: JobId= backup2-sd: stored/job.c:85-0 <dird: JobId=627 job=FileserverConVent.2015-04-29_20.45.01_01 job_name=FileserverConVent client_name=fileserver2-fd type=66 level=73 FileSet=FileserverConVent NoAttr=0 SpoolAttr=0 FileSetMD5=Z9/wbg+rk99YE/ZlZ4Q/KD SpoolData=0 PreferMountedVols=1 SpoolSize=0 rerunning=0 VolSessionId=0 VolSessionTime=0 Quota=0 Protocol=0 BackupFormat=Native DumpLevel=0 backup2-sd: stored/job.c:105-0 rerunning=0 VolSesId=0 VolSesTime=0 Protocol=0 backup2-sd: stored/job.c:153-0 Quota set as 0 backup2-sd: stored/job.c:161-0 >dird jid=627: 3000 OK Job SDid=3 SDtime=1430301668 Authorization=LICM-FGPM-NHDC-PJFO-GPJH-BIHD-LEFC-JPKP backup2-sd: stored/dir_cmd.c:262-0 <dird: use storage=FileConVent media_type=File pool_name=IncrConVent pool_type=Backup append=1 copy=0 stripe=0 backup2-sd: stored/dir_cmd.c:280-0 Do command: use storage= backup2-sd: stored/reserve.c:195-0 <dird: use storage=FileConVent media_type=File pool_name=IncrConVent pool_type=Backup append=1 copy=0 stripe=0 backup2-sd: stored/reserve.c:224-0 <dird device: use device=FileStorageConvent backup2-sd: stored/reserve.c:432-0 Start find_suit_dev PrefMnt=1 exact=1 suitable=0 chgronly=0 any=0 backup2-sd: stored/reserve.c:557-0 search res for FileStorageConvent backup2-sd: stored/reserve.c:591-0 Try match res=FileStorageIQB backup2-sd: stored/reserve.c:591-0 Try match res=FileStorageConvent backup2-sd: stored/reserve.c:628-0 chk MediaType device=File request=File backup2-sd: stored/reserve.c:651-0 try reserve FileStorageConvent backup2-sd: stored/block.c:127-0 created new block of blocksize 64512 (dev->device->label_block_size) as dev->max_block_size is zero backup2-sd: stored/acquire.c:760-0 Attach Jid=627 dcr=8867a8 size=0 dev="FileStorageConvent" (H:/bareos-storage/ConVent) backup2-sd: stored/reserve.c:678-0 call reserve for append: have_vol=0 vol= backup2-sd: stored/reserve.c:873-0 reserve_append device is "FileStorageConvent" (H:/bareos-storage/ConVent) backup2-sd: stored/reserve.c:964-0 PrefMnt=1 exact=1 suitable=1 chgronly=0 any=0 backup2-sd: stored/reserve.c:926-0 MaxJobs=0 Jobs=0 reserves=0 Status= Vol= backup2-sd: stored/reserve.c:1068-0 OK Dev avail reserved "FileStorageConvent" (H:/bareos-storage/ConVent) backup2-sd: stored/reserve.c:125-0 Inc reserve=0 dev="FileStorageConvent" (H:/bareos-storage/ConVent) backup2-sd: stored/reserve.c:687-0 Reserved=1 dev_name=FileStorageConvent mediatype=File pool=IncrConVent ok=1 backup2-sd: stored/reserve.c:689-0 Vol= num_writers=0, have_vol=0 backup2-sd: stored/reserve.c:700-0 no vol, call find_next_appendable_vol. backup2-sd: stored/askdir.c:271-0 dir_find_next_appendable_volume: reserved=1 Vol= backup2-sd: stored/askdir.c:288-0 >dird CatReq Job=FileserverConVent.2015-04-29_20.45.01_01 FindMedia=1 pool_name=IncrConVent media_type=File backup2-sd: stored/askdir.c:175-0 <dird 1000 OK VolName=Fileserver-Incr-ConVent-0573 VolJobs=2 VolFiles=0 VolBlocks=41628 VolBytes=2685485905 VolMounts=2 VolErrors=0 VolWrites=41629 MaxVolBytes=5368709120 VolCapacityBytes=0 VolStatus=Append Slot=0 MaxVolJobs=0 MaxVolFiles=0 InChanger=0 VolReadTime=0 VolWriteTime=3541299 EndFile=0 EndBlock=2685485904 LabelType=0 MediaId=573 EncryptionKey= MinBlocksize=0 MaxBlocksize=0 backup2-sd: stored/askdir.c:211-0 do_get_volume_info return true slot=0 Volume=Fileserver-Incr-ConVent-0573, VolminBlocksize=0 VolMaxBlocksize=0 backup2-sd: stored/askdir.c:213-0 setting dcr->VolMinBlocksize(0) to vol.VolMinBlocksize(0) backup2-sd: stored/askdir.c:215-0 setting dcr->VolMaxBlocksize(0) to vol.VolMaxBlocksize(0) backup2-sd: stored/vol_mgr.c:653-0 find_read_vol: read_vol_list empty. backup2-sd: stored/vol_mgr.c:848-0 Vol=Fileserver-Incr-ConVent-0573 not in use. backup2-sd: stored/askdir.c:299-0 Call reserve_volume for write. Vol=Fileserver-Incr-ConVent-0573 backup2-sd: stored/vol_mgr.c:373-0 enter reserve_volume=Fileserver-Incr-ConVent-0573 drive="FileStorageConvent" (H:/bareos-storage/ConVent) backup2-sd: stored/vol_mgr.c:283-0 new Vol=Fileserver-Incr-ConVent-0573 at 8493a8 dev="FileStorageConvent" (H:/bareos-storage/ConVent) backup2-sd: stored/vol_mgr.c:533-0 === set in_use. vol=Fileserver-Incr-ConVent-0573 dev="FileStorageConvent" (H:/bareos-storage/ConVent) backup2-sd: stored/vol_mgr.c:571-0 Inc walk_start use_count=2 volname=Fileserver-Incr-ConVent-0573 backup2-sd: stored/vol_mgr.c:219-0 List end new volume: Fileserver-Incr-ConVent-0573 in_use=1 swap=0 on device "FileStorageConvent" (H:/bareos-storage/ConVent) backup2-sd: stored/askdir.c:304-0 dir_find_next_appendable_volume return true. vol=Fileserver-Incr-ConVent-0573 backup2-sd: stored/reserve.c:704-0 looking for Volume=Fileserver-Incr-ConVent-0573 backup2-sd: stored/reserve.c:761-0 >dird: 3000 OK use device device=FileStorageConvent backup2-sd: stored/reserve.c:601-0 Device FileStorageConvent reserved=1 for append. backup2-sd: stored/reserve.c:526-0 available device found=FileStorageConvent backup2-sd: stored/reserve.c:541-0 OK dev found. Vol=Fileserver-Incr-ConVent-0573 backup2-sd: stored/dir_cmd.c:262-0 <dird: runbackup2-sd: stored/dir_cmd.c:280-0 Do command: run backup2-sd: stored/dir_cmd.c:1610-0 Run_cmd: run backup2-sd: stored/job.c:185-0 FileserverConVent.2015-04-29_20.45.01_01 waiting 1800 sec for FD to contact SD key=LICM-FGPM-NHDC-PJFO-GPJH-BIHD-LEFC-JPKP backup2-sd: stored/dir_cmd.c:342-0 Conn: Hello Start Job FileserverConVent.2015-04-29_20.45.01_01 backup2-sd: stored/dir_cmd.c:348-0 Got a FD connection at 29-Apr-2015 20:58:23 backup2-sd: stored/fd_cmds.c:120-0 Found Job FileserverConVent.2015-04-29_20.45.01_01 backup2-sd: lib/bsys.c:120-0 pthread_cond_timedwait sec=0 usec=100 backup2-sd: lib/cram-md5.c:68-0 send: auth cram-md5 <30451.1430333903@backup2-sd> ssl=0 backup2-sd: lib/cram-md5.c:123-0 cram-get received: auth cram-md5 <4512.1430333904@fileserver2-fd> ssl=0 backup2-sd: lib/cram-md5.c:143-0 sending resp to challenge: uxdLS9hTIw0Pe++GsC8V1A backup2-sd: lib/bsys.c:120-0 pthread_cond_timedwait sec=0 usec=100 backup2-sd: stored/fd_cmds.c:146-0 OK Authentication jid=627 Job FileserverConVent.2015-04-29_20.45.01_01 backup2-sd: stored/job.c:202-0 Auth=1 canceled=0 errstat=0 backup2-sd: stored/fd_cmds.c:175-0 Start run Job=FileserverConVent.2015-04-29_20.45.01_01 backup2-sd: stored/fd_cmds.c:219-0 <filed: append open session backup2-sd: stored/fd_cmds.c:303-0 Append open session: append open session backup2-sd: stored/fd_cmds.c:314-0 >filed: 3000 OK open ticket = 3 backup2-sd: stored/fd_cmds.c:219-0 <filed: append data 3 backup2-sd: stored/fd_cmds.c:265-0 Append data: append data 3 backup2-sd: stored/fd_cmds.c:267-0 <filed: append data 3 backup2-sd: stored/append.c:69-0 Start append data. res=1 backup2-sd: stored/acquire.c:369-0 acquire_append device is disk backup2-sd: stored/acquire.c:404-0 jid=627 Do mount_next_write_vol backup2-sd: stored/mount.c:71-0 Enter mount_next_volume(release=0) dev="FileStorageConvent" (H:/bareos-storage/ConVent) backup2-sd: stored/mount.c:84-0 mount_next_vol retry=0 backup2-sd: stored/mount.c:604-0 No swap_dev set backup2-sd: stored/askdir.c:246-0 >dird CatReq Job=FileserverConVent.2015-04-29_20.45.01_01 GetVolInfo VolName=Fileserver-Incr-ConVent-0573 write=1 backup2-sd: stored/askdir.c:175-0 <dird 1000 OK VolName=Fileserver-Incr-ConVent-0573 VolJobs=2 VolFiles=0 VolBlocks=41628 VolBytes=2685485905 VolMounts=2 VolErrors=0 VolWrites=41629 MaxVolBytes=5368709120 VolCapacityBytes=0 VolStatus=Append Slot=0 MaxVolJobs=0 MaxVolFiles=0 InChanger=0 VolReadTime=0 VolWriteTime=3541299 EndFile=0 EndBlock=2685485904 LabelType=0 MediaId=573 EncryptionKey= MinBlocksize=0 MaxBlocksize=0 backup2-sd: stored/askdir.c:211-0 do_get_volume_info return true slot=0 Volume=Fileserver-Incr-ConVent-0573, VolminBlocksize=0 VolMaxBlocksize=0 backup2-sd: stored/askdir.c:213-0 setting dcr->VolMinBlocksize(0) to vol.VolMinBlocksize(0) backup2-sd: stored/askdir.c:215-0 setting dcr->VolMaxBlocksize(0) to vol.VolMaxBlocksize(0) backup2-sd: stored/mount.c:122-0 After find_next_append. Vol=Fileserver-Incr-ConVent-0573 Slot=0 backup2-sd: stored/autochanger.c:99-0 Device "FileStorageConvent" (H:/bareos-storage/ConVent) is not an autochanger backup2-sd: stored/mount.c:144-0 autoload_dev returns 0 backup2-sd: stored/mount.c:175-0 want vol=Fileserver-Incr-ConVent-0573 devvol= dev="FileStorageConvent" (H:/bareos-storage/ConVent) backup2-sd: stored/dev.c:536-0 open dev: type=1 dev_name="FileStorageConvent" (H:/bareos-storage/ConVent) vol=Fileserver-Incr-ConVent-0573 mode=OPEN_READ_WRITE backup2-sd: stored/dev.c:540-0 call open_device mode=OPEN_READ_WRITE backup2-sd: stored/dev.c:941-0 Enter mount backup2-sd: stored/dev.c:610-0 open disk: mode=OPEN_READ_WRITE open(H:/bareos-storage/ConVent/Fileserver-Incr-ConVent-0573, 0x8002, 0640) backup2-sd: stored/dev.c:626-0 open dev: disk fd=3 opened backup2-sd: stored/dev.c:544-0 preserve=0x0 fd=3 backup2-sd: stored/dev.c:486-0 setting minblocksize to 64512, maxblocksize to label_block_size=64512, on device "FileStorageConvent" (H:/bareos-storage/ConVent) backup2-sd: stored/label.c:82-0 Enter read_volume_label res=1 device="FileStorageConvent" (H:/bareos-storage/ConVent) vol=Fileserver-Incr-ConVent-0573 dev_Vol=*NULL* max_blocksize=64512 backup2-sd: stored/label.c:146-0 Big if statement in read_volume_label backup2-sd: stored/label.c:909-0 unser_vol_label Volume Label: Id : Bacula 1.0 immortal VerNo : 11 VolName : Fileserver-Incr-ConVent-0573 PrevVolName : VolFile : 0 LabelType : VOL_LABEL LabelSize : 186 PoolName : IncrConVent MediaType : File PoolType : Backup HostName : Backup2 Date label written: 28-Apr-2015 11:34 backup2-sd: stored/label.c:219-0 Compare Vol names: VolName=Fileserver-Incr-ConVent-0573 hdr=Fileserver-Incr-ConVent-0573 Volume Label: Id : Bacula 1.0 immortal VerNo : 11 VolName : Fileserver-Incr-ConVent-0573 PrevVolName : VolFile : 0 LabelType : VOL_LABEL LabelSize : 186 PoolName : IncrConVent MediaType : File PoolType : Backup HostName : Backup2 Date label written: 28-Apr-2015 11:34 backup2-sd: stored/label.c:240-0 Leave read_volume_label() VOL_OK backup2-sd: stored/label.c:257-0 Call reserve_volume=Fileserver-Incr-ConVent-0573 backup2-sd: stored/vol_mgr.c:373-0 enter reserve_volume=Fileserver-Incr-ConVent-0573 drive="FileStorageConvent" (H:/bareos-storage/ConVent) backup2-sd: stored/vol_mgr.c:571-0 Inc walk_start use_count=2 volname=Fileserver-Incr-ConVent-0573 backup2-sd: stored/vol_mgr.c:219-0 List begin reserve_volume: Fileserver-Incr-ConVent-0573 in_use=1 swap=0 on device "FileStorageConvent" (H:/bareos-storage/ConVent) backup2-sd: stored/vol_mgr.c:400-0 Vol attached=Fileserver-Incr-ConVent-0573, newvol=Fileserver-Incr-ConVent-0573 volinuse=1 on "FileStorageConvent" (H:/bareos-storage/ConVent) backup2-sd: stored/vol_mgr.c:408-0 === set reserved vol=Fileserver-Incr-ConVent-0573 dev="FileStorageConvent" (H:/bareos-storage/ConVent) backup2-sd: stored/vol_mgr.c:533-0 === set in_use. vol=Fileserver-Incr-ConVent-0573 dev="FileStorageConvent" (H:/bareos-storage/ConVent) backup2-sd: stored/vol_mgr.c:571-0 Inc walk_start use_count=2 volname=Fileserver-Incr-ConVent-0573 backup2-sd: stored/vol_mgr.c:219-0 List end new volume: Fileserver-Incr-ConVent-0573 in_use=1 swap=0 on device "FileStorageConvent" (H:/bareos-storage/ConVent) backup2-sd: stored/dev.c:416-0 Device "FileStorageConvent" (H:/bareos-storage/ConVent) has dev->device->max_block_size of 0 and dev->max_block_size of 64512, dcr->VolMaxBlocksize is 0 backup2-sd: stored/dev.c:458-0 set minblocksize to 64512, maxblocksize to 64512 on device "FileStorageConvent" (H:/bareos-storage/ConVent) backup2-sd: stored/mount.c:392-0 Want dirVol=Fileserver-Incr-ConVent-0573 dirStat=Append backup2-sd: stored/mount.c:400-0 Vol OK name=Fileserver-Incr-ConVent-0573 backup2-sd: stored/askdir.c:246-0 >dird CatReq Job=FileserverConVent.2015-04-29_20.45.01_01 GetVolInfo VolName=Fileserver-Incr-ConVent-0573 write=1 backup2-sd: stored/askdir.c:175-0 <dird 1000 OK VolName=Fileserver-Incr-ConVent-0573 VolJobs=2 VolFiles=0 VolBlocks=41628 VolBytes=2685485905 VolMounts=2 VolErrors=0 VolWrites=41629 MaxVolBytes=5368709120 VolCapacityBytes=0 VolStatus=Append Slot=0 MaxVolJobs=0 MaxVolFiles=0 InChanger=0 VolReadTime=0 VolWriteTime=3541299 EndFile=0 EndBlock=2685485904 LabelType=0 MediaId=573 EncryptionKey= MinBlocksize=0 MaxBlocksize=0 backup2-sd: stored/askdir.c:211-0 do_get_volume_info return true slot=0 Volume=Fileserver-Incr-ConVent-0573, VolminBlocksize=0 VolMaxBlocksize=0 backup2-sd: stored/askdir.c:213-0 setting dcr->VolMinBlocksize(0) to vol.VolMinBlocksize(0) backup2-sd: stored/askdir.c:215-0 setting dcr->VolMaxBlocksize(0) to vol.VolMaxBlocksize(0) backup2-sd: stored/mount.c:249-0 applying vol block sizes to device "FileStorageConvent" (H:/bareos-storage/ConVent): dcr->VolMinBlocksize set to 0, dcr->VolMaxBlocksize set to 0 backup2-sd: stored/dev.c:416-0 Device "FileStorageConvent" (H:/bareos-storage/ConVent) has dev->device->max_block_size of 0 and dev->max_block_size of 64512, dcr->VolMaxBlocksize is 0 backup2-sd: stored/dev.c:458-0 set minblocksize to 64512, maxblocksize to 64512 on device "FileStorageConvent" (H:/bareos-storage/ConVent) backup2-sd: stored/mount.c:283-0 Device previously written, moving to end of data. Expect 2685485905 bytes backup2-sd: stored/dev.c:704-0 Enter eod backup2-sd: stored/dev.c:716-0 ====== Seek to 2685485905 backup2-sd: stored/mount.c:301-0 update volinfo mounts=3 backup2-sd: stored/askdir.c:353-0 Update cat VolBytes=2685485905 backup2-sd: stored/askdir.c:375-0 >dird CatReq Job=FileserverConVent.2015-04-29_20.45.01_01 UpdateMedia VolName=Fileserver-Incr-ConVent-0573 VolJobs=2 VolFiles=0 VolBlocks=41628 VolBytes=2685485905 VolMounts=3 VolErrors=0 VolWrites=41629 MaxVolBytes=5368709120 EndTime=1430333921 VolStatus=Append Slot=0 relabel=0 InChanger=0 VolReadTime=0 VolWriteTime=3541299 VolFirstWritten=0 backup2-sd: stored/askdir.c:175-0 <dird 1000 OK VolName=Fileserver-Incr-ConVent-0573 VolJobs=2 VolFiles=0 VolBlocks=41628 VolBytes=2685485905 VolMounts=3 VolErrors=0 VolWrites=41629 MaxVolBytes=5368709120 VolCapacityBytes=0 VolStatus=Append Slot=0 MaxVolJobs=0 MaxVolFiles=0 InChanger=0 VolReadTime=0 VolWriteTime=3541299 EndFile=0 EndBlock=2685485904 LabelType=0 MediaId=573 EncryptionKey= MinBlocksize=0 MaxBlocksize=0 backup2-sd: stored/askdir.c:211-0 do_get_volume_info return true slot=0 Volume=Fileserver-Incr-ConVent-0573, VolminBlocksize=0 VolMaxBlocksize=0 backup2-sd: stored/askdir.c:213-0 setting dcr->VolMinBlocksize(0) to vol.VolMinBlocksize(0) backup2-sd: stored/askdir.c:215-0 setting dcr->VolMaxBlocksize(0) to vol.VolMaxBlocksize(0) backup2-sd: stored/mount.c:311-0 set APPEND, normal return from mount_next_write_volume. dev="FileStorageConvent" (H:/bareos-storage/ConVent) backup2-sd: stored/acquire.c:417-0 Output pos=0:2685485905 backup2-sd: stored/acquire.c:428-0 === nwriters=1 nres=1 vcatjob=3 dev="FileStorageConvent" (H:/bareos-storage/ConVent) backup2-sd: stored/askdir.c:353-0 Update cat VolBytes=2685485905 backup2-sd: stored/askdir.c:375-0 >dird CatReq Job=FileserverConVent.2015-04-29_20.45.01_01 UpdateMedia VolName=Fileserver-Incr-ConVent-0573 VolJobs=3 VolFiles=0 VolBlocks=41628 VolBytes=2685485905 VolMounts=3 VolErrors=0 VolWrites=41629 MaxVolBytes=5368709120 EndTime=1430333921 VolStatus=Append Slot=0 relabel=0 InChanger=0 VolReadTime=0 VolWriteTime=3541299 VolFirstWritten=0 backup2-sd: stored/askdir.c:175-0 <dird 1000 OK VolName=Fileserver-Incr-ConVent-0573 VolJobs=3 VolFiles=0 VolBlocks=41628 VolBytes=2685485905 VolMounts=3 VolErrors=0 VolWrites=41629 MaxVolBytes=5368709120 VolCapacityBytes=0 VolStatus=Append Slot=0 MaxVolJobs=0 MaxVolFiles=0 InChanger=0 VolReadTime=0 VolWriteTime=3541299 EndFile=0 EndBlock=2685485904 LabelType=0 MediaId=573 EncryptionKey= MinBlocksize=0 MaxBlocksize=0 backup2-sd: stored/askdir.c:211-0 do_get_volume_info return true slot=0 Volume=Fileserver-Incr-ConVent-0573, VolminBlocksize=0 VolMaxBlocksize=0 backup2-sd: stored/askdir.c:213-0 setting dcr->VolMinBlocksize(0) to vol.VolMinBlocksize(0) backup2-sd: stored/askdir.c:215-0 setting dcr->VolMaxBlocksize(0) to vol.VolMaxBlocksize(0) backup2-sd: stored/reserve.c:134-0 Dec reserve=0 dev="FileStorageConvent" (H:/bareos-storage/ConVent) backup2-sd: stored/append.c:89-0 Begin append device="FileStorageConvent" (H:/bareos-storage/ConVent) backup2-sd: stored/append.c:100-0 Just after acquire_device_for_append backup2-sd: stored/label.c:799-0 session_label record=8861a0 backup2-sd: stored/label.c:844-0 Write sesson_label record JobId=627 FI=SOS_LABEL SessId=3 Strm=627 len=187 remainder=0 backup2-sd: stored/label.c:848-0 Leave write_session_label Block=2685485905d File=0d backup2-sd: stored/dir_cmd.c:342-0 Conn: Hello Director backup2-dir calling backup2-sd: stored/dir_cmd.c:360-0 Got a DIR connection at 29-Apr-2015 21:00:02 backup2-sd: lib/bsys.c:120-0 pthread_cond_timedwait sec=0 usec=100 backup2-sd: lib/cram-md5.c:68-0 send: auth cram-md5 <26714.1430334002@backup2-sd> ssl=0 backup2-sd: lib/cram-md5.c:123-0 cram-get received: auth cram-md5 <26714.1430334002@backup2-dir> ssl=0 backup2-sd: lib/cram-md5.c:143-0 sending resp to challenge: X2Qz3hhq8C5/hW+Qw//JvC backup2-sd: lib/bsys.c:120-0 pthread_cond_timedwait sec=0 usec=100 backup2-sd: stored/dir_cmd.c:251-0 Message channel init completed. backup2-sd: stored/dir_cmd.c:262-0 <dird: JobId=629 job=BackupClient1.2015-04-29_21.00.00_03 job_name=BackupClient1 client_name=backup2-fd type=66 level=73 FileSet=SelfTest NoAttr=0 SpoolAttr=0 FileSetMD5=M7+QD6/p58+35TJDEAJQuA SpoolData=0 PreferMountedVols=1 SpoolSize=0 rerunning=0 VolSessionId=0 VolSessionTime=0 Quota=0 Protocol=0 BackupFormat=Native DumpLevel=0 backup2-sd: stored/dir_cmd.c:280-0 Do command: JobId= backup2-sd: stored/job.c:85-0 <dird: JobId=629 job=BackupClient1.2015-04-29_21.00.00_03 job_name=BackupClient1 client_name=backup2-fd type=66 level=73 FileSet=SelfTest NoAttr=0 SpoolAttr=0 FileSetMD5=M7+QD6/p58+35TJDEAJQuA SpoolData=0 PreferMountedVols=1 SpoolSize=0 rerunning=0 VolSessionId=0 VolSessionTime=0 Quota=0 Protocol=0 BackupFormat=Native DumpLevel=0 backup2-sd: stored/job.c:105-0 rerunning=0 VolSesId=0 VolSesTime=0 Protocol=0 backup2-sd: stored/job.c:153-0 Quota set as 0 backup2-sd: stored/job.c:161-0 >dird jid=629: 3000 OK Job SDid=4 SDtime=1430301668 Authorization=NDCK-NIEJ-ONBL-COPI-DPPD-EIGK-LJKM-NIFI backup2-sd: stored/dir_cmd.c:262-0 <dird: use storage=FileIQB media_type=File pool_name=Incremental pool_type=Backup append=1 copy=0 stripe=0 backup2-sd: stored/dir_cmd.c:280-0 Do command: use storage= backup2-sd: stored/reserve.c:195-0 <dird: use storage=FileIQB media_type=File pool_name=Incremental pool_type=Backup append=1 copy=0 stripe=0 backup2-sd: stored/reserve.c:224-0 <dird device: use device=FileStorageIQB backup2-sd: stored/reserve.c:432-0 Start find_suit_dev PrefMnt=1 exact=1 suitable=0 chgronly=0 any=0 backup2-sd: stored/vol_mgr.c:890-0 lock volumes backup2-sd: stored/vol_mgr.c:892-0 duplicate vol list backup2-sd: stored/vol_mgr.c:571-0 Inc walk_start use_count=2 volname=Fileserver-Incr-ConVent-0573 backup2-sd: stored/vol_mgr.c:909-0 unlock volumes backup2-sd: stored/reserve.c:446-0 look for vol in vol list backup2-sd: stored/askdir.c:246-0 >dird CatReq Job=BackupClient1.2015-04-29_21.00.00_03 GetVolInfo VolName=Fileserver-Incr-ConVent-0573 write=1 backup2-sd: stored/askdir.c:175-0 <dird 1998 Volume "Fileserver-Incr-ConVent-0573" catalog status is Append, not in Pool. backup2-sd: stored/askdir.c:189-0 Bad response from Dir fields=-1, len=82: 1998 Volume "Fileserver-Incr-ConVent-0573" catalog status is Append, not in Pool. backup2-sd: stored/reserve.c:505-0 lock volumes backup2-sd: stored/vol_mgr.c:780-0 free vol_list Volume=Fileserver-Incr-ConVent-0573 dev="FileStorageConvent" (H:/bareos-storage/ConVent) -- You received this message because you are subscribed to the Google Groups "bareos-users" group. To unsubscribe from this group and stop receiving emails from it, send an email to [email protected]. To post to this group, send email to [email protected]. For more options, visit https://groups.google.com/d/optout.
