I'm not finding my precise problem in logs of other fixes, so : amrecover hangs after one answers the "set owner/mode?" question. It HAS actually done the restore (as long as it wasn't planning to want a second tape). The amrecover.debug file ends in
gzip: stdout: broken pipe If it's relevant, I'm still using chg-zd-mtx to back up (one change at a time) but since amanda complained, there is also the line amrecover_changer "/dev/changer" Deb Baddorf badd...@fnal.gov *==========================================* amrecover.***debug Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: pid 27602 ruid 0 euid 0 version 3.3.2: start at Thu Dec 6 16:33:32 2012 Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: config_overrides: conf daily Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: pid 27602 ruid 0 euid 0 version 3.3.2: rename at Thu Dec 6 16:33:32 2012 Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: security_getdriver(name=bsd) returns 0x7f6caeba12e0 Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: security_handleinit(handle=0x247e260, driver=0x7f6caeba12e0 (BSD)) Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: dgram_bind: setting up a socket with family 2 Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: bind_portrange2: Try port 811: Available - Success Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: dgram_bind: socket 3 bound to 0.0.0.0:811 Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: dgram_send_addr(addr=0x247e2a0, dgram=0x7f6caebadda8) Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: (sockaddr_in *)0x247e2a0 = { 2, 10080, 131.225.121.103 } Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: dgram_send_addr: 0x7f6caebadda8->socket = 3 Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: dgram_recv(dgram=0x7f6caebadda8, timeout=0, fromaddr=0x7f6caebbdda0) Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: (sockaddr_in *)0x7f6caebbdda0 = { 2, 10080, 131.225.121.103 } Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: dgram_recv(dgram=0x7f6caebadda8, timeout=0, fromaddr=0x7f6caebbdda0) Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: (sockaddr_in *)0x7f6caebbdda0 = { 2, 10080, 131.225.121.103 } Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: dgram_send_addr(addr=0x247e2a0, dgram=0x7f6caebadda8) Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: (sockaddr_in *)0x247e2a0 = { 2, 10080, 131.225.121.103 } Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: dgram_send_addr: 0x7f6caebadda8->socket = 3 Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: security_streaminit(stream=0x2485840, driver=0x7f6caeba12e0 (BSD)) Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: make_socket opening socket with family 2 Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: connect_port: Try port 50000: available - Success Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: connected to 131.225.121.103:50052 Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: our side is 0.0.0.0:50000 Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: try_socksize: send buffer size is 65536 Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: try_socksize: receive buffer size is 65536 Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: security_close(handle=0x247e260, driver=0x7f6caeba12e0 (BSD)) Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: sending: FEATURES ffffffff9efefbffffffffff1f Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: sending: DATE 2012-12-06 Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: sending: SCNF daily Thu Dec 6 16:33:32 2012: thd-0x2472490: amrecover: sending: HOST mynode.fqdn Thu Dec 6 16:34:21 2012: thd-0x2472490: amrecover: user command: 'setdisk /var' Thu Dec 6 16:34:21 2012: thd-0x2472490: amrecover: sending: DISK /var Thu Dec 6 16:34:21 2012: thd-0x2472490: amrecover: sending: OISD / Thu Dec 6 16:34:21 2012: thd-0x2472490: amrecover: sending: OLSD / Thu Dec 6 16:34:21 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/." Thu Dec 6 16:34:21 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/account/" Thu Dec 6 16:34:21 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/adm/" Thu Dec 6 16:34:21 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/cache/" Thu Dec 6 16:34:21 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/crash/" Thu Dec 6 16:34:21 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/cvs/" Thu Dec 6 16:34:21 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/db/" Thu Dec 6 16:34:21 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/empty/" Thu Dec 6 16:34:21 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/games/" Thu Dec 6 16:34:21 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/gdm/" Thu Dec 6 16:34:21 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/lib/" Thu Dec 6 16:34:21 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/local/" Thu Dec 6 16:34:21 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/lock/" Thu Dec 6 16:34:21 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/" Thu Dec 6 16:34:21 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/lost+found/" Thu Dec 6 16:34:21 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/mail" Thu Dec 6 16:34:21 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/nis/" Thu Dec 6 16:34:21 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/opt/" Thu Dec 6 16:34:21 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/preserve/" Thu Dec 6 16:34:21 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/run/" Thu Dec 6 16:34:21 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/spool/" Thu Dec 6 16:34:21 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/tmp/" Thu Dec 6 16:34:21 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/yp/" Thu Dec 6 16:34:21 2012: thd-0x2472490: amrecover: sending: DLE Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: user command: 'cd log' Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: cd_glob (log) -> ^log$ Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: sending: OISD /log Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: sending: OLSD /log Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/." Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/ConsoleKit/" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/Xorg.0.log" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/Xorg.0.log.old" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/Xorg.9.log" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/Xorg.9.log.old" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/anaconda.ifcfg.log" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/anaconda.log" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/anaconda.program.log" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/anaconda.storage.log" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/anaconda.syslog" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/anaconda.xlog" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/anaconda.yum.log" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/audit/" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/boot.log" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/btmp" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/btmp-20121201" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/cron" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/cron-20121118" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/cron-20121125" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/cron-20121202" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/cups/" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/dmesg" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/dmesg.old" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/dracut.log" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/gdm/" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/lastlog" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/maillog" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/maillog-20121118" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/maillog-20121125" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/maillog-20121202" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/mcelog" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/messages" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/messages-20121118" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/messages-20121125" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/messages-20121202" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/ntpstats/" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/ocsinventory" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/pm-powersave.log" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/ppp/" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/prelink/" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/sa/" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/samba/" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/secure" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/secure-20121118" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/secure-20121125" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/secure-20121202" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/spice-vdagentd/" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/spooler" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/spooler-20121118" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/spooler-20121125" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/spooler-20121202" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/sssd/" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/tallylog" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/wpa_supplicant.log" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/wtmp" Thu Dec 6 16:34:23 2012: thd-0x2472490: amrecover: add_dir_list_item: Adding "2012-12-06-12-56-36" "0" "atape827test:3" "3" "/log/yum.log" Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: user command: 'add pm-powersave.log' Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_glob (pm-powersave.log) -> ^pm-powersave\.log$ Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Looking for "pm-powersave\.log[/]*$" Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Converted path="pm-powersave\.log[/]*$" to tpath_on_disk="\/log/pm-powersave\.log[/]*$" Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/yum.log Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/wtmp Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/wpa_supplicant.log Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/tallylog Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/sssd/ Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/spooler-20121202 Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/spooler-20121125 Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/spooler-20121118 Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/spooler Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/spice-vdagentd/ Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/secure-20121202 Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/secure-20121125 Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/secure-20121118 Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/secure Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/samba/ Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/sa/ Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/prelink/ Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/ppp/ Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/pm-powersave.log Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: (Successful) Added /log/pm-powersave.log Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/ocsinventory Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/ntpstats/ Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/messages-20121202 Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/messages-20121125 Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/messages-20121118 Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/messages Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/mcelog Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/maillog-20121202 Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/maillog-20121125 Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/maillog-20121118 Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/maillog Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/lastlog Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/gdm/ Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/dracut.log Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/dmesg.old Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/dmesg Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/cups/ Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/cron-20121202 Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/cron-20121125 Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/cron-20121118 Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/cron Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/btmp-20121201 Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/btmp Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/boot.log Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/audit/ Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/anaconda.yum.log Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/anaconda.xlog Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/anaconda.syslog Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/anaconda.storage.log Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/anaconda.program.log Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/anaconda.log Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/anaconda.ifcfg.log Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/Xorg.9.log.old Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/Xorg.9.log Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/Xorg.0.log.old Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/Xorg.0.log Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/ConsoleKit/ Thu Dec 6 16:34:31 2012: thd-0x2472490: amrecover: add_file: Pondering ditem->path=/log/. Thu Dec 6 16:34:34 2012: thd-0x2472490: amrecover: user command: 'list' Thu Dec 6 16:34:42 2012: thd-0x2472490: amrecover: user command: 'extract' Thu Dec 6 16:34:42 2012: thd-0x2472490: amrecover: sending: TAPE Thu Dec 6 16:34:42 2012: thd-0x2472490: amrecover: append_to_tapelist(tapelist=(nil), label='atape827test', file=-1, partnum=-1, isafile=0) Thu Dec 6 16:34:42 2012: thd-0x2472490: amrecover: append_to_tapelist(tapelist=0x2495b10, label='atape827test', file=3, partnum=-1, isafile=0) Thu Dec 6 16:34:42 2012: thd-0x2472490: amrecover: append_to_tapelist(tapelist=(nil), label='atape827test', file=-1, partnum=-1, isafile=0) Thu Dec 6 16:34:42 2012: thd-0x2472490: amrecover: append_to_tapelist(tapelist=0x2495bf0, label='atape827test', file=3, partnum=-1, isafile=0) Thu Dec 6 16:34:42 2012: thd-0x2472490: amrecover: Requesting tape atape827test from user Thu Dec 6 16:34:43 2012: thd-0x2472490: amrecover: User prompt: 'Continue [?/Y/n/s/d]? '; response: 'y' Thu Dec 6 16:34:43 2012: thd-0x2472490: amrecover: security_getdriver(name=bsd) returns 0x7f6caeba12e0 Thu Dec 6 16:34:43 2012: thd-0x2472490: amrecover: security_handleinit(handle=0x2496510, driver=0x7f6caeba12e0 (BSD)) Thu Dec 6 16:34:43 2012: thd-0x2472490: amrecover: dgram_send_addr(addr=0x2496550, dgram=0x7f6caebadda8) Thu Dec 6 16:34:43 2012: thd-0x2472490: amrecover: (sockaddr_in *)0x2496550 = { 2, 10080, 131.225.121.103 } Thu Dec 6 16:34:43 2012: thd-0x2472490: amrecover: dgram_send_addr: 0x7f6caebadda8->socket = 3 Thu Dec 6 16:34:43 2012: thd-0x2472490: amrecover: dgram_recv(dgram=0x7f6caebadda8, timeout=0, fromaddr=0x7f6caebbdda0) Thu Dec 6 16:34:43 2012: thd-0x2472490: amrecover: (sockaddr_in *)0x7f6caebbdda0 = { 2, 10080, 131.225.121.103 } Thu Dec 6 16:34:43 2012: thd-0x2472490: amrecover: dgram_recv(dgram=0x7f6caebadda8, timeout=0, fromaddr=0x7f6caebbdda0) Thu Dec 6 16:34:43 2012: thd-0x2472490: amrecover: (sockaddr_in *)0x7f6caebbdda0 = { 2, 10080, 131.225.121.103 } Thu Dec 6 16:34:43 2012: thd-0x2472490: amrecover: dgram_send_addr(addr=0x2496550, dgram=0x7f6caebadda8) Thu Dec 6 16:34:43 2012: thd-0x2472490: amrecover: (sockaddr_in *)0x2496550 = { 2, 10080, 131.225.121.103 } Thu Dec 6 16:34:43 2012: thd-0x2472490: amrecover: dgram_send_addr: 0x7f6caebadda8->socket = 3 Thu Dec 6 16:34:43 2012: thd-0x2472490: amrecover: security_streaminit(stream=0x24a2110, driver=0x7f6caeba12e0 (BSD)) Thu Dec 6 16:34:44 2012: thd-0x2472490: amrecover: make_socket opening socket with family 2 Thu Dec 6 16:34:44 2012: thd-0x2472490: amrecover: connect_port: Try port 50000: available - Success Thu Dec 6 16:34:44 2012: thd-0x2472490: amrecover: connected to 131.225.121.103:50022 Thu Dec 6 16:34:44 2012: thd-0x2472490: amrecover: our side is 0.0.0.0:50000 Thu Dec 6 16:34:44 2012: thd-0x2472490: amrecover: try_socksize: send buffer size is 65536 Thu Dec 6 16:34:44 2012: thd-0x2472490: amrecover: try_socksize: receive buffer size is 65536 Thu Dec 6 16:34:44 2012: thd-0x2472490: amrecover: amidxtaped_streams[0].fd = 0x24a2110 Thu Dec 6 16:34:44 2012: thd-0x2472490: amrecover: security_streaminit(stream=0x24aa170, driver=0x7f6caeba12e0 (BSD)) Thu Dec 6 16:34:44 2012: thd-0x2472490: amrecover: make_socket opening socket with family 2 Thu Dec 6 16:34:44 2012: thd-0x2472490: amrecover: connect_port: Try port 50000: available - Success Thu Dec 6 16:34:44 2012: thd-0x2472490: amrecover: connected to 131.225.121.103:50023 Thu Dec 6 16:34:44 2012: thd-0x2472490: amrecover: our side is 0.0.0.0:50000 Thu Dec 6 16:34:44 2012: thd-0x2472490: amrecover: try_socksize: send buffer size is 65536 Thu Dec 6 16:34:44 2012: thd-0x2472490: amrecover: try_socksize: receive buffer size is 65536 Thu Dec 6 16:34:44 2012: thd-0x2472490: amrecover: amidxtaped_streams[1].fd = 0x24aa170 Thu Dec 6 16:34:44 2012: thd-0x2472490: amrecover: security_close(handle=0x2496510, driver=0x7f6caeba12e0 (BSD)) Thu Dec 6 16:34:44 2012: thd-0x2472490: amrecover: send_to_tape_server: FEATURES=ffffffff9efefbffffffffff1f Thu Dec 6 16:34:44 2012: thd-0x2472490: amrecover: send_to_tape_server: CONFIG=daily Thu Dec 6 16:34:44 2012: thd-0x2472490: amrecover: send_to_tape_server: LABEL=atape827test:3 Thu Dec 6 16:34:44 2012: thd-0x2472490: amrecover: send_to_tape_server: FSF=3 Thu Dec 6 16:34:44 2012: thd-0x2472490: amrecover: send_to_tape_server: HEADER Thu Dec 6 16:34:44 2012: thd-0x2472490: amrecover: send_to_tape_server: DEVICE=/dev/changer Thu Dec 6 16:34:44 2012: thd-0x2472490: amrecover: send_to_tape_server: HOST=^mynode.fqdn$ Thu Dec 6 16:34:44 2012: thd-0x2472490: amrecover: send_to_tape_server: DISK=^/var$ Thu Dec 6 16:34:44 2012: thd-0x2472490: amrecover: send_to_tape_server: DATESTAMP=20121206125636 Thu Dec 6 16:34:44 2012: thd-0x2472490: amrecover: send_to_tape_server: END Thu Dec 6 16:35:18 2012: thd-0x2472490: amrecover: read header 32768 => 32768 Thu Dec 6 16:35:22 2012: thd-0x2472490: amrecover: User prompt: 'Continue [?/Y/n]? '; response: 'y' Thu Dec 6 16:35:22 2012: thd-0x2472490: amrecover: send_to_tape_server: AVAIL-DATAPATH AMANDA Thu Dec 6 16:35:22 2012: thd-0x2472490: amrecover: get amidxtaped line: USE-DATAPATH AMANDA Thu Dec 6 16:35:22 2012: thd-0x2472490: amrecover: Using AMANDA data-path Thu Dec 6 16:35:22 2012: thd-0x2472490: amrecover: image is compressed Thu Dec 6 16:35:22 2012: thd-0x2472490: amrecover: Spawning "/bin/gzip /bin/gzip -dc" in pipeline Thu Dec 6 16:35:22 2012: thd-0x2472490: amrecover: send_to_tape_server: DATAPATH-OK Thu Dec 6 16:35:22 2012: thd-0x2472490: amrecover: Exec'ing /sbin/restore with arguments: Thu Dec 6 16:35:22 2012: thd-0x2472490: amrecover: restore Thu Dec 6 16:35:22 2012: thd-0x2472490: amrecover: xbf Thu Dec 6 16:35:22 2012: thd-0x2472490: amrecover: 2 Thu Dec 6 16:35:22 2012: thd-0x2472490: amrecover: - Thu Dec 6 16:35:22 2012: thd-0x2472490: amrecover: /log/pm-powersave.log gzip: stdout: Broken pipe Thu Dec 6 16:40:06 2012: thd-0x2472490: amrecover: sending: QUIT