Page 2 of 2

Re: NanoSD Continually Reboots

Posted: Fri Sep 17, 2021 3:22 pm
by wilkerjnc
I have my route set for a maximum of 50 clients, with 24 as the max if all devices are configured.

I have not made any changes to any of the interfaces via the OpenWrt interface, just looked only at the logs and configurations; etc.

The frequency of these requests is very high it seems as seen in the latest log:

Code: Select all

<many previous...>
Fri Sep 17 09:06:32 2021 daemon.warn dnsmasq-dhcp[1184]: no address range available for DHCP request via apcli0
Fri Sep 17 09:08:33 2021 daemon.warn dnsmasq-dhcp[1184]: no address range available for DHCP request via apcli0
Fri Sep 17 09:08:33 2021 daemon.warn dnsmasq-dhcp[1184]: no address range available for DHCP request via apcli0
Fri Sep 17 09:09:42 2021 daemon.warn dnsmasq-dhcp[1184]: no address range available for DHCP request via apcli0
Fri Sep 17 09:09:42 2021 daemon.warn dnsmasq-dhcp[1184]: no address range available for DHCP request via apcli0
Fri Sep 17 09:11:07 2021 daemon.notice netifd: Network device 'ra0' link is up
Fri Sep 17 09:11:07 2021 daemon.notice netifd: Interface 'wwan' has link connectivity
Fri Sep 17 09:11:07 2021 kern.info kernel: [730853.415275] IPv6: ADDRCONF(NETDEV_UP): ra0: link is not ready
Fri Sep 17 09:11:07 2021 kern.info kernel: [730853.421317] IPv6: ADDRCONF(NETDEV_CHANGE): ra0: link becomes ready
Fri Sep 17 09:11:13 2021 daemon.err uhttpd[954]: ls: /sys/bus/usb/drivers/cdc_ether/: No such file or directory
Fri Sep 17 09:11:28 2021 daemon.notice netifd: Network device 'ra0' link is down
Fri Sep 17 09:11:28 2021 daemon.notice netifd: Interface 'wwan' has link connectivity loss

Re: NanoSD Continually Reboots

Posted: Fri Sep 17, 2021 4:07 pm
by wilkerjnc
Just for the sake of checking all the tests, I set the router to serve 100 IP addresses.

Then rebooted the NanoSD, which picked up a new address.

System log:

Code: Select all

Fri Sep 17 09:21:10 2021 kern.notice kernel: [    0.000000] Linux version 4.9.73 (boris@develop) (gcc version 5.5.0 (OpenWrt GCC 5.5.0 r5669-a367645) ) #0 Tue Jan 2 16:22:19 2018
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000000] Board has DDR2
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000000] Analog PMU set to hw control
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000000] Digital PMU set to hw control
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000000] SoC Type: MediaTek MT7628AN ver:1 eco:2
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000000] bootconsole [early0] enabled
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000000] CPU0 revision is: 00019655 (MIPS 24KEc)
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000000] MIPS: machine is VoCore2
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000000] Determined physical RAM map:
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000000]  memory: 08000000 @ 00000000 (usable)
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000000] Initrd not found or empty - disabling initrd
Fri Sep 17 09:21:10 2021 kern.warn kernel: [    0.000000] Primary instruction cache 64kB, VIPT, 4-way, linesize 32 bytes.
Fri Sep 17 09:21:10 2021 kern.warn kernel: [    0.000000] Primary data cache 32kB, 4-way, PIPT, no aliases, linesize 32 bytes
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000000] Zone ranges:
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000000]   Normal   [mem 0x0000000000000000-0x0000000007ffffff]
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000000] Movable zone start for each node
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000000] Early memory node ranges
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000000]   node   0: [mem 0x0000000000000000-0x0000000007ffffff]
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x0000000007ffffff]
Fri Sep 17 09:21:10 2021 kern.debug kernel: [    0.000000] On node 0 totalpages: 32768
Fri Sep 17 09:21:10 2021 kern.debug kernel: [    0.000000] free_area_init_node: node 0, pgdat 803f7174, node_mem_map 81000020
Fri Sep 17 09:21:10 2021 kern.debug kernel: [    0.000000]   Normal zone: 256 pages used for memmap
Fri Sep 17 09:21:10 2021 kern.debug kernel: [    0.000000]   Normal zone: 0 pages reserved
Fri Sep 17 09:21:10 2021 kern.debug kernel: [    0.000000]   Normal zone: 32768 pages, LIFO batch:7
Fri Sep 17 09:21:10 2021 kern.debug kernel: [    0.000000] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
Fri Sep 17 09:21:10 2021 kern.debug kernel: [    0.000000] pcpu-alloc: [0] 0
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 32512
Fri Sep 17 09:21:10 2021 kern.notice kernel: [    0.000000] Kernel command line: console=ttyS2,115200 rootfstype=squashfs,jffs2
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000000] PID hash table entries: 512 (order: -1, 2048 bytes)
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000000] Dentry cache hash table entries: 16384 (order: 4, 65536 bytes)
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000000] Inode-cache hash table entries: 8192 (order: 3, 32768 bytes)
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000000] Writing ErrCtl register=00068900
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000000] Readback ErrCtl register=00068900
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000000] Memory: 125420K/131072K available (3149K kernel code, 159K rwdata, 756K rodata, 152K init, 209K bss, 5652K reserved, 0K cma-reserved)
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000000] SLUB: HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000000] NR_IRQS:256
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000000] intc: using register map from devicetree
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000000] CPU Clock: 580MHz
Fri Sep 17 09:21:10 2021 kern.crit kernel: [    0.000000] clocksource_probe: no matching clocksources found
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000000] clocksource: MIPS: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 6590553264 ns
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.000012] sched_clock: 32 bits at 290MHz, resolution 3ns, wraps every 7405115902ns
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.007527] Calibrating delay loop... 385.84 BogoMIPS (lpj=1929216)
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.070044] pid_max: default: 32768 minimum: 301
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.074635] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.080975] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.093977] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.103466] futex hash table entries: 256 (order: -1, 3072 bytes)
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.109394] pinctrl core: initialized pinctrl subsystem
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.115085] NET: Registered protocol family 16
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.141777] mt7621_gpio 10000600.gpio: registering 32 gpios
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.147504] mt7621_gpio 10000600.gpio: registering 32 gpios
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.153043] mt7621_gpio 10000600.gpio: registering 32 gpios
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.162349] clocksource: Switched to clocksource MIPS
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.168492] NET: Registered protocol family 2
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.173554] TCP established hash table entries: 1024 (order: 0, 4096 bytes)
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.180245] TCP bind hash table entries: 1024 (order: 0, 4096 bytes)
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.186431] TCP: Hash tables configured (established 1024 bind 1024)
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.192631] UDP hash table entries: 256 (order: 0, 4096 bytes)
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.198227] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.204577] NET: Registered protocol family 1
Fri Sep 17 09:21:10 2021 kern.debug kernel: [    0.208751] PCI: CLS 0 bytes, default 32
Fri Sep 17 09:21:10 2021 kern.warn kernel: [    0.211724] Crashlog allocated RAM at address 0x3f00000
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.217920] workingset: timestamp_bits=30 max_order=15 bucket_order=0
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.232470] squashfs: version 4.0 (2009/01/31) Phillip Lougher
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.238044] jffs2: version 2.2 (NAND) (SUMMARY) (LZMA) (RTIME) (CMODE_PRIORITY) (c) 2001-2006 Red Hat, Inc.
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.256135] io scheduler noop registered
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.259866] io scheduler deadline registered (default)
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.265776] Serial: 8250/16550 driver, 3 ports, IRQ sharing disabled
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.273165] 10000c00.uartlite: ttyS0 at MMIO 0x10000c00 (irq = 28, base_baud = 2500000) is a 16550A
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.282428] 10000d00.uart1: ttyS1 at MMIO 0x10000d00 (irq = 29, base_baud = 2500000) is a 16550A
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.291397] 10000e00.uart2: ttyS2 at MMIO 0x10000e00 (irq = 30, base_baud = 2500000) is a 16550A
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.299920] console [ttyS2] enabled
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.306915] bootconsole [early0] disabled
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.316305] spi-mt7621 10000b00.spi: sys_freq: 193333333
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.327581] m25p80 spi32766.0: using chunked io (size=32)
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.333134] m25p80 spi32766.0: gd25q128 (16384 Kbytes)
Fri Sep 17 09:21:10 2021 kern.notice kernel: [    0.338373] 4 ofpart partitions found on MTD device spi32766.0
Fri Sep 17 09:21:10 2021 kern.notice kernel: [    0.344295] Creating 4 MTD partitions on "spi32766.0":
Fri Sep 17 09:21:10 2021 kern.notice kernel: [    0.349516] 0x000000000000-0x000000030000 : "u-boot"
Fri Sep 17 09:21:10 2021 kern.notice kernel: [    0.356326] 0x000000030000-0x000000040000 : "u-boot-env"
Fri Sep 17 09:21:10 2021 kern.notice kernel: [    0.363626] 0x000000040000-0x000000050000 : "factory"
Fri Sep 17 09:21:10 2021 kern.notice kernel: [    0.370565] 0x000000050000-0x000001000000 : "firmware"
Fri Sep 17 09:21:10 2021 kern.notice kernel: [    0.451126] 2 uimage-fw partitions found on MTD device firmware
Fri Sep 17 09:21:10 2021 kern.notice kernel: [    0.457174] 0x000000050000-0x00000019b0c4 : "kernel"
Fri Sep 17 09:21:10 2021 kern.notice kernel: [    0.463864] 0x00000019b0c4-0x000001000000 : "rootfs"
Fri Sep 17 09:21:10 2021 kern.notice kernel: [    0.470697] mtd: device 5 (rootfs) set to be root filesystem
Fri Sep 17 09:21:10 2021 kern.notice kernel: [    0.477062] 1 squashfs-split partitions found on MTD device rootfs
Fri Sep 17 09:21:10 2021 kern.notice kernel: [    0.483394] 0x000000770000-0x000001000000 : "rootfs_data"
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.491172] libphy: Fixed MDIO Bus: probed
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.505963] rt3050-esw 10110000.esw: link changed 0x00
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.512850] mtk_soc_eth 10100000.ethernet eth0: mediatek frame engine at 0xb0100000, irq 5
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.522884] NET: Registered protocol family 10
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.530456] NET: Registered protocol family 17
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.535103] 8021q: 802.1Q VLAN Support v1.8
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.551221] VFS: Mounted root (squashfs filesystem) readonly on device 31:5.
Fri Sep 17 09:21:10 2021 kern.info kernel: [    0.559268] Freeing unused kernel memory: 152K
Fri Sep 17 09:21:10 2021 kern.warn kernel: [    0.563805] This architecture does not have kernel memory protection.
Fri Sep 17 09:21:10 2021 user.info kernel: [    1.711712] init: Console is alive
Fri Sep 17 09:21:10 2021 user.info kernel: [    1.715492] init: - watchdog -
Fri Sep 17 09:21:10 2021 kern.notice kernel: [    2.195305] random: fast init done
Fri Sep 17 09:21:10 2021 user.info kernel: [    3.934032] kmodloader: loading kernel modules from /etc/modules-boot.d/*
Fri Sep 17 09:21:10 2021 kern.info kernel: [    4.185936] usbcore: registered new interface driver usbfs
Fri Sep 17 09:21:10 2021 kern.info kernel: [    4.191635] usbcore: registered new interface driver hub
Fri Sep 17 09:21:10 2021 kern.info kernel: [    4.197200] usbcore: registered new device driver usb
Fri Sep 17 09:21:10 2021 kern.info kernel: [    4.234275] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
Fri Sep 17 09:21:10 2021 kern.notice kernel: [    4.250139] SCSI subsystem initialized
Fri Sep 17 09:21:10 2021 kern.info kernel: [    4.259178] ehci-platform: EHCI generic platform driver
Fri Sep 17 09:21:10 2021 kern.info kernel: [    4.274839] phy phy-10120000.usbphy.0: remote usb device wakeup disabled
Fri Sep 17 09:21:10 2021 kern.info kernel: [    4.281640] phy phy-10120000.usbphy.0: UTMI 16bit 30MHz
Fri Sep 17 09:21:10 2021 kern.info kernel: [    4.286990] ehci-platform 101c0000.ehci: EHCI Host Controller
Fri Sep 17 09:21:10 2021 kern.info kernel: [    4.292870] ehci-platform 101c0000.ehci: new USB bus registered, assigned bus number 1
Fri Sep 17 09:21:10 2021 kern.info kernel: [    4.301032] ehci-platform 101c0000.ehci: irq 26, io mem 0x101c0000
Fri Sep 17 09:21:10 2021 kern.info kernel: [    4.332392] ehci-platform 101c0000.ehci: USB 2.0 started, EHCI 1.00
Fri Sep 17 09:21:10 2021 kern.info kernel: [    4.339845] hub 1-0:1.0: USB hub found
Fri Sep 17 09:21:10 2021 kern.info kernel: [    4.344070] hub 1-0:1.0: 1 port detected
Fri Sep 17 09:21:10 2021 kern.info kernel: [    4.352761] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
Fri Sep 17 09:21:10 2021 kern.info kernel: [    4.360575] ohci-platform: OHCI generic platform driver
Fri Sep 17 09:21:10 2021 kern.info kernel: [    4.366217] ohci-platform 101c1000.ohci: Generic Platform OHCI controller
Fri Sep 17 09:21:10 2021 kern.info kernel: [    4.373189] ohci-platform 101c1000.ohci: new USB bus registered, assigned bus number 2
Fri Sep 17 09:21:10 2021 kern.info kernel: [    4.381319] ohci-platform 101c1000.ohci: irq 26, io mem 0x101c1000
Fri Sep 17 09:21:10 2021 kern.info kernel: [    4.457426] hub 2-0:1.0: USB hub found
Fri Sep 17 09:21:10 2021 kern.info kernel: [    4.461650] hub 2-0:1.0: 1 port detected
Fri Sep 17 09:21:10 2021 kern.warn kernel: [    4.478637] MTK MSDC device init.
Fri Sep 17 09:21:10 2021 kern.info kernel: [    4.542518] mtk-sd: MediaTek MT6575 MSDC Driver
Fri Sep 17 09:21:10 2021 kern.info kernel: [    4.553304] sdhci: Secure Digital Host Controller Interface driver
Fri Sep 17 09:21:10 2021 kern.info kernel: [    4.559595] sdhci: Copyright(c) Pierre Ossman
Fri Sep 17 09:21:10 2021 kern.info kernel: [    4.565613] sdhci-pltfm: SDHCI platform and OF driver helper
Fri Sep 17 09:21:10 2021 kern.info kernel: [    4.577338] usbcore: registered new interface driver usb-storage
Fri Sep 17 09:21:10 2021 user.info kernel: [    4.588967] kmodloader: done loading kernel modules from /etc/modules-boot.d/*
Fri Sep 17 09:21:10 2021 user.info kernel: [    4.606861] init: - preinit -
Fri Sep 17 09:21:10 2021 kern.info kernel: [    5.059169] mmc0: new high speed SD card at address 0001
Fri Sep 17 09:21:10 2021 kern.info kernel: [    5.074034] mmcblk0: mmc0:0001 N1BM1 1.88 GiB
Fri Sep 17 09:21:10 2021 kern.info kernel: [    5.085251]  mmcblk0: p1
Fri Sep 17 09:21:10 2021 kern.info kernel: [    6.413069] rt3050-esw 10110000.esw: link changed 0x00
Fri Sep 17 09:21:10 2021 user.info kernel: [    9.743636] mount_root: loading kmods from internal overlay
Fri Sep 17 09:21:10 2021 user.info kernel: [    9.787603] kmodloader: loading kernel modules from //etc/modules-boot.d/*
Fri Sep 17 09:21:10 2021 user.info kernel: [    9.796687] kmodloader: done loading kernel modules from //etc/modules-boot.d/*
Fri Sep 17 09:21:10 2021 kern.notice kernel: [   11.737430] jffs2: notice: (391) jffs2_build_xattr_subsystem: complete building xattr subsystem, 0 of xdatum (0 unchecked, 0 orphan) and 0 of xref (0 dead, 0 orphan) found.
Fri Sep 17 09:21:10 2021 user.info kernel: [   11.753810] block: attempting to load /tmp/jffs_cfg/upper/etc/config/fstab
Fri Sep 17 09:21:10 2021 user.info kernel: [   11.767384] block: extroot: not configured
Fri Sep 17 09:21:10 2021 kern.notice kernel: [   12.002638] jffs2: notice: (388) jffs2_build_xattr_subsystem: complete building xattr subsystem, 0 of xdatum (0 unchecked, 0 orphan) and 0 of xref (0 dead, 0 orphan) found.
Fri Sep 17 09:21:10 2021 user.info kernel: [   12.020025] mount_root: loading kmods from internal overlay
Fri Sep 17 09:21:10 2021 user.info kernel: [   12.078226] kmodloader: loading kernel modules from /tmp/overlay/upper/etc/modules-boot.d/*
Fri Sep 17 09:21:10 2021 user.info kernel: [   12.091057] kmodloader: done loading kernel modules from /tmp/overlay/upper/etc/modules-boot.d/*
Fri Sep 17 09:21:10 2021 user.info kernel: [   15.782142] block: attempting to load /tmp/jffs_cfg/upper/etc/config/fstab
Fri Sep 17 09:21:10 2021 user.info kernel: [   15.792859] block: extroot: not configured
Fri Sep 17 09:21:10 2021 user.info kernel: [   15.798291] mount_root: switching to jffs2 overlay
Fri Sep 17 09:21:10 2021 user.warn kernel: [   15.850511] urandom-seed: Seeding with /etc/urandom.seed
Fri Sep 17 09:21:10 2021 user.info kernel: [   16.005591] procd: - early -
Fri Sep 17 09:21:10 2021 user.info kernel: [   16.008618] procd: - watchdog -
Fri Sep 17 09:21:10 2021 user.info kernel: [   16.719718] procd: - watchdog -
Fri Sep 17 09:21:10 2021 user.info kernel: [   16.729470] procd: - ubus -
Fri Sep 17 09:21:10 2021 user.info kernel: [   17.277028] procd: - init -
Fri Sep 17 09:21:10 2021 user.info kernel: [   18.971727] kmodloader: loading kernel modules from /etc/modules.d/*
Fri Sep 17 09:21:10 2021 kern.info kernel: [   19.185208] ip6_tables: (C) 2000-2006 Netfilter Core Team
Fri Sep 17 09:21:10 2021 kern.info kernel: [   19.249483] hidraw: raw HID events driver (C) Jiri Kosina
Fri Sep 17 09:21:10 2021 kern.info kernel: [   19.279535] ip_tables: (C) 2000-2006 Netfilter Core Team
Fri Sep 17 09:21:10 2021 kern.info kernel: [   20.421033] nf_conntrack version 0.5.0 (2048 buckets, 8192 max)
Fri Sep 17 09:21:10 2021 kern.info kernel: [   20.586547] usbcore: registered new interface driver usbhid
Fri Sep 17 09:21:10 2021 kern.info kernel: [   20.592208] usbhid: USB HID core driver
Fri Sep 17 09:21:10 2021 kern.info kernel: [   20.607325] usbcore: registered new interface driver usbserial
Fri Sep 17 09:21:10 2021 kern.info kernel: [   20.613440] usbcore: registered new interface driver usbserial_generic
Fri Sep 17 09:21:10 2021 kern.info kernel: [   20.620179] usbserial: USB Serial support registered for generic
Fri Sep 17 09:21:10 2021 kern.info kernel: [   20.765352] xt_time: kernel timezone is -0000
Fri Sep 17 09:21:10 2021 kern.info kernel: [   20.771831] usbcore: registered new interface driver ch341
Fri Sep 17 09:21:10 2021 kern.info kernel: [   20.777612] usbserial: USB Serial support registered for ch341-uart
Fri Sep 17 09:21:10 2021 kern.info kernel: [   20.787967] usbcore: registered new interface driver cp210x
Fri Sep 17 09:21:10 2021 kern.info kernel: [   20.793847] usbserial: USB Serial support registered for cp210x
Fri Sep 17 09:21:10 2021 kern.info kernel: [   20.804849] usbcore: registered new interface driver ftdi_sio
Fri Sep 17 09:21:10 2021 kern.info kernel: [   20.810793] usbserial: USB Serial support registered for FTDI USB Serial Device
Fri Sep 17 09:21:10 2021 kern.info kernel: [   20.831091] usbcore: registered new interface driver pl2303
Fri Sep 17 09:21:10 2021 kern.info kernel: [   20.836956] usbserial: USB Serial support registered for pl2303
Fri Sep 17 09:21:10 2021 kern.info kernel: [   20.848941] PPP generic driver version 2.4.2
Fri Sep 17 09:21:10 2021 kern.info kernel: [   20.857253] NET: Registered protocol family 24
Fri Sep 17 09:21:10 2021 kern.info kernel: [   20.868454] usbcore: registered new interface driver option
Fri Sep 17 09:21:10 2021 kern.info kernel: [   20.874303] usbserial: USB Serial support registered for GSM modem (1-port)
Fri Sep 17 09:21:10 2021 user.info kernel: [   20.902934] kmodloader: done loading kernel modules from /etc/modules.d/*
Fri Sep 17 09:21:12 2021 user.notice : Added device handler type: tunnel
Fri Sep 17 09:21:12 2021 user.notice : Added device handler type: Network device
Fri Sep 17 09:21:12 2021 user.notice : Added device handler type: bridge
Fri Sep 17 09:21:12 2021 user.notice : Added device handler type: veth
Fri Sep 17 09:21:12 2021 user.notice : Added device handler type: macvlan
Fri Sep 17 09:21:12 2021 user.notice : Added device handler type: 8021ad
Fri Sep 17 09:21:12 2021 user.notice : Added device handler type: 8021q
Fri Sep 17 09:21:12 2021 daemon.notice procd: /etc/init.d/network: radio0(mac80211): Interface type not supported
Fri Sep 17 09:21:12 2021 daemon.notice procd: /etc/init.d/network: radio0(mac80211): Interface type not supported
Fri Sep 17 09:21:13 2021 daemon.notice netifd: Interface 'lan' is enabled
Fri Sep 17 09:21:13 2021 daemon.notice netifd: Interface 'lan' is setting up now
Fri Sep 17 09:21:13 2021 daemon.notice netifd: Interface 'lan' is now up
Fri Sep 17 09:21:13 2021 daemon.notice netifd: Interface 'loopback' is enabled
Fri Sep 17 09:21:13 2021 daemon.notice netifd: Interface 'loopback' is setting up now
Fri Sep 17 09:21:13 2021 daemon.notice netifd: Interface 'loopback' is now up
Fri Sep 17 09:21:14 2021 daemon.err block: /dev/mtdblock5 is already mounted on /rom
Fri Sep 17 09:21:14 2021 daemon.err block: /dev/mtdblock6 is already mounted on /overlay
Fri Sep 17 09:21:16 2021 user.notice firewall: Reloading firewall due to ifup of lan (eth0)
Fri Sep 17 09:21:16 2021 authpriv.info dropbear[924]: Not backgrounding
Fri Sep 17 09:21:20 2021 kern.warn kernel: [   32.687518] rt28xx_init, status=0
Fri Sep 17 09:21:20 2021 daemon.notice netifd: Interface 'wwan' is enabled
Fri Sep 17 09:21:20 2021 daemon.notice netifd: Interface 'wwan' is setting up now
Fri Sep 17 09:21:20 2021 daemon.notice netifd: Interface 'wwan' is now up
Fri Sep 17 09:21:20 2021 daemon.notice netifd: Network device 'eth0' link is up
Fri Sep 17 09:21:20 2021 daemon.notice netifd: Interface 'lan' has link connectivity
Fri Sep 17 09:21:20 2021 daemon.notice netifd: Interface 'wlan' is enabled
Fri Sep 17 09:21:20 2021 daemon.notice netifd: Network device 'lo' link is up
Fri Sep 17 09:21:20 2021 daemon.notice netifd: Interface 'loopback' has link connectivity
Fri Sep 17 09:21:20 2021 daemon.notice netifd: Network device 'apcli0' link is up
Fri Sep 17 09:21:20 2021 daemon.notice netifd: Interface 'wlan' has link connectivity
Fri Sep 17 09:21:20 2021 daemon.notice netifd: Interface 'wlan' is setting up now
Fri Sep 17 09:21:20 2021 daemon.notice netifd: Network device 'ra0' link is up
Fri Sep 17 09:21:20 2021 daemon.notice netifd: Interface 'wwan' has link connectivity
Fri Sep 17 09:21:20 2021 daemon.notice netifd: wlan (1061): udhcpc: started, v1.27.2
Fri Sep 17 09:21:21 2021 daemon.notice netifd: wlan (1061): udhcpc: sending discover
Fri Sep 17 09:21:23 2021 daemon.notice procd: /etc/rc.d/S95done:   _______                     ________        __
Fri Sep 17 09:21:23 2021 daemon.notice procd: /etc/rc.d/S95done:  |       |.-----.-----.-----.|  |  |  |.----.|  |_
Fri Sep 17 09:21:23 2021 daemon.notice procd: /etc/rc.d/S95done:  |   -   ||  _  |  -__|     ||  |  |  ||   _||   _|
Fri Sep 17 09:21:23 2021 daemon.notice procd: /etc/rc.d/S95done:  |_______||   __|_____|__|__||________||__|  |____|
Fri Sep 17 09:21:23 2021 daemon.notice procd: /etc/rc.d/S95done:           |__| W I R E L E S S   F R E E D O M
Fri Sep 17 09:21:23 2021 daemon.notice procd: /etc/rc.d/S95done:  -----------------------------------------------------
Fri Sep 17 09:21:23 2021 daemon.notice procd: /etc/rc.d/S95done:  OpenWrt SNAPSHOT, r5669-a367645
Fri Sep 17 09:21:23 2021 daemon.notice procd: /etc/rc.d/S95done:  -----------------------------------------------------
Fri Sep 17 09:21:23 2021 daemon.notice procd: /etc/rc.d/S95done: /etc/rc.local: line 23: can't create /sys/class/leds/tl-wr902ac-v1:green:wps/trigger: nonexistent directory
Fri Sep 17 09:21:24 2021 daemon.notice netifd: wlan (1061): udhcpc: sending discover
Fri Sep 17 09:21:24 2021 daemon.info dnsmasq[1185]: started, version 2.78 cachesize 150
Fri Sep 17 09:21:24 2021 daemon.info dnsmasq[1185]: compile time options: IPv6 GNU-getopt no-DBus no-i18n no-IDN DHCP no-DHCPv6 no-Lua TFTP no-conntrack no-ipset no-auth no-DNSSEC no-ID loop-detect inotify
Fri Sep 17 09:21:24 2021 daemon.info dnsmasq-dhcp[1185]: DHCP, IP range 192.168.169.200 -- 192.168.169.254, lease time 12h
Fri Sep 17 09:21:24 2021 daemon.info dnsmasq[1185]: using local addresses only for domain test
Fri Sep 17 09:21:24 2021 daemon.info dnsmasq[1185]: using local addresses only for domain onion
Fri Sep 17 09:21:24 2021 daemon.info dnsmasq[1185]: using local addresses only for domain localhost
Fri Sep 17 09:21:24 2021 daemon.info dnsmasq[1185]: using local addresses only for domain local
Fri Sep 17 09:21:24 2021 daemon.info dnsmasq[1185]: using local addresses only for domain invalid
Fri Sep 17 09:21:24 2021 daemon.info dnsmasq[1185]: using local addresses only for domain example.net
Fri Sep 17 09:21:24 2021 daemon.info dnsmasq[1185]: using local addresses only for domain example.org
Fri Sep 17 09:21:24 2021 daemon.info dnsmasq[1185]: using local addresses only for domain example.com
Fri Sep 17 09:21:24 2021 daemon.info dnsmasq[1185]: using 3 more local addresses
Fri Sep 17 09:21:24 2021 daemon.warn dnsmasq[1185]: no servers found in /tmp/resolv.conf.auto, will retry
Fri Sep 17 09:21:24 2021 daemon.info dnsmasq[1185]: read /etc/hosts - 4 addresses
Fri Sep 17 09:21:24 2021 daemon.info dnsmasq[1185]: read /tmp/hosts/dhcp.cfg01411c - 1 addresses
Fri Sep 17 09:21:24 2021 daemon.info dnsmasq-dhcp[1185]: read /etc/ethers - 0 addresses
Fri Sep 17 09:21:25 2021 daemon.info dnsmasq[1185]: read /etc/hosts - 4 addresses
Fri Sep 17 09:21:25 2021 daemon.info dnsmasq[1185]: read /tmp/hosts/dhcp.cfg01411c - 1 addresses
Fri Sep 17 09:21:25 2021 daemon.info dnsmasq-dhcp[1185]: read /etc/ethers - 0 addresses
Fri Sep 17 09:21:27 2021 daemon.notice netifd: wlan (1061): udhcpc: sending discover
Fri Sep 17 09:21:31 2021 daemon.notice procd: /etc/rc.d/S95done: ### start.sh
Fri Sep 17 09:21:31 2021 user.warn kernel: [   43.532651] start /root/start.sh
Fri Sep 17 09:21:31 2021 daemon.notice procd: /etc/rc.d/S95done: HW: VoCore2
Fri Sep 17 09:21:31 2021 daemon.notice procd: /etc/rc.d/S95done: FW: 1.4
Fri Sep 17 09:21:31 2021 daemon.notice procd: /etc/rc.d/S95done: MAC: B8:D8:12:60:5A:60
Fri Sep 17 09:21:37 2021 daemon.notice procd: /etc/rc.d/S95done: PASS: meteobridge
Fri Sep 17 09:21:37 2021 daemon.notice procd: /etc/rc.d/S95done: ra0 rebuilt
Fri Sep 17 09:21:43 2021 daemon.notice procd: /etc/rc.d/S95done: set to channel 5
Fri Sep 17 09:21:43 2021 daemon.notice procd: /etc/rc.d/S95done: set low power
Fri Sep 17 09:21:47 2021 daemon.notice procd: /etc/rc.d/S95done: no rescue download
Fri Sep 17 09:21:47 2021 daemon.notice procd: /etc/rc.d/S95done: LED path: /sys/class/leds/vocore2:fuchsia:status
Fri Sep 17 09:21:47 2021 daemon.notice procd: /etc/rc.d/S95done: accepted microSD card: N1BM1
Fri Sep 17 09:21:47 2021 daemon.notice procd: /etc/rc.d/S95done: Meteobridge NANO storage, device /dev/mmcblk0p1.
Fri Sep 17 09:21:48 2021 kern.err kernel: [   60.315650] EXT4-fs (mmcblk0p1): couldn't mount as ext3 due to feature incompatibilities
Fri Sep 17 09:21:48 2021 kern.err kernel: [   60.326289] EXT4-fs (mmcblk0p1): couldn't mount as ext2 due to feature incompatibilities
Fri Sep 17 09:21:48 2021 kern.info kernel: [   60.357834] EXT4-fs (mmcblk0p1): mounted filesystem with ordered data mode. Opts: (null)
Fri Sep 17 09:21:48 2021 kern.info kernel: [   60.427084] EXT4-fs (mmcblk0p1): mounted filesystem with ordered data mode. Opts: (null)
Fri Sep 17 09:21:48 2021 daemon.notice procd: /etc/rc.d/S95done: Use existing formatted SD card
Fri Sep 17 09:21:48 2021 daemon.notice procd: /etc/rc.d/S95done: start filesystem check: /dev/mmcblk0p1
Fri Sep 17 09:21:48 2021 daemon.notice procd: /etc/rc.d/S95done: /dev/mmcblk0p1: clean, 2173/123136 files, 29798/492256 blocks
Fri Sep 17 09:21:48 2021 kern.notice kernel: [   61.085882] random: crng init done
Fri Sep 17 09:21:48 2021 daemon.notice procd: /etc/rc.d/S95done: filesystem is fine
Fri Sep 17 09:21:48 2021 kern.err kernel: [   61.099694] EXT4-fs (mmcblk0p1): couldn't mount as ext3 due to feature incompatibilities
Fri Sep 17 09:21:48 2021 kern.err kernel: [   61.110090] EXT4-fs (mmcblk0p1): couldn't mount as ext2 due to feature incompatibilities
Fri Sep 17 09:21:48 2021 daemon.notice procd: /etc/rc.d/S95done: SD card mounted
Fri Sep 17 09:21:48 2021 kern.info kernel: [   61.135235] EXT4-fs (mmcblk0p1): mounted filesystem with ordered data mode. Opts: (null)
Fri Sep 17 09:21:54 2021 daemon.notice netifd: wlan (1061): udhcpc: sending select for 10.243.1.182
Fri Sep 17 09:21:55 2021 daemon.notice netifd: wlan (1061): udhcpc: lease of 10.243.1.182 obtained, lease time 86400
Fri Sep 17 09:21:55 2021 daemon.notice netifd: Interface 'wlan' is now up
Fri Sep 17 09:21:55 2021 daemon.info dnsmasq[1185]: reading /tmp/resolv.conf.auto
Fri Sep 17 09:21:55 2021 daemon.info dnsmasq[1185]: using local addresses only for domain test
Fri Sep 17 09:21:55 2021 daemon.info dnsmasq[1185]: using local addresses only for domain onion
Fri Sep 17 09:21:55 2021 daemon.info dnsmasq[1185]: using local addresses only for domain localhost
Fri Sep 17 09:21:55 2021 daemon.info dnsmasq[1185]: using local addresses only for domain local
Fri Sep 17 09:21:55 2021 daemon.info dnsmasq[1185]: using local addresses only for domain invalid
Fri Sep 17 09:21:55 2021 daemon.info dnsmasq[1185]: using local addresses only for domain example.net
Fri Sep 17 09:21:55 2021 daemon.info dnsmasq[1185]: using local addresses only for domain example.org
Fri Sep 17 09:21:55 2021 daemon.info dnsmasq[1185]: using local addresses only for domain example.com
Fri Sep 17 09:21:55 2021 daemon.info dnsmasq[1185]: using nameserver 10.243.1.1#53
Fri Sep 17 09:21:55 2021 daemon.info dnsmasq[1185]: using 3 more local addresses
Fri Sep 17 09:21:55 2021 user.notice firewall: Reloading firewall due to ifup of wlan (apcli0)
Fri Sep 17 09:21:58 2021 daemon.info dnsmasq[1185]: read /etc/hosts - 4 addresses
Fri Sep 17 09:21:58 2021 daemon.info dnsmasq[1185]: read /tmp/hosts/dhcp.cfg01411c - 1 addresses
Fri Sep 17 09:21:58 2021 daemon.info dnsmasq-dhcp[1185]: read /etc/ethers - 0 addresses
Fri Sep 17 09:23:09 2021 daemon.warn dnsmasq-dhcp[1185]: no address range available for DHCP request via apcli0
Fri Sep 17 09:23:09 2021 daemon.warn dnsmasq-dhcp[1185]: no address range available for DHCP request via apcli0
Fri Sep 17 09:23:11 2021 daemon.warn dnsmasq-dhcp[1185]: no address range available for DHCP request via apcli0
Fri Sep 17 09:23:19 2021 user.warn kernel: [  151.598311] extract meteobridge archive
Fri Sep 17 09:23:19 2021 daemon.notice procd: /etc/rc.d/S95done: start downloading application stack from internet... done
Fri Sep 17 09:23:23 2021 user.warn kernel: [  155.897324] done /root/start.sh
Fri Sep 17 09:23:23 2021 user.warn kernel: [  155.906556] start /home/setup.sh
Fri Sep 17 09:23:23 2021 daemon.notice procd: /etc/rc.d/S95done: ### setup.sh
Fri Sep 17 09:23:23 2021 daemon.notice procd: /etc/rc.d/S95done: Hardware: VoCore2
Fri Sep 17 09:23:23 2021 daemon.notice procd: /etc/rc.d/S95done: LED path: /sys/class/leds/vocore2:fuchsia:status
Fri Sep 17 09:23:23 2021 daemon.notice procd: /etc/rc.d/S95done: Reseller:
Fri Sep 17 09:23:24 2021 kern.info kernel: [  156.837605] EXT4-fs (mmcblk0p1): re-mounted. Opts: stripe=2,data=ordered,commit=60,max_batch_time=1000000,min_batch_time=1000000,errors=remount-ro
Fri Sep 17 09:25:51 2021 daemon.notice procd: /etc/rc.d/S95done: read time from meteobridge server: Fri Sep 17 09:25:51 EDT 2021
Fri Sep 17 09:25:51 2021 daemon.notice procd: /etc/rc.d/S95done: get IP tracker information.
Fri Sep 17 09:25:52 2021 daemon.notice procd: /etc/rc.d/S95done: error: cannot get TimeLine
Fri Sep 17 09:26:05 2021 daemon.notice procd: /etc/rc.d/S95done: no database integrity test requested.
Fri Sep 17 09:26:05 2021 daemon.notice procd: /etc/rc.d/S95done: Starting databased... done.
Fri Sep 17 09:26:07 2021 daemon.notice procd: /etc/rc.d/S95done: database daemon started... done
Fri Sep 17 09:26:07 2021 daemon.notice procd: /etc/rc.d/S95done: load meteotemplate... done
Fri Sep 17 09:26:08 2021 daemon.notice procd: /etc/rc.d/S95done: load hwstemplate... done
Fri Sep 17 09:26:08 2021 daemon.notice procd: /etc/rc.d/S95done: load hwstemplate2... done
Fri Sep 17 09:26:08 2021 daemon.notice procd: /etc/rc.d/S95done: load swisstemplate... done
Fri Sep 17 09:26:08 2021 daemon.notice procd: /etc/rc.d/S95done: Starting wnetd... done.
Fri Sep 17 09:26:08 2021 daemon.notice procd: /etc/rc.d/S95done: weather network daemon started.
Fri Sep 17 09:26:09 2021 daemon.notice procd: /etc/rc.d/S95done: Starting loggerd... done.
Fri Sep 17 09:26:09 2021 daemon.notice procd: /etc/rc.d/S95done: data logger started
Fri Sep 17 09:26:09 2021 daemon.notice procd: /etc/rc.d/S95done: sleep 0 secs
Fri Sep 17 09:26:09 2021 daemon.notice procd: /etc/rc.d/S95done: restart reboot helper
Fri Sep 17 09:26:09 2021 daemon.notice procd: /etc/rc.d/S95done: PING www.google.de (142.251.33.195): 56 data bytes
Fri Sep 17 09:26:10 2021 daemon.notice procd: /etc/rc.d/S95done:
Fri Sep 17 09:26:10 2021 daemon.notice procd: /etc/rc.d/S95done: --- www.google.de ping statistics ---
Fri Sep 17 09:26:10 2021 daemon.notice procd: /etc/rc.d/S95done: 2 packets transmitted, 2 packets received, 0% packet loss
Fri Sep 17 09:26:10 2021 daemon.notice procd: /etc/rc.d/S95done: round-trip min/avg/max = 14.742/15.645/16.548 ms
Fri Sep 17 09:26:10 2021 daemon.notice procd: /etc/rc.d/S95done: WiFi no power change
Fri Sep 17 09:26:11 2021 daemon.notice procd: /etc/rc.d/S95done: cat: can't open '/var/run/lastday': No such file or directory
Fri Sep 17 09:26:13 2021 user.warn kernel: [  180.946047] done /home/setup.sh
Fri Sep 17 09:26:15 2021 daemon.info procd: - init complete -
Fri Sep 17 09:26:18 2021 daemon.info dnsmasq[1185]: read /etc/hosts - 4 addresses
Fri Sep 17 09:26:18 2021 daemon.info dnsmasq[1185]: read /tmp/hosts/dhcp.cfg01411c - 1 addresses
Fri Sep 17 09:26:18 2021 daemon.info dnsmasq-dhcp[1185]: read /etc/ethers - 0 addresses
Fri Sep 17 09:27:27 2021 daemon.err uhttpd[955]: ls: /sys/bus/usb/drivers/cdc_ether/: No such file or directory
Fri Sep 17 09:37:06 2021 daemon.warn dnsmasq-dhcp[1185]: no address range available for DHCP request via apcli0
Fri Sep 17 09:41:01 2021 daemon.notice netifd: Network device 'ra0' link is down
Fri Sep 17 09:41:01 2021 daemon.notice netifd: Interface 'wwan' has link connectivity loss
Fri Sep 17 09:41:37 2021 daemon.warn dnsmasq-dhcp[1185]: no address range available for DHCP request via apcli0
(and this line again continually...)
Looking in the OpenWrt interface, the Interface Overview shows both the LAN (eth0) and WLAN (apcli0) interfaces as up.

LAN eth0
Uptime: 0h 42m 23s
MAC-Address: B8:D8:12:60:5A:60
RX: 0 B (0 Pkts.)
TX: 14.80 KB (90 Pkts.)
IPv4: 192.168.168.1/24

WLAN apcli0
Uptime: 0h 42m 20s
MAC-Address: BA:D8:12:00:5A:60
RX: 0 B (0 Pkts.)
TX: 0 B (0 Pkts.)
IPv4: 10.243.1.182/24

As I am wireless connected, is this correct?

Re: NanoSD Continually Reboots

Posted: Mon Sep 20, 2021 3:26 pm
by wilkerjnc
At this point, I would say

Item 1: The continual reboot of the NanoSD = Solved by the higher capacity power supply, replacing the stock Davis model.
Item 2: The repeated network restarting of the NanoSD = Solved by stopping the Weewx version 4.5.1 running on Linux. This is kind of a bummer as I liked the charting and historical data I could get from this. I will start a thread over in the Weewx forum and see what they can come up with.

Item 3:

Still the repeated

Code: Select all

Mon Sep 20 09:16:15 2021 daemon.warn dnsmasq-dhcp[1185]: no address range available for DHCP request via apcli0
seen in the system log.

Re: NanoSD Continually Reboots

Posted: Tue Sep 21, 2021 6:53 pm
by Mattk
Right now have two (2) NanoSD's continuously rebooting (almost in sync) for the past 5 minutes, very strange. Current time is 16:52 UTC (21/9/2021)