Bug 12621

Summary: busybox syslog missing a lot of kernel messages when kernel bootup（compare with serial port outputs or dmesg outputs）
Product: Busybox Reporter: jack back <1204539207>
Component: OtherAssignee: unassigned
Status: NEW ---    
Severity: normal CC: busybox-cvs
Priority: P5    
Version: 1.22.x   
Target Milestone: ---   
Hardware: Other   
OS: Other   
Host: Target:
Build:
Attachments: openwrt config file （rar type file, need to unpack first then can see .config）

Description jack back 2020-03-09 06:47:20 UTC 
I'm using busybox-1.22.1 on an embedded system running Linux kernel 3.10.34. The system is openwrt and the cpu architecture is MIPS 1004Kc V2.15（Soc：MTK 7621A）.

I check the system.log file and find it has less logs then serial port or dmesg outputs, below I'll list the output：

1. logs in system.log
2020.03.03-16:29:16  info  syslogd started: BusyBox v1.22.1                                                                     
2020.03.03-16:29:16  notice  kernel: [    0.000000] Linux version 3.10.34 (yanai.wang@localhost.localdomain) (gcc version 4.8.3 (OpenWrt/Linaro GCC 4.8-2014.04 r288) ) #1 SMP Mon Mar 2 12:28
2020.03.03-16:29:16  info  kernel: [    0.000000] SoC Type: Mediatek MT7621 ver:1 eco:3                                     
2020.03.03-16:29:16  info  kernel: [    0.000000] bootconsole [early0] enabled                                                       
2020.03.03-16:29:16  info  kernel: [    0.000000] CPU revision is: 0001992f (MIPS 1004Kc)                                     
2020.03.03-16:29:16  info  kernel: [    0.000000] MIPS: machine is WiTown board                                                 
2020.03.03-16:29:16  info  kernel: [    0.000000] Determined physical RAM map:                                                   
2020.03.03-16:29:16  info  kernel: [    0.000000]  memory: 10000000 @ 00000000 (usable)                                   
2020.03.03-16:29:16  info  kernel: [    0.000000] Initrd not found or empty - disabling initrd                                   
2020.03.03-16:29:16  warn  kernel: [    0.000000] Zone ranges:                                                               
2020.03.03-16:29:16  warn  kernel: [    0.000000]   Normal   [mem 0x00000000-0x0fffffff] 
2020.03.04-10:17:19  warn  kernel: [    0.000000] Movable zone start for each node       
2020.03.04-10:17:19  info  kernel: [    1.970000] pci 0000:00:01.0: BAR 9: assigned [mem 0x60200000-0x602fffff pref]
2020.03.04-10:17:19  warn  kernel: [    2.710000] FM_OUT value: u4FmOut = 0(0x00000000)                             
2020.03.04-10:17:19  info  kernel: [    9.470000] xt_time: kernel timezone is -0000                                 
2020.03.04-10:17:19  emerg  syslog: ls: /etc/log/crashlog.*: No such file or directory       
2020.03.04-10:17:21  notice  netifd: netifd start ...                                         
2020.03.04-10:17:21  warn  kernel: [   14.320000] raeth: HW IP/TCP/UDP checksum RX/TX offload enabled       
2020.03.04-10:17:21  warn  kernel: [   14.330000] raeth: HW VLAN RX offload enabled                 
2020.03.04-10:17:21  warn  kernel: [   14.340000] raeth: HW Scatter/Gather TX offload enabled                       
2020.03.04-10:17:21  warn  kernel: [   14.350000] raeth: HW TCP segmentation offload (TSO) enabled                 
2020.03.04-10:17:21  warn  kernel: [   14.360000] mtk_esw - hw bridge: W|LLLL                                       
2020.03.04-10:17:21  info  kernel: [   14.380000] device eth0.1 entered promiscuous mode         
2020.03.04-10:17:21  info  kernel: [   14.390000] device eth0 entered promiscuous mode               
2020.03.04-10:17:21  info  kernel: [   14.400000] br-lan: port 1(eth0.1) entered forwarding state   
2020.03.04-10:17:21  info  kernel: [   14.410000] br-lan: port 1(eth0.1) entered forwarding state   

2. logs on serial port （too long and I just pick some of them）
[    0.000000] Linux version 3.10.34 (yanai.wang@localhost.localdomain) (gcc version 4.8.3 (OpenWrt/Linaro GCC 4.8-2014.04 r288) ) #1 SMP Mon Mar 2 12:28:24 CST 2020
[    0.000000] SoC Type: Mediatek MT7621 ver:1 eco:3
[    0.000000] bootconsole [early0] enabled
[    0.000000] CPU revision is: 0001992f (MIPS 1004Kc)
[    0.000000] MIPS: machine is WiTown board
[    0.000000] Determined physical RAM map:
[    0.000000]  memory: 10000000 @ 00000000 (usable)
[    0.000000] Initrd not found or empty - disabling initrd
[    0.000000] Zone ranges:
[    0.000000]   Normal   [mem 0x00000000-0x0fffffff]
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x00000000-0x0fffffff]   #these logs below can't be seen in system.log reboot everytime 
[    0.000000] Detected 3 available secondary CPU(s)
[    0.000000] Primary instruction cache 32kB, VIPT, 4-way, linesize 32 bytes.
[    0.000000] Primary data cache 32kB, 4-way, PIPT, no aliases, linesize 32 bytes
[    0.000000] MIPS secondary cache 256kB, 8-way, linesize 32 bytes.
[    0.000000] PERCPU: Embedded 7 pages/cpu @81207000 s6656 r8192 d13824 u32768
[    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 65024
[    0.000000] Kernel command line:  boot_firmware=1 console=ttyS0,57600 rootfstype=squashfs,jffs2
[    0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes)
[    0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes)
[    0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes)
[    0.000000] Writing ErrCtl register=00031010
[    0.000000] Readback ErrCtl register=00031010
[    0.000000] Memory: 255796k/262144k available (2825k kernel code, 6348k reserved, 675k data, 204k init, 0k highmem)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] Hierarchical RCU implementation.
[    0.000000] NR_IRQS:256
[    0.000000] gic: revision 3.0
[    0.000000] CPU Clock: 880MHz
[    0.000000] Calibrating delay loop... 577.53 BogoMIPS (lpj=2887680)
[    0.050000] pid_max: default: 32768 minimum: 301
[    0.060000] Mount-cache hash table entries: 512
[    0.070000] CPU revision is: 0001992f (MIPS 1004Kc)
[    0.070000] Primary instruction cache 32kB, VIPT, 4-way, linesize 32 bytes.
[    0.070000] Primary data cache 32kB, 4-way, PIPT, no aliases, linesize 32 bytes
[    0.070000] MIPS secondary cache 256kB, 8-way, linesize 32 bytes.
[    0.140000] Synchronize counters for CPU 1: done.
[    0.150000] CPU revision is: 0001992f (MIPS 1004Kc)
[    0.150000] Primary instruction cache 32kB, VIPT, 4-way, linesize 32 bytes.
[    0.150000] Primary data cache 32kB, 4-way, PIPT, no aliases, linesize 32 bytes
[    0.150000] MIPS secondary cache 256kB, 8-way, linesize 32 bytes.
[    0.220000] Synchronize counters for CPU 2: done.
[    0.230000] CPU revision is: 0001992f (MIPS 1004Kc)
[    0.230000] Primary instruction cache 32kB, VIPT, 4-way, linesize 32 bytes.
[    0.230000] Primary data cache 32kB, 4-way, PIPT, no aliases, linesize 32 bytes
[    0.230000] MIPS secondary cache 256kB, 8-way, linesize 32 bytes.
[    0.300000] Synchronize counters for CPU 3: done.
[    0.310000] Brought up 4 CPUs
[    0.310000] pinctrl core: initialized pinctrl subsystem
[    0.320000] NET: Registered protocol family 16
[    0.320000] witown_netlink_init init witown netlink type WI_NETLINK_WITOWN !
[    0.330000] release PCIe RST: RALINK_RSTCTRL = 7000000
[    0.340000] ***** Xtal 40MHz *****
[    0.340000] pull PCIe RST: RALINK_RSTCTRL = 6000000
[    0.640000] release PCIe RST: RALINK_RSTCTRL = 7000000
[    0.650000] Port 0 N_FTS = 1b105000
[    0.650000] Port 1 N_FTS = 1b105000
[    0.660000] Port 2 N_FTS = 1b105000
[    1.790000] PCIE2 no card, disable it(RST&CLK)
[    1.800000]  -> 21007f2
[    1.800000] PCIE0 enabled
[    1.810000] PCIE1 enabled
[    1.820000] bio: create slab <bio-0> at 0
[    1.830000] mt7621_gpio 1e000600.gpio: registering 32 gpios
[    1.840000] mt7621_gpio 1e000600.gpio: registering 32 gpios
[    1.850000] mt7621_gpio 1e000600.gpio: registering 32 gpios
[    1.860000] usbcore: registered new interface driver usbfs
[    1.870000] usbcore: registered new interface driver hub
[    1.880000] usbcore: registered new device driver usb
[    1.900000] PCI host bridge to bus 0000:00
[    1.900000] pci_bus 0000:00: root bus resource [mem 0x60000000-0x6fffffff]
[    1.920000] pci_bus 0000:00: root bus resource [io  0x1e160000-0x1e16ffff]
[    1.930000] pci_bus 0000:00: No busn resource found for root bus, will use [bus 00-ff]
[    1.950000] pci 0000:00:00.0: BAR 0: can't assign mem (size 0x80000000)
[    1.960000] pci 0000:00:01.0: BAR 0: can't assign mem (size 0x80000000)
[    1.970000] pci 0000:00:00.0: BAR 8: assigned [mem 0x60000000-0x600fffff]
[    1.990000] pci 0000:00:01.0: BAR 8: assigned [mem 0x60100000-0x601fffff]
[    2.000000] pci 0000:00:01.0: BAR 9: assigned [mem 0x60200000-0x602fffff pref]
[    2.020000] pci 0000:00:00.0: BAR 1: assigned [mem 0x60300000-0x6030ffff]
[    2.030000] pci 0000:00:01.0: BAR 1: assigned [mem 0x60310000-0x6031ffff]
[    2.040000] pci 0000:01:00.0: BAR 0: assigned [mem 0x60000000-0x600fffff]
[    2.060000] pci 0000:00:00.0: PCI bridge to [bus 01]
[    2.070000] pci 0000:00:00.0:   bridge window [mem 0x60000000-0x600fffff]
[    2.080000] pci 0000:02:00.0: BAR 0: assigned [mem 0x60100000-0x601fffff 64bit]
[    2.090000] pci 0000:02:00.0: BAR 6: assigned [mem 0x60200000-0x6020ffff pref]
[    2.110000] pci 0000:00:01.0: PCI bridge to [bus 02]
[    2.120000] pci 0000:00:01.0:   bridge window [mem 0x60100000-0x601fffff]
[    2.130000] pci 0000:00:01.0:   bridge window [mem 0x60200000-0x602fffff pref]
[    2.150000] BAR0 at slot 0 = 0
[    2.150000] bus=0x0, slot = 0x0
[    2.160000] BAR0 at slot 1 = 0
[    2.160000] bus=0x0, slot = 0x1
[    2.170000] bus=0x1, slot = 0x0, irq=0xff
[    2.180000] bus=0x2, slot = 0x1, irq=0xff
[    2.190000] Switching to clocksource MIPS
[    2.200000] NET: Registered protocol family 2
[    2.220000] TCP established hash table entries: 2048 (order: 2, 16384 bytes)
[    2.230000] TCP bind hash table entries: 2048 (order: 2, 16384 bytes)
[    2.240000] TCP: Hash tables configured (established 2048 bind 2048)
[    2.260000] TCP: reno registered
[    2.260000] UDP hash table entries: 256 (order: 1, 8192 bytes)
[    2.270000] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes)
[    2.290000] NET: Registered protocol family 1
[    2.310000] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    2.320000] jffs2: version 2.2 (NAND) (SUMMARY) (LZMA) (RTIME) (CMODE_PRIORITY) (c) 2001-2006 Red Hat, Inc.
[    2.340000] msgmni has been set to 499
[    2.350000] io scheduler noop registered
[    2.350000] io scheduler deadline registered (default)
[    2.370000] Serial: 8250/16550 driver, 2 ports, IRQ sharing disabled
[    2.380000] 1e000c00.uartlite: ttyS0 at MMIO 0x1e000c00 (irq = 34) is a 16550A
[    2.390000] console [ttyS0] enabled, bootconsole disabled
[    2.390000] console [ttyS0] enabled, bootconsole disabled
[    2.420000] flash manufacture id: c2, device id 20 19
[    2.430000] MX25L25635E(c2 2019c220) (32768 Kbytes)
[    2.440000] mtd .name = raspi, .size = 0x02000000 (32M) .erasesize = 0x00010000 (64K) .numeraseregions = 0
[    2.460000] Creating 9 MTD partitions on "raspi":
[    2.470000] 0x000000000000-0x000000030000 : "u-boot"
[    2.480000] 0x000000030000-0x000000040000 : "u-boot-env"
[    2.490000] 0x000000040000-0x000000050000 : "factory"
[    2.500000] 0x000000050000-0x000000b50000 : "firmware1"
[    2.510000] 0x000000180222-0x000000b50000 : "rootfs"
[    2.520000] mtd: partition "rootfs" must either start or end on erase block boundary or be smaller than an erase block -- forcing read-only
[    2.550000] mtd: device 4 (rootfs) set to be root filesystem
[    2.560000] 0x000000b50000-0x000001650000 : "firmware2"
[    2.570000] 0x000001650000-0x000001ad0000 : "rootfs_data"
[    2.580000] 0x000001ad0000-0x000001fd0000 : "cloud"
[    2.590000] 0x000001fd0000-0x000001ff0000 : "Reserve"
[    2.600000] 0x000001ff0000-0x000002000000 : "Buginfo"
[    2.620000] Ralink APSoC Ethernet Driver v3.2.4 (raeth)
[    2.630000] raeth: PDMA RX ring 512, PDMA TX ring 256. Max packet size 1536

3. my busybox syslog setting
see attachment
Comment 1 jack back 2020-03-09 06:50:59 UTC 
Created attachment 8391 [details]
openwrt config file （rar type file, need to unpack first then can see .config）