Menu
▾
▴
[Bacula-users] Device is BLOCKED waiting for mount of volume "File-0"
|
From: Diogo N. <dio...@gm...> - 2021-05-26 15:27:37
|
Hi,
I am a newbie to Bacula. I tried to find out what is happening and could not
get right answer. Probably I am not searching with the right question or
looking at the right place.
I removed all volumes from the machine and deleted them from Bacula.
Then I proceed to the some jobs. I've done 3 jobs and in the last
(BackupBaculaCatalog), Bacula tried to open a Volume (File-0) that was in
another directive (/mnt/backup1 and not /mnt/backup2). Failing that Bacula
marked File-0 as ERROR and created another one. So at this time all 3 jobs
were done and I updated the Volume File-0 to append.
For last job it was a copy job and it came back as ERROR due to trying to
reach to the Volume File-0 in the wrong directive.
I´ve been trying to understand this error for quite some days now and would
really like to get this figured out asap.
I have put in this post the:
////ERROR in the BackupBaculaCatalog job////
////ERROR in the copy job////
////Status Director////
////Status Storage////
If you need any more information about the conf files or any other thing
please respond saying so
Thanks
Diogo Neves
////ERROR in the BackupBaculaCatalog job////
*run
A job name must be specified.
The defined Job resources are:
1: BackupBaculaDirFiles
2: BackupBaculaFD1
3: BackupCopy
4: BackupBaculaCatalog
5: RestoreFiles
Select Job resource (1-5): 4
Run Backup job
JobName: BackupBaculaCatalog
Level: Full
Client: bacula-srv-fd
FileSet: Catalog
Pool: File (From Job resource)
Storage: File1 (From Pool resource)
When: 2021-05-26 16:00:59
Priority: 11
OK to run? (yes/mod/no): yes
Job queued. JobId=1317
*mes
26-May 16:01 bacula-dir JobId 1317: shell command: run BeforeJob
"/opt/bacula/scripts/make_catalog_backup.pl MyCatalog"
26-May 16:01 bacula-dir JobId 1317: Start Backup JobId 1317,
Job=BackupBaculaCatalog.2021-05-26_16.01.02_25
26-May 16:01 bacula-dir JobId 1317: Using Device "FileChgr1-Dev2" to write.
26-May 16:01 bacula-sd JobId 1317: Warning: mount.c:217 Open of File device
"FileChgr1-Dev2" (/mnt/backup2) Volume "File-0" failed: ERR=file_dev.c:190
Could not open(/mnt/backup2/File-0,OPEN_READ_WRITE,0640): ERR=No such file
or directory
26-May 16:01 bacula-sd JobId 1317: Marking Volume "File-0" in Error in
Catalog.
26-May 16:01 bacula-dir JobId 1317: Created new Volume="File-1",
Pool="File", MediaType="File1" in catalog.
26-May 16:01 bacula-sd JobId 1317: Labeled new Volume "File-1" on File
device "FileChgr1-Dev2" (/mnt/backup2).
26-May 16:01 bacula-sd JobId 1317: Wrote label to prelabeled Volume "File-1"
on File device "FileChgr1-Dev2" (/mnt/backup2)
26-May 16:01 bacula-sd JobId 1317: Elapsed time=00:00:01, Transfer
rate=1.826 M Bytes/second
26-May 16:01 bacula-sd JobId 1317: Sending spooled attrs to the Director.
Despooling 230 bytes ...
26-May 16:01 bacula-dir JobId 1317: Bacula bacula-dir 11.0.2 (26Mar21):
Build OS: x86_64-pc-linux-gnu debian 10.9
JobId: 1317
Job: BackupBaculaCatalog.2021-05-26_16.01.02_25
Backup Level: Full
Client: "bacula-srv-fd" 11.0.2 (26Mar21)
x86_64-pc-linux-gnu,debian,10.9
FileSet: "Catalog" 2021-05-07 23:05:00
Pool: "File" (From Job resource)
Catalog: "MyCatalog" (From Client resource)
Storage: "File1" (From Pool resource)
Scheduled time: 26-May-2021 16:00:59
Start time: 26-May-2021 16:01:05
End time: 26-May-2021 16:01:06
Elapsed time: 1 sec
Priority: 11
FD Files Written: 1
SD Files Written: 1
FD Bytes Written: 1,826,490 (1.826 MB)
SD Bytes Written: 1,826,606 (1.826 MB)
Rate: 1826.5 KB/s
Software Compression: None
Comm Line Compression: 64.4% 2.8:1
Snapshot/VSS: no
Encryption: no
Accurate: no
Volume name(s): File-1
Volume Session Id: 14
Volume Session Time: 1622038885
Last Volume Bytes: 1,828,630 (1.828 MB)
Non-fatal FD errors: 0
SD Errors: 0
FD termination status: OK
SD termination status: OK
Termination: Backup OK
26-May 16:01 bacula-dir JobId 1317: Begin pruning Jobs older than 6 months .
26-May 16:01 bacula-dir JobId 1317: No Jobs found to prune.
26-May 16:01 bacula-dir JobId 1317: Begin pruning Files.
26-May 16:01 bacula-dir JobId 1317: No Files found to prune.
26-May 16:01 bacula-dir JobId 1317: End auto prune.
*list media
Pool: Copy
No results to list.
Pool: Default
No results to list.
Pool: File
+---------+------------+-----------+---------+-------------+----------+--------------+---------+------+-----------+-----------+---------+----------+---------------------+------------+
| mediaid | volumename | volstatus | enabled | volbytes | volfiles |
volretention | recycle | slot | inchanger | mediatype | voltype | volparts |
lastwritten | expiresin |
+---------+------------+-----------+---------+-------------+----------+--------------+---------+------+-----------+-----------+---------+----------+---------------------+------------+
| 35 | File-0 | Error | 1 | 726,135,313 | 0 |
31,536,000 | 1 | 0 | 0 | File1 | 1 | 0 |
2021-05-26 16:00:13 | 31,535,833 |
| 36 | File-1 | Append | 1 | 1,828,630 | 0 |
31,536,000 | 1 | 0 | 0 | File1 | 1 | 0 |
2021-05-26 16:01:05 | 31,535,885 |
+---------+------------+-----------+---------+-------------+----------+--------------+---------+------+-----------+-----------+---------+----------+---------------------+------------+
Pool: Scratch
No results to list.
////ERROR in the copy job////
A job name must be specified.
The defined Job resources are:
1: BackupBaculaDirFiles
2: BackupBaculaFD1
3: BackupCopy
4: BackupBaculaCatalog
5: RestoreFiles
Select Job resource (1-5): 3
Run Copy job
JobName: BackupCopy
Bootstrap: *None*
Client: bacula-srv-fd
FileSet: Full Set
Pool: File (From Job resource)
NextPool: Copy (From Job Pool's NextPool resource)
Read Storage: File1 (From Pool resource)
Write Storage: File2 (From Job Pool's NextPool resource)
JobId: *None*
When: 2021-05-26 16:03:38
Catalog: MyCatalog
Priority: 10
OK to run? (yes/mod/no): yes
Job queued. JobId=1318
You have messages.
*mes
26-May 16:03 bacula-dir JobId 1318: The following 3 JobIds were chosen to be
copied: 1315,1316,1317
26-May 16:03 bacula-dir JobId 1319: Copying using JobId=1315
Job=BackupBaculaDirFiles.2021-05-26_15.59.13_23
26-May 16:03 bacula-dir JobId 1318: Job queued. JobId=1319
26-May 16:03 bacula-dir JobId 1318: Copying JobId 1319 started.
26-May 16:03 bacula-dir JobId 1321: Copying using JobId=1316
Job=BackupBaculaFD1.2021-05-26_15.59.32_24
26-May 16:03 bacula-dir JobId 1318: Job queued. JobId=1321
26-May 16:03 bacula-dir JobId 1318: Copying JobId 1321 started.
26-May 16:03 bacula-dir JobId 1318: Copying using JobId=1317
Job=BackupBaculaCatalog.2021-05-26_16.01.02_25
26-May 16:03 bacula-dir JobId 1319: Start Copying JobId 1319,
Job=BackupCopy.2021-05-26_16.03.40_27
26-May 16:03 bacula-dir JobId 1319: Using Device "FileChgr1-Dev2" to read.
26-May 16:03 bacula-dir JobId 1320: Created new Volume="Copy-0",
Pool="Copy", MediaType="File2" in catalog.
26-May 16:03 bacula-dir JobId 1320: Using Device "FileChgr2-Dev2" to write.
26-May 16:03 bacula-sd JobId 1320: Labeled new Volume "Copy-0" on File
device "FileChgr2-Dev2" (/mnt/backup4).
26-May 16:03 bacula-sd JobId 1320: Wrote label to prelabeled Volume "Copy-0"
on File device "FileChgr2-Dev2" (/mnt/backup4)
26-May 16:03 bacula-sd JobId 1319: Warning: acquire.c:235 Read open File
device "FileChgr1-Dev2" (/mnt/backup2) Volume "File-0" failed:
ERR=file_dev.c:190 Could not open(/mnt/backup2/File-0,OPEN_READ_ONLY,0640):
ERR=No such file or directory
26-May 16:03 bacula-sd JobId 1319: Warning: acquire.c:235 Read open File
device "FileChgr1-Dev2" (/mnt/backup2) Volume "File-0" failed:
ERR=file_dev.c:190 Could not open(/mnt/backup2/File-0,OPEN_READ_ONLY,0640):
ERR=No such file or directory
26-May 16:03 bacula-sd JobId 1319: Please mount read Volume "File-0" for:
Job: BackupCopy.2021-05-26_16.03.40_27
Storage: "FileChgr1-Dev2" (/mnt/backup2)
Pool: File
Media type: File1
////Status Director////
*st dir
bacula-dir Version: 11.0.2 (26 March 2021) x86_64-pc-linux-gnu debian 10.9
Daemon started 26-May-21 15:21, conf reloaded 26-May-2021 15:21:06
Jobs: run=18, running=6 mode=0,0
Crypto: fips=N/A crypto=OpenSSL
Heap: heap=86,016 smbytes=647,114 max_bytes=707,538 bufs=627 max_bufs=672
Res: njobs=5 nclients=2 nstores=2 npools=4 ncats=1 nfsets=4 nscheds=1
Scheduled Jobs:
Level Type Pri Scheduled Job Name Volume
===================================================================================
Incremental Backup 10 26-May-21 23:05 BackupBaculaDirFiles File-1
Incremental Backup 10 26-May-21 23:05 BackupBaculaFD1 File-1
Incremental Copy 10 26-May-21 23:05 BackupCopy
Incremental Backup 11 26-May-21 23:05 BackupBaculaCatalog File-1
====
Running Jobs:
Console connected at 26-May-21 16:17
JobId Type Level Files Bytes Name Status
======================================================================
1318 Copy Full 0 0 BackupCopy is waiting on max
Job jobs
1319 Copy Incr 0 0 BackupCopy is waiting for a
mount request
1320 Back Full 0 0 BackupBaculaDirFiles is running
1321 Copy Incr 0 0 BackupCopy is waiting on max
Job jobs
1322 Back Full 0 0 BackupBaculaFD1 is waiting
execution
1323 Back Full 0 0 BackupBaculaCatalog is waiting
execution
====
Terminated Jobs:
JobId Level Files Bytes Status Finished Name
====================================================================
1308 Full 1 1.812 M OK 26-May-21 15:42
BackupBaculaCatalog
1309 Full 0 0 Cancel 26-May-21 15:58 BackupCopy
1310 Incr 0 0 Cancel 26-May-21 15:58 BackupCopy
1311 Full 0 0 Error 26-May-21 15:58
BackupBaculaDirFiles
1312 Incr 0 0 Error 26-May-21 15:58 BackupCopy
1313 Full 0 0 Cancel 26-May-21 15:58 BackupBaculaFD1
1314 Full 0 0 Error 26-May-21 15:58
BackupBaculaCatalog
1315 Full 10 69.54 K OK 26-May-21 15:59
BackupBaculaDirFiles
1316 Full 9,906 723.8 M OK 26-May-21 16:00 BackupBaculaFD1
1317 Full 1 1.826 M OK 26-May-21 16:01
BackupBaculaCatalog
====
////Status Storage////
*st storage
Automatically selected Storage: File1
Connecting to Storage daemon File1 at 172.16.1.1:9103
bacula-sd Version: 11.0.2 (26 March 2021) x86_64-pc-linux-gnu debian 10.9
Daemon started 26-May-21 15:21. Jobs: run=14, running=2.
Ulimits: nofile=1024 memlock=67108864 status=nofile
Heap: heap=73,728 smbytes=1,144,452 max_bytes=1,145,345 bufs=378
max_bufs=381
Sizes: boffset_t=8 size_t=8 int32_t=4 int64_t=8 mode=0,0 newbsr=0
Crypto: fips=N/A crypto=OpenSSL
Res: ndevices=4 nautochgr=2
Running Jobs:
Writing: Full Backup job BackupBaculaDirFiles JobId=1320 Volume="Copy-0"
pool="Copy" device="FileChgr2-Dev2" (/mnt/backup4)
spooling=0 despooling=0 despool_wait=0
Files=0 Bytes=0 AveBytes/sec=0 LastBytes/sec=0
FDReadSeqNo=9 in_msg=6 out_msg=6 fd=7
Reading: Incremental Copy job BackupCopy JobId=1319 Volume="File-0"
pool="File" device="FileChgr1-Dev2" (/mnt/backup2) newbsr=0
Files=0 Bytes=0 AveBytes/sec=0 LastBytes/sec=0
FDReadSeqNo=6 in_msg=6 out_msg=8 fd=8
Director connected at: 26-May-21 16:18
====
Jobs waiting to reserve a drive:
====
Terminated Jobs:
JobId Level Files Bytes Status Finished Name
===================================================================
1304 Full 9,906 725.1 M OK 26-May-21 15:27 BackupBaculaFD1
1305 Incr 0 0 OK 26-May-21 15:29
BackupBaculaDirFiles
1306 Full 10 70.68 K OK 26-May-21 15:40
BackupBaculaDirFiles
1307 Full 9,906 725.2 M OK 26-May-21 15:41 BackupBaculaFD1
1308 Full 1 1.812 M OK 26-May-21 15:42
BackupBaculaCatalog
1310 Incr 0 0 Cancel 26-May-21 15:58 BackupCopy
1311 Full 0 0 Error 26-May-21 15:58
BackupBaculaDirFiles
1315 Full 10 70.68 K OK 26-May-21 15:59
BackupBaculaDirFiles
1316 Full 9,906 725.2 M OK 26-May-21 16:00 BackupBaculaFD1
1317 Full 1 1.826 M OK 26-May-21 16:01
BackupBaculaCatalog
====
Device status:
Autochanger "FileChgr1" with devices:
"FileChgr1-Dev1" (/mnt/backup1)
"FileChgr1-Dev2" (/mnt/backup2)
Autochanger "FileChgr2" with devices:
"FileChgr2-Dev1" (/mnt/backup3)
"FileChgr2-Dev2" (/mnt/backup4)
Device File: "FileChgr1-Dev1" (/mnt/backup1) is not open.
Drive 0 is not loaded.
Available Space=15.18 GB
==
Device File: "FileChgr1-Dev2" (/mnt/backup2) is not open.
Device is BLOCKED waiting for mount of volume "File-0",
Pool: File
Media type: File1
Drive 0 is not loaded.
Available Space=15.18 GB
==
Device File: "FileChgr2-Dev1" (/mnt/backup3) is not open.
Drive 0 is not loaded.
Available Space=15.18 GB
==
Device File is "FileChgr2-Dev2" (/mnt/backup4) mounted with:
Volume: Copy-0
Pool: Copy
Media type: File2
Total Bytes=226 Blocks=0 Bytes/block=226
Positioned at File=0 Block=0
Drive 0 is not loaded.
Available Space=15.18 GB
==
====
Used Volume status:
Reserved volume: Copy-0 on File device "FileChgr2-Dev2" (/mnt/backup4)
Reader=0 writers=1 reserves=0 volinuse=1 worm=0
Volume: File-0 no device. volinuse=0
====
Attr spooling: 1 active jobs, 9,497,298 bytes; 13 total jobs, 9,497,298 max
bytes.
====
--
Sent from: http://bacula.10910.n7.nabble.com/Bacula-Users-f3.html
|
