Hi,

the issue looks like a memory problem of kernel 4.14. If I reboot the router or 
restart the network, netifd doesn't
crash again. Independently of this, memory consumption does increase very fast. 
I let run an endless loop to call free
every 15min. The output from the beginning:
Sun May 20 07:43:42 CEST 2018
             total       used       free     shared    buffers     cached
Mem:         28040      25996       2044         60       3112       5100
-/+ buffers/cache:      17784      10256
Swap:            0          0          0

The same after 10 hours:
Sun May 20 17:35:37 CEST 2018
             total       used       free     shared    buffers     cached
Mem:         28040      26732       1308         60        852       1504
-/+ buffers/cache:      24376       3664
Swap:            0          0          0

During the next loop, the router does restart. If I try the same with kernel 
4.9, at the beginning:
Sun May 20 19:36:53 CEST 2018
             total       used       free     shared    buffers     cached
Mem:         28336      25988       2348        128       2952       6412
-/+ buffers/cache:      16624      11712
Swap:            0          0          0

After 12hours:
Mon May 21 07:16:57 CEST 2018
             total       used       free     shared    buffers     cached
Mem:         28336      25928       2408        128       2952       6420
-/+ buffers/cache:      16556      11780
Swap:            0          0          0

With kernel 4.14, the memory consumption increase from 17784k to 24376k, with 
kernel 4.9 it is stable at 16556k.

What can be the reason for this increasing of used memory?

Currently, the main tree isn't usable for carambola box with target ramips.

Regards,
Hartmut

Am 13.05.2018 um 13:22 schrieb e9hack:
> Hi,
> 
> I've trouble with netifd on a carambola box (ralink rt305x target) from 
> 8devices. After a sysupgrade, netifd crashes all
> the time at the first boot. Lan/wan access over cable isn't possible. 
> Wireless access is possible. After a reboot,
> netifd doesn't crash again.
> 
> ...
> Sat May 12 23:54:13 2018 daemon.err block: /dev/mtdblock5 is already mounted 
> on /rom
> Sat May 12 23:54:13 2018 daemon.err block: /dev/mtdblock6 is already mounted 
> on /overlay
> Sat May 12 23:54:18 2018 authpriv.info dropbear[1179]: Not backgrounding
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.576598] netifd: page 
> allocation failure: order:0,
> mode:0x1080120(GFP_ATOMIC|__GFP_COLD), nodemask=(null)
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.586606] CPU: 0 PID: 1086 
> Comm: netifd Not tainted 4.14.37 #0
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.592668] Stack : 00000006 
> 80443640 00000000 00000000 00000000 00000000
> 804474e2 00000034
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.601134]         803f0000 
> 803ed8a7 803b55ac 0000043e 80443640 00000001
> 80a2bb20 803f0000
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.609601]         00000000 
> 00000000 80440000 000000cb 00000000 6465746e
> 312e3420 37332e34
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.618067]         646f6e20 
> 0000003c 00000020 73616d65 803f0000 80000000
> 00000000 00000000
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.626532]         00000000 
> 000003e8 77f39000 00000000 00000003 801bce3c
> 08052098 80440000
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.634998]         ...
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.637474] Call Trace:
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.639997] [<8000e504>] 
> show_stack+0x8c/0x130
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.644511] [<80090944>] 
> warn_alloc+0xbc/0x178
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.649010] [<80091228>] 
> __alloc_pages_nodemask+0x79c/0x9e4
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.654648] [<800915e8>] 
> page_frag_alloc+0x6c/0x160
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.659619] [<802172c8>] 
> netdev_alloc_frag+0x30/0x54
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.664656] [<801fd6d4>] 
> fe_open+0x3e0/0x548
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.668985] [<8022d1e0>] 
> __dev_open+0x128/0x140
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.673571] [<8022d4c8>] 
> __dev_change_flags+0xf4/0x1c0
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.678768] [<8022d5bc>] 
> dev_change_flags+0x28/0x70
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.683731] [<80249c78>] 
> dev_ifsioc+0x1fc/0x384
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.688319] [<8024a188>] 
> dev_ioctl+0x30c/0x714
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.692843] [<800d63f0>] 
> vfs_ioctl+0x28/0x40
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.697169] [<800d65d0>] 
> do_vfs_ioctl+0xcc/0x73c
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.701844] [<800d6c90>] 
> SyS_ioctl+0x50/0x90
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.706179] [<800133ac>] 
> syscall_common+0x34/0x58
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.710937] Mem-Info:
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.713274] active_anon:261 
> inactive_anon:2 isolated_anon:0
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.713274]  active_file:1734 
> inactive_file:1418 isolated_file:0
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.713274]  unevictable:0 
> dirty:0 writeback:0 unstable:0
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.713274]  
> slab_reclaimable:445 slab_unreclaimable:1352
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.713274]  mapped:580 shmem:5 
> pagetables:39 bounce:0
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.713274]  free:96 free_pcp:0 
> free_cma:0
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.745152] Node 0 
> active_anon:1044kB inactive_anon:8kB active_file:6936kB
> inactive_file:5672kB unevictable:0kB isolated(anon):0kB isolated(file):0kB 
> mapped:2320kB dirty:0kB writeback:0kB
> shmem:20kB writeback_tmp:0kB unstable:0kB all_unreclaimable? no
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.767633] Normal free:384kB 
> min:1024kB low:1280kB high:1536kB
> active_anon:1044kB inactive_anon:8kB active_file:6936kB inactive_file:5672kB 
> unevictable:0kB writepending:0kB
> present:32768kB managed:28044kB mlocked:0kB kernel_stack:256kB 
> pagetables:156kB bounce:0kB free_pcp:0kB local_pcp:0kB
> free_cma:0kB
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.794706] lowmem_reserve[]: 0 > 0
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.798063] Normal: 10*4kB (M) 
> 23*8kB (UM) 10*16kB (UM) 0*32kB 0*64kB
> 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 384kB
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.809818] 3157 total 
> pagecache pages
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.813601] 8192 pages RAM
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.816332] 0 pages 
> HighMem/MovableOnly
> Sat May 12 23:54:23 2018 kern.warn kernel: [   70.820202] 1181 pages reserved
> Sat May 12 23:54:23 2018 kern.info kernel: [   71.017567] br-lan: port 
> 1(eth0.1) entered blocking state
> Sat May 12 23:54:23 2018 kern.info kernel: [   71.023206] br-lan: port 
> 1(eth0.1) entered disabled state
> Sat May 12 23:54:23 2018 kern.info kernel: [   71.029582] device eth0.1 
> entered promiscuous mode
> Sat May 12 23:54:24 2018 daemon.notice netifd: Interface 'lan' is enabled
> Sat May 12 23:54:24 2018 daemon.notice netifd: Interface 'lan' is setting up 
> now
> Sat May 12 23:54:24 2018 kern.info kernel: [   71.069251] IPv6: 
> ADDRCONF(NETDEV_UP): br-lan: link is not ready
> Sat May 12 23:54:24 2018 daemon.notice netifd: Interface 'lan' is now up
> Sat May 12 23:54:24 2018 daemon.notice netifd: Interface 'loopback' is enabled
> Sat May 12 23:54:24 2018 daemon.notice netifd: Interface 'loopback' is 
> setting up now
> Sat May 12 23:54:24 2018 daemon.notice netifd: Interface 'loopback' is now up
> Sat May 12 23:54:24 2018 daemon.notice netifd: Interface 'wan' is enabled
> Sat May 12 23:54:24 2018 daemon.notice netifd: Interface 'wan' is setting up 
> now
> Sat May 12 23:54:24 2018 daemon.notice netifd: Network device 'lo' link is up
> Sat May 12 23:54:24 2018 daemon.notice netifd: Interface 'loopback' has link 
> connectivity
> Sat May 12 23:54:25 2018 daemon.notice netifd: wan (1289): udhcpc: started, 
> v1.28.3
> Sat May 12 23:54:28 2018 daemon.warn 6relayd[1302]: Failed to relay to 
> ff02::2% (Permission denied)
> Sat May 12 23:54:28 2018 daemon.notice netifd: wan (1289): udhcpc: sending 
> discover
> Sat May 12 23:54:28 2018 daemon.notice netifd: wan (1289): udhcpc: sendto: 
> Network is down
> Sat May 12 23:54:28 2018 daemon.notice netifd: wan (1289): udhcpc: read 
> error: Network is down, reopening socket
> ...
> 
> Regards,
> Hartmut
> 


_______________________________________________
openwrt-devel mailing list
openwrt-devel@lists.openwrt.org
http://lists.infradead.org/mailman/listinfo/openwrt-devel

Reply via email to