Amanda-Users

Re: 'amtape update' coredumps

2003-05-14 10:31:28
Subject: Re: 'amtape update' coredumps
From: Brian Cuttler <brian AT wadsworth DOT org>
To: Jean-Louis Martineau <martinea AT IRO.UMontreal DOT CA>
Date: Wed, 14 May 2003 10:27:55 -0400 (EDT)
Jean-Louis,

A newer release of 2.4.4 will fix the issues on Solaris as well ?

> Hi Jean-François,
> 
> It's broken in 2.4.4, it was fixed the day after the 2.4.4 release.
> You need a recent snapshot from http://www.iro.umontreal.ca/~martinea/amanda
> 
> Jean-Louis
> 
> On Wed, May 14, 2003 at 08:45:35AM -0400, Jean-Francois Malouin wrote:
> > Hi,
> > 
> > Setup: SGI Origin3000, Irix 6.5.14m, Changer: STK L40, 4 Seagate LTOs
> > Amanda-2.4.4 split in 4 configurations, each owning one tape
> > and 10 slots in the changer, with chg-zd-mtx glue script.
> > 
> > Since I've upgraded to amanda-2.4.4, running 'amtape <conf> update'
> > coredumps. Amanda reads the label of one tape, update the changer
> > label database, then drops the ball when reaching for the next tape.
> > I've appended the debug output of chg-zd-mtx and amtape just before
> > the core is dumped and the state of amtape when it terminated.
> > My programming skills being rusty, can someone shed some light
> > on this. 
> > 
> > TIA,
> > jf
> > 
> > ---
> > chg-zd-mtx: debug 1 pid 4205656 ruid 666 euid 666: start at Tue May 13
> > 15:42:00 
> > 2003
> > 15:42:00 Arg info:
> >          $# = 2
> >          $0 = "/opt/amanda/amanda2/libexec/chg-zd-mtx"
> >          $1 = "-label"
> >          $2 = "stk_40-conf2-000009"
> > 15:42:00 Running: /opt/bin/mtx status
> > 15:42:04 Exit code: 0
> >          Stdout:
> >   Storage Changer /dev/changer:4 Drives, 42 Slots ( 2 Import/Export )
> > Data Transfer Element 0:Full (Storage Element 1 Loaded):VolumeTag = 000010  
> >     
> > Data Transfer Element 1:Full (Storage Element 19 Loaded):VolumeTag = 000049 
> >     
> > Data Transfer Element 2:Empty
> > Data Transfer Element 3:Empty
> >       Storage Element 1:Empty
> >       Storage Element 2:Full :VolumeTag=000016                          
> >       Storage Element 3:Full :VolumeTag=000017                          
> >       Storage Element 4:Full :VolumeTag=000018                          
> >       Storage Element 5:Full :VolumeTag=000019                          
> >       Storage Element 6:Full :VolumeTag=000021                          
> >       Storage Element 7:Full :VolumeTag=000040                          
> >       Storage Element 8:Full :VolumeTag=000011                          
> >       Storage Element 9:Full :VolumeTag=000012                          
> >       Storage Element 10:Full :VolumeTag=000015                          
> >       Storage Element 11:Full :VolumeTag=000041                          
> >       Storage Element 12:Full :VolumeTag=000042                          
> >       Storage Element 13:Full :VolumeTag=000043                          
> >       Storage Element 14:Full :VolumeTag=000044                          
> >       Storage Element 15:Full :VolumeTag=000045                          
> >       Storage Element 16:Full :VolumeTag=000046                          
> >       Storage Element 17:Full :VolumeTag=000047                          
> >       Storage Element 18:Full :VolumeTag=000048                          
> >       Storage Element 19:Empty
> >       Storage Element 20:Full :VolumeTag=000050                          
> > [snip: empty slots follow]
> > 
> > 15:42:04 Config info:
> >          firstslot = "11"
> >          lastslot = "20"
> >          cleanslot = "-1"
> >          cleancycle = "120"
> >          offline_before_unload = "1"
> >          unloadpause = "0"
> >          autoclean = "0"
> >          autocleancount = "99"
> >          havereader = "1"
> >          driveslot = "1"
> >          poll_drive_ready = "30"
> >          max_drive_wait = "120"
> > 15:42:04 STATUS   -> currently loaded slot = 19
> >                   -> currently loaded barcode = "000049"
> > 15:42:04 LABEL    -> Adding label "stk_40-conf2-000009" with barcode 
> > "000049" fo
> > r slot 19 into
> > /opt/amanda/amanda2/etc/amanda/stk_40-conf2/stk_40-barcodes
> >                   -> appended
> > /opt/amanda/amanda2/etc/amanda/stk_40-conf2/stk_40-barcodes entry: 
> > stk_40-conf2-000009 000049
> > 15:42:04 Exit (0) -> 19 /hw/tape/tps13d2nrnsv
> > chg-zd-mtx: pid 4230788 finish time Tue May 13 15:42:04 2003
> > 
> > ---
> > The amtape debug:
> > 
> > amtape: debug 1 pid 4227776 ruid 666 euid 666: start at Tue May 13 15:44:15 
> > 2003
> > changer: got exit: 0 str: 20 10 1 1
> > changer: got exit: 0 str: 20 /hw/tape/tps13d2nrnsv
> > changer_label: stk_40-conf2-000010 for slot 20
> > changer: got exit: 0 str: 20 10 1 1
> > changer_query: changer return was 10 1 1
> > changer_query: searchable = 1
> > changer_label: calling changer -label stk_40-conf2-000010
> > changer: got exit: 0 str: 20 /hw/tape/tps13d2nrnsv
> > 
> > ---
> > Running a debugger on the core:
> > 
> > bullcalf:amanda-conf2# dbx /opt/amanda/amanda2/sbin/amtape
> > core20030513
> > dbx version 7.3 MR 55458_Apr30_MR Apr 30 1999 13:44:41
> > dbx Warning: Unknown processor type 0xe, assuming this is not an R8000
> > Core from signal SIGBUS: Bus error
> > (dbx) where
> > >  0 realfree(0x1001c5f3, 0x145, 0x32, 0x11, 0x10, 0x6, 0x1001bf58, 
> > > 0xfb523f4) 
> > > ["/xlv46/6.5.14m/work/irix/lib/libc/libc_n32_M4/gen/malloc.c":503, 
> > > 0xfb0cfbc]
> >    1 cleanfree(0x0, 0x145, 0x32, 0x11, 0x10, 0x6, 0x1001bf58, 0xfb523f4) 
> > ["/xlv46/6.5.14m/work/irix/lib/libc/libc_n32_M4/gen/malloc.c":944, 
> > 0xfb0d830]
> >    2 __malloc(0x0, 0x145, 0x32, 0x11, 0x10, 0x6, 0x1001bf58, 0xfb523f4) 
> > ["/xlv46/6.5.14m/work/irix/lib/libc/libc_n32_M4/gen/malloc.c":230, 
> > 0xfb0ca50]
> >    3 _malloc(0x0, 0x145, 0x32, 0x11, 0x10, 0x6, 0x1001bf58, 0xfb523f4) 
> > ["/xlv46/6.5.14m/work/irix/lib/libc/libc_n32_M4/gen/malloc.c":186, 
> > 0xfb0c8c0]
> >    4 debug_alloc(s = 0x5fff4010 = "changer.c", l = 325, size = 50) 
> > ["/stuff/amanda/amanda-2.4.4/common-src/alloc.c":218, 0x401d8d4]
> >    5 internal_vstralloc(str = 0x1001db20 = 
> > "/opt/amanda/amanda2/libexec/chg-zd-mtx", argp = 0x7fff2c10 = "") 
> > ["/stuff/amanda/amanda-2.4.4/common-src/alloc.c":323, 0x401dca0]
> >    6 debug_vstralloc(str = 0x1001db20 = 
> > "/opt/amanda/amanda2/libexec/chg-zd-mtx", ... = <void>) 
> > ["/stuff/amanda/amanda-2.4.4/common-src/alloc.c":345, 0x401dddc]
> >    7 changer_command(cmd = 0x5fff7a70 = "-slot", arg = 0x5fff7a90 = "next") 
> > ["/stuff/amanda/amanda-2.4.4/server-src/changer.c":325, 0x5ffc72f0]
> >    8 run_changer_command(cmd = 0x5fff7a70 = "-slot", arg = 0x5fff7a90 = 
> > "next", slotstr = 0x7fff2e04, rest = 0x7fff2db0) 
> > ["/stuff/amanda/amanda-2.4.4/server-src/changer.c":93, 0x5ffc6308]
> >    9 changer_loadslot(inslotstr = 0x5fff7a90 = "next", outslotstr = 
> > 0x7fff2e04, devicename = 0x7fff2e00) 
> > ["/stuff/amanda/amanda-2.4.4/server-src/changer.c":148, 0x5ffc67cc]
> >    10 changer_scan(user_init = 0x100038b0, user_slot = 0x100039e0) 
> > ["/stuff/amanda/amanda-2.4.4/server-src/changer.c":221, 0x5ffc6bd0]
> >    11 update_labeldb(argc = 1, argv = 0x7fff2f2c) 
> > ["/stuff/amanda/amanda-2.4.4/server-src/amtape.c":463, 0x10003e48]
> >    12 main(argc = 1, argv = 0x7fff2f2c) 
> > ["/stuff/amanda/amanda-2.4.4/server-src/amtape.c":177, 0x10002b08]
> >    13 __start() 
> > ["/xlv55/kudzu-apr12/work/irix/lib/libc/libc_n32_M3/csu/crt1text.s":177, 
> > 0x10002178]
> > 
> > -- 
> > Excess on occasion is exhilarating.  It prevents moderation from
> > acquiring the deadening effect of a habit.
> 
> -- 
> Jean-Louis Martineau             email: martineau AT IRO.UMontreal DOT CA 
> Departement IRO, Universite de Montreal
> C.P. 6128, Succ. CENTRE-VILLE    Tel: (514) 343-6111 ext. 3529
> Montreal, Canada, H3C 3J7        Fax: (514) 343-5834



<Prev in Thread] Current Thread [Next in Thread>