Bug#707588: md crash on DNS-323 (armel/orion5x)
Am Donnerstag, 9. Mai 2013, 21:56:28 schrieben Sie:
> Control: retitle -1 md crash on DNS-323 (armel/orion5x)
> Control: tag -1 moreinfo
>
> On Thu, May 09, 2013 at 06:03:04PM +0200, Christian Samsel wrote:
> > Package: src:linux
> > Version: 3.2.41-2
> > Severity: normal
> > Tags: upstream
> >
> > Dear Maintainer,
> >
> > Upgraded to wheezy on a DNS-323. The upgrade worked more or
> > less flawless in term of userpace. Unfortunately the wheezy
> > kernel crashes as mdadm starts assembling my raid1 array.
> > If found that out by removing the HDDs form the DNS-323 and solely
> > booting from a USB stick. Hotplugging the HDDs still worked but
> > mdmadm-startall afterwards crashed the system. Downgrading to 2.6.32-5
> > resolved the issue.
>
> [...]
>
> We will need some sort of log of the crash in order to investigate
> this. Since you are able to reproduce this by booting and then
> hotplugging the HDDs, it should be possible to obtain the log using
> netconsole
> <https://www.kernel.org/doc/Documentation/networking/netconsole.txt>.
>
> Ben.
Hey Ben,
thanks for your answer; log at the bottom (sorry for long lines).
PS: it is kind of wierd that flash-kernel takes the taget kernel version as
parameter but prevents you from flashing anything but the latest version.
ad to remove this "protection" to switch between kernel versions.
May 10 20:20:20 192.168.2.11 [ 193.952244] ata1: exception Emask 0x10 SAct 0x0 SErr 0x4010000 action 0xe frozen
May 10 20:20:20 192.168.2.11 [ 193.959771] ata1: edma_err_cause=00000010 pp_flags=00000000, dev connect
May 10 20:20:20 192.168.2.11 [ 193.966559] ata1: SError: { PHYRdyChg DevExch }
May 10 20:20:20 192.168.2.11 [ 193.971170] ata1: hard resetting link
May 10 20:20:24 192.168.2.11 [ 198.077300] ata2: exception Emask 0x10 SAct 0x0 SErr 0x4010000 action 0xe frozen
May 10 20:20:24 192.168.2.11 [ 198.084822] ata2: edma_err_cause=00000010 pp_flags=00000000, dev connect
May 10 20:20:24 192.168.2.11 [ 198.091564] ata2: SError: { PHYRdyChg DevExch }
May 10 20:20:24 192.168.2.11 [ 198.096209] ata2: hard resetting link
May 10 20:20:26 192.168.2.11 [ 199.922885] ata1: link is slow to respond, please be patient (ready=0)
May 10 20:20:30 192.168.2.11 [ 204.002886] ata1: SRST failed (errno=-16)
May 10 20:20:30 192.168.2.11 [ 204.006967] ata1: hard resetting link
May 10 20:20:30 192.168.2.11 [ 204.042898] ata2: link is slow to respond, please be patient (ready=0)
May 10 20:20:32 192.168.2.11 [ 205.632929] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
May 10 20:20:32 192.168.2.11 [ 205.672962] ata1.00: ATA-8: ST32000542AS, CC34, max UDMA/133
May 10 20:20:32 192.168.2.11 [ 205.678687] ata1.00: 3907029168 sectors, multi 0: LBA48 NCQ (depth 31/32)
May 10 20:20:32 192.168.2.11 [ 205.723058] ata1.00: configured for UDMA/133
May 10 20:20:32 192.168.2.11 [ 205.727428] ata1: EH complete
May 10 20:20:32 192.168.2.11 [ 205.731172] scsi 1:0:0:0: Direct-Access ATA ST32000542AS CC34 PQ: 0 ANSI: 5
May 10 20:20:32 192.168.2.11 [ 205.749871] sd 1:0:0:0: [sdb] 3907029168 512-byte logical blocks: (2.00 TB/1.81 TiB)
May 10 20:20:32 192.168.2.11 [ 205.759928] sd 1:0:0:0: Attached scsi generic sg2 type 0
May 10 20:20:32 192.168.2.11 [ 205.773660] sd 1:0:0:0: [sdb] Write Protect is off
May 10 20:20:32 192.168.2.11 [ 205.784763] sd 1:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
May 10 20:20:32 192.168.2.11 [ 205.900432] sdb: sdb1
May 10 20:20:32 192.168.2.11 [ 205.912641] sd 1:0:0:0: [sdb] Attached SCSI disk
May 10 20:20:34 192.168.2.11 [ 208.122926] ata2: SRST failed (errno=-16)
May 10 20:20:34 192.168.2.11 [ 208.127005] ata2: hard resetting link
May 10 20:20:35 192.168.2.11 [ 209.512927] ata2: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
May 10 20:20:35 192.168.2.11 [ 209.552988] ata2.00: ATA-8: ST32000542AS, CC34, max UDMA/133
May 10 20:20:35 192.168.2.11 [ 209.558715] ata2.00: 3907029168 sectors, multi 0: LBA48 NCQ (depth 31/32)
May 10 20:20:36 192.168.2.11 [ 209.663014] ata2.00: configured for UDMA/133
May 10 20:20:36 192.168.2.11 [ 209.667381] ata2: EH complete
May 10 20:20:36 192.168.2.11 [ 209.671052] scsi 2:0:0:0: Direct-Access ATA ST32000542AS CC34 PQ: 0 ANSI: 5
May 10 20:20:36 192.168.2.11 [ 209.689192] sd 2:0:0:0: [sdc] 3907029168 512-byte logical blocks: (2.00 TB/1.81 TiB)
May 10 20:20:36 192.168.2.11 [ 209.699286] sd 2:0:0:0: Attached scsi generic sg3 type 0
May 10 20:20:36 192.168.2.11 [ 209.713731] sd 2:0:0:0: [sdc] Write Protect is off
May 10 20:20:36 192.168.2.11 [ 209.724010] sd 2:0:0:0: [sdc] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
May 10 20:20:36 192.168.2.11 [ 209.833383] sdc: sdc1
May 10 20:20:36 192.168.2.11 [ 209.845671] sd 2:0:0:0: [sdc] Attached SCSI disk
May 10 20:20:58 192.168.2.11 [ 231.615174] md: md0 stopped.
May 10 20:20:58 192.168.2.11 [ 231.653839] md: bind<sdc1>
May 10 20:20:58 192.168.2.11 [ 231.673005] md: bind<sdb1>
May 10 20:20:58 192.168.2.11 [ 231.742381] md: raid1 personality registered for level 1
May 10 20:20:58 192.168.2.11 [ 231.750900] bio: create slab <bio-1> at 1
May 10 20:20:58 192.168.2.11 [ 231.756210] md/raid1:md0: active with 2 out of 2 mirrors
May 10 20:20:58 192.168.2.11 [ 231.762158] md0: detected capacity change from 0 to 2000396607488
May 10 20:20:58 192.168.2.11 [ 231.771358] Unable to handle kernel paging request at virtual address 00001280
May 10 20:20:58 192.168.2.11 [ 231.778682] pgd = c2e34000
May 10 20:20:58 192.168.2.11 [ 231.781421] [00001280] *pgd=031ca831
May 10 20:20:58 192.168.2.11 , *pte=00000000
May 10 20:20:58 192.168.2.11 , *ppte=00000000
May 10 20:20:58 192.168.2.11
May 10 20:20:58 192.168.2.11 [ 231.787808] Internal error: Oops: 17 [#1]
May 10 20:20:58 192.168.2.11 [ 231.791827] Modules linked in:
May 10 20:20:58 192.168.2.11 raid1
May 10 20:20:58 192.168.2.11 netconsole
May 10 20:20:58 192.168.2.11 configfs
May 10 20:20:58 192.168.2.11 ipv6
May 10 20:20:58 192.168.2.11 ext4
May 10 20:20:58 192.168.2.11 crc16
May 10 20:20:58 192.168.2.11 jbd2
May 10 20:20:58 192.168.2.11 md_mod
May 10 20:20:58 192.168.2.11 loop
May 10 20:20:58 192.168.2.11 ledtrig_heartbeat
May 10 20:20:58 192.168.2.11 sg
May 10 20:20:58 192.168.2.11 sr_mod
May 10 20:20:58 192.168.2.11 evdev
May 10 20:20:58 192.168.2.11 cdrom
May 10 20:20:58 192.168.2.11 mv643xx_eth
May 10 20:20:58 192.168.2.11 inet_lro
May 10 20:20:58 192.168.2.11 g760a
May 10 20:20:58 192.168.2.11 lm75
May 10 20:20:58 192.168.2.11 sata_mv
May 10 20:20:58 192.168.2.11 libata
May 10 20:20:58 192.168.2.11 gpio_keys
May 10 20:20:58 192.168.2.11 sd_mod
May 10 20:20:58 192.168.2.11 crc_t10dif
May 10 20:20:58 192.168.2.11 usb_storage
May 10 20:20:58 192.168.2.11 scsi_mod
May 10 20:20:58 192.168.2.11 ext3
May 10 20:20:58 192.168.2.11 mbcache
May 10 20:20:58 192.168.2.11 jbd
May 10 20:20:58 192.168.2.11 ehci_hcd
May 10 20:20:58 192.168.2.11 usbcore
May 10 20:20:58 192.168.2.11 usb_common
May 10 20:20:58 192.168.2.11
May 10 20:20:58 192.168.2.11 [ 231.816448] CPU: 0 Not tainted (3.2.0-4-orion5x #1 Debian 3.2.41-2)
May 10 20:20:58 192.168.2.11 [ 231.823154] PC is at mddev_bio_destructor+0x4/0xc [md_mod]
May 10 20:20:58 192.168.2.11 [ 231.828660] LR is at bio_put+0x44/0x48
May 10 20:20:58 192.168.2.11 [ 231.832431] pc : [<bf1948f8>] lr : [<c00ee754>] psr: 60000013
May 10 20:20:58 192.168.2.11 [ 231.832447] sp : c3269d78 ip : 60000093 fp : 00001000
May 10 20:20:58 192.168.2.11 [ 231.843915] r10: 00000000 r9 : 00000000 r8 : 00000000
May 10 20:20:58 192.168.2.11 [ 231.849150] r7 : c32272e0 r6 : c2f978a0 r5 : 00000000 r4 : c2f978a0
May 10 20:20:58 192.168.2.11 [ 231.855684] r3 : 00001008 r2 : 00000000 r1 : 20000013 r0 : c2e05724
May 10 20:20:58 192.168.2.11 [ 231.862213] Flags: nZCv IRQs on FIQs on Mode SVC_32 ISA ARM Segment user
May 10 20:20:58 192.168.2.11 [ 231.869351] Control: a005317f Table: 02e34000 DAC: 00000015
May 10 20:20:58 192.168.2.11 [ 231.875105] Process udevd (pid: 2664, stack limit = 0xc3268270)
May 10 20:20:58 192.168.2.11 [ 231.881031] Stack: (0xc3269d78 to 0xc326a000)
May 10 20:20:58 192.168.2.11 [ 231.885398] 9d60: 00000002 bf2b0ccc
May 10 20:20:58 192.168.2.11 [ 231.893601] 9d80: c2f978a0 c32272e0 00000000 00000000 00000000 bf2b0db0 00000000 bf0fbbb0
May 10 20:20:58 192.168.2.11 [ 231.901795] 9da0: 00000002 c2d336a0 00000000 c38d0000 00000098 c38d00bc c38d0000 c38d13c8
May 10 20:20:58 192.168.2.11 [ 231.909984] 9dc0: c313a738 c313a730 00001000 c2e05724 00000000 00000000 00000000 c00eddbc
May 10 20:20:58 192.168.2.11 [ 231.918176] 9de0: 09164000 c0154754 000013c0 c2c3fe10 c4a22000 0000000c 000014f8 c313a730
May 10 20:20:58 192.168.2.11 [ 231.926362] 9e00: 00000000 00000000 00000000 00000000 c313a730 00000000 00001000 c015663c
May 10 20:20:58 192.168.2.11 [ 231.934558] 9e20: 00000000 c313a730 c313a730 c015722c c32a2098 c2d466c0 00000000 c313a730
May 10 20:20:58 192.168.2.11 [ 231.942754] 9e40: 00000000 bf0a0e50 00000002 c2d466c0 c32a2098 c32a2098 c2d0ec00 00000000
May 10 20:20:58 192.168.2.11 [ 231.950946] 9e60: 00000004 c3269e88 00000010 c3268000 c0417e24 00000000 00000004 00000004
May 10 20:20:58 192.168.2.11 [ 231.959149] 9e80: 00000100 c015af58 c3269e88 c3269e88 00000001 c0030ad0 00000000 c32e0440
May 10 20:20:58 192.168.2.11 [ 231.967346] 9ea0: 00000000 c03d02c0 0000000a fdd20200 c3269f24 0000000b 00000000 fdd20200
May 10 20:20:58 192.168.2.11 [ 231.975535] 9ec0: c3269f24 00000000 00000004 00000000 c2ecb53c c0030f1c 00000040 c0013078
May 10 20:20:58 192.168.2.11 [ 231.983728] 9ee0: c028df30 c00fafe0 60000013 c0011dd4 fffffffc c326fe6c 00000013 00000001
May 10 20:20:58 192.168.2.11 [ 231.991915] 9f00: c2ecb520 00000000 c32e0440 00000000 00000000 00000004 00000000 c2ecb53c
May 10 20:20:58 192.168.2.11 [ 232.000111] 9f20: c2e48044 c3269f38 c028df30 c00fafe0 60000013 ffffffff c2dcd5e8 c00121dc
May 10 20:20:58 192.168.2.11 [ 232.008308] 9f40: 00000001 bef7bd00 00000000 00000001 c3beeb40 c0024860 00100100 00200200
May 10 20:20:58 192.168.2.11 [ 232.016497] 9f60: 00000000 00000000 00000004 bef7bd00 00000008 00000000 0000000c 01a8d008
May 10 20:20:58 192.168.2.11 [ 232.024697] 9f80: 01aa5b70 01a8d008 01aa5b70 01aa54b8 000000fc c0012328 c3268000 00000000
May 10 20:20:58 192.168.2.11 [ 232.032889] 9fa0: 0003126c c0012180 01a8d008 01aa5b70 00000004 bef7bd00 00000004 ffffffff
May 10 20:20:58 192.168.2.11 [ 232.041079] 9fc0: 01a8d008 01aa5b70 01aa54b8 000000fc 01a8ed60 0000000b 00000000 0003126c
May 10 20:20:58 192.168.2.11 [ 232.049269] 9fe0: 00031268 bef7bc68 0001a864 b6ea4d9c 60000010 00000004 00000000 00000000
May 10 20:20:58 192.168.2.11 [ 232.057559] [<bf1948f8>] (mddev_bio_destructor+0x4/0xc [md_mod]) from [<c00ee754>] (bio_put+0x44/0x48)
May 10 20:20:58 192.168.2.11 [ 232.066908] [<c00ee754>] (bio_put+0x44/0x48) from [<bf2b0ccc>] (raid_end_bio_io+0x58/0x80 [raid1])
May 10 20:20:58 192.168.2.11 [ 232.075920] [<bf2b0ccc>] (raid_end_bio_io+0x58/0x80 [raid1]) from [<bf2b0db0>] (raid1_end_read_request+0xbc/0x1a8 [raid1])
May 10 20:20:58 192.168.2.11 [ 232.086990] [<bf2b0db0>] (raid1_end_read_request+0xbc/0x1a8 [raid1]) from [<c00eddbc>] (bio_endio+0x4c/0x50)
May 10 20:20:58 192.168.2.11 [ 232.096855] [<c00eddbc>] (bio_endio+0x4c/0x50) from [<c0154754>] (blk_update_request+0x1b0/0x420)
May 10 20:20:58 192.168.2.11 [ 232.105759] [<c0154754>] (blk_update_request+0x1b0/0x420) from [<c015663c>] (blk_update_bidi_request+0x14/0x70)
May 10 20:20:58 192.168.2.11 [ 232.115879] [<c015663c>] (blk_update_bidi_request+0x14/0x70) from [<c015722c>] (blk_end_request+0x14/0x4c)
May 10 20:20:58 192.168.2.11 [ 232.125682] [<c015722c>] (blk_end_request+0x14/0x4c) from [<bf0a0e50>] (scsi_io_completion+0x1d0/0x510 [scsi_mod])
May 10 20:20:58 192.168.2.11 [ 232.136154] [<bf0a0e50>] (scsi_io_completion+0x1d0/0x510 [scsi_mod]) from [<c015af58>] (blk_done_softirq+0x70/0x84)
May 10 20:20:58 192.168.2.11 [ 232.146625] [<c015af58>] (blk_done_softirq+0x70/0x84) from [<c0030ad0>] (__do_softirq+0xe8/0x1ec)
May 10 20:20:58 192.168.2.11 [ 232.155517] [<c0030ad0>] (__do_softirq+0xe8/0x1ec) from [<c0030f1c>] (irq_exit+0x40/0x94)
May 10 20:20:58 192.168.2.11 [ 232.163724] [<c0030f1c>] (irq_exit+0x40/0x94) from [<c0013078>] (handle_IRQ+0x64/0x84)
May 10 20:20:58 192.168.2.11 [ 232.171679] [<c0013078>] (handle_IRQ+0x64/0x84) from [<c0011dd4>] (__irq_svc+0x34/0x64)
May 10 20:20:58 192.168.2.11 [ 232.179715] [<c0011dd4>] (__irq_svc+0x34/0x64) from [<c00fafe0>] (sys_epoll_wait+0x23c/0x2f8)
May 10 20:20:58 192.168.2.11 [ 232.188267] [<c00fafe0>] (sys_epoll_wait+0x23c/0x2f8) from [<c0012180>] (ret_fast_syscall+0x0/0x2c)
May 10 20:20:58 192.168.2.11 [ 232.197333] Code: e1a00004 e8bd80f8 bf1948f4 e5103004 (e5931278)
May 10 20:20:58 192.168.2.11 [ 232.203522] ---[ end trace c365588de75d7453 ]---
May 10 20:20:58 192.168.2.11 [ 232.208155] Kernel panic - not syncing: Fatal exception in interrupt
May 10 20:20:58 192.168.2.11 [ 232.214584] [<c0017f90>] (unwind_backtrace+0x0/0xe0) from [<c028b504>] (panic+0x50/0x194)
May 10 20:20:58 192.168.2.11 [ 232.222790] [<c028b504>] (panic+0x50/0x194) from [<c0015a48>] (die+0x2e4/0x33c)
May 10 20:20:58 192.168.2.11 [ 232.230179] [<c0015a48>] (die+0x2e4/0x33c) from [<c028b3e4>] (__do_kernel_fault.part.4+0x54/0x74)
May 10 20:20:58 192.168.2.11 [ 232.239124] [<c028b3e4>] (__do_kernel_fault.part.4+0x54/0x74) from [<c00190f8>] (do_page_fault+0x298/0x2b4)
May 10 20:20:58 192.168.2.11 [ 232.248938] [<c00190f8>] (do_page_fault+0x298/0x2b4) from [<c000838c>] (do_DataAbort+0x34/0x98)
May 10 20:20:58 192.168.2.11 [ 232.257709] [<c000838c>] (do_DataAbort+0x34/0x98) from [<c0011d78>] (__dabt_svc+0x38/0x60)
May 10 20:20:58 192.168.2.11 [ 232.266017] Exception stack(0xc3269d30 to 0xc3269d78)
May 10 20:20:58 192.168.2.11 [ 232.271089] 9d20: c2e05724 20000013 00000000 00001008
May 10 20:20:58 192.168.2.11 [ 232.279340] 9d40: c2f978a0 00000000 c2f978a0 c32272e0 00000000 00000000 00000000 00001000
May 10 20:20:58 192.168.2.11 [ 232.287571] 9d60: 60000093 c3269d78 c00ee754 bf1948f8 60000013 ffffffff
May 10 20:20:58 192.168.2.11 [ 232.294352] [<c0011d78>] (__dabt_svc+0x38/0x60) from [<bf1948f8>] (mddev_bio_destructor+0x4/0xc [md_mod])
May 10 20:20:58 192.168.2.11 [ 232.304057] [<bf1948f8>] (mddev_bio_destructor+0x4/0xc [md_mod]) from [<c00ee754>] (bio_put+0x44/0x48)
May 10 20:20:58 192.168.2.11 [ 232.313454] [<c00ee754>] (bio_put+0x44/0x48) from [<bf2b0ccc>] (raid_end_bio_io+0x58/0x80 [raid1])
May 10 20:20:58 192.168.2.11 [ 232.322467] [<bf2b0ccc>] (raid_end_bio_io+0x58/0x80 [raid1]) from [<bf2b0db0>] (raid1_end_read_request+0xbc/0x1a8 [raid1])
May 10 20:20:58 192.168.2.11 [ 232.333594] [<bf2b0db0>] (raid1_end_read_request+0xbc/0x1a8 [raid1]) from [<c00eddbc>] (bio_endio+0x4c/0x50)
May 10 20:20:58 192.168.2.11 [ 232.343504] [<c00eddbc>] (bio_endio+0x4c/0x50) from [<c0154754>] (blk_update_request+0x1b0/0x420)
May 10 20:20:58 192.168.2.11 [ 232.352416] [<c0154754>] (blk_update_request+0x1b0/0x420) from [<c015663c>] (blk_update_bidi_request+0x14/0x70)
May 10 20:20:58 192.168.2.11 [ 232.362568] [<c015663c>] (blk_update_bidi_request+0x14/0x70) from [<c015722c>] (blk_end_request+0x14/0x4c)
May 10 20:20:58 192.168.2.11 [ 232.372418] [<c015722c>] (blk_end_request+0x14/0x4c) from [<bf0a0e50>] (scsi_io_completion+0x1d0/0x510 [scsi_mod])
May 10 20:20:58 192.168.2.11 [ 232.382961] [<bf0a0e50>] (scsi_io_completion+0x1d0/0x510 [scsi_mod]) from [<c015af58>] (blk_done_softirq+0x70/0x84)
May 10 20:20:58 192.168.2.11 [ 232.393486] [<c015af58>] (blk_done_softirq+0x70/0x84) from [<c0030ad0>] (__do_softirq+0xe8/0x1ec)
May 10 20:20:58 192.168.2.11 [ 232.402391] [<c0030ad0>] (__do_softirq+0xe8/0x1ec) from [<c0030f1c>] (irq_exit+0x40/0x94)
May 10 20:20:58 192.168.2.11 [ 232.410649] [<c0030f1c>] (irq_exit+0x40/0x94) from [<c0013078>] (handle_IRQ+0x64/0x84)
May 10 20:20:58 192.168.2.11 [ 232.418665] [<c0013078>] (handle_IRQ+0x64/0x84) from [<c0011dd4>] (__irq_svc+0x34/0x64)
May 10 20:20:58 192.168.2.11 [ 232.426756] [<c0011dd4>] (__irq_svc+0x34/0x64) from [<c00fafe0>] (sys_epoll_wait+0x23c/0x2f8)
May 10 20:20:58 192.168.2.11 [ 232.435359] [<c00fafe0>] (sys_epoll_wait+0x23c/0x2f8) from [<c0012180>] (ret_fast_syscall+0x0/0x2c)
Reply to: