Date: Tue, 21 May 2002 11:56:24 -0400 From: Mike Tancsa <mike@sentex.net> To: freebsd-scsi@freebsd.org Subject: tape changer problems Message-ID: <5.1.0.14.0.20020521114013.0555e948@192.168.0.12>
next in thread | raw e-mail | index | archive | help
Since our backups are getting bigger and bigger, I figured it was time for a tape changer. We picked up a Sony TSL-9000 which *seems* to work ok. Before I move to something like Amanda, I wanted to at least go through the process manually. Briefly, I can seeming dump out to multiple volumes, but never read beyond the first tape. So far I have tried the following 1) Load up the mag with 8 tapes. 2) chio move drive 0 slot 0 At this point, chio status -S shows backup2# chio status -S picker 0: source: <> slot 0: <ACCESS> source: <> slot 1: <ACCESS,FULL> source: <> slot 2: <ACCESS,FULL> source: <> slot 3: <ACCESS,FULL> source: <> slot 4: <ACCESS,FULL> source: <> slot 5: <ACCESS,FULL> source: <> slot 6: <ACCESS,FULL> source: <> slot 7: <ACCESS,FULL> source: <> drive 0: <ACCESS,FULL> source: <> backup2# Looks good so far. 3) dump -0 -u -a -n -f /dev/nrsa1 /tmpbackup 4) When prompted because the tape runs out, I issue a mt -f /dev/nrsa1 offline and chio status shows that I am pointing to the next slot. I then continue with the dump on the next tape. Once everything is written out mt -f /dev/nrsa1 offline until I am at the start again and do a chio move drive 0 slot 0. Note, I dont know if its a limitation of the unit, but I can never do a move until I return the unit to its native position (i.e. the position right after I physically put the magazine in.) So far so good (it seems) Now I try a restore. restore -rf /dev/nrsa1 or restore -i -f /dev/nrsa1 add my files and start at vol 1 From the first tape all is restoring great. But when it hits the end of the tape, I get an error and Tape read error while trying to resynchronize with the following in kern.* May 19 21:55:37 backup2 /kernel: (sa1:ahc0:0:5:0): SCB 0x3 - timed out May 19 21:55:37 backup2 /kernel: ahc0: Dumping Card State while idle, at SEQADDR 0x8 May 19 21:55:37 backup2 /kernel: ACCUM = 0x0, SINDEX = 0x38, DINDEX = 0xe4, ARG_2 = 0x0 May 19 21:55:37 backup2 /kernel: HCNT = 0x0 SCBPTR = 0x6 May 19 21:55:37 backup2 /kernel: SCSISEQ = 0x12, SBLKCTL = 0x6 May 19 21:55:37 backup2 /kernel: DFCNTRL = 0x0, DFSTATUS = 0x89 May 19 21:55:37 backup2 /kernel: LASTPHASE = 0x1, SCSISIGI = 0x0, SXFRCTL0 = 0x80 May 19 21:55:37 backup2 /kernel: SSTAT0 = 0x0, SSTAT1 = 0xa May 19 21:55:37 backup2 /kernel: STACK == 0x3, 0x10d, 0x165, 0xec May 19 21:55:38 backup2 /kernel: SCB count = 140 May 19 21:55:38 backup2 /kernel: Kernel NEXTQSCB = 23 May 19 21:55:38 backup2 /kernel: Card NEXTQSCB = 23 May 19 21:55:38 backup2 /kernel: QINFIFO entries: May 19 21:55:38 backup2 /kernel: Waiting Queue entries: May 19 21:55:38 backup2 /kernel: Disconnected Queue entries: 18:3 May 19 21:55:38 backup2 /kernel: QOUTFIFO entries: May 19 21:55:38 backup2 /kernel: Sequencer Free SCB List: 6 11 21 2 15 14 1 5 25 28 12 13 30 26 9 19 31 0 4 20 16 3 27 23 17 29 22 1 0 8 24 7 May 19 21:55:38 backup2 /kernel: Sequencer SCB Info: 0(c 0x60, s 0x47, l 0, t 0xff) 1(c 0x60, s 0x47, l 0, t 0xff) 2(c 0x60, s 0x27, l 0, t 0xff) 3(c 0x60, s 0x47, l 0, t 0xff) 4(c 0x60, s 0x27, l 0, t 0xff) 5(c 0x60, s 0x27, l 0, t 0xff) 6(c 0x60, s 0x27, l 0, t 0xff) 7(c 0x60, s 0x47, l 0, t 0xff) 8(c 0x40, s 0x57, l 0, t 0xff) 9(c 0x60, s 0x27, l 0, t 0xff) 10(c 0x60, s 0x47, l 0, t 0xff) 1 1(c 0x60, s 0x27, l 0, t 0xff) 12(c 0x60, s 0x27, l 0, t 0xff) 13(c 0x60, s 0x47, l 0, t 0xff) 14(c 0x60, s 0x27, l 0, t 0xff) 15(c 0x60, s 0x47, l 0, t 0xff) 16(c 0x60, s 0x27, l 0, t 0xff) 17(c 0x40, s 0x57, l 0, t 0xff) 18(c 0x44, s 0x57, l 0, t 0x3) 19(c 0x60, s 0x27, l 0, t 0xff) 20(c 0x60, s 0x27, l 0, t 0xff) 21(c 0x60, s 0x27, l 0, t 0xff) 22(c 0x60, s 0x27, l 0, t 0xff) 23(c 0x60, s 0 x27, l 0, t 0xff) 24(c 0x60, s 0x47, l 0, t 0xff) 25(c 0x60, s 0x47, l 0, t 0xff) 26(c 0x60, s 0x27, l 0, t 0xff) 27(c 0x60, s 0x27, l 0, t 0xff) 28(c 0x60, s 0x47, l 0, t 0xff) 29(c 0x60, s 0x47, l 0, t 0xff) 30(c 0x60, s 0x47, l 0, t 0xff) 31(c 0x60, s 0 May 19 21:55:38 backup2 /kernel: , t 0xff) May 19 21:55:38 backup2 /kernel: Pending list: 3(c 0x40, s 0x57, l 0) May 19 21:55:38 backup2 /kernel: Kernel Free SCB list: 56 15 66 95 99 7 88 6 10 86 34 32 83 138 71 122 60 76 67 93 78 36 43 77 29 12 1 58 11 17 81 68 18 44 20 64 0 73 94 1 13 87 12 4 33 52 47 46 92 97 96 28 50 139 59 35 80 54 120 79 82 45 30 65 98 49 61 22 72 5 123 124 125 126 127 128 129 110 111 112 113 114 115 116 117 118 119 100 101 102 103 104 105 106 107 108 109 90 91 74 40 9 27 63 62 8 48 38 24 57 16 42 37 41 69 39 75 89 19 51 21 31 26 85 2 53 25 55 70 84 14 137 136 135 134 133 132 131 130 May 19 21:55:38 backup2 /kernel: Untagged Q(5): 3 May 19 21:55:38 backup2 /kernel: sg[0] - Addr 0x13c82000 : Length 4096 May 19 21:55:38 backup2 /kernel: sg[1] - Addr 0x130c3000 : Length 4096 May 19 21:55:38 backup2 /kernel: sg[2] - Addr 0x2e0c4000 : Length 4096 May 19 21:55:38 backup2 /kernel: sg[3] - Addr 0x4725000 : Length 4096 May 19 21:55:38 backup2 /kernel: sg[4] - Addr 0x22aa6000 : Length 4096 May 19 21:55:38 backup2 /kernel: sg[5] - Addr 0x1bfa7000 : Length 4096 May 19 21:55:38 backup2 /kernel: sg[6] - Addr 0xb228000 : Length 4096 May 19 21:55:38 backup2 /kernel: sg[7] - Addr 0x3c49000 : Length 4096 May 19 21:55:38 backup2 /kernel: sg[8] - Addr 0x2594a000 : Length 4096 May 19 21:55:38 backup2 /kernel: sg[9] - Addr 0x1dc2b000 : Length 4096 May 19 21:55:38 backup2 /kernel: sg[10] - Addr 0x2906c000 : Length 4096 May 19 21:55:38 backup2 /kernel: sg[11] - Addr 0x2f6d000 : Length 4096 May 19 21:55:38 backup2 /kernel: sg[12] - Addr 0x504e000 : Length 4096 May 19 21:55:38 backup2 /kernel: sg[13] - Addr 0x698f000 : Length 4096 May 19 21:55:38 backup2 /kernel: sg[14] - Addr 0xa4d0000 : Length 4096 May 19 21:55:38 backup2 /kernel: sg[15] - Addr 0x1b71000 : Length 4096 May 19 21:55:38 backup2 /kernel: (sa1:ahc0:0:5:0): Queuing a BDR SCB May 19 21:55:38 backup2 /kernel: (sa1:ahc0:0:5:0): Bus Device Reset Message Sent May 19 21:55:38 backup2 /kernel: (sa1:ahc0:0:5:0): no longer in timeout, status = 34b May 19 21:55:38 backup2 /kernel: ahc0: Bus Device Reset on A:5. 1 SCBs aborted May 19 22:04:11 backup2 /kernel: (sa1:ahc0:0:5:0): tape is now frozen- use an OFFLINE, REWIND or MTEOM command to clear this state. I try a mt -f /dev/nrsa1 offline to move to the next tape, but no dice on continuing the restore. The machine is 4.6-RC FreeBSD 4.6-RC #1: Thu May 16 16:56:59 EDT 2002 May 16 17:00:30 backup2 /kernel: Copyright (c) 1992-2002 The FreeBSD Project. May 16 17:00:30 backup2 /kernel: Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994 May 16 17:00:30 backup2 /kernel: The Regents of the University of California. All rights reserved. May 16 17:00:30 backup2 /kernel: FreeBSD 4.6-RC #1: Thu May 16 16:56:59 EDT 2002 May 16 17:00:30 backup2 /kernel: mdtancsa@backup2.sentex.ca:/usr/obj/usr/src/sys/backup May 16 17:00:30 backup2 /kernel: Timecounter "i8254" frequency 1193182 Hz May 16 17:00:30 backup2 /kernel: Timecounter "TSC" frequency 803413761 Hz May 16 17:00:30 backup2 /kernel: CPU: Pentium III/Pentium III Xeon/Celeron (803.41-MHz 686-class CPU) May 16 17:00:30 backup2 /kernel: Origin = "GenuineIntel" Id = 0x686 Stepping = 6 May 16 17:00:30 backup2 /kernel: Features=0x383f9ff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,MMX,FXSR,SSE> May 16 17:00:30 backup2 /kernel: real memory = 805224448 (786352K bytes) May 16 17:00:30 backup2 /kernel: config> q May 16 17:00:30 backup2 /kernel: avail memory = 779894784 (761616K bytes) May 16 17:00:30 backup2 /kernel: Preloaded elf kernel "kernel" at 0xc0366000. May 16 17:00:30 backup2 /kernel: Preloaded userconfig_script "/boot/kernel.conf" at 0xc036609c. May 16 17:00:30 backup2 /kernel: netsmb_dev: loaded May 16 17:00:30 backup2 /kernel: Pentium Pro MTRR support enabled May 16 17:00:30 backup2 /kernel: md0: Malloc disk May 16 17:00:30 backup2 /kernel: Using $PIR table, 7 entries at 0xc00f1250 May 16 17:00:30 backup2 /kernel: npx0: <math processor> on motherboard May 16 17:00:30 backup2 /kernel: npx0: INT 16 interface May 16 17:00:30 backup2 /kernel: pcib0: <Host to PCI bridge> on motherboard May 16 17:00:30 backup2 /kernel: pci0: <PCI bus> on pcib0 May 16 17:00:30 backup2 /kernel: pcib2: <PCI to PCI bridge (vendor=1106 device=8605)> at device 1.0 on pci0 May 16 17:00:30 backup2 /kernel: pci1: <PCI bus> on pcib2 May 16 17:00:30 backup2 /kernel: pci1: <ATI Mach64-GB graphics accelerator> at 0.0 May 16 17:00:30 backup2 /kernel: isab0: <VIA 82C686 PCI-ISA bridge> at device 4.0 on pci0 May 16 17:00:30 backup2 /kernel: isa0: <ISA bus> on isab0 May 16 17:00:30 backup2 /kernel: atapci0: <VIA 82C686 ATA66 controller> port 0xb800-0xb80f at device 4.1 on pci0 May 16 17:00:30 backup2 /kernel: ata0: at 0x1f0 irq 14 on atapci0 May 16 17:00:30 backup2 /kernel: ata1: at 0x170 irq 15 on atapci0 May 16 17:00:30 backup2 /kernel: pci0: <unknown card> (vendor=0x1106, dev=0x3057) at 4.4 May 16 17:00:30 backup2 /kernel: fxp0: <Intel Pro 10/100B/100+ Ethernet> port 0xa800-0xa81f mem 0xf9000000-0xf90fffff,0xfd000000-0xf d000fff irq 11 at device 13.0 on pci0 May 16 17:00:30 backup2 /kernel: fxp0: Ethernet address 00:a0:c9:89:d5:ba May 16 17:00:30 backup2 /kernel: inphy0: <i82555 10/100 media interface> on miibus0 May 16 17:00:30 backup2 /kernel: inphy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto May 16 17:00:30 backup2 /kernel: atapci1: <HighPoint HPT372 ATA133 controller> port 0x9000-0x90ff,0x9400-0x9403,0x9800-0x9807,0xa000 -0xa003,0xa400-0xa407 irq 10 at device 14.0 on pci0 May 16 17:00:30 backup2 /kernel: ata2: at 0xa400 on atapci1 May 16 17:00:30 backup2 /kernel: ata3: at 0x9800 on atapci1 May 16 17:00:30 backup2 /kernel: fxp1: <Intel Pro 10/100B/100+ Ethernet> port 0x8800-0x881f mem 0xf8800000-0xf88fffff,0xfc000000-0xf c000fff irq 12 at device 15.0 on pci0 May 16 17:00:30 backup2 /kernel: fxp1: Ethernet address 00:90:27:25:bf:8b May 16 17:00:30 backup2 /kernel: inphy1: <i82555 10/100 media interface> on miibus1 May 16 17:00:30 backup2 /kernel: inphy1: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto May 16 17:00:30 backup2 /kernel: ahc0: <Adaptec 2940 Ultra2 SCSI adapter> port 0x8400-0x84ff mem 0xf8000000-0xf8000fff irq 11 at dev ice 17.0 on pci0 May 16 17:00:30 backup2 /kernel: aic7890/91: Ultra2 Wide Channel A, SCSI Id=7, 32/253 SCBs May 16 17:00:30 backup2 /kernel: pcib1: <Host to PCI bridge> on motherboard May 16 17:00:30 backup2 /kernel: pci2: <PCI bus> on pcib1 May 16 17:00:30 backup2 /kernel: orm0: <Option ROMs> at iomem 0xc0000-0xc7fff,0xd8000-0xdd7ff on isa0 May 16 17:00:30 backup2 /kernel: fdc0: <NEC 72065B or clone> at port 0x3f0-0x3f5,0x3f7 irq 6 drq 2 on isa0 May 16 17:00:30 backup2 /kernel: fdc0: FIFO enabled, 8 bytes threshold May 16 17:00:30 backup2 /kernel: fd0: <1440-KB 3.5" drive> on fdc0 drive 0 May 16 17:00:30 backup2 /kernel: atkbdc0: <Keyboard controller (i8042)> at port 0x60,0x64 on isa0 May 16 17:00:30 backup2 /kernel: atkbd0: <AT Keyboard> irq 1 on atkbdc0 May 16 17:00:30 backup2 /kernel: kbd0 at atkbd0 May 16 17:00:30 backup2 /kernel: vga0: <Generic ISA VGA> at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0 May 16 17:00:30 backup2 /kernel: sc0: <System console> at flags 0x100 on isa0 May 16 17:00:30 backup2 /kernel: sc0: VGA <16 virtual consoles, flags=0x300> May 16 17:00:30 backup2 /kernel: sio0 at port 0x3f8-0x3ff irq 4 flags 0x10 on isa0 May 16 17:00:30 backup2 /kernel: sio0: type 16550A May 16 17:00:30 backup2 /kernel: sio1: configured irq 3 not in bitmap of probed irqs 0 May 16 17:00:30 backup2 /kernel: IP packet filtering initialized, divert enabled, rule-based forwarding enabled, default to accept, logging limited to 23100 packets/entry by default May 16 17:00:30 backup2 /kernel: IPv6 packet filtering initialized, logging limited to 1000 packets/entry May 16 17:00:30 backup2 /kernel: ad0: 19595MB <QUANTUM FIREBALLP AS20.5> [39813/16/63] at ata0-master UDMA66 May 16 17:00:30 backup2 /kernel: ad1: 117246MB <Maxtor 4G120J6> [238216/16/63] at ata0-slave UDMA66 May 16 17:00:30 backup2 /kernel: ad4: 117246MB <Maxtor 4G120J6> [238216/16/63] at ata2-master UDMA133 May 16 17:00:30 backup2 /kernel: ad6: 117246MB <Maxtor 4G120J6> [238216/16/63] at ata3-master UDMA133 May 16 17:00:30 backup2 /kernel: Waiting 15 seconds for SCSI devices to settle May 16 17:00:30 backup2 /kernel: sa0 at ahc0 bus 0 target 0 lun 0 May 16 17:00:30 backup2 /kernel: sa0: <SONY SDT-10000 0110> Removable Sequential Access SCSI-2 device May 16 17:00:30 backup2 /kernel: sa0: 40.000MB/s transfers (20.000MHz, offset 15, 16bit) May 16 17:00:30 backup2 /kernel: sa1 at ahc0 bus 0 target 5 lun 0 May 16 17:00:30 backup2 /kernel: sa1: <SONY TSL-9000 L006> Removable Sequential Access SCSI-2 device May 16 17:00:30 backup2 /kernel: sa1: 10.000MB/s transfers (10.000MHz, offset 15) May 16 17:00:30 backup2 /kernel: da0 at ahc0 bus 0 target 2 lun 0 May 16 17:00:30 backup2 /kernel: da0: <QUANTUM ATLAS IV 9 WLS 0909> Fixed Direct Access SCSI-3 device May 16 17:00:30 backup2 /kernel: da0: 40.000MB/s transfers (20.000MHz, offset 31, 16bit), Tagged Queueing Enabled May 16 17:00:30 backup2 /kernel: da0: 8761MB (17942584 512 byte sectors: 255H 63S/T 1116C) May 16 17:00:30 backup2 /kernel: da1 at ahc0 bus 0 target 4 lun 0 May 16 17:00:30 backup2 /kernel: da1: <QUANTUM ATLAS IV 9 WLS 0B0B> Fixed Direct Access SCSI-3 device May 16 17:00:30 backup2 /kernel: da1: 40.000MB/s transfers (20.000MHz, offset 31, 16bit), Tagged Queueing Enabled May 16 17:00:30 backup2 /kernel: da1: 8761MB (17942584 512 byte sectors: 255H 63S/T 1116C) May 16 17:00:30 backup2 /kernel: ch0 at ahc0 bus 0 target 5 lun 1 May 16 17:00:30 backup2 /kernel: ch0: <SONY TSL-9000 L006> Removable Changer SCSI-2 device May 16 17:00:30 backup2 /kernel: ch0: 10.000MB/s transfers (10.000MHz, offset 15) May 16 17:00:30 backup2 /kernel: ch0: 8 slots, 1 drive, 1 picker, 0 portals May 16 17:00:30 backup2 /kernel: Mounting root from ufs:/dev/ad0s1a Any pointers much appreciated! ---Mike -------------------------------------------------------------------- Mike Tancsa, tel +1 519 651 3400 Sentex Communications, mike@sentex.net Providing Internet since 1994 www.sentex.net Cambridge, Ontario Canada www.sentex.net/mike To Unsubscribe: send mail to majordomo@FreeBSD.org with "unsubscribe freebsd-questions" in the body of the message
Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?5.1.0.14.0.20020521114013.0555e948>