Bill,

Thank you for your response.  The command output you asked for is 183MB, it is 
the message from below about 7 times a second every second from 10:21:30 
10/2/2017 until we caught it and canceled the job at 22:30:05 10/02/2017.  I 
attached a file with the heading and ending information.  The primary problem 
is that the job is waiting on media intervention, but does not produce an email 
for the warning.  With the write protect on, it is just like the tape is never 
there.  All jobs queue, and we end up with a huge mess.  If we get a message, 
then we can remove the tape, remove the write protect, and then wait for all 
the jobs to finish.  I would expect that the Read-Only volume warning from 
mount.c would be at a severity level to produce the same media intervention 
email message as "operator = al...@somewhere.com = mount".

Let me know if that additional context helps with another solution.

Jim Richardson
CISSP CISA

SecurIT360

-----Original Message-----
From: Bill Arlofski [mailto:waa-bac...@revpol.com]
Sent: Wednesday, October 4, 2017 11:42 AM
To: bacula-users@lists.sourceforge.net
Subject: Re: [Bacula-users] Not Receiving Messages for Read-Only file system

On 10/04/2017 09:35 AM, Jim Richardson wrote:
> All,
>
>
>
> We are using Bacula 9.0.4.  We accidentally placed a tape in our
> library with the write-protect on.  The following message was written
> in bconsole, but we didn’t receive notifications.
>
>
>
> 02-Oct 22:30 bacula-sd JobId 2801: Warning: mount.c:210 Open of Tape
> device "ULT3580" (/dev/nst0) Volume "000005L7" failed:
> ERR=tape_dev.c:170 Unable to open device "ULT3580" (/dev/nst0):
> ERR=Read-only file system
>
>
>
> Below are all of our messages directives.  Thank you in advance.

Hi Jim,

The job summary should have some non-zero number of "SD Errors:", and the 
Termination status should (probably) be "Backup OK -- with warnings"

Take a look with:

* llist joblog jobid=2801


Since it is only some "minor" issue during the backup, Bacula does not fail the 
job, it just logs the issue, and moves on.

Because Bacula will set the JobStatus in the catalog the same as a "Backup OK"
job (JobStatus=T), there is no way to trigger warnings by simply querying the 
catalog for JobStatus=W (for example), so I have all backup jobs send the 
emails to my helpdesk, which is configured to look for "Backup OK -- with 
warnings"  and flag those jobs as 'bad' which need to be investigated.

Hope this helps...

Best regards,

Bill

--
Bill Arlofski
http://www.revpol.com/bacula
-- Not responsible for anything below this line --

------------------------------------------------------------------------------
Check out the vibrant tech community on one of the world's most engaging tech 
sites, Slashdot.org! http://sdm.link/slashdot 
_______________________________________________
Bacula-users mailing list
Bacula-users@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/bacula-users
CONFIDENTIALITY: This email (including any attachments) may contain 
confidential, proprietary and privileged information, and unauthorized 
disclosure or use is prohibited. If you received this email in error, please 
notify the sender and delete this email from your system. Thank you.
onnecting to Director localhost:9101
1000 OK: 103 bacula-dir Version: 9.0.4 (06 September 2017)
Enter a period to cancel a command.
llist joblog jobid=2801
Automatically selected Catalog: MyCatalog
Using Catalog "MyCatalog"
    time: 2017-10-02 03:05:18
 logtext: bacula-dir JobId 2801: Start Backup JobId 2801, 
Job=C2T-DiskBackups.2017-10-02_03.00.00_57

    time: 2017-10-02 03:05:18
 logtext: bacula-sd JobId 2801: 3307 Issuing autochanger "unload Volume 
000008L7, Slot 3, Drive 0" command.

    time: 2017-10-02 03:05:42
 logtext: bacula-dir JobId 2801: Using Device "ULT3580" to write.

    time: 2017-10-02 03:05:43
 logtext: bacula-sd JobId 2801: 3304 Issuing autochanger "load Volume 000004L7, 
Slot 9, Drive 0" command.

    time: 2017-10-02 03:06:15
 logtext: bacula-sd JobId 2801: 3305 Autochanger "load Volume 000004L7, Slot 9, 
Drive 0", status is OK.

    time: 2017-10-02 03:06:18
 logtext: bacula-sd JobId 2801: Volume "000004L7" previously written, moving to 
end of data.

    time: 2017-10-02 03:07:06
 logtext: bacula-sd JobId 2801: Ready to append to end of Volume "000004L7" at 
file=7184.

    time: 2017-10-02 04:26:37
 logtext: bacula-sd JobId 2801: End of Volume "000004L7" at 7696:15127 on 
device "ULT3580" (/dev/nst0). Write of 64512 bytes got -1.

    time: 2017-10-02 04:26:43
 logtext: bacula-sd JobId 2801: Re-read of last block succeeded.

    time: 2017-10-02 04:26:43
 logtext: bacula-sd JobId 2801: End of medium on Volume "000004L7" 
Bytes=7,692,268,243,968 Blocks=119,237,788 at 02-Oct-2017 04:26.

    time: 2017-10-02 04:26:43
 logtext: bacula-sd JobId 2801: 3307 Issuing autochanger "unload Volume 
000004L7, Slot 9, Drive 0" command.

    time: 2017-10-02 04:28:01
 logtext: bacula-dir JobId 2801: Pruning oldest volume "000007L7"

    time: 2017-10-02 04:28:01
 logtext: bacula-dir JobId 2801: Found no Job associated with the Volume 
"000007L7" to prune

    time: 2017-10-02 04:28:01
 logtext: bacula-dir JobId 2801: Pruning oldest volume "000007L7"

    time: 2017-10-02 04:28:01
 logtext: bacula-dir JobId 2801: Found no Job associated with the Volume 
"000007L7" to prune

    time: 2017-10-02 04:28:01
 logtext: bacula-sd JobId 2801: Job C2T-DiskBackups.2017-10-02_03.00.00_57 is 
waiting. Cannot find any appendable volumes.
Please use the "label" command to create a new Volume for:
    Storage:      "ULT3580" (/dev/nst0)
    Pool:         Pool_Weeky_OffSite_Tapes
    Media type:   LTO-7

 logtext: bacula-dir JobId 2801: There are no more Jobs associated with Volume 
"000005L7". Marking it purged.

    time: 2017-10-02 10:17:56
 logtext: bacula-dir JobId 2801: All records pruned from Volume "000005L7"; 
marking it "Purged"

    time: 2017-10-02 10:17:56
 logtext: bacula-dir JobId 2801: Recycled volume "000005L7"

    time: 2017-10-02 10:17:56
 logtext: bacula-sd JobId 2801: 3304 Issuing autochanger "load Volume 000005L7, 
Slot 8, Drive 0" command.

    time: 2017-10-02 10:18:54
 logtext: bacula-sd JobId 2801: 3305 Autochanger "load Volume 000005L7, Slot 8, 
Drive 0", status is OK.

    time: 2017-10-02 10:18:56
 logtext: bacula-sd JobId 2801: Warning: mount.c:210 Open of Tape device 
"ULT3580" (/dev/nst0) Volume "000005L7" failed: ERR=tape_dev.c:170 Unable to 
open device "ULT3580" (/dev/nst0): ERR=Read-only file system

<repeated>

    time: 2017-10-02 22:30:05
 logtext: bacula-sd JobId 2801: Elapsed time=19:22:59, Transfer rate=7.345 M 
Bytes/second

    time: 2017-10-02 22:30:05
 logtext: bacula-dir JobId 2801: Bacula bacula-dir 9.0.4 (06Sep17):
  Build OS:               x86_64-redhat-linux-gnu redhat (Core)
  JobId:                  2801
  Job:                    C2T-DiskBackups.2017-10-02_03.00.00_57
  Backup Level:           Full
  Client:                 "bacula-fd" 9.0.4 (06Sep17) 
x86_64-redhat-linux-gnu,redhat,(Core)
  FileSet:                "2Disk-Folders" 2017-07-29 21:22:38
  Pool:                   "Pool_Weeky_OffSite_Tapes" (From Run Pool override)
  Catalog:                "MyCatalog" (From Client resource)
  Storage:                "Tape" (From Job resource)
  Scheduled time:         02-Oct-2017 03:00:00
  Start time:             02-Oct-2017 03:05:42
  End time:               02-Oct-2017 22:30:05
  Elapsed time:           19 hours 24 mins 23 secs
  Priority:               14
  FD Files Written:       67
  SD Files Written:       70
  FD Bytes Written:       484,804,967,981 (484.8 GB)
  SD Bytes Written:       512,563,085,750 (512.5 GB)
  Rate:                   6939.4 KB/s
  Software Compression:   None
  Comm Line Compression:  None
  Snapshot/VSS:           no
  Encryption:             no
  Accurate:               no
  Volume name(s):         000004L7
  Volume Session Id:      216
  Volume Session Time:    1506444025
  Last Volume Bytes:      1 (1 B)
  Non-fatal FD errors:    0
  SD Errors:              0
  FD termination status:  Canceled
  SD termination status:  Canceled
  Termination:            Backup Canceled

           jobid: 2,801
             job: C2T-DiskBackups.2017-10-02_03.00.00_57
            name: C2T-DiskBackups
     purgedfiles: 0
            type: B
           level: F
        clientid: 1
      clientname: bacula-fd
       jobstatus: A
       schedtime: 2017-10-02 03:00:00
       starttime: 2017-10-02 03:05:42
         endtime: 2017-10-02 22:30:05
     realendtime: 2017-10-02 22:30:05
        jobtdate: 1,507,001,405
    volsessionid: 216
  volsessiontime: 1,506,444,025
        jobfiles: 67
        jobbytes: 484,804,967,981
       readbytes: 0
       joberrors: 0
 jobmissingfiles: 0
          poolid: 29
        poolname: Pool_Weeky_OffSite_Tapes
      priorjobid: 0
       filesetid: 62
         fileset: 2Disk-Folders
         hasbase: 0
        hascache: 0
         comment:
------------------------------------------------------------------------------
Check out the vibrant tech community on one of the world's most
engaging tech sites, Slashdot.org! http://sdm.link/slashdot
_______________________________________________
Bacula-users mailing list
Bacula-users@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/bacula-users

Reply via email to