[FS#1335] ZBT-WG3526 (16M) SD card write makes crash and reboot
LEDE Bugs
lede-bugs at lists.infradead.org
Thu Feb 8 00:59:35 PST 2018
A new Flyspray task has been opened. Details are below.
User who did this - ds_shadof (ds_shadof)
Attached to Project - OpenWrt/LEDE Project
Summary - ZBT-WG3526 (16M) SD card write makes crash and reboot
Task Type - Bug Report
Category - Kernel
Status - Unconfirmed
Assigned To -
Operating System - All
Severity - Critical
Priority - Very Low
Reported Version - Trunk
Due in Version - Undecided
Due Date - Undecided
Details - - Device problem occurs on
ZBT-WG3526 (16M)
- Software versions of OpenWrt/LEDE release, packages, etc.
Trunk
- Steps to reproduce
Mound SD card and start writing
Tested ext4 and f2fs
Time: 1518078139.211806
Modules:
pppoe at 8ecdc000+20b0
ppp_async at 8f226000+1a00
pppox at 8f218000+58a
ppp_generic at 8ecd0000+55a2
nf_conntrack_ipv6 at 8f7ec000+1770
mt76x2e at 8ec20000+ab93
mt7603e at 8f7f0000+75c9
mt76 at 8f1c8000+4bc3
mac80211 at 8f300000+669e0
iptable_nat at 8f7ac000+330
ipt_REJECT at 8f70b000+3d0
ipt_MASQUERADE at 8f139000+2d0 cfg80211 at 8f280000+346d4 xt_time at 8f0b5000+690 xt_tcpudp at 8f0b9000+730 xt_state at 8f075000+2f0 xt_nat at 8f256000+4b0 xt_multiport at 8f253000+510 xt_mark at 8f24f000+2d0 xt_mac at 8f24c000+2b0 xt_limit at 8f23d000+460 xt_conntrack at 8f23a000+8d0 xt_comment at 8f237000+230 xt_TCPMSS at 8f234000+af0 xt_REDIRECT at 8f7dd000+2d0 xt_LOG at 8f0fb000+330 xt_CT at 8f094000+a50 slhc at 8f22a000+11bb nf_reject_ipv4 at 8f056000+923 nf_nat_redirect at 8f059000+3fb nf_nat_masquerade_ipv4 at 8f05d000+5bc nf_conntrack_ipv4 at 8f220000+1530 nf_nat_ipv4 at 8f20e000+1031 nf_nat at 8f208000+287c nf_log_ipv4 at 8f064000+d30 nf_defrag_ipv6 at 8f200000+32ae nf_defrag_ipv4 at 8f06a000+3b6 nf_conntrack_rtcache at 8f06d000+a70 nf_conntrack at 8f1e0000+f600 iptable_mangle at 8f076000+3f0 iptable_filter at 8f079000+310 ip_tables at 8f1c4000+2acd crc_ccitt at 8f07e000+42b compat at 8f7fe000+14b8 ledtrig_usbport at 8f0bd000+a60 ip6t_REJECT at 8f0b2000+3f0 nf_reject_ipv6 at 8f0b6000+aa8 nf_log_ipv6 at 8f0b8000+db0 nf_log_common at 8f1b8000+a8f ip6table_mangle at 8f1bb000+490 ip6table_filter at 8f1bd000+2d0 ip6_tables at 8f098000+29a1 x_tables at 8f174000+3078 f2fs at 8f180000+35a00 ext4 at 8f000000+52fa9 jbd2 at 8f080000+db02 mbcache at 8f0fe000+ff4 crc32c_generic at 8f0fc000+530 crc32_generic at 8f0fa000+530 mmc_block at 8f738000+5db2 mtk_sd at 8f728000+49a0 mmc_core at 8f760000+140ed leds_gpio at 8fe79000+ab0 xhci_mtk at 8f650000+1130 xhci_plat_hcd at 8f5d2000+1390 xhci_pci at 8f75f000+ab0 xhci_hcd at 8f740000+154c7 ahci at 8f670000+3620 libahci at 8f668000+4531 libata at 8f680000+213da sd_mod at 8f640000+63a0 scsi_mod at 8f620000+15e9b gpio_button_hotplug at 8f606000+18b0 usbcore at 8f5e0000+1f315 nls_base at 8f5d0000+14d0 usb_common at 8ff1e000+a17
[ 2.219075] pci 0000:03:00.0: BAR 0: no space for [io size 0x0008]
[ 2.225282] pci 0000:03:00.0: BAR 0: failed to assign [io size 0x0008]
[ 2.231875] pci 0000:03:00.0: BAR 2: no space for [io size 0x0008]
[ 2.238067] pci 0000:03:00.0: BAR 2: failed to assign [io size 0x0008]
[ 2.244648] pci 0000:03:00.0: BAR 1: no space for [io size 0x0004]
[ 2.250854] pci 0000:03:00.0: BAR 1: failed to assign [io size 0x0004]
[ 2.257435] pci 0000:03:00.0: BAR 3: no space for [io size 0x0004]
[ 2.263643] pci 0000:03:00.0: BAR 3: failed to assign [io size 0x0004]
[ 2.270223] pci 0000:00:02.0: PCI bridge to [bus 03]
[ 2.275137] pci 0000:00:02.0: bridge window [mem 0x60300000-0x603fffff]
[ 2.281888] pci 0000:00:02.0: bridge window [mem 0x60400000-0x604fffff pref]
[ 2.289063] BAR0 at slot 0 = 0
[ 2.292075] bus=0x0, slot = 0x0
[ 2.295181] BAR0 at slot 1 = 0
[ 2.298196] bus=0x0, slot = 0x1
[ 2.301311] BAR0 at slot 2 = 0
[ 2.304343] bus=0x0, slot = 0x2
[ 2.307451] bus=0x1, slot = 0x0, irq=0xff
[ 2.311426] bus=0x2, slot = 0x1, irq=0xff
[ 2.315415] bus=0x3, slot = 0x2, irq=0x0
[ 2.320700] clocksource: Switched to clocksource GIC
[ 2.327348] NET: Registered protocol family 2
[ 2.332492] TCP established hash table entries: 2048 (order: 1, 8192 bytes)
[ 2.339382] TCP bind hash table entries: 2048 (order: 2, 16384 bytes)
[ 2.345858] TCP: Hash tables configured (established 2048 bind 2048)
[ 2.352215] UDP hash table entries: 256 (order: 1, 8192 bytes)
[ 2.357977] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes)
[ 2.364470] NET: Registered protocol family 1
[ 2.368811] PCI: CLS 80 bytes, default 32
[ 2.600640] 4 CPUs re-calibrate udelay(lpj = 2924544)
[ 2.607001] Crashlog allocated RAM at address 0x3f00000
[ 2.612799] workingset: timestamp_bits=30 max_order=17 bucket_order=0
[ 2.627212] random: fast init done
[ 2.628261] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[ 2.628269] jffs2: version 2.2 (NAND) (SUMMARY) (LZMA) (RTIME) (CMODE_PRIORITY) (c) 2001-2006 Red Hat, Inc.
[ 2.631770] bounce: pool size: 64 pages
[ 2.631781] io scheduler noop registered
[ 2.631787] io scheduler deadline registered (default)
[ 2.632701] Serial: 8250/16550 driver, 16 ports, IRQ sharing enabled
[ 2.636603] console [ttyS0] disabled
[ 2.668830] 1e000c00.uartlite: ttyS0 at MMIO 0x1e000c00 (irq = 18, base_baud = 3125000) is a 16550A
[ 2.677904] console [ttyS0] enabled
[ 2.684795] bootconsole [early0] disabled
[ 2.694188] MediaTek Nand driver init, version v2.1 Fix AHB virt2phys error
[ 2.701558] spi-mt7621 1e000b00.spi: sys_freq: 50000000
[ 2.718213] m25p80 spi32766.0: using chunked io (size=32)
[ 2.723765] m25p80 spi32766.0: w25q128 (16384 Kbytes)
[ 2.728836] 4 ofpart partitions found on MTD device spi32766.0
[ 2.734657] Creating 4 MTD partitions on "spi32766.0":
[ 2.739793] 0x000000000000-0x000000030000 : "u-boot"
[ 2.746336] 0x000000030000-0x000000040000 : "u-boot-env"
[ 2.753069] 0x000000040000-0x000000050000 : "factory"
[ 2.759440] 0x000000050000-0x000001000000 : "firmware"
[ 2.793128] 2 uimage-fw partitions found on MTD device firmware
[ 2.799047] 0x000000050000-0x0000001f18ea : "kernel"
[ 2.805331] 0x0000001f18ea-0x000001000000 : "rootfs"
[ 2.811633] mtd: device 5 (rootfs) set to be root filesystem
[ 2.817386] 1 squashfs-split partitions found on MTD device rootfs
[ 2.823575] 0x000000420000-0x000001000000 : "rootfs_data"
[ 2.830959] libphy: Fixed MDIO Bus: probed
[ 2.902732] libphy: mdio: probed
[ 4.305387] mtk_soc_eth 1e100000.ethernet: loaded mt7530 driver
[ 4.312156] mtk_soc_eth 1e100000.ethernet eth0: mediatek frame engine at 0xbe100000, irq 21
[ 4.322826] NET: Registered protocol family 10
[ 4.328848] NET: Registered protocol family 17
[ 4.333401] bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this.
[ 4.346308] 8021q: 802.1Q VLAN Support v1.8
[ 4.353120] hctosys: unable to open rtc device (rtc0)
[ 4.362668] VFS: Mounted root (squashfs filesystem) readonly on device 31:5.
[ 4.370156] Freeing unused kernel memory: 204K
[ 4.374625] This architecture does not have kernel memory protection.
[ 4.790549] random: crng init done
[ 5.002582] init: Console is alive
[ 5.006183] init: - watchdog -
[ 5.987902] kmodloader: loading kernel modules from /etc/modules-boot.d/*
[ 6.059779] mtk_soc_eth 1e100000.ethernet eth0: port 0 link up
[ 6.121177] usbcore: registered new interface driver usbfs
[ 6.126760] usbcore: registered new interface driver hub
[ 6.132258] usbcore: registered new device driver usb
[ 6.145808] SCSI subsystem initialized
[ 6.154699] mtk_soc_eth 1e100000.ethernet eth0: port 4 link up
[ 6.166694] libata version 3.00 loaded.
[ 6.169957] ahci 0000:03:00.0: version 3.0
[ 6.170129] ahci 0000:03:00.0: SSS flag set, parallel bus scan disabled
[ 6.176820] ahci 0000:03:00.0: AHCI 0001.0200 32 slots 2 ports 6 Gbps 0x3 impl IDE mode
[ 6.184809] ahci 0000:03:00.0: flags: 64bit ncq sntf stag led clo pmp pio slum part ccc sxs
[ 6.195579] scsi host0: ahci
[ 6.199202] scsi host1: ahci
[ 6.202584] ata1: SATA max UDMA/133 abar m512 at 0x60300000 port 0x60300100 irq 25
[ 6.209868] ata2: SATA max UDMA/133 abar m512 at 0x60300000 port 0x60300180 irq 25
[ 6.550727] ata1: SATA link down (SStatus 0 SControl 300)
[ 6.890703] ata2: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[ 6.897614] ata2.00: ATA-8: KingDian H100 16GB, 20140718, max UDMA/133
[ 6.904142] ata2.00: 30932992 sectors, multi 0: LBA48
[ 6.910306] ata2.00: configured for UDMA/133
[ 6.915377] scsi 1:0:0:0: Direct-Access ATA KingDian H100 16 0718 PQ: 0 ANSI: 5
[ 7.001701] sd 1:0:0:0: [sda] 30932992 512-byte logical blocks: (15.8 GB/14.8 GiB)
[ 7.009788] sd 1:0:0:0: [sda] Write Protect is off
[ 7.014644] sd 1:0:0:0: [sda] Mode Sense: 00 3a 00 00
[ 7.014841] sd 1:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 7.026096] sda: sda1
[ 7.030326] sd 1:0:0:0: [sda] Attached SCSI disk
[ 7.042954] xhci-mtk 1e1c0000.xhci: xHCI Host Controller
[ 7.048292] xhci-mtk 1e1c0000.xhci: new USB bus registered, assigned bus number 1
[ 7.060904] xhci-mtk 1e1c0000.xhci: hcc params 0x01401198 hci version 0x96 quirks 0x00210010
[ 7.069380] xhci-mtk 1e1c0000.xhci: irq 20, io mem 0x1e1c0000
[ 7.076218] hub 1-0:1.0: USB hub found
[ 7.080039] hub 1-0:1.0: 2 ports detected
[ 7.084524] xhci-mtk 1e1c0000.xhci: xHCI Host Controller
[ 7.089829] xhci-mtk 1e1c0000.xhci: new USB bus registered, assigned bus number 2
[ 7.097509] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM.
[ 7.106548] hub 2-0:1.0: USB hub found
[ 7.110366] hub 2-0:1.0: 1 port detected
[ 7.123432] MTK MSDC device init.
[ 7.180858] mtk-sd: MediaTek MT6575 MSDC Driver
[ 7.191146] kmodloader: done loading kernel modules from /etc/modules-boot.d/*
[ 7.201034] init: - preinit -
[ 7.229901] mmc0: new high speed SD card at address 0260
[ 7.251066] mmcblk0: mmc0:0260 SD 977 MiB
[ 11.279722] jffs2: notice: (489) jffs2_build_xattr_subsystem: complete building xattr subsystem, 0 of xdatum (0 unchecked, 0 orphan) and 0 of xref (0 dead, 0 orphan) found.
[ 11.297711] mount_root: switching to jffs2 overlay
[ 11.326110] urandom-seed: Seeding with /etc/urandom.seed
[ 11.423971] procd: - early -
[ 11.426945] procd: - watchdog -
[ 12.080860] procd: - watchdog -
[ 12.084304] procd: - ubus -
[ 12.144166] procd: - init -
[ 12.687841] kmodloader: loading kernel modules from /etc/modules.d/*
[ 13.072475] ip6_tables: (C) 2000-2006 Netfilter Core Team
[ 13.086602] Loading modules backported from Linux version wt-2017-11-01-0-gfe248fc2c180
[ 13.094631] Backport generated by backports.git v4.14-rc2-1-31-g86cf0e5d
[ 13.103378] ip_tables: (C) 2000-2006 Netfilter Core Team
[ 13.116001] nf_conntrack version 0.5.0 (8192 buckets, 32768 max)
[ 13.163038] xt_time: kernel timezone is -0000
[ 13.222697] mt7603e 0000:01:00.0: ASIC revision: 76030010
[ 13.249203] mt7603e 0000:01:00.0: Firmware Version: ap_pcie
[ 13.254941] mt7603e 0000:01:00.0: Build Time: 20160107100755
[ 13.300693] firmware init done
[ 13.469340] ieee80211 phy0: Selected rate control algorithm 'minstrel_ht'
[ 13.477595] mt76x2e 0000:02:00.0: ASIC revision: 76120044
[ 13.500776] mt76x2e 0000:02:00.0: ROM patch already applied
[ 13.507648] mt76x2e 0000:02:00.0: Firmware Version: 0.0.00
[ 13.513275] mt76x2e 0000:02:00.0: Build: 1
[ 13.517355] mt76x2e 0000:02:00.0: Build Time: 201507311614____
[ 13.550815] mt76x2e 0000:02:00.0: Firmware running!
[ 13.557036] ieee80211 phy1: Selected rate control algorithm 'minstrel_ht'
[ 13.566089] PPP generic driver version 2.4.2
[ 13.572196] NET: Registered protocol family 24
[ 13.580106] kmodloader: done loading kernel modules from /etc/modules.d/*
[ 18.314394] br-lan: port 1(eth0.1) entered blocking state
[ 18.319822] br-lan: port 1(eth0.1) entered disabled state
[ 18.326037] device eth0.1 entered promiscuous mode
[ 18.331166] device eth0 entered promiscuous mode
[ 18.343871] br-lan: port 1(eth0.1) entered blocking state
[ 18.349340] br-lan: port 1(eth0.1) entered forwarding state
[ 18.355422] IPv6: ADDRCONF(NETDEV_UP): br-lan: link is not ready
[ 18.382881] br-wan: port 1(eth0.2) entered blocking state
[ 18.388313] br-wan: port 1(eth0.2) entered disabled state
[ 18.394676] device eth0.2 entered promiscuous mode
[ 18.409320] br-wan: port 1(eth0.2) entered blocking state
[ 18.414804] br-wan: port 1(eth0.2) entered forwarding state
[ 19.331184] IPv6: ADDRCONF(NETDEV_CHANGE): br-lan: link becomes ready
[ 21.452788] IPv6: ADDRCONF(NETDEV_UP): wlan1: link is not ready
[ 21.463889] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[ 21.485191] br-wan: port 2(wlan1) entered blocking state
[ 21.490522] br-wan: port 2(wlan1) entered disabled state
[ 21.496811] device wlan1 entered promiscuous mode
[ 21.502092] br-lan: port 2(wlan0) entered blocking state
[ 21.507420] br-lan: port 2(wlan0) entered disabled state
[ 21.513554] device wlan0 entered promiscuous mode
[ 21.914778] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
[ 21.921443] br-lan: port 2(wlan0) entered blocking state
[ 21.926741] br-lan: port 2(wlan0) entered forwarding state
[ 22.503269] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready
[ 22.509842] br-wan: port 2(wlan1) entered blocking state
[ 22.515172] br-wan: port 2(wlan1) entered forwarding state
[ 93.302625] EXT4-fs (mmcblk0): couldn't mount as ext3 due to feature incompatibilities
[ 93.312647] EXT4-fs (mmcblk0): couldn't mount as ext2 due to feature incompatibilities
[ 93.330485] EXT4-fs (mmcblk0): recovery complete
[ 93.335180] EXT4-fs (mmcblk0): mounted filesystem with ordered data mode. Opts: (null)
[ 94.533007] CPU 2 Unable to handle kernel paging request at virtual address 00000000, epc == 8f72a4ac, ra == 8f72a480
[ 94.543650] Oops[#1]:
[ 94.545920] CPU: 2 PID: 443 Comm: mmcqd/0 Not tainted 4.9.77 #0
[ 94.551811] task: 8feaf580 task.stack: 8f604000
[ 94.556315] $ 0 : 00000000 80550008 00000080 8057a258
[ 94.561533] $ 4 : 8057a268 00000001 ffffb0b2 814a84a8
[ 94.566752] $ 8 : 00000110 00007c00 00000000 00000000
[ 94.571967] $12 : 0000049a ffffffff 00000000 00000081
[ 94.577181] $16 : 8fe6d000 8fe6dd0c be130000 be130000
[ 94.582400] $20 : 8f79c000 00000000 00001000 8fe6d240
[ 94.587615] $24 : 00000000 8005800c
[ 94.592834] $28 : 8f604000 8f605c40 8fe6dc34 8f72a480
[ 94.598049] Hi : 00000007
[ 94.600910] Lo : 00000001
[ 94.603801] epc : 8f72a4ac 0x8f72a4ac
[ 94.607619] ra : 8f72a480 0x8f72a480
[ 94.611429] Status: 11007c03 KERNEL EXL IE
[ 94.615604] Cause : 40800008 (ExcCode 02)
[ 94.619588] BadVA : 00000000
[ 94.622454] PrId : 0001992f (MIPS 1004Kc)
[ 94.626525] Modules linked in: pppoe ppp_async pppox ppp_generic nf_conntrack_ipv6 mt76x2e mt7603e mt76 mac80211 iptable_nat ipt_REJECT ipt_MASQUERADE cfg80211 xt_time xt_tcpudp xt_state xt_nat xt_multiport xt_mark xt_mac xt_limit xt_conntrack xt_comment xt_TCPMSS xt_REDIRECT xt_LOG xt_CT slhc nf_reject_ipv4 nf_nat_redirect nf_nat_masquerade_ipv4 nf_conntrack_ipv4 nf_nat_ipv4 nf_nat nf_log_ipv4 nf_defrag_ipv6 nf_defrag_ipv4 nf_conntrack_rtcache nf_conntrack iptable_mangle iptable_filter ip_tables crc_ccitt compat ledtrig_usbport ip6t_REJECT nf_reject_ipv6 nf_log_ipv6 nf_log_common ip6table_mangle ip6table_filter ip6_tables x_tables f2fs ext4 jbd2 mbcache crc32c_generic crc32_generic mmc_block mtk_sd mmc_core leds_gpio xhci_mtk xhci_plat_hcd xhci_pci xhci_hcd ahci libahci libata sd_mod scsi_mod gpio_button_hotplug
[ 94.698342] usbcore nls_base usb_common
Process mmcqd/0 (pid: 443, threadinfo=8f604000, task=8feaf580, tls=00000000)
[ 94.707710] Stack : 814b5c80 8054ec80 00000000 8004d598 00000000 8f605c54 00000010 00000000
[ 94.716059] 00000000 00000000 8fe6d800 00000000 0000007d ffffb0b2 804f0000 8fe6dd1c
[ 94.724406] 00000000 00100000 01000000 80063b4c 00000001 00000000 8f605e24 80063620
[ 94.732751] 804e880c 80063584 8fe6d000 8fe6dc34 8fe6dc34 00000000 00000000 8f605e24
[ 94.741094] 8f64b270 805541a4 8f64c000 8f72a850 00001000 80063620 00000000 0000049a
[ 94.749442] ...
[ 94.751886] Call Trace:
[ 94.754322] [] 0x8f72a4ac
[ 94.757795] Code: 14400009 8fa60034 26a20080 26b50004 ae430018 1455fffc 00000000 26d6ff80
[ 94.767536]
[ 94.769507] ---[ end trace 185ac8575f4af9a9 ]---
More information can be found at the following URL:
https://bugs.lede-project.org/index.php?do=details&task_id=1335
More information about the lede-bugs
mailing list