Problems with OpenWrt LTE driver adaptation

fangxu1999 · May 3, 2022, 4:29pm

Hello, everyone.

I tried to use the MeiG SLM730 LTE module to openwrt.

I use the latest v21.02.3 version openwrt.

I added usb-modeswitch, kmod-mii, kmod-usb-net, kmod-usb-wdm, kmod-usb-net-qmi-wwan, uqmi, kmod-usb-serial-option, kmod-usb-serial, kmod-usb-serial-wwan, luci, luci-proto-qmi and modified the following files:

net/usb/qmi_wwan.c
usb/serial/option.c
usb/serial/usb_wwan.c

But it has been unable to dial successfully, only TX has data sent, RX is always 0.

The device has already be recognized successfully.

root@OpenWrt:~# lsusb -t
/:  Bus 02.Port 1: Dev 1, Class=root_hub, Driver=ohci-platform/1p, 12M
/:  Bus 01.Port 1: Dev 1, Class=root_hub, Driver=ehci-platform/1p, 480M
    |__ Port 1: Dev 2, If 0, Class=, Driver=hub/4p, 480M
        |__ Port 2: Dev 3, If 0, Class=, Driver=option, 480M
        |__ Port 2: Dev 3, If 1, Class=, Driver=option, 480M
        |__ Port 2: Dev 3, If 2, Class=, Driver=option, 480M
        |__ Port 2: Dev 3, If 3, Class=, Driver=option, 480M
        |__ Port 2: Dev 3, If 4, Class=, Driver=, 480M
        |__ Port 2: Dev 3, If 5, Class=, Driver=qmi_wwan, 480M

Here is the output of dmesg:

root@OpenWrt:~# dmesg
[    0.000000] Linux version 5.4.188 (xu@xu-virtual-machine) (gcc version 8.4.0 (OpenWrt GCC 8.4.0 r16554-1d4dea6d4f)) #0 Sat Apr 16 12:59:34 2022
[    0.000000] Board has DDR2
[    0.000000] Analog PMU set to hw control
[    0.000000] Digital PMU set to hw control
[    0.000000] SoC Type: MediaTek MT7620A ver:2 eco:6
[    0.000000] printk: bootconsole [early0] enabled
[    0.000000] CPU0 revision is: 00019650 (MIPS 24KEc)
[    0.000000] MIPS: machine is Asus RT-AC51U
[    0.000000] Initrd not found or empty - disabling initrd
[    0.000000] Primary instruction cache 64kB, VIPT, 4-way, linesize 32 bytes.
[    0.000000] Primary data cache 32kB, 4-way, PIPT, no aliases, linesize 32 bytes
[    0.000000] Zone ranges:
[    0.000000]   Normal   [mem 0x0000000000000000-0x0000000007ffffff]
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000000000000-0x0000000007ffffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x0000000007ffffff]
[    0.000000] On node 0 totalpages: 32768
[    0.000000]   Normal zone: 288 pages used for memmap
[    0.000000]   Normal zone: 0 pages reserved
[    0.000000]   Normal zone: 32768 pages, LIFO batch:7
[    0.000000] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
[    0.000000] pcpu-alloc: [0] 0
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 32480
[    0.000000] Kernel command line: console=ttyS0,57600 rootfstype=squashfs,jffs2
[    0.000000] Dentry cache hash table entries: 16384 (order: 4, 65536 bytes, linear)
[    0.000000] Inode-cache hash table entries: 8192 (order: 3, 32768 bytes, linear)
[    0.000000] Writing ErrCtl register=00035bf1
[    0.000000] Readback ErrCtl register=00035bf1
[    0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
[    0.000000] Memory: 122288K/131072K available (4745K kernel code, 206K rwdata, 1048K rodata, 1224K init, 205K bss, 8784K reserved, 0K cma-reserved)
[    0.000000] SLUB: HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[    0.000000] NR_IRQS: 256
[    0.000000] random: get_random_bytes called from start_kernel+0x358/0x54c with crng_init=0
[    0.000000] CPU Clock: 580MHz
[    0.000000] clocksource: systick: mask: 0xffff max_cycles: 0xffff, max_idle_ns: 583261500 ns
[    0.000000] systick: enable autosleep mode
[    0.000000] systick: running - mult: 214748, shift: 32
[    0.000000] clocksource: MIPS: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 6590553264 ns
[    0.000010] sched_clock: 32 bits at 290MHz, resolution 3ns, wraps every 7405115902ns
[    0.007611] Calibrating delay loop... 385.02 BogoMIPS (lpj=770048)
[    0.045493] pid_max: default: 32768 minimum: 301
[    0.050185] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes, linear)
[    0.057240] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes, linear)
[    0.071776] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[    0.081258] futex hash table entries: 256 (order: -1, 3072 bytes, linear)
[    0.087942] pinctrl core: initialized pinctrl subsystem
[    0.093612] NET: Registered protocol family 16
[    0.474655] mt7620-pci 10140000.pcie: PCIE0 no card, disable it(RST&CLK)
[    0.481162] mt7620-pci: probe of 10140000.pcie failed with error -1
[    0.510746] rt2880_gpio 10000600.gpio: registering 24 gpios
[    0.516229] rt2880_gpio 10000600.gpio: registering 24 irq handlers
[    0.522244] GPIO line 10 (enable-leds) hogged as output/low
[    0.527990] rt2880_gpio 10000688.gpio: registering 1 gpios
[    0.533337] rt2880_gpio 10000688.gpio: registering 1 irq handlers
[    0.544501] clocksource: Switched to clocksource systick
[    0.551104] NET: Registered protocol family 2
[    0.555548] IP idents hash table entries: 2048 (order: 2, 16384 bytes, linear)
[    0.563304] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 4096 bytes, linear)
[    0.571455] TCP established hash table entries: 1024 (order: 0, 4096 bytes, linear)
[    0.578865] TCP bind hash table entries: 1024 (order: 0, 4096 bytes, linear)
[    0.585705] TCP: Hash tables configured (established 1024 bind 1024)
[    0.592020] UDP hash table entries: 256 (order: 0, 4096 bytes, linear)
[    0.598370] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes, linear)
[    0.605409] NET: Registered protocol family 1
[    0.609655] PCI: CLS 0 bytes, default 32
[    0.616407] rt-timer 10000100.timer: maximum frequency is 1220Hz
[    0.624774] workingset: timestamp_bits=14 max_order=15 bucket_order=1
[    0.639628] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    0.645300] jffs2: version 2.2 (NAND) (SUMMARY) (LZMA) (RTIME) (CMODE_PRIORITY) (c) 2001-2006 Red Hat, Inc.
[    0.673582] Serial: 8250/16550 driver, 2 ports, IRQ sharing disabled
[    0.681013] printk: console [ttyS0] disabled
[    0.685220] 10000c00.uartlite: ttyS0 at MMIO 0x10000c00 (irq = 20, base_baud = 2500000) is a Palmchip BK-3103
[    0.694838] printk: console [ttyS0] enabled
[    0.711374] printk: bootconsole [early0] disabled
[    0.736465] spi spi0.0: force spi mode3
[    0.755771] spi-nor spi0.0: w25q128 (16384 Kbytes)
[    0.765400] 4 fixed-partitions partitions found on MTD device spi0.0
[    0.778065] Creating 4 MTD partitions on "spi0.0":
[    0.787625] 0x000000000000-0x000000030000 : "u-boot"
[    0.798620] 0x000000030000-0x000000040000 : "u-boot-env"
[    0.810317] 0x000000040000-0x000000050000 : "factory"
[    0.821535] 0x000000050000-0x000001000000 : "firmware"
[    0.836226] 2 uimage-fw partitions found on MTD device firmware
[    0.848103] Creating 2 MTD partitions on "firmware":
[    0.858012] 0x000000000000-0x0000001e828c : "kernel"
[    0.869101] 0x0000001e828c-0x000000fb0000 : "rootfs"
[    0.880012] mtd: device 5 (rootfs) set to be root filesystem
[    0.893263] 1 squashfs-split partitions found on MTD device rootfs
[    0.905655] 0x00000056d000-0x000000fb0000 : "rootfs_data"
[    0.928631] gsw: setting port4 to ephy mode
[    0.937039] mtk_soc_eth 10100000.ethernet eth0 (uninitialized): port 3 link up (100Mbps/Full duplex)
[    0.955759] mtk_soc_eth 10100000.ethernet: loaded mt7620 driver
[    0.968361] mtk_soc_eth 10100000.ethernet eth0: mediatek frame engine at 0xb0100000, irq 5
[    0.985429] rt2880_wdt 10000120.watchdog: Initialized
[    0.997153] NET: Registered protocol family 10
[    1.010488] Segment Routing with IPv6
[    1.018010] NET: Registered protocol family 17
[    1.026942] 8021q: 802.1Q VLAN Support v1.8
[    1.044632] VFS: Mounted root (squashfs filesystem) readonly on device 31:5.
[    1.065693] Freeing unused kernel memory: 1224K
[    1.074737] This architecture does not have kernel memory protection.
[    1.087570] Run /sbin/init as init process
[    1.376461] random: fast init done
[    1.986622] init: Console is alive
[    1.993833] init: - watchdog -
[    3.420622] kmodloader: loading kernel modules from /etc/modules-boot.d/*
[    3.635304] usbcore: registered new interface driver usbfs
[    3.646413] usbcore: registered new interface driver hub
[    3.657139] usbcore: registered new device driver usb
[    3.674675] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    3.689736] ehci-fsl: Freescale EHCI Host controller driver
[    3.702634] ehci-platform: EHCI generic platform driver
[    3.723451] phy phy-usbphy.0: remote usb device wakeup disabled
[    3.735261] phy phy-usbphy.0: UTMI 16bit 30MHz
[    3.744124] ehci-platform 101c0000.ehci: EHCI Host Controller
[    3.755613] ehci-platform 101c0000.ehci: new USB bus registered, assigned bus number 1
[    3.771544] ehci-platform 101c0000.ehci: irq 26, io mem 0x101c0000
[    3.788422] ehci-platform 101c0000.ehci: USB 2.0 started, EHCI 1.00
[    3.801994] hub 1-0:1.0: USB hub found
[    3.809990] hub 1-0:1.0: 1 port detected
[    3.823568] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[    3.837841] ohci-platform: OHCI generic platform driver
[    3.848666] ohci-platform 101c1000.ohci: Generic Platform OHCI controller
[    3.862262] ohci-platform 101c1000.ohci: new USB bus registered, assigned bus number 2
[    3.878194] ohci-platform 101c1000.ohci: irq 26, io mem 0x101c1000
[    3.915374] hub 2-0:1.0: USB hub found
[    3.923373] hub 2-0:1.0: 1 port detected
[    3.936495] kmodloader: done loading kernel modules from /etc/modules-boot.d/*
[    3.955358] init: - preinit -
[    4.080508] usb 1-1: new high-speed USB device number 2 using ehci-platform
[    4.668805] hub 1-1:1.0: USB hub found
[    4.768271] hub 1-1:1.0: 4 ports detected
[    4.848520] random: procd: uninitialized urandom read (4 bytes read)
[    5.231629] usb 1-1.2: new high-speed USB device number 3 using ehci-platform
[    5.251938] random: jshn: uninitialized urandom read (4 bytes read)
[    5.431566] random: jshn: uninitialized urandom read (4 bytes read)
[    5.916295] urandom_read: 4 callbacks suppressed
[    5.916304] random: jshn: uninitialized urandom read (4 bytes read)
[    6.396876] 8021q: adding VLAN 0 to HW filter on device eth0
[    8.040037] mount_root: jffs2 not ready yet, using temporary tmpfs overlay
[    8.058390] urandom-seed: Seed file not found (/etc/urandom.seed)
[    8.181039] procd: - early -
[    8.187091] procd: - watchdog -
[    8.847980] random: jshn: uninitialized urandom read (4 bytes read)
[    8.948155] procd: - watchdog -
[    8.955179] procd: - ubus -
[    9.185351] random: ubusd: uninitialized urandom read (4 bytes read)
[    9.221234] procd: - init -
[   11.701987] kmodloader: loading kernel modules from /etc/modules.d/*
[   11.988760] usbcore: registered new interface driver cdc_wdm
[   12.017931] Loading modules backported from Linux version v5.10.110-0-g3238bffaf992
[   12.033279] Backport generated by backports.git v5.10.110-1-0-g1fbde860
[   12.113347] usbcore: registered new interface driver usbserial_generic
[   12.126509] usbserial: USB Serial support registered for generic
[   12.193556] xt_time: kernel timezone is -0000
[   12.239731] urngd: jent-rng init failed, err: 2
[   12.401783] PPP generic driver version 2.4.2
[   12.413893] NET: Registered protocol family 24
[   12.426633] qmi_wwan 1-1.2:1.5: work on RawIP mode
[   12.437478] qmi_wwan 1-1.2:1.5: cdc-wdm0: USB WDM device
[   12.449206] qmi_wwan 1-1.2:1.5 wwan0: register 'qmi_wwan' at usb-101c0000.ehci-1.2, WWAN/QMI device, 7a:a8:ae:e9:6e:86
[   12.470905] usbcore: registered new interface driver qmi_wwan
[   12.627036] usbcore: registered new interface driver option
[   12.638338] usbserial: USB Serial support registered for GSM modem (1-port)
[   12.652833] option 1-1.2:1.0: GSM modem (1-port) converter detected
[   12.665686] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB0
[   12.679853] option 1-1.2:1.1: GSM modem (1-port) converter detected
[   12.692748] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB1
[   12.706902] option 1-1.2:1.2: GSM modem (1-port) converter detected
[   12.719824] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB2
[   12.733958] option 1-1.2:1.3: GSM modem (1-port) converter detected
[   12.746833] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB3
[   12.943757] rt2800_wmac 10180000.wmac: loaded eeprom from mtd device "factory"
[   12.958194] ieee80211 phy0: rt2x00_set_rt: Info - RT chipset 6352, rev 0500 detected
[   12.973669] ieee80211 phy0: rt2x00_set_rf: Info - RF chipset 7620 detected
[   12.987503] ieee80211 phy0: Selected rate control algorithm 'minstrel_ht'
[   13.031948] kmodloader: done loading kernel modules from /etc/modules.d/*
[   24.722303] crng init done
[   46.735943] jffs2_scan_eraseblock(): End of filesystem marker found at 0x0
[   46.779026] jffs2_build_filesystem(): unlocking the mtd device...
[   46.779981] done.
[   46.796204] jffs2_build_filesystem(): erasing all blocks after the end marker...
[   48.934666] 8021q: adding VLAN 0 to HW filter on device eth0
[   49.060777] br-lan: port 1(eth0.1) entered blocking state
[   49.071639] br-lan: port 1(eth0.1) entered disabled state
[   49.082849] device eth0.1 entered promiscuous mode
[   49.092455] device eth0 entered promiscuous mode
[   49.237050] br-lan: port 1(eth0.1) entered blocking state
[   49.247889] br-lan: port 1(eth0.1) entered forwarding state
[   49.938878] IPv6: ADDRCONF(NETDEV_CHANGE): br-lan: link becomes ready
[  293.242138] done.
[  293.246035] jffs2: notice: (2443) jffs2_build_xattr_subsystem: complete building xattr subsystem, 0 of xdatum (0 unchecked, 0 orphan) and 0 of xref (0 dead, 0 orphan) found.
[  293.495834] overlayfs: upper fs does not support tmpfile.

This is a screenshot of the network interface

The modified driver code is attached, please refer to

drivers.zip

Please excuse my English writing. English is not my first language.

After two weeks of research, I have not found a solution.

Please give me some pointers. Thank you!

bmork · May 3, 2022, 4:42pm

The driver in OpenWrt will never print anything like that. You should contact whoever gave you that driver for support.

fangxu1999 · May 3, 2022, 5:17pm

Thank you for your reply.

This code is what I searched for a lot of information on the Internet and added it by myself.

The purpose is to be patched to support Raw IP mode.

in drivers/net/usb/qmi_wwan.c
add qmi_wwan_tx_fixup and modify qmi_wwan_bind for rawIP mode mainly

$ diff -u qmi_wwan.c qmi_wwan.c.old
--- qmi_wwan.c  2022-04-27 16:08:24.983174400 +0800
+++ qmi_wwan.c.old      2022-03-28 14:46:49.000000000 +0800
@@ -579,24 +579,6 @@
        return 1;
 }

-struct sk_buff *qmi_wwan_tx_fixup(struct usbnet *dev, struct sk_buff *skb,
-                                  gfp_t flags) {
-  if (dev->udev->descriptor.idVendor != cpu_to_le16(0x05C6))
-    return skb;
-
-  // Skip Ethernet header from message
-  if (skb_pull(skb, ETH_HLEN)) {
-    return skb;
-  } else {
-    dev_err(&dev->intf->dev, "Packet Dropped ");
-  }
-
-  // Filter the packet out, release it
-  dev_kfree_skb_any(skb);
-
-  return NULL;
-}
-
 /* very simplistic detection of IPv4 or IPv6 headers */
 static bool possibly_iphdr(const char *data)
 {
@@ -745,19 +727,6 @@
        cdc_union = hdr.usb_cdc_union_desc;
        cdc_ether = hdr.usb_cdc_ether_desc;

-       if (dev->udev->descriptor.idVendor == cpu_to_le16(0x05C6)) {
-
-               dev_info(&intf->dev, "work on RawIP mode\n");
-               dev->net->flags |= IFF_NOARP;
-               usb_control_msg(interface_to_usbdev(intf),
-                                               usb_sndctrlpipe(interface_to_usbdev(intf), 0),
-                                               0x22, // USB_CDC_REQ_SET_CONTROL_LINE_STATE
-                                               0x21, // USB_DIR_OUT | USB_TYPE_CLASS | USB_RECIP_INTERFACE
-                                               1,    // active CDC DTR
-                                               intf->cur_altsetting->desc.bInterfaceNumber, NULL, 0, 100);
-       }
-
-
        /* Use separate control and data interfaces if we found a CDC Union */
        if (cdc_union) {
                info->data = usb_ifnum_to_if(dev->udev,
@@ -923,7 +892,6 @@
        .unbind         = qmi_wwan_unbind,
        .manage_power   = qmi_wwan_manage_power,
        .rx_fixup       = qmi_wwan_rx_fixup,
-       .tx_fixup               = qmi_wwan_tx_fixup,
 };

 static const struct driver_info        qmi_wwan_info_quirk_dtr = {
@@ -933,7 +901,6 @@
        .unbind         = qmi_wwan_unbind,
        .manage_power   = qmi_wwan_manage_power,
        .rx_fixup       = qmi_wwan_rx_fixup,
-       .tx_fixup               = qmi_wwan_tx_fixup,
        .data           = QMI_WWAN_QUIRK_DTR,
 };

@@ -971,8 +938,6 @@
        .driver_info = (unsigned long)&qmi_wwan_info_quirk_dtr

 static const struct usb_device_id products[] = {
-    { QMI_FIXED_INTF(0x05C6, 0xF601, 5) },
-
        /* 1. CDC ECM like devices match on the control interface */
        {       /* Huawei E392, E398 and possibly others sharing both device id and more... */
                USB_VENDOR_AND_INTERFACE_INFO(HUAWEI_VENDOR_ID, USB_CLASS_VENDOR_SPEC, 1, 9),

in drivers/usb/serial

$ diff -u option.c option.c.old
--- option.c    2022-04-27 13:49:58.347566300 +0800
+++ option.c.old        2022-03-28 14:46:49.000000000 +0800
@@ -587,7 +587,6 @@


 static const struct usb_device_id option_ids[] = {
-       { USB_DEVICE(0x05C6, 0xF601) },
        { USB_DEVICE(OPTION_VENDOR_ID, OPTION_PRODUCT_COLT) },
        { USB_DEVICE(OPTION_VENDOR_ID, OPTION_PRODUCT_RICOLA) },
        { USB_DEVICE(OPTION_VENDOR_ID, OPTION_PRODUCT_RICOLA_LIGHT) },
@@ -2161,7 +2160,6 @@
 #ifdef CONFIG_PM
        .suspend           = usb_wwan_suspend,
        .resume            = usb_wwan_resume,
-       .reset_resume      = usb_wwan_resume,
 #endif
 };

@@ -2205,12 +2203,6 @@
        if (device_flags & NUMEP2 && iface_desc->bNumEndpoints != 2)
                return -ENODEV;

-       if (serial->dev->descriptor.idVendor == cpu_to_le16(0x05C6) &&
-               serial->dev->descriptor.idProduct == cpu_to_le16(0xF601) &&
-               serial->interface->cur_altsetting->desc.bInterfaceNumber >= 4)
-               return -ENODEV;
-
-
        /* Store the device flags so we can use them during attach. */
        usb_set_serial_data(serial, (void *)device_flags);

modify usb_wwan_setup_urb for zero packet

$ diff -u usb_wwan.c usb_wwan.c.old
--- usb_wwan.c  2022-04-27 09:11:46.493804500 +0800
+++ usb_wwan.c.old      2022-03-28 14:46:49.000000000 +0800
@@ -480,15 +480,6 @@
        if (intfdata->use_zlp && dir == USB_DIR_OUT)
                urb->transfer_flags |= URB_ZERO_PACKET;

-       if (dir == USB_DIR_OUT) {
-               struct usb_device_descriptor *desc = &serial->dev->descriptor;
-
-               if (desc->idVendor == cpu_to_le16(0x05C6) &&
-                       desc->idProduct == cpu_to_le16(0xF601))
-                       urb->transfer_flags |= URB_ZERO_PACKET;
-       }
-
-
        return urb;
 }

Where is wrong?

bmork · May 3, 2022, 8:54pm

The driver already supports that, just not in the stupid broken way.

fangxu1999 · May 4, 2022, 12:55am

I removed the relevant code and only kept the following parts:

in /usb/serial/option.c

$ diff -u option.c option.c.old
--- option.c    2022-05-04 08:32:28.581805800 +0800
+++ option.c.old        2022-03-28 14:46:49.000000000 +0800
@@ -587,7 +587,6 @@


 static const struct usb_device_id option_ids[] = {
-       { USB_DEVICE(0x05C6, 0xF601) },
        { USB_DEVICE(OPTION_VENDOR_ID, OPTION_PRODUCT_COLT) },
        { USB_DEVICE(OPTION_VENDOR_ID, OPTION_PRODUCT_RICOLA) },
        { USB_DEVICE(OPTION_VENDOR_ID, OPTION_PRODUCT_RICOLA_LIGHT) },
@@ -2161,7 +2160,6 @@
 #ifdef CONFIG_PM
        .suspend           = usb_wwan_suspend,
        .resume            = usb_wwan_resume,
-       .reset_resume      = usb_wwan_resume,
 #endif
 };

@@ -2205,12 +2203,6 @@
        if (device_flags & NUMEP2 && iface_desc->bNumEndpoints != 2)
                return -ENODEV;

-       if (serial->dev->descriptor.idVendor == cpu_to_le16(0x05C6) &&
-               serial->dev->descriptor.idProduct == cpu_to_le16(0xF601) &&
-               serial->interface->cur_altsetting->desc.bInterfaceNumber >= 4)
-               return -ENODEV;
-
-
        /* Store the device flags so we can use them during attach. */
        usb_set_serial_data(serial, (void *)device_flags);

in net/usb/qmi_wwan.c

$ diff -u qmi_wwan.c qmi_wwan.c.old
--- qmi_wwan.c  2022-05-04 08:30:27.985530600 +0800
+++ qmi_wwan.c.old      2022-03-28 14:46:49.000000000 +0800
@@ -938,8 +938,6 @@
        .driver_info = (unsigned long)&qmi_wwan_info_quirk_dtr

 static const struct usb_device_id products[] = {
-    { QMI_FIXED_INTF(0x05C6, 0xF601, 5) },
-
        /* 1. CDC ECM like devices match on the control interface */
        {       /* Huawei E392, E398 and possibly others sharing both device id and more... */
                USB_VENDOR_AND_INTERFACE_INFO(HUAWEI_VENDOR_ID, USB_CLASS_VENDOR_SPEC, 1, 9),

After recompiling, TX and RX have no data.

This is the kernel log:

[    0.000000] Linux version 5.4.188 (xu@xu-virtual-machine) (gcc version 8.4.0 (OpenWrt GCC 8.4.0 r16554-1d4dea6d4f)) #0 Sat Apr 16 12:59:34 2022
[    0.000000] Board has DDR2
[    0.000000] Analog PMU set to hw control
[    0.000000] Digital PMU set to hw control
[    0.000000] SoC Type: MediaTek MT7620A ver:2 eco:6
[    0.000000] printk: bootconsole [early0] enabled
[    0.000000] CPU0 revision is: 00019650 (MIPS 24KEc)
[    0.000000] MIPS: machine is Asus RT-AC51U
[    0.000000] Initrd not found or empty - disabling initrd
[    0.000000] Primary instruction cache 64kB, VIPT, 4-way, linesize 32 bytes.
[    0.000000] Primary data cache 32kB, 4-way, PIPT, no aliases, linesize 32 bytes
[    0.000000] Zone ranges:
[    0.000000]   Normal   [mem 0x0000000000000000-0x0000000007ffffff]
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000000000000-0x0000000007ffffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x0000000007ffffff]
[    0.000000] On node 0 totalpages: 32768
[    0.000000]   Normal zone: 288 pages used for memmap
[    0.000000]   Normal zone: 0 pages reserved
[    0.000000]   Normal zone: 32768 pages, LIFO batch:7
[    0.000000] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
[    0.000000] pcpu-alloc: [0] 0 
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 32480
[    0.000000] Kernel command line: console=ttyS0,57600 rootfstype=squashfs,jffs2
[    0.000000] Dentry cache hash table entries: 16384 (order: 4, 65536 bytes, linear)
[    0.000000] Inode-cache hash table entries: 8192 (order: 3, 32768 bytes, linear)
[    0.000000] Writing ErrCtl register=0007e001
[    0.000000] Readback ErrCtl register=0007e001
[    0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
[    0.000000] Memory: 122288K/131072K available (4745K kernel code, 206K rwdata, 1048K rodata, 1224K init, 205K bss, 8784K reserved, 0K cma-reserved)
[    0.000000] SLUB: HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[    0.000000] NR_IRQS: 256
[    0.000000] random: get_random_bytes called from start_kernel+0x358/0x54c with crng_init=0
[    0.000000] CPU Clock: 580MHz
[    0.000000] clocksource: systick: mask: 0xffff max_cycles: 0xffff, max_idle_ns: 583261500 ns
[    0.000000] systick: enable autosleep mode
[    0.000000] systick: running - mult: 214748, shift: 32
[    0.000000] clocksource: MIPS: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 6590553264 ns
[    0.000010] sched_clock: 32 bits at 290MHz, resolution 3ns, wraps every 7405115902ns
[    0.007611] Calibrating delay loop... 385.02 BogoMIPS (lpj=770048)
[    0.045501] pid_max: default: 32768 minimum: 301
[    0.050193] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes, linear)
[    0.057247] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes, linear)
[    0.071784] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[    0.081266] futex hash table entries: 256 (order: -1, 3072 bytes, linear)
[    0.087950] pinctrl core: initialized pinctrl subsystem
[    0.093621] NET: Registered protocol family 16
[    0.570451] mt7620-pci 10140000.pcie: PCIE0 no card, disable it(RST&CLK)
[    0.576959] mt7620-pci: probe of 10140000.pcie failed with error -1
[    0.606541] rt2880_gpio 10000600.gpio: registering 24 gpios
[    0.612024] rt2880_gpio 10000600.gpio: registering 24 irq handlers
[    0.618039] GPIO line 10 (enable-leds) hogged as output/low
[    0.623785] rt2880_gpio 10000688.gpio: registering 1 gpios
[    0.629132] rt2880_gpio 10000688.gpio: registering 1 irq handlers
[    0.640300] clocksource: Switched to clocksource systick
[    0.646905] NET: Registered protocol family 2
[    0.651348] IP idents hash table entries: 2048 (order: 2, 16384 bytes, linear)
[    0.659105] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 4096 bytes, linear)
[    0.667256] TCP established hash table entries: 1024 (order: 0, 4096 bytes, linear)
[    0.674666] TCP bind hash table entries: 1024 (order: 0, 4096 bytes, linear)
[    0.681506] TCP: Hash tables configured (established 1024 bind 1024)
[    0.687821] UDP hash table entries: 256 (order: 0, 4096 bytes, linear)
[    0.694172] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes, linear)
[    0.701210] NET: Registered protocol family 1
[    0.705456] PCI: CLS 0 bytes, default 32
[    0.712208] rt-timer 10000100.timer: maximum frequency is 1220Hz
[    0.720576] workingset: timestamp_bits=14 max_order=15 bucket_order=1
[    0.735431] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    0.741103] jffs2: version 2.2 (NAND) (SUMMARY) (LZMA) (RTIME) (CMODE_PRIORITY) (c) 2001-2006 Red Hat, Inc.
[    0.769325] Serial: 8250/16550 driver, 2 ports, IRQ sharing disabled
[    0.776752] printk: console [ttyS0] disabled
[    0.780960] 10000c00.uartlite: ttyS0 at MMIO 0x10000c00 (irq = 20, base_baud = 2500000) is a Palmchip BK-3103
[    0.790578] printk: console [ttyS0] enabled
[    0.807113] printk: bootconsole [early0] disabled
[    0.832359] spi spi0.0: force spi mode3
[    0.851570] spi-nor spi0.0: w25q128 (16384 Kbytes)
[    0.861198] 4 fixed-partitions partitions found on MTD device spi0.0
[    0.873865] Creating 4 MTD partitions on "spi0.0":
[    0.883423] 0x000000000000-0x000000030000 : "u-boot"
[    0.894422] 0x000000030000-0x000000040000 : "u-boot-env"
[    0.906117] 0x000000040000-0x000000050000 : "factory"
[    0.917335] 0x000000050000-0x000001000000 : "firmware"
[    0.932022] 2 uimage-fw partitions found on MTD device firmware
[    0.943900] Creating 2 MTD partitions on "firmware":
[    0.953809] 0x000000000000-0x0000001e828c : "kernel"
[    0.964902] 0x0000001e828c-0x000000fb0000 : "rootfs"
[    0.975812] mtd: device 5 (rootfs) set to be root filesystem
[    0.989061] 1 squashfs-split partitions found on MTD device rootfs
[    1.001453] 0x00000056d000-0x000000fb0000 : "rootfs_data"
[    1.024438] gsw: setting port4 to ephy mode
[    1.032846] mtk_soc_eth 10100000.ethernet eth0 (uninitialized): port 3 link up (100Mbps/Full duplex)
[    1.051564] mtk_soc_eth 10100000.ethernet: loaded mt7620 driver
[    1.064164] mtk_soc_eth 10100000.ethernet eth0: mediatek frame engine at 0xb0100000, irq 5
[    1.081232] rt2880_wdt 10000120.watchdog: Initialized
[    1.092958] NET: Registered protocol family 10
[    1.106288] Segment Routing with IPv6
[    1.113810] NET: Registered protocol family 17
[    1.122743] 8021q: 802.1Q VLAN Support v1.8
[    1.139687] VFS: Mounted root (squashfs filesystem) readonly on device 31:5.
[    1.160794] Freeing unused kernel memory: 1224K
[    1.169840] This architecture does not have kernel memory protection.
[    1.182673] Run /sbin/init as init process
[    1.476240] random: fast init done
[    2.082168] init: Console is alive
[    2.089381] init: - watchdog -
[    3.514830] kmodloader: loading kernel modules from /etc/modules-boot.d/*
[    3.729029] usbcore: registered new interface driver usbfs
[    3.740116] usbcore: registered new interface driver hub
[    3.750844] usbcore: registered new device driver usb
[    3.768199] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    3.783218] ehci-fsl: Freescale EHCI Host controller driver
[    3.796124] ehci-platform: EHCI generic platform driver
[    3.816953] phy phy-usbphy.0: remote usb device wakeup disabled
[    3.828764] phy phy-usbphy.0: UTMI 16bit 30MHz
[    3.837629] ehci-platform 101c0000.ehci: EHCI Host Controller
[    3.849117] ehci-platform 101c0000.ehci: new USB bus registered, assigned bus number 1
[    3.865049] ehci-platform 101c0000.ehci: irq 26, io mem 0x101c0000
[    3.882684] ehci-platform 101c0000.ehci: USB 2.0 started, EHCI 1.00
[    3.896256] hub 1-0:1.0: USB hub found
[    3.904251] hub 1-0:1.0: 1 port detected
[    3.917846] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[    3.932121] ohci-platform: OHCI generic platform driver
[    3.942945] ohci-platform 101c1000.ohci: Generic Platform OHCI controller
[    3.956539] ohci-platform 101c1000.ohci: new USB bus registered, assigned bus number 2
[    3.972475] ohci-platform 101c1000.ohci: irq 26, io mem 0x101c1000
[    4.009643] hub 2-0:1.0: USB hub found
[    4.017641] hub 2-0:1.0: 1 port detected
[    4.030763] kmodloader: done loading kernel modules from /etc/modules-boot.d/*
[    4.049623] init: - preinit -
[    4.174544] usb 1-1: new high-speed USB device number 2 using ehci-platform
[    4.762864] hub 1-1:1.0: USB hub found
[    4.862540] hub 1-1:1.0: 4 ports detected
[    4.938819] random: procd: uninitialized urandom read (4 bytes read)
[    5.324970] usb 1-1.2: new high-speed USB device number 3 using ehci-platform
[    5.345314] random: jshn: uninitialized urandom read (4 bytes read)
[    5.525206] random: jshn: uninitialized urandom read (4 bytes read)
[    6.008075] urandom_read: 4 callbacks suppressed
[    6.008085] random: jshn: uninitialized urandom read (4 bytes read)
[    6.486267] 8021q: adding VLAN 0 to HW filter on device eth0
[    8.129681] mount_root: jffs2 not ready yet, using temporary tmpfs overlay
[    8.148046] urandom-seed: Seed file not found (/etc/urandom.seed)
[    8.270687] procd: - early -
[    8.276742] procd: - watchdog -
[    8.937943] random: jshn: uninitialized urandom read (4 bytes read)
[    9.038235] procd: - watchdog -
[    9.045257] procd: - ubus -
[    9.275005] random: ubusd: uninitialized urandom read (4 bytes read)
[    9.312455] procd: - init -
[   11.815241] kmodloader: loading kernel modules from /etc/modules.d/*
[   12.094057] usbcore: registered new interface driver cdc_wdm
[   12.123593] Loading modules backported from Linux version v5.10.110-0-g3238bffaf992
[   12.138935] Backport generated by backports.git v5.10.110-1-0-g1fbde860
[   12.218542] usbcore: registered new interface driver usbserial_generic
[   12.231738] usbserial: USB Serial support registered for generic
[   12.299628] xt_time: kernel timezone is -0000
[   12.316466] urngd: jent-rng init failed, err: 2
[   12.491931] PPP generic driver version 2.4.2
[   12.503724] NET: Registered protocol family 24
[   12.517069] qmi_wwan 1-1.2:1.5: cdc-wdm0: USB WDM device
[   12.528849] qmi_wwan 1-1.2:1.5 wwan0: register 'qmi_wwan' at usb-101c0000.ehci-1.2, WWAN/QMI device, f2:0b:c9:73:6f:24
[   12.550504] usbcore: registered new interface driver qmi_wwan
[   12.707375] usbcore: registered new interface driver option
[   12.718679] usbserial: USB Serial support registered for GSM modem (1-port)
[   12.733182] option 1-1.2:1.0: GSM modem (1-port) converter detected
[   12.746035] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB0
[   12.760184] option 1-1.2:1.1: GSM modem (1-port) converter detected
[   12.773081] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB1
[   12.787237] option 1-1.2:1.2: GSM modem (1-port) converter detected
[   12.800117] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB2
[   12.814263] option 1-1.2:1.3: GSM modem (1-port) converter detected
[   12.827143] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB3
[   13.021377] rt2800_wmac 10180000.wmac: loaded eeprom from mtd device "factory"
[   13.035871] ieee80211 phy0: rt2x00_set_rt: Info - RT chipset 6352, rev 0500 detected
[   13.051346] ieee80211 phy0: rt2x00_set_rf: Info - RF chipset 7620 detected
[   13.065175] ieee80211 phy0: Selected rate control algorithm 'minstrel_ht'
[   13.114881] kmodloader: done loading kernel modules from /etc/modules.d/*
[   24.810801] crng init done
[   66.932398] jffs2_scan_eraseblock(): End of filesystem marker found at 0x0
[   66.975494] jffs2_build_filesystem(): unlocking the mtd device... 
[   66.976439] done.
[   66.992665] jffs2_build_filesystem(): erasing all blocks after the end marker... 
[   69.203152] 8021q: adding VLAN 0 to HW filter on device eth0
[   69.339200] br-lan: port 1(eth0.1) entered blocking state
[   69.350029] br-lan: port 1(eth0.1) entered disabled state
[   69.361216] device eth0.1 entered promiscuous mode
[   69.370817] device eth0 entered promiscuous mode
[   69.500293] br-lan: port 1(eth0.1) entered blocking state
[   69.511098] br-lan: port 1(eth0.1) entered forwarding state
[   70.219230] IPv6: ADDRCONF(NETDEV_CHANGE): br-lan: link becomes ready
[  314.180786] done.
[  314.184725] jffs2: notice: (2443) jffs2_build_xattr_subsystem: complete building xattr subsystem, 0 of xdatum (0 unchecked, 0 orphan) and 0 of xref (0 dead, 0 orphan) found.
[  314.509684] overlayfs: upper fs does not support tmpfile.
[  376.873077] ------------[ cut here ]------------
[  376.882333] WARNING: CPU: 0 PID: 0 at net/sched/sch_generic.c:473 dev_watchdog+0x26c/0x274
[  376.898815] NETDEV WATCHDOG: wwan0 (qmi_wwan): transmit queue 0 timed out
[  376.912337] Modules linked in: rt2800soc rt2800mmio rt2800lib pppoe ppp_async option mt76x0e mt76x0_common iptable_nat xt_state xt_nat xt_conntrack xt_REDIRECT xt_MASQUERADE xt_FLOWOFFLOAD usb_wwan rt2x00soc rt2x00mmio rt2x00lib qmi_wwan pppox ppp_generic nf_nat nf_flow_table_hw nf_flow_table nf_conntrack mt76x02_lib mt76 mac80211 ipt_REJECT cfg80211 xt_time xt_tcpudp xt_multiport xt_mark xt_mac xt_limit xt_comment xt_TCPMSS xt_LOG usbserial usbnet slhc nf_reject_ipv4 nf_log_ipv4 nf_defrag_ipv6 nf_defrag_ipv4 iptable_mangle iptable_filter ip_tables crc_ccitt compat cdc_wdm ledtrig_usbport nf_log_ipv6 nf_log_common ip6table_mangle ip6table_filter ip6_tables ip6t_REJECT x_tables nf_reject_ipv6 leds_gpio ohci_platform ohci_hcd fsl_mph_dr_of ehci_platform ehci_fsl ehci_hcd gpio_button_hotplug usbcore nls_base usb_common mii
[  377.057274] CPU: 0 PID: 0 Comm: swapper Not tainted 5.4.188 #0
[  377.068895] Stack : 805e0000 8057c788 00000000 00000000 8057b880 87c0be14 805b5180 805b4d63
[  377.085548]         80527d08 00000000 807133bc 805d0000 00200000 00000001 87c0bdc8 eb6c9640
[  377.102208]         00000000 00000000 80740000 00000000 00000030 000000c6 312e342e 23203838
[  377.118864]         00000000 00000012 00000000 0000dfba 00000000 00000009 00000000 80370ae0
[  377.135517]         00000009 805d0000 00200000 00000122 00000001 8029fd60 00000000 80710000
[  377.152176]         ...
[  377.157043] Call Trace:
[  377.161939] [<80009c90>] show_stack+0x30/0x100
[  377.170803] [<80023de0>] __warn+0xc0/0x10c
[  377.178967] [<80023eb8>] warn_slowpath_fmt+0x8c/0xac
[  377.188864] [<80370ae0>] dev_watchdog+0x26c/0x274
[  377.198252] [<8006856c>] call_timer_fn.isra.34+0x20/0x90
[  377.208841] [<80068780>] run_timer_softirq+0x1a4/0x1ec
[  377.219094] [<804a13c0>] __do_softirq+0x110/0x298
[  377.228473] [<80005670>] except_vec_vi_end+0xb8/0xc4
[  377.238368] [<804a118c>] r4k_wait_irqoff+0x18/0x24
[  377.247919] ---[ end trace 26d29036d027cbd9 ]---

I don't know what happened.

fangxu1999 · May 4, 2022, 12:57am

This is the ps output:

root@OpenWrt:~# ps
  PID USER       VSZ STAT COMMAND
    1 root      1640 S    /sbin/procd
    2 root         0 SW   [kthreadd]
    3 root         0 IW   [kworker/0:0-eve]
    4 root         0 IW<  [kworker/0:0H-kb]
    5 root         0 IW   [kworker/u2:0-ev]
    6 root         0 IW<  [mm_percpu_wq]
    7 root         0 SW   [ksoftirqd/0]
    8 root         0 IW<  [netns]
    9 root         0 SW   [oom_reaper]
   97 root         0 IW<  [writeback]
   99 root         0 SW   [kcompactd0]
  101 root         0 IW<  [kblockd]
  103 root         0 IW<  [blkcg_punt_bio]
  121 root         0 SW   [watchdogd]
  141 root         0 SW   [kswapd0]
  208 root         0 IW   [kworker/u2:3-ev]
  223 root         0 IW<  [kthrotld]
  245 root         0 SW   [spi0]
  320 root         0 IW<  [ipv6_addrconf]
  324 root         0 IW<  [kworker/0:1H-kb]
  334 root         0 SW   [irq/40-keys]
  335 root         0 SW   [irq/41-keys]
  353 root         0 IW   [kworker/0:2-eve]
  548 ubus      1272 S    /sbin/ubusd
  575 root       940 S    /sbin/askfirst /usr/libexec/login.sh
  826 root         0 IW<  [cfg80211]
 1309 root      1664 S    /usr/sbin/uhttpd -f -h /www -r OpenWrt -x /cgi-bin -u /ubus -t 60 -T 30 -k 20 -A 1 -n 3 -N 100 -R -p 0.0.0.0:80 -p [::]:80
 1558 logd      1264 S    /sbin/logd -S 64
 1610 root      2220 S    /sbin/rpcd -s /var/run/ubus/ubus.sock -t 30
 1815 root      1148 S    /usr/sbin/dropbear -F -P /var/run/dropbear.1.pid -p 22 -K 300 -T 3
 1913 root      4264 S    /usr/sbin/hostapd -s -g /var/run/hostapd/global
 1914 root      4264 S    /usr/sbin/wpa_supplicant -n -s -g /var/run/wpa_supplicant/global
 1976 root      1800 S    /sbin/netifd
 2078 root      1480 S    /usr/sbin/odhcpd
 2547 root      1252 S    udhcpc -p /var/run/udhcpc-eth0.2.pid -s /lib/netifd/dhcp.script -f -t 0 -i eth0.2 -x hostname:OpenWrt -C -R -O 121
 2548 root      1068 S    odhcp6c -s /lib/netifd/dhcpv6.script -P0 -t120 eth0.2
 2731 dnsmasq   1392 S    /usr/sbin/dnsmasq -C /var/etc/dnsmasq.conf.cfg01411c -k -x /var/run/dnsmasq/dnsmasq.cfg01411c.pid
 2773 root      1172 S    /usr/sbin/dropbear -F -P /var/run/dropbear.1.pid -p 22 -K 300 -T 3
 2774 root      1260 S    -ash
 3161 root      1452 S    /bin/sh ./qmi.sh qmi setup lte {"proto":"qmi","device":"/dev/cdc-wdm0","device":"/dev/cdc-wdm0","auth":"none","pdptype":"ipv4"}
 3178 root      1272 S    uqmi -s -d /dev/cdc-wdm0 --get-pin-status
 3179 root      1252 S    grep "UIM uninitialized"
 3434 root      1252 S    udhcpc -p /var/run/udhcpc-wwan0.pid -s /lib/netifd/dhcp.script -f -t 0 -i wwan0 -x hostname:OpenWrt -C -R -O 121
 3497 root         0 SWN  [jffs2_gcd_mtd6]
 3583 root      1252 S<   /usr/sbin/ntpd -n -N -S /usr/sbin/ntpd-hotplug -p 0.openwrt.pool.ntp.org -p 1.openwrt.pool.ntp.org -p 2.openwrt.pool.ntp.org -p 3.openwrt.pool.ntp.org
 4406 root         0 IW   [kworker/u2:1-ev]
 5064 root      1252 R    ps

fangxu1999 · May 4, 2022, 1:01am

This is the system log (part 1):

Sat Apr 16 12:59:44 2022 kern.notice kernel: [    0.000000] Linux version 5.4.188 (xu@xu-virtual-machine) (gcc version 8.4.0 (OpenWrt GCC 8.4.0 r16554-1d4dea6d4f)) #0 Sat Apr 16 12:59:34 2022
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000000] Board has DDR2
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000000] Analog PMU set to hw control
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000000] Digital PMU set to hw control
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000000] SoC Type: MediaTek MT7620A ver:2 eco:6
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000000] printk: bootconsole [early0] enabled
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000000] CPU0 revision is: 00019650 (MIPS 24KEc)
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000000] MIPS: machine is Asus RT-AC51U
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000000] Initrd not found or empty - disabling initrd
Sat Apr 16 12:59:44 2022 kern.warn kernel: [    0.000000] Primary instruction cache 64kB, VIPT, 4-way, linesize 32 bytes.
Sat Apr 16 12:59:44 2022 kern.warn kernel: [    0.000000] Primary data cache 32kB, 4-way, PIPT, no aliases, linesize 32 bytes
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000000] Zone ranges:
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000000]   Normal   [mem 0x0000000000000000-0x0000000007ffffff]
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000000] Movable zone start for each node
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000000] Early memory node ranges
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000000]   node   0: [mem 0x0000000000000000-0x0000000007ffffff]
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x0000000007ffffff]
Sat Apr 16 12:59:44 2022 kern.debug kernel: [    0.000000] On node 0 totalpages: 32768
Sat Apr 16 12:59:44 2022 kern.debug kernel: [    0.000000]   Normal zone: 288 pages used for memmap
Sat Apr 16 12:59:44 2022 kern.debug kernel: [    0.000000]   Normal zone: 0 pages reserved
Sat Apr 16 12:59:44 2022 kern.debug kernel: [    0.000000]   Normal zone: 32768 pages, LIFO batch:7
Sat Apr 16 12:59:44 2022 kern.debug kernel: [    0.000000] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
Sat Apr 16 12:59:44 2022 kern.debug kernel: [    0.000000] pcpu-alloc: [0] 0
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 32480
Sat Apr 16 12:59:44 2022 kern.notice kernel: [    0.000000] Kernel command line: console=ttyS0,57600 rootfstype=squashfs,jffs2
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000000] Dentry cache hash table entries: 16384 (order: 4, 65536 bytes, linear)
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000000] Inode-cache hash table entries: 8192 (order: 3, 32768 bytes, linear)
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000000] Writing ErrCtl register=0007e001
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000000] Readback ErrCtl register=0007e001
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000000] Memory: 122288K/131072K available (4745K kernel code, 206K rwdata, 1048K rodata, 1224K init, 205K bss, 8784K reserved, 0K cma-reserved)
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000000] SLUB: HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000000] NR_IRQS: 256
Sat Apr 16 12:59:44 2022 kern.notice kernel: [    0.000000] random: get_random_bytes called from start_kernel+0x358/0x54c with crng_init=0
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000000] CPU Clock: 580MHz
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000000] clocksource: systick: mask: 0xffff max_cycles: 0xffff, max_idle_ns: 583261500 ns
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000000] systick: enable autosleep mode
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000000] systick: running - mult: 214748, shift: 32
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000000] clocksource: MIPS: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 6590553264 ns
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.000010] sched_clock: 32 bits at 290MHz, resolution 3ns, wraps every 7405115902ns
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.007611] Calibrating delay loop... 385.02 BogoMIPS (lpj=770048)
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.045501] pid_max: default: 32768 minimum: 301
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.050193] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes, linear)
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.057247] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes, linear)
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.071784] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.081266] futex hash table entries: 256 (order: -1, 3072 bytes, linear)
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.087950] pinctrl core: initialized pinctrl subsystem
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.093621] NET: Registered protocol family 16
Sat Apr 16 12:59:44 2022 kern.err kernel: [    0.570451] mt7620-pci 10140000.pcie: PCIE0 no card, disable it(RST&CLK)
Sat Apr 16 12:59:44 2022 kern.warn kernel: [    0.576959] mt7620-pci: probe of 10140000.pcie failed with error -1
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.606541] rt2880_gpio 10000600.gpio: registering 24 gpios
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.612024] rt2880_gpio 10000600.gpio: registering 24 irq handlers
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.618039] GPIO line 10 (enable-leds) hogged as output/low
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.623785] rt2880_gpio 10000688.gpio: registering 1 gpios
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.629132] rt2880_gpio 10000688.gpio: registering 1 irq handlers
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.640300] clocksource: Switched to clocksource systick
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.646905] NET: Registered protocol family 2
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.651348] IP idents hash table entries: 2048 (order: 2, 16384 bytes, linear)
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.659105] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 4096 bytes, linear)
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.667256] TCP established hash table entries: 1024 (order: 0, 4096 bytes, linear)
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.674666] TCP bind hash table entries: 1024 (order: 0, 4096 bytes, linear)
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.681506] TCP: Hash tables configured (established 1024 bind 1024)
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.687821] UDP hash table entries: 256 (order: 0, 4096 bytes, linear)
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.694172] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes, linear)
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.701210] NET: Registered protocol family 1
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.705456] PCI: CLS 0 bytes, default 32
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.712208] rt-timer 10000100.timer: maximum frequency is 1220Hz
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.720576] workingset: timestamp_bits=14 max_order=15 bucket_order=1
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.735431] squashfs: version 4.0 (2009/01/31) Phillip Lougher
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.741103] jffs2: version 2.2 (NAND) (SUMMARY) (LZMA) (RTIME) (CMODE_PRIORITY) (c) 2001-2006 Red Hat, Inc.
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.769325] Serial: 8250/16550 driver, 2 ports, IRQ sharing disabled
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.776752] printk: console [ttyS0] disabled
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.780960] 10000c00.uartlite: ttyS0 at MMIO 0x10000c00 (irq = 20, base_baud = 2500000) is a Palmchip BK-3103
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.790578] printk: console [ttyS0] enabled
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.807113] printk: bootconsole [early0] disabled
Sat Apr 16 12:59:44 2022 kern.warn kernel: [    0.832359] spi spi0.0: force spi mode3
Sat Apr 16 12:59:44 2022 kern.info kernel: [    0.851570] spi-nor spi0.0: w25q128 (16384 Kbytes)
Sat Apr 16 12:59:44 2022 kern.notice kernel: [    0.861198] 4 fixed-partitions partitions found on MTD device spi0.0
Sat Apr 16 12:59:44 2022 kern.notice kernel: [    0.873865] Creating 4 MTD partitions on "spi0.0":
Sat Apr 16 12:59:44 2022 kern.notice kernel: [    0.883423] 0x000000000000-0x000000030000 : "u-boot"
Sat Apr 16 12:59:44 2022 kern.notice kernel: [    0.894422] 0x000000030000-0x000000040000 : "u-boot-env"
Sat Apr 16 12:59:44 2022 kern.notice kernel: [    0.906117] 0x000000040000-0x000000050000 : "factory"
Sat Apr 16 12:59:44 2022 kern.notice kernel: [    0.917335] 0x000000050000-0x000001000000 : "firmware"
Sat Apr 16 12:59:44 2022 kern.notice kernel: [    0.932022] 2 uimage-fw partitions found on MTD device firmware
Sat Apr 16 12:59:44 2022 kern.notice kernel: [    0.943900] Creating 2 MTD partitions on "firmware":
Sat Apr 16 12:59:44 2022 kern.notice kernel: [    0.953809] 0x000000000000-0x0000001e828c : "kernel"
Sat Apr 16 12:59:44 2022 kern.notice kernel: [    0.964902] 0x0000001e828c-0x000000fb0000 : "rootfs"
Sat Apr 16 12:59:44 2022 kern.notice kernel: [    0.975812] mtd: device 5 (rootfs) set to be root filesystem
Sat Apr 16 12:59:44 2022 kern.notice kernel: [    0.989061] 1 squashfs-split partitions found on MTD device rootfs
Sat Apr 16 12:59:44 2022 kern.notice kernel: [    1.001453] 0x00000056d000-0x000000fb0000 : "rootfs_data"
Sat Apr 16 12:59:44 2022 kern.info kernel: [    1.024438] gsw: setting port4 to ephy mode
Sat Apr 16 12:59:44 2022 kern.info kernel: [    1.032846] mtk_soc_eth 10100000.ethernet eth0 (uninitialized): port 3 link up (100Mbps/Full duplex)
Sat Apr 16 12:59:44 2022 kern.info kernel: [    1.051564] mtk_soc_eth 10100000.ethernet: loaded mt7620 driver
Sat Apr 16 12:59:44 2022 kern.info kernel: [    1.064164] mtk_soc_eth 10100000.ethernet eth0: mediatek frame engine at 0xb0100000, irq 5
Sat Apr 16 12:59:44 2022 kern.info kernel: [    1.081232] rt2880_wdt 10000120.watchdog: Initialized
Sat Apr 16 12:59:44 2022 kern.info kernel: [    1.092958] NET: Registered protocol family 10
Sat Apr 16 12:59:44 2022 kern.info kernel: [    1.106288] Segment Routing with IPv6
Sat Apr 16 12:59:44 2022 kern.info kernel: [    1.113810] NET: Registered protocol family 17
Sat Apr 16 12:59:44 2022 kern.info kernel: [    1.122743] 8021q: 802.1Q VLAN Support v1.8
Sat Apr 16 12:59:44 2022 kern.info kernel: [    1.139687] VFS: Mounted root (squashfs filesystem) readonly on device 31:5.
Sat Apr 16 12:59:44 2022 kern.info kernel: [    1.160794] Freeing unused kernel memory: 1224K
Sat Apr 16 12:59:44 2022 kern.warn kernel: [    1.169840] This architecture does not have kernel memory protection.
Sat Apr 16 12:59:44 2022 kern.info kernel: [    1.182673] Run /sbin/init as init process
Sat Apr 16 12:59:44 2022 kern.notice kernel: [    1.476240] random: fast init done
Sat Apr 16 12:59:44 2022 user.info kernel: [    2.082168] init: Console is alive
Sat Apr 16 12:59:44 2022 user.info kernel: [    2.089381] init: - watchdog -
Sat Apr 16 12:59:44 2022 user.info kernel: [    3.514830] kmodloader: loading kernel modules from /etc/modules-boot.d/*
Sat Apr 16 12:59:44 2022 kern.info kernel: [    3.729029] usbcore: registered new interface driver usbfs
Sat Apr 16 12:59:44 2022 kern.info kernel: [    3.740116] usbcore: registered new interface driver hub
Sat Apr 16 12:59:44 2022 kern.info kernel: [    3.750844] usbcore: registered new device driver usb
Sat Apr 16 12:59:44 2022 kern.info kernel: [    3.768199] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
Sat Apr 16 12:59:44 2022 kern.info kernel: [    3.783218] ehci-fsl: Freescale EHCI Host controller driver
Sat Apr 16 12:59:44 2022 kern.info kernel: [    3.796124] ehci-platform: EHCI generic platform driver
Sat Apr 16 12:59:44 2022 kern.info kernel: [    3.816953] phy phy-usbphy.0: remote usb device wakeup disabled
Sat Apr 16 12:59:44 2022 kern.info kernel: [    3.828764] phy phy-usbphy.0: UTMI 16bit 30MHz
Sat Apr 16 12:59:44 2022 kern.info kernel: [    3.837629] ehci-platform 101c0000.ehci: EHCI Host Controller
Sat Apr 16 12:59:44 2022 kern.info kernel: [    3.849117] ehci-platform 101c0000.ehci: new USB bus registered, assigned bus number 1
Sat Apr 16 12:59:44 2022 kern.info kernel: [    3.865049] ehci-platform 101c0000.ehci: irq 26, io mem 0x101c0000
Sat Apr 16 12:59:44 2022 kern.info kernel: [    3.882684] ehci-platform 101c0000.ehci: USB 2.0 started, EHCI 1.00
Sat Apr 16 12:59:44 2022 kern.info kernel: [    3.896256] hub 1-0:1.0: USB hub found
Sat Apr 16 12:59:44 2022 kern.info kernel: [    3.904251] hub 1-0:1.0: 1 port detected
Sat Apr 16 12:59:44 2022 kern.info kernel: [    3.917846] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
Sat Apr 16 12:59:44 2022 kern.info kernel: [    3.932121] ohci-platform: OHCI generic platform driver
Sat Apr 16 12:59:44 2022 kern.info kernel: [    3.942945] ohci-platform 101c1000.ohci: Generic Platform OHCI controller
Sat Apr 16 12:59:44 2022 kern.info kernel: [    3.956539] ohci-platform 101c1000.ohci: new USB bus registered, assigned bus number 2
Sat Apr 16 12:59:44 2022 kern.info kernel: [    3.972475] ohci-platform 101c1000.ohci: irq 26, io mem 0x101c1000
Sat Apr 16 12:59:44 2022 kern.info kernel: [    4.009643] hub 2-0:1.0: USB hub found
Sat Apr 16 12:59:44 2022 kern.info kernel: [    4.017641] hub 2-0:1.0: 1 port detected
Sat Apr 16 12:59:44 2022 user.info kernel: [    4.030763] kmodloader: done loading kernel modules from /etc/modules-boot.d/*
Sat Apr 16 12:59:44 2022 user.info kernel: [    4.049623] init: - preinit -
Sat Apr 16 12:59:44 2022 kern.info kernel: [    4.174544] usb 1-1: new high-speed USB device number 2 using ehci-platform
Sat Apr 16 12:59:44 2022 kern.info kernel: [    4.762864] hub 1-1:1.0: USB hub found
Sat Apr 16 12:59:44 2022 kern.info kernel: [    4.862540] hub 1-1:1.0: 4 ports detected
Sat Apr 16 12:59:44 2022 kern.notice kernel: [    4.938819] random: procd: uninitialized urandom read (4 bytes read)
Sat Apr 16 12:59:44 2022 kern.info kernel: [    5.324970] usb 1-1.2: new high-speed USB device number 3 using ehci-platform
Sat Apr 16 12:59:44 2022 kern.notice kernel: [    5.345314] random: jshn: uninitialized urandom read (4 bytes read)
Sat Apr 16 12:59:44 2022 kern.notice kernel: [    5.525206] random: jshn: uninitialized urandom read (4 bytes read)
Sat Apr 16 12:59:44 2022 kern.warn kernel: [    6.008075] urandom_read: 4 callbacks suppressed
Sat Apr 16 12:59:44 2022 kern.notice kernel: [    6.008085] random: jshn: uninitialized urandom read (4 bytes read)
Sat Apr 16 12:59:44 2022 kern.info kernel: [    6.486267] 8021q: adding VLAN 0 to HW filter on device eth0
Sat Apr 16 12:59:44 2022 user.notice kernel: [    8.129681] mount_root: jffs2 not ready yet, using temporary tmpfs overlay
Sat Apr 16 12:59:44 2022 user.warn kernel: [    8.148046] urandom-seed: Seed file not found (/etc/urandom.seed)
Sat Apr 16 12:59:44 2022 user.info kernel: [    8.270687] procd: - early -
Sat Apr 16 12:59:44 2022 user.info kernel: [    8.276742] procd: - watchdog -
Sat Apr 16 12:59:44 2022 kern.notice kernel: [    8.937943] random: jshn: uninitialized urandom read (4 bytes read)
Sat Apr 16 12:59:44 2022 user.info kernel: [    9.038235] procd: - watchdog -
Sat Apr 16 12:59:44 2022 user.info kernel: [    9.045257] procd: - ubus -
Sat Apr 16 12:59:44 2022 kern.notice kernel: [    9.275005] random: ubusd: uninitialized urandom read (4 bytes read)
Sat Apr 16 12:59:44 2022 user.info kernel: [    9.312455] procd: - init -
Sat Apr 16 12:59:44 2022 user.info kernel: [   11.815241] kmodloader: loading kernel modules from /etc/modules.d/*
Sat Apr 16 12:59:44 2022 kern.info kernel: [   12.094057] usbcore: registered new interface driver cdc_wdm
Sat Apr 16 12:59:44 2022 kern.info kernel: [   12.123593] Loading modules backported from Linux version v5.10.110-0-g3238bffaf992
Sat Apr 16 12:59:44 2022 kern.info kernel: [   12.138935] Backport generated by backports.git v5.10.110-1-0-g1fbde860
Sat Apr 16 12:59:44 2022 kern.info kernel: [   12.218542] usbcore: registered new interface driver usbserial_generic
Sat Apr 16 12:59:44 2022 kern.info kernel: [   12.231738] usbserial: USB Serial support registered for generic
Sat Apr 16 12:59:44 2022 kern.info kernel: [   12.299628] xt_time: kernel timezone is -0000
Sat Apr 16 12:59:44 2022 user.err kernel: [   12.316466] urngd: jent-rng init failed, err: 2
Sat Apr 16 12:59:44 2022 kern.info kernel: [   12.491931] PPP generic driver version 2.4.2
Sat Apr 16 12:59:44 2022 kern.info kernel: [   12.503724] NET: Registered protocol family 24
Sat Apr 16 12:59:44 2022 kern.info kernel: [   12.517069] qmi_wwan 1-1.2:1.5: cdc-wdm0: USB WDM device
Sat Apr 16 12:59:44 2022 kern.info kernel: [   12.528849] qmi_wwan 1-1.2:1.5 wwan0: register 'qmi_wwan' at usb-101c0000.ehci-1.2, WWAN/QMI device, f2:0b:c9:73:6f:24
Sat Apr 16 12:59:44 2022 kern.info kernel: [   12.550504] usbcore: registered new interface driver qmi_wwan
Sat Apr 16 12:59:44 2022 kern.info kernel: [   12.707375] usbcore: registered new interface driver option
Sat Apr 16 12:59:44 2022 kern.info kernel: [   12.718679] usbserial: USB Serial support registered for GSM modem (1-port)
Sat Apr 16 12:59:44 2022 kern.info kernel: [   12.733182] option 1-1.2:1.0: GSM modem (1-port) converter detected
Sat Apr 16 12:59:44 2022 kern.info kernel: [   12.746035] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB0
Sat Apr 16 12:59:44 2022 kern.info kernel: [   12.760184] option 1-1.2:1.1: GSM modem (1-port) converter detected
Sat Apr 16 12:59:44 2022 kern.info kernel: [   12.773081] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB1
Sat Apr 16 12:59:44 2022 kern.info kernel: [   12.787237] option 1-1.2:1.2: GSM modem (1-port) converter detected
Sat Apr 16 12:59:44 2022 kern.info kernel: [   12.800117] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB2
Sat Apr 16 12:59:44 2022 kern.info kernel: [   12.814263] option 1-1.2:1.3: GSM modem (1-port) converter detected
Sat Apr 16 12:59:44 2022 kern.info kernel: [   12.827143] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB3
Sat Apr 16 12:59:44 2022 kern.info kernel: [   13.021377] rt2800_wmac 10180000.wmac: loaded eeprom from mtd device "factory"
Sat Apr 16 12:59:44 2022 kern.info kernel: [   13.035871] ieee80211 phy0: rt2x00_set_rt: Info - RT chipset 6352, rev 0500 detected
Sat Apr 16 12:59:44 2022 kern.info kernel: [   13.051346] ieee80211 phy0: rt2x00_set_rf: Info - RF chipset 7620 detected
Sat Apr 16 12:59:44 2022 kern.debug kernel: [   13.065175] ieee80211 phy0: Selected rate control algorithm 'minstrel_ht'
Sat Apr 16 12:59:44 2022 user.info kernel: [   13.114881] kmodloader: done loading kernel modules from /etc/modules.d/*
Sat Apr 16 12:59:46 2022 user.notice dnsmasq: DNS rebinding protection is active, will discard upstream RFC1918 responses!
Sat Apr 16 12:59:46 2022 user.notice dnsmasq: Allowing 127.0.0.0/8 responses
Sat Apr 16 12:59:47 2022 daemon.info dnsmasq[1749]: Connected to system UBus
Sat Apr 16 12:59:47 2022 daemon.info dnsmasq[1749]: started, version 2.85 cachesize 150
Sat Apr 16 12:59:47 2022 daemon.info dnsmasq[1749]: DNS service limited to local subnets
Sat Apr 16 12:59:47 2022 daemon.info dnsmasq[1749]: compile time options: IPv6 GNU-getopt no-DBus UBus no-i18n no-IDN DHCP no-DHCPv6 no-Lua TFTP no-conntrack no-ipset no-auth no-cryptohash no-DNSSEC no-ID loop-detect inotify dumpfile
Sat Apr 16 12:59:47 2022 daemon.info dnsmasq[1749]: UBus support enabled: connected to system bus
Sat Apr 16 12:59:47 2022 daemon.info dnsmasq[1749]: using only locally-known addresses for domain test
Sat Apr 16 12:59:47 2022 daemon.info dnsmasq[1749]: using only locally-known addresses for domain onion
Sat Apr 16 12:59:47 2022 daemon.info dnsmasq[1749]: using only locally-known addresses for domain localhost
Sat Apr 16 12:59:47 2022 daemon.info dnsmasq[1749]: using only locally-known addresses for domain local
Sat Apr 16 12:59:47 2022 daemon.info dnsmasq[1749]: using only locally-known addresses for domain invalid
Sat Apr 16 12:59:47 2022 daemon.info dnsmasq[1749]: using only locally-known addresses for domain bind
Sat Apr 16 12:59:47 2022 daemon.info dnsmasq[1749]: using only locally-known addresses for domain lan
Sat Apr 16 12:59:47 2022 daemon.warn dnsmasq[1749]: no servers found in /tmp/resolv.conf.d/resolv.conf.auto, will retry
Sat Apr 16 12:59:47 2022 daemon.info dnsmasq[1749]: read /etc/hosts - 4 addresses
Sat Apr 16 12:59:47 2022 daemon.info dnsmasq[1749]: read /tmp/hosts/dhcp.cfg01411c - 0 addresses
Sat Apr 16 12:59:49 2022 kern.notice kernel: [   24.810801] crng init done
Sat Apr 16 13:00:22 2022 authpriv.info dropbear[1815]: Not backgrounding
Sat Apr 16 13:00:24 2022 daemon.notice wpa_supplicant[1914]: Successfully initialized wpa_supplicant
Sat Apr 16 13:00:25 2022 user.notice : Added device handler type: bonding
Sat Apr 16 13:00:25 2022 user.notice : Added device handler type: 8021ad
Sat Apr 16 13:00:25 2022 user.notice : Added device handler type: 8021q
Sat Apr 16 13:00:25 2022 user.notice : Added device handler type: macvlan
Sat Apr 16 13:00:25 2022 user.notice : Added device handler type: veth
Sat Apr 16 13:00:25 2022 user.notice : Added device handler type: bridge
Sat Apr 16 13:00:25 2022 user.notice : Added device handler type: Network device
Sat Apr 16 13:00:25 2022 user.notice : Added device handler type: tunnel
Sat Apr 16 13:00:27 2022 daemon.notice procd: /etc/rc.d/S50uhttpd: 4+0 records in
Sat Apr 16 13:00:27 2022 daemon.notice procd: /etc/rc.d/S50uhttpd: 4+0 records out
Sat Apr 16 13:00:28 2022 user.notice ucitrack: Setting up /etc/config/network reload dependency on /etc/config/dhcp
Sat Apr 16 13:00:28 2022 user.notice ucitrack: Setting up /etc/config/wireless reload dependency on /etc/config/network
Sat Apr 16 13:00:28 2022 user.notice ucitrack: Setting up /etc/config/firewall reload dependency on /etc/config/luci-splash
Sat Apr 16 13:00:28 2022 user.notice ucitrack: Setting up /etc/config/firewall reload dependency on /etc/config/qos
Sat Apr 16 13:00:28 2022 user.notice ucitrack: Setting up /etc/config/firewall reload dependency on /etc/config/miniupnpd
Sat Apr 16 13:00:29 2022 user.notice ucitrack: Setting up /etc/config/dhcp reload dependency on /etc/config/odhcpd
Sat Apr 16 13:00:29 2022 user.notice ucitrack: Setting up non-init /etc/config/fstab reload handler: /sbin/block mount
Sat Apr 16 13:00:29 2022 user.notice ucitrack: Setting up /etc/config/system reload trigger for non-procd /etc/init.d/led
Sat Apr 16 13:00:30 2022 user.notice ucitrack: Setting up /etc/config/system reload dependency on /etc/config/luci_statistics
Sat Apr 16 13:00:30 2022 user.notice ucitrack: Setting up /etc/config/system reload dependency on /etc/config/dhcp
Sat Apr 16 13:00:31 2022 kern.warn kernel: [   66.932398] jffs2_scan_eraseblock(): End of filesystem marker found at 0x0
Sat Apr 16 13:00:31 2022 kern.warn kernel: [   66.975494] jffs2_build_filesystem(): unlocking the mtd device...
Sat Apr 16 13:00:31 2022 kern.warn kernel: [   66.976439] done.
Sat Apr 16 13:00:33 2022 kern.warn kernel: [   66.992665] jffs2_build_filesystem(): erasing all blocks after the end marker...
Sat Apr 16 13:00:33 2022 kern.info kernel: [   69.203152] 8021q: adding VLAN 0 to HW filter on device eth0
Sat Apr 16 13:00:33 2022 kern.info kernel: [   69.339200] br-lan: port 1(eth0.1) entered blocking state
Sat Apr 16 13:00:33 2022 kern.info kernel: [   69.350029] br-lan: port 1(eth0.1) entered disabled state
Sat Apr 16 13:00:33 2022 kern.info kernel: [   69.361216] device eth0.1 entered promiscuous mode
Sat Apr 16 13:00:33 2022 kern.info kernel: [   69.370817] device eth0 entered promiscuous mode
Sat Apr 16 13:00:33 2022 kern.info kernel: [   69.500293] br-lan: port 1(eth0.1) entered blocking state
Sat Apr 16 13:00:33 2022 kern.info kernel: [   69.511098] br-lan: port 1(eth0.1) entered forwarding state
Sat Apr 16 13:00:33 2022 daemon.notice netifd: Interface 'lan' is enabled
Sat Apr 16 13:00:33 2022 daemon.notice netifd: Interface 'lan' is setting up now
Sat Apr 16 13:00:33 2022 daemon.notice netifd: Interface 'lan' is now up
Sat Apr 16 13:00:33 2022 daemon.notice netifd: bridge 'br-lan' link is up
Sat Apr 16 13:00:33 2022 daemon.notice netifd: Interface 'lan' has link connectivity
Sat Apr 16 13:00:33 2022 daemon.notice netifd: VLAN 'eth0.1' link is up
Sat Apr 16 13:00:33 2022 daemon.notice netifd: Interface 'loopback' is enabled
Sat Apr 16 13:00:33 2022 daemon.notice netifd: Interface 'loopback' is setting up now
Sat Apr 16 13:00:33 2022 daemon.notice netifd: Interface 'loopback' is now up
Sat Apr 16 13:00:33 2022 daemon.notice netifd: Interface 'wan' is enabled
Sat Apr 16 13:00:33 2022 daemon.notice netifd: Interface 'wan6' is enabled
Sat Apr 16 13:00:33 2022 daemon.notice netifd: Network device 'eth0' link is up
Sat Apr 16 13:00:34 2022 daemon.notice netifd: Network device 'lo' link is up
Sat Apr 16 13:00:34 2022 daemon.notice netifd: Interface 'loopback' has link connectivity
Sat Apr 16 13:00:34 2022 daemon.notice netifd: VLAN 'eth0.2' link is up
Sat Apr 16 13:00:34 2022 daemon.notice netifd: Interface 'wan' has link connectivity
Sat Apr 16 13:00:34 2022 daemon.notice netifd: Interface 'wan' is setting up now
Sat Apr 16 13:00:34 2022 daemon.notice netifd: Interface 'wan6' has link connectivity
Sat Apr 16 13:00:34 2022 daemon.notice netifd: Interface 'wan6' is setting up now
Sat Apr 16 13:00:34 2022 kern.info kernel: [   70.219230] IPv6: ADDRCONF(NETDEV_CHANGE): br-lan: link becomes ready
Sat Apr 16 13:00:34 2022 daemon.notice netifd: wan (2547): udhcpc: started, v1.33.2
Sat Apr 16 13:00:34 2022 daemon.err odhcp6c[2548]: Failed to send RS (Address not available)
Sat Apr 16 13:00:34 2022 user.notice firewall: Reloading firewall due to ifup of lan (br-lan)
Sat Apr 16 13:00:34 2022 daemon.err odhcpd[2078]: Failed to send to ff02::1%lan@br-lan (Address not available)
Sat Apr 16 13:00:35 2022 daemon.err odhcp6c[2548]: Failed to send SOLICIT message to ff02::1:2 (Address not available)
Sat Apr 16 13:00:35 2022 daemon.notice netifd: wan (2547): udhcpc: sending discover
Sat Apr 16 13:00:38 2022 daemon.notice netifd: wan (2547): udhcpc: sending discover
Sat Apr 16 13:00:41 2022 daemon.info dnsmasq[1749]: exiting on receipt of SIGTERM
Sat Apr 16 13:00:41 2022 daemon.notice netifd: wan (2547): udhcpc: sending discover
Sat Apr 16 13:00:41 2022 daemon.info dnsmasq[2731]: Connected to system UBus
Sat Apr 16 13:00:41 2022 daemon.info dnsmasq[2731]: started, version 2.85 cachesize 150
Sat Apr 16 13:00:41 2022 daemon.info dnsmasq[2731]: DNS service limited to local subnets
Sat Apr 16 13:00:41 2022 daemon.info dnsmasq[2731]: compile time options: IPv6 GNU-getopt no-DBus UBus no-i18n no-IDN DHCP no-DHCPv6 no-Lua TFTP no-conntrack no-ipset no-auth no-cryptohash no-DNSSEC no-ID loop-detect inotify dumpfile
Sat Apr 16 13:00:41 2022 daemon.info dnsmasq[2731]: UBus support enabled: connected to system bus
Sat Apr 16 13:00:41 2022 daemon.info dnsmasq-dhcp[2731]: DHCP, IP range 192.168.1.100 -- 192.168.1.249, lease time 12h
Sat Apr 16 13:00:41 2022 daemon.info dnsmasq[2731]: using only locally-known addresses for domain test
Sat Apr 16 13:00:41 2022 daemon.info dnsmasq[2731]: using only locally-known addresses for domain onion
Sat Apr 16 13:00:41 2022 daemon.info dnsmasq[2731]: using only locally-known addresses for domain localhost
Sat Apr 16 13:00:41 2022 daemon.info dnsmasq[2731]: using only locally-known addresses for domain local
Sat Apr 16 13:00:41 2022 daemon.info dnsmasq[2731]: using only locally-known addresses for domain invalid
Sat Apr 16 13:00:41 2022 daemon.info dnsmasq[2731]: using only locally-known addresses for domain bind
Sat Apr 16 13:00:41 2022 daemon.info dnsmasq[2731]: using only locally-known addresses for domain lan
Sat Apr 16 13:00:41 2022 daemon.warn dnsmasq[2731]: no servers found in /tmp/resolv.conf.d/resolv.conf.auto, will retry
Sat Apr 16 13:00:41 2022 daemon.info dnsmasq[2731]: read /etc/hosts - 4 addresses
Sat Apr 16 13:00:41 2022 daemon.info dnsmasq[2731]: read /tmp/hosts/dhcp.cfg01411c - 2 addresses
Sat Apr 16 13:00:41 2022 daemon.info dnsmasq-dhcp[2731]: read /etc/ethers - 0 addresses
Sat Apr 16 13:00:41 2022 daemon.info dnsmasq[2731]: read /etc/hosts - 4 addresses
Sat Apr 16 13:00:41 2022 daemon.info dnsmasq[2731]: read /tmp/hosts/dhcp.cfg01411c - 2 addresses
Sat Apr 16 13:00:41 2022 daemon.info dnsmasq-dhcp[2731]: read /etc/ethers - 0 addresses
Sat Apr 16 13:00:51 2022 daemon.info dnsmasq[2731]: read /etc/hosts - 4 addresses
Sat Apr 16 13:00:51 2022 daemon.info dnsmasq[2731]: read /tmp/hosts/odhcpd - 0 addresses
Sat Apr 16 13:00:51 2022 daemon.info dnsmasq[2731]: read /tmp/hosts/dhcp.cfg01411c - 2 addresses
Sat Apr 16 13:00:51 2022 daemon.info dnsmasq-dhcp[2731]: read /etc/ethers - 0 addresses
Sat Apr 16 13:00:52 2022 daemon.info dnsmasq[2731]: read /etc/hosts - 4 addresses
Sat Apr 16 13:00:52 2022 daemon.info dnsmasq[2731]: read /tmp/hosts/odhcpd - 1 addresses
Sat Apr 16 13:00:52 2022 daemon.info dnsmasq[2731]: read /tmp/hosts/dhcp.cfg01411c - 2 addresses
Sat Apr 16 13:00:52 2022 daemon.info dnsmasq-dhcp[2731]: read /etc/ethers - 0 addresses
Sat Apr 16 13:02:01 2022 authpriv.info dropbear[2773]: Child connection from 192.168.1.100:58845
Sat Apr 16 13:02:03 2022 authpriv.notice dropbear[2773]: Auth succeeded with blank password for 'root' from 192.168.1.100:58845
Sat Apr 16 13:02:17 2022 user.info : luci: accepted login on / for root from 192.168.1.100

fangxu1999 · May 4, 2022, 1:02am

This is the system log (part 2):

Sat Apr 16 13:03:37 2022 daemon.notice netifd: Interface 'lte' is setting up now
Sat Apr 16 13:03:38 2022 daemon.notice netifd: lte (3161): Waiting for SIM initialization
Sat Apr 16 13:04:27 2022 daemon.notice netifd: Interface 'ltewan' is enabled
Sat Apr 16 13:04:27 2022 daemon.notice netifd: Network device 'wwan0' link is up
Sat Apr 16 13:04:27 2022 daemon.notice netifd: Interface 'ltewan' has link connectivity
Sat Apr 16 13:04:27 2022 daemon.notice netifd: Interface 'ltewan' is setting up now
Sat Apr 16 13:04:28 2022 daemon.notice netifd: ltewan (3434): udhcpc: started, v1.33.2
Sat Apr 16 13:04:28 2022 daemon.notice netifd: ltewan (3434): udhcpc: sending discover
Sat Apr 16 13:04:31 2022 daemon.notice netifd: ltewan (3434): udhcpc: sending discover
Sat Apr 16 13:04:34 2022 daemon.notice netifd: ltewan (3434): udhcpc: sending discover
Sat Apr 16 13:04:38 2022 kern.warn kernel: [  314.180786] done.
Sat Apr 16 13:04:38 2022 kern.notice kernel: [  314.184725] jffs2: notice: (2443) jffs2_build_xattr_subsystem: complete building xattr subsystem, 0 of xdatum (0 unchecked, 0 orphan) and 0 of xref (0 dead, 0 orphan) found.
Sat Apr 16 13:04:38 2022 daemon.info mount_root: performing overlay whiteout
Sat Apr 16 13:04:38 2022 kern.warn kernel: [  314.509684] overlayfs: upper fs does not support tmpfile.
Sat Apr 16 13:04:38 2022 daemon.info mount_root: syncronizing overlay
Sat Apr 16 13:04:39 2022 daemon.err mount_root: failed to sync jffs2 overlay
Sat Apr 16 13:04:41 2022 daemon.info procd: - init complete -
Sat Apr 16 13:04:41 2022 daemon.info urandom_seed[3644]: Seed saved (/etc/urandom.seed)
Sat Apr 16 13:07:12 2022 kern.warn kernel: [  376.873077] ------------[ cut here ]------------
Sat Apr 16 13:07:12 2022 kern.warn kernel: [  376.882333] WARNING: CPU: 0 PID: 0 at net/sched/sch_generic.c:473 dev_watchdog+0x26c/0x274
Sat Apr 16 13:07:12 2022 kern.info kernel: [  376.898815] NETDEV WATCHDOG: wwan0 (qmi_wwan): transmit queue 0 timed out
Sat Apr 16 13:07:12 2022 kern.warn kernel: [  376.912337] Modules linked in: rt2800soc rt2800mmio rt2800lib pppoe ppp_async option mt76x0e mt76x0_common iptable_nat xt_state xt_nat xt_conntrack xt_REDIRECT xt_MASQUERADE xt_FLOWOFFLOAD usb_wwan rt2x00soc rt2x00mmio rt2x00lib qmi_wwan pppox ppp_generic nf_nat nf_flow_table_hw nf_flow_table nf_conntrack mt76x02_lib mt76 mac80211 ipt_REJECT cfg80211 xt_time xt_tcpudp xt_multiport xt_mark xt_mac xt_limit xt_comment xt_TCPMSS xt_LOG usbserial usbnet slhc nf_reject_ipv4 nf_log_ipv4 nf_defrag_ipv6 nf_defrag_ipv4 iptable_mangle iptable_filter ip_tables crc_ccitt compat cdc_wdm ledtrig_usbport nf_log_ipv6 nf_log_common ip6table_mangle ip6table_filter ip6_tables ip6t_REJECT x_tables nf_reject_ipv6 leds_gpio ohci_platform ohci_hcd fsl_mph_dr_of ehci_platform ehci_fsl ehci_hcd gpio_button_hotplug usbcore nls_base usb_common mii
Sat Apr 16 13:07:12 2022 kern.warn kernel: [  377.057274] CPU: 0 PID: 0 Comm: swapper Not tainted 5.4.188 #0
Sat Apr 16 13:07:12 2022 kern.warn kernel: [  377.068895] Stack : 805e0000 8057c788 00000000 00000000 8057b880 87c0be14 805b5180 805b4d63
Sat Apr 16 13:07:12 2022 kern.warn kernel: [  377.085548]         80527d08 00000000 807133bc 805d0000 00200000 00000001 87c0bdc8 eb6c9640
Sat Apr 16 13:07:12 2022 kern.warn kernel: [  377.102208]         00000000 00000000 80740000 00000000 00000030 000000c6 312e342e 23203838
Sat Apr 16 13:07:12 2022 kern.warn kernel: [  377.118864]         00000000 00000012 00000000 0000dfba 00000000 00000009 00000000 80370ae0
Sat Apr 16 13:07:12 2022 kern.warn kernel: [  377.135517]         00000009 805d0000 00200000 00000122 00000001 8029fd60 00000000 80710000
Sat Apr 16 13:07:12 2022 kern.warn kernel: [  377.152176]         ...
Sat Apr 16 13:07:12 2022 kern.warn kernel: [  377.157043] Call Trace:
Sat Apr 16 13:07:12 2022 kern.warn kernel: [  377.161939] [<80009c90>] show_stack+0x30/0x100
Sat Apr 16 13:07:12 2022 kern.warn kernel: [  377.170803] [<80023de0>] __warn+0xc0/0x10c
Sat Apr 16 13:07:12 2022 kern.warn kernel: [  377.178967] [<80023eb8>] warn_slowpath_fmt+0x8c/0xac
Sat Apr 16 13:07:12 2022 kern.warn kernel: [  377.188864] [<80370ae0>] dev_watchdog+0x26c/0x274
Sat Apr 16 13:07:12 2022 kern.warn kernel: [  377.198252] [<8006856c>] call_timer_fn.isra.34+0x20/0x90
Sat Apr 16 13:07:12 2022 kern.warn kernel: [  377.208841] [<80068780>] run_timer_softirq+0x1a4/0x1ec
Sat Apr 16 13:07:12 2022 kern.warn kernel: [  377.219094] [<804a13c0>] __do_softirq+0x110/0x298
Sat Apr 16 13:07:12 2022 kern.warn kernel: [  377.228473] [<80005670>] except_vec_vi_end+0xb8/0xc4
Sat Apr 16 13:07:12 2022 kern.warn kernel: [  377.238368] [<804a118c>] r4k_wait_irqoff+0x18/0x24
Sat Apr 16 13:07:12 2022 kern.warn kernel: [  377.247919] ---[ end trace 26d29036d027cbd9 ]---

fangxu1999 · May 4, 2022, 1:07am

Then I remove the LTE interface, like this

then run command:

root@OpenWrt:~# uqmi -s -d /dev/cdc-wdm0 --get-pin-status
^C"Failed to connect to service"
root@OpenWrt:~# uqmi -s -d /dev/cdc-wdm0 --get-signal-info
^C"Failed to connect to service"
root@OpenWrt:~# --get-data-status^C
root@OpenWrt:~# uqmi -s -d /dev/cdc-wdm0 --get-data-status
^C"Failed to connect to service"

fangxu1999 · May 4, 2022, 1:57am

When I switched to the previous version (fixed rawIP manually), I found a situation:

after add LTE and LTEWAN interface:

root@OpenWrt:~# ps | grep qmi
 2295 root      1452 S    /bin/sh ./qmi.sh qmi setup lte {"proto":"qmi","device":"/dev/cdc-wdm0","device":"/dev/cdc-wdm0","auth":"none","pdptype":"ipv4"}
 2358 root      1280 S    uqmi -s -d /dev/cdc-wdm0 --get-pin-status
 3044 root      1252 S    grep qmi

Wait for a long time. Then I kill the uqmi process

root@OpenWrt:~# kill 2358
root@OpenWrt:~# ps | grep qmi
 3150 root      1252 S    grep qmi

Wait for a short time, it get the IP address

wwan0     Link encap:Ethernet  HWaddr 5E:18:FA:9E:DE:DA
          inet addr:10.179.231.176  Bcast:10.179.231.191  Mask:255.255.255.224
          inet6 addr: fe80::5c18:faff:fe9e:deda/64 Scope:Link
          UP BROADCAST RUNNING NOARP MULTICAST  MTU:1500  Metric:1
          RX packets:971 errors:0 dropped:0 overruns:0 frame:0
          TX packets:1603 errors:0 dropped:0 overruns:0 carrier:0
          collisions:0 txqueuelen:1000
          RX bytes:128103 (125.1 KiB)  TX bytes:171534 (167.5 KiB)

Then it can ping host

root@OpenWrt:~# ping openwrt.org
PING openwrt.org (139.59.209.225): 56 data bytes
64 bytes from 139.59.209.225: seq=0 ttl=50 time=433.645 ms
64 bytes from 139.59.209.225: seq=1 ttl=50 time=321.963 ms
64 bytes from 139.59.209.225: seq=2 ttl=50 time=340.424 ms
64 bytes from 139.59.209.225: seq=3 ttl=50 time=324.664 ms
64 bytes from 139.59.209.225: seq=4 ttl=50 time=312.843 ms
^C
--- openwrt.org ping statistics ---
6 packets transmitted, 5 packets received, 16% packet loss
round-trip min/avg/max = 312.843/346.707/433.645 ms

But it cannot access webpage

root@OpenWrt:~# wget openwrt.org
Downloading 'openwrt.org'
Failed to allocate uclient context

I run the some commands. maybe the messages are useful

root@OpenWrt:~# uqmi -s -d /dev/cdc-wdm0 --get-pin-status
"Not supported"
root@OpenWrt:~# uqmi -s -d /dev/cdc-wdm0 --get-data-status
"connected"
root@OpenWrt:~# uqmi -s -d /dev/cdc-wdm0 --get-signal-info
{"type":"cdma","rssi":-86,"ecio":8,"type":"lte","rssi":-73,"rsrq":-9,"rsrp":-97,"snr":136}
root@OpenWrt:~# uqmi -s -d /dev/cdc-wdm0 --wda-get-data-format
"raw-ip"

Is it necessary to manually modify the rawIP mode?
Where is the problem?
How to work smoothly?

fangxu1999 · May 4, 2022, 2:47am

I further discovered new details:

after reboot, uqmi is running auto

root@OpenWrt:~# ps | grep qmi
 2292 root      1452 S    /bin/sh ./qmi.sh qmi setup lte {"proto":"qmi","device":"/dev/cdc-wdm0","device":"/dev/cdc-wdm0","auth":"none","pdptype":"ipv4"}
 2357 root      1280 S    uqmi -s -d /dev/cdc-wdm0 --get-pin-status
 2704 root      1252 S    grep qmi

after I kill the uqmi process

root@OpenWrt:~# kill 2357
root@OpenWrt:~# ps | grep qmi
 2847 root      1252 S    grep qmi

it works

root@OpenWrt:~# opkg update
Downloading https://downloads.openwrt.org/releases/21.02.3/targets/ramips/mt7620/packages/Packages.gz
Updated list of available packages in /var/opkg-lists/openwrt_core
Downloading https://downloads.openwrt.org/releases/21.02.3/targets/ramips/mt7620/packages/Packages.sig
Signature check passed.
Downloading https://downloads.openwrt.org/releases/21.02.3/packages/mipsel_24kc/base/Packages.gz
Updated list of available packages in /var/opkg-lists/openwrt_base
Downloading https://downloads.openwrt.org/releases/21.02.3/packages/mipsel_24kc/base/Packages.sig

root@OpenWrt:~# opkg install curl
Installing curl (7.82.0-2) to root...
Downloading https://downloads.openwrt.org/releases/21.02.3/packages/mipsel_24kc/packages/curl_7.82.0-2_mipsel_24kc.ipk
Installing libnghttp2-14 (1.43.0-1) to root...
Downloading https://downloads.openwrt.org/releases/21.02.3/packages/mipsel_24kc/packages/libnghttp2-14_1.43.0-1_mipsel_24kc.ipk
Installing libcurl4 (7.82.0-2) to root...
Downloading https://downloads.openwrt.org/releases/21.02.3/packages/mipsel_24kc/packages/libcurl4_7.82.0-2_mipsel_24kc.ipk
Configuring libnghttp2-14.
Configuring libcurl4.
Configuring curl.

root@OpenWrt:~# curl openwrt.org
<html>
<head><title>301 Moved Permanently</title></head>
<body>
<center><h1>301 Moved Permanently</h1></center>
<hr><center>nginx</center>
</body>
</html>

root@OpenWrt:~# ps | grep qmi
 3026 root      1252 S    grep qmi

It seems that uqmi -s -d /dev/cdc-wdm0 --get-pin-status is blocked.

Please how can I bypass it?

fangxu1999 · May 4, 2022, 2:50am

This is the latest system log, maybe it is useful.

Sat Apr 16 13:06:23 2022 authpriv.info dropbear[2690]: Child connection from 192.168.1.100:61720
Sat Apr 16 13:06:23 2022 authpriv.notice dropbear[2690]: Auth succeeded with blank password for 'root' from 192.168.1.100:61720
Sat Apr 16 13:06:47 2022 daemon.notice netifd: lte (2292): Device does not support 802.3 mode. Informing driver of raw-ip only for wwan0 ..
Sat Apr 16 13:06:47 2022 daemon.notice netifd: lte (2292): sh: write error: Resource busy
Sat Apr 16 13:06:47 2022 kern.err kernel: [   72.886169] qmi_wwan 1-1.2:1.5 wwan0: Cannot change a running device
Sat Apr 16 13:06:47 2022 daemon.notice netifd: lte (2292): Waiting for network registration
Sat Apr 16 13:06:48 2022 daemon.notice netifd: lte (2292): Starting network lte
Sat Apr 16 13:06:48 2022 daemon.notice netifd: lte (2292): Setting up wwan0
Sat Apr 16 13:06:48 2022 daemon.notice netifd: Interface 'lte' is now up
Sat Apr 16 13:06:48 2022 daemon.notice netifd: Network alias 'wwan0' link is up
Sat Apr 16 13:06:48 2022 daemon.notice netifd: Interface 'lte_4' is enabled
Sat Apr 16 13:06:48 2022 daemon.notice netifd: Interface 'lte_4' has link connectivity
Sat Apr 16 13:06:48 2022 daemon.notice netifd: Interface 'lte_4' is setting up now
Sat Apr 16 13:06:49 2022 daemon.notice netifd: lte_4 (2764): udhcpc: started, v1.33.2
Sat Apr 16 13:06:49 2022 user.notice firewall: Reloading firewall due to ifup of lte (wwan0)
Sat Apr 16 13:06:49 2022 daemon.notice netifd: lte_4 (2764): udhcpc: sending discover
Sat Apr 16 13:06:49 2022 daemon.notice netifd: lte_4 (2764): udhcpc: sending select for 10.179.231.176
Sat Apr 16 13:06:49 2022 daemon.notice netifd: lte_4 (2764): udhcpc: lease of 10.179.231.176 obtained, lease time 7200
Sat Apr 16 13:06:49 2022 daemon.notice netifd: Interface 'lte_4' is now up
Sat Apr 16 13:06:49 2022 daemon.info dnsmasq[2656]: reading /tmp/resolv.conf.d/resolv.conf.auto
Sat Apr 16 13:06:49 2022 daemon.info dnsmasq[2656]: using only locally-known addresses for domain test
Sat Apr 16 13:06:49 2022 daemon.info dnsmasq[2656]: using only locally-known addresses for domain onion
Sat Apr 16 13:06:49 2022 daemon.info dnsmasq[2656]: using only locally-known addresses for domain localhost
Sat Apr 16 13:06:49 2022 daemon.info dnsmasq[2656]: using only locally-known addresses for domain local
Sat Apr 16 13:06:49 2022 daemon.info dnsmasq[2656]: using only locally-known addresses for domain invalid
Sat Apr 16 13:06:49 2022 daemon.info dnsmasq[2656]: using only locally-known addresses for domain bind
Sat Apr 16 13:06:49 2022 daemon.info dnsmasq[2656]: using only locally-known addresses for domain lan
Sat Apr 16 13:06:49 2022 daemon.info dnsmasq[2656]: using nameserver 218.4.4.4#53
Sat Apr 16 13:06:49 2022 daemon.info dnsmasq[2656]: using nameserver 218.2.2.2#53
Sat Apr 16 13:06:49 2022 user.notice firewall: Reloading firewall due to ifup of lte_4 (wwan0)
Sat Apr 16 13:06:50 2022 daemon.notice netifd: ltewan (2371): udhcpc: sending select for 10.179.231.176
Sat Apr 16 13:06:50 2022 daemon.notice netifd: ltewan (2371): udhcpc: lease of 10.179.231.176 obtained, lease time 7200
Sat Apr 16 13:06:51 2022 daemon.notice netifd: Interface 'ltewan' is now up
Sat Apr 16 13:06:51 2022 daemon.info dnsmasq[2656]: reading /tmp/resolv.conf.d/resolv.conf.auto
Sat Apr 16 13:06:51 2022 daemon.info dnsmasq[2656]: using only locally-known addresses for domain test
Sat Apr 16 13:06:51 2022 daemon.info dnsmasq[2656]: using only locally-known addresses for domain onion
Sat Apr 16 13:06:51 2022 daemon.info dnsmasq[2656]: using only locally-known addresses for domain localhost
Sat Apr 16 13:06:51 2022 daemon.info dnsmasq[2656]: using only locally-known addresses for domain local
Sat Apr 16 13:06:51 2022 daemon.info dnsmasq[2656]: using only locally-known addresses for domain invalid
Sat Apr 16 13:06:51 2022 daemon.info dnsmasq[2656]: using only locally-known addresses for domain bind
Sat Apr 16 13:06:51 2022 daemon.info dnsmasq[2656]: using only locally-known addresses for domain lan
Sat Apr 16 13:06:51 2022 daemon.info dnsmasq[2656]: using nameserver 218.4.4.4#53
Sat Apr 16 13:06:51 2022 daemon.info dnsmasq[2656]: using nameserver 218.2.2.2#53
Sat Apr 16 13:06:51 2022 daemon.info dnsmasq[2656]: using nameserver 218.4.4.4#53
Sat Apr 16 13:06:51 2022 daemon.info dnsmasq[2656]: using nameserver 218.2.2.2#53
Sat Apr 16 13:06:51 2022 user.notice firewall: Reloading firewall due to ifup of ltewan (wwan0)

bmork · May 4, 2022, 4:53am

Should be

    { QMI_QUIRK_SET_DTR(0x05C6, 0xF601, 5) },

or the modem won't respond to any command

fangxu1999 · May 4, 2022, 5:48am

Hi. I change the code as you said.

$ diff -u qmi_wwan.c qmi_wwan.c.old
--- qmi_wwan.c  2022-05-04 13:22:24.204685800 +0800
+++ qmi_wwan.c.old      2022-03-28 14:46:49.000000000 +0800
@@ -938,8 +938,6 @@
        .driver_info = (unsigned long)&qmi_wwan_info_quirk_dtr

 static const struct usb_device_id products[] = {
-    { QMI_QUIRK_SET_DTR(0x05C6, 0xF601, 5) },
-
        /* 1. CDC ECM like devices match on the control interface */
        {       /* Huawei E392, E398 and possibly others sharing both device id and more... */
                USB_VENDOR_AND_INTERFACE_INFO(HUAWEI_VENDOR_ID, USB_CLASS_VENDOR_SPEC, 1, 9),

Now it run as before.

only TX data, not RX data

This is output from ifconfig:

wwan0     Link encap:Ethernet  HWaddr 12:9F:B9:19:F2:4C
          inet6 addr: fe80::109f:b9ff:fe19:f24c/64 Scope:Link
          UP BROADCAST RUNNING MULTICAST  MTU:1500  Metric:1
          RX packets:0 errors:0 dropped:0 overruns:0 frame:0
          TX packets:185 errors:0 dropped:0 overruns:0 carrier:0
          collisions:0 txqueuelen:1000
          RX bytes:0 (0.0 B)  TX bytes:61702 (60.2 KiB)

This is part of system log:

Sat Apr 16 13:02:21 2022 daemon.notice netifd: Interface 'lte' is setting up now
Sat Apr 16 13:02:21 2022 daemon.notice netifd: lte (3125): Waiting for SIM initialization
Sat Apr 16 13:03:01 2022 daemon.notice netifd: Interface 'ltewan' is enabled
Sat Apr 16 13:03:01 2022 daemon.notice netifd: Network device 'wwan0' link is up
Sat Apr 16 13:03:01 2022 daemon.notice netifd: Interface 'ltewan' has link connectivity
Sat Apr 16 13:03:01 2022 daemon.notice netifd: Interface 'ltewan' is setting up now
Sat Apr 16 13:03:02 2022 daemon.notice netifd: ltewan (3367): udhcpc: started, v1.33.2
Sat Apr 16 13:03:02 2022 daemon.notice netifd: ltewan (3367): udhcpc: sending discover
Sat Apr 16 13:03:05 2022 daemon.notice netifd: ltewan (3367): udhcpc: sending discover
Sat Apr 16 13:03:08 2022 daemon.notice netifd: ltewan (3367): udhcpc: sending discover

This is part of kernel log:

[    9.262508] procd: - init -
[   11.762913] kmodloader: loading kernel modules from /etc/modules.d/*
[   12.051082] usbcore: registered new interface driver cdc_wdm
[   12.075417] Loading modules backported from Linux version v5.10.110-0-g3238bffaf992
[   12.090761] Backport generated by backports.git v5.10.110-1-0-g1fbde860
[   12.174397] usbcore: registered new interface driver usbserial_generic
[   12.187602] usbserial: USB Serial support registered for generic
[   12.253323] xt_time: kernel timezone is -0000
[   12.265656] urngd: jent-rng init failed, err: 2
[   12.442030] PPP generic driver version 2.4.2
[   12.453744] NET: Registered protocol family 24
[   12.467337] qmi_wwan 1-1.2:1.5: cdc-wdm0: USB WDM device
[   12.495227] qmi_wwan 1-1.2:1.5 wwan0: register 'qmi_wwan' at usb-101c0000.ehci-1.2, WWAN/QMI device, 12:9f:b9:19:f2:4c
[   12.516908] usbcore: registered new interface driver qmi_wwan
[   12.657537] usbcore: registered new interface driver option
[   12.668840] usbserial: USB Serial support registered for GSM modem (1-port)
[   12.683339] option 1-1.2:1.0: GSM modem (1-port) converter detected
[   12.696189] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB0
[   12.710334] option 1-1.2:1.1: GSM modem (1-port) converter detected
[   12.723232] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB1
[   12.737386] option 1-1.2:1.2: GSM modem (1-port) converter detected
[   12.750291] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB2
[   12.764428] option 1-1.2:1.3: GSM modem (1-port) converter detected
[   12.777309] usb 1-1.2: GSM modem (1-port) converter now attached to ttyUSB3
[   12.972522] rt2800_wmac 10180000.wmac: loaded eeprom from mtd device "factory"
[   12.987012] ieee80211 phy0: rt2x00_set_rt: Info - RT chipset 6352, rev 0500 detected
[   13.002484] ieee80211 phy0: rt2x00_set_rf: Info - RF chipset 7620 detected
[   13.016319] ieee80211 phy0: Selected rate control algorithm 'minstrel_ht'
[   13.066285] kmodloader: done loading kernel modules from /etc/modules.d/*
[   24.776746] crng init done
[   41.360952] jffs2_scan_eraseblock(): End of filesystem marker found at 0x0
[   41.398318] jffs2_build_filesystem(): unlocking the mtd device... 
[   41.399223] done.
[   41.415442] jffs2_build_filesystem(): erasing all blocks after the end marker... 
[   43.501114] 8021q: adding VLAN 0 to HW filter on device eth0
[   43.633210] br-lan: port 1(eth0.1) entered blocking state
[   43.644059] br-lan: port 1(eth0.1) entered disabled state
[   43.655251] device eth0.1 entered promiscuous mode
[   43.664866] device eth0 entered promiscuous mode
[   43.803319] br-lan: port 1(eth0.1) entered blocking state
[   43.814158] br-lan: port 1(eth0.1) entered forwarding state
[   44.521170] IPv6: ADDRCONF(NETDEV_CHANGE): br-lan: link becomes ready

Even if I reboot the device, it still doesn't work.

Where is wrong?

bmork · May 4, 2022, 6:02am

This is not in raw-ip mode like the OpenWrt qmi proto would have configured it.

mrhaav · May 4, 2022, 7:11am

fangxu1999:

Sat Apr 16 13:02:21 2022 daemon.notice netifd: Interface 'lte' is setting up now
Sat Apr 16 13:02:21 2022 daemon.notice netifd: lte (3125): Waiting for SIM initialization
Sat Apr 16 13:03:01 2022 daemon.notice netifd: Interface 'ltewan' is enabled
Sat Apr 16 13:03:01 2022 daemon.notice netifd: Network device 'wwan0' link is up
Sat Apr 16 13:03:01 2022 daemon.notice netifd: Interface 'ltewan' has link connectivity
Sat Apr 16 13:03:01 2022 daemon.notice netifd: Interface 'ltewan' is setting up now
Sat Apr 16 13:03:02 2022 daemon.notice netifd: ltewan (3367): udhcpc: started, v1.33.2
Sat Apr 16 13:03:02 2022 daemon.notice netifd: ltewan (3367): udhcpc: sending discover
Sat Apr 16 13:03:05 2022 daemon.notice netifd: ltewan (3367): udhcpc: sending discover
Sat Apr 16 13:03:08 2022 daemon.notice netifd: ltewan (3367): udhcpc: sending discover

Hi

I looks like your LTE modem is working, but I think you have to "disable" DHCP. There are no answers to the udhcpc: sending discover.

uci set network.ltewan.dhcp=0
uci commit network

fangxu1999 · May 5, 2022, 12:17pm

I modified qmi_wwan.c to Raw IP.

Then step through the qmi.sh script.

I found that when the following call is executed, it will always block

uqmi -s -d "$device" --get-pin-status
uqmi -s -d "$device" --stop-network

So I increase the -t 5000 timeout parameter, and chmod +x /lib/netifd/proto/qmi.sh.
Now it can work normally.

Thank you all

system · May 15, 2022, 12:18pm

This topic was automatically closed 10 days after the last reply. New replies are no longer allowed.