ds_shadof:

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