Skip site navigation (1)Skip section navigation (2)
Date:      Mon, 6 Mar 2017 10:36:13 -0800
From:      Mark Millard <markmi@dsl-only.net>
To:        Mark Johnston <markj@FreeBSD.org>
Cc:        FreeBSD PowerPC ML <freebsd-ppc@freebsd.org>
Subject:   Re: powerpc64 head -r314687 (PowerMac G5 so-called "Quad Core", clang based): CAM status: Command timeout (always?)
Message-ID:  <466C25ED-0A70-4988-9BB1-3B43BD031E5E@dsl-only.net>
In-Reply-To: <20170306164341.GA83069@wkstn-mjohnston.west.isilon.com>
References:  <98A62E0D-C2A0-40B1-AE6D-5810906208AE@dsl-only.net> <4C78F6AA-5ABD-4445-B5EF-4E6778CE36FE@dsl-only.net> <20170306164341.GA83069@wkstn-mjohnston.west.isilon.com>

next in thread | previous in thread | raw e-mail | index | archive | help
On 2017-Mar-6, at 8:43 AM, Mark Johnston <markj at FreeBSD.org> wrote:

> On Mon, Mar 06, 2017 at 02:05:39AM -0800, Mark Millard wrote:
>> On 2017-Mar-6, at 1:37 AM, Mark Millard <markmi at dsl-only.net> =
wrote:
>>=20
>>> When I tried to jump from head -r314479 to -r314687 the -r314687 =
kernel
>>> the result failed by always(?) getting:
>>>=20
>>> CAM status: Command timeout
>>>=20
>>> for:
>>>=20
>>> ATAPI_IDENTIFY
>>> INQUIRY
>>> DSM TRIM
>>> READ_DMA48
>>> SETFEATURES ENABLE RCACHE
>>> WRITE_DMA48
>>> etc.
>>>=20
>>> at:
>>>=20
>>> ada0:ata2:0:0:0
>>> aprobe0:ata0:0:0:0
>>>=20
>>> Booting with the older -r314479 works fine (same -r314687 world).
>>>=20
>>> [FYI: It is a ufs context.]
>>>=20
>>>=20
>>> The only thing that looks likely to me for
>>> the change in behavior is. . .
>>>=20
>>> Author: markj
>>> Date: Fri Mar  3 20:51:57 2017
>>> New Revision: 314624
>>> URL:=20
>>> https://svnweb.freebsd.org/changeset/base/314624
>>>=20
>>>=20
>>> Log:
>>> Reject userland CCBs that have CAM_UNLOCKED set.
>>>=20
>>> CAM_UNLOCKED is internal flag and cannot correctly be set by =
userland.
>>> Return EINVAL from CAMIOCOMMAND and CAMIOQUEUE if it is set.
>>>=20
>>> Also fix leaks in some of the error paths for CAMIOQUEUE.
>>>=20
>>> PR:		215356
>>> Reviewed by:	ken, mav
>>> MFC after:	1 week
>>> Differential Revision:=09
>>> https://reviews.freebsd.org/D9869
>>>=20
>>>=20
>>> Modified:
>>> head/sys/cam/cam_xpt.c
>>> head/sys/cam/scsi/scsi_pass.c
>>>=20
>>>=20
>>>=20
>>> [This may just mean that it exposes other problems.]
>>=20
>> Yep: reverting the two files allowed the PowerMac G5 so-called
>> "Quad Core" to boot fully and I could log in.
>=20
> Do you have a full dmesg of the failed boot? Am I correct in thinking
> that the boot failed before making it to user mode?

/var/log/messages has the boot. I'll put the text at the end of
this reply.

It ends abruptly because I had to use the power switch: It never
did take input to login with. Being ufs with softupdates the
recorded end is possibly before the actual end.

> If so I'm rather
> puzzled, as the change should only affect userland applications.
> Specifically, it modified a couple of ioctl handlers.
>=20
>>=20
>> It appears that if such powerpc64 machines are to stay bootable
>> then other things need to be cleaned up before the two updated
>> files from -r314624 should be used.
>>=20
>> Should the 2 files be reverted until other things are cleaned up?
>=20
> I don't mind reverting the change, but my suspicion is that it =
uncovered
> a problem rather than introducing it. If you're willing to narrow =
things
> down a bit, could you try booting with one of the file modifications =
and
> not the other? They are independent.

In a while I'll try each of the files individually, one old, one modern
each time.

Here is the /var/log/messages content:
(I've removed various serial numbers.)


Mar  6 03:54:36 FBSDG5L syslogd: kernel boot file is /boot/kernel/kernel
Mar  6 03:54:36 FBSDG5L kernel: Copyright (c) 1992-2017 The FreeBSD =
Project.
Mar  6 03:54:36 FBSDG5L kernel: Copyright (c) 1979, 1980, 1983, 1986, =
1988, 1989, 1991, 1992, 1993, 1994
Mar  6 03:54:36 FBSDG5L kernel: The Regents of the University of =
California. All rights reserved.
Mar  6 03:54:36 FBSDG5L kernel: FreeBSD is a registered trademark of The =
FreeBSD Foundation.
Mar  6 03:54:36 FBSDG5L kernel: FreeBSD 12.0-CURRENT  r314687M powerpc
Mar  6 03:54:36 FBSDG5L kernel: FreeBSD clang version 4.0.0 =
(branches/release_40 296509) (based on LLVM 4.0.0)
Mar  6 03:54:36 FBSDG5L kernel: VT(ofwfb): resolution 1280x1024
Mar  6 03:54:36 FBSDG5L kernel: cpu0: IBM PowerPC 970MP revision 1.1, =
2500.41 MHz
Mar  6 03:54:36 FBSDG5L kernel: cpu0: Features =
dc000000<PPC32,PPC64,ALTIVEC,FPU,MMU>
Mar  6 03:54:36 FBSDG5L kernel: cpu0: HID0 =
1511081<DEEPNAP,NAP,DPM,NHR,TBEN,ENATTN>
Mar  6 03:54:36 FBSDG5L kernel: real memory  =3D 17148002304 (16353 MB)
Mar  6 03:54:36 FBSDG5L kernel: avail memory =3D 16428167168 (15667 MB)
Mar  6 03:54:36 FBSDG5L kernel: FreeBSD/SMP: Multiprocessor System =
Detected: 4 CPUs
Mar  6 03:54:36 FBSDG5L kernel: cpu0: dev=3Dff89d680 (BSP)
Mar  6 03:54:36 FBSDG5L kernel: cpu1: dev=3Dff89eb70
Mar  6 03:54:36 FBSDG5L kernel: cpu2: dev=3Dff89f248
Mar  6 03:54:36 FBSDG5L kernel: cpu3: dev=3Dff89f920
Mar  6 03:54:36 FBSDG5L kernel: random: unblocking device.
Mar  6 03:54:36 FBSDG5L kernel: random: entropy device external =
interface
Mar  6 03:54:36 FBSDG5L kernel: kbd0 at kbdmux0
Mar  6 03:54:36 FBSDG5L kernel: ofwbus0: <Open Firmware Device Tree> on =
nexus0
Mar  6 03:54:36 FBSDG5L kernel: cpulist0: <Open Firmware CPU Group> on =
ofwbus0
Mar  6 03:54:36 FBSDG5L kernel: cpu0: <Open Firmware CPU> on cpulist0
Mar  6 03:54:36 FBSDG5L kernel: pcr0: <PPC 970 Power Control Register> =
on cpu0
Mar  6 03:54:36 FBSDG5L kernel: cpu1: <Open Firmware CPU> on cpulist0
Mar  6 03:54:36 FBSDG5L kernel: pcr1: <PPC 970 Power Control Register> =
on cpu1
Mar  6 03:54:36 FBSDG5L kernel: cpu2: <Open Firmware CPU> on cpulist0
Mar  6 03:54:36 FBSDG5L kernel: pcr2: <PPC 970 Power Control Register> =
on cpu2
Mar  6 03:54:36 FBSDG5L kernel: cpu3: <Open Firmware CPU> on cpulist0
Mar  6 03:54:36 FBSDG5L kernel: pcr3: <PPC 970 Power Control Register> =
on cpu3
Mar  6 03:54:36 FBSDG5L kernel: powermac_nvram0: <Apple NVRAM> mem =
0xfff04000-0xfff07fff on ofwbus0
Mar  6 03:54:36 FBSDG5L kernel: powermac_nvram0: bank0 generation 1650, =
bank1 generation 1649
Mar  6 03:54:36 FBSDG5L kernel: unin0: <Apple UniNorth System =
Controller> mem 0xf8000000-0xf8ffffff on ofwbus0
Mar  6 03:54:36 FBSDG5L kernel: unin0: Version 66
Mar  6 03:54:36 FBSDG5L kernel: iichb0: <Keywest I2C controller> mem =
0xf8001000-0xf8001fff irq 0 on unin0
Mar  6 03:54:36 FBSDG5L kernel: iicbus0: <OFW I2C bus> on iichb0
Mar  6 03:54:36 FBSDG5L kernel: ds17750: <Temp-Monitor DS1775> at addr =
0x94 on iicbus0
Mar  6 03:54:36 FBSDG5L kernel: ds16310: <Temp-Monitor DS1631> at addr =
0x96 on iicbus0
Mar  6 03:54:36 FBSDG5L kernel: max66900: <Temp-Monitor MAX6690> at addr =
0x98 on iicbus0
Mar  6 03:54:36 FBSDG5L kernel: max66901: <Temp-Monitor MAX6690> at addr =
0x9c on iicbus0
Mar  6 03:54:36 FBSDG5L kernel: htpic0: <OpenPIC Interrupt Controller> =
mem 0xf8040000-0xf807ffff on unin0
Mar  6 03:54:36 FBSDG5L kernel: pcib0: <IBM CPC945 PCI Express Root> mem =
0xf0000000-0xf1ffffff on ofwbus0
Mar  6 03:54:36 FBSDG5L kernel: pci0: <OFW PCI bus> on pcib0
Mar  6 03:54:36 FBSDG5L kernel: vgapci0: <VGA-compatible display> mem =
0xa1000000-0xa1ffffff,0x90000000-0x9fffffff,0xa0000000-0xa0ffffff irq 3 =
at device 0.0 on pci0
Mar  6 03:54:36 FBSDG5L kernel: vgapci0: Boot video device
Mar  6 03:54:36 FBSDG5L kernel: pcib1: <IBM CPC9X5 HyperTransport =
Tunnel> mem 0xf2000000-0xf47fffff,0xf8070000-0xf8070fff on ofwbus0
Mar  6 03:54:36 FBSDG5L kernel: pcib1: 86 HT IRQs on device 7.0
Mar  6 03:54:36 FBSDG5L kernel: pci1: <OFW PCI bus> on pcib1
Mar  6 03:54:36 FBSDG5L kernel: pcib1: Enabling MSI window for =
HyperTransport slave at pci1:0:1:0
Mar  6 03:54:36 FBSDG5L kernel: pcib2: <OFW PCI-PCI bridge> at device =
1.0 on pci1
Mar  6 03:54:36 FBSDG5L kernel: pci2: <OFW PCI bus> on pcib2
Mar  6 03:54:36 FBSDG5L kernel: pcib3: <OFW PCI-PCI bridge> at device =
2.0 on pci1
Mar  6 03:54:36 FBSDG5L kernel: pci3: <OFW PCI bus> on pcib3
Mar  6 03:54:36 FBSDG5L kernel: bge0: <Broadcom BCM5714 B3, ASIC rev. =
0x008003> mem 0xfa530000-0xfa53ffff,0xfa520000-0xfa52ffff irq 66 at =
device 4.0 on pci3
Mar  6 03:54:36 FBSDG5L kernel: bge0: CHIP ID 0x00008003; ASIC REV 0x08; =
CHIP REV 0x80; PCI-X 33 MHz
Mar  6 03:54:36 FBSDG5L kernel: miibus0: <MII bus> on bge0
Mar  6 03:54:36 FBSDG5L kernel: brgphy0: <BCM5780 1000BASE-T media =
interface> PHY 1 on miibus0
Mar  6 03:54:36 FBSDG5L kernel: brgphy0:  10baseT, 10baseT-FDX, =
100baseTX, 100baseTX-FDX, 1000baseT, 1000baseT-master, 1000baseT-FDX, =
1000baseT-FDX-master, auto, auto-flow
Mar  6 03:54:36 FBSDG5L kernel: bge0: Ethernet address: =
00:14:51:68:5a:44
Mar  6 03:54:36 FBSDG5L kernel: bge1: <Broadcom BCM5714 B3, ASIC rev. =
0x008003> mem 0xfa510000-0xfa51ffff,0xfa500000-0xfa50ffff irq 67 at =
device 4.1 on pci3
Mar  6 03:54:36 FBSDG5L kernel: bge1: CHIP ID 0x00008003; ASIC REV 0x08; =
CHIP REV 0x80; PCI-X 33 MHz
Mar  6 03:54:36 FBSDG5L kernel: miibus1: <MII bus> on bge1
Mar  6 03:54:36 FBSDG5L kernel: brgphy1: <BCM5780 1000BASE-T media =
interface> PHY 1 on miibus1
Mar  6 03:54:36 FBSDG5L kernel: brgphy1:  10baseT, 10baseT-FDX, =
100baseTX, 100baseTX-FDX, 1000baseT, 1000baseT-master, 1000baseT-FDX, =
1000baseT-FDX-master, auto, auto-flow
Mar  6 03:54:36 FBSDG5L kernel: bge1: Ethernet address: =
00:14:51:68:5a:45
Mar  6 03:54:36 FBSDG5L kernel: pcib4: <OFW PCI-PCI bridge> at device =
3.0 on pci1
Mar  6 03:54:36 FBSDG5L kernel: pci4: <OFW PCI bus> on pcib4
Mar  6 03:54:36 FBSDG5L kernel: pcib5: <OFW PCI-PCI bridge> at device =
4.0 on pci1
Mar  6 03:54:36 FBSDG5L kernel: pci5: <OFW PCI bus> on pcib5
Mar  6 03:54:36 FBSDG5L kernel: pcib6: <OFW PCI-PCI bridge> at device =
5.0 on pci1
Mar  6 03:54:36 FBSDG5L kernel: pci6: <OFW PCI bus> on pcib6
Mar  6 03:54:36 FBSDG5L kernel: pcib7: <OFW PCI-PCI bridge> at device =
6.0 on pci1
Mar  6 03:54:36 FBSDG5L kernel: pci7: <OFW PCI bus> on pcib7
Mar  6 03:54:36 FBSDG5L kernel: pcib8: <OFW PCI-PCI bridge> at device =
7.0 on pci1
Mar  6 03:54:36 FBSDG5L kernel: pci8: <OFW PCI bus> on pcib8
Mar  6 03:54:36 FBSDG5L kernel: gem0: <Apple Shasta GMAC Ethernet> mem =
0xfa200000-0xfa3fffff at device 15.0 on pci8
Mar  6 03:54:36 FBSDG5L kernel: gem0: invalid MAC address
Mar  6 03:54:36 FBSDG5L kernel: device_attach: gem0 attach returned 6
Mar  6 03:54:36 FBSDG5L kernel: pcib9: <OFW PCI-PCI bridge> at device =
8.0 on pci1
Mar  6 03:54:36 FBSDG5L kernel: pci9: <OFW PCI bus> on pcib9
Mar  6 03:54:36 FBSDG5L kernel: macio0: <Shasta I/O Controller> mem =
0x80000000-0x8007ffff at device 7.0 on pci9
Mar  6 03:54:36 FBSDG5L kernel: macgpio0: <MacIO GPIO Controller> mem =
0x50-0x8a on macio0
Mar  6 03:54:36 FBSDG5L kernel: scc0: <Zilog Z8530 dual channel SCC> mem =
0x13000-0x13fff,0x8400-0x84ff,0x8500-0x85ff,0x8600-0x86ff,0x8700-0x87ff =
irq 23,17,18,24,19,20 on macio0
Mar  6 03:54:36 FBSDG5L kernel: uart0: <z8530, channel A> on scc0
Mar  6 03:54:36 FBSDG5L kernel: uart1: <z8530, channel B> on scc0
Mar  6 03:54:36 FBSDG5L kernel: iichb1: <Keywest I2C controller> mem =
0x18000-0x18fff irq 27 on macio0
Mar  6 03:54:36 FBSDG5L kernel: iicbus1: <OFW I2C bus> on iichb1
Mar  6 03:54:36 FBSDG5L kernel: onyx0: <Texas Instruments PCM3052 Audio =
Codec> at addr 0x8c on iicbus1
Mar  6 03:54:36 FBSDG5L kernel: iicbus1: <unknown card> at addr 0x24
Mar  6 03:54:36 FBSDG5L kernel: pcm0: <Apple I2S Audio Controller> mem =
0x10000-0x10fff,0x8000-0x80ff,0x8100-0x81ff irq 28,11,12,30,15,16 on =
macio0
Mar  6 03:54:36 FBSDG5L kernel: pci9: <network> at device 1.0 (no driver =
attached)
Mar  6 03:54:36 FBSDG5L kernel: ohci0: <NEC uPD 9210 USB controller> mem =
0x80082000-0x80082fff irq 70 at device 11.0 on pci9
Mar  6 03:54:36 FBSDG5L kernel: usbus0 on ohci0
Mar  6 03:54:36 FBSDG5L kernel: ohci1: <NEC uPD 9210 USB controller> mem =
0x80081000-0x80081fff irq 70 at device 11.1 on pci9
Mar  6 03:54:36 FBSDG5L kernel: usbus1 on ohci1
Mar  6 03:54:36 FBSDG5L kernel: ehci0: <NEC uPD 72010x USB 2.0 =
controller> mem 0x80080000-0x800800ff irq 70 at device 11.2 on pci9
Mar  6 03:54:36 FBSDG5L kernel: usbus2: EHCI version 1.0
Mar  6 03:54:36 FBSDG5L kernel: usbus2 on ehci0
Mar  6 03:54:36 FBSDG5L kernel: pcib10: <OFW PCI-PCI bridge> at device =
9.0 on pci1
Mar  6 03:54:36 FBSDG5L kernel: pci10: <OFW PCI bus> on pcib10
Mar  6 03:54:36 FBSDG5L kernel: atapci0: <ServerWorks K2 SATA150 =
controller> mem 0xfa402000-0xfa403fff irq 10 at device 12.0 on pci10
Mar  6 03:54:36 FBSDG5L kernel: pcib1: failed to reserve resource for =
pcib10
Mar  6 03:54:36 FBSDG5L kernel: atapci0: 0x10 bytes of rid 0x20 res 4 =
failed (0, 0xffffffffffffffff).
Mar  6 03:54:36 FBSDG5L kernel: ata2: <ATA channel> at channel 0 on =
atapci0
Mar  6 03:54:36 FBSDG5L kernel: ata3: <ATA channel> at channel 1 on =
atapci0
Mar  6 03:54:36 FBSDG5L kernel: ata4: <ATA channel> at channel 2 on =
atapci0
Mar  6 03:54:36 FBSDG5L kernel: ata5: <ATA channel> at channel 3 on =
atapci0
Mar  6 03:54:36 FBSDG5L kernel: ata0: <Shasta Kauai ATA Controller> mem =
0xfa404000-0xfa407fff irq 38,37 at device 13.0 on pci10
Mar  6 03:54:36 FBSDG5L kernel: fwohci0: <1394 Open Host Controller =
Interface> mem 0xfa400000-0xfa400fff irq 39 at device 14.0 on pci10
Mar  6 03:54:36 FBSDG5L kernel: fwohci0: OHCI version 1.0 (ROM=3D0)
Mar  6 03:54:36 FBSDG5L kernel: fwohci0: No. of Isochronous channels is =
8.
Mar  6 03:54:36 FBSDG5L kernel: fwohci0: EUI64 00:14:51:ff:fe:35:63:7c
Mar  6 03:54:36 FBSDG5L kernel: fwohci0: invalid speed 7 (fixed to 3).
Mar  6 03:54:36 FBSDG5L kernel: fwohci0: Phy 1394a available S800, 3 =
ports.
Mar  6 03:54:36 FBSDG5L kernel: fwohci0: Link S800, max_rec 4096 bytes.
Mar  6 03:54:36 FBSDG5L kernel: firewire0: <IEEE1394(FireWire) bus> on =
fwohci0
Mar  6 03:54:36 FBSDG5L kernel: fwe0: <Ethernet over FireWire> on =
firewire0
Mar  6 03:54:36 FBSDG5L kernel: if_fwe0: Fake Ethernet address: =
02:14:51:35:63:7c
Mar  6 03:54:36 FBSDG5L kernel: fwe0: Ethernet address: =
02:14:51:35:63:7c
Mar  6 03:54:36 FBSDG5L kernel: sbp0: <SBP-2/SCSI over FireWire> on =
firewire0
Mar  6 03:54:36 FBSDG5L kernel: fwohci0: Initiate bus reset
Mar  6 03:54:36 FBSDG5L kernel: fwohci0: fwohci_intr_core: BUS reset
Mar  6 03:54:36 FBSDG5L kernel: fwohci0: PhysicalUpperBound register is =
not implemented.  Physical memory access is limited to the first 4GB
Mar  6 03:54:36 FBSDG5L kernel: fwohci0: PhysicalUpperBound =3D =
0x00000000
Mar  6 03:54:36 FBSDG5L kernel: fwohci0: fwohci_intr_core: =
node_id=3D0x00000001, SelfID Count=3D1, CYCLEMASTER mode
Mar  6 03:54:36 FBSDG5L kernel: smu0: <Apple System Management Unit> on =
ofwbus0
Mar  6 03:54:36 FBSDG5L kernel: iichb2: <SMU I2C controller> on smu0
Mar  6 03:54:36 FBSDG5L kernel: iicbus2: <OFW I2C bus> on iichb2
Mar  6 03:54:36 FBSDG5L kernel: smusat0: <SMU Satellite Sensors> at addr =
0xb0 on iicbus2
Mar  6 03:54:36 FBSDG5L kernel: smusat1: <SMU Satellite Sensors> at addr =
0xb2 on iicbus2
Mar  6 03:54:36 FBSDG5L kernel: iicbus2: <unknown card> at addr 0xd4
Mar  6 03:54:36 FBSDG5L kernel: iichb3: <SMU I2C controller> on smu0
Mar  6 03:54:36 FBSDG5L kernel: iicbus3: <OFW I2C bus> on iichb3
Mar  6 03:54:36 FBSDG5L kernel: Timecounter "timebase" frequency =
33333333 Hz quality 0
Mar  6 03:54:36 FBSDG5L kernel: Event timer "decrementer" frequency =
33333333 Hz quality 1000
Mar  6 03:54:36 FBSDG5L kernel: Timecounters tick every 1.000 msec
Mar  6 03:54:36 FBSDG5L kernel: firewire0: 2 nodes, maxhop <=3D 1 cable =
IRM irm(1)  (me)=20
Mar  6 03:54:36 FBSDG5L kernel: firewire0: bus manager 1=20
Mar  6 03:54:36 FBSDG5L kernel: bge0: link state changed to UP
Mar  6 03:54:36 FBSDG5L kernel: usbus0: 12Mbps Full Speed USB v1.0
Mar  6 03:54:36 FBSDG5L kernel: usbus1: 12Mbps Full Speed USB v1.0
Mar  6 03:54:36 FBSDG5L kernel: max66900: 2 sensors detected.
Mar  6 03:54:36 FBSDG5L kernel: max66901: 2 sensors detected.
Mar  6 03:54:36 FBSDG5L kernel: ugen1.1: <NEC OHCI root HUB> at usbus1
Mar  6 03:54:36 FBSDG5L kernel: uhub0: <NEC OHCI root HUB, class 9/0, =
rev 1.00/1.00, addr 1> on usbus1
Mar  6 03:54:36 FBSDG5L kernel: ugen0.1: <NEC OHCI root HUB> at usbus0
Mar  6 03:54:36 FBSDG5L kernel: uhub1: <NEC OHCI root HUB, class 9/0, =
rev 1.00/1.00, addr 1> on usbus0
Mar  6 03:54:36 FBSDG5L kernel: usbus2: 480Mbps High Speed USB v2.0
Mar  6 03:54:36 FBSDG5L kernel: ugen2.1: <NEC EHCI root HUB> at usbus2
Mar  6 03:54:36 FBSDG5L kernel: uhub2: <NEC EHCI root HUB, class 9/0, =
rev 2.00/1.00, addr 1> on usbus2
Mar  6 03:54:36 FBSDG5L kernel: uhub0: 2 ports with 2 removable, self =
powered
Mar  6 03:54:36 FBSDG5L kernel: uhub1: 3 ports with 3 removable, self =
powered
Mar  6 03:54:36 FBSDG5L kernel: uhub2: 5 ports with 5 removable, self =
powered
Mar  6 03:54:36 FBSDG5L kernel: ada0 at ata2 bus 0 scbus0 target 0 lun 0
Mar  6 03:54:36 FBSDG5L kernel: ada0: <OWC Mercury Electra 3G SSD =
541ABBF0> ATA8-ACS SATA 2.x device
Mar  6 03:54:36 FBSDG5L kernel: ada0: Serial Number . . .
Mar  6 03:54:36 FBSDG5L kernel: ada0: 150.000MB/s transfers (SATA 1.x, =
UDMA5, PIO 512bytes)
Mar  6 03:54:36 FBSDG5L kernel: ada0: 457862MB (937703088 512 byte =
sectors)
Mar  6 03:54:36 FBSDG5L kernel: ada1 at ata3 bus 0 scbus1 target 0 lun 0
Mar  6 03:54:36 FBSDG5L kernel: ada1: <OWC Mercury Electra 3G SSD =
560ABBF0> ATA8-ACS SATA 2.x device
Mar  6 03:54:36 FBSDG5L kernel: ada1: Serial Number . . .
Mar  6 03:54:36 FBSDG5L kernel: ada1: 150.000MB/s transfers (SATA 1.x, =
UDMA5, PIO 512bytes)
Mar  6 03:54:36 FBSDG5L kernel: ada1: 114473MB (234441648 512 byte =
sectors)
Mar  6 03:54:36 FBSDG5L kernel: SMP: AP CPU #1 launched
Mar  6 03:54:36 FBSDG5L kernel: SMP: AP CPU #2 launched
Mar  6 03:54:36 FBSDG5L kernel: SMP: AP CPU #3 launched
Mar  6 03:54:36 FBSDG5L kernel: cd0 at ata0 bus 0 scbus4 target 0 lun 0
Mar  6 03:54:36 FBSDG5L kernel: cd0: <HL-DT-ST DVD-RW GWA-4165B C006> =
Removable CD-ROM SCSI device
Mar  6 03:54:36 FBSDG5L kernel: cd0: Serial Number . . .
Mar  6 03:54:36 FBSDG5L kernel: cd0: 66.700MB/s transfers (UDMA4, ATAPI =
12bytes, PIO 65534bytes)
Mar  6 03:54:36 FBSDG5L kernel: cd0: Attempt to query device size =
failed: NOT READY, Medium not present
Mar  6 03:54:36 FBSDG5L kernel: Trying to mount root from =
ufs:/dev/ufs/FBSDG5Lrootfs [rw,noatime]...
Mar  6 03:54:36 FBSDG5L kernel: (aprobe0:ata0:0:0:0): ATAPI_IDENTIFY. =
ACB: a1 00 00 00 00 40 00 00 00 00 00 00
Mar  6 03:54:36 FBSDG5L kernel: (aprobe0:ata0:0:0:0): CAM status: =
Command timeout
Mar  6 03:54:36 FBSDG5L kernel: (aprobe0:ata0:0:0:0): Retrying command
Mar  6 03:54:36 FBSDG5L kernel: bge0: link state changed to DOWN
Mar  6 03:54:36 FBSDG5L kernel: bge0: link state changed to UP
Mar  6 04:11:48 FBSDG5L ntpd[865]: ntpd 4.2.8p9-a (2): Starting
Mar  6 04:13:58 FBSDG5L ntpd[866]: leapsecond file =
('/var/db/ntpd.leap-seconds.list'): good hash signature
Mar  6 04:13:58 FBSDG5L ntpd[866]: leapsecond file =
('/var/db/ntpd.leap-seconds.list'): loaded, expire=3D2017-06-01T00:00:00Z =
last=3D2017-01-01T00:00:00Z ofs=3D37
Mar  6 04:22:34 FBSDG5L kernel: (aprobe0:ata0:0:0:0): INQUIRY. CDB: 12 =
00 00 00 24 00=20
Mar  6 04:22:34 FBSDG5L kernel: (aprobe0:ata0:0:0:0): CAM status: =
Command timeout
Mar  6 04:22:34 FBSDG5L kernel: (aprobe0:ata0:0:0:0): Retrying command
Mar  6 05:05:38 FBSDG5L kernel: (ada0:ata2:0:0:0): WRITE_DMA48. ACB: 35 =
00 a8 78 94 40 1d 00 00 00 08 00
Mar  6 05:05:38 FBSDG5L kernel: (ada0:ata2:0:0:0): CAM status: Command =
timeout
Mar  6 05:05:38 FBSDG5L kernel: (ada0:ata2:0:0:0): Retrying command
Mar  6 05:07:48 FBSDG5L kernel: (ada0:ata2:0:0:0): WRITE_DMA48. ACB: 35 =
00 58 78 94 40 1d 00 00 00 08 00
Mar  6 05:07:48 FBSDG5L kernel: (ada0:ata2:0:0:0): CAM status: Command =
timeout
Mar  6 05:07:48 FBSDG5L kernel: (ada0:ata2:0:0:0): Retrying command
Mar  6 05:44:25 FBSDG5L kernel: (aprobe0:ata0:0:0:0): INQUIRY. CDB: 12 =
00 00 00 24 00=20
Mar  6 05:44:25 FBSDG5L kernel: (aprobe0:ata0:0:0:0): CAM status: =
Command timeout
Mar  6 05:44:25 FBSDG5L kernel: (aprobe0:ata0:0:0:0): Retrying command
Mar  6 05:50:54 FBSDG5L kernel: (ada0:ata2:0:0:0): WRITE_DMA48. ACB: 35 =
00 30 82 94 40 1d 00 00 00 08 00
Mar  6 05:50:54 FBSDG5L kernel: (ada0:ata2:0:0:0): CAM status: Command =
timeout
Mar  6 05:50:54 FBSDG5L kernel: (ada0:ata2:0:0:0): Retrying command
Mar  6 06:10:16 FBSDG5L kernel: (aprobe0:ata0:0:0:0): INQUIRY. CDB: 12 =
00 00 00 24 00=20
Mar  6 06:10:16 FBSDG5L kernel: (aprobe0:ata0:0:0:0): CAM status: =
Command timeout
Mar  6 06:10:16 FBSDG5L kernel: (aprobe0:ata0:0:0:0): Retrying command
Mar  6 06:23:09 FBSDG5L kernel: (aprobe0:ata0:0:0:0): ATAPI_IDENTIFY. =
ACB: a1 00 00 00 00 40 00 00 00 00 00 00
Mar  6 06:23:09 FBSDG5L kernel: (aprobe0:ata0:0:0:0): CAM status: =
Command timeout
Mar  6 06:23:09 FBSDG5L kernel: (aprobe0:ata0:0:0:0): Retrying command
Mar  6 07:04:07 FBSDG5L kernel: (aprobe0:ata0:0:0:0): INQUIRY. CDB: 12 =
00 00 00 24 00=20
Mar  6 07:04:07 FBSDG5L kernel: (aprobe0:ata0:0:0:0): CAM status: =
Command timeout
Mar  6 07:04:07 FBSDG5L kernel: (aprobe0:ata0:0:0:0): Retrying command
Mar  6 07:34:16 FBSDG5L kernel: (aprobe0:ata0:0:0:0): INQUIRY. CDB: 12 =
00 00 00 24 00=20
Mar  6 07:34:16 FBSDG5L kernel: (aprobe0:ata0:0:0:0): CAM status: =
Command timeout
Mar  6 07:34:16 FBSDG5L kernel: (aprobe0:ata0:0:0:0): Retrying command
Mar  6 08:02:14 FBSDG5L kernel: (ada0:ata2:0:0:0): DSM TRIM. ACB: 06 01 =
00 00 00 40 00 00 00 00 01 00
Mar  6 08:02:14 FBSDG5L kernel: (ada0:ata2:0:0:0): CAM status: Command =
timeout
Mar  6 08:02:14 FBSDG5L kernel: (ada0:ata2:0:0:0): Retrying command
Mar  6 08:19:27 FBSDG5L kernel: (ada0:ata2:0:0:0): DSM TRIM. ACB: 06 01 =
00 00 00 40 00 00 00 00 01 00
Mar  6 08:19:27 FBSDG5L kernel: (ada0:ata2:0:0:0): CAM status: Command =
timeout
Mar  6 08:19:27 FBSDG5L kernel: (ada0:ata2:0:0:0): Retrying command
Mar  6 08:36:42 FBSDG5L kernel: (aprobe0:ata0:0:0:0): INQUIRY. CDB: 12 =
00 00 00 24 00=20
Mar  6 08:36:42 FBSDG5L kernel: (aprobe0:ata0:0:0:0): CAM status: =
Command timeout
Mar  6 08:36:42 FBSDG5L kernel: (aprobe0:ata0:0:0:0): Retrying command
Mar  6 09:00:21 FBSDG5L kernel: (aprobe0:ata0:0:0:0): ATAPI_IDENTIFY. =
ACB: a1 00 00 00 00 40 00 00 00 00 00 00
Mar  6 09:00:21 FBSDG5L kernel: (aprobe0:ata0:0:0:0): CAM status: =
Command timeout
Mar  6 09:00:21 FBSDG5L kernel: (aprobe0:ata0:0:0:0): Retrying command
Mar  6 09:45:37 FBSDG5L kernel: (aprobe0:ata0:0:0:0): INQUIRY. CDB: 12 =
00 00 00 24 00=20
Mar  6 09:45:37 FBSDG5L kernel: (aprobe0:ata0:0:0:0): CAM status: =
Command timeout
Mar  6 09:45:37 FBSDG5L kernel: (aprobe0:ata0:0:0:0): Retrying command
Mar  6 10:50:23 FBSDG5L kernel: (ada0:ata2:0:0:0): DSM TRIM. ACB: 06 01 =
00 00 00 40 00 00 00 00 01 00
Mar  6 10:50:23 FBSDG5L kernel: (ada0:ata2:0:0:0): CAM status: Command =
timeout
Mar  6 10:50:23 FBSDG5L kernel: (ada0:ata2:0:0:0): Retrying command
Mar  6 03:17:46 FBSDG5L kernel: (ada0:ata2:0:0:0): READ_DMA48. ACB: 25 =
00 40 71 54 40 14 00 00 00 40 00
Mar  6 03:17:46 FBSDG5L kernel: (ada0:ata2:0:0:0): CAM status: Command =
timeout
Mar  6 03:17:46 FBSDG5L kernel: (ada0:ata2:0:0:0): Retrying command
Mar  6 03:41:25 FBSDG5L kernel: (ada0:ata2:0:0:0): READ_DMA48. ACB: 25 =
00 c8 ef b0 40 25 00 00 00 08 00
Mar  6 03:41:25 FBSDG5L kernel: (ada0:ata2:0:0:0): CAM status: Command =
timeout
Mar  6 03:41:25 FBSDG5L kernel: (ada0:ata2:0:0:0): Retrying command
Mar  6 04:13:41 FBSDG5L kernel: (aprobe0:ata0:0:0:0): ATAPI_IDENTIFY. =
ACB: a1 00 00 00 00 40 00 00 00 00 00 00
Mar  6 04:13:41 FBSDG5L kernel: (aprobe0:ata0:0:0:0): CAM status: =
Command timeout
Mar  6 04:13:41 FBSDG5L kernel: (aprobe0:ata0:0:0:0): Retrying command
Mar  6 08:51:07 FBSDG5L kernel: (aprobe0:ata0:0:0:0): INQUIRY. CDB: 12 =
00 00 00 24 00=20
Mar  6 08:51:07 FBSDG5L kernel: (aprobe0:ata0:0:0:0): CAM status: =
Command timeout
Mar  6 08:51:07 FBSDG5L kernel: (aprobe0:ata0:0:0:0): Retrying command
Mar  6 10:29:59 FBSDG5L kernel: (ada0:ata2:0:0:0): DSM TRIM. ACB: 06 01 =
00 00 00 40 00 00 00 00 01 00
Mar  6 10:29:59 FBSDG5L kernel: (ada0:ata2:0:0:0): CAM status: Command =
timeout
Mar  6 10:29:59 FBSDG5L kernel: (ada0:ata2:0:0:0): Retrying command
Mar  6 11:47:27 FBSDG5L kernel: (ada0:ata2:0:0:0): DSM TRIM. ACB: 06 01 =
00 00 00 40 00 00 00 00 01 00
Mar  6 11:47:27 FBSDG5L kernel: (ada0:ata2:0:0:0): CAM status: Command =
timeout
Mar  6 11:47:27 FBSDG5L kernel: (ada0:ata2:0:0:0): Retrying command
Mar  6 13:19:52 FBSDG5L ntpd[866]: error resolving pool =
0.freebsd.pool.ntp.org: hostname nor servname provided, or not known (8)
Mar  6 13:22:02 FBSDG5L kernel: (ada0:ata2:0:0:0): READ_DMA48. ACB: 25 =
00 b8 bf 5e 40 1a 00 00 00 08 00
Mar  6 13:22:02 FBSDG5L kernel: (ada0:ata2:0:0:0): CAM status: Command =
timeout
Mar  6 13:22:02 FBSDG5L kernel: (ada0:ata2:0:0:0): Retrying command
Mar  6 13:58:33 FBSDG5L kernel: (aprobe0:ata0:0:0:0): ATAPI_IDENTIFY. =
ACB: a1 00 00 00 00 40 00 00 00 00 00 00
Mar  6 13:58:33 FBSDG5L kernel: (aprobe0:ata0:0:0:0): CAM status: =
Command timeout
Mar  6 13:58:33 FBSDG5L kernel: (aprobe0:ata0:0:0:0): Retrying command
Mar  6 18:25:00 FBSDG5L ntpd[866]: error resolving pool =
0.freebsd.pool.ntp.org: hostname nor servname provided, or not known (8)
Mar  7 00:21:41 FBSDG5L kernel: (aprobe0:ata0:0:0:0): ATAPI_IDENTIFY. =
ACB: a1 00 00 00 00 40 00 00 00 00 00 00
Mar  7 00:21:41 FBSDG5L kernel: (aprobe0:ata0:0:0:0): CAM status: =
Command timeout
Mar  7 00:21:41 FBSDG5L kernel: (aprobe0:ata0:0:0:0): Retrying command
Mar  7 01:32:36 FBSDG5L kernel: (aprobe0:ata0:0:0:0): ATAPI_IDENTIFY. =
ACB: a1 00 00 00 00 40 00 00 00 00 00 00
Mar  7 01:32:36 FBSDG5L kernel: (aprobe0:ata0:0:0:0): CAM status: =
Command timeout
Mar  7 01:32:36 FBSDG5L kernel: (aprobe0:ata0:0:0:0): Retrying command
Mar  7 02:11:18 FBSDG5L kernel: (aprobe0:ata0:0:0:0): ATAPI_IDENTIFY. =
ACB: a1 00 00 00 00 40 00 00 00 00 00 00
Mar  7 02:11:18 FBSDG5L kernel: (aprobe0:ata0:0:0:0): CAM status: =
Command timeout
Mar  7 02:11:18 FBSDG5L kernel: (aprobe0:ata0:0:0:0): Retrying command
Mar  7 02:15:36 FBSDG5L kernel: (ada0:ata2:0:0:0): READ_DMA48. ACB: 25 =
00 20 11 55 40 14 00 00 00 08 00
Mar  7 02:15:36 FBSDG5L kernel: (ada0:ata2:0:0:0): CAM status: Command =
timeout
Mar  7 02:15:36 FBSDG5L kernel: (ada0:ata2:0:0:0): Retrying command
Mar  7 03:29:14 FBSDG5L kernel: (ada0:ata2:0:0:0): DSM TRIM. ACB: 06 01 =
00 00 00 40 00 00 00 00 01 00
Mar  7 03:29:14 FBSDG5L kernel: (ada0:ata2:0:0:0): CAM status: Command =
timeout
Mar  7 03:29:14 FBSDG5L kernel: (ada0:ata2:0:0:0): Retrying command
Mar  7 03:33:32 FBSDG5L kernel: (ada0:ata2:0:0:0): SETFEATURES ENABLE =
RCACHE. ACB: ef aa 00 00 00 40 00 00 00 00 00 00
Mar  7 03:33:32 FBSDG5L kernel: (ada0:ata2:0:0:0): CAM status: Command =
timeout
Mar  7 03:33:32 FBSDG5L kernel: (ada0:ata2:0:0:0): Retrying command
Mar  7 03:48:35 FBSDG5L kernel: (aprobe0:ata0:0:0:0): INQUIRY. CDB: 12 =
00 00 00 60 00=20
Mar  7 03:48:35 FBSDG5L kernel: (aprobe0:ata0:0:0:0): CAM status: =
Command timeout
Mar  7 03:48:35 FBSDG5L kernel: (aprobe0:ata0:0:0:0): Retrying command
Mar  7 05:19:02 FBSDG5L kernel: (aprobe0:ata0:0:0:0): INQUIRY. CDB: 12 =
00 00 00 24 00=20
Mar  7 05:19:02 FBSDG5L kernel: (aprobe0:ata0:0:0:0): CAM status: =
Command timeout
Mar  7 05:19:02 FBSDG5L kernel: (aprobe0:ata0:0:0:0): Retrying command
Mar  7 05:55:36 FBSDG5L kernel: (ada0:ata2:0:0:0): DSM TRIM. ACB: 06 01 =
00 00 00 40 00 00 00 00 01 00
Mar  7 05:55:36 FBSDG5L kernel: (ada0:ata2:0:0:0): CAM status: Command =
timeout
Mar  7 05:55:36 FBSDG5L kernel: (ada0:ata2:0:0:0): Retrying command
Mar  7 07:56:31 FBSDG5L kernel: (aprobe0:ata0:0:0:0): INQUIRY. CDB: 12 =
00 00 00 24 00=20
Mar  7 07:56:31 FBSDG5L kernel: (aprobe0:ata0:0:0:0): CAM status: =
Command timeout
Mar  7 07:56:31 FBSDG5L kernel: (aprobe0:ata0:0:0:0): Retrying command
Mar  7 08:22:23 FBSDG5L kernel: (aprobe0:ata0:0:0:0): ATAPI_IDENTIFY. =
ACB: a1 00 00 00 00 40 00 00 00 00 00 00
Mar  7 08:22:23 FBSDG5L kernel: (aprobe0:ata0:0:0:0): CAM status: =
Command timeout
Mar  7 08:22:23 FBSDG5L kernel: (aprobe0:ata0:0:0:0): Retrying command
Mar  7 09:20:35 FBSDG5L kernel: (aprobe0:ata0:0:0:0): INQUIRY. CDB: 12 =
00 00 00 24 00=20
Mar  7 09:20:35 FBSDG5L kernel: (aprobe0:ata0:0:0:0): CAM status: =
Command timeout
Mar  7 09:20:35 FBSDG5L kernel: (aprobe0:ata0:0:0:0): Retrying command
Mar  7 09:27:01 FBSDG5L kernel: (ada0:ata2:0:0:0): DSM TRIM. ACB: 06 01 =
00 00 00 40 00 00 00 00 01 00
Mar  7 09:27:01 FBSDG5L kernel: (ada0:ata2:0:0:0): CAM status: Command =
timeout
Mar  7 09:27:01 FBSDG5L kernel: (ada0:ata2:0:0:0): Retrying command
Mar  7 10:03:33 FBSDG5L kernel: (ada0:ata2:0:0:0): DSM TRIM. ACB: 06 01 =
00 00 00 40 00 00 00 00 01 00
Mar  7 10:03:33 FBSDG5L kernel: (ada0:ata2:0:0:0): CAM status: Command =
timeout
Mar  7 10:03:33 FBSDG5L kernel: (ada0:ata2:0:0:0): Retrying command
Mar  7 10:03:33 FBSDG5L kernel: (ada0:ata2:0:0:0): DSM TRIM. ACB: 06 01 =
00 00 00 40 00 00 00 00 01 00
Mar  7 10:03:33 FBSDG5L kernel: (ada0:ata2:0:0:0): CAM status: Command =
timeout
Mar  7 10:03:33 FBSDG5L kernel: (ada0:ata2:0:0:0): Retrying command
Mar  7 10:03:33 FBSDG5L kernel: (ada0:ata2:0:0:0): DSM TRIM. ACB: 06 01 =
00 00 00 40 00 00 00 00 01 00
Mar  7 10:03:33 FBSDG5L kernel: (ada0:ata2:0:0:0): CAM status: Command =
timeout
Mar  7 10:03:33 FBSDG5L kernel: (ada0:ata2:0:0:0): Retrying command
Mar  7 10:10:01 FBSDG5L kernel: (aprobe0:ata0:0:0:0): ATAPI_IDENTIFY. =
ACB: a1 00 00 00 00 40 00 00 00 00 00 00
Mar  7 10:10:01 FBSDG5L kernel: (aprobe0:ata0:0:0:0): CAM status: =
Command timeout
Mar  7 10:10:01 FBSDG5L kernel: (aprobe0:ata0:0:0:0): Retrying command
Mar  7 10:16:28 FBSDG5L kernel: (ada0:ata2:0:0:0): DSM TRIM. ACB: 06 01 =
00 00 00 40 00 00 00 00 01 00
Mar  7 10:16:28 FBSDG5L kernel: (ada0:ata2:0:0:0): CAM status: Command =
timeout
Mar  7 10:16:28 FBSDG5L kernel: (ada0:ata2:0:0:0): Retrying command
Mar  7 10:20:46 FBSDG5L kernel: (ada0:ata2:0:0:0): SETFEATURES ENABLE =
RCACHE. ACB: ef aa 00 00 00 40 00 00 00 00 00 00
Mar  7 10:20:46 FBSDG5L kernel: (ada0:ata2:0:0:0): CAM status: Command =
timeout
Mar  7 10:20:46 FBSDG5L kernel: (ada0:ata2:0:0:0): Retrying command
Mar  7 10:33:41 FBSDG5L kernel: (aprobe0:ata0:0:0:0): ATAPI_IDENTIFY. =
ACB: a1 00 00 00 00 40 00 00 00 00 00 00
Mar  7 10:33:41 FBSDG5L kernel: (aprobe0:ata0:0:0:0): CAM status: =
Command timeout
Mar  7 10:33:41 FBSDG5L kernel: (aprobe0:ata0:0:0:0): Retrying command


=3D=3D=3D
Mark Millard
markmi at dsl-only.net




Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?466C25ED-0A70-4988-9BB1-3B43BD031E5E>