bareos-sd (50): stored/dir_cmd.cc:446-0 level=100 trace=1 timestamp=0 tracefilename=/var/lib/bareos/bareos-sd.trace
bareos-sd (100): lib/jcr.cc:278-0 FreeCommonJcr: 7f3ebc010200 
bareos-sd (100): lib/tls_openssl.cc:73-0 Destruct TLsOpenSsl Implementation Object
bareos-sd (100): lib/tls_openssl_private.cc:68-0 Destruct TlsOpenSslPrivate
bareos-sd (100): lib/bsock.cc:136-0 Destruct BareosSocket
bareos-sd (100): lib/bsock.cc:84-0 Construct BareosSocket
bareos-sd (100): lib/tls_openssl_private.cc:63-0 Construct TlsOpenSslPrivate
bareos-sd (100): lib/tls_openssl_private.cc:550-0 Set tcp filedescriptor: <6>
bareos-sd (100): lib/tls_openssl_private.cc:496-0 Set ca_certfile:	<>
bareos-sd (100): lib/tls_openssl_private.cc:502-0 Set ca_certdir:	<>
bareos-sd (100): lib/tls_openssl_private.cc:508-0 Set crlfile_:	<>
bareos-sd (100): lib/tls_openssl_private.cc:514-0 Set certfile_:	<>
bareos-sd (100): lib/tls_openssl_private.cc:520-0 Set keyfile_:	<>
bareos-sd (100): lib/tls_openssl_private.cc:538-0 Set dhfile_:	<>
bareos-sd (100): lib/tls_openssl_private.cc:556-0 Set cipherlist:	<>
bareos-sd (100): lib/tls_openssl_private.cc:544-0 Set Verify Peer:	<false>
bareos-sd (50): lib/tls_openssl.cc:100-0 Preparing TLS_PSK SERVER callback
bareos-sd (100): lib/tls_openssl_private.cc:414-0 psk_server_cb. identitiy: R_DIRECTOR bareos-dir.
bareos-sd (100): lib/tls_openssl_private.cc:435-0 psk_server_cb. result: 32.
bareos-sd (50): lib/bnet.cc:142-0 TLS server negotiation established.
bareos-sd (100): lib/jcr.cc:195-0 Construct JobControlRecord
bareos-sd (50): lib/cram_md5.cc:82-0 send: auth cram-md5 <1374863409.1582040620@bareos-sd> ssl=1
bareos-sd (100): lib/cram_md5.cc:136-0 cram-get received: auth cram-md5 <239806740.1582040620@bareos-dir> ssl=1
bareos-sd (99): lib/cram_md5.cc:178-0 sending resp to challenge: m9/Ll/+SU8RTa+/ZI5+0gD
bareos-sd (90): stored/dir_cmd.cc:289-0 Message channel init completed.
bareos-sd (100): stored/job.cc:93-0 <dird: JobId=91 job=backup-win-fd.2020-02-18_16.43.38_28 job_name=backup-win-fd client_name=win10_1910-fd type=66 level=70 FileSet=Win NoAttr=0 SpoolAttr=0 FileSetMD5=Q7+v25/GiH/epgYEG5/4RC SpoolData=0 PreferMountedVols=1 SpoolSize=0 rerunning=0 VolSessionId=0 VolSessionTime=0 Quota=0 Protocol=0 BackupFormat=Native
bareos-sd (100): stored/job.cc:114-0 rerunning=0 VolSesId=0 VolSesTime=0 Protocol=0
bareos-sd (50): stored/job.cc:162-91 Quota set as 0
bareos-sd (50): stored/job.cc:172-91 >dird jid=91: 3000 OK Job SDid=11 SDtime=1582040123 Authorization=BLEA-OCIN-MGEA-EOOA-GKBC-GEHF-FEOG-AAAE
bareos-sd (100): stored/block.cc:136-91 created new block of blocksize 64512 (dev->max_block_size)
bareos-sd (50): stored/askdir.cc:205-91 DirFindNextAppendableVolume: reserved=1 Vol=
bareos-sd (50): stored/askdir.cc:226-91 >dird CatReq Job=backup-win-fd.2020-02-18_16.43.38_28 FindMedia=1 pool_name=Full media_type=File unwanted_volumes=
bareos-sd (50): stored/askdir.cc:106-91 <dird 1000 OK VolName=Full-0001 VolJobs=41 VolFiles=0 VolBlocks=41 VolBytes=58187 VolMounts=41 VolErrors=0 VolWrites=42 MaxVolBytes=53687091200 VolCapacityBytes=0 VolStatus=Append Slot=0 MaxVolJobs=0 MaxVolFiles=0 InChanger=0 VolReadTime=0 VolWriteTime=1641 EndFile=0 EndBlock=58186 LabelType=0 MediaId=1 EncryptionKey= MinBlocksize=0 MaxBlocksize=0
bareos-sd (50): stored/askdir.cc:141-91 DoGetVolumeInfo return true slot=0 Volume=Full-0001, VolminBlocksize=0 VolMaxBlocksize=0
bareos-sd (50): stored/askdir.cc:144-91 setting dcr->VolMinBlocksize(0) to vol.VolMinBlocksize(0)
bareos-sd (50): stored/askdir.cc:147-91 setting dcr->VolMaxBlocksize(0) to vol.VolMaxBlocksize(0)
bareos-sd (50): stored/askdir.cc:238-91 Call reserve_volume for write. Vol=Full-0001
bareos-sd (50): stored/askdir.cc:245-91 DirFindNextAppendableVolume return true. vol=Full-0001
bareos-sd (50): stored/job.cc:194-91 backup-win-fd.2020-02-18_16.43.38_28 waiting 1800 sec for FD to contact SD key=BLEA-OCIN-MGEA-EOOA-GKBC-GEHF-FEOG-AAAE
bareos-sd (100): lib/bsock.cc:84-0 Construct BareosSocket
bareos-sd (50): stored/fd_cmds.cc:120-0 Found Job backup-win-fd.2020-02-18_16.43.38_28
bareos-sd (50): lib/cram_md5.cc:82-0 send: auth cram-md5 <1698020313.1582040620@bareos-sd> ssl=1
bareos-sd (100): lib/cram_md5.cc:136-0 cram-get received: auth cram-md5 <30996.1582040620@win10_1910-fd> ssl=0
bareos-sd (99): lib/cram_md5.cc:178-0 sending resp to challenge: A6+gb7M/880/DwMp/i/2+B
bareos-sd (50): stored/fd_cmds.cc:148-0 OK Authentication jid=91 Job backup-win-fd.2020-02-18_16.43.38_28
bareos-sd (50): stored/job.cc:212-91 Auth=1 canceled=0 errstat=0
bareos-sd (100): stored/append.cc:79-91 Start append data. res=1
bareos-sd (100): stored/acquire.cc:455-91 acquire_append device is disk
bareos-sd (100): stored/mount.cc:673-91 No swap_dev set
bareos-sd (50): stored/askdir.cc:179-91 >dird CatReq Job=backup-win-fd.2020-02-18_16.43.38_28 GetVolInfo VolName=Full-0001 write=1
bareos-sd (50): stored/askdir.cc:106-91 <dird 1000 OK VolName=Full-0001 VolJobs=41 VolFiles=0 VolBlocks=41 VolBytes=58187 VolMounts=41 VolErrors=0 VolWrites=42 MaxVolBytes=53687091200 VolCapacityBytes=0 VolStatus=Append Slot=0 MaxVolJobs=0 MaxVolFiles=0 InChanger=0 VolReadTime=0 VolWriteTime=1641 EndFile=0 EndBlock=58186 LabelType=0 MediaId=1 EncryptionKey= MinBlocksize=0 MaxBlocksize=0
bareos-sd (50): stored/askdir.cc:141-91 DoGetVolumeInfo return true slot=0 Volume=Full-0001, VolminBlocksize=0 VolMaxBlocksize=0
bareos-sd (50): stored/askdir.cc:144-91 setting dcr->VolMinBlocksize(0) to vol.VolMinBlocksize(0)
bareos-sd (50): stored/askdir.cc:147-91 setting dcr->VolMaxBlocksize(0) to vol.VolMaxBlocksize(0)
bareos-sd (100): stored/autochanger.cc:136-91 Device "FileStorage" (/var/lib/bareos/storage) is not an autochanger
bareos-sd (100): stored/dev.cc:646-91 open dev: type=1 dev_name="FileStorage" (/var/lib/bareos/storage) vol=Full-0001 mode=OPEN_READ_WRITE
bareos-sd (100): stored/dev.cc:665-91 call OpenDevice mode=OPEN_READ_WRITE
bareos-sd (100): stored/dev.cc:741-91 open disk: mode=OPEN_READ_WRITE open(/var/lib/bareos/storage/Full-0001, 00000002, 0640)
bareos-sd (100): stored/dev.cc:757-91 open dev: disk fd=9 opened
bareos-sd (100): stored/dev.cc:673-91 preserve=31076634506 fd=9
bareos-sd (100): stored/dev.cc:590-91 setting minblocksize to 64512, maxblocksize to label_block_size=64512, on device "FileStorage" (/var/lib/bareos/storage)
bareos-sd (100): stored/label.cc:92-91 Enter ReadVolumeLabel res=1 device="FileStorage" (/var/lib/bareos/storage) vol=Full-0001 dev_Vol=*NULL* max_blocksize=64512
bareos-sd (100): stored/label.cc:265-91 Call reserve_volume=Full-0001
bareos-sd (100): stored/dev.cc:509-91 Device "FileStorage" (/var/lib/bareos/storage) has dev->device->max_block_size of 0 and dev->max_block_size of 64512, dcr->VolMaxBlocksize is 0
bareos-sd (100): stored/dev.cc:558-91 set minblocksize to 64512, maxblocksize to 64512 on device "FileStorage" (/var/lib/bareos/storage)
bareos-sd (50): stored/askdir.cc:179-91 >dird CatReq Job=backup-win-fd.2020-02-18_16.43.38_28 GetVolInfo VolName=Full-0001 write=1
bareos-sd (50): stored/askdir.cc:106-91 <dird 1000 OK VolName=Full-0001 VolJobs=41 VolFiles=0 VolBlocks=41 VolBytes=58187 VolMounts=41 VolErrors=0 VolWrites=42 MaxVolBytes=53687091200 VolCapacityBytes=0 VolStatus=Append Slot=0 MaxVolJobs=0 MaxVolFiles=0 InChanger=0 VolReadTime=0 VolWriteTime=1641 EndFile=0 EndBlock=58186 LabelType=0 MediaId=1 EncryptionKey= MinBlocksize=0 MaxBlocksize=0
bareos-sd (50): stored/askdir.cc:141-91 DoGetVolumeInfo return true slot=0 Volume=Full-0001, VolminBlocksize=0 VolMaxBlocksize=0
bareos-sd (50): stored/askdir.cc:144-91 setting dcr->VolMinBlocksize(0) to vol.VolMinBlocksize(0)
bareos-sd (50): stored/askdir.cc:147-91 setting dcr->VolMaxBlocksize(0) to vol.VolMaxBlocksize(0)
bareos-sd (100): stored/dev.cc:509-91 Device "FileStorage" (/var/lib/bareos/storage) has dev->device->max_block_size of 0 and dev->max_block_size of 64512, dcr->VolMaxBlocksize is 0
bareos-sd (100): stored/dev.cc:558-91 set minblocksize to 64512, maxblocksize to 64512 on device "FileStorage" (/var/lib/bareos/storage)
bareos-sd (100): stored/mount.cc:353-91 Device previously written, moving to end of data. Expect 58187 bytes
bareos-sd (100): stored/dev.cc:839-91 Enter eod
bareos-sd (50): stored/askdir.cc:302-91 Update cat VolBytes=58187
bareos-sd (50): stored/askdir.cc:325-91 >dird CatReq Job=backup-win-fd.2020-02-18_16.43.38_28 UpdateMedia VolName=Full-0001 VolJobs=41 VolFiles=0 VolBlocks=41 VolBytes=58187 VolMounts=42 VolErrors=0 VolWrites=42 MaxVolBytes=53687091200 EndTime=1582040620 VolStatus=Append Slot=0 relabel=0 InChanger=0 VolReadTime=0 VolWriteTime=1641 VolFirstWritten=0
bareos-sd (50): stored/askdir.cc:106-91 <dird 1000 OK VolName=Full-0001 VolJobs=41 VolFiles=0 VolBlocks=41 VolBytes=58187 VolMounts=42 VolErrors=0 VolWrites=42 MaxVolBytes=53687091200 VolCapacityBytes=0 VolStatus=Append Slot=0 MaxVolJobs=0 MaxVolFiles=0 InChanger=0 VolReadTime=0 VolWriteTime=1641 EndFile=0 EndBlock=58186 LabelType=0 MediaId=1 EncryptionKey= MinBlocksize=0 MaxBlocksize=0
bareos-sd (50): stored/askdir.cc:141-91 DoGetVolumeInfo return true slot=0 Volume=Full-0001, VolminBlocksize=0 VolMaxBlocksize=0
bareos-sd (50): stored/askdir.cc:144-91 setting dcr->VolMinBlocksize(0) to vol.VolMinBlocksize(0)
bareos-sd (50): stored/askdir.cc:147-91 setting dcr->VolMaxBlocksize(0) to vol.VolMaxBlocksize(0)
bareos-sd (100): stored/acquire.cc:515-91 === nwriters=1 nres=1 vcatjob=42 dev="FileStorage" (/var/lib/bareos/storage)
bareos-sd (50): stored/askdir.cc:302-91 Update cat VolBytes=58187
bareos-sd (50): stored/askdir.cc:325-91 >dird CatReq Job=backup-win-fd.2020-02-18_16.43.38_28 UpdateMedia VolName=Full-0001 VolJobs=42 VolFiles=0 VolBlocks=41 VolBytes=58187 VolMounts=42 VolErrors=0 VolWrites=42 MaxVolBytes=53687091200 EndTime=1582040620 VolStatus=Append Slot=0 relabel=0 InChanger=0 VolReadTime=0 VolWriteTime=1641 VolFirstWritten=0
bareos-sd (50): stored/askdir.cc:106-91 <dird 1000 OK VolName=Full-0001 VolJobs=42 VolFiles=0 VolBlocks=41 VolBytes=58187 VolMounts=42 VolErrors=0 VolWrites=42 MaxVolBytes=53687091200 VolCapacityBytes=0 VolStatus=Append Slot=0 MaxVolJobs=0 MaxVolFiles=0 InChanger=0 VolReadTime=0 VolWriteTime=1641 EndFile=0 EndBlock=58186 LabelType=0 MediaId=1 EncryptionKey= MinBlocksize=0 MaxBlocksize=0
bareos-sd (50): stored/askdir.cc:141-91 DoGetVolumeInfo return true slot=0 Volume=Full-0001, VolminBlocksize=0 VolMaxBlocksize=0
bareos-sd (50): stored/askdir.cc:144-91 setting dcr->VolMinBlocksize(0) to vol.VolMinBlocksize(0)
bareos-sd (50): stored/askdir.cc:147-91 setting dcr->VolMaxBlocksize(0) to vol.VolMaxBlocksize(0)
bareos-sd (50): stored/append.cc:98-91 Begin append device="FileStorage" (/var/lib/bareos/storage)
bareos-sd (100): stored/append.cc:107-91 Just after AcquireDeviceForAppend
bareos-sd (90): stored/append.cc:295-91 back from write_end_session_label()
bareos-sd (100): stored/acquire.cc:578-91 releasing device "FileStorage" (/var/lib/bareos/storage)
bareos-sd (100): stored/acquire.cc:603-91 There are 0 writers in ReleaseDevice
bareos-sd (50): stored/askdir.cc:386-91 >dird CatReq Job=backup-win-fd.2020-02-18_16.43.38_28 CreateJobMedia FirstIndex=1 LastIndex=2 StartFile=0 EndFile=0 StartBlock=58187 EndBlock=59520 Copy=0 Strip=0 MediaId=1
bareos-sd (50): stored/askdir.cc:394-91 <dird 1000 OK CreateJobMedia
bareos-sd (50): stored/askdir.cc:302-91 Update cat VolBytes=59521
bareos-sd (50): stored/askdir.cc:325-91 >dird CatReq Job=backup-win-fd.2020-02-18_16.43.38_28 UpdateMedia VolName=Full-0001 VolJobs=42 VolFiles=0 VolBlocks=42 VolBytes=59521 VolMounts=42 VolErrors=0 VolWrites=43 MaxVolBytes=53687091200 EndTime=1582040641 VolStatus=Append Slot=0 relabel=0 InChanger=0 VolReadTime=0 VolWriteTime=1646 VolFirstWritten=0
bareos-sd (50): stored/askdir.cc:106-91 <dird 1000 OK VolName=Full-0001 VolJobs=42 VolFiles=0 VolBlocks=42 VolBytes=59521 VolMounts=42 VolErrors=0 VolWrites=43 MaxVolBytes=53687091200 VolCapacityBytes=0 VolStatus=Append Slot=0 MaxVolJobs=0 MaxVolFiles=0 InChanger=0 VolReadTime=0 VolWriteTime=1646 EndFile=0 EndBlock=59520 LabelType=0 MediaId=1 EncryptionKey= MinBlocksize=0 MaxBlocksize=0
bareos-sd (50): stored/askdir.cc:141-91 DoGetVolumeInfo return true slot=0 Volume=Full-0001, VolminBlocksize=0 VolMaxBlocksize=0
bareos-sd (50): stored/askdir.cc:144-91 setting dcr->VolMinBlocksize(0) to vol.VolMinBlocksize(0)
bareos-sd (50): stored/askdir.cc:147-91 setting dcr->VolMaxBlocksize(0) to vol.VolMaxBlocksize(0)
bareos-sd (100): stored/acquire.cc:646-91 0 writers, 0 reserve, dev="FileStorage" (/var/lib/bareos/storage)
bareos-sd (100): stored/dev.cc:1020-91 close_dev "FileStorage" (/var/lib/bareos/storage)
bareos-sd (100): stored/dev.cc:1129-91 Enter unmount
bareos-sd (100): stored/dev.cc:1008-91 Clear volhdr vol=Full-0001
bareos-sd (100): stored/acquire.cc:708-91 JobId=91 broadcast wait_device_release at 18-Feb-2020 16:44:01
bareos-sd (100): stored/acquire.cc:731-91 Device "FileStorage" (/var/lib/bareos/storage) released by JobId=91
bareos-sd (100): stored/spool.cc:774-91 Commit attributes at 18-Feb-2020 16:44:01
bareos-sd (100): stored/append.cc:349-91 return from DoAppendData() ok=1
bareos-sd (100): lib/bsock.cc:136-91 Destruct BareosSocket
bareos-sd (100): lib/bsys.cc:644-91 write_last_jobs seek to 192
bareos-sd (100): lib/jcr.cc:278-91 FreeCommonJcr: 7f3ebc016e80 
bareos-sd (100): lib/tls_openssl.cc:73-0 Destruct TLsOpenSsl Implementation Object
bareos-sd (100): lib/tls_openssl_private.cc:68-0 Destruct TlsOpenSslPrivate
bareos-sd (100): lib/bsock.cc:136-0 Destruct BareosSocket
bareos-sd (100): lib/bsock.cc:84-0 Construct BareosSocket
bareos-sd (100): lib/tls_openssl_private.cc:63-0 Construct TlsOpenSslPrivate
bareos-sd (100): lib/tls_openssl_private.cc:550-0 Set tcp filedescriptor: <6>
bareos-sd (100): lib/tls_openssl_private.cc:496-0 Set ca_certfile:	<>
bareos-sd (100): lib/tls_openssl_private.cc:502-0 Set ca_certdir:	<>
bareos-sd (100): lib/tls_openssl_private.cc:508-0 Set crlfile_:	<>
bareos-sd (100): lib/tls_openssl_private.cc:514-0 Set certfile_:	<>
bareos-sd (100): lib/tls_openssl_private.cc:520-0 Set keyfile_:	<>
bareos-sd (100): lib/tls_openssl_private.cc:538-0 Set dhfile_:	<>
bareos-sd (100): lib/tls_openssl_private.cc:556-0 Set cipherlist:	<>
bareos-sd (100): lib/tls_openssl_private.cc:544-0 Set Verify Peer:	<false>
bareos-sd (50): lib/tls_openssl.cc:100-0 Preparing TLS_PSK SERVER callback
bareos-sd (100): lib/tls_openssl_private.cc:414-0 psk_server_cb. identitiy: R_DIRECTOR bareos-dir.
bareos-sd (100): lib/tls_openssl_private.cc:435-0 psk_server_cb. result: 32.
bareos-sd (50): lib/bnet.cc:142-0 TLS server negotiation established.
bareos-sd (100): lib/jcr.cc:195-0 Construct JobControlRecord
bareos-sd (50): lib/cram_md5.cc:82-0 send: auth cram-md5 <468828736.1582040649@bareos-sd> ssl=1
bareos-sd (100): lib/cram_md5.cc:136-0 cram-get received: auth cram-md5 <975259508.1582040649@bareos-dir> ssl=1
bareos-sd (99): lib/cram_md5.cc:178-0 sending resp to challenge: zlNc84Ao1X+i58I6Z+/AXD
bareos-sd (90): stored/dir_cmd.cc:289-0 Message channel init completed.
bareos-sd (100): stored/job.cc:93-0 <dird: JobId=92 job=backup-win-fd.2020-02-18_16.44.07_30 job_name=backup-win-fd client_name=win10_1910-fd type=66 level=70 FileSet=Win NoAttr=0 SpoolAttr=0 FileSetMD5=Q7+v25/GiH/epgYEG5/4RC SpoolData=0 PreferMountedVols=1 SpoolSize=0 rerunning=0 VolSessionId=0 VolSessionTime=0 Quota=0 Protocol=0 BackupFormat=Native
bareos-sd (100): stored/job.cc:114-0 rerunning=0 VolSesId=0 VolSesTime=0 Protocol=0
bareos-sd (50): stored/job.cc:162-92 Quota set as 0
bareos-sd (50): stored/job.cc:172-92 >dird jid=92: 3000 OK Job SDid=12 SDtime=1582040123 Authorization=JCMF-LLIP-HBLP-JDJP-HMHH-PIBO-LBMB-JPNI
bareos-sd (100): stored/block.cc:136-92 created new block of blocksize 64512 (dev->max_block_size)
bareos-sd (50): stored/askdir.cc:205-92 DirFindNextAppendableVolume: reserved=1 Vol=
bareos-sd (50): stored/askdir.cc:226-92 >dird CatReq Job=backup-win-fd.2020-02-18_16.44.07_30 FindMedia=1 pool_name=Full media_type=File unwanted_volumes=
bareos-sd (50): stored/askdir.cc:106-92 <dird 1000 OK VolName=Full-0001 VolJobs=42 VolFiles=0 VolBlocks=42 VolBytes=59521 VolMounts=42 VolErrors=0 VolWrites=43 MaxVolBytes=53687091200 VolCapacityBytes=0 VolStatus=Append Slot=0 MaxVolJobs=0 MaxVolFiles=0 InChanger=0 VolReadTime=0 VolWriteTime=1646 EndFile=0 EndBlock=59520 LabelType=0 MediaId=1 EncryptionKey= MinBlocksize=0 MaxBlocksize=0
bareos-sd (50): stored/askdir.cc:141-92 DoGetVolumeInfo return true slot=0 Volume=Full-0001, VolminBlocksize=0 VolMaxBlocksize=0
bareos-sd (50): stored/askdir.cc:144-92 setting dcr->VolMinBlocksize(0) to vol.VolMinBlocksize(0)
bareos-sd (50): stored/askdir.cc:147-92 setting dcr->VolMaxBlocksize(0) to vol.VolMaxBlocksize(0)
bareos-sd (50): stored/askdir.cc:238-92 Call reserve_volume for write. Vol=Full-0001
bareos-sd (50): stored/askdir.cc:245-92 DirFindNextAppendableVolume return true. vol=Full-0001
bareos-sd (50): stored/job.cc:194-92 backup-win-fd.2020-02-18_16.44.07_30 waiting 1800 sec for FD to contact SD key=JCMF-LLIP-HBLP-JDJP-HMHH-PIBO-LBMB-JPNI
bareos-sd (100): lib/bsock.cc:84-0 Construct BareosSocket
bareos-sd (100): lib/bsock.cc:136-0 Destruct BareosSocket
bareos-sd (100): lib/bsock.cc:84-0 Construct BareosSocket
bareos-sd (100): lib/tls_openssl_private.cc:63-0 Construct TlsOpenSslPrivate
bareos-sd (100): lib/tls_openssl_private.cc:550-0 Set tcp filedescriptor: <8>
bareos-sd (100): lib/tls_openssl_private.cc:496-0 Set ca_certfile:	<>
bareos-sd (100): lib/tls_openssl_private.cc:502-0 Set ca_certdir:	<>
bareos-sd (100): lib/tls_openssl_private.cc:508-0 Set crlfile_:	<>
bareos-sd (100): lib/tls_openssl_private.cc:514-0 Set certfile_:	<>
bareos-sd (100): lib/tls_openssl_private.cc:520-0 Set keyfile_:	<>
bareos-sd (100): lib/tls_openssl_private.cc:538-0 Set dhfile_:	<>
bareos-sd (100): lib/tls_openssl_private.cc:556-0 Set cipherlist:	<>
bareos-sd (100): lib/tls_openssl_private.cc:544-0 Set Verify Peer:	<false>
bareos-sd (50): lib/tls_openssl.cc:100-0 Preparing TLS_PSK SERVER callback
bareos-sd (100): lib/tls_openssl_private.cc:414-0 psk_server_cb. identitiy: R_DIRECTOR bareos-dir.
bareos-sd (100): lib/tls_openssl_private.cc:435-0 psk_server_cb. result: 32.
bareos-sd (50): lib/bnet.cc:142-0 TLS server negotiation established.
bareos-sd (100): lib/jcr.cc:195-0 Construct JobControlRecord
bareos-sd (50): lib/cram_md5.cc:82-0 send: auth cram-md5 <730234987.1582040654@bareos-sd> ssl=1
bareos-sd (100): lib/cram_md5.cc:136-0 cram-get received: auth cram-md5 <416302.1582040654@bareos-dir> ssl=1
bareos-sd (99): lib/cram_md5.cc:178-0 sending resp to challenge: qC/Ee/d923oDa++FC4hXaC
bareos-sd (90): stored/dir_cmd.cc:289-0 Message channel init completed.
bareos-sd (50): stored/job.cc:212-92 Auth=0 canceled=1 errstat=0
bareos-sd (100): lib/bsys.cc:644-0 write_last_jobs seek to 192
bareos-sd (100): lib/jcr.cc:278-0 FreeCommonJcr: 7f3ebc012550 
bareos-sd (100): lib/tls_openssl.cc:73-0 Destruct TLsOpenSsl Implementation Object
bareos-sd (100): lib/tls_openssl_private.cc:68-0 Destruct TlsOpenSslPrivate
bareos-sd (100): lib/bsock.cc:136-0 Destruct BareosSocket
bareos-sd (100): lib/jcr.cc:278-0 FreeCommonJcr: 7f3ec4011ca0 
bareos-sd (100): lib/tls_openssl.cc:73-0 Destruct TLsOpenSsl Implementation Object
bareos-sd (100): lib/tls_openssl_private.cc:68-0 Destruct TlsOpenSslPrivate
bareos-sd (100): lib/bsock.cc:136-0 Destruct BareosSocket
bareos-sd (100): lib/bsock.cc:84-0 Construct BareosSocket
bareos-sd (100): lib/tls_openssl_private.cc:63-0 Construct TlsOpenSslPrivate
bareos-sd (100): lib/tls_openssl_private.cc:550-0 Set tcp filedescriptor: <6>
bareos-sd (100): lib/tls_openssl_private.cc:496-0 Set ca_certfile:	<>
bareos-sd (100): lib/tls_openssl_private.cc:502-0 Set ca_certdir:	<>
bareos-sd (100): lib/tls_openssl_private.cc:508-0 Set crlfile_:	<>
bareos-sd (100): lib/tls_openssl_private.cc:514-0 Set certfile_:	<>
bareos-sd (100): lib/tls_openssl_private.cc:520-0 Set keyfile_:	<>
bareos-sd (100): lib/tls_openssl_private.cc:538-0 Set dhfile_:	<>
bareos-sd (100): lib/tls_openssl_private.cc:556-0 Set cipherlist:	<>
bareos-sd (100): lib/tls_openssl_private.cc:544-0 Set Verify Peer:	<false>
bareos-sd (50): lib/tls_openssl.cc:100-0 Preparing TLS_PSK SERVER callback
bareos-sd (100): lib/tls_openssl_private.cc:414-0 psk_server_cb. identitiy: R_DIRECTOR bareos-dir.
bareos-sd (100): lib/tls_openssl_private.cc:435-0 psk_server_cb. result: 32.
bareos-sd (50): lib/bnet.cc:142-0 TLS server negotiation established.
bareos-sd (100): lib/jcr.cc:195-0 Construct JobControlRecord
bareos-sd (50): lib/cram_md5.cc:82-0 send: auth cram-md5 <1951224456.1582040663@bareos-sd> ssl=1
bareos-sd (100): lib/cram_md5.cc:136-0 cram-get received: auth cram-md5 <189743127.1582040663@bareos-dir> ssl=1
bareos-sd (99): lib/cram_md5.cc:178-0 sending resp to challenge: 1x+YeA+4R++WW8+5X6k8wD
bareos-sd (90): stored/dir_cmd.cc:289-0 Message channel init completed.
bareos-sd (100): stored/job.cc:93-0 <dird: JobId=93 job=backup-win-fd.2020-02-18_16.44.21_33 job_name=backup-win-fd client_name=win10_1910-fd type=66 level=70 FileSet=Win NoAttr=0 SpoolAttr=0 FileSetMD5=Q7+v25/GiH/epgYEG5/4RC SpoolData=0 PreferMountedVols=1 SpoolSize=0 rerunning=0 VolSessionId=0 VolSessionTime=0 Quota=0 Protocol=0 BackupFormat=Native
bareos-sd (100): stored/job.cc:114-0 rerunning=0 VolSesId=0 VolSesTime=0 Protocol=0
bareos-sd (50): stored/job.cc:162-93 Quota set as 0
bareos-sd (50): stored/job.cc:172-93 >dird jid=93: 3000 OK Job SDid=13 SDtime=1582040123 Authorization=GFMC-EIMJ-MCLO-NKDL-GLMH-JDPM-HCAK-CNAK
bareos-sd (100): stored/block.cc:136-93 created new block of blocksize 64512 (dev->max_block_size)
bareos-sd (50): stored/askdir.cc:205-93 DirFindNextAppendableVolume: reserved=1 Vol=
bareos-sd (50): stored/askdir.cc:226-93 >dird CatReq Job=backup-win-fd.2020-02-18_16.44.21_33 FindMedia=1 pool_name=Full media_type=File unwanted_volumes=
bareos-sd (50): stored/askdir.cc:106-93 <dird 1000 OK VolName=Full-0001 VolJobs=42 VolFiles=0 VolBlocks=42 VolBytes=59521 VolMounts=42 VolErrors=0 VolWrites=43 MaxVolBytes=53687091200 VolCapacityBytes=0 VolStatus=Append Slot=0 MaxVolJobs=0 MaxVolFiles=0 InChanger=0 VolReadTime=0 VolWriteTime=1646 EndFile=0 EndBlock=59520 LabelType=0 MediaId=1 EncryptionKey= MinBlocksize=0 MaxBlocksize=0
bareos-sd (50): stored/askdir.cc:141-93 DoGetVolumeInfo return true slot=0 Volume=Full-0001, VolminBlocksize=0 VolMaxBlocksize=0
bareos-sd (50): stored/askdir.cc:144-93 setting dcr->VolMinBlocksize(0) to vol.VolMinBlocksize(0)
bareos-sd (50): stored/askdir.cc:147-93 setting dcr->VolMaxBlocksize(0) to vol.VolMaxBlocksize(0)
bareos-sd (50): stored/askdir.cc:238-93 Call reserve_volume for write. Vol=Full-0001
bareos-sd (50): stored/askdir.cc:245-93 DirFindNextAppendableVolume return true. vol=Full-0001
bareos-sd (50): stored/job.cc:194-93 backup-win-fd.2020-02-18_16.44.21_33 waiting 1800 sec for FD to contact SD key=GFMC-EIMJ-MCLO-NKDL-GLMH-JDPM-HCAK-CNAK
bareos-sd (100): lib/bsock.cc:84-0 Construct BareosSocket
bareos-sd (50): stored/fd_cmds.cc:120-0 Found Job backup-win-fd.2020-02-18_16.44.21_33
bareos-sd (50): lib/cram_md5.cc:82-0 send: auth cram-md5 <1015463404.1582040663@bareos-sd> ssl=1
bareos-sd (100): lib/cram_md5.cc:136-0 cram-get received: auth cram-md5 <869.1582040663@win10_1910-fd> ssl=0
bareos-sd (99): lib/cram_md5.cc:178-0 sending resp to challenge: rC/I/++WSkFhb6/ZDU+LCD
bareos-sd (50): stored/fd_cmds.cc:148-0 OK Authentication jid=93 Job backup-win-fd.2020-02-18_16.44.21_33
bareos-sd (50): stored/job.cc:212-93 Auth=1 canceled=0 errstat=0
bareos-sd (100): stored/append.cc:79-93 Start append data. res=1
bareos-sd (100): stored/acquire.cc:455-93 acquire_append device is disk
bareos-sd (100): stored/mount.cc:673-93 No swap_dev set
bareos-sd (50): stored/askdir.cc:179-93 >dird CatReq Job=backup-win-fd.2020-02-18_16.44.21_33 GetVolInfo VolName=Full-0001 write=1
bareos-sd (50): stored/askdir.cc:106-93 <dird 1000 OK VolName=Full-0001 VolJobs=42 VolFiles=0 VolBlocks=42 VolBytes=59521 VolMounts=42 VolErrors=0 VolWrites=43 MaxVolBytes=53687091200 VolCapacityBytes=0 VolStatus=Append Slot=0 MaxVolJobs=0 MaxVolFiles=0 InChanger=0 VolReadTime=0 VolWriteTime=1646 EndFile=0 EndBlock=59520 LabelType=0 MediaId=1 EncryptionKey= MinBlocksize=0 MaxBlocksize=0
bareos-sd (50): stored/askdir.cc:141-93 DoGetVolumeInfo return true slot=0 Volume=Full-0001, VolminBlocksize=0 VolMaxBlocksize=0
bareos-sd (50): stored/askdir.cc:144-93 setting dcr->VolMinBlocksize(0) to vol.VolMinBlocksize(0)
bareos-sd (50): stored/askdir.cc:147-93 setting dcr->VolMaxBlocksize(0) to vol.VolMaxBlocksize(0)
bareos-sd (100): stored/autochanger.cc:136-93 Device "FileStorage" (/var/lib/bareos/storage) is not an autochanger
bareos-sd (100): stored/dev.cc:646-93 open dev: type=1 dev_name="FileStorage" (/var/lib/bareos/storage) vol=Full-0001 mode=OPEN_READ_WRITE
bareos-sd (100): stored/dev.cc:665-93 call OpenDevice mode=OPEN_READ_WRITE
bareos-sd (100): stored/dev.cc:741-93 open disk: mode=OPEN_READ_WRITE open(/var/lib/bareos/storage/Full-0001, 00000002, 0640)
bareos-sd (100): stored/dev.cc:757-93 open dev: disk fd=9 opened
bareos-sd (100): stored/dev.cc:673-93 preserve=31207074506 fd=9
bareos-sd (100): stored/dev.cc:590-93 setting minblocksize to 64512, maxblocksize to label_block_size=64512, on device "FileStorage" (/var/lib/bareos/storage)
bareos-sd (100): stored/label.cc:92-93 Enter ReadVolumeLabel res=1 device="FileStorage" (/var/lib/bareos/storage) vol=Full-0001 dev_Vol=*NULL* max_blocksize=64512
bareos-sd (100): stored/label.cc:265-93 Call reserve_volume=Full-0001
bareos-sd (100): stored/dev.cc:509-93 Device "FileStorage" (/var/lib/bareos/storage) has dev->device->max_block_size of 0 and dev->max_block_size of 64512, dcr->VolMaxBlocksize is 0
bareos-sd (100): stored/dev.cc:558-93 set minblocksize to 64512, maxblocksize to 64512 on device "FileStorage" (/var/lib/bareos/storage)
bareos-sd (50): stored/askdir.cc:179-93 >dird CatReq Job=backup-win-fd.2020-02-18_16.44.21_33 GetVolInfo VolName=Full-0001 write=1
bareos-sd (50): stored/askdir.cc:106-93 <dird 1000 OK VolName=Full-0001 VolJobs=42 VolFiles=0 VolBlocks=42 VolBytes=59521 VolMounts=42 VolErrors=0 VolWrites=43 MaxVolBytes=53687091200 VolCapacityBytes=0 VolStatus=Append Slot=0 MaxVolJobs=0 MaxVolFiles=0 InChanger=0 VolReadTime=0 VolWriteTime=1646 EndFile=0 EndBlock=59520 LabelType=0 MediaId=1 EncryptionKey= MinBlocksize=0 MaxBlocksize=0
bareos-sd (50): stored/askdir.cc:141-93 DoGetVolumeInfo return true slot=0 Volume=Full-0001, VolminBlocksize=0 VolMaxBlocksize=0
bareos-sd (50): stored/askdir.cc:144-93 setting dcr->VolMinBlocksize(0) to vol.VolMinBlocksize(0)
bareos-sd (50): stored/askdir.cc:147-93 setting dcr->VolMaxBlocksize(0) to vol.VolMaxBlocksize(0)
bareos-sd (100): stored/dev.cc:509-93 Device "FileStorage" (/var/lib/bareos/storage) has dev->device->max_block_size of 0 and dev->max_block_size of 64512, dcr->VolMaxBlocksize is 0
bareos-sd (100): stored/dev.cc:558-93 set minblocksize to 64512, maxblocksize to 64512 on device "FileStorage" (/var/lib/bareos/storage)
bareos-sd (100): stored/mount.cc:353-93 Device previously written, moving to end of data. Expect 59521 bytes
bareos-sd (100): stored/dev.cc:839-93 Enter eod
bareos-sd (50): stored/askdir.cc:302-93 Update cat VolBytes=59521
bareos-sd (50): stored/askdir.cc:325-93 >dird CatReq Job=backup-win-fd.2020-02-18_16.44.21_33 UpdateMedia VolName=Full-0001 VolJobs=42 VolFiles=0 VolBlocks=42 VolBytes=59521 VolMounts=43 VolErrors=0 VolWrites=43 MaxVolBytes=53687091200 EndTime=1582040663 VolStatus=Append Slot=0 relabel=0 InChanger=0 VolReadTime=0 VolWriteTime=1646 VolFirstWritten=0
bareos-sd (50): stored/askdir.cc:106-93 <dird 1000 OK VolName=Full-0001 VolJobs=42 VolFiles=0 VolBlocks=42 VolBytes=59521 VolMounts=43 VolErrors=0 VolWrites=43 MaxVolBytes=53687091200 VolCapacityBytes=0 VolStatus=Append Slot=0 MaxVolJobs=0 MaxVolFiles=0 InChanger=0 VolReadTime=0 VolWriteTime=1646 EndFile=0 EndBlock=59520 LabelType=0 MediaId=1 EncryptionKey= MinBlocksize=0 MaxBlocksize=0
bareos-sd (50): stored/askdir.cc:141-93 DoGetVolumeInfo return true slot=0 Volume=Full-0001, VolminBlocksize=0 VolMaxBlocksize=0
bareos-sd (50): stored/askdir.cc:144-93 setting dcr->VolMinBlocksize(0) to vol.VolMinBlocksize(0)
bareos-sd (50): stored/askdir.cc:147-93 setting dcr->VolMaxBlocksize(0) to vol.VolMaxBlocksize(0)
bareos-sd (100): stored/acquire.cc:515-93 === nwriters=1 nres=1 vcatjob=43 dev="FileStorage" (/var/lib/bareos/storage)
bareos-sd (50): stored/askdir.cc:302-93 Update cat VolBytes=59521
bareos-sd (50): stored/askdir.cc:325-93 >dird CatReq Job=backup-win-fd.2020-02-18_16.44.21_33 UpdateMedia VolName=Full-0001 VolJobs=43 VolFiles=0 VolBlocks=42 VolBytes=59521 VolMounts=43 VolErrors=0 VolWrites=43 MaxVolBytes=53687091200 EndTime=1582040663 VolStatus=Append Slot=0 relabel=0 InChanger=0 VolReadTime=0 VolWriteTime=1646 VolFirstWritten=0
bareos-sd (50): stored/askdir.cc:106-93 <dird 1000 OK VolName=Full-0001 VolJobs=43 VolFiles=0 VolBlocks=42 VolBytes=59521 VolMounts=43 VolErrors=0 VolWrites=43 MaxVolBytes=53687091200 VolCapacityBytes=0 VolStatus=Append Slot=0 MaxVolJobs=0 MaxVolFiles=0 InChanger=0 VolReadTime=0 VolWriteTime=1646 EndFile=0 EndBlock=59520 LabelType=0 MediaId=1 EncryptionKey= MinBlocksize=0 MaxBlocksize=0
bareos-sd (50): stored/askdir.cc:141-93 DoGetVolumeInfo return true slot=0 Volume=Full-0001, VolminBlocksize=0 VolMaxBlocksize=0
bareos-sd (50): stored/askdir.cc:144-93 setting dcr->VolMinBlocksize(0) to vol.VolMinBlocksize(0)
bareos-sd (50): stored/askdir.cc:147-93 setting dcr->VolMaxBlocksize(0) to vol.VolMaxBlocksize(0)
bareos-sd (50): stored/append.cc:98-93 Begin append device="FileStorage" (/var/lib/bareos/storage)
bareos-sd (100): stored/append.cc:107-93 Just after AcquireDeviceForAppend
bareos-sd (90): stored/append.cc:295-93 back from write_end_session_label()
bareos-sd (100): stored/acquire.cc:578-93 releasing device "FileStorage" (/var/lib/bareos/storage)
bareos-sd (100): stored/acquire.cc:603-93 There are 0 writers in ReleaseDevice
bareos-sd (50): stored/askdir.cc:386-93 >dird CatReq Job=backup-win-fd.2020-02-18_16.44.21_33 CreateJobMedia FirstIndex=1 LastIndex=2 StartFile=0 EndFile=0 StartBlock=59521 EndBlock=60854 Copy=0 Strip=0 MediaId=1
bareos-sd (50): stored/askdir.cc:394-93 <dird 1000 OK CreateJobMedia
bareos-sd (50): stored/askdir.cc:302-93 Update cat VolBytes=60855
bareos-sd (50): stored/askdir.cc:325-93 >dird CatReq Job=backup-win-fd.2020-02-18_16.44.21_33 UpdateMedia VolName=Full-0001 VolJobs=43 VolFiles=0 VolBlocks=43 VolBytes=60855 VolMounts=43 VolErrors=0 VolWrites=44 MaxVolBytes=53687091200 EndTime=1582040683 VolStatus=Append Slot=0 relabel=0 InChanger=0 VolReadTime=0 VolWriteTime=1652 VolFirstWritten=0
bareos-sd (50): stored/askdir.cc:106-93 <dird 1000 OK VolName=Full-0001 VolJobs=43 VolFiles=0 VolBlocks=43 VolBytes=60855 VolMounts=43 VolErrors=0 VolWrites=44 MaxVolBytes=53687091200 VolCapacityBytes=0 VolStatus=Append Slot=0 MaxVolJobs=0 MaxVolFiles=0 InChanger=0 VolReadTime=0 VolWriteTime=1652 EndFile=0 EndBlock=60854 LabelType=0 MediaId=1 EncryptionKey= MinBlocksize=0 MaxBlocksize=0
bareos-sd (50): stored/askdir.cc:141-93 DoGetVolumeInfo return true slot=0 Volume=Full-0001, VolminBlocksize=0 VolMaxBlocksize=0
bareos-sd (50): stored/askdir.cc:144-93 setting dcr->VolMinBlocksize(0) to vol.VolMinBlocksize(0)
bareos-sd (50): stored/askdir.cc:147-93 setting dcr->VolMaxBlocksize(0) to vol.VolMaxBlocksize(0)
bareos-sd (100): stored/acquire.cc:646-93 0 writers, 0 reserve, dev="FileStorage" (/var/lib/bareos/storage)
bareos-sd (100): stored/dev.cc:1020-93 close_dev "FileStorage" (/var/lib/bareos/storage)
bareos-sd (100): stored/dev.cc:1129-93 Enter unmount
bareos-sd (100): stored/dev.cc:1008-93 Clear volhdr vol=Full-0001
bareos-sd (100): stored/acquire.cc:708-93 JobId=93 broadcast wait_device_release at 18-Feb-2020 16:44:43
bareos-sd (100): stored/acquire.cc:731-93 Device "FileStorage" (/var/lib/bareos/storage) released by JobId=93
bareos-sd (100): stored/spool.cc:774-93 Commit attributes at 18-Feb-2020 16:44:43
bareos-sd (100): stored/append.cc:349-93 return from DoAppendData() ok=1
bareos-sd (100): lib/bsock.cc:136-93 Destruct BareosSocket
bareos-sd (100): lib/bsys.cc:644-93 write_last_jobs seek to 192
bareos-sd (100): lib/jcr.cc:278-93 FreeCommonJcr: 7f3ec4010df0 
bareos-sd (100): lib/tls_openssl.cc:73-0 Destruct TLsOpenSsl Implementation Object
bareos-sd (100): lib/tls_openssl_private.cc:68-0 Destruct TlsOpenSslPrivate
bareos-sd (100): lib/bsock.cc:136-0 Destruct BareosSocket