On 12/18/2015 10:34 PM, Andy Shevchenko wrote:
On Sat, Dec 19, 2015 at 1:16 AM, Måns Rullgård <mans@xxxxxxxxx> wrote:
Julian Margetson <runaway@xxxxxxxx> writes:
On 12/18/2015 6:33 PM, Måns Rullgård wrote:
Julian Margetson <runaway@xxxxxxxx> writes:
On 12/18/2015 1:18 PM, Måns Rullgård wrote:
Julian Margetson <runaway@xxxxxxxx> writes:
On 12/18/2015 8:49 AM, Måns Rullgård wrote:
Andy Shevchenko <andriy.shevchenko@xxxxxxxxxxxxxxx> writes:
[ 5.206125] Unable to handle kernel paging request for data at
address 0x00000000
[ 5.228546] Faulting instruction address: 0xc043a2c8
[ 5.248577] Vector: 300 (Data Access) at [eddafae0]
[ 5.268658] pc: c043a2c8: sata_dwc_qc_issue+0xb8/0x204
Well, that's not good. Can you translate that address to a line of
code?
Besides that, can you enable DYNAMIC_DEBUG in the config and append
'dw_dmac_core.dyndbg dw_dmac.dyndbg' to the kernel cmdline?
Enabling debug messages in the sata_dwc driver might also be informative.
Changed the sata-dwc to a module .
[ 18.475140] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: dma_dwc_xfer_setup returns NULL
[ 18.535698] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: dma_dwc_xfer_setup returns NULL
That's strange. The only way that can happen is if
dmaengine_prep_slave_sg() return NULL, and that really shouldn't be
happening. Did you turn on debug messages in dw_dma? You can enable
some extra debug messages by adding "#define VERBOSE_DEBUG" at the top
of drivers/dma/dw/core.c
[ 17.526173] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: dma_dwc_xfer_setup returns NULL
[ 17.600124] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: dma_dwc_xfer_setup returns NULL
[ 17.662978] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: dma_dwc_xfer_setup returns NULL
Could you post the entire kernel log? There might be important
information before the errors start.
=~=~=~=~=~=~=~=~=~=~=~= PuTTY log 2015.12.18 15:01:48 =~=~=~=~=~=~=~=~=~=~=~=
[ 0.000000] Using Canyonlands machine description
[ 0.000000] Initializing cgroup subsys cpu
[ 0.000000] Linux version 4.4.0-rc5-Sam460ex (root@julian-VirtualBox) (gcc version 4.8.2 (Ubuntu 4.8.2-16ubuntu3) ) #8 PREEMPT Fri Dec 18 13:36:34 AST 2015
[ 0.000000] Zone ranges:
[ 0.000000] DMA [mem 0x0000000000000000-0x000000002fffffff]
[ 0.000000] Normal empty
[ 0.000000] HighMem [mem 0x0000000030000000-0x000000007fffffff]
[ 0.000000] Movable zone start for each node
[ 0.000000] Early memory node ranges
[ 0.000000] node 0: [mem 0x0000000000000000-0x000000007fffffff]
[ 0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x000000007fffffff]
[ 0.000000] MMU: Allocated 1088 bytes of context maps for 255 contexts
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 522752
[ 0.000000] Kernel command line: root=/dev/sda8 console=ttyS0,115200 console=tty0 dw_dmac_core.dyndbg dw_dmac.dyndbg
I would suggest to use console=tty1 instead of console=tty0.
[...]
[ 13.643415] systemd[1]: Mounted Configuration File System.
[ 17.526173] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: dma_dwc_xfer_setup returns NULL
[ 17.600124] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: dma_dwc_xfer_setup returns NULL
[ 17.662978] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: dma_dwc_xfer_setup returns NULL
This log is weird. The sata_dwc_probe() function prints several things
(one using dev_notice()), for instance this:
/* Read the ID and Version Registers */
idr = in_le32(&hsdev->sata_dwc_regs->idr);
versionr = in_le32(&hsdev->sata_dwc_regs->versionr);
dev_notice(&ofdev->dev, "id %d, controller version %c.%c%c\n",
idr, ver[0], ver[1], ver[2]);
The dw_dma_probe() function also prints a line:
dev_info(chip->dev, "DesignWare DMA Controller, %d channels\n",
pdata->nr_channels);
These messages are nowhere to be seen in your log, nor are numerous
others that really must appear before before sata_dwc_qc_prep_by_tag()
can be called.
It would be better to add 'ignore_loglevel' to the cmdline as well.
I'd like to note that the driver works on my Sigma Designs based system
using a different DMA controller, so it's not completely broken. The
DMA driver could still be faulty, but that still doesn't explain the
missing kernel messages.
--
Måns Rullgård
--
To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
the body of a message to majordomo@xxxxxxxxxxxxxxx
More majordomo info at http://vger.kernel.org/majordomo-info.html
Please read the FAQ at http://www.tux.org/lkml/
=~=~=~=~=~=~=~=~=~=~=~= PuTTY log 2015.12.19 07:30:22 =~=~=~=~=~=~=~=~=~=~=~=
U-Boot 2015.a (May 16 2015 - 14:20:11)
CPU: AMCC PowerPC 460EX Rev. B at 1155 MHz (PLB=231 OPB=115 EBC=115)
No Security/Kasumi support
Bootstrap Option H - Boot ROM Location I2C (Addr 0x52)
Internal PCI arbiter enabled
32 kB I-Cache 32 kB D-Cache
Board: Sam460ex/cr, PCIe 4x + SATA-2
I2C: ready
DRAM: 2 GiB (ECC not enabled, 462 MHz, CL4)
PCI: Bus Dev VenId DevId Class Int
00 04 1095 3512 0104 00
00 06 126f 0501 0380 00
PCIE1: successfully set as root-complex
02 00 1002 683f 0300 ff
Net: ppc_4xx_eth0
FPGA: Revision 03 (2010-10-07)
SM502: found
PERMD2:not found
VGA: 1
VESA: OK
[ 0.000000] debug: ignoring loglevel setting.
[ 0.000000] Using Canyonlands machine description
[ 0.000000] Initializing cgroup subsys cpu
[ 0.000000] Linux version 4.4.0-rc5-Sam460ex (root@julian-VirtualBox) (gcc version 4.8.2 (Ubuntu 4.8.2-16ubuntu3) ) #9 PREEMPT Sat Dec 19 07:16:30 AST 2015
[ 0.000000] Found legacy serial port 0 for /plb/opb/serial@ef600300
[ 0.000000] mem=4ef600300, taddr=4ef600300, irq=0, clk=11059200, speed=0
[ 0.000000] Found legacy serial port 1 for /plb/opb/serial@ef600400
[ 0.000000] mem=4ef600400, taddr=4ef600400, irq=0, clk=11059200, speed=0
[ 0.000000] Top of RAM: 0x80000000, Total RAM: 0x80000000
[ 0.000000] Memory hole size: 0MB
[ 0.000000] Zone ranges:
[ 0.000000] DMA [mem 0x0000000000000000-0x000000002fffffff]
[ 0.000000] Normal empty
[ 0.000000] HighMem [mem 0x0000000030000000-0x000000007fffffff]
[ 0.000000] Movable zone start for each node
[ 0.000000] Early memory node ranges
[ 0.000000] node 0: [mem 0x0000000000000000-0x000000007fffffff]
[ 0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x000000007fffffff]
[ 0.000000] On node 0 totalpages: 524288
[ 0.000000] free_area_init_node: node 0, pgdat c0a33dc8, node_mem_map eefed000
[ 0.000000] DMA zone: 1536 pages used for memmap
[ 0.000000] DMA zone: 0 pages reserved
[ 0.000000] DMA zone: 196608 pages, LIFO batch:31
[ 0.000000] HighMem zone: 327680 pages, LIFO batch:31
[ 0.000000] MMU: Allocated 1088 bytes of context maps for 255 contexts
[ 0.000000] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
[ 0.000000] pcpu-alloc: [0] 0
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 522752
[ 0.000000] Kernel command line: root=/dev/sda8 console=ttyS0,115200 console=tty1 ignore_loglevel dw_dmac_core.dyndbg dw_dmac.dyndbg
[ 0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes)
[ 0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[ 0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[ 0.000000] Sorting __ex_table...
[ 0.000000] Memory: 2068868K/2097152K available (6732K kernel code, 332K rwdata, 3232K rodata, 236K init, 368K bss, 28284K reserved, 0K cma-reserved, 1310720K highmem)
[ 0.000000] Kernel virtual memory layout:
[ 0.000000] * 0xfffcf000..0xfffff000 : fixmap
[ 0.000000] * 0xffc00000..0xffe00000 : highmem PTEs
[ 0.000000] * 0xffa00000..0xffc00000 : consistent mem
[ 0.000000] * 0xffa00000..0xffa00000 : early ioremap
[ 0.000000] * 0xf1000000..0xffa00000 : vmalloc & ioremap
[ 0.000000] SLUB: HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[ 0.000000] Preemptible hierarchical RCU implementation.
[ 0.000000] Build-time adjustment of leaf fanout to 32.
[ 0.000000] NR_IRQS:512 nr_irqs:512 16
[ 0.000000] UIC0 (32 IRQ sources) at DCR 0xc0
[ 0.000000] UIC1 (32 IRQ sources) at DCR 0xd0
[ 0.000000] UIC2 (32 IRQ sources) at DCR 0xe0
[ 0.000000] UIC3 (32 IRQ sources) at DCR 0xf0
[ 0.000000] time_init: decrementer frequency = 1155.000010 MHz
[ 0.000000] time_init: processor frequency = 1155.000010 MHz
[ 0.000013] clocksource: timebase: mask: 0xffffffffffffffff max_cycles: 0x10a60dda894, max_idle_ns: 440795207041 ns
[ 0.000024] clocksource: timebase mult[dda520] shift[24] registered
[ 0.000035] clockevent: decrementer mult[93d70a53] shift[31] cpu[0]
[ 0.000144] Console: colour dummy device 80x25
[ 0.000952] console [tty1] enabled
[ 0.000991] pid_max: default: 32768 minimum: 301
[ 0.001149] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.001190] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.005048] devtmpfs: initialized
[ 0.007832] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
[ 0.008272] xor: measuring software checksum speed
[ 0.018381] 8regs : 856.000 MB/sec
[ 0.028392] 8regs_prefetch: 784.000 MB/sec
[ 0.038423] 32regs : 1120.000 MB/sec
[ 0.048462] 32regs_prefetch: 996.000 MB/sec
[ 0.048481] xor: using function: 32regs (1120.000 MB/sec)
[ 0.048528] prandom: seed boundary self test passed
[ 0.050984] prandom: 100 self tests passed
[ 0.051601] NET: Registered protocol family 16
[ 0.054582] cpuidle: using governor ladder
[ 0.057616] cpuidle: using governor menu
[ 0.058050] 256k L2-cache enabled
[ 0.058168] PCIE0: Port disabled via device-tree
[ 0.058230] PCIE1: Checking link...
[ 0.058247] PCIE1: Device detected, waiting for link...
[ 0.058266] PCIE1: link is up !
[ 0.160449] PCI host bridge /plb/pciex@d20000000 (primary) ranges:
[ 0.160499] MEM 0x0000000e80000000..0x0000000effffffff -> 0x0000000080000000
[ 0.160535] MEM 0x0000000f00100000..0x0000000f001fffff -> 0x0000000000000000
[ 0.160566] IO 0x0000000f80010000..0x0000000f8001ffff -> 0x0000000000000000
[ 0.160605] 4xx PCI DMA offset set to 0x00000000
[ 0.160623] 4xx PCI DMA window base to 0x0000000000000000
[ 0.160642] DMA window size 0x0000000080000000
[ 0.160677] PCIE1: successfully set as root-complex
[ 0.160752] PCI host bridge /plb/pci@c0ec00000 (primary) ranges:
[ 0.160781] MEM 0x0000000d80000000..0x0000000dffffffff -> 0x0000000080000000
[ 0.160816] MEM 0x0000000c0ee00000..0x0000000c0eefffff -> 0x0000000000000000
[ 0.160848] IO 0x0000000c08000000..0x0000000c0800ffff -> 0x0000000000000000
[ 0.160877] 4xx PCI DMA offset set to 0x00000000
[ 0.160894] 4xx PCI DMA window base to 0x0000000000000000
[ 0.160913] DMA window size 0x0000000080000000
[ 0.161421] PCI: Probing PCI hardware
[ 0.161540] PCI host bridge to bus 0000:80
[ 0.161570] pci_bus 0000:80: root bus resource [io 0xfffe0000-0xfffeffff] (bus address [0x0000-0xffff])
[ 0.161608] pci_bus 0000:80: root bus resource [mem 0xe80000000-0xeffffffff] (bus address [0x80000000-0xffffffff])
[ 0.161645] pci_bus 0000:80: root bus resource [mem 0xf00100000-0xf001fffff] (bus address [0x00000000-0x000fffff])
[ 0.161683] pci_bus 0000:80: root bus resource [bus 80-ff]
[ 0.161710] pci_bus 0000:80: busn_res: [bus 80-ff] end is updated to ff
[ 0.161763] pci 0000:80:00.0: [aaa1:bed1] type 01 class 0x060400
[ 0.161817] pci 0000:80:00.0: reg 0x10: [mem 0x00000000-0x7fffffff pref]
[ 0.161863] PCI: Hiding 4xx host bridge resources 0000:80:00.0
[ 0.162177] pci 0000:81:00.0: [1002:683f] type 00 class 0x030000
[ 0.162250] pci 0000:81:00.0: reg 0x10: [mem 0xea0000000-0xeafffffff 64bit pref]
[ 0.162291] pci 0000:81:00.0: reg 0x18: [mem 0xeb0000000-0xeb003ffff 64bit]
[ 0.162322] pci 0000:81:00.0: reg 0x20: [io 0xfffe2000-0xfffe20ff]
[ 0.162359] pci 0000:81:00.0: reg 0x30: [mem 0xf00100000-0xf0011ffff pref]
[ 0.162437] pci 0000:81:00.0: supports D1 D2
[ 0.162459] pci 0000:81:00.0: PME# supported from D1 D2 D3hot
[ 0.162607] pci 0000:81:00.1: [1002:aab0] type 00 class 0x040300
[ 0.162671] pci 0000:81:00.1: reg 0x10: [mem 0xf00100000-0xf00103fff 64bit]
[ 0.162771] pci 0000:81:00.1: supports D1 D2
[ 0.162908] pci 0000:80:00.0: PCI bridge to [bus 81-bf]
[ 0.162941] pci 0000:80:00.0: bridge window [io 0xfffe2000-0xfffe2fff]
[ 0.162967] pci 0000:80:00.0: bridge window [mem 0xea0000000-0xeb00fffff]
[ 0.163086] pci_bus 0000:80: busn_res: [bus 80-ff] end is updated to bf
[ 0.163203] PCI host bridge to bus 0001:00
[ 0.163229] pci_bus 0001:00: root bus resource [io 0x0000-0xffff]
[ 0.163256] pci_bus 0001:00: root bus resource [mem 0xd80000000-0xdffffffff] (bus address [0x80000000-0xffffffff])
[ 0.163294] pci_bus 0001:00: root bus resource [mem 0xc0ee00000-0xc0eefffff] (bus address [0x00000000-0x000fffff])
[ 0.163329] pci_bus 0001:00: root bus resource [bus 00-ff]
[ 0.163353] pci_bus 0001:00: busn_res: [bus 00-ff] end is updated to ff
[ 0.163396] pci 0001:00:04.0: [1095:3512] type 00 class 0x010400
[ 0.163433] pci 0001:00:04.0: reg 0x10: [io 0x1000-0x1007]
[ 0.163458] pci 0001:00:04.0: reg 0x14: [io 0x1008-0x100b]
[ 0.163484] pci 0001:00:04.0: reg 0x18: [io 0x1010-0x1017]
[ 0.163509] pci 0001:00:04.0: reg 0x1c: [io 0x1018-0x101b]
[ 0.163535] pci 0001:00:04.0: reg 0x20: [io 0x1020-0x102f]
[ 0.163560] pci 0001:00:04.0: reg 0x24: [mem 0xd80000000-0xd800001ff]
[ 0.163588] pci 0001:00:04.0: reg 0x30: [mem 0xc0ee00000-0xc0ee7ffff pref]
[ 0.163631] pci 0001:00:04.0: supports D1 D2
[ 0.163763] pci 0001:00:06.0: [126f:0501] type 00 class 0x038000
[ 0.163808] pci 0001:00:06.0: reg 0x10: [mem 0xd84000000-0xd87ffffff]
[ 0.163834] pci 0001:00:06.0: reg 0x14: [mem 0xd88000000-0xd881fffff]
[ 0.163884] pci 0001:00:06.0: supports D1 D2
[ 0.164072] pci_bus 0001:00: busn_res: [bus 00-ff] end is updated to 00
[ 0.164183] pci 0000:80:00.0: BAR 9: assigned [mem 0xe80000000-0xe8fffffff 64bit pref]
[ 0.164218] pci 0000:80:00.0: BAR 8: assigned [mem 0xe90000000-0xe900fffff]
[ 0.164244] pci 0000:80:00.0: BAR 7: assigned [io 0xfffe1000-0xfffe1fff]
[ 0.164275] pci 0000:81:00.0: BAR 0: assigned [mem 0xe80000000-0xe8fffffff 64bit pref]
[ 0.164318] pci 0000:81:00.0: BAR 2: assigned [mem 0xe90000000-0xe9003ffff 64bit]
[ 0.164357] pci 0000:81:00.0: BAR 6: assigned [mem 0xe90040000-0xe9005ffff pref]
[ 0.164391] pci 0000:81:00.1: BAR 0: assigned [mem 0xe90060000-0xe90063fff 64bit]
[ 0.164430] pci 0000:81:00.0: BAR 4: assigned [io 0xfffe1000-0xfffe10ff]
[ 0.164458] pci 0000:80:00.0: PCI bridge to [bus 81-bf]
[ 0.164481] pci 0000:80:00.0: bridge window [io 0xfffe1000-0xfffe1fff]
[ 0.164507] pci 0000:80:00.0: bridge window [mem 0xe90000000-0xe900fffff]
[ 0.164534] pci 0000:80:00.0: bridge window [mem 0xe80000000-0xe8fffffff 64bit pref]
[ 0.164569] pci_bus 0000:80: resource 4 [io 0xfffe0000-0xfffeffff]
[ 0.164593] pci_bus 0000:80: resource 5 [mem 0xe80000000-0xeffffffff]
[ 0.164617] pci_bus 0000:80: resource 6 [mem 0xf00100000-0xf001fffff]
[ 0.164641] pci_bus 0000:81: resource 0 [io 0xfffe1000-0xfffe1fff]
[ 0.164665] pci_bus 0000:81: resource 1 [mem 0xe90000000-0xe900fffff]
[ 0.164689] pci_bus 0000:81: resource 2 [mem 0xe80000000-0xe8fffffff 64bit pref]
[ 0.164727] pci 0001:00:06.0: BAR 0: assigned [mem 0xd80000000-0xd83ffffff]
[ 0.164755] pci 0001:00:06.0: BAR 1: assigned [mem 0xd84000000-0xd841fffff]
[ 0.164783] pci 0001:00:04.0: BAR 6: assigned [mem 0xd84200000-0xd8427ffff pref]
[ 0.164816] pci 0001:00:04.0: BAR 5: assigned [mem 0xd84280000-0xd842801ff]
[ 0.164842] pci 0001:00:04.0: BAR 4: assigned [io 0x1000-0x100f]
[ 0.164868] pci 0001:00:04.0: BAR 0: assigned [io 0x1010-0x1017]
[ 0.164893] pci 0001:00:04.0: BAR 2: assigned [io 0x1018-0x101f]
[ 0.164919] pci 0001:00:04.0: BAR 1: assigned [io 0x1020-0x1023]
[ 0.164944] pci 0001:00:04.0: BAR 3: assigned [io 0x1024-0x1027]
[ 0.164971] pci_bus 0001:00: resource 4 [io 0x0000-0xffff]
[ 0.164995] pci_bus 0001:00: resource 5 [mem 0xd80000000-0xdffffffff]
[ 0.165019] pci_bus 0001:00: resource 6 [mem 0xc0ee00000-0xc0eefffff]
[ 0.192330] raid6: int32x1 gen() 300 MB/s
[ 0.209486] raid6: int32x1 xor() 173 MB/s
[ 0.226514] raid6: int32x2 gen() 433 MB/s
[ 0.243562] raid6: int32x2 xor() 240 MB/s
[ 0.260656] raid6: int32x4 gen() 476 MB/s
[ 0.277733] raid6: int32x4 xor() 267 MB/s
[ 0.294790] raid6: int32x8 gen() 234 MB/s
[ 0.311962] raid6: int32x8 xor() 218 MB/s
[ 0.311987] raid6: using algorithm int32x4 gen() 476 MB/s
[ 0.312006] raid6: .... xor() 267 MB/s, rmw enabled
[ 0.312025] raid6: using intx1 recovery algorithm
[ 0.312340] vgaarb: device added: PCI:0000:81:00.0,decodes=io+mem,owns=none,locks=none
[ 0.312383] vgaarb: loaded
[ 0.312398] vgaarb: bridge control possible 0000:81:00.0
[ 0.312677] SCSI subsystem initialized
[ 0.312871] libata version 3.00 loaded.
[ 0.313094] usbcore: registered new interface driver usbfs
[ 0.313160] usbcore: registered new interface driver hub
[ 0.313225] usbcore: registered new device driver usb
[ 0.313338] pps_core: LinuxPPS API ver. 1 registered
[ 0.313360] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@xxxxxxxx>
[ 0.313411] PTP clock support registered
[ 0.313569] EDAC MC: Ver: 3.0.0
[ 0.313968] Advanced Linux Sound Architecture Driver Initialized.
[ 0.333908] DMA-API: preallocated 65536 debug entries
[ 0.333950] DMA-API: debugging enabled by kernel config
[ 0.334008] clocksource: Switched to clocksource timebase
[ 0.340625] NET: Registered protocol family 2
[ 0.341237] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
[ 0.341358] TCP bind hash table entries: 8192 (order: 5, 163840 bytes)
[ 0.341682] TCP: Hash tables configured (established 8192 bind 8192)
[ 0.341815] UDP hash table entries: 512 (order: 2, 24576 bytes)
[ 0.341897] UDP-Lite hash table entries: 512 (order: 2, 24576 bytes)
[ 0.342260] NET: Registered protocol family 1
[ 0.342598] RPC: Registered named UNIX socket transport module.
[ 0.342629] RPC: Registered udp transport module.
[ 0.342647] RPC: Registered tcp transport module.
[ 0.342665] RPC: Registered tcp NFSv4.1 backchannel transport module.
[ 0.342749] PCI: CLS mismatch (32 != 4), using 32 bytes
[ 0.343462] Could not remap bcsr
[ 0.346666] genirq: Setting trigger mode 3 for irq 45 failed (uic_set_irq_type+0x0/0x160)
[ 0.349455] futex hash table entries: 256 (order: 0, 7168 bytes)
[ 0.359627] ntfs: driver 2.1.32 [Flags: R/W].
[ 0.360204] fuse init (API version 7.23)
[ 0.364400] async_tx: api initialized (async)
[ 0.364525] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251)
[ 0.364563] io scheduler noop registered
[ 0.364717] io scheduler cfq registered (default)
[ 0.366709] crc32: CRC_LE_BITS = 64, CRC_BE BITS = 64
[ 0.366738] crc32: self tests passed, processed 225944 bytes in 891727 nsec
[ 0.367772] crc32c: CRC_LE_BITS = 64
[ 0.367794] crc32c: self tests passed, processed 225944 bytes in 446743 nsec
[ 0.434226] crc32_combine: 8373 self tests passed
[ 0.500847] crc32c_combine: 8373 self tests passed
[ 0.500914] glob: 64 self-tests passed, 0 failed
[ 0.539171] Serial: 8250/16550 driver, 2 ports, IRQ sharing disabled
[ 0.539969] console [ttyS0] disabled
[ 0.560168] serial8250.0: ttyS0 at MMIO 0x4ef600300 (irq = 22, base_baud = 691200) is a U6_16550A
[ 1.846794] console [ttyS0] enabled
[ 1.870919] serial8250.0: ttyS1 at MMIO 0x4ef600400 (irq = 23, base_baud = 691200) is a U6_16550A
[ 1.880804] console [ttyS0] disabled
[ 0.000000] debug: ignoring loglevel setting.
[ 0.000000] Using Canyonlands machine description
[ 0.000000] Initializing cgroup subsys cpu
[ 0.000000] Linux version 4.4.0-rc5-Sam460ex (root@julian-VirtualBox) (gcc version 4.8.2 (Ubuntu 4.8.2-16ubuntu3) ) #9 PREEMPT Sat Dec 19 07:16:30 AST 2015
[ 0.000000] Found legacy serial port 0 for /plb/opb/serial@ef600300
[ 0.000000] mem=4ef600300, taddr=4ef600300, irq=0, clk=11059200, speed=0
[ 0.000000] Found legacy serial port 1 for /plb/opb/serial@ef600400
[ 0.000000] mem=4ef600400, taddr=4ef600400, irq=0, clk=11059200, speed=0
[ 0.000000] Top of RAM: 0x80000000, Total RAM: 0x80000000
[ 0.000000] Memory hole size: 0MB
[ 0.000000] Zone ranges:
[ 0.000000] DMA [mem 0x0000000000000000-0x000000002fffffff]
[ 0.000000] Normal empty
[ 0.000000] HighMem [mem 0x0000000030000000-0x000000007fffffff]
[ 0.000000] Movable zone start for each node
[ 0.000000] Early memory node ranges
[ 0.000000] node 0: [mem 0x0000000000000000-0x000000007fffffff]
[ 0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x000000007fffffff]
[ 0.000000] On node 0 totalpages: 524288
[ 0.000000] free_area_init_node: node 0, pgdat c0a33dc8, node_mem_map eefed000
[ 0.000000] DMA zone: 1536 pages used for memmap
[ 0.000000] DMA zone: 0 pages reserved
[ 0.000000] DMA zone: 196608 pages, LIFO batch:31
[ 0.000000] HighMem zone: 327680 pages, LIFO batch:31
[ 0.000000] MMU: Allocated 1088 bytes of context maps for 255 contexts
[ 0.000000] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
[ 0.000000] pcpu-alloc: [0] 0
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 522752
[ 0.000000] Kernel command line: root=/dev/sda8 console=ttyS0,115200 console=tty1 ignore_loglevel dw_dmac_core.dyndbg dw_dmac.dyndbg
[ 0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes)
[ 0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[ 0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[ 0.000000] Sorting __ex_table...
[ 0.000000] Memory: 2068868K/2097152K available (6732K kernel code, 332K rwdata, 3232K rodata, 236K init, 368K bss, 28284K reserved, 0K cma-reserved, 1310720K highmem)
[ 0.000000] Kernel virtual memory layout:
[ 0.000000] * 0xfffcf000..0xfffff000 : fixmap
[ 0.000000] * 0xffc00000..0xffe00000 : highmem PTEs
[ 0.000000] * 0xffa00000..0xffc00000 : consistent mem
[ 0.000000] * 0xffa00000..0xffa00000 : early ioremap
[ 0.000000] * 0xf1000000..0xffa00000 : vmalloc & ioremap
[ 0.000000] SLUB: HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[ 0.000000] Preemptible hierarchical RCU implementation.
[ 0.000000] Build-time adjustment of leaf fanout to 32.
[ 0.000000] NR_IRQS:512 nr_irqs:512 16
[ 0.000000] UIC0 (32 IRQ sources) at DCR 0xc0
[ 0.000000] UIC1 (32 IRQ sources) at DCR 0xd0
[ 0.000000] UIC2 (32 IRQ sources) at DCR 0xe0
[ 0.000000] UIC3 (32 IRQ sources) at DCR 0xf0
[ 0.000000] time_init: decrementer frequency = 1155.000010 MHz
[ 0.000000] time_init: processor frequency = 1155.000010 MHz
[ 0.000013] clocksource: timebase: mask: 0xffffffffffffffff max_cycles: 0x10a60dda894, max_idle_ns: 440795207041 ns
[ 0.000024] clocksource: timebase mult[dda520] shift[24] registered
[ 0.000035] clockevent: decrementer mult[93d70a53] shift[31] cpu[0]
[ 0.000144] Console: colour dummy device 80x25
[ 0.000952] console [tty1] enabled
[ 0.000991] pid_max: default: 32768 minimum: 301
[ 0.001149] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.001190] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.005048] devtmpfs: initialized
[ 0.007832] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
[ 0.008272] xor: measuring software checksum speed
[ 0.018381] 8regs : 856.000 MB/sec
[ 0.028392] 8regs_prefetch: 784.000 MB/sec
[ 0.038423] 32regs : 1120.000 MB/sec
[ 0.048462] 32regs_prefetch: 996.000 MB/sec
[ 0.048481] xor: using function: 32regs (1120.000 MB/sec)
[ 0.048528] prandom: seed boundary self test passed
[ 0.050984] prandom: 100 self tests passed
[ 0.051601] NET: Registered protocol family 16
[ 0.054582] cpuidle: using governor ladder
[ 0.057616] cpuidle: using governor menu
[ 0.058050] 256k L2-cache enabled
[ 0.058168] PCIE0: Port disabled via device-tree
[ 0.058230] PCIE1: Checking link...
[ 0.058247] PCIE1: Device detected, waiting for link...
[ 0.058266] PCIE1: link is up !
[ 0.160449] PCI host bridge /plb/pciex@d20000000 (primary) ranges:
[ 0.160499] MEM 0x0000000e80000000..0x0000000effffffff -> 0x0000000080000000
[ 0.160535] MEM 0x0000000f00100000..0x0000000f001fffff -> 0x0000000000000000
[ 0.160566] IO 0x0000000f80010000..0x0000000f8001ffff -> 0x0000000000000000
[ 0.160605] 4xx PCI DMA offset set to 0x00000000
[ 0.160623] 4xx PCI DMA window base to 0x0000000000000000
[ 0.160642] DMA window size 0x0000000080000000
[ 0.160677] PCIE1: successfully set as root-complex
[ 0.160752] PCI host bridge /plb/pci@c0ec00000 (primary) ranges:
[ 0.160781] MEM 0x0000000d80000000..0x0000000dffffffff -> 0x0000000080000000
[ 0.160816] MEM 0x0000000c0ee00000..0x0000000c0eefffff -> 0x0000000000000000
[ 0.160848] IO 0x0000000c08000000..0x0000000c0800ffff -> 0x0000000000000000
[ 0.160877] 4xx PCI DMA offset set to 0x00000000
[ 0.160894] 4xx PCI DMA window base to 0x0000000000000000
[ 0.160913] DMA window size 0x0000000080000000
[ 0.161421] PCI: Probing PCI hardware
[ 0.161540] PCI host bridge to bus 0000:80
[ 0.161570] pci_bus 0000:80: root bus resource [io 0xfffe0000-0xfffeffff] (bus address [0x0000-0xffff])
[ 0.161608] pci_bus 0000:80: root bus resource [mem 0xe80000000-0xeffffffff] (bus address [0x80000000-0xffffffff])
[ 0.161645] pci_bus 0000:80: root bus resource [mem 0xf00100000-0xf001fffff] (bus address [0x00000000-0x000fffff])
[ 0.161683] pci_bus 0000:80: root bus resource [bus 80-ff]
[ 0.161710] pci_bus 0000:80: busn_res: [bus 80-ff] end is updated to ff
[ 0.161763] pci 0000:80:00.0: [aaa1:bed1] type 01 class 0x060400
[ 0.161817] pci 0000:80:00.0: reg 0x10: [mem 0x00000000-0x7fffffff pref]
[ 0.161863] PCI: Hiding 4xx host bridge resources 0000:80:00.0
[ 0.162177] pci 0000:81:00.0: [1002:683f] type 00 class 0x030000
[ 0.162250] pci 0000:81:00.0: reg 0x10: [mem 0xea0000000-0xeafffffff 64bit pref]
[ 0.162291] pci 0000:81:00.0: reg 0x18: [mem 0xeb0000000-0xeb003ffff 64bit]
[ 0.162322] pci 0000:81:00.0: reg 0x20: [io 0xfffe2000-0xfffe20ff]
[ 0.162359] pci 0000:81:00.0: reg 0x30: [mem 0xf00100000-0xf0011ffff pref]
[ 0.162437] pci 0000:81:00.0: supports D1 D2
[ 0.162459] pci 0000:81:00.0: PME# supported from D1 D2 D3hot
[ 0.162607] pci 0000:81:00.1: [1002:aab0] type 00 class 0x040300
[ 0.162671] pci 0000:81:00.1: reg 0x10: [mem 0xf00100000-0xf00103fff 64bit]
[ 0.162771] pci 0000:81:00.1: supports D1 D2
[ 0.162908] pci 0000:80:00.0: PCI bridge to [bus 81-bf]
[ 0.162941] pci 0000:80:00.0: bridge window [io 0xfffe2000-0xfffe2fff]
[ 0.162967] pci 0000:80:00.0: bridge window [mem 0xea0000000-0xeb00fffff]
[ 0.163086] pci_bus 0000:80: busn_res: [bus 80-ff] end is updated to bf
[ 0.163203] PCI host bridge to bus 0001:00
[ 0.163229] pci_bus 0001:00: root bus resource [io 0x0000-0xffff]
[ 0.163256] pci_bus 0001:00: root bus resource [mem 0xd80000000-0xdffffffff] (bus address [0x80000000-0xffffffff])
[ 0.163294] pci_bus 0001:00: root bus resource [mem 0xc0ee00000-0xc0eefffff] (bus address [0x00000000-0x000fffff])
[ 0.163329] pci_bus 0001:00: root bus resource [bus 00-ff]
[ 0.163353] pci_bus 0001:00: busn_res: [bus 00-ff] end is updated to ff
[ 0.163396] pci 0001:00:04.0: [1095:3512] type 00 class 0x010400
[ 0.163433] pci 0001:00:04.0: reg 0x10: [io 0x1000-0x1007]
[ 0.163458] pci 0001:00:04.0: reg 0x14: [io 0x1008-0x100b]
[ 0.163484] pci 0001:00:04.0: reg 0x18: [io 0x1010-0x1017]
[ 0.163509] pci 0001:00:04.0: reg 0x1c: [io 0x1018-0x101b]
[ 0.163535] pci 0001:00:04.0: reg 0x20: [io 0x1020-0x102f]
[ 0.163560] pci 0001:00:04.0: reg 0x24: [mem 0xd80000000-0xd800001ff]
[ 0.163588] pci 0001:00:04.0: reg 0x30: [mem 0xc0ee00000-0xc0ee7ffff pref]
[ 0.163631] pci 0001:00:04.0: supports D1 D2
[ 0.163763] pci 0001:00:06.0: [126f:0501] type 00 class 0x038000
[ 0.163808] pci 0001:00:06.0: reg 0x10: [mem 0xd84000000-0xd87ffffff]
[ 0.163834] pci 0001:00:06.0: reg 0x14: [mem 0xd88000000-0xd881fffff]
[ 0.163884] pci 0001:00:06.0: supports D1 D2
[ 0.164072] pci_bus 0001:00: busn_res: [bus 00-ff] end is updated to 00
[ 0.164183] pci 0000:80:00.0: BAR 9: assigned [mem 0xe80000000-0xe8fffffff 64bit pref]
[ 0.164218] pci 0000:80:00.0: BAR 8: assigned [mem 0xe90000000-0xe900fffff]
[ 0.164244] pci 0000:80:00.0: BAR 7: assigned [io 0xfffe1000-0xfffe1fff]
[ 0.164275] pci 0000:81:00.0: BAR 0: assigned [mem 0xe80000000-0xe8fffffff 64bit pref]
[ 0.164318] pci 0000:81:00.0: BAR 2: assigned [mem 0xe90000000-0xe9003ffff 64bit]
[ 0.164357] pci 0000:81:00.0: BAR 6: assigned [mem 0xe90040000-0xe9005ffff pref]
[ 0.164391] pci 0000:81:00.1: BAR 0: assigned [mem 0xe90060000-0xe90063fff 64bit]
[ 0.164430] pci 0000:81:00.0: BAR 4: assigned [io 0xfffe1000-0xfffe10ff]
[ 0.164458] pci 0000:80:00.0: PCI bridge to [bus 81-bf]
[ 0.164481] pci 0000:80:00.0: bridge window [io 0xfffe1000-0xfffe1fff]
[ 0.164507] pci 0000:80:00.0: bridge window [mem 0xe90000000-0xe900fffff]
[ 0.164534] pci 0000:80:00.0: bridge window [mem 0xe80000000-0xe8fffffff 64bit pref]
[ 0.164569] pci_bus 0000:80: resource 4 [io 0xfffe0000-0xfffeffff]
[ 0.164593] pci_bus 0000:80: resource 5 [mem 0xe80000000-0xeffffffff]
[ 0.164617] pci_bus 0000:80: resource 6 [mem 0xf00100000-0xf001fffff]
[ 0.164641] pci_bus 0000:81: resource 0 [io 0xfffe1000-0xfffe1fff]
[ 0.164665] pci_bus 0000:81: resource 1 [mem 0xe90000000-0xe900fffff]
[ 0.164689] pci_bus 0000:81: resource 2 [mem 0xe80000000-0xe8fffffff 64bit pref]
[ 0.164727] pci 0001:00:06.0: BAR 0: assigned [mem 0xd80000000-0xd83ffffff]
[ 0.164755] pci 0001:00:06.0: BAR 1: assigned [mem 0xd84000000-0xd841fffff]
[ 0.164783] pci 0001:00:04.0: BAR 6: assigned [mem 0xd84200000-0xd8427ffff pref]
[ 0.164816] pci 0001:00:04.0: BAR 5: assigned [mem 0xd84280000-0xd842801ff]
[ 0.164842] pci 0001:00:04.0: BAR 4: assigned [io 0x1000-0x100f]
[ 0.164868] pci 0001:00:04.0: BAR 0: assigned [io 0x1010-0x1017]
[ 0.164893] pci 0001:00:04.0: BAR 2: assigned [io 0x1018-0x101f]
[ 0.164919] pci 0001:00:04.0: BAR 1: assigned [io 0x1020-0x1023]
[ 0.164944] pci 0001:00:04.0: BAR 3: assigned [io 0x1024-0x1027]
[ 0.164971] pci_bus 0001:00: resource 4 [io 0x0000-0xffff]
[ 0.164995] pci_bus 0001:00: resource 5 [mem 0xd80000000-0xdffffffff]
[ 0.165019] pci_bus 0001:00: resource 6 [mem 0xc0ee00000-0xc0eefffff]
[ 0.192330] raid6: int32x1 gen() 300 MB/s
[ 0.209486] raid6: int32x1 xor() 173 MB/s
[ 0.226514] raid6: int32x2 gen() 433 MB/s
[ 0.243562] raid6: int32x2 xor() 240 MB/s
[ 0.260656] raid6: int32x4 gen() 476 MB/s
[ 0.277733] raid6: int32x4 xor() 267 MB/s
[ 0.294790] raid6: int32x8 gen() 234 MB/s
[ 0.311962] raid6: int32x8 xor() 218 MB/s
[ 0.311987] raid6: using algorithm int32x4 gen() 476 MB/s
[ 0.312006] raid6: .... xor() 267 MB/s, rmw enabled
[ 0.312025] raid6: using intx1 recovery algorithm
[ 0.312340] vgaarb: device added: PCI:0000:81:00.0,decodes=io+mem,owns=none,locks=none
[ 0.312383] vgaarb: loaded
[ 0.312398] vgaarb: bridge control possible 0000:81:00.0
[ 0.312677] SCSI subsystem initialized
[ 0.312871] libata version 3.00 loaded.
[ 0.313094] usbcore: registered new interface driver usbfs
[ 0.313160] usbcore: registered new interface driver hub
[ 0.313225] usbcore: registered new device driver usb
[ 0.313338] pps_core: LinuxPPS API ver. 1 registered
[ 0.313360] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@xxxxxxxx>
[ 0.313411] PTP clock support registered
[ 0.313569] EDAC MC: Ver: 3.0.0
[ 0.313968] Advanced Linux Sound Architecture Driver Initialized.
[ 0.333908] DMA-API: preallocated 65536 debug entries
[ 0.333950] DMA-API: debugging enabled by kernel config
[ 0.334008] clocksource: Switched to clocksource timebase
[ 0.340625] NET: Registered protocol family 2
[ 0.341237] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
[ 0.341358] TCP bind hash table entries: 8192 (order: 5, 163840 bytes)
[ 0.341682] TCP: Hash tables configured (established 8192 bind 8192)
[ 0.341815] UDP hash table entries: 512 (order: 2, 24576 bytes)
[ 0.341897] UDP-Lite hash table entries: 512 (order: 2, 24576 bytes)
[ 0.342260] NET: Registered protocol family 1
[ 0.342598] RPC: Registered named UNIX socket transport module.
[ 0.342629] RPC: Registered udp transport module.
[ 0.342647] RPC: Registered tcp transport module.
[ 0.342665] RPC: Registered tcp NFSv4.1 backchannel transport module.
[ 0.342749] PCI: CLS mismatch (32 != 4), using 32 bytes
[ 0.343462] Could not remap bcsr
[ 0.346666] genirq: Setting trigger mode 3 for irq 45 failed (uic_set_irq_type+0x0/0x160)
[ 0.349455] futex hash table entries: 256 (order: 0, 7168 bytes)
[ 0.359627] ntfs: driver 2.1.32 [Flags: R/W].
[ 0.360204] fuse init (API version 7.23)
[ 0.364400] async_tx: api initialized (async)
[ 0.364525] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251)
[ 0.364563] io scheduler noop registered
[ 0.364717] io scheduler cfq registered (default)
[ 0.366709] crc32: CRC_LE_BITS = 64, CRC_BE BITS = 64
[ 0.366738] crc32: self tests passed, processed 225944 bytes in 891727 nsec
[ 0.367772] crc32c: CRC_LE_BITS = 64
[ 0.367794] crc32c: self tests passed, processed 225944 bytes in 446743 nsec
[ 0.434226] crc32_combine: 8373 self tests passed
[ 0.500847] crc32c_combine: 8373 self tests passed
[ 0.500914] glob: 64 self-tests passed, 0 failed
[ 0.539171] Serial: 8250/16550 driver, 2 ports, IRQ sharing disabled
[ 0.539969] console [ttyS0] disabled
[ 0.560168] serial8250.0: ttyS0 at MMIO 0x4ef600300 (irq = 22, base_baud = 691200) is a U6_16550A
[ 1.846794] console [ttyS0] enabled
[ 1.870919] serial8250.0: ttyS1 at MMIO 0x4ef600400 (irq = 23, base_baud = 691200) is a U6_16550A
[ 1.880804] console [ttyS0] disabled
[ 1.884490] 4ef600300.serial: ttyS0 at MMIO 0x4ef600300 (irq = 22, base_baud = 691200) is a 16550
[ 3.195928] console [ttyS0] enabled
[ 3.200119] 4ef600400.serial: ttyS1 at MMIO 0x4ef600400 (irq = 23, base_baud = 691200) is a 16550
[ 3.209491] Generic non-volatile memory driver v1.1
[ 3.214667] [drm] Initialized drm 1.1.0 20060810
[ 3.219396] [drm] radeon kernel modesetting enabled.
[ 3.225162] [drm] initializing kernel modesetting (VERDE 0x1002:0x683F 0x1545:0x7750).
[ 3.233176] [drm] register mmio base: 0xe90000000
[ 3.237925] [drm] register mmio size: 262144
[ 3.573996] ATOM BIOS: C44501
[ 3.577260] radeon 0000:81:00.0: VRAM: 1024M 0x0000000000000000 - 0x000000003FFFFFFF (1024M used)
[ 3.586182] radeon 0000:81:00.0: GTT: 2048M 0x0000000040000000 - 0x00000000BFFFFFFF
[ 3.593867] [drm] Detected VRAM RAM=1024M, BAR=256M
[ 3.598761] [drm] RAM width 128bits DDR
[ 3.602801] [TTM] Zone kernel: Available graphics memory: 379074 kiB
[ 3.609288] [TTM] Zone highmem: Available graphics memory: 1034434 kiB
[ 3.615838] [TTM] Initializing pool allocator
[ 3.620300] [drm] radeon: 1024M of VRAM memory ready
[ 3.625309] [drm] radeon: 2048M of GTT memory ready.
[ 3.630363] [drm] Loading verde Microcode
[ 3.634429] [drm] Internal thermal controller with fan control
[ 3.640508] [drm] probing gen 2 caps for device aaa1:bed1 = 18cc41/0
[ 3.694186] [drm] radeon: dpm initialized
[ 3.698438] radeon 0000:81:00.0: Direct firmware load for radeon/TAHITI_vce.bin failed with error -2
[ 3.707661] radeon 0000:81:00.0: radeon_vce: Can't load firmware "radeon/TAHITI_vce.bin"
[ 3.715837] [drm] GART: num cpu pages 524288, num gpu pages 524288
[ 3.732597] [drm] probing gen 2 caps for device aaa1:bed1 = 18cc41/0
[ 3.789439] [drm] PCIE GART of 2048M enabled (table at 0x0000000000277000).
[ 3.796787] radeon 0000:81:00.0: WB enabled
[ 3.801032] radeon 0000:81:00.0: fence driver on ring 0 use gpu addr 0x0000000040000c00 and cpu addr 0xedccec00
[ 3.811153] radeon 0000:81:00.0: fence driver on ring 1 use gpu addr 0x0000000040000c04 and cpu addr 0xedccec04
[ 3.821273] radeon 0000:81:00.0: fence driver on ring 2 use gpu addr 0x0000000040000c08 and cpu addr 0xedccec08
[ 3.831396] radeon 0000:81:00.0: fence driver on ring 3 use gpu addr 0x0000000040000c0c and cpu addr 0xedccec0c
[ 3.841516] radeon 0000:81:00.0: fence driver on ring 4 use gpu addr 0x0000000040000c10 and cpu addr 0xedccec10
[ 3.882058] radeon 0000:81:00.0: fence driver on ring 5 use gpu addr 0x0000000000075a18 and cpu addr 0xf5135a18
[ 3.892203] radeon 0000:81:00.0: VCE init error (-22).
[ 3.897373] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
[ 3.904018] [drm] Driver supports precise vblank timestamp query.
[ 3.910136] radeon 0000:81:00.0: radeon: MSI limited to 32-bit
[ 3.916068] genirq: Setting trigger mode 3 for irq 45 failed (uic_set_irq_type+0x0/0x160)
[ 3.924345] radeon 0000:81:00.0: radeon: using MSI.
[ 3.929305] [drm] radeon: irq initialized.
[ 4.687638] [drm:r600_ring_test] *ERROR* radeon: ring 0 test failed (scratch(0x850C)=0xCAFEDEAD)
[ 4.696493] radeon 0000:81:00.0: disabling GPU acceleration
[ 4.905058] [drm] Radeon Display Connectors
[ 4.909328] [drm] Connector 0:
[ 4.912432] [drm] HDMI-A-1
[ 4.915340] [drm] HPD4
[ 4.917895] [drm] DDC: 0x6570 0x6570 0x6574 0x6574 0x6578 0x6578 0x657c 0x657c
[ 4.925313] [drm] Encoders:
[ 4.928301] [drm] DFP1: INTERNAL_UNIPHY2
[ 4.932588] [drm] Connector 1:
[ 4.935660] [drm] DVI-I-1
[ 4.938474] [drm] HPD2
[ 4.941029] [drm] DDC: 0x6560 0x6560 0x6564 0x6564 0x6568 0x6568 0x656c 0x656c
[ 4.948447] [drm] Encoders:
[ 4.951433] [drm] DFP2: INTERNAL_UNIPHY
[ 4.955634] [drm] CRT1: INTERNAL_KLDSCP_DAC1
[ 5.072716] [drm] fb mappable at 0x80678000
[ 5.076938] [drm] vram apper at 0x80000000
[ 5.081052] [drm] size 8294400
[ 5.084124] [drm] fb depth is 24
[ 5.087371] [drm] pitch is 7680
[ 5.365235] Console: switching to colour frame buffer device 240x67
[ 5.443459] radeon 0000:81:00.0: fb0: radeondrmfb frame buffer device
[ 5.453074] [drm] Initialized radeon 2.43.0 20080528 for 0000:81:00.0 on minor 0
[ 5.470305] brd: module loaded
[ 5.478052] loop: module loaded
[ 5.481628] sata_sil 0001:00:04.0: version 2.4
[ 5.486452] sata_sil 0001:00:04.0: Applying R_ERR on DMA activate FIS errata fix
[ 5.494919] scsi host0: sata_sil
[ 5.498653] scsi host1: sata_sil
[ 5.502241] ata1: SATA max UDMA/100 mmio m512@0xd84280000 tf 0xd84280080 irq 21
[ 5.509991] ata2: SATA max UDMA/100 mmio m512@0xd84280000 tf 0xd842800c0 irq 21
[ 5.518372] PPC 4xx OCP EMAC driver, version 3.54
[ 5.523910] MAL v2 /plb/mcmal, 2 TX channels, 16 RX channels
[ 5.530126] ZMII /plb/opb/emac-zmii@ef600d00 initialized
[ 5.535861] RGMII /plb/opb/emac-rgmii@ef601500 initialized with MDIO support
[ 5.543433] TAH /plb/opb/emac-tah@ef601350 initialized
[ 5.548926] TAH /plb/opb/emac-tah@ef601450 initialized
[ 5.554639] /plb/opb/emac-rgmii@ef601500: input 0 in RGMII mode
[ 5.562145] eth0: EMAC-0 /plb/opb/ethernet@ef600e00, MAC 00:50:c2:80:d5:c5
[ 5.569434] eth0: found Generic MII PHY (0x00)
[ 5.574321] /plb/opb/emac-rgmii@ef601500: input 1 in RGMII mode
[ 5.581758] eth1: EMAC-1 /plb/opb/ethernet@ef600f00, MAC 00:00:00:00:00:00
[ 5.589055] eth1: found Generic MII PHY (0x01)
[ 5.593817] PPP generic driver version 2.4.2
[ 5.598517] PPP BSD Compression module registered
[ 5.603519] PPP Deflate Compression module registered
[ 5.608877] NET: Registered protocol family 24
[ 5.613783] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[ 5.620861] ppc-of-ehci 4bffd0400.ehci: OF EHCI
[ 5.625840] ppc-of-ehci 4bffd0400.ehci: new USB bus registered, assigned bus number 1
[ 5.634894] ppc-of-ehci 4bffd0400.ehci: irq 31, io mem 0x4bffd0400
[ 5.647026] ppc-of-ehci 4bffd0400.ehci: USB 2.0 started, EHCI 1.00
[ 5.653756] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
[ 5.660955] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 5.668594] usb usb1: Product: OF EHCI
[ 5.672571] usb usb1: Manufacturer: Linux 4.4.0-rc5-Sam460ex ehci_hcd
[ 5.679383] usb usb1: SerialNumber: PPC-OF USB
[ 5.684495] hub 1-0:1.0: USB hub found
[ 5.702491] hub 1-0:1.0: 1 port detected
[ 5.720561] ehci-pci: EHCI PCI platform driver
[ 5.738898] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[ 5.759100] ppc-of-ohci 4bffd0000.usb: OF OHCI
[ 5.777616] ppc-of-ohci 4bffd0000.usb: new USB bus registered, assigned bus number 2
[ 5.799630] ppc-of-ohci 4bffd0000.usb: irq 32, io mem 0x4bffd0000
[ 5.844036] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 5.896404] ata1.00: ATA-8: WDC WD5000AAKS-00V1A0, 05.01D05, max UDMA/133
[ 5.936012] ata1.00: 976773168 sectors, multi 0: LBA48 NCQ (depth 0/32)
[ 5.986286] ata1.00: configured for UDMA/100
[ 6.022023] usb 1-1: new high-speed USB device number 2 using ppc-of-ehci
[ 6.046282] scsi 0:0:0:0: Direct-Access ATA WDC WD5000AAKS-0 1D05 PQ: 0 ANSI: 5
[ 6.093756] sd 0:0:0:0: Attached scsi generic sg0 type 0
[ 6.114436] sd 0:0:0:0: [sda] 976773168 512-byte logical blocks: (500 GB/465 GiB)
[ 6.156271] sd 0:0:0:0: [sda] Write Protect is off
[ 6.196021] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
[ 6.216599] usb 1-1: New USB device found, idVendor=0424, idProduct=2517
[ 6.258017] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[ 6.283125] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 6.331112] hub 1-1:1.0: USB hub found
[ 6.361793] sda: RDSK (512) sda1 (DOS^G)(res 2 spb 1) sda2 (SFS^@)(res 2 spb 1) sda3 (SFS^@)(res 2 spb 1) sda4 (SFS^@)(res 2 spb 1) sda5 (SFS^@)(res 2 spb 1) sda6 (SFS^@)(res 2 spb 1) sda7 (NTFS)(res 2 spb 2) sda8 (EXT^C)(res 2 spb 1)
[ 6.409217] hub 1-1:1.0: 7 ports detected
[ 6.461702] sd 0:0:0:0: [sda] Attached SCSI disk
[ 6.501036] ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 6.565154] ata2.00: ATAPI: ASUS DRW-24B3ST i, 1.00, max UDMA/100
[ 6.617130] ata2.00: configured for UDMA/100
[ 6.670101] scsi 1:0:0:0: CD-ROM ASUS DRW-24B3ST i 1.00 PQ: 0 ANSI: 5
[ 6.747026] usb 1-1.1: new high-speed USB device number 3 using ppc-of-ehci
[ 6.771907] sr 1:0:0:0: [sr0] scsi3-mmc drive: 48x/48x writer dvd-ram cd/rw xa/form2 cdda tray
[ 6.823029] cdrom: Uniform CD-ROM driver Revision: 3.20
[ 6.870652] sr 1:0:0:0: Attached scsi CD-ROM sr0
[ 6.909687] usb 1-1.1: New USB device found, idVendor=1a40, idProduct=0101
[ 6.942250] sr 1:0:0:0: Attached scsi generic sg1 type 5
[ 6.974992] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001
[ 7.000436] usb 1-1.1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
[ 7.026583] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 7.052571] usb 1-1.1: Product: USB 2.0 Hub
[ 7.075377] usb usb2: Product: OF OHCI
[ 7.097886] usb usb2: Manufacturer: Linux 4.4.0-rc5-Sam460ex ohci_hcd
[ 7.123059] hub 1-1.1:1.0: USB hub found
[ 7.145651] usb usb2: SerialNumber: PPC-OF USB
[ 7.168929] hub 1-1.1:1.0: 4 ports detected
[ 7.191892] hub 2-0:1.0: USB hub found
[ 7.214110] hub 2-0:1.0: 1 port detected
[ 7.236758] ohci-pci: OHCI PCI platform driver
[ 7.259745] usbcore: registered new interface driver usblp
[ 7.283678] usbcore: registered new interface driver usb-storage
[ 7.307945] usbcore: registered new interface driver usbserial
[ 7.331720] usbcore: registered new interface driver usbserial_generic
[ 7.356069] usbserial: USB Serial support registered for generic
[ 7.379912] usb 1-1.2: new low-speed USB device number 4 using ppc-of-ehci
[ 7.404927] mousedev: PS/2 mouse device common for all mice
[ 7.428570] i2c /dev entries driver
[ 7.452495] rtc-m41t80 8-0068: rtc core: registered m41t80 as rtc0
[ 7.477700] ibm-iic 4ef600700.i2c: using standard (100 kHz) mode
[ 7.502081] ibm-iic 4ef600800.i2c: using standard (100 kHz) mode
[ 7.525938] md: linear personality registered for level -1
[ 7.549276] md: raid0 personality registered for level 0
[ 7.572442] md: raid1 personality registered for level 1
[ 7.595349] md: raid10 personality registered for level 10
[ 7.618605] md: raid6 personality registered for level 6
[ 7.641650] md: raid5 personality registered for level 5
[ 7.664544] md: raid4 personality registered for level 4
[ 7.687751] device-mapper: ioctl: 4.34.0-ioctl (2015-10-28) initialised: dm-devel@xxxxxxxxxx
[ 7.713983] EDAC PPC4xx MC: v1.0.0
[ 7.734972] EDAC PPC4xx MC: Reporting type: interrupt
[ 7.757576] usb 1-1.2: New USB device found, idVendor=04f2, idProduct=0116
[ 7.782194] usb 1-1.1.1: new full-speed USB device number 5 using ppc-of-ehci
[ 7.807330] hidraw: raw HID events driver (C) Jiri Kosina
[ 7.830421] usb 1-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[ 7.856237] usbcore: registered new interface driver usbhid
[ 7.879712] usb 1-1.2: Product: USB Keyboard
[ 7.901729] usbhid: USB HID core driver
[ 7.923228] usb 1-1.2: Manufacturer: CHICONY
[ 7.945102] usbcore: registered new interface driver snd-usb-audio
[ 7.969185] usbcore: registered new interface driver snd-ua101
[ 7.992668] usbcore: registered new interface driver snd-usb-usx2y
[ 8.016309] ipip: IPv4 over IPv4 tunneling driver
[ 8.039919] input: CHICONY USB Keyboard as /devices/platform/plb/4bffd0400.ehci/usb1/1-1/1-1.2/1-1.2:1.0/0003:04F2:0116.0001/input/input0
[ 8.070724] Initializing XFRM netlink socket
[ 8.093892] usb 1-1.1.1: New USB device found, idVendor=0d8c, idProduct=000c
[ 8.118740] NET: Registered protocol family 10
[ 8.140643] usb 1-1.1.1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
[ 8.165418] sit: IPv6 over IPv4 tunneling driver
[ 8.187198] NET: Registered protocol family 17
[ 8.208448] hid-generic 0003:04F2:0116.0001: input,hidraw0: USB HID v1.10 Keyboard [CHICONY USB Keyboard] on usb-PPC-OF USB-1.2/input0
[ 8.237748] usb 1-1.1.1: Product: C-Media USB Audio Device
[ 8.260676] NET: Registered protocol family 15
[ 8.283570] Running MSI bitmap self-tests ...
[ 8.307582] Key type encrypted registered
[ 8.329925] rtc-m41t80 8-0068: setting system clock to 2015-12-19 07:29:40 UTC (1450510180)
[ 8.355420] ALSA device list:
[ 8.375164] usb 1-1.6: new full-speed USB device number 6 using ppc-of-ehci
[ 8.399022] No soundcards found.
[ 8.435074] input: C-Media USB Audio Device as /devices/platform/plb/4bffd0400.ehci/usb1/1-1/1-1.1/1-1.1.1/1-1.1.1:1.3/0003:0D8C:000C.0002/input/input1
[ 8.517388] hid-generic 0003:0D8C:000C.0002: input,hidraw1: USB HID v1.00 Device [C-Media USB Audio Device ] on usb-PPC-OF USB-1.1.1/input3
[ 8.548185] md: Waiting for all devices to be available before autodetect
[ 8.572939] md: If you don't use raid, use raid=noautodetect
[ 8.597300] md: Autodetecting RAID arrays.
[ 8.619298] md: Scanned 0 and added 0 devices.
[ 8.641444] md: autorun ...
[ 8.661759] md: ... autorun DONE.
[ 8.683505] usb 1-1.6: New USB device found, idVendor=046d, idProduct=c52b
[ 8.708264] EXT4-fs (sda8): mounting ext3 file system using the ext4 subsystem
[ 8.733596] usb 1-1.6: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[ 8.759346] usb 1-1.6: Product: USB Receiver
[ 8.781959] usb 1-1.6: Manufacturer: Logitech
[ 8.808952] input: Logitech USB Receiver as /devices/platform/plb/4bffd0400.ehci/usb1/1-1/1-1.6/1-1.6:1.0/0003:046D:C52B.0003/input/input2
[ 8.850499] EXT4-fs (sda8): mounted filesystem with ordered data mode. Opts: (null)
[ 8.877588] VFS: Mounted root (ext3 filesystem) readonly on device 8:8.
[ 8.903971] hid-generic 0003:046D:C52B.0003: input,hidraw2: USB HID v1.11 Keyboard [Logitech USB Receiver] on usb-PPC-OF USB-1.6/input0
[ 8.942852] input: Logitech USB Receiver as /devices/platform/plb/4bffd0400.ehci/usb1/1-1/1-1.6/1-1.6:1.1/0003:046D:C52B.0004/input/input3
[ 8.982723] devtmpfs: mounted
[ 9.006561] Freeing unused kernel memory: 236K (c09be000 - c09f9000)
[ 9.033908] hid-generic 0003:046D:C52B.0004: input,hidraw3: USB HID v1.11 Mouse [Logitech USB Receiver] on usb-PPC-OF USB-1.6/input1
[ 9.073153] hid-generic 0003:046D:C52B.0005: hidraw4: USB HID v1.11 Device [Logitech USB Receiver] on usb-PPC-OF USB-1.6/input2
[ 9.179033] usb 1-1.7: new high-speed USB device number 7 using ppc-of-ehci
[ 9.301106] usb 1-1.7: New USB device found, idVendor=0424, idProduct=2240
[ 9.329948] usb 1-1.7: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[ 9.359054] usb 1-1.7: Product: Ultra Fast Media
[ 9.385502] usb 1-1.7: Manufacturer: Generic
[ 9.411517] usb 1-1.7: SerialNumber: 000000225001
[ 9.438648] usb-storage 1-1.7:1.0: USB Mass Storage device detected
[ 9.467371] scsi host2: usb-storage 1-1.7:1.0
[ 9.612318] random: nonblocking pool is initialized
[ 10.378304] systemd[1]: Failed to insert module 'kdbus': Function not implemented
[ 10.490351] systemd[1]: systemd 228 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ -LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN)
[ 10.532351] systemd[1]: Detected architecture ppc.
[ 10.561217] scsi 2:0:0:0: Direct-Access Generic Ultra HS-COMBO 1.98 PQ: 0 ANSI: 0
[ 10.593813] sd 2:0:0:0: Attached scsi generic sg2 type 0
[ 10.624201] sd 2:0:0:0: [sdb] Attached SCSI removable disk
[ 10.738888] systemd[1]: Set hostname to <Sam460ex>.
[ 11.013157] systemd-fstab-generator[118]: Mount point is not a valid path, ignoring.
[ 11.731680] systemd[112]: /lib/systemd/system-generators/systemd-fstab-generator terminated by signal ABRT.
[ 12.114434] systemd[1]: Listening on udev Kernel Socket.
[ 12.167872] systemd[1]: Created slice User and Session Slice.
[ 12.219976] systemd[1]: Reached target Encrypted Volumes.
[ 12.271988] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point.
[ 12.328330] systemd[1]: Listening on Syslog Socket.
[ 12.454329] systemd[1]: Created slice System Slice.
[ 12.505243] systemd[1]: Created slice system-getty.slice.
[ 12.556622] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[ 12.610451] systemd[1]: Listening on /dev/initctl Compatibility Named Pipe.
[ 12.663766] systemd[1]: Listening on fsck to fsckd communication Socket.
[ 12.715996] systemd[1]: Created slice system-serial\x2dgetty.slice.
[ 12.766688] systemd[1]: Reached target Swap.
[ 12.815423] systemd[1]: Listening on Journal Socket.
[ 12.867949] systemd[1]: Starting Create list of required static device nodes for the current kernel...
[ 12.960359] systemd[1]: Mounting Debug File System...
[ 13.021582] systemd[1]: Started Read required files in advance.
[ 13.091685] systemd[1]: Mounting POSIX Message Queue File System...
[ 13.153885] systemd[1]: Reached target User and Group Name Lookups.
[ 13.235485] systemd[1]: Starting Load Kernel Modules...
[ 13.291532] systemd[1]: Starting Uncomplicated firewall...
[ 13.345257] systemd[1]: Reached target Slices.
[ 13.393394] systemd[1]: Listening on Journal Socket (/dev/log).
[ 13.446868] systemd[1]: Starting Journal Service...
[ 13.499488] systemd[1]: Reached target Remote File Systems (Pre).
[ 13.551527] systemd[1]: Reached target Remote File Systems.
[ 13.601668] systemd[1]: Listening on udev Control Socket.
[ 13.677119] systemd[1]: Started Create list of required static device nodes for the current kernel.
[ 13.728651] systemd[1]: systemd-modules-load.service: Main process exited, code=exited, status=1/FAILURE
[ 13.759817] systemd[1]: Failed to start Load Kernel Modules.
[ 13.833762] systemd[1]: systemd-modules-load.service: Unit entered failed state.
[ 13.862567] systemd[1]: systemd-modules-load.service: Failed with result 'exit-code'.
[ 13.892677] systemd[1]: Started Uncomplicated firewall.
[ 13.958779] systemd[1]: Mounted Debug File System.
[ 14.008093] systemd[1]: Mounted POSIX Message Queue File System.
[ 14.135897] systemd[1]: Starting Apply Kernel Variables...
[ 14.192177] systemd[1]: Mounting FUSE Control File System...
[ 14.291816] systemd[1]: Mounting Configuration File System...
[ 14.436150] systemd[1]: Starting Create Static Device Nodes in /dev...
[ 14.550470] systemd[1]: Mounted FUSE Control File System.
[ 14.632354] systemd[1]: Mounted Configuration File System.
[ 14.694905] systemd[1]: Started Journal Service.
[ 16.665999] EXT4-fs (sda8): re-mounted. Opts: errors=remount-ro
[ 16.694612] systemd-remount[153]: unhandled signal 11 at 0000000c nip 1ff849a4 lr 1ff8471c code 30001
[ 17.035478] systemd-journald[133]: Received request to flush runtime journal from PID 1
[ 18.459275] sata-dwc 4bffd1000.sata: ioremap done for SATA register address
[ 18.756140] sata-dwc 4bffd1000.sata: id 0, controller version 1.82
[ 18.902080] sata-dwc 4bffd1000.sata: sata_dwc_enable_interrupts: INTMR = 0x0000000f, ERRMR = 0x0fff0f03
[ 19.029117] sata-dwc 4bffd1000.sata: DW_PARAMS: 0x10800804
[ 19.092107] sata-dwc 4bffd1000.sata: DWC_PARAMS[0]: 0x49230b1b
[ 19.163182] sata-dwc 4bffd1000.sata: DesignWare DMA Controller, 1 channels
[ 19.218044] sata-dwc 4bffd1000.sata: sata_dwc_port_start: port_no=0
[ 19.266038] dma dma0chan0: dwc_alloc_chan_resources
[ 19.316079] dma dma0chan0: moving desc ffa0c000 to freelist
[ 19.416053] dma dma0chan0: moving desc ffa0c060 to freelist
[ 19.468040] dma dma0chan0: moving desc ffa0c0c0 to freelist
[ 19.517055] dma dma0chan0: moving desc ffa0c120 to freelist
[ 19.583093] dma dma0chan0: moving desc ffa0c180 to freelist
[ 19.640058] dma dma0chan0: moving desc ffa0c1e0 to freelist
[ 19.686040] dma dma0chan0: moving desc ffa0c240 to freelist
[ 19.734041] dma dma0chan0: moving desc ffa0c2a0 to freelist
[ 19.780057] dma dma0chan0: moving desc ffa0c300 to freelist
[ 19.868081] dma dma0chan0: moving desc ffa0c360 to freelist
[ 19.971129] dma dma0chan0: moving desc ffa0c3c0 to freelist
[ 20.040190] dma dma0chan0: moving desc ffa0c420 to freelist
[ 20.099058] dma dma0chan0: moving desc ffa0c480 to freelist
[ 20.163051] dma dma0chan0: moving desc ffa0c4e0 to freelist
[ 20.226040] dma dma0chan0: moving desc ffa0c540 to freelist
[ 20.278575] dma dma0chan0: moving desc ffa0c5a0 to freelist
[ 20.544075] dma dma0chan0: moving desc ffa0c600 to freelist
[ 20.889108] dma dma0chan0: moving desc ffa0c660 to freelist
[ 21.342067] dma dma0chan0: moving desc ffa0c6c0 to freelist
[ 21.769148] dma dma0chan0: moving desc ffa0c720 to freelist
[ 22.239110] dma dma0chan0: moving desc ffa0c780 to freelist
[ 22.394895] dma dma0chan0: moving desc ffa0c7e0 to freelist
[ 22.677075] dma dma0chan0: moving desc ffa0c840 to freelist
[ 22.910882] dma dma0chan0: moving desc ffa0c8a0 to freelist
[ 23.098565] dma dma0chan0: moving desc ffa0c900 to freelist
[ 23.259305] dma dma0chan0: moving desc ffa0c960 to freelist
[ 23.381851] dma dma0chan0: moving desc ffa0c9c0 to freelist
[ 23.602287] dma dma0chan0: moving desc ffa0ca20 to freelist
[ 23.793080] dma dma0chan0: moving desc ffa0ca80 to freelist
[ 23.836677] eth0: link is up, 1000 FDX, pause enabled
[ 24.016333] dma dma0chan0: moving desc ffa0cae0 to freelist
[ 24.253258] dma dma0chan0: moving desc ffa0cb40 to freelist
[ 24.507605] dma dma0chan0: moving desc ffa0cba0 to freelist
[ 24.767302] dma dma0chan0: moving desc ffa0cc00 to freelist
[ 25.034931] dma dma0chan0: moving desc ffa0cc60 to freelist
[ 25.303172] dma dma0chan0: moving desc ffa0ccc0 to freelist
[ 25.577937] dma dma0chan0: moving desc ffa0cd20 to freelist
[ 25.798059] dma dma0chan0: moving desc ffa0cd80 to freelist
[ 25.997066] dma dma0chan0: moving desc ffa0cde0 to freelist
[ 26.144287] dma dma0chan0: moving desc ffa0ce40 to freelist
[ 26.162475] dma dma0chan0: moving desc ffa0cea0 to freelist
[ 26.184114] dma dma0chan0: moving desc ffa0cf00 to freelist
[ 26.205612] dma dma0chan0: moving desc ffa0cf60 to freelist
[ 26.224809] dma dma0chan0: moving desc ffa0d000 to freelist
[ 26.243487] dma dma0chan0: moving desc ffa0d060 to freelist
[ 26.264979] dma dma0chan0: moving desc ffa0d0c0 to freelist
[ 26.285699] dma dma0chan0: moving desc ffa0d120 to freelist
[ 26.306114] dma dma0chan0: moving desc ffa0d180 to freelist
[ 26.324913] dma dma0chan0: moving desc ffa0d1e0 to freelist
[ 26.342691] dma dma0chan0: moving desc ffa0d240 to freelist
[ 26.360248] dma dma0chan0: moving desc ffa0d2a0 to freelist
[ 26.378519] dma dma0chan0: moving desc ffa0d300 to freelist
[ 26.395843] dma dma0chan0: moving desc ffa0d360 to freelist
[ 26.417101] dma dma0chan0: moving desc ffa0d3c0 to freelist
[ 26.437374] dma dma0chan0: moving desc ffa0d420 to freelist
[ 26.454728] dma dma0chan0: moving desc ffa0d480 to freelist
[ 26.476097] dma dma0chan0: moving desc ffa0d4e0 to freelist
[ 26.494200] dma dma0chan0: moving desc ffa0d540 to freelist
[ 26.511617] dma dma0chan0: moving desc ffa0d5a0 to freelist
[ 26.528439] dma dma0chan0: moving desc ffa0d600 to freelist
[ 26.545577] dma dma0chan0: moving desc ffa0d660 to freelist
[ 26.562763] dma dma0chan0: moving desc ffa0d6c0 to freelist
[ 26.579306] dma dma0chan0: moving desc ffa0d720 to freelist
[ 26.595282] dma dma0chan0: moving desc ffa0d780 to freelist
[ 26.611132] dma dma0chan0: moving desc ffa0d7e0 to freelist
[ 26.627336] dma dma0chan0: dwc_alloc_chan_resources: allocated 64 descriptors
[ 26.648107] dmaengine: __dma_request_channel: success (dma0chan0)
[ 26.664477] sata-dwc 4bffd1000.sata: sata_dwc_port_start: clearing TXCHEN, RXCHEN in DMAC
[ 26.681633] sata-dwc 4bffd1000.sata: sata_dwc_port_start: setting burst size in DBTSR
[ 26.700399] sata-dwc 4bffd1000.sata: sata_dwc_port_start: done
[ 26.717407] scsi host3: sata-dwc
[ 26.730519] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000000
[ 26.747776] ata3: SATA max UDMA/133 irq 36
[ 26.762881] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000000
[ 26.783728] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000000
[ 26.800638] sata-dwc 4bffd1000.sata: sata_dwc_scr_write: id=3 reg=2 val=val=0x00000301
[ 26.820690] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000301
[ 26.839256] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000301
[ 26.857262] sata-dwc 4bffd1000.sata: sata_dwc_scr_write: id=3 reg=2 val=val=0x00000300
[ 27.079049] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000300
[ 27.101265] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 27.123035] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 27.146038] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 27.167117] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 27.190038] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 27.211039] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 27.226680] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=1 val=val=0x04050002
[ 27.244384] sata-dwc 4bffd1000.sata: sata_dwc_scr_write: id=3 reg=1 val=val=0x04050002
[ 27.260647] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 27.278815] sata-dwc 4bffd1000.sata: sata_dwc_enable_interrupts: INTMR = 0x0000000f, ERRMR = 0x0fff0f03
[ 27.298630] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 27.319121] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 27.337376] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 27.353723] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=1 val=val=0x00000000
[ 27.371590] sata-dwc 4bffd1000.sata: sata_dwc_scr_write: id=3 reg=1 val=val=0x00000000
[ 27.389398] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 27.405495] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000300
[ 27.423448] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 27.441133] ata3: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[ 27.455855] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 27.473654] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0xec)=IDENTIFY DEVICE qc tag=31 prot=ATA PIO ap active_tag=0x0000001f ap sactive=0x00000000
[ 27.497003] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=from device n_elem=1
[ 27.515116] dma dma0chan0: dwc_prep_slave_sg
[ 27.528735] dma dma0chan0: scanned 1 descriptors on freelist
[ 27.543962] sata-dwc 4bffd1000.sata: dma_dwc_xfer_setup sg: 0xed673c88, count: 1 addr: 0xfffffffff6a18400
[ 27.573150] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0x27)=READ NATIVE MAX ADDRESS EXT qc tag=31 prot=ATA no data ap active_tag=0x0000001f ap sactive=0x00000000
[ 27.599964] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=none n_elem=0
[ 27.619472] dma dma0chan0: dwc_prep_slave_sg
[ 27.635097] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: dma_dwc_xfer_setup returns NULL
[ 27.661574] sata-dwc 4bffd1000.sata: sata_dwc_isr intpr=0x80000080 active_tag=31
[ 27.681196] sata-dwc 4bffd1000.sata: sata_dwc_isr non-NCQ cmd interrupt, protocol: ATA no data
[ 27.702137] sata-dwc 4bffd1000.sata: sata_dwc_qc_complete checkstatus? 1
[ 27.721261] sata-dwc 4bffd1000.sata: QC complete cmd=0x27 status=0x00 ata3: protocol=1
[ 27.742694] ata3.00: ATA-8: WDC WD5000AAKS-00UU3A0, 01.03B01, max UDMA/133
[ 27.768517] ata3.00: 976773168 sectors, multi 0: LBA48 NCQ (depth 1/32)
[ 27.789390] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0xef)=SET FEATURES qc tag=31 prot=ATA no data ap active_tag=0x0000001f ap sactive=0x00000000
[ 27.817993] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=none n_elem=0
[ 27.840644] dma dma0chan0: dwc_prep_slave_sg
[ 27.859411] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: dma_dwc_xfer_setup returns NULL
[ 27.891131] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0xec)=IDENTIFY DEVICE qc tag=31 prot=ATA PIO ap active_tag=0x0000001f ap sactive=0x00000000
[ 27.921309] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=from device n_elem=1
[ 27.946217] dma dma0chan0: dwc_prep_slave_sg
[ 27.966634] dma dma0chan0: scanned 1 descriptors on freelist
[ 27.988649] sata-dwc 4bffd1000.sata: dma_dwc_xfer_setup sg: 0xed673bb8, count: 1 addr: 0xfffffffff6a18400
[ 28.020704] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0x27)=READ NATIVE MAX ADDRESS EXT qc tag=31 prot=ATA no data ap active_tag=0x0000001f ap sactive=0x00000000
[ 28.054322] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=none n_elem=0
[ 28.080635] dma dma0chan0: dwc_prep_slave_sg
[ 28.102865] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: dma_dwc_xfer_setup returns NULL
[ 28.129844] sata-dwc 4bffd1000.sata: sata_dwc_isr intpr=0x80000080 active_tag=31
[ 28.155368] sata-dwc 4bffd1000.sata: sata_dwc_isr non-NCQ cmd interrupt, protocol: ATA no data
[ 28.182198] sata-dwc 4bffd1000.sata: sata_dwc_qc_complete checkstatus? 1
[ 28.207085] sata-dwc 4bffd1000.sata: QC complete cmd=0x27 status=0x00 ata3: protocol=1
[ 28.244838] ata3.00: configured for UDMA/133
[ 28.279436] scsi 3:0:0:0: Direct-Access ATA WDC WD5000AAKS-0 3B01 PQ: 0 ANSI: 5
[ 28.308915] sd 3:0:0:0: [sdc] 976773168 512-byte logical blocks: (500 GB/465 GiB)
[ 28.337770] sd 3:0:0:0: Attached scsi generic sg3 type 0
[ 28.364583] sd 3:0:0:0: [sdc] Write Protect is off
[ 28.390294] sd 3:0:0:0: [sdc] Mode Sense: 00 3a 00 00
[ 28.415545] sd 3:0:0:0: [sdc] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 28.452506] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=from device n_elem=1
[ 28.480518] dma dma0chan0: dwc_prep_slave_sg
[ 28.503735] dma dma0chan0: scanned 1 descriptors on freelist
[ 28.528546] sata-dwc 4bffd1000.sata: dma_dwc_xfer_setup sg: 0xed55de00, count: 1 addr: 0xfffffffff6a18400
[ 28.557894] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue: tag=0 ap->link.sactive = 0x00000001 sactive=0x00000001
[ 28.588047] sata-dwc 4bffd1000.sata: sata_dwc_exec_command_by_tag cmd(0x60): READ FPDMA QUEUED tag=0
[ 28.617552] BUG: spinlock recursion on CPU#0, kworker/u2:1/85
[ 28.643875] lock: 0xed491110, .magic: dead4ead, .owner: kworker/u2:1/85, .owner_cpu: 0
[ 28.672927] CPU: 0 PID: 85 Comm: kworker/u2:1 Not tainted 4.4.0-rc5-Sam460ex #9
[ 28.701565] Workqueue: events_unbound async_run_entry_fn
[ 28.728261] Call Trace:
[ 28.751964] [ee3cf8f0] [c0049238] do_raw_spin_lock+0x4c/0x100 (unreliable)
[ 28.780427] [ee3cf910] [c068af98] _raw_spin_lock_irqsave+0x2c/0x38
[ 28.808148] [ee3cf920] [f6a0ec24] sata_dwc_exec_command_by_tag.constprop.8+0x80/0xb4 [sata_dwc_460ex]
[ 28.839409] [ee3cf950] [f6a0f340] sata_dwc_qc_issue+0x350/0x370 [sata_dwc_460ex]
[ 28.869038] [ee3cf9d0] [c043bdf8] ata_qc_issue+0x338/0x3a0
[ 28.896875] [ee3cfa00] [c0440c84] ata_scsi_translate+0xf4/0x150
[ 28.925159] [ee3cfa20] [c0444080] ata_scsi_queuecmd+0x1e8/0x238
[ 28.953413] [ee3cfa40] [c042511c] scsi_dispatch_cmd+0xd4/0x110
[ 28.981695] [ee3cfa50] [c0427a9c] scsi_request_fn+0x52c/0x55c
[ 29.009994] [ee3cfaa0] [c024cd34] __blk_run_queue+0x44/0x58
[ 29.037929] [ee3cfab0] [c0250780] blk_queue_bio+0x220/0x23c
[ 29.065653] [ee3cfae0] [c024ec5c] generic_make_request+0xb8/0x150
[ 29.093621] [ee3cfb10] [c024eda4] submit_bio+0xb0/0x138
[ 29.120372] [ee3cfb60] [c00edb78] submit_bh_wbc.isra.25+0x168/0x174
[ 29.147988] [ee3cfb80] [c00edf4c] block_read_full_page+0x2f4/0x30c
[ 29.175541] [ee3cfc00] [c0088f34] do_read_cache_page+0xac/0x198
[ 29.202595] [ee3cfc40] [c025fc38] read_dev_sector+0x3c/0x80
[ 29.228829] [ee3cfc50] [c0261440] msdos_partition+0x78/0x54c
[ 29.254739] [ee3cfcd0] [c0260bd0] check_partition+0x13c/0x1f0
[ 29.280477] [ee3cfcf0] [c0260250] rescan_partitions+0xa8/0x2d8
[ 29.306098] [ee3cfd40] [c00f15a8] __blkdev_get+0x150/0x33c
[ 29.331313] [ee3cfd80] [c00f1804] blkdev_get+0x70/0x2c8
[ 29.356209] [ee3cfdd0] [c025e03c] add_disk+0x2a8/0x3f0
[ 29.380947] [ee3cfe10] [c0432790] sd_probe_async+0xe4/0x170
[ 29.406059] [ee3cfe30] [c003b9e4] async_run_entry_fn+0x94/0x1a4
[ 29.431372] [ee3cfe60] [c0034dcc] process_one_work+0x1c4/0x2d8
[ 29.456510] [ee3cfe90] [c00351a4] worker_thread+0x288/0x3a8
[ 29.480892] [ee3cfed0] [c0039798] kthread+0xc8/0xcc
[ 29.504196] [ee3cff40] [c000b0d0] ret_from_kernel_thread+0x5c/0x64
[ 49.528714] BUG: spinlock lockup suspected on CPU#0, kworker/u2:1/85
[ 49.553298] lock: 0xed491110, .magic: dead4ead, .owner: kworker/u2:1/85, .owner_cpu: 0
[ 49.579477] CPU: 0 PID: 85 Comm: kworker/u2:1 Not tainted 4.4.0-rc5-Sam460ex #9
[ 49.604799] Workqueue: events_unbound async_run_entry_fn
[ 49.627972] Call Trace:
[ 49.648162] [ee3cf8f0] [c00492d0] do_raw_spin_lock+0xe4/0x100 (unreliable)
[ 49.672951] [ee3cf910] [c068af98] _raw_spin_lock_irqsave+0x2c/0x38
[ 49.696589] [ee3cf920] [f6a0ec24] sata_dwc_exec_command_by_tag.constprop.8+0x80/0xb4 [sata_dwc_460ex]
[ 49.723246] [ee3cf950] [f6a0f340] sata_dwc_qc_issue+0x350/0x370 [sata_dwc_460ex]
[ 49.747919] [ee3cf9d0] [c043bdf8] ata_qc_issue+0x338/0x3a0
[ 49.770468] [ee3cfa00] [c0440c84] ata_scsi_translate+0xf4/0x150
[ 49.793411] [ee3cfa20] [c0444080] ata_scsi_queuecmd+0x1e8/0x238
[ 49.816258] [ee3cfa40] [c042511c] scsi_dispatch_cmd+0xd4/0x110
[ 49.838968] [ee3cfa50] [c0427a9c] scsi_request_fn+0x52c/0x55c
[ 49.861485] [ee3cfaa0] [c024cd34] __blk_run_queue+0x44/0x58
[ 49.883647] [ee3cfab0] [c0250780] blk_queue_bio+0x220/0x23c
[ 49.905651] [ee3cfae0] [c024ec5c] generic_make_request+0xb8/0x150
[ 49.928081] [ee3cfb10] [c024eda4] submit_bio+0xb0/0x138
[ 49.949516] [ee3cfb60] [c00edb78] submit_bh_wbc.isra.25+0x168/0x174
[ 49.972050] [ee3cfb80] [c00edf4c] block_read_full_page+0x2f4/0x30c
[ 49.994557] [ee3cfc00] [c0088f34] do_read_cache_page+0xac/0x198
[ 50.016666] [ee3cfc40] [c025fc38] read_dev_sector+0x3c/0x80
[ 50.038203] [ee3cfc50] [c0261440] msdos_partition+0x78/0x54c
[ 50.059591] [ee3cfcd0] [c0260bd0] check_partition+0x13c/0x1f0
[ 50.080997] [ee3cfcf0] [c0260250] rescan_partitions+0xa8/0x2d8
[ 50.102233] [ee3cfd40] [c00f15a8] __blkdev_get+0x150/0x33c
[ 50.122962] [ee3cfd80] [c00f1804] blkdev_get+0x70/0x2c8
[ 50.143249] [ee3cfdd0] [c025e03c] add_disk+0x2a8/0x3f0
[ 50.163185] [ee3cfe10] [c0432790] sd_probe_async+0xe4/0x170
[ 50.183377] [ee3cfe30] [c003b9e4] async_run_entry_fn+0x94/0x1a4
[ 50.203749] [ee3cfe60] [c0034dcc] process_one_work+0x1c4/0x2d8
[ 50.223880] [ee3cfe90] [c00351a4] worker_thread+0x288/0x3a8
[ 50.243673] [ee3cfed0] [c0039798] kthread+0xc8/0xcc
[ 50.262587] [ee3cff40] [c000b0d0] ret_from_kernel_thread+0x5c/0x64
[ 50.282937] INFO: rcu_preempt self-detected stall on CPU
[ 50.302201] 0-...: (1 ticks this GP) idle=89b/140000000000002/0 softirq=13852/13852 fqs=0
[ 50.324674] (t=21830 jiffies g=6606 c=6605 q=17)
[ 50.343507] rcu_preempt kthread starved for 21830 jiffies! g6606 c6605 f0x0 s3 ->state=0x1
[ 50.366187] Task dump for CPU 0:
[ 50.383773] kworker/u2:1 R running 0 85 2 0x00000800
[ 50.404755] Workqueue: events_unbound async_run_entry_fn
[ 50.424718] Call Trace:
[ 50.441696] [effefd30] [c00543a0] rcu_dump_cpu_stacks+0x90/0xb4 (unreliable)
[ 50.463726] [effefd50] [c0057470] rcu_check_callbacks+0x240/0x6b8
[ 50.484719] [effefdb0] [c0059b94] update_process_times+0x30/0x60
[ 50.505593] [effefdc0] [c0067638] tick_sched_timer+0x54/0xa4
[ 50.526114] [effefdf0] [c005a60c] __hrtimer_run_queues.constprop.27+0xcc/0x170
[ 50.548343] [effefe30] [c005aaa4] hrtimer_interrupt+0xc0/0x230
[ 50.569164] [effefe80] [c0006d84] __timer_interrupt+0xcc/0x138
[ 50.589871] [effefea0] [c0006fc8] timer_interrupt+0x7c/0x9c
[ 50.610322] [effefec0] [c000b644] ret_from_except+0x0/0x18
[ 50.630729] --- interrupt: 901 at __do_softirq+0x9c/0x1f0
[ 50.630729] LR = __do_softirq+0x90/0x1f0
[ 50.670192] [effeff80] [c0023b8c] __do_softirq+0x48/0x1f0 (unreliable)
[ 50.691901] [effeffe0] [c0023f68] irq_exit+0x58/0xa0
[ 50.712003] [effefff0] [c000a0f4] call_do_irq+0x24/0x3c
[ 50.732353] [ee3cf920] [c0003528] do_IRQ+0x94/0xd4
[ 50.752197] [ee3cf950] [c000b644] ret_from_except+0x0/0x18
[ 50.772755] --- interrupt: 501 at _raw_spin_unlock_irqrestore+0x1c/0x5c
[ 50.772755] LR = _raw_spin_unlock_irqrestore+0x18/0x5c
[ 50.815340] [ee3cfa20] [c04440c4] ata_scsi_queuecmd+0x22c/0x238
[ 50.836641] [ee3cfa40] [c042511c] scsi_dispatch_cmd+0xd4/0x110
[ 50.857719] [ee3cfa50] [c0427a9c] scsi_request_fn+0x52c/0x55c
[ 50.878491] [ee3cfaa0] [c024cd34] __blk_run_queue+0x44/0x58
[ 50.898882] [ee3cfab0] [c0250780] blk_queue_bio+0x220/0x23c
[ 50.919099] [ee3cfae0] [c024ec5c] generic_make_request+0xb8/0x150
[ 50.939845] [ee3cfb10] [c024eda4] submit_bio+0xb0/0x138
[ 50.959561] [ee3cfb60] [c00edb78] submit_bh_wbc.isra.25+0x168/0x174
[ 50.980297] [ee3cfb80] [c00edf4c] block_read_full_page+0x2f4/0x30c
[ 51.000765] [ee3cfc00] [c0088f34] do_read_cache_page+0xac/0x198
[ 51.020850] [ee3cfc40] [c025fc38] read_dev_sector+0x3c/0x80
[ 51.040468] [ee3cfc50] [c0261440] msdos_partition+0x78/0x54c
[ 51.060164] [ee3cfcd0] [c0260bd0] check_partition+0x13c/0x1f0
[ 51.079930] [ee3cfcf0] [c0260250] rescan_partitions+0xa8/0x2d8
[ 51.099794] [ee3cfd40] [c00f15a8] __blkdev_get+0x150/0x33c
[ 51.119333] [ee3cfd80] [c00f1804] blkdev_get+0x70/0x2c8
[ 51.138580] [ee3cfdd0] [c025e03c] add_disk+0x2a8/0x3f0
[ 51.157736] [ee3cfe10] [c0432790] sd_probe_async+0xe4/0x170
[ 51.177310] [ee3cfe30] [c003b9e4] async_run_entry_fn+0x94/0x1a4
[ 51.197248] [ee3cfe60] [c0034dcc] process_one_work+0x1c4/0x2d8
[ 51.217091] [ee3cfe90] [c00351a4] worker_thread+0x288/0x3a8
[ 51.236637] [ee3cfed0] [c0039798] kthread+0xc8/0xcc
[ 51.255408] [ee3cff40] [c000b0d0] ret_from_kernel_thread+0x5c/0x64
[ 51.275664] sata-dwc 4bffd1000.sata: sata_dwc_isr intpr=0x00000082 active_tag=-84148995
[ 51.297963] sata-dwc 4bffd1000.sata: sata_dwc_isr: NEWFP tag=0
[ 51.318025] sata-dwc 4bffd1000.sata: sata_dwc_bmdma_start_by_tag qc=ed61c0b8 tag: 0 cmd: 0x60 dma_dir: from device start_dma? 1
[ 51.344246] sata-dwc 4bffd1000.sata: taskfile cmd: 0x60 protocol: ATA NCQ flags: 0x17 device: 40
[ 51.367841] sata-dwc 4bffd1000.sata: feature: 0x08 nsect: 0x0 lbal: 0x0 lbam: 0x0 lbah: 0x0
[ 51.391105] sata-dwc 4bffd1000.sata: hob_feature: 0x00 hob_nsect: 0x0 hob_lbal: 0x0 hob_lbam: 0x0 hob_lbah: 0x0
[ 51.416399] dma dma0chan0: dwc_tx_submit: queued 2
[ 51.436391] dma dma0chan0: dwc_dostart_first_queued: started 2
[ 58.733110] ata3: lost interrupt (Status 0x40)
[ 58.759105] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=1 val=val=0x00000000
[ 58.782909] ata3.00: exception Emask 0x0 SAct 0x1 SErr 0x0 action 0x6 frozen
[ 58.807125] ata3.00: failed command: READ FPDMA QUEUED
[ 58.828167] ata3.00: cmd 60/08:00:00:00:00/00:00:00:00:00/40 tag 0 ncq 4096 in
[ 58.828167] res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
[ 58.881038] ata3.00: status: { DRDY }
[ 58.881062] ata3: hard resetting link
[ 58.881078] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000300
[ 58.881086] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000300
[ 58.881093] sata-dwc 4bffd1000.sata: sata_dwc_scr_write: id=3 reg=2 val=val=0x00000301
[ 58.881100] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000301
[ 58.883021] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000301
[ 58.883029] sata-dwc 4bffd1000.sata: sata_dwc_scr_write: id=3 reg=2 val=val=0x00000300
[ 59.084086] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000300
[ 59.120405] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 59.149036] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 59.177033] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 59.205033] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 59.233033] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 59.255246] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=1 val=val=0x04050002
[ 59.278858] sata-dwc 4bffd1000.sata: sata_dwc_scr_write: id=3 reg=1 val=val=0x04050002
[ 59.300932] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 59.324557] sata-dwc 4bffd1000.sata: sata_dwc_enable_interrupts: INTMR = 0x0000000f, ERRMR = 0x0fff0f03
[ 59.348318] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 59.372062] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 59.394105] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 59.417416] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=1 val=val=0x00000000
[ 59.438972] sata-dwc 4bffd1000.sata: sata_dwc_scr_write: id=3 reg=1 val=val=0x00000000
[ 59.462112] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 59.483964] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000300
[ 59.507121] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 59.528445] ata3: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[ 59.549268] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 59.571002] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 59.594123] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0xec)=IDENTIFY DEVICE qc tag=31 prot=ATA PIO ap active_tag=0x0000001f ap sactive=0x00000000
[ 59.622443] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=from device n_elem=1
[ 59.645453] dma dma0chan0: dwc_prep_slave_sg
[ 59.663778] dma dma0chan0: scanned 1 descriptors on freelist
[ 59.683563] sata-dwc 4bffd1000.sata: dma_dwc_xfer_setup sg: 0xed673c48, count: 1 addr: 0xfffffffff6a18400
[ 59.711822] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0x27)=READ NATIVE MAX ADDRESS EXT qc tag=31 prot=ATA no data ap active_tag=0x0000001f ap sactive=0x00000000
[ 59.742992] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=none n_elem=0
[ 59.766745] dma dma0chan0: dwc_prep_slave_sg
[ 59.786458] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: dma_dwc_xfer_setup returns NULL
[ 59.811022] sata-dwc 4bffd1000.sata: sata_dwc_isr intpr=0x80000080 active_tag=31
[ 59.834353] sata-dwc 4bffd1000.sata: sata_dwc_isr non-NCQ cmd interrupt, protocol: ATA no data
[ 59.858995] sata-dwc 4bffd1000.sata: sata_dwc_qc_complete checkstatus? 1
[ 59.881659] sata-dwc 4bffd1000.sata: QC complete cmd=0x27 status=0x00 ata3: protocol=1
[ 59.911867] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0xef)=SET FEATURES qc tag=31 prot=ATA no data ap active_tag=0x0000001f ap sactive=0x00000000
[ 59.943063] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=none n_elem=0
[ 59.968170] dma dma0chan0: dwc_prep_slave_sg
[ 59.989210] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: dma_dwc_xfer_setup returns NULL
[ 60.018111] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0xec)=IDENTIFY DEVICE qc tag=31 prot=ATA PIO ap active_tag=0x0000001f ap sactive=0x00000000
[ 60.050068] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=from device n_elem=1
[ 60.076452] dma dma0chan0: dwc_prep_slave_sg
[ 60.097962] dma dma0chan0: scanned 1 descriptors on freelist
[ 60.120820] sata-dwc 4bffd1000.sata: dma_dwc_xfer_setup sg: 0xed673bb8, count: 1 addr: 0xfffffffff6a18400
[ 60.151986] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0x27)=READ NATIVE MAX ADDRESS EXT qc tag=31 prot=ATA no data ap active_tag=0x0000001f ap sactive=0x00000000
[ 60.185665] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=none n_elem=0
[ 60.211954] dma dma0chan0: dwc_prep_slave_sg
[ 60.234106] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: dma_dwc_xfer_setup returns NULL
[ 60.261006] sata-dwc 4bffd1000.sata: sata_dwc_isr intpr=0x80000080 active_tag=31
[ 60.286471] sata-dwc 4bffd1000.sata: sata_dwc_isr non-NCQ cmd interrupt, protocol: ATA no data
[ 60.313057] sata-dwc 4bffd1000.sata: sata_dwc_qc_complete checkstatus? 1
[ 60.337588] sata-dwc 4bffd1000.sata: QC complete cmd=0x27 status=0x00 ata3: protocol=1
[ 60.369787] ata3.00: configured for UDMA/133
[ 60.392151] ata3.00: device reported invalid CHS sector 0
[ 60.415867] ata3: EH complete
[ 60.436752] ------------[ cut here ]------------
[ 60.458925] WARNING: at drivers/ata/libata-core.c:5051
[ 60.481445] Modules linked in: input_leds led_class sata_dwc_460ex
[ 60.505436] CPU: 0 PID: 408 Comm: scsi_eh_3 Not tainted 4.4.0-rc5-Sam460ex #9
[ 60.530504] task: ed7fcb80 ti: ed672000 task.ti: ed672000
[ 60.553886] NIP: c043bb0c LR: c0440c84 CTR: c0442b00
[ 60.577029] REGS: ed673c70 TRAP: 0700 Not tainted (4.4.0-rc5-Sam460ex)
[ 60.602235] MSR: 00021000 <CE,ME> CR: 22000048 XER: 00000000
[ 60.626697]
GPR00: c0440c84 ed673d20 ed7fcb80 ed61c0b8 ed61da48 00000000 00000000 00000000
GPR08: 00000006 00000004 00000001 ed673d50 24000022 00000000 00000005 00002710
GPR16: c04263e0 c0944a03 c08fb4b8 c094492f c09020db ed4eb41c 0000001e 00000000
GPR24: ed4eace0 ed5e7e00 ede061a0 c0442b00 ed61c000 ed61d7c8 ed61c000 ed61c0b8
[ 60.753124] NIP [c043bb0c] ata_qc_issue+0x4c/0x3a0
[ 60.777804] LR [c0440c84] ata_scsi_translate+0xf4/0x150
[ 60.802965] Call Trace:
[ 60.825237] [ed673d20] [c0442c98] ata_scsi_rw_xlat+0x198/0x1e4 (unreliable)
[ 60.852378] [ed673d50] [c0440c84] ata_scsi_translate+0xf4/0x150
[ 60.878334] [ed673d70] [c0444080] ata_scsi_queuecmd+0x1e8/0x238
[ 60.904384] [ed673d90] [c042511c] scsi_dispatch_cmd+0xd4/0x110
[ 60.930480] [ed673da0] [c0427a9c] scsi_request_fn+0x52c/0x55c
[ 60.956591] [ed673df0] [c024cd34] __blk_run_queue+0x44/0x58
[ 60.982527] [ed673e00] [c024cf30] blk_run_queue+0x28/0x44
[ 61.008255] [ed673e10] [c0425c78] scsi_run_queue+0x240/0x268
[ 61.034402] [ed673e50] [c0427b04] scsi_run_host_queues+0x30/0x44
[ 61.060998] [ed673e60] [c0424d44] scsi_error_handler+0x3e0/0x44c
[ 61.087395] [ed673ed0] [c0039798] kthread+0xc8/0xcc
[ 61.112434] [ed673f40] [c000b0d0] ret_from_kernel_thread+0x5c/0x64
[ 61.139023] Instruction dump:
[ 61.161985] 815e0004 83a90000 89230014 814a0058 2f8a0000 419e0038 815d0120 2b8a001f
[ 61.190004] 419d002c 3d40c0a3 894a575b 694a0001 <0f0a0000> 2f8a0000 41be0014 3d40c0a3
[ 61.218114] ---[ end trace c4f4eb32724d9e3a ]---
[ 61.242736] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=from device n_elem=1
[ 61.271791] dma dma0chan0: dwc_prep_slave_sg
[ 61.295740] dma dma0chan0: scanned 1 descriptors on freelist
[ 61.320759] sata-dwc 4bffd1000.sata: dma_dwc_xfer_setup sg: 0xed55de00, count: 1 addr: 0xfffffffff6a18400
[ 61.349968] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue: tag=0 ap->link.sactive = 0x00000001 sactive=0x00000001
[ 61.379609] sata-dwc 4bffd1000.sata: sata_dwc_exec_command_by_tag cmd(0x60): READ FPDMA QUEUED tag=0
[ 81.408393] BUG: spinlock lockup suspected on CPU#0, scsi_eh_3/408
[ 81.434271] lock: 0xed491110, .magic: dead4ead, .owner: scsi_eh_3/408, .owner_cpu: 0
[ 81.462022] CPU: 0 PID: 408 Comm: scsi_eh_3 Tainted: G W 4.4.0-rc5-Sam460ex #9
[ 81.490464] Call Trace:
[ 81.512424] [ed673c40] [c00492d0] do_raw_spin_lock+0xe4/0x100 (unreliable)
[ 81.538899] [ed673c60] [c068af98] _raw_spin_lock_irqsave+0x2c/0x38
[ 81.564511] [ed673c70] [f6a0ec24] sata_dwc_exec_command_by_tag.constprop.8+0x80/0xb4 [sata_dwc_460ex]
[ 81.593306] [ed673ca0] [f6a0f340] sata_dwc_qc_issue+0x350/0x370 [sata_dwc_460ex]
[ 81.619967] [ed673d20] [c043bdf8] ata_qc_issue+0x338/0x3a0
[ 81.644409] [ed673d50] [c0440c84] ata_scsi_translate+0xf4/0x150
[ 81.669063] [ed673d70] [c0444080] ata_scsi_queuecmd+0x1e8/0x238
[ 81.693680] [ed673d90] [c042511c] scsi_dispatch_cmd+0xd4/0x110
[ 81.717926] [ed673da0] [c0427a9c] scsi_request_fn+0x52c/0x55c
[ 81.741598] [ed673df0] [c024cd34] __blk_run_queue+0x44/0x58
[ 81.764687] [ed673e00] [c024cf30] blk_run_queue+0x28/0x44
[ 81.787378] [ed673e10] [c0425c78] scsi_run_queue+0x240/0x268
[ 81.810139] [ed673e50] [c0427b04] scsi_run_host_queues+0x30/0x44
[ 81.833184] [ed673e60] [c0424d44] scsi_error_handler+0x3e0/0x44c
[ 81.856178] [ed673ed0] [c0039798] kthread+0xc8/0xcc
[ 81.877935] [ed673f40] [c000b0d0] ret_from_kernel_thread+0x5c/0x64
[ 81.901100] INFO: rcu_preempt self-detected stall on CPU
[ 81.923260] 0-...: (1 ticks this GP) idle=05d/140000000000002/0 softirq=17796/17796 fqs=0
[ 81.948771] (t=21465 jiffies g=9412 c=9411 q=3)
[ 81.970634] rcu_preempt kthread starved for 21465 jiffies! g9412 c9411 f0x0 s3 ->state=0x1
[ 81.996403] Task dump for CPU 0:
[ 82.016992] scsi_eh_3 R running 0 408 2 0x00000800
[ 82.040863] Call Trace:
[ 82.060440] [effefd30] [c00543a0] rcu_dump_cpu_stacks+0x90/0xb4 (unreliable)
[ 82.084897] [effefd50] [c0057470] rcu_check_callbacks+0x240/0x6b8
[ 82.108277] [effefdb0] [c0059b94] update_process_times+0x30/0x60
[ 82.131435] [effefdc0] [c0067638] tick_sched_timer+0x54/0xa4
[ 82.154109] [effefdf0] [c005a60c] __hrtimer_run_queues.constprop.27+0xcc/0x170
[ 82.178465] [effefe30] [c005aaa4] hrtimer_interrupt+0xc0/0x230
[ 82.201274] [effefe80] [c0006d84] __timer_interrupt+0xcc/0x138
[ 82.223968] [effefea0] [c0006fc8] timer_interrupt+0x7c/0x9c
[ 82.246320] [effefec0] [c000b644] ret_from_except+0x0/0x18
[ 82.268471] --- interrupt: 901 at __do_softirq+0x9c/0x1f0
[ 82.268471] LR = __do_softirq+0x90/0x1f0
[ 82.311051] [effeff80] [c0023b8c] __do_softirq+0x48/0x1f0 (unreliable)
[ 82.334254] [effeffe0] [c0023f68] irq_exit+0x58/0xa0
[ 82.355673] [effefff0] [c000a0f4] call_do_irq+0x24/0x3c
[ 82.377326] [ed673c70] [c0003528] do_IRQ+0x94/0xd4
[ 82.398559] [ed673ca0] [c000b644] ret_from_except+0x0/0x18
[ 82.420533] --- interrupt: 501 at _raw_spin_unlock_irqrestore+0x1c/0x5c
[ 82.420533] LR = _raw_spin_unlock_irqrestore+0x18/0x5c
[ 82.465982] [ed673d70] [c04440c4] ata_scsi_queuecmd+0x22c/0x238
[ 82.488767] [ed673d90] [c042511c] scsi_dispatch_cmd+0xd4/0x110
[ 82.511442] [ed673da0] [c0427a9c] scsi_request_fn+0x52c/0x55c
[ 82.534045] [ed673df0] [c024cd34] __blk_run_queue+0x44/0x58
[ 82.556467] [ed673e00] [c024cf30] blk_run_queue+0x28/0x44
[ 82.578663] [ed673e10] [c0425c78] scsi_run_queue+0x240/0x268
[ 82.601102] [ed673e50] [c0427b04] scsi_run_host_queues+0x30/0x44
[ 82.623766] [ed673e60] [c0424d44] scsi_error_handler+0x3e0/0x44c
[ 82.646264] [ed673ed0] [c0039798] kthread+0xc8/0xcc
[ 82.667474] [ed673f40] [c000b0d0] ret_from_kernel_thread+0x5c/0x64
[ 82.690018] sata-dwc 4bffd1000.sata: sata_dwc_isr intpr=0x00000082 active_tag=0
[ 82.713579] sata-dwc 4bffd1000.sata: sata_dwc_isr: NEWFP tag=0
[ 82.735334] sata-dwc 4bffd1000.sata: sata_dwc_bmdma_start_by_tag qc=ed61c0b8 tag: 0 cmd: 0x60 dma_dir: from device start_dma? 1
[ 82.763239] sata-dwc 4bffd1000.sata: taskfile cmd: 0x60 protocol: ATA NCQ flags: 0x17 device: 40
[ 82.788274] sata-dwc 4bffd1000.sata: feature: 0x08 nsect: 0x0 lbal: 0x0 lbam: 0x0 lbah: 0x0
[ 82.812806] sata-dwc 4bffd1000.sata: hob_feature: 0x00 hob_nsect: 0x0 hob_lbal: 0x0 hob_lbam: 0x0 hob_lbah: 0x0
[ 82.839202] dma dma0chan0: dwc_tx_submit: queued 3
[ 90.733042] ata3: lost interrupt (Status 0x40)
[ 90.754234] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=1 val=val=0x00000000
[ 90.778814] ata3.00: NCQ disabled due to excessive errors
[ 90.801931] ata3.00: exception Emask 0x0 SAct 0x1 SErr 0x0 action 0x6 frozen
[ 90.828229] ata3.00: failed command: READ FPDMA QUEUED
[ 90.850412] ata3.00: cmd 60/08:00:00:00:00/00:00:00:00:00/40 tag 0 ncq 4096 in
[ 90.850412] res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
[ 90.900282] ata3.00: status: { DRDY }
[ 90.921168] ata3: hard resetting link
[ 90.942370] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000300
[ 90.967745] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000300
[ 90.994655] sata-dwc 4bffd1000.sata: sata_dwc_scr_write: id=3 reg=2 val=val=0x00000301
[ 91.019989] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000301
[ 91.048048] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000301
[ 91.073115] sata-dwc 4bffd1000.sata: sata_dwc_scr_write: id=3 reg=2 val=val=0x00000300
[ 91.300031] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000300
[ 91.328265] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 91.360031] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 91.392032] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 91.424032] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 91.455032] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 91.480505] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=1 val=val=0x04050002
[ 91.507291] sata-dwc 4bffd1000.sata: sata_dwc_scr_write: id=3 reg=1 val=val=0x04050002
[ 91.532396] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 91.558759] sata-dwc 4bffd1000.sata: sata_dwc_enable_interrupts: INTMR = 0x0000000f, ERRMR = 0x0fff0f03
[ 91.585314] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 91.611764] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 91.636450] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 91.662496] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=1 val=val=0x00000000
[ 91.686880] sata-dwc 4bffd1000.sata: sata_dwc_scr_write: id=3 reg=1 val=val=0x00000000
[ 91.712845] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 91.737111] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000300
[ 91.762711] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 91.786735] ata3: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[ 91.812318] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 91.837129] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 91.864017] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0xec)=IDENTIFY DEVICE qc tag=31 prot=ATA PIO ap active_tag=0x0000001f ap sactive=0x00000000
[ 91.896291] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=from device n_elem=1
[ 91.923074] dma dma0chan0: dwc_prep_slave_sg
[ 91.945192] dma dma0chan0: scanned 1 descriptors on freelist
[ 91.968806] sata-dwc 4bffd1000.sata: dma_dwc_xfer_setup sg: 0xed673c48, count: 1 addr: 0xfffffffff6a18400
[ 92.035153] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0x27)=READ NATIVE MAX ADDRESS EXT qc tag=31 prot=ATA no data ap active_tag=0x0000001f ap sactive=0x00000000
[ 92.070084] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=none n_elem=0
[ 92.097475] dma dma0chan0: dwc_prep_slave_sg
[ 92.120738] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: dma_dwc_xfer_setup returns NULL
[ 92.148759] sata-dwc 4bffd1000.sata: sata_dwc_isr intpr=0x80000080 active_tag=31
[ 92.175541] sata-dwc 4bffd1000.sata: sata_dwc_isr non-NCQ cmd interrupt, protocol: ATA no data
[ 92.203647] sata-dwc 4bffd1000.sata: sata_dwc_qc_complete checkstatus? 1
[ 92.229784] sata-dwc 4bffd1000.sata: QC complete cmd=0x27 status=0x00 ata3: protocol=1
[ 92.257433] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0xef)=SET FEATURES qc tag=31 prot=ATA no data ap active_tag=0x0000001f ap sactive=0x00000000
[ 92.292034] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=none n_elem=0
[ 92.320650] dma dma0chan0: dwc_prep_slave_sg
[ 92.345269] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: dma_dwc_xfer_setup returns NULL
[ 92.385864] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0xec)=IDENTIFY DEVICE qc tag=31 prot=ATA PIO ap active_tag=0x0000001f ap sactive=0x00000000
[ 92.443861] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=from device n_elem=1
[ 92.475296] dma dma0chan0: dwc_prep_slave_sg
[ 92.501903] dma dma0chan0: scanned 1 descriptors on freelist
[ 92.529752] sata-dwc 4bffd1000.sata: dma_dwc_xfer_setup sg: 0xed673bb8, count: 1 addr: 0xfffffffff6a18400
[ 92.565987] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0x27)=READ NATIVE MAX ADDRESS EXT qc tag=31 prot=ATA no data ap active_tag=0x0000001f ap sactive=0x00000000
[ 92.604824] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=none n_elem=0
[ 92.635973] dma dma0chan0: dwc_prep_slave_sg
[ 92.662692] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: dma_dwc_xfer_setup returns NULL
[ 92.693828] sata-dwc 4bffd1000.sata: sata_dwc_isr intpr=0x80000080 active_tag=31
[ 92.723554] sata-dwc 4bffd1000.sata: sata_dwc_isr non-NCQ cmd interrupt, protocol: ATA no data
[ 92.754498] sata-dwc 4bffd1000.sata: sata_dwc_qc_complete checkstatus? 1
[ 92.783022] sata-dwc 4bffd1000.sata: QC complete cmd=0x27 status=0x00 ata3: protocol=1
[ 92.821204] ata3.00: configured for UDMA/133
[ 92.847418] ata3.00: device reported invalid CHS sector 0
[ 92.875398] ata3: EH complete
[ 92.900751] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=from device n_elem=1
[ 92.932009] dma dma0chan0: dwc_prep_slave_sg
[ 92.958725] dma dma0chan0: scanned 1 descriptors on freelist
[ 92.986913] sata-dwc 4bffd1000.sata: dma_dwc_xfer_setup sg: 0xed55de00, count: 1 addr: 0xfffffffff6a18400
[ 93.019696] ------------[ cut here ]------------
[ 93.047444] WARNING: at drivers/ata/libata-sff.c:1493
[ 93.075690] Modules linked in: input_leds led_class sata_dwc_460ex
[ 93.105332] CPU: 0 PID: 408 Comm: scsi_eh_3 Tainted: G W 4.4.0-rc5-Sam460ex #9
[ 93.136769] task: ed7fcb80 ti: ed672000 task.ti: ed672000
[ 93.164633] NIP: c044d734 LR: c044d5a4 CTR: c044a354
[ 93.192264] REGS: ed673bd0 TRAP: 0700 Tainted: G W (4.4.0-rc5-Sam460ex)
[ 93.223381] MSR: 00021000 <CE,ME> CR: 24008044 XER: 20000000
[ 93.252669]
GPR00: c044d5a4 ed673c80 ed7fcb80 00000050 f6a18018 00000000 c02e1328 00000000
GPR08: 00000000 00000001 10912d85 ed673c80 c044d560 00000000 00000005 00002710
GPR16: c04263e0 c0944a03 c08fb4b8 c094492f c09020db ed4eb41c c09fd770 00000000
GPR24: ed53b900 ede97ad0 ffa0d510 ed61c000 00000000 ed61d7c8 ed61c000 ed61c0b8
[ 93.401513] NIP [c044d734] ata_sff_qc_issue+0x1d4/0x1fc
[ 93.430765] LR [c044d5a4] ata_sff_qc_issue+0x44/0x1fc
[ 93.460012] Call Trace:
[ 93.486696] [ed673c80] [c044d5a4] ata_sff_qc_issue+0x44/0x1fc (unreliable)
[ 93.518271] [ed673ca0] [f6a0f34c] sata_dwc_qc_issue+0x35c/0x370 [sata_dwc_460ex]
[ 93.550461] [ed673d20] [c043bdf8] ata_qc_issue+0x338/0x3a0
[ 93.580860] [ed673d50] [c0440c84] ata_scsi_translate+0xf4/0x150
[ 93.611832] [ed673d70] [c0444080] ata_scsi_queuecmd+0x1e8/0x238
[ 93.642570] [ed673d90] [c042511c] scsi_dispatch_cmd+0xd4/0x110
[ 93.672624] [ed673da0] [c0427a9c] scsi_request_fn+0x52c/0x55c
[ 93.701973] [ed673df0] [c024cd34] __blk_run_queue+0x44/0x58
[ 93.730799] [ed673e00] [c024cf30] blk_run_queue+0x28/0x44
[ 93.759096] [ed673e10] [c0425c78] scsi_run_queue+0x240/0x268
[ 93.787440] [ed673e50] [c0427b04] scsi_run_host_queues+0x30/0x44
[ 93.816120] [ed673e60] [c0424d44] scsi_error_handler+0x3e0/0x44c
[ 93.844522] [ed673ed0] [c0039798] kthread+0xc8/0xcc
[ 93.871278] [ed673f40] [c000b0d0] ret_from_kernel_thread+0x5c/0x64
[ 93.899040] Instruction dump:
[ 93.923330] 7d2903a6 4e800421 39200001 913e2720 813f0004 8129000c 71280004 4082ff80
[ 93.952782] 4bffff88 3d20c0a3 89295769 69290001 <0f090000> 2f890000 38600040 41be0014
[ 93.982497] ---[ end trace c4f4eb32724d9e3b ]---
[ 123.757041] ata3: lost interrupt (Status 0x50)
[ 123.784377] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=1 val=val=0x00000000
[ 123.814857] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000123
[ 123.846362] ata3: limiting SATA link speed to 1.5 Gbps
[ 123.873279] ata3.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 123.902436] ata3.00: failed command: READ DMA
[ 123.928477] ata3.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 dma 4096 in
[ 123.928477] res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
[ 123.984036] ata3.00: status: { DRDY }
[ 124.007382] ata3: hard resetting link
[ 124.031093] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000300
[ 124.062562] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000300
[ 124.090763] sata-dwc 4bffd1000.sata: sata_dwc_scr_write: id=3 reg=2 val=val=0x00000304
[ 124.120737] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000304
[ 124.148586] sata-dwc 4bffd1000.sata: sata_dwc_scr_write: id=3 reg=2 val=val=0x00000314
[ 124.177848] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000314
[ 124.205293] sata-dwc 4bffd1000.sata: sata_dwc_scr_write: id=3 reg=2 val=val=0x00000311
[ 124.234321] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000311
[ 124.263065] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000311
[ 124.290181] sata-dwc 4bffd1000.sata: sata_dwc_scr_write: id=3 reg=2 val=val=0x00000310
[ 124.519032] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000310
[ 124.545678] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 124.581030] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 124.613033] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 124.646032] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 124.678033] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 124.704609] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=1 val=val=0x04050002
[ 124.732334] sata-dwc 4bffd1000.sata: sata_dwc_scr_write: id=3 reg=1 val=val=0x04050002
[ 124.758405] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 124.785862] sata-dwc 4bffd1000.sata: sata_dwc_enable_interrupts: INTMR = 0x0000000f, ERRMR = 0x0fff0f03
[ 124.813451] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 124.840951] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 124.866462] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 124.893297] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=1 val=val=0x00000000
[ 124.918324] sata-dwc 4bffd1000.sata: sata_dwc_scr_write: id=3 reg=1 val=val=0x00000000
[ 124.944752] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 124.969556] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000310
[ 124.995561] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 125.019874] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 125.043635] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 125.071341] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 125.096330] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0xec)=IDENTIFY DEVICE qc tag=31 prot=ATA PIO ap active_tag=0x0000001f ap sactive=0x00000000
[ 125.128405] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=from device n_elem=1
[ 125.155167] dma dma0chan0: dwc_prep_slave_sg
[ 125.177154] dma dma0chan0: scanned 1 descriptors on freelist
[ 125.200489] sata-dwc 4bffd1000.sata: dma_dwc_xfer_setup sg: 0xed673c48, count: 1 addr: 0xfffffffff6a18400
[ 125.232134] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0x27)=READ NATIVE MAX ADDRESS EXT qc tag=31 prot=ATA no data ap active_tag=0x0000001f ap sactive=0x00000000
[ 125.266681] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=none n_elem=0
[ 125.293863] dma dma0chan0: dwc_prep_slave_sg
[ 125.317031] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: dma_dwc_xfer_setup returns NULL
[ 125.345061] sata-dwc 4bffd1000.sata: sata_dwc_isr intpr=0x80000080 active_tag=31
[ 125.371834] sata-dwc 4bffd1000.sata: sata_dwc_isr non-NCQ cmd interrupt, protocol: ATA no data
[ 125.399931] sata-dwc 4bffd1000.sata: sata_dwc_qc_complete checkstatus? 1
[ 125.426052] sata-dwc 4bffd1000.sata: QC complete cmd=0x27 status=0x00 ata3: protocol=1
[ 125.460639] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0xef)=SET FEATURES qc tag=31 prot=ATA no data ap active_tag=0x0000001f ap sactive=0x00000000
[ 125.495353] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=none n_elem=0
[ 125.523942] dma dma0chan0: dwc_prep_slave_sg
[ 125.548481] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: dma_dwc_xfer_setup returns NULL
[ 125.583176] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0xec)=IDENTIFY DEVICE qc tag=31 prot=ATA PIO ap active_tag=0x0000001f ap sactive=0x00000000
[ 125.640657] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=from device n_elem=1
[ 125.671668] dma dma0chan0: dwc_prep_slave_sg
[ 125.697640] dma dma0chan0: scanned 1 descriptors on freelist
[ 125.724655] sata-dwc 4bffd1000.sata: dma_dwc_xfer_setup sg: 0xed673bb8, count: 1 addr: 0xfffffffff6a18400
[ 125.760152] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0x27)=READ NATIVE MAX ADDRESS EXT qc tag=31 prot=ATA no data ap active_tag=0x0000001f ap sactive=0x00000000
[ 125.798408] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=none n_elem=0
[ 125.829141] dma dma0chan0: dwc_prep_slave_sg
[ 125.855773] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: dma_dwc_xfer_setup returns NULL
[ 125.887155] sata-dwc 4bffd1000.sata: sata_dwc_isr intpr=0x80000080 active_tag=31
[ 125.887163] sata-dwc 4bffd1000.sata: sata_dwc_isr non-NCQ cmd interrupt, protocol: ATA no data
[ 125.887170] sata-dwc 4bffd1000.sata: sata_dwc_qc_complete checkstatus? 1
[ 125.887177] sata-dwc 4bffd1000.sata: QC complete cmd=0x27 status=0x00 ata3: protocol=1
[ 126.015109] ata3.00: configured for UDMA/133
[ 126.041639] ata3.00: device reported invalid CHS sector 0
[ 126.071209] ata3: EH complete
[ 126.096636] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=from device n_elem=1
[ 126.127869] dma dma0chan0: dwc_prep_slave_sg
[ 126.154394] dma dma0chan0: scanned 1 descriptors on freelist
[ 126.182373] sata-dwc 4bffd1000.sata: dma_dwc_xfer_setup sg: 0xed55de00, count: 1 addr: 0xfffffffff6a18400
[ 144.853669] cgroup: new mount options do not match the existing superblock, will be ignored
[ 149.562973] IPv6: ADDRCONF(NETDEV_UP): sit0: link is not ready
[ 149.751626] IPv6: ADDRCONF(NETDEV_UP): eth1: link is not ready
[ 149.875449] IPv6: ADDRCONF(NETDEV_UP): tunl0: link is not ready
[ 156.781119] ata3: lost interrupt (Status 0x50)
[ 156.794072] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=1 val=val=0x00000000
[ 156.839113] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 156.881060] ata3.00: limiting speed to UDMA/100:PIO4
[ 156.908123] ata3.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 156.941086] ata3.00: failed command: READ DMA
[ 156.961099] ata3.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 dma 4096 in
[ 156.961099] res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
[ 157.030081] ata3.00: status: { DRDY }
[ 157.044105] ata3: hard resetting link
[ 157.059094] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000310
[ 157.091056] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000310
[ 157.128084] sata-dwc 4bffd1000.sata: sata_dwc_scr_write: id=3 reg=2 val=val=0x00000311
[ 157.162071] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000311
[ 157.216617] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000311
[ 157.259084] sata-dwc 4bffd1000.sata: sata_dwc_scr_write: id=3 reg=2 val=val=0x00000310
[ 157.509089] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000310
[ 157.538087] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 157.586073] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 157.624146] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 157.675085] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 157.712085] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=1 val=val=0x04050002
[ 157.755049] sata-dwc 4bffd1000.sata: sata_dwc_scr_write: id=3 reg=1 val=val=0x04050002
[ 157.795063] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 157.837087] sata-dwc 4bffd1000.sata: sata_dwc_enable_interrupts: INTMR = 0x0000000f, ERRMR = 0x0fff0f03
[ 157.886080] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 157.936052] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 158.021403] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 158.084104] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=1 val=val=0x00000000
[ 158.147278] sata-dwc 4bffd1000.sata: sata_dwc_scr_write: id=3 reg=1 val=val=0x00000000
[ 158.216803] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 158.292058] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000310
[ 158.342043] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 158.374047] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 158.390075] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 158.414075] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 158.436076] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0xec)=IDENTIFY DEVICE qc tag=31 prot=ATA PIO ap active_tag=0x0000001f ap sactive=0x00000000
[ 158.450266] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=from device n_elem=1
[ 158.459142] dma dma0chan0: dwc_prep_slave_sg
[ 158.463422] dma dma0chan0: scanned 1 descriptors on freelist
[ 158.469091] sata-dwc 4bffd1000.sata: dma_dwc_xfer_setup sg: 0xed673c48, count: 1 addr: 0xfffffffff6a18400
[ 158.574136] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0x27)=READ NATIVE MAX ADDRESS EXT qc tag=31 prot=ATA no data ap active_tag=0x0000001f ap sactive=0x00000000
[ 158.589719] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=none n_elem=0
[ 158.597988] dma dma0chan0: dwc_prep_slave_sg
[ 158.602265] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: dma_dwc_xfer_setup returns NULL
[ 158.610938] sata-dwc 4bffd1000.sata: sata_dwc_isr intpr=0x80000080 active_tag=31
[ 158.618344] sata-dwc 4bffd1000.sata: sata_dwc_isr non-NCQ cmd interrupt, protocol: ATA no data
[ 158.626962] sata-dwc 4bffd1000.sata: sata_dwc_qc_complete checkstatus? 1
[ 158.633664] sata-dwc 4bffd1000.sata: QC complete cmd=0x27 status=0x00 ata3: protocol=1
[ 158.828093] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0xef)=SET FEATURES qc tag=31 prot=ATA no data ap active_tag=0x0000001f ap sactive=0x00000000
[ 158.842367] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=none n_elem=0
[ 158.850634] dma dma0chan0: dwc_prep_slave_sg
[ 158.854913] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: dma_dwc_xfer_setup returns NULL
[ 158.929082] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0xec)=IDENTIFY DEVICE qc tag=31 prot=ATA PIO ap active_tag=0x0000001f ap sactive=0x00000000
[ 158.943269] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=from device n_elem=1
[ 158.952146] dma dma0chan0: dwc_prep_slave_sg
[ 158.956424] dma dma0chan0: scanned 1 descriptors on freelist
[ 158.962094] sata-dwc 4bffd1000.sata: dma_dwc_xfer_setup sg: 0xed673bb8, count: 1 addr: 0xfffffffff6a18400
[ 158.985723] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0x27)=READ NATIVE MAX ADDRESS EXT qc tag=31 prot=ATA no data ap active_tag=0x0000001f ap sactive=0x00000000
[ 159.001299] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=none n_elem=0
[ 159.009567] dma dma0chan0: dwc_prep_slave_sg
[ 159.013845] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: dma_dwc_xfer_setup returns NULL
[ 159.022521] sata-dwc 4bffd1000.sata: sata_dwc_isr intpr=0x80000080 active_tag=31
[ 159.029923] sata-dwc 4bffd1000.sata: sata_dwc_isr non-NCQ cmd interrupt, protocol: ATA no data
[ 159.038542] sata-dwc 4bffd1000.sata: sata_dwc_qc_complete checkstatus? 1
[ 159.045245] sata-dwc 4bffd1000.sata: QC complete cmd=0x27 status=0x00 ata3: protocol=1
[ 159.097260] ata3.00: configured for UDMA/100
[ 159.101800] ata3.00: device reported invalid CHS sector 0
[ 159.109299] ata3: EH complete
[ 159.113116] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=from device n_elem=1
[ 159.122001] dma dma0chan0: dwc_prep_slave_sg
[ 159.126277] dma dma0chan0: scanned 1 descriptors on freelist
[ 159.131948] sata-dwc 4bffd1000.sata: dma_dwc_xfer_setup sg: 0xed55de00, count: 1 addr: 0xfffffffff6a18400
Ubuntu Xenial Xerus (development branch) Sam460ex ttyS0
Sam460ex login: [ 189.804846] ata3: lost interrupt (Status 0x50)
[ 189.810492] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=1 val=val=0x00000000
[ 189.818411] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 189.828549] ata3.00: limiting speed to UDMA/33:PIO4
[ 189.833511] ata3.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 189.841544] ata3.00: failed command: READ DMA
[ 189.845959] ata3.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 dma 4096 in
[ 189.845959] res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
[ 189.861345] ata3.00: status: { DRDY }
[ 189.865068] ata3: hard resetting link
[ 189.869476] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000310
[ 189.877356] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000310
[ 189.887245] sata-dwc 4bffd1000.sata: sata_dwc_scr_write: id=3 reg=2 val=val=0x00000311
[ 189.895232] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000311
[ 189.906843] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000311
[ 189.916256] sata-dwc 4bffd1000.sata: sata_dwc_scr_write: id=3 reg=2 val=val=0x00000310
[ 190.124849] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000310
[ 190.132705] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 190.147834] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 190.160833] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 190.173886] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 190.186835] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 190.199834] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 190.212834] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 190.225834] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 190.238836] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 190.248318] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=1 val=val=0x04050002
[ 190.256226] sata-dwc 4bffd1000.sata: sata_dwc_scr_write: id=3 reg=1 val=val=0x04050002
[ 190.266379] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 190.274335] sata-dwc 4bffd1000.sata: sata_dwc_enable_interrupts: INTMR = 0x0000000f, ERRMR = 0x0fff0f03
[ 190.286073] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 190.294054] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 190.304067] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 190.311970] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=1 val=val=0x00000000
[ 190.321909] sata-dwc 4bffd1000.sata: sata_dwc_scr_write: id=3 reg=1 val=val=0x00000000
[ 190.329887] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 190.339868] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=2 val=val=0x00000310
[ 190.349275] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 190.357169] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 190.365051] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 190.372955] sata-dwc 4bffd1000.sata: sata_dwc_scr_read: id=3 reg=0 val=val=0x00000113
[ 190.382908] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0xec)=IDENTIFY DEVICE qc tag=31 prot=ATA PIO ap active_tag=0x0000001f ap sactive=0x00000000
[ 190.397097] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=from device n_elem=1
[ 190.405973] dma dma0chan0: dwc_prep_slave_sg
[ 190.410253] dma dma0chan0: scanned 1 descriptors on freelist
[ 190.415922] sata-dwc 4bffd1000.sata: dma_dwc_xfer_setup sg: 0xed673c48, count: 1 addr: 0xfffffffff6a18400
[ 190.429929] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0x27)=READ NATIVE MAX ADDRESS EXT qc tag=31 prot=ATA no data ap active_tag=0x0000001f ap sactive=0x00000000
[ 190.445509] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=none n_elem=0
[ 190.453776] dma dma0chan0: dwc_prep_slave_sg
[ 190.458055] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: dma_dwc_xfer_setup returns NULL
[ 190.466712] sata-dwc 4bffd1000.sata: sata_dwc_isr intpr=0x80000080 active_tag=31
[ 190.474116] sata-dwc 4bffd1000.sata: sata_dwc_isr non-NCQ cmd interrupt, protocol: ATA no data
[ 190.482734] sata-dwc 4bffd1000.sata: sata_dwc_qc_complete checkstatus? 1
[ 190.489436] sata-dwc 4bffd1000.sata: QC complete cmd=0x27 status=0x00 ata3: protocol=1
[ 190.506311] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0xef)=SET FEATURES qc tag=31 prot=ATA no data ap active_tag=0x0000001f ap sactive=0x00000000
[ 190.520587] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=none n_elem=0
[ 190.528855] dma dma0chan0: dwc_prep_slave_sg
[ 190.533134] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: dma_dwc_xfer_setup returns NULL
[ 190.545620] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0xec)=IDENTIFY DEVICE qc tag=31 prot=ATA PIO ap active_tag=0x0000001f ap sactive=0x00000000
[ 190.559805] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=from device n_elem=1
[ 190.568681] dma dma0chan0: dwc_prep_slave_sg
[ 190.572961] dma dma0chan0: scanned 1 descriptors on freelist
[ 190.578631] sata-dwc 4bffd1000.sata: dma_dwc_xfer_setup sg: 0xed673bb8, count: 1 addr: 0xfffffffff6a18400
[ 190.592927] sata-dwc 4bffd1000.sata: sata_dwc_qc_issue ap id=3 cmd(0x27)=READ NATIVE MAX ADDRESS EXT qc tag=31 prot=ATA no data ap active_tag=0x0000001f ap sactive=0x00000000
[ 190.608503] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=none n_elem=0
[ 190.616771] dma dma0chan0: dwc_prep_slave_sg
[ 190.621050] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: dma_dwc_xfer_setup returns NULL
[ 190.629706] sata-dwc 4bffd1000.sata: sata_dwc_isr intpr=0x80000080 active_tag=31
[ 190.637111] sata-dwc 4bffd1000.sata: sata_dwc_isr non-NCQ cmd interrupt, protocol: ATA no data
[ 190.645730] sata-dwc 4bffd1000.sata: sata_dwc_qc_complete checkstatus? 1
[ 190.652440] sata-dwc 4bffd1000.sata: QC complete cmd=0x27 status=0x00 ata3: protocol=1
[ 190.669423] ata3.00: configured for UDMA/33
[ 190.673693] ata3.00: device reported invalid CHS sector 0
[ 190.680063] ata3: EH complete
[ 190.683708] sata-dwc 4bffd1000.sata: sata_dwc_qc_prep_by_tag: port=0 dma dir=from device n_elem=1
[ 190.692599] dma dma0chan0: dwc_prep_slave_sg
[ 190.696876] dma dma0chan0: scanned 1 descriptors on freelist
[ 190.702546] sata-dwc 4bffd1000.sata: dma_dwc_xfer_setup sg: 0xed55de00, count: 1 addr: 0xfffffffff6a18400
