Hi Bdale, After my failed attempt to close the bug, it's come to light that amanda is only intermittently using 'dump' instead of 'xfsdump' for xfs partitions. See the two attached "sendbackup" debug files for the same partition on consecutive days. The first from eysterday runs xfsdump, the second from today runs dump. Very odd.
The main trouble is that when it runs dump, it fails to complete and retires running in to office hours which is very boring when the disk sub-sytem is being hammered whilst people are trying to work. :-) Ronny -- Ronny Adsetts Technical Director Amazing Internet Ltd, London t: +44 20 8977 8943 f: +44 20 8607 9536 w: www.amazinginternet.com Registered office: 69 Strathmore Road, Teddington, TW11 8UH Registered in England. Company No. 4042957
1331197420.112165: sendbackup: pid 31205 ruid 34 euid 34 version 2.6.1p2: start at Thu Mar 8 09:03:40 2012 1331197420.112252: sendbackup: Version 2.6.1p2 1331197420.112979: sendbackup: pid 31205 ruid 34 euid 34 version 2.6.1p2: rename at Thu Mar 8 09:03:40 2012 1331197420.113861: sendbackup: Parsed request as: program `DUMP' 1331197420.113876: sendbackup: disk `/snapshots/cvsroot' 1331197420.113885: sendbackup: device `/snapshots/cvsroot' 1331197420.113894: sendbackup: level 1 1331197420.113903: sendbackup: since NODATE 1331197420.113910: sendbackup: options `' 1331197420.114099: sendbackup: start: vimes.amazing-internet.net:/snapshots/cvsroot lev 1 1331197420.114187: sendbackup: pipespawnv: stdoutfd is 50 1331197420.114254: sendbackup: Spawning "/bin/gzip /bin/gzip --fast" in pipeline 1331197420.114648: sendbackup: dump: pid 31207: /bin/gzip1331197420.114702: sendbackup: --fast1331197420.114715: sendbackup: 1331197420.193839: sendbackup: dumping device '/snapshots/cvsroot' with '' 1331197420.197535: sendbackup: pipespawnv: stdoutfd is 6 1331197420.197678: sendbackup: Spawning "/sbin/dump dump 1usf 1048576 - /snapshots/cvsroot" in pipeline 1331197420.197955: sendbackup: Started backup 1331197420.198348: sendbackup: Started index creator: "/sbin/restore -tvf - 2>&1 | sed -e ' s/^leaf[ ]*[0-9]*[ ]*\.// t /^dir[ ]/ { s/^dir[ ]*[0-9]*[ ]*\.// s%$%/% t } d '" 1331197420.451695: sendbackup: 91: normal(|): DUMP: Only level 0 dumps are allowed on a subdirectory 1331197420.452658: sendbackup: 91: normal(|): DUMP: The ENTIRE dump is aborted. 1331197420.473535: sendbackup: Index created successfully 1331197420.474460: sendbackup: critical (fatal): error [dump (31209) /sbin/dump returned 1] /usr/lib/amanda/libamanda-2.6.1p2.so(+0x22ab7)[0x7f79f0799ab7] /lib/libglib-2.0.so.0(g_logv+0x1a7)[0x7f79efa0bd27] /lib/libglib-2.0.so.0(g_log+0x83)[0x7f79efa0c103] /usr/lib/amanda/sendbackup(parse_backup_messages+0x25a)[0x4046ea] /usr/lib/amanda/sendbackup(main+0x11c7)[0x4058d7] /lib/libc.so.6(__libc_start_main+0xfd)[0x7f79ef035c8d] /usr/lib/amanda/sendbackup[0x403519]
1331086195.919951: sendbackup: pid 19369 ruid 34 euid 34 version 2.6.1p2: start at Wed Mar 7 02:09:55 2012 1331086195.920038: sendbackup: Version 2.6.1p2 1331086195.935324: sendbackup: pid 19369 ruid 34 euid 34 version 2.6.1p2: rename at Wed Mar 7 02:09:55 2012 1331086195.964518: sendbackup: Parsed request as: program `DUMP' 1331086195.964542: sendbackup: disk `/snapshots/cvsroot' 1331086195.964552: sendbackup: device `/snapshots/cvsroot' 1331086195.964560: sendbackup: level 0 1331086195.964568: sendbackup: since NODATE 1331086195.964576: sendbackup: options `' 1331086195.964777: sendbackup: start: vimes.amazing-internet.net:/snapshots/cvsroot lev 0 1331086195.964844: sendbackup: pipespawnv: stdoutfd is 50 1331086195.964912: sendbackup: Spawning "/bin/gzip /bin/gzip --fast" in pipeline 1331086195.965296: sendbackup: dump: pid 19371: /bin/gzip1331086195.965354: sendbackup: --fast1331086195.965362: sendbackup: 1331086195.976703: sendbackup: dumping device '/dev/mapper/vg_stor-lv_cvsroot_bak' with 'xfs' 1331086195.977965: sendbackup: pipespawnv: stdoutfd is 6 1331086195.978132: sendbackup: Spawning "/usr/lib/amanda/rundump /usr/lib/amanda/rundump DailySet2 xfsdump -F -l 0 - /dev/mapper/vg_stor-lv_cvsroot_bak" in pipeline 1331086195.978420: sendbackup: Started backup 1331086195.978740: sendbackup: Started index creator: "/sbin/xfsrestore -t -v silent - 2>/dev/null | sed -e 's/^/\//'" 1331086196.135877: sendbackup: 97: normal(|): xfsdump: using file dump (drive_simple) strategy 1331086196.136924: sendbackup: 97: normal(|): xfsdump: version 3.0.4 (dump format 3.0) - Running single-threaded 1331086196.252145: sendbackup: 97: normal(|): xfsdump: level 0 dump of vimes:/snapshots/cvsroot 1331086196.253502: sendbackup: 97: normal(|): xfsdump: dump date: Wed Mar 7 02:09:56 2012 1331086196.254438: sendbackup: 97: normal(|): xfsdump: session id: c7cd6a47-8885-4dc0-ade5-9ffabcad5e15 1331086196.255329: sendbackup: 97: normal(|): xfsdump: session label: "" 1331086198.599395: sendbackup: 97: normal(|): xfsdump: ino map phase 1: constructing initial dump list 1331086211.811366: sendbackup: 97: normal(|): xfsdump: ino map phase 2: skipping (no pruning necessary) 1331086211.812627: sendbackup: 97: normal(|): xfsdump: ino map phase 3: skipping (only one dump stream) 1331086211.818320: sendbackup: 97: normal(|): xfsdump: ino map construction complete 1331086211.819273: sendbackup: 97: normal(|): xfsdump: estimated dump size: 62519561984 bytes 1331086212.142606: sendbackup: 97: normal(|): xfsdump: creating dump session media file 0 (media 0, file 0) 1331086212.143975: sendbackup: 97: normal(|): xfsdump: dumping ino map 1331086215.963885: sendbackup: 97: normal(|): xfsdump: dumping directories 1331086589.187444: sendbackup: 97: normal(|): xfsdump: dumping non-directory files 1331104117.005047: sendbackup: 97: normal(|): xfsdump: ending media file 1331104117.057564: sendbackup: 79: size(|): xfsdump: media file size 61132123424 bytes 1331104117.073456: sendbackup: 97: normal(|): xfsdump: dump size (non-dir files) : 60708578808 bytes 1331104117.074395: sendbackup: 97: normal(|): xfsdump: dump complete: 17921 seconds elapsed 1331104117.082966: sendbackup: 97: normal(|): xfsdump: Dump Status: SUCCESS 1331104117.159096: sendbackup: Index created successfully 1331104117.256441: sendbackup: Parsed backup messages 1331104117.256543: sendbackup: pid 19369 finish time Wed Mar 7 07:08:37 2012
signature.asc
Description: OpenPGP digital signature