[Bacula-users] Bacula "estimate listing" shows the files and attributes, backup job error is "Could not stat FILE=: ERR=No such file or directory"
2008-12-11 15:44:43
All, I am having a very strange problem. My backup server is running Bacula 2.4.2 (Solaris 10_x86) and my client is Bacula 2.2.8 (Solaris 10_x86). This client is having intermittent job failures that I am at a loss to explain. Here is the log output from one of the "failed" jobs. Its completing with an OK status, but is not backing up any files. I know it says "ERR=No such file or directory", but the files are there and "estimate listing" shows the files.
008-12-11 11:32:04mt-back4.director JobId 17587: Start Backup JobId 17587, Job=GCRS_Lvl0_Tape.2008-12-11_11.32.41 2008-12-11 11:32:04mt-back4.director JobId 17587: Using Device "Ultrium-TD3" 2008-12-11 11:32:04mt-back4.storage JobId 17587: 3301 Issuing autochanger "loaded? drive 0" command.
2008-12-11 11:32:07mt-back4.storage JobId 17587: 3302 Autochanger "loaded? drive 0", result: nothing loaded. 2008-12-11 11:32:07mt-back4.storage JobId 17587: 3304 Issuing autochanger "load slot 18, drive 0" command.
2008-12-11 11:34:30mt-back4.storage JobId 17587: 3305 Autochanger "load slot 18, drive 0", status is OK. 2008-12-11 11:34:30mt-back4.storage JobId 17587: Volume "B00041" previously written, moving to end of data.
2008-12-11 11:35:19mt-back4.storage JobId 17587: Ready to append to end of Volume "B00041" at file=142. 2008-12-11 11:35:19mt-back4.storage JobId 17587: Spooling data ... 11-Dec 11:35 adm9. JobId 17587: Could not stat FILE=: ERR=No such file or directory
11-Dec 11:35 adm9. JobId 17587: Could not stat FILE=: ERR=No such file or directory 11-Dec 11:35 adm9. JobId 17587: Could not stat FILE=: ERR=No such file or directory 11-Dec 11:35 adm9. JobId 17587: Could not stat FILE=: ERR=No such file or directory
11-Dec 11:35 adm9. JobId 17587: Could not stat FILE=: ERR=No such file or directory 11-Dec 11:35 adm9. JobId 17587: Could not stat FILE=: ERR=No such file or directory 11-Dec 11:35 adm9. JobId 17587: Could not stat FILE=: ERR=No such file or directory
11-Dec 11:35 adm9. JobId 17587: Could not stat FILE=: ERR=No such file or directory 11-Dec 11:35 adm9. JobId 17587: Could not stat FILE=: ERR=No such file or directory 11-Dec 11:35 adm9. JobId 17587: Could not stat FILE=: ERR=No such file or directory
11-Dec 11:35 adm9. JobId 17587: Could not stat FILE=: ERR=No such file or directory 11-Dec 11:35 adm9. JobId 17587: Could not stat FILE=: ERR=No such file or directory 11-Dec 11:35 adm9. JobId 17587: Could not stat FILE=: ERR=No such file or directory
11-Dec 11:35 adm9. JobId 17587: Could not stat FILE=: ERR=No such file or directory 11-Dec 11:35 adm9. JobId 17587: Could not stat FILE=: ERR=No such file or directory 11-Dec 11:35 adm9. JobId 17587: Could not stat FILE=: ERR=No such file or directory
11-Dec 11:35 adm9. JobId 17587: Could not stat FILE=: ERR=No such file or directory 11-Dec 11:35 adm9. JobId 17587: Could not stat FILE=: ERR=No such file or directory 11-Dec 11:35 adm9. JobId 17587: Could not stat FILE=: ERR=No such file or directory
11-Dec 11:35 adm9. JobId 17587: Could not stat FILE=: ERR=No such file or directory 11-Dec 11:35 adm9. JobId 17587: Could not stat FILE=: ERR=No such file or directory 2008-12-11 11:35:19mt-back4.storage JobId 17587: Job write elapsed time = 00:00:01, Transfer rate = 0 bytes/second
2008-12-11 11:35:19mt-back4.storage JobId 17587: Committing spooled data to Volume "B00041". Despooling 462 bytes ... 2008-12-11 11:35:19mt-back4.storage JobId 17587: Despooling elapsed time = 00:00:01, Transfer rate = 462 bytes/second
2008-12-11 11:35:24mt-back4.storage JobId 17587: Sending spooled attrs to the Director. Despooling 0 bytes ... 2008-12-11 11:35:24mt-back4.director JobId 17587: Bacula mt-back4.director 2.4.2 (26Jul08): 11-Dec-2008 11:35:24
Build OS: i386-pc-solaris2.10 solaris 5.10 JobId: 17587 Job: GCRS_Lvl0_Tape.2008-12-11_11.32.41 Backup Level: Incremental, since=2008-12-08 22:53:45
Client: "adm9." 2.2.8 (26Jan08) i386-pc-solaris2.8,solaris,5.8 FileSet: "Gcrs_Lvl0" 2008-11-16 08:03:52 Pool: "Tapes" (From Job resource)
Storage: "Exabyte_224" (From Pool resource) Scheduled time: 11-Dec-2008 11:31:57 Start time: 11-Dec-2008 11:32:04 End time: 11-Dec-2008 11:35:24
Elapsed time: 3 mins 20 secs Priority: 10 FD Files Written: 0 SD Files Written: 0 FD Bytes Written: 0 (0 B) SD Bytes Written: 0 (0 B) Rate: 0.0 KB/s
Software Compression: None VSS: no Storage Encryption: no Volume name(s): B00041 Volume Session Id: 1391 Volume Session Time: 1227027150 Last Volume Bytes: 140,914,916,352 (140.9 GB)
Non-fatal FD errors: 21 SD Errors: 0 FD termination status: OK SD termination status: OK Termination: Backup OK -- with warnings
Here is the estimate listing output
Connecting to Client adm9. at 192.168.14.25:9102 -rw-r----- 1 user 100 2071502848 2008-12-07 02:19:36 /pool1/backup/oracle/GCRS/lvl0/GCRS_lvl0_elk1kb7n_1_1 -rw-r----- 1 user 100 641552384 2008-12-07 02:25:04 /pool1/backup/oracle/GCRS/lvl0/GCRS_lvl0_elk1kb7n_2_1
-rw-r----- 1 user 100 2071363584 2008-12-07 02:43:13 /pool1/backup/oracle/GCRS/lvl0/GCRS_lvl0_emk1kck4_1_1 -rw-r----- 1 user 100 723550208 2008-12-07 02:48:11 /pool1/backup/oracle/GCRS/lvl0/GCRS_lvl0_emk1kck4_2_1
-rw-r----- 1 user 100 2071404544 2008-12-07 02:59:56 /pool1/backup/oracle/GCRS/lvl0/GCRS_lvl0_eok1kdvj_1_1 -rw-r----- 1 user 100 77914112 2008-12-07 03:00:52 /pool1/backup/oracle/GCRS/lvl0/GCRS_lvl0_eok1kdvj_2_1
-rw-r----- 1 user 100 2071474176 2008-12-07 03:11:51 /pool1/backup/oracle/GCRS/lvl0/GCRS_lvl0_epk1kenc_1_1 -rw-r----- 1 user 100 355069952 2008-12-07 03:13:48 /pool1/backup/oracle/GCRS/lvl0/GCRS_lvl0_epk1kenc_2_1
-rw-r----- 1 user 100 2071527424 2008-12-07 03:23:49 /pool1/backup/oracle/GCRS/lvl0/GCRS_lvl0_erk1kffh_1_1 -rw-r----- 1 user 100 756748288 2008-12-07 03:28:16 /pool1/backup/oracle/GCRS/lvl0/GCRS_lvl0_erk1kffh_2_1
-rw-r----- 1 user 100 2046550016 2008-12-07 03:37:34 /pool1/backup/oracle/GCRS/lvl0/GCRS_lvl0_etk1kgao_1_1 -rw-r----- 1 user 100 2071408640 2008-12-07 03:47:31 /pool1/backup/oracle/GCRS/lvl0/GCRS_lvl0_euk1kgs3_1_1
-rw-r----- 1 user 100 432750592 2008-12-07 03:49:53 /pool1/backup/oracle/GCRS/lvl0/GCRS_lvl0_euk1kgs3_2_1 -rw-r----- 1 user 100 1990238208 2008-12-07 03:59:57 /pool1/backup/oracle/GCRS/lvl0/GCRS_lvl0_evk1khj8_1_1
-rw-r----- 1 user 100 2071371776 2008-12-07 04:08:31 /pool1/backup/oracle/GCRS/lvl0/GCRS_lvl0_f0k1ki66_1_1 -rw-r----- 1 user 100 589840384 2008-12-07 04:11:10 /pool1/backup/oracle/GCRS/lvl0/GCRS_lvl0_f0k1ki66_2_1
-rw-r----- 1 user 100 2071306240 2008-12-07 04:19:32 /pool1/backup/oracle/GCRS/lvl0/GCRS_lvl0_f1k1kir4_1_1 -rw-r----- 1 user 100 801792000 2008-12-07 04:23:12 /pool1/backup/oracle/GCRS/lvl0/GCRS_lvl0_f1k1kir4_2_1
-rw-r----- 1 user 100 2071597056 2008-12-07 04:32:57 /pool1/backup/oracle/GCRS/lvl0/GCRS_lvl0_f2k1kjhl_1_1 -rw-r----- 1 user 100 337649664 2008-12-07 04:34:38 /pool1/backup/oracle/GCRS/lvl0/GCRS_lvl0_f2k1kjhl_2_1
-rw-r----- 1 user 100 23134208 2008-12-07 04:35:47 /pool1/backup/oracle/GCRS/controlfile/c-4061640606-20081207-01 2000 OK estimate files=21 bytes=27,419,746,304
Does anyone have any ideas what the problem may be?
Thanks, Shon
------------------------------------------------------------------------------
SF.Net email is Sponsored by MIX09, March 18-20, 2009 in Las Vegas, Nevada.
The future of the web can't happen without you. Join us at MIX09 to help
pave the way to the Next Web now. Learn more and register at
http://ad.doubleclick.net/clk;208669438;13503038;i?http://2009.visitmix.com/ _______________________________________________
Bacula-users mailing list
Bacula-users AT lists.sourceforge DOT net
https://lists.sourceforge.net/lists/listinfo/bacula-users
|
<Prev in Thread] |
Current Thread |
[Next in Thread> |
- [Bacula-users] Bacula "estimate listing" shows the files and attributes, backup job error is "Could not stat FILE=: ERR=No such file or directory",
Mingus Dew <=
|
|
|