[LITMUS^RT] ft-trace-overheads
Martinez Garcia Jorge Luis (PS-EC/ESB2)
JorgeLuis.MartinezGarcia at de.bosch.com
Sun Nov 4 14:15:53 CET 2018
Dear all,
I'm running Litmus^RT with a reservation-based plugin on top of a RPi3. While trying to trace and process system overheads by means of the "ft-trace-overheads" script, like this :
[root at alarm OVTest1]# setsched ESPRESSO
[root at alarm OVTest1]# ft-
ft-combine-samples ft-compute-stats ft-count-samples ft-extract-samples ft-select-samples ft-shuffle-truncate ft-sort-traces ft-trace-overheads
[root at alarm OVTest1]# ft-trace-overheads test
[II] Recording /dev/litmus/ft_cpu_trace0 -> overheads_host=alarm_scheduler=ESPRESSO_trace=test_cpu=0.bin
[II] Recording /dev/litmus/ft_cpu_trace1 -> overheads_host=alarm_scheduler=ESPRESSO_trace=test_cpu=1.bin
[II] Recording /dev/litmus/ft_cpu_trace2 -> overheads_host=alarm_scheduler=ESPRESSO_trace=test_cpu=2.bin
[II] Recording /dev/litmus/ft_cpu_trace3 -> overheads_host=alarm_scheduler=ESPRESSO_trace=test_cpu=3.bin
[II] Recording /dev/litmus/ft_msg_trace0 -> overheads_host=alarm_scheduler=ESPRESSO_trace=test_msg=0.bin
Hangup
Connection to 192.168.0.13 closed.
, dmesg reports an "out-of-memory" issue :
[ 1113.492567] Switching to LITMUS^RT plugin ESPRESSO.
[ 1149.890457] time stamp buffer: trying to allocate 33554432 time stamps for minor=0.
[ 1149.907937] time stamp buffer: trying to allocate 33554432 time stamps for minor=1.
[ 1149.931135] time stamp buffer: trying to allocate 33554432 time stamps for minor=2.
[ 1149.977169] time stamp buffer: trying to allocate 33554432 time stamps for minor=3.
[ 1150.014975] time stamp buffer: trying to allocate 33554432 time stamps for minor=0.
[ 1150.688347] ftcat invoked oom-killer: gfp_mask=0x24002c2(GFP_KERNEL|__GFP_HIGHMEM|__GFP_NOWARN), nodemask=0, order=0, oom_score_adj=0
[ 1150.741491] ftcat cpuset=/ mems_allowed=0
[ 1150.760686] CPU: 3 PID: 606 Comm: ftcat Not tainted 4.9.30-litmus+ #1
[ 1150.789462] Hardware name: Raspberry Pi 3 Model B Rev 1.2 (DT)
[ 1150.815950] Call trace:
[ 1150.828894] [<ffff000008087d20>] dump_backtrace+0x0/0x1e0
[ 1150.853884] [<ffff000008087f24>] show_stack+0x24/0x30
[ 1150.877550] [<ffff000008538a78>] dump_stack+0x90/0xb0
[ 1150.901269] [<ffff00000822fe14>] dump_header+0x74/0x1c0
[ 1150.925728] [<ffff0000081b52fc>] oom_kill_process+0x28c/0x4a0
[ 1150.952423] [<ffff0000081b594c>] out_of_memory+0xfc/0x310
[ 1150.977805] [<ffff0000081baf2c>] __alloc_pages_nodemask+0xcc4/0xcf0
[ 1151.006808] [<ffff0000081fb8cc>] __vmalloc_node_range+0x1dc/0x280
[ 1151.035237] [<ffff0000081fba44>] vmalloc+0x5c/0x70
[ 1151.058485] [<ffff00000852c61c>] alloc_ft_buffer+0x54/0xf8
[ 1151.084647] [<ffff00000852e54c>] alloc_timestamp_buffer+0x8c/0xb0
[ 1151.113345] [<ffff00000852c04c>] ftdev_open+0x9c/0xe8
[ 1151.137957] [<ffff000008238290>] chrdev_open+0x88/0x150
[ 1151.163316] [<ffff000008230514>] do_dentry_open+0x1f4/0x2f0
[ 1151.190175] [<ffff000008231a20>] vfs_open+0x58/0x88
[ 1151.214316] [<ffff000008241538>] path_openat+0x500/0xe58
[ 1151.240149] [<ffff000008242c44>] do_filp_open+0x74/0xf0
[ 1151.265555] [<ffff000008231fe8>] do_sys_open+0x130/0x208
[ 1151.291397] [<ffff000008232144>] SyS_openat+0x3c/0x50
[ 1151.316243] [<ffff000008082b70>] el0_svc_naked+0x24/0x28
[ 1151.342533] Mem-Info:
[ 1151.356413] active_anon:4542 inactive_anon:28 isolated_anon:0
active_file:92 inactive_file:130 isolated_file:0
unevictable:0 dirty:0 writeback:0 unstable:0
slab_reclaimable:4398 slab_unreclaimable:5251
mapped:72 shmem:53 pagetables:263 bounce:0
free:15495 free_pcp:2 free_cma:14690
[ 1151.522488] Node 0 active_anon:18168kB inactive_anon:112kB active_file:324kB inactive_file:276kB unevictable:0kB isolated(anon):0kB isolated(file):0kB mapped:288kB dirty:0kB writeback:0kB shmem:212kB writeback_tmp:0kB unstable:0kB pages_scanned:0 all_unreclaimable? no
[ 1151.657461] DMA free:61836kB min:3724kB low:4652kB high:5580kB active_anon:18168kB inactive_anon:112kB active_file:412kB inactive_file:472kB unevictable:0kB writepending:0kB present:970752kB managed:934492kB mlocked:0kB slab_reclaimable:17592kB slab_unreclaimable:21004kB kernel_stack:1808kB pagetables:1052kB bounce:0kB free_pcp:116kB local_pcp:56kB free_cma:58760kB
[ 1151.870640] lowmem_reserve[]: 0 0 0
[ 1151.916659] DMA: 320*4kB (UMEHC) 129*8kB (UMEHC) 50*16kB (UMHC) 22*32kB (UMHC) 9*64kB (UHC) 3*128kB (HC) 2*256kB (H) 1*512kB (C) 0*1024kB 0*2048kB 13*4096kB (C) = 59048kB
[ 1151.996992] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB
[ 1152.040397] 266 total pagecache pages
[ 1152.080970] 0 pages in swap cache
[ 1152.112345] Swap cache stats: add 0, delete 0, find 0/0
[ 1152.143368] Free swap = 0kB
[ 1152.174351] Total swap = 0kB
[ 1152.195241] 242688 pages RAM
[ 1152.215428] 0 pages HighMem/MovableOnly
[ 1152.239749] 9065 pages reserved
[ 1152.261198] 16384 pages cma reserved
[ 1152.283953] [ pid ] uid tgid total_vm rss nr_ptes nr_pmds swapents oom_score_adj name
[ 1152.327737] [ 153] 0 153 11328 190 19 3 0 0 systemd-journal
[ 1152.375020] [ 163] 0 163 19617 52 8 3 0 0 lvmetad
[ 1152.418955] [ 165] 0 165 5746 442 11 3 0 -1000 systemd-udevd
[ 1152.465456] [ 196] 981 196 5338 194 10 3 0 0 systemd-network
[ 1152.512340] [ 198] 62583 198 21796 187 12 4 0 0 systemd-timesyn
[ 1152.563386] [ 221] 81 221 1901 163 9 3 0 -900 dbus-daemon
[ 1152.617251] [ 235] 0 235 3192 193 10 4 0 0 systemd-logind
[ 1152.673358] [ 285] 0 285 2131 162 9 4 0 -1000 sshd
[ 1152.723100] [ 293] 0 293 532 26 5 4 0 0 agetty
[ 1152.776394] [ 295] 0 295 532 26 5 4 0 0 agetty
[ 1152.831495] [ 296] 0 296 532 25 5 4 0 0 agetty
[ 1152.883224] [ 459] 980 459 4776 245 12 4 0 0 systemd-resolve
[ 1152.939413] [ 494] 0 494 2897 227 11 3 0 0 sshd
[ 1152.982209] [ 497] 1000 497 3602 271 11 4 0 0 systemd
[ 1153.025948] [ 506] 1000 506 25545 527 16 4 0 0 (sd-pam)
[ 1153.070047] [ 515] 1000 515 3107 245 11 3 0 0 sshd
[ 1153.112746] [ 521] 1000 521 1076 112 5 3 0 0 bash
[ 1153.155400] [ 524] 1000 524 1921 114 8 4 0 0 su
[ 1153.197356] [ 525] 0 525 1043 112 6 3 0 0 bash
[ 1153.239946] [ 546] 0 546 2946 262 10 4 0 0 sshd
[ 1153.282554] [ 549] 1000 549 3156 270 11 4 0 0 sshd
[ 1153.325030] [ 554] 1000 554 1076 112 7 4 0 0 bash
[ 1153.367405] [ 556] 1000 556 1921 113 8 3 0 0 su
[ 1153.409063] [ 558] 0 558 1073 135 7 4 0 0 bash
[ 1153.451423] [ 571] 0 571 975 72 5 3 0 0 ft-trace-overhe
[ 1153.497560] [ 591] 0 591 451 15 3 3 0 0 ftcat
[ 1153.540160] [ 596] 0 596 451 14 4 3 0 0 ftcat
[ 1153.582618] [ 601] 0 601 451 15 4 3 0 0 ftcat
[ 1153.624709] [ 606] 0 606 451 14 4 3 0 0 ftcat
[ 1153.666432] [ 611] 0 611 451 15 4 3 0 0 ftcat
[ 1153.707861] Out of memory: Kill process 506 ((sd-pam)) score 2 or sacrifice child
[ 1153.744640] Killed process 506 ((sd-pam)) total-vm:102180kB, anon-rss:2108kB, file-rss:0kB, shmem-rss:0kB
[ 1153.814976] ftcat invoked oom-killer: gfp_mask=0x24002c2(GFP_KERNEL|__GFP_HIGHMEM|__GFP_NOWARN), nodemask=0, order=0, oom_score_adj=0
[ 1153.876525] ftcat cpuset=/ mems_allowed=0
[ 1153.899117] CPU: 2 PID: 591 Comm: ftcat Not tainted 4.9.30-litmus+ #1
[ 1153.931212] Hardware name: Raspberry Pi 3 Model B Rev 1.2 (DT)
[ 1153.960730] Call trace:
[ 1153.976452] [<ffff000008087d20>] dump_backtrace+0x0/0x1e0
[ 1154.004173] [<ffff000008087f24>] show_stack+0x24/0x30
[ 1154.030494] [<ffff000008538a78>] dump_stack+0x90/0xb0
[ 1154.056732] [<ffff00000822fe14>] dump_header+0x74/0x1c0
[ 1154.083943] [<ffff0000081b52fc>] oom_kill_process+0x28c/0x4a0
[ 1154.113094] [<ffff0000081b594c>] out_of_memory+0xfc/0x310
[ 1154.140851] [<ffff0000081baf2c>] __alloc_pages_nodemask+0xcc4/0xcf0
[ 1154.172119] [<ffff0000081fb8cc>] __vmalloc_node_range+0x1dc/0x280
[ 1154.202709] [<ffff0000081fba44>] vmalloc+0x5c/0x70
[ 1154.227917] [<ffff00000852c61c>] alloc_ft_buffer+0x54/0xf8
[ 1154.255801] [<ffff00000852e54c>] alloc_timestamp_buffer+0x8c/0xb0
[ 1154.286172] [<ffff00000852c04c>] ftdev_open+0x9c/0xe8
[ 1154.312329] [<ffff000008238290>] chrdev_open+0x88/0x150
[ 1154.339191] [<ffff000008230514>] do_dentry_open+0x1f4/0x2f0
[ 1154.367503] [<ffff000008231a20>] vfs_open+0x58/0x88
[ 1154.392997] [<ffff000008241538>] path_openat+0x500/0xe58
[ 1154.420513] [<ffff000008242c44>] do_filp_open+0x74/0xf0
[ 1154.447370] [<ffff000008231fe8>] do_sys_open+0x130/0x208
[ 1154.474442] [<ffff000008232144>] SyS_openat+0x3c/0x50
[ 1154.500518] [<ffff000008082b70>] el0_svc_naked+0x24/0x28
[ 1154.527825] Mem-Info:
[ 1154.542821] active_anon:4277 inactive_anon:28 isolated_anon:0
active_file:122 inactive_file:117 isolated_file:0
unevictable:0 dirty:0 writeback:1 unstable:0
slab_reclaimable:4398 slab_unreclaimable:5247
mapped:97 shmem:53 pagetables:247 bounce:0
free:13912 free_pcp:0 free_cma:12983
[ 1154.709096] Node 0 active_anon:17108kB inactive_anon:112kB active_file:344kB inactive_file:568kB unevictable:0kB isolated(anon):0kB isolated(file):0kB mapped:392kB dirty:0kB writeback:4kB shmem:212kB writeback_tmp:0kB unstable:0kB pages_scanned:29 all_unreclaimable? no
[ 1154.827542] DMA free:55556kB min:3724kB low:4652kB high:5580kB active_anon:17108kB inactive_anon:112kB active_file:252kB inactive_file:492kB unevictable:0kB writepending:0kB present:970752kB managed:934492kB mlocked:0kB slab_reclaimable:17592kB slab_unreclaimable:20988kB kernel_stack:1824kB pagetables:988kB bounce:0kB free_pcp:4kB local_pcp:0kB free_cma:52100kB
[ 1154.979734] lowmem_reserve[]: 0 0 0
[ 1155.002220] DMA: 133*4kB (UMEC) 67*8kB (UMEC) 23*16kB (UMHC) 11*32kB (UMHC) 3*64kB (HC) 4*128kB (HC) 2*256kB (H) 2*512kB (H) 0*1024kB 1*2048kB (C) 12*4096kB (C) = 55228kB
[ 1155.082198] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB
[ 1155.125316] 345 total pagecache pages
[ 1155.149324] 0 pages in swap cache
[ 1155.171973] Swap cache stats: add 0, delete 0, find 0/0
[ 1155.202238] Free swap = 0kB
[ 1155.222874] Total swap = 0kB
[ 1155.243219] 242688 pages RAM
[ 1155.263217] 0 pages HighMem/MovableOnly
[ 1155.287070] 9065 pages reserved
[ 1155.308037] 16384 pages cma reserved
[ 1155.330653] [ pid ] uid tgid total_vm rss nr_ptes nr_pmds swapents oom_score_adj name
[ 1155.373508] [ 153] 0 153 11328 199 19 3 0 0 systemd-journal
[ 1155.420296] [ 163] 0 163 19617 52 8 3 0 0 lvmetad
[ 1155.464169] [ 165] 0 165 5746 442 11 3 0 -1000 systemd-udevd
[ 1155.510154] [ 196] 981 196 5338 194 10 3 0 0 systemd-network
[ 1155.556829] [ 198] 62583 198 21796 187 12 4 0 0 systemd-timesyn
[ 1155.603483] [ 221] 81 221 1901 163 9 3 0 -900 dbus-daemon
[ 1155.808199] [ 235] 0 235 3192 193 10 4 0 0 systemd-logind
[ 1155.854451] [ 285] 0 285 2131 162 9 4 0 -1000 sshd
[ 1155.897136] [ 293] 0 293 532 26 5 4 0 0 agetty
[ 1155.940581] [ 295] 0 295 532 26 5 4 0 0 agetty
[ 1155.983860] [ 296] 0 296 532 25 5 4 0 0 agetty
[ 1156.027022] [ 459] 980 459 4776 245 12 4 0 0 systemd-resolve
[ 1156.073420] [ 494] 0 494 2897 227 11 3 0 0 sshd
[ 1156.116015] [ 497] 1000 497 3602 282 11 4 0 0 systemd
[ 1156.159700] [ 515] 1000 515 3107 245 11 3 0 0 sshd
[ 1156.202256] [ 521] 1000 521 1076 112 5 3 0 0 bash
[ 1156.244763] [ 524] 1000 524 1921 114 8 4 0 0 su
[ 1156.286437] [ 525] 0 525 1043 112 6 3 0 0 bash
[ 1156.328741] [ 546] 0 546 2946 262 10 4 0 0 sshd
[ 1156.371031] [ 549] 1000 549 3156 270 11 4 0 0 sshd
[ 1156.413209] [ 554] 1000 554 1076 112 7 4 0 0 bash
[ 1156.455359] [ 556] 1000 556 1921 113 8 3 0 0 su
[ 1156.496751] [ 558] 0 558 1073 135 7 4 0 0 bash
[ 1156.538560] [ 571] 0 571 975 72 5 3 0 0 ft-trace-overhe
[ 1156.583981] [ 591] 0 591 451 15 3 3 0 0 ftcat
[ 1156.625616] [ 596] 0 596 451 14 4 3 0 0 ftcat
[ 1156.666884] [ 601] 0 601 451 15 4 3 0 0 ftcat
[ 1156.707828] [ 606] 0 606 451 14 4 3 0 0 ftcat
[ 1156.748496] [ 611] 0 611 451 15 4 3 0 0 ftcat
[ 1156.788859] [ 618] 0 618 975 161 5 3 0 0 ft-trace-overhe
[ 1156.832474] Out of memory: Kill process 497 (systemd) score 1 or sacrifice child
[ 1156.867587] Killed process 497 (systemd) total-vm:14408kB, anon-rss:1128kB, file-rss:68kB, shmem-rss:0kB
[ 1156.936392] ftcat invoked oom-killer: gfp_mask=0x24002c2(GFP_KERNEL|__GFP_HIGHMEM|__GFP_NOWARN), nodemask=0, order=0, oom_score_adj=0
[ 1156.995658] ftcat cpuset=/ mems_allowed=0
[ 1157.017553] CPU: 3 PID: 606 Comm: ftcat Not tainted 4.9.30-litmus+ #1
...
...
[ 1193.179860] time stamp buffer: trying to allocate 1048576 time stamps for minor=0.
[ 1193.184695] ftcat: vmalloc: allocation failure, allocated 9936896 of 17829888 bytes, mode:0x24000c2(GFP_KERNEL|__GFP_HIGHMEM)
[ 1193.184712] CPU: 1 PID: 591 Comm: ftcat Not tainted 4.9.30-litmus+ #1
[ 1193.184717] Hardware name: Raspberry Pi 3 Model B Rev 1.2 (DT)
[ 1193.184724] Call trace:
[ 1193.184750] [<ffff000008087d20>] dump_backtrace+0x0/0x1e0
[ 1193.184762] [<ffff000008087f24>] show_stack+0x24/0x30
[ 1193.184778] [<ffff000008538a78>] dump_stack+0x90/0xb0
[ 1193.184794] [<ffff0000081ba130>] warn_alloc+0x108/0x120
[ 1193.184806] [<ffff0000081fb8f0>] __vmalloc_node_range+0x200/0x280
[ 1193.184813] [<ffff0000081fba44>] vmalloc+0x5c/0x70
[ 1193.184828] [<ffff00000852c61c>] alloc_ft_buffer+0x54/0xf8
[ 1193.184838] [<ffff00000852e54c>] alloc_timestamp_buffer+0x8c/0xb0
[ 1193.184848] [<ffff00000852c04c>] ftdev_open+0x9c/0xe8
[ 1193.184861] [<ffff000008238290>] chrdev_open+0x88/0x150
[ 1193.184870] [<ffff000008230514>] do_dentry_open+0x1f4/0x2f0
[ 1193.184878] [<ffff000008231a20>] vfs_open+0x58/0x88
[ 1193.184890] [<ffff000008241538>] path_openat+0x500/0xe58
[ 1193.184899] [<ffff000008242c44>] do_filp_open+0x74/0xf0
[ 1193.184908] [<ffff000008231fe8>] do_sys_open+0x130/0x208
[ 1193.184916] [<ffff000008232144>] SyS_openat+0x3c/0x50
[ 1193.184926] [<ffff000008082b70>] el0_svc_naked+0x24/0x28
[ 1193.184931] Mem-Info:
[ 1193.184954] active_anon:3601 inactive_anon:28 isolated_anon:0
active_file:195 inactive_file:277 isolated_file:0
unevictable:0 dirty:0 writeback:0 unstable:0
slab_reclaimable:4397 slab_unreclaimable:5239
mapped:212 shmem:53 pagetables:212 bounce:0
free:12212 free_pcp:276 free_cma:11687
[ 1193.184973] Node 0 active_anon:14404kB inactive_anon:112kB active_file:780kB inactive_file:1108kB unevictable:0kB isolated(anon):0kB isolated(file):0kB mapped:848kB dirty:0kB writeback:0kB shmem:212kB writeback_tmp:0kB unstable:0kB pages_scanned:0 all_unreclaimable? no
[ 1193.184995] DMA free:48848kB min:3724kB low:4652kB high:5580kB active_anon:14404kB inactive_anon:112kB active_file:780kB inactive_file:1108kB unevictable:0kB writepending:0kB present:970752kB managed:934492kB mlocked:0kB slab_reclaimable:17588kB slab_unreclaimable:20956kB kernel_stack:1824kB pagetables:848kB bounce:0kB free_pcp:1104kB local_pcp:656kB free_cma:46748kB
[ 1193.185011] lowmem_reserve[]: 0 0 0
[ 1193.185094] DMA: 26*4kB (C) 11*8kB (C) 7*16kB (HC) 7*32kB (HC) 5*64kB (C) 5*128kB (HC) 5*256kB (HC) 2*512kB (H) 0*1024kB 0*2048kB 11*4096kB (C) = 48848kB
[ 1193.185103] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB
[ 1193.185107] 604 total pagecache pages
[ 1193.185118] 0 pages in swap cache
[ 1193.185124] Swap cache stats: add 0, delete 0, find 0/0
[ 1193.185128] Free swap = 0kB
[ 1193.185132] Total swap = 0kB
[ 1193.185136] 242688 pages RAM
[ 1193.185162] 0 pages HighMem/MovableOnly
[ 1193.185166] 9065 pages reserved
[ 1193.185171] 16384 pages cma reserved
[ 1193.188982] time stamp buffer: trying to allocate 524288 time stamps for minor=0.
[ 1193.278835] oom_reaper: reaped process 596 (ftcat), now anon-rss:0kB, file-rss:0kB, shmem-rss:0kB
[ 1193.279615] ftcat: vmalloc: allocation failure, allocated 434040832 of 570429440 bytes, mode:0x24000c2(GFP_KERNEL|__GFP_HIGHMEM)
[ 1193.279628] CPU: 1 PID: 596 Comm: ftcat Not tainted 4.9.30-litmus+ #1
[ 1193.279633] Hardware name: Raspberry Pi 3 Model B Rev 1.2 (DT)
[ 1193.279638] Call trace:
[ 1193.279661] [<ffff000008087d20>] dump_backtrace+0x0/0x1e0
[ 1193.279672] [<ffff000008087f24>] show_stack+0x24/0x30
[ 1193.279686] [<ffff000008538a78>] dump_stack+0x90/0xb0
[ 1193.279699] [<ffff0000081ba130>] warn_alloc+0x108/0x120
[ 1193.279709] [<ffff0000081fb8f0>] __vmalloc_node_range+0x200/0x280
[ 1193.279716] [<ffff0000081fba44>] vmalloc+0x5c/0x70
[ 1193.279728] [<ffff00000852c61c>] alloc_ft_buffer+0x54/0xf8
[ 1193.279739] [<ffff00000852e54c>] alloc_timestamp_buffer+0x8c/0xb0
[ 1193.279749] [<ffff00000852c04c>] ftdev_open+0x9c/0xe8
[ 1193.279760] [<ffff000008238290>] chrdev_open+0x88/0x150
[ 1193.279769] [<ffff000008230514>] do_dentry_open+0x1f4/0x2f0
[ 1193.279778] [<ffff000008231a20>] vfs_open+0x58/0x88
[ 1193.279788] [<ffff000008241538>] path_openat+0x500/0xe58
[ 1193.279797] [<ffff000008242c44>] do_filp_open+0x74/0xf0
[ 1193.279805] [<ffff000008231fe8>] do_sys_open+0x130/0x208
[ 1193.279814] [<ffff000008232144>] SyS_openat+0x3c/0x50
[ 1193.279826] [<ffff000008082b70>] el0_svc_naked+0x24/0x28
[ 1193.279834] Mem-Info:
[ 1193.279874] active_anon:3601 inactive_anon:28 isolated_anon:0
active_file:239 inactive_file:250 isolated_file:0
unevictable:0 dirty:0 writeback:0 unstable:0
slab_reclaimable:4397 slab_unreclaimable:5239
mapped:262 shmem:53 pagetables:212 bounce:0
free:12213 free_pcp:27 free_cma:11762
[ 1193.279898] Node 0 active_anon:14404kB inactive_anon:112kB active_file:956kB inactive_file:1000kB unevictable:0kB isolated(anon):0kB isolated(file):0kB mapped:1148kB dirty:0kB writeback:0kB shmem:212kB writeback_tmp:0kB unstable:0kB pages_scanned:46 all_unreclaimable? no
[ 1193.279938] DMA free:48852kB min:3724kB low:4652kB high:5580kB active_anon:14404kB inactive_anon:112kB active_file:956kB inactive_file:1000kB unevictable:0kB writepending:0kB present:970752kB managed:934492kB mlocked:0kB slab_reclaimable:17588kB slab_unreclaimable:20956kB kernel_stack:1824kB pagetables:848kB bounce:0kB free_pcp:108kB local_pcp:0kB free_cma:47048kB
[ 1193.279955] lowmem_reserve[]: 0 0 0
[ 1193.280044] DMA: 2*4kB (C) 20*8kB (C) 10*16kB (HC) 7*32kB (HC) 5*64kB (C) 5*128kB (HC) 5*256kB (HC) 2*512kB (H) 0*1024kB 0*2048kB 11*4096kB (C) = 48872kB
[ 1193.280053] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB
[ 1193.280057] 589 total pagecache pages
[ 1193.280066] 0 pages in swap cache
[ 1193.280073] Swap cache stats: add 0, delete 0, find 0/0
[ 1193.280076] Free swap = 0kB
[ 1193.280080] Total swap = 0kB
[ 1193.280085] 242688 pages RAM
[ 1193.280088] 0 pages HighMem/MovableOnly
[ 1193.280093] 9065 pages reserved
[ 1193.280097] 16384 pages cma reserved
[ 1193.422269] time stamp buffer: trying to allocate 16777216 time stamps for minor=1.
[ 1194.153424] systemd[1]: user-runtime-dir at 1000.service: Unit not needed anymore. Stopping.
[ 1194.157663] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart.
[ 1194.157965] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
[ 1194.159542] systemd[1]: Stopped Flush Journal to Persistent Storage.
[ 1194.159613] systemd[1]: Stopping Flush Journal to Persistent Storage...
[ 1194.159657] systemd[1]: Stopped Journal Service.
[ 1194.168164] systemd[1]: Starting Journal Service...
[ 1194.176251] systemd[1]: Stopping /run/user/1000 mount wrapper...
[ 1194.204245] Failed trace writes: 0
[ 1194.716243] Failed trace writes: 0
...
Did you face a similar issue? Do you think that vmalloc=512 could help me solve the problem?
Best regards
Jorge
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.litmus-rt.org/pipermail/litmus-dev/attachments/20181104/5fe922dc/attachment-0001.html>
More information about the litmus-dev
mailing list