Hello,
This looks like bug #1227, but since I no longer have much time for support, I
didn't look carefully at your output.
This problem is fixed in the current beta release, and I'll probably release a
patch for the 2.4 Branch a bit later today.
Regards,
Kern
On Wednesday 18 March 2009 11:44:47 Stephen Maher wrote:
> Hi Kern..
>
> You have helped me in the past via email.. and hoping to chance my arm
> again :-)
>
> I think I might have found a potential bug with bacula.. but would
> need some help in diagnosing.
> Basically its asking for tape 38 yet tape 38 is there and in the
> drive. The director keeps stating to insert the tape..
>
> Could you please have a look down below and see if its a potential bug?
>
> If you need any more info please let me know
>
> Many thanks
> Stephen
>
>
> 17-Mar 04:45 mop-sd JobId 49: Please mount Volume "000038" or label a
> new one for:
> Job: bushmills.2009-03-13_20.30.16
> Storage: "124t-1" (/dev/nst0)
> Pool: Default
> Media type: LTO-1
> *list media
> Pool: Default
> +---------+------------+-----------+---------+-----------------+----------+
>--------------+---------+------+-----------+-----------+--------------------
>-+
>
> | MediaId | VolumeName | VolStatus | Enabled | VolBytes |
>
> VolFiles | VolRetention | Recycle | Slot | InChanger | MediaType |
> LastWritten |
> +---------+------------+-----------+---------+-----------------+----------+
>--------------+---------+------+-----------+-----------+--------------------
>-+
>
> | 1 | 000025 | Full | 1 | 128,079,866,880 |
>
> 129 | 2,592,000 | 1 | 1 | 0 | LTO-1 |
> 2009-02-27 23:08:07 |
>
> | 2 | 000026 | Full | 1 | 107,123,143,680 |
>
> 108 | 2,592,000 | 1 | 2 | 0 | LTO-1 |
> 2009-02-28 01:25:47 |
>
> | 3 | 000027 | Full | 1 | 106,705,299,456 |
>
> 107 | 2,592,000 | 1 | 3 | 0 | LTO-1 |
> 2009-02-28 03:21:19 |
>
> | 4 | 000028 | Full | 1 | 122,908,520,448 |
>
> 123 | 2,592,000 | 1 | 4 | 0 | LTO-1 |
> 2009-02-28 05:38:32 |
>
> | 5 | 000029 | Full | 1 | 131,950,715,904 |
>
> 132 | 2,592,000 | 1 | 5 | 0 | LTO-1 |
> 2009-02-28 08:00:14 |
>
> | 6 | 000030 | Full | 1 | 110,486,799,360 |
>
> 111 | 2,592,000 | 1 | 6 | 0 | LTO-1 |
> 2009-02-28 10:05:31 |
>
> | 7 | 000031 | Full | 1 | 115,940,837,376 |
>
> 116 | 2,592,000 | 1 | 7 | 0 | LTO-1 |
> 2009-02-28 12:10:56 |
>
> | 8 | 000032 | Full | 1 | 161,427,474,432 |
>
> 162 | 2,592,000 | 1 | 8 | 0 | LTO-1 |
> 2009-02-28 14:57:15 |
>
> | 9 | 000033 | Full | 1 | 146,252,058,624 |
>
> 147 | 2,592,000 | 1 | 9 | 0 | LTO-1 |
> 2009-02-28 17:05:58 |
>
> | 10 | 000034 | Full | 1 | 169,546,567,680 |
>
> 173 | 2,592,000 | 1 | 10 | 0 | LTO-1 |
> 2009-03-05 00:15:14 |
>
> | 11 | 000035 | Full | 1 | 133,992,133,632 |
>
> 138 | 2,592,000 | 1 | 1 | 1 | LTO-1 |
> 2009-03-07 00:29:44 |
>
> | 26 | 000037 | Full | 1 | 129,891,492,864 |
>
> 131 | 2,592,000 | 1 | 3 | 1 | LTO-1 |
> 2009-03-06 23:02:47 |
>
> | 27 | 000036 | Full | 1 | 162,726,617,088 |
>
> 169 | 2,592,000 | 1 | 2 | 1 | LTO-1 |
> 2009-03-13 21:42:32 |
>
> | 28 | 000038 | Append | 1 | 64,512 |
>
> 0 | 2,592,000 | 1 | 4 | 1 | LTO-1 |
> 0000-00-00 00:00:00 |
>
> | 29 | 000039 | Append | 1 | 64,512 |
>
> 0 | 2,592,000 | 1 | 5 | 1 | LTO-1 |
> 0000-00-00 00:00:00 |
>
> | 30 | 000040 | Append | 1 | 64,512 |
>
> 0 | 2,592,000 | 1 | 6 | 1 | LTO-1 |
> 0000-00-00 00:00:00 |
>
> | 31 | 000041 | Append | 1 | 64,512 |
>
> 0 | 2,592,000 | 1 | 7 | 1 | LTO-1 |
> 0000-00-00 00:00:00 |
>
> | 32 | 000042 | Append | 1 | 64,512 |
>
> 0 | 2,592,000 | 1 | 8 | 1 | LTO-1 |
> 0000-00-00 00:00:00 |
>
> | 33 | 000043 | Append | 1 | 64,512 |
>
> 0 | 2,592,000 | 1 | 9 | 1 | LTO-1 |
> 0000-00-00 00:00:00 |
>
> | 34 | 000044 | Append | 1 | 64,512 |
>
> 0 | 2,592,000 | 1 | 10 | 1 | LTO-1 |
> 0000-00-00 00:00:00 |
>
> | 35 | 000045 | Append | 1 | 64,512 |
>
> 0 | 2,592,000 | 1 | 11 | 1 | LTO-1 |
> 0000-00-00 00:00:00 |
>
> | 36 | 000046 | Append | 1 | 64,512 |
>
> 0 | 2,592,000 | 1 | 12 | 1 | LTO-1 |
> 0000-00-00 00:00:00 |
>
> | 37 | 000047 | Append | 1 | 64,512 |
>
> 0 | 2,592,000 | 1 | 13 | 1 | LTO-1 |
> 0000-00-00 00:00:00 |
>
> | 38 | 000048 | Append | 1 | 64,512 |
>
> 0 | 2,592,000 | 1 | 14 | 1 | LTO-1 |
> 0000-00-00 00:00:00 |
>
> | 39 | 000049 | Append | 1 | 64,512 |
>
> 0 | 2,592,000 | 1 | 15 | 1 | LTO-1 |
> 0000-00-00 00:00:00 |
>
> | 40 | 000050 | Full | 1 | 174,568,439,808 |
>
> 181 | 2,592,000 | 1 | 16 | 1 | LTO-1 |
> 2009-03-13 00:03:37 |
> +---------+------------+-----------+---------+-----------------+----------+
>--------------+---------+------+-----------+-----------+--------------------
>-+ root@mop:~# bacula-sd -c /etc/bacula/bacula-sd.conf -f -d99 -v
> bacula-sd: stored_conf.c:672-0 Inserting director res: mop-mon
> bacula-sd: stored_conf.c:672-0 Inserting device res: 124t-1
> mop-sd: stored.c:480-0 calling init_dev /tmp/
> mop-sd: stored.c:482-0 SD init done /tmp/
> mop-sd: stored.c:480-0 calling init_dev /dev/nst0
> mop-sd: stored.c:482-0 SD init done /dev/nst0
> mop-sd: cram-md5.c:73-0 send: auth cram-md5 <200307337.1237372850@mop-sd>
> ssl=0 mop-sd: cram-md5.c:152-0 sending resp to challenge:
> mop-sd: dircmd.c:210-0 Message channel init completed.
> mop-sd: reserve.c:695-0 jid=60 <dird: use storage=PowerVault
> media_type=LTO-1 pool_name=Default pool_type=Backup append=1 copy=0
> stripe=0
> mop-sd: reserve.c:724-0 jid=60 <dird device: use device=PowerVault
> mop-sd: reserve.c:741-0 jid=60 Storage=PowerVault media_type=LTO-1
> pool=Default pool_type=Backup append=1
> mop-sd: reserve.c:743-0 jid=60 Device=PowerVault
> mop-sd: reserve.c:919-0 jid=60 PrefMnt=1 exact=1 suitable=0 chgronly=0
> mop-sd: reserve.c:1084-0 jid=60 search res for PowerVault
> mop-sd: reserve.c:1087-0 jid=60 Try match changer res=PowerVault
> mop-sd: reserve.c:1098-0 jid=60 Try changer device 124t-1
> mop-sd: reserve.c:1161-0 jid=60 chk MediaType device=LTO-1 request=LTO-1
> mop-sd: reserve.c:1184-0 try reserve 124t-1
> mop-sd: reserve.c:1198-0 jid=60 have_vol=0 vol=
> mop-sd: reserve.c:1381-0 jid=60 reserve_append device is "124t-1"
> (/dev/nst0) mop-sd: reserve.c:1459-0 jid=60 PrefMnt=1 exact=1 suitable=1
> chgronly=0 any=0 mop-sd: reserve.c:1430-0 MaxJobs=0 Jobs=0 reserves=0
> Status= Vol=
> mop-sd: reserve.c:1503-0 jid=60 failed: want mounted -- no vol
> mop-sd: reserve.c:1385-0 jid=60 can_reserve_drive!=1
> mop-sd: reserve.c:1287-0 jid=60 Not OK.
> mop-sd: reserve.c:1121-0 jid=60 Try match res=FileStorage
> mop-sd: reserve.c:1121-0 jid=60 Try match res=124t-1
> mop-sd: reserve.c:1060-0 jid=60 No usable device found.
> mop-sd: reserve.c:1070-0 Leave find_suit_dev: no dev found.
> mop-sd: reserve.c:919-0 jid=60 PrefMnt=1 exact=0 suitable=1 chgronly=0
> mop-sd: reserve.c:1084-0 jid=60 search res for PowerVault
> mop-sd: reserve.c:1087-0 jid=60 Try match changer res=PowerVault
> mop-sd: reserve.c:1098-0 jid=60 Try changer device 124t-1
> mop-sd: reserve.c:1161-0 jid=60 chk MediaType device=LTO-1 request=LTO-1
> mop-sd: reserve.c:1184-0 try reserve 124t-1
> mop-sd: reserve.c:1198-0 jid=60 have_vol=0 vol=
> mop-sd: reserve.c:1381-0 jid=60 reserve_append device is "124t-1"
> (/dev/nst0) mop-sd: reserve.c:1459-0 jid=60 PrefMnt=1 exact=0 suitable=1
> chgronly=0 any=0 mop-sd: reserve.c:1430-0 MaxJobs=0 Jobs=0 reserves=0
> Status= Vol=
> mop-sd: reserve.c:1503-0 jid=60 failed: want mounted -- no vol
> mop-sd: reserve.c:1385-0 jid=60 can_reserve_drive!=1
> mop-sd: reserve.c:1287-0 jid=60 Not OK.
> mop-sd: reserve.c:1121-0 jid=60 Try match res=FileStorage
> mop-sd: reserve.c:1121-0 jid=60 Try match res=124t-1
> mop-sd: reserve.c:1060-0 jid=60 No usable device found.
> mop-sd: reserve.c:1070-0 Leave find_suit_dev: no dev found.
> mop-sd: reserve.c:919-0 jid=60 PrefMnt=1 exact=0 suitable=1 chgronly=0
> mop-sd: reserve.c:1084-0 jid=60 search res for PowerVault
> mop-sd: reserve.c:1087-0 jid=60 Try match changer res=PowerVault
> mop-sd: reserve.c:1098-0 jid=60 Try changer device 124t-1
> mop-sd: reserve.c:1161-0 jid=60 chk MediaType device=LTO-1 request=LTO-1
> mop-sd: reserve.c:1184-0 try reserve 124t-1
> mop-sd: reserve.c:1198-0 jid=60 have_vol=0 vol=
> mop-sd: reserve.c:1381-0 jid=60 reserve_append device is "124t-1"
> (/dev/nst0) mop-sd: reserve.c:1459-0 jid=60 PrefMnt=1 exact=0 suitable=1
> chgronly=0 any=1 mop-sd: reserve.c:1430-0 MaxJobs=0 Jobs=0 reserves=0
> Status= Vol=
> mop-sd: reserve.c:1566-0 jid=60 OK Dev avail reserved "124t-1" (/dev/nst0)
> mop-sd: reserve.c:481-0 Inc reserve=0 dev="124t-1" (/dev/nst0)
> mop-sd: reserve.c:1208-0 jid=60 Reserved=1 dev_name=PowerVault
> mediatype=LTO-1 pool=Default ok=1
> mop-sd: reserve.c:472-0 jid=60 find_vol=000038 found=0
> mop-sd: reserve.c:635-0 jid=60 Vol=000038 not in use.
> mop-sd: reserve.c:316-0 jid=60 enter reserve_volume=000038
> drive="124t-1" (/dev/nst0)
> mop-sd: reserve.c:236-0 jid=60 new Vol=000038 at 9585708 dev="124t-1"
> (/dev/nst0)
> mop-sd: reserve.c:418-0 jid=60 === set in_use. vol=000038 dev="124t-1"
> (/dev/nst0)
> mop-sd: reserve.c:189-0 jid=60 List end new volume: 000038 in_use=1 on
> device "124t-1" (/dev/nst0)
> mop-sd: reserve.c:1220-0 jid=60 looking for Volume=000038
> mop-sd: reserve.c:1279-0 jid=60 >dird changer: 3000 OK use device
> device=124t-1 mop-sd: reserve.c:1107-0 jid=60 Device 124t-1 reserved=1 for
> append. mop-sd: reserve.c:1053-0 jid=60 available device found=PowerVault
> mop-sd: reserve.c:1068-0 OK dev found. Vol=000038
> mop-sd: job.c:190-0 firewater.2009-03-18_03.40.04 waiting 1800 sec for
> FD to contact SD key=
> mop-sd: cram-md5.c:73-0 send: auth cram-md5 <1116341978.1237372851@mop-sd>
> ssl=0 mop-sd: cram-md5.c:152-0 sending resp to challenge:
> mop-sd: mount.c:230-0 set_unload
> mop-sd: mount.c:230-0 set_unload
> mop-sd: mount.c:230-0 set_unload
> mop-sd: mount.c:230-0 set_unload
> mop-sd: mount.c:230-0 set_unload
------------------------------------------------------------------------------
_______________________________________________
Bacula-users mailing list
Bacula-users AT lists.sourceforge DOT net
https://lists.sourceforge.net/lists/listinfo/bacula-users
|
