I continue to have random trouble with running jobs on Windows machines located on remote subnets. Maybe being on another subnet has nothing to do with it, but I am running between firewalls.
I can check the status of the problem client just fine and make a connection to start a job, but always get the Authorization key rejected by Storage daemon error in a short time. The host file on the Windows box has the full name of the storage daemon and the public IP for proper name resolution. (Public is nated to private) I have reinstalled bacula 5.3 and edited the config files twice, just to be sure names and passwords matched. debug shows the following: root@maccray:/etc/bacula# bacula-sd -d 200 bacula-sd: stored_conf.c:698-0 Inserting director res: vmserver-2-mon vmserver-2-sd: jcr.c:138-0 read_last_jobs seek to 188 vmserver-2-sd: jcr.c:145-0 Read num_items=10 root@maccray:/etc/bacula# vmserver-2-sd: bpipe.c:367-0 Run program returning 0 vmserver-2-sd: bnet_server.c:96-0 Addresses host[ipv4:0.0.0.0:9103] vmserver-2-sd: stored.c:535-0 calling init_dev /Backups vmserver-2-sd: dev.c:284-0 init_dev: tape=0 dev_name=/Backups vmserver-2-sd: stored.c:537-0 SD init done /Backups vmserver-2-sd: mem_pool.c:369-0 garbage collect memory pool vmserver-2-sd: bnet.c:669-0 who=client host=10.10.1.49 port=36643 vmserver-2-sd: dircmd.c:173-0 Conn: Hello Director vmserver-2-dir calling vmserver-2-sd: dircmd.c:189-0 Got a DIR connection at 15-Mar-2011 14:24:19 vmserver-2-sd: cram-md5.c:73-0 send: auth cram-md5 <1431400194.1300217059@vmserver-2-sd> ssl=0 vmserver-2-sd: cram-md5.c:133-0 cram-get received: auth cram-md5 <1853643290.1300217059@vmserver-2-dir> ssl=0 vmserver-2-sd: cram-md5.c:152-0 sending resp to challenge: flNvjSZFw8+mrWZBOxVx0B vmserver-2-sd: dircmd.c:211-0 Message channel init completed. vmserver-2-sd: dircmd.c:218-0 <dird: JobId=208 job=hsgx520-fd.2011-03-15_14.24.17_13 job_name=hsgx520-fd client_name=hsgx520-fd type=66 level=70 FileSet=hsgx520-fdSet NoAttr=0 SpoolAttr=0 FileSetMD5=N8Rb0F8jS1MIpW/dJ6+mHA SpoolData=0 WritePartAfterJob=1 PreferMountedVols=1 SpoolSize=0 Resched=157412024 vmserver-2-sd: dircmd.c:232-0 Do command: JobId= vmserver-2-sd: job.c:96-0 <dird: JobId=208 job=hsgx520-fd.2011-03-15_14.24.17_13 job_name=hsgx520-fd client_name=hsgx520-fd type=66 level=70 FileSet=hsgx520-fdSet NoAttr=0 SpoolAttr=0 FileSetMD5=N8Rb0F8jS1MIpW/dJ6+mHA SpoolData=0 WritePartAfterJob=1 PreferMountedVols=1 SpoolSize=0 Resched=157412024 vmserver-2-sd: job.c:171-0 >dird jid=208: 3000 OK Job SDid=1 SDtime=1300217043 Authorization=JPOA-CMMA-CIBB-NLCD-IPJB-OPEP-BGCH-AAFC vmserver-2-sd: dircmd.c:218-0 <dird: use storage=File media_type=File pool_name=Default pool_type=Backup append=1 copy=0 stripe=0 vmserver-2-sd: dircmd.c:232-0 Do command: use storage= vmserver-2-sd: reserve.c:200-0 <dird: use storage=File media_type=File pool_name=Default pool_type=Backup append=1 copy=0 stripe=0 vmserver-2-sd: reserve.c:229-0 <dird device: use device=FileStorage vmserver-2-sd: reserve.c:245-0 Storage=File media_type=File pool=Default pool_type=Backup append=1 vmserver-2-sd: reserve.c:247-0 Device=FileStorage vmserver-2-sd: reserve.c:419-0 Start find_suit_dev PrefMnt=1 exact=1 suitable=0 chgronly=0 any=0 vmserver-2-sd: reserve.c:544-0 search res for FileStorage vmserver-2-sd: reserve.c:578-0 Try match res=FileStorage vmserver-2-sd: reserve.c:615-0 chk MediaType device=File request=File vmserver-2-sd: reserve.c:638-0 try reserve FileStorage vmserver-2-sd: reserve.c:655-0 call reserve for append: have_vol=0 vol= vmserver-2-sd: reserve.c:845-0 reserve_append device is "FileStorage" (/Backups) vmserver-2-sd: reserve.c:931-0 PrefMnt=1 exact=1 suitable=1 chgronly=0 any=0 vmserver-2-sd: reserve.c:893-0 MaxJobs=0 Jobs=0 reserves=0 Status= Vol= vmserver-2-sd: reserve.c:1035-0 OK Dev avail reserved "FileStorage" (/Backups) vmserver-2-sd: reserve.c:129-0 Inc reserve=0 dev="FileStorage" (/Backups) vmserver-2-sd: reserve.c:664-0 Reserved=1 dev_name=FileStorage mediatype=File pool=Default ok=1 vmserver-2-sd: reserve.c:666-0 Vol= num_writers=0, have_vol=0 vmserver-2-sd: reserve.c:677-0 no vol, call find_next_appendable_vol. vmserver-2-sd: askdir.c:260-0 dir_find_next_appendable_volume: reserved=1 Vol= vmserver-2-sd: askdir.c:277-0 >dird CatReq Job=hsgx520-fd.2011-03-15_14.24.17_13 FindMedia=1 pool_name=Default media_type=File vmserver-2-sd: askdir.c:182-0 <dird 1000 OK VolName=Vol1b VolJobs=20 VolFiles=3 VolBlocks=213004 VolBytes=16244533255 VolMounts=20 VolErrors=0 VolWrites=213005 MaxVolBytes=0 VolCapacityBytes=0 VolStatus=Append Slot=0 MaxVolJobs=0 MaxVolFiles=0 InChanger=0 VolReadTime=0 VolWriteTime=1084855850 EndFile=3 EndBlock=3359631366 VolParts=0 LabelType=0 MediaId=4 vmserver-2-sd: askdir.c:206-0 do_reqest_vol_info return true slot=0 Volume=Vol1b vmserver-2-sd: vol_mgr.c:544-0 find_read_vol: read_vol_list empty. vmserver-2-sd: vol_mgr.c:724-0 Vol=Vol1b not in use. vmserver-2-sd: askdir.c:286-0 Call reserve_volume. Vol=Vol1b vmserver-2-sd: vol_mgr.c:351-0 enter reserve_volume=Vol1b drive="FileStorage" (/Backups) vmserver-2-sd: vol_mgr.c:267-0 new Vol=Vol1b at 8de0cd8 dev="FileStorage" (/Backups) vmserver-2-sd: vol_mgr.c:469-0 === set in_use. vol=Vol1b dev="FileStorage" (/Backups) vmserver-2-sd: vol_mgr.c:210-0 List end new volume: Vol1b in_use=1 on device "FileStorage" (/Backups) vmserver-2-sd: askdir.c:293-0 dir_find_next_appendable_volume return true. vol=Vol1b vmserver-2-sd: reserve.c:681-0 looking for Volume=Vol1b vmserver-2-sd: reserve.c:738-0 >dird: 3000 OK use device device=FileStorage vmserver-2-sd: reserve.c:588-0 Device FileStorage reserved=1 for append. vmserver-2-sd: reserve.c:513-0 available device found=FileStorage vmserver-2-sd: reserve.c:528-0 OK dev found. Vol=Vol1b vmserver-2-sd: dircmd.c:218-0 <dird: run vmserver-2-sd: dircmd.c:232-0 Do command: run vmserver-2-sd: job.c:186-0 Run_cmd: run vmserver-2-sd: job.c:204-0 hsgx520-fd.2011-03-15_14.24.17_13 waiting 1800 sec for FD to contact SD key=JPOA-CMMA-CIBB-NLCD-IPJB-OPEP-BGCH-AAFC vmserver-2-sd: bnet.c:669-0 who=client host=Public IP port=36643 vmserver-2-sd: bnet.c:669-0 who=client host=10.10.1.49 port=36643 vmserver-2-sd: dircmd.c:173-0 Conn: Hello Director vmserver-2-dir calling vmserver-2-sd: dircmd.c:189-0 Got a DIR connection at 15-Mar-2011 14:24:30 vmserver-2-sd: cram-md5.c:73-0 send: auth cram-md5 <307555062.1300217070@vmserver-2-sd> ssl=0 vmserver-2-sd: cram-md5.c:133-0 cram-get received: auth cram-md5 <1845678713.1300217070@vmserver-2-dir> ssl=0 vmserver-2-sd: cram-md5.c:152-0 sending resp to challenge: oA1mvkN6++hquk+gF+5F1A vmserver-2-sd: dircmd.c:211-0 Message channel init completed. vmserver-2-sd: dircmd.c:218-0 <dird: cancel Job=hsgx520-fd.2011-03-15_14.24.17_13 vmserver-2-sd: dircmd.c:232-0 Do command: cancel vmserver-2-sd: job.c:221-0 Auth=0 canceled=1 errstat=0 vmserver-2-sd: dircmd.c:235-0 Command run requests quit vmserver-2-sd: reserve.c:138-0 Dec reserve=0 dev="FileStorage" (/Backups) vmserver-2-sd: vol_mgr.c:593-0 === set not reserved vol=Vol1b num_writers=0 dev_reserved=0 dev="FileStorage" (/Backups) vmserver-2-sd: vol_mgr.c:594-0 === clear in_use vol=Vol1b vmserver-2-sd: vol_mgr.c:622-0 === clear in_use vol=Vol1b vmserver-2-sd: vol_mgr.c:625-0 === remove volume Vol1b dev="FileStorage" (/Backups) vmserver-2-sd: jcr.c:181-0 write_last_jobs seek to 188 vmserver-2-sd: mem_pool.c:369-0 garbage collect memory pool vmserver-2-sd: mem_pool.c:369-0 garbage collect memory pool ------------------------------------------------------------------------------ Colocation vs. Managed Hosting A question and answer guide to determining the best fit for your organization - today and in the future. http://p.sf.net/sfu/internap-sfd2d _______________________________________________ Bacula-users mailing list Bacula-users@lists.sourceforge.net https://lists.sourceforge.net/lists/listinfo/bacula-users
