[LITMUS^RT] domU crashes (RT-Xen)

[Björn Brandenburg]

On 05 May 2014, at 11:03, Thijs Raets <thijsraets at gmail.com> wrote:

> Hi,
> 
> The problem is not within RT-Xen since under the credit scheduler the domain also crashes. I reinstalled litmus and the litmus tools to the latest version (2014). I also reworked base_task.c and did my tests again. But still no luck. I noticed that my VM does not crash if I only assign it 1 VCPU(even when executing the task set meant for the 6 VCPUs!) . And yes Xen is fundamental to my research.
> 
>  
> /dev/litmus/log:
> 
> 79 P0: (base_task/764:0) alloc_ctrl_page ctrl_page = ffff88006157f000
> 
> 80 P0: (base_task/764:0) litmus/ctrl: mapping ffff88006157f000 (pfn:6157f) to 0x7f26c56f8000 (prot:8000000000000027)
> 
> 81 P0: (base_task/764:0) litmus_ctrl_mmap flags=0x10162073 prot=0x8000000000000027
> 
> 82 P0: Setting up rt task parameters for process 764.
> 
> 83 P1: (base_task/765:0) alloc_ctrl_page ctrl_page = ffff88001d3cb000
> 
> 84 P1: (base_task/765:0) litmus/ctrl: mapping ffff88001d3cb000 (pfn:1d3cb) to 0x7fb131f28000 (prot:8000000000000027)
> 
> 85 P1: (base_task/765:0) litmus_ctrl_mmap flags=0x10162073 prot=0x8000000000000027
> 
> 86 P0: gsn edf: task new 764
> 
> 87 P0: rt: adding base_task/764 (12000000, 601000000, 601000000) rel=245998448412 to ready queue at 245998449965
> 
> 88 P0: (base_task/764:1) linking to local CPU 0 to avoid IPI
> 
> 89 P0: (base_task/764:1) ignoring an enqueue, not a wake up.
> 
> 90 P0: (base_task/764:1) blocks:0 out_of_time:0 np:0 sleep:0 preempt:0 state:0 sig:0
> 
> 91 P0: (base_task/764:1) try_to_wake_up() state:1
> 
> 92 P0: (base_task/764:1) try_to_wake_up() done state:0
> 
> 93 P0: (base_task/764:1) try_to_wake_up() state:0
> 
> 94 P0: (base_task/764:1) try_to_wake_up() done state:0
> 
> 95 P0: (base_task/764:1) block at 245998573054
> 
> 96 P0: (base_task/764:1) blocks:1 out_of_time:0 np:0 sleep:0 preempt:1 state:1 sig:0
> 
> 97 P0: (base_task/764:1) scheduled_on = NO_CPU
> 
> 98 P2: (base_task/766:0) alloc_ctrl_page ctrl_page = ffff88001d2a9000
> 
> 99 P2: (base_task/766:0) litmus/ctrl: mapping ffff88001d2a9000 (pfn:1d2a9) to 0x7f199e100000 (prot:8000000000000027)
> 
> 100 P2: (base_task/766:0) litmus_ctrl_mmap flags=0x10162073 prot=0x8000000000000027
> 
> 101 P2: Setting up rt task parameters for process 766.
> 
> 102 P2: gsn edf: task new 766
> 
> 103 P2: rt: adding base_task/766 (334000000, 636000000, 636000000) rel=245999566110 to ready queue at 245999567302
> 
> 104 P2: (base_task/766:1) linking to local CPU 2 to avoid IPI
> 
> 105 P2: (base_task/766:1) ignoring an enqueue, not a wake up.
> 
> 106 P2: (base_task/766:1) blocks:0 out_of_time:0 np:0 sleep:0 preempt:0 state:0 sig:0
> 
> 107 P2: (base_task/766:1) try_to_wake_up() state:1
> 
> 108 P2: (base_task/766:1) try_to_wake_up() done state:0
> 
> 109 P2: (base_task/766:1) try_to_wake_up() state:0
> 
> 110 P2: (base_task/766:1) try_to_wake_up() done state:0
> 
> 111 P2: (base_task/766:1) block at 245999651240
> 
> 112 P2: (base_task/766:1) blocks:1 out_of_time:0 np:0 sleep:0 preempt:1 state:1 sig:0
> 
> 113 P2: (base_task/766:1) scheduled_on = NO_CPU
> 
> 114 P3: (base_task/767:0) alloc_ctrl_page ctrl_page = ffff88001d3da000
> 
> 115 P3: (base_task/767:0) litmus/ctrl: mapping ffff88001d3da000 (pfn:1d3da) to 0x7fc667408000 (prot:8000000000000027)
> 
> 116 P3: (base_task/767:0) litmus_ctrl_mmap flags=0x10162073 prot=0x8000000000000027
> 
> 117 P4: Setting up rt task parameters for process 767.
> 
> 118 P4: gsn edf: task new 767
> 
> 119 P4: rt: adding base_task/767 (128000000, 644000000, 644000000) rel=246003046895 to ready queue at 246003048071
> 
> 120 P4: (base_task/767:1) linking to local CPU 4 to avoid IPI
> 
> 121 P4: (base_task/767:1) ignoring an enqueue, not a wake up.
> 
> 122 P4: (base_task/767:1) blocks:0 out_of_time:0 np:0 sleep:0 preempt:0 state:0 sig:0
> 
> 123 P4: (base_task/767:1) try_to_wake_up() state:1
> 
> 124 P4: (base_task/767:1) try_to_wake_up() done state:0
> 
> 125 P4: (base_task/767:1) try_to_wake_up() state:0
> 
> 126 P4: (base_task/767:1) try_to_wake_up() done state:0
> 
> 127 P4: (base_task/767:1) block at 246003225410
> 
> 128 P4: (base_task/767:1) blocks:1 out_of_time:0 np:0 sleep:0 preempt:1 state:1 sig:0
> 
> 129 P4: (base_task/767:1) scheduled_on = NO_CPU
> 
> 130 P4: Setting up rt task parameters for process 765.
> 
> 131 P4: gsn edf: task new 765
> 
> 132 P4: rt: adding base_task/765 (478000000, 634000000, 634000000) rel=246003479909 to ready queue at 246003480520
> 
> 133 P4: (base_task/765:1) linking to local CPU 4 to avoid IPI
> 
> 134 P4: (base_task/765:1) ignoring an enqueue, not a wake up.
> 
> 135 P4: (base_task/765:1) blocks:0 out_of_time:0 np:0 sleep:0 preempt:0 state:0 sig:0
> 
> 136 P4: (base_task/765:1) try_to_wake_up() state:1
> 
> 137 P4: (base_task/765:1) try_to_wake_up() done state:0
> 
> 138 P4: (base_task/765:1) try_to_wake_up() state:0
> 
> 139 P4: (base_task/765:1) try_to_wake_up() done state:0
> 
> 140 P4: (base_task/765:1) block at 246003516461
> 
> 141 P4: (base_task/765:1) blocks:1 out_of_time:0 np:0 sleep:0 preempt:1 state:1 sig:0
> 
> 142 P4: (base_task/765:1) scheduled_on = NO_CPU
> 
> 143 P1: (base_task/768:0) alloc_ctrl_page ctrl_page = ffff88001d63b000
> 
> 144 P1: (base_task/768:0) litmus/ctrl: mapping ffff88001d63b000 (pfn:1d63b) to 0x7f04cd8f8000 (prot:8000000000000027)
> 
> 145 P1: (base_task/768:0) litmus_ctrl_mmap flags=0x10162073 prot=0x8000000000000027
> 
> 146 P1: Setting up rt task parameters for process 768.
> 
> 147 P1: gsn edf: task new 768
> 
> 148 P1: rt: adding base_task/768 (460000000, 645000000, 645000000) rel=246004420644 to ready queue at 246004421838
> 
> 149 P1: (base_task/768:1) linking to local CPU 1 to avoid IPI
> 
> 150 P1: (base_task/768:1) ignoring an enqueue, not a wake up.
> 
> 151 P1: (base_task/768:1) blocks:0 out_of_time:0 np:0 sleep:0 preempt:0 state:0 sig:0
> 
> 152 P1: (base_task/768:1) try_to_wake_up() state:1
> 
> 153 P1: (base_task/768:1) try_to_wake_up() done state:0
> 
> 154 P1: (base_task/768:1) try_to_wake_up() state:0
> 
> 155 P1: (base_task/768:1) try_to_wake_up() done state:0
> 
> 156 P1: (base_task/768:1) block at 246004490589
> 
> 157 P1: (base_task/768:1) blocks:1 out_of_time:0 np:0 sleep:0 preempt:1 state:1 sig:0
> 
> 158 P1: (base_task/768:1) scheduled_on = NO_CPU
> 
> 159 P0: (base_task/769:0) alloc_ctrl_page ctrl_page = ffff88001c886000
> 
> 160 P0: (base_task/769:0) litmus/ctrl: mapping ffff88001c886000 (pfn:1c886) to 0x7f609f8e8000 (prot:8000000000000027)
> 
> 161 P0: (base_task/769:0) litmus_ctrl_mmap flags=0x10162073 prot=0x8000000000000027
> 
> 162 P0: Setting up rt task parameters for process 769.
> 
> 163 P0: gsn edf: task new 769
> 
> 164 P0: rt: adding base_task/769 (10000000, 662000000, 662000000) rel=246007204229 to ready queue at 246007205266
> 
> 165 P0: (base_task/769:1) linking to local CPU 0 to avoid IPI
> 
> 166 P0: (base_task/769:1) ignoring an enqueue, not a wake up.
> 
> 167 P0: (base_task/769:1) blocks:0 out_of_time:0 np:0 sleep:0 preempt:0 state:0 sig:0
> 
> 168 P0: (base_task/769:1) try_to_wake_up() state:1
> 
> 169 P0: (base_task/769:1) try_to_wake_up() done state:0
> 
> 170 P0: (base_task/769:1) try_to_wake_up() state:0
> 
> 171 P0: (base_task/769:1) try_to_wake_up() done state:0
> 
> 172 P0: (base_task/769:1) block at 246007248304
> 
> 173 P0: (base_task/769:1) blocks:1 out_of_time:0 np:0 sleep:0 preempt:1 state:1 sig:0
> 
> 174 P0: (base_task/769:1) scheduled_on = NO_CPU
> 
> 175 P2: (base_task/772:0) alloc_ctrl_page ctrl_page = ffff88001d71e000
> 
> 176 P2: (base_task/772:0) litmus/ctrl: mapping ffff88001d71e000 (pfn:1d71e) to 0x7f7d70028000 (prot:8000000000000027)
> 
> 177 P2: (base_task/772:0) litmus_ctrl_mmap flags=0x10162073 prot=0x8000000000000027
> 
> 178 P2: Setting up rt task parameters for process 772.
> 
> 179 P3: (base_task/770:0) alloc_ctrl_page ctrl_page = ffff88001d21e000
> 
> 180 P3: (base_task/770:0) litmus/ctrl: mapping ffff88001d21e000 (pfn:1d21e) to 0x7f106ed30000 (prot:8000000000000027)
> 
> 181 P3: (base_task/770:0) litmus_ctrl_mmap flags=0x10162073 prot=0x8000000000000027
> 
> 182 P2: gsn edf: task new 772
> 
> 183 P2: rt: adding base_task/772 (137000000, 691000000, 691000000) rel=246010030031 to ready queue at 246010031755
> 
> 184 P2: (base_task/772:1) linking to local CPU 2 to avoid IPI
> 
> 185 P2: (base_task/772:1) ignoring an enqueue, not a wake up.
> 
> 186 P2: (base_task/772:1) blocks:0 out_of_time:0 np:0 sleep:0 preempt:0 state:0 sig:0
> 
> 187 P4: (base_task/772:1) try_to_wake_up() state:1
> 
> 188 P4: (base_task/772:1) try_to_wake_up() done state:0
> 
> 189 P3: Setting up rt task parameters for process 770.
> 
> 190 P2: (base_task/772:1) try_to_wake_up() state:0
> 
> 191 P2: (base_task/772:1) try_to_wake_up() done state:0
> 
> 192 P2: (base_task/772:1) try_to_wake_up() state:0
> 
> 193 P2: (base_task/772:1) try_to_wake_up() done state:0
> 
> 194 P2: (base_task/772:1) block at 246010152448
> 
> 195 P2: (base_task/772:1) blocks:1 out_of_time:0 np:0 sleep:0 preempt:1 state:1 sig:0
> 
> 196 P2: (base_task/772:1) scheduled_on = NO_CPU
> 
> 197 P3: gsn edf: task new 770
> 
> 198 P3: rt: adding base_task/770 (103000000, 666000000, 666000000) rel=246010179923 to ready queue at 246010181373
> 
> 199 P3: (base_task/770:1) linking to local CPU 3 to avoid IPI
> 
> 200 P3: (base_task/770:1) ignoring an enqueue, not a wake up.
> 
> 201 P3: (base_task/770:1) blocks:0 out_of_time:0 np:0 sleep:0 preempt:0 state:0 sig:0
> 
> 202 P3: (base_task/770:1) try_to_wake_up() state:1
> 
> 203 P3: (base_task/770:1) try_to_wake_up() done state:0
> 
> 204 P3: (base_task/770:1) try_to_wake_up() state:0
> 
> 205 P3: (base_task/770:1) try_to_wake_up() done state:0
> 
> 206 P5: (base_task/771:0) alloc_ctrl_page ctrl_page = ffff88007c2bc000
> 
> 207 P3: (base_task/770:1) block at 246010246008
> 
> 208 P5: (base_task/771:0) litmus/ctrl: mapping ffff88007c2bc000 (pfn:7c2bc) to 0x7fa7f5ae8000 (prot:8000000000000027)
> 
> 209 P3: (base_task/770:1) blocks:1 out_of_time:0 np:0 sleep:0 preempt:1 state:1 sig:0
> 
> 210 P3: (base_task/770:1) scheduled_on = NO_CPU
> 
> 211 P5: (base_task/771:0) litmus_ctrl_mmap flags=0x10162073 prot=0x8000000000000027
> 
> 212 P5: Setting up rt task parameters for process 771.
> 
> 213 P5: gsn edf: task new 771
> 
> 214 P5: rt: adding base_task/771 (276000000, 678000000, 678000000) rel=246010457309 to ready queue at 246010458266
> 
> 215 P5: (base_task/771:1) linking to local CPU 5 to avoid IPI
> 
> 216 P5: (base_task/771:1) ignoring an enqueue, not a wake up.
> 
> 217 P5: (base_task/771:1) blocks:0 out_of_time:0 np:0 sleep:0 preempt:0 state:0 sig:0
> 
> 218 P5: (base_task/771:1) try_to_wake_up() state:1
> 
> 219 P5: (base_task/771:1) try_to_wake_up() done state:0
> 
> 220 P5: (base_task/771:1) try_to_wake_up() state:0
> 
> 221 P5: (base_task/771:1) try_to_wake_up() done state:0
> 
> 222 P5: (base_task/771:1) block at 246010519089
> 
> 223 P5: (base_task/771:1) blocks:1 out_of_time:0 np:0 sleep:0 preempt:1 state:1 sig:0
> 
> 224 P5: (base_task/771:1) scheduled_on = NO_CPU
> 
> 225 P0: <<<<<< synchronous task system release >>>>>>
> 
> 226 P0: (base_task/771:1) try_to_wake_up() state:1
> 
> 227 P0: (base_task/771:1) wake_up at 249335157596
> 
> 228 P0: rt: adding base_task/771 (276000000, 678000000, 678000000) rel=249335160937 to ready queue at 249335162445
> 
> 229 P0: (base_task/771:2) linking to local CPU 0 to avoid IPI
> 
> 230 P0: (base_task/771:2) try_to_wake_up() done state:0
> 
> 231 P0: (release_ts/773:0) will be preempted by base_task/771
> 
> 232 P0: (base_task/771:2) scheduled_on = P0
> 
> 233 P0: (base_task/771:2) migrate from 5
> 
> 234 P0: (base_task/771:2) stack_in_use=-1
> 
> 235 P0: (base_task/771:2) blocks:0 out_of_time:0 np:0 sleep:1 preempt:0 state:0 sig:0
> 
> 236 P0: (base_task/771:2) job_completion().
> 
> 237 P0: (base_task/771:2) sporadic release at 250335000000
> 
> 238 P0: (base_task/771:3) add_release(), rel=250335000000
> 
> 239 P0: (base_task/771:3) scheduled_on = NO_CPU
> 
> 240 P0: (base_task/770:1) try_to_wake_up() state:1
> 
> 241 P0: (base_task/770:1) wake_up at 249335243177
> 
> 242 P0: rt: adding base_task/770 (103000000, 666000000, 666000000) rel=249335245245 to ready queue at 249335246291
> 
> 243 P0: (base_task/770:2) linking to local CPU 0 to avoid IPI
> 
> 244 P0: (base_task/770:2) try_to_wake_up() done state:0
> 
> 245 P0: (release_ts/773:0) will be preempted by base_task/770
> 
> 246 P0: (base_task/770:2) scheduled_on = P0
> 
> 247 P0: (base_task/770:2) migrate from 3
> 
> 248 P0: (base_task/770:2) stack_in_use=-1
> 
> 249 P0: (base_task/770:2) blocks:0 out_of_time:0 np:0 sleep:1 preempt:0 state:0 sig:0
> 
> 250 P0: (base_task/770:2) job_completion().
> 
> 251 P0: (base_task/770:2) sporadic release at 250335000000
> 
> 252 P0: (base_task/770:3) add_release(), rel=250335000000
> 
> 253 P0: (base_task/770:3) scheduled_on = NO_CPU
> 
> 254 P0: (base_task/772:1) try_to_wake_up() state:1
> 
> 255 P0: (base_task/772:1) wake_up at 249335309319
> 
> 256 P0: rt: adding base_task/772 (137000000, 691000000, 691000000) rel=249335311261 to ready queue at 249335312403
> 
> 257 P0: (base_task/772:2) linking to local CPU 0 to avoid IPI
> 
> 258 P0: (base_task/772:2) try_to_wake_up() done state:0
> 
> 259 P0: (release_ts/773:0) will be preempted by base_task/772
> 
> 260 P0: (base_task/772:2) scheduled_on = P0
> 
> 261 P0: (base_task/772:2) migrate from 2
> 
> 262 P0: (base_task/772:2) stack_in_use=-1
> 
> 263 P0: (base_task/772:2) blocks:0 out_of_time:0 np:0 sleep:1 preempt:0 state:0 sig:0
> 
> 264 P0: (base_task/772:2) job_completion().
> 
> 265 P0: (base_task/772:2) sporadic release at 250335000000
> 
> 266 P0: (base_task/772:3) add_release(), rel=250335000000
> 
> 267 P0: (base_task/772:3) scheduled_on = NO_CPU
> 
> 268 P0: (base_task/769:1) try_to_wake_up() state:1
> 
> 269 P0: (base_task/769:1) wake_up at 249335371192
> 
> 270 P0: rt: adding base_task/769 (10000000, 662000000, 662000000) rel=249335373171 to ready queue at 249335374185
> 
> 271 P0: (base_task/769:2) linking to local CPU 0 to avoid IPI
> 
> 272 P0: (base_task/769:2) try_to_wake_up() done state:0
> 
> 273 P0: (release_ts/773:0) will be preempted by base_task/769
> 
> 274 P0: (base_task/769:2) scheduled_on = P0
> 
> 275 P0: (base_task/769:2) blocks:0 out_of_time:0 np:0 sleep:1 preempt:0 state:0 sig:0
> 
> 276 P0: (base_task/769:2) job_completion().
> 
> 277 P0: (base_task/769:2) sporadic release at 250335000000
> 
> 278 P0: (base_task/769:3) add_release(), rel=250335000000
> 
> 279 P0: (base_task/769:3) scheduled_on = NO_CPU
> 
> 280 P0: (base_task/768:1) try_to_wake_up() state:1
> 
> 281 P0: (base_task/768:1) wake_up at 249335422499
> 
> 282 P0: rt: adding base_task/768 (460000000, 645000000, 645000000) rel=249335424518 to ready queue at 249335425670
> 
> 283 P0: (base_task/768:2) linking to local CPU 0 to avoid IPI
> 
> 284 P0: (base_task/768:2) try_to_wake_up() done state:0
> 
> 285 P0: (release_ts/773:0) will be preempted by base_task/768
> 
> 286 P0: (base_task/768:2) scheduled_on = P0
> 
> 287 P0: (base_task/768:2) migrate from 1
> 
> 288 P0: (base_task/768:2) stack_in_use=-1
> 
> 289 P0: (base_task/768:2) blocks:0 out_of_time:0 np:0 sleep:1 preempt:0 state:0 sig:0
> 
> 290 P0: (base_task/768:2) job_completion().
> 
> 291 P0: (base_task/768:2) sporadic release at 250335000000
> 
> 292 P0: (base_task/768:3) add_release(), rel=250335000000
> 
> 293 P0: (base_task/768:3) scheduled_on = NO_CPU
> 
> 294 P0: (base_task/765:1) try_to_wake_up() state:1
> 
> 295 P0: (base_task/765:1) wake_up at 249335483548
> 
> 296 P0: rt: adding base_task/765 (478000000, 634000000, 634000000) rel=249335485511 to ready queue at 249335486540
> 
> 297 P0: (base_task/765:2) linking to local CPU 0 to avoid IPI
> 
> 298 P0: (base_task/765:2) try_to_wake_up() done state:0
> 
> 299 P0: (release_ts/773:0) will be preempted by base_task/765
> 
> 300 P0: (base_task/765:2) scheduled_on = P0
> 
> 301 P0: (base_task/765:2) migrate from 4
> 
> 302 P0: (base_task/765:2) stack_in_use=-1
> 
> 303 P0: (base_task/765:2) blocks:0 out_of_time:0 np:0 sleep:1 preempt:0 state:0 sig:0
> 
> 304 P0: (base_task/765:2) job_completion().
> 
> 305 P0: (base_task/765:2) sporadic release at 250335000000
> 
> 306 P0: (base_task/765:3) add_release(), rel=250335000000
> 
> 307 P0: (base_task/765:3) scheduled_on = NO_CPU
> 
> 308 P0: (base_task/767:1) try_to_wake_up() state:1
> 
> 309 P0: (base_task/767:1) wake_up at 249335548928
> 
> 310 P0: rt: adding base_task/767 (128000000, 644000000, 644000000) rel=249335551007 to ready queue at 249335551763
> 
> 311 P0: (base_task/767:2) linking to local CPU 0 to avoid IPI
> 
> 312 P0: (base_task/767:2) try_to_wake_up() done state:0
> 
> 313 P0: (release_ts/773:0) will be preempted by base_task/767
> 
> 314 P0: (base_task/767:2) scheduled_on = P0
> 
> 315 P0: (base_task/767:2) migrate from 4
> 
> 316 P0: (base_task/767:2) stack_in_use=-1
> 
> 317 P0: (base_task/767:2) blocks:0 out_of_time:0 np:0 sleep:1 preempt:0 state:0 sig:0
> 
> 318 P0: (base_task/767:2) job_completion().
> 
> 319 P0: (base_task/767:2) sporadic release at 250335000000
> 
> 320 P0: (base_task/767:3) add_release(), rel=250335000000
> 
> 321 P0: (base_task/767:3) scheduled_on = NO_CPU
> 
> 322 P0: (base_task/766:1) try_to_wake_up() state:1
> 
> 323 P0: (base_task/766:1) wake_up at 249335611816
> 
> 324 P0: rt: adding base_task/766 (334000000, 636000000, 636000000) rel=249335613791 to ready queue at 249335614536
> 
> 325 P0: (base_task/766:2) linking to local CPU 0 to avoid IPI
> 
> 326 P0: (base_task/766:2) try_to_wake_up() done state:0
> 
> 327 P0: (release_ts/773:0) will be preempted by base_task/766
> 
> 328 P0: (base_task/766:2) scheduled_on = P0
> 
> 329 P0: (base_task/766:2) migrate from 2
> 
> 330 P0: (base_task/766:2) stack_in_use=-1
> 
> 331 P0: (base_task/766:2) blocks:0 out_of_time:0 np:0 sleep:1 preempt:0 state:0 sig:0
> 
> 332 P0: (base_task/766:2) job_completion().
> 
> 333 P0: (base_task/766:2) sporadic release at 250335000000
> 
> 334 P0: (base_task/766:3) add_release(), rel=250335000000
> 
> 335 P0: (base_task/766:3) scheduled_on = NO_CPU
> 
> 336 P0: (base_task/764:1) try_to_wake_up() state:1
> 
> 337 P0: (base_task/764:1) wake_up at 249335673983
> 
> 338 P0: rt: adding base_task/764 (12000000, 601000000, 601000000) rel=249335675958 to ready queue at 249335676749
> 
> 339 P0: (base_task/764:2) linking to local CPU 0 to avoid IPI
> 
> 340 P0: (base_task/764:2) try_to_wake_up() done state:0
> 
> 341 P0: (release_ts/773:0) will be preempted by base_task/764
> 
> 342 P0: (base_task/764:2) scheduled_on = P0
> 
> 343 P0: (base_task/764:2) blocks:0 out_of_time:0 np:0 sleep:1 preempt:0 state:0 sig:0
> 
> 344 P0: (base_task/764:2) job_completion().
> 
> 345 P0: (base_task/764:2) sporadic release at 250335000000
> 
> 346 P0: (base_task/764:3) add_release(), rel=250335000000
> 
> 347 P0: (base_task/764:3) scheduled_on = NO_CPU
> 
> 348 P0: (base_task/764:3) linking to local CPU 0 to avoid IPI
> 
> 349 P0: check_for_preemptions: attempting to link task 765 to 2
> 
> 350 P0: P1 is closest available CPU to P0
> 
> 351 P0: check_for_preemptions: attempting to link task 766 to 2
> 
> 352 P0: P2 is closest available CPU to P0
> 
> 353 P0: check_for_preemptions: attempting to link task 767 to 3
> 
> 354 P0: P3 is closest available CPU to P0
> 
> 355 P0: check_for_preemptions: attempting to link task 768 to 4
> 
> 356 P0: P4 is closest available CPU to P0
> 
> 357 P0: check_for_preemptions: attempting to link task 769 to 5
> 
> 358 P0: P5 is closest available CPU to P0
> 
> 359 P0: (swapper/0/0:0) will be preempted by base_task/764
> 
> 360 P0: (base_task/764:3) scheduled_on = P0
> 
> 361 P0: (base_task/764:3) blocks:0 out_of_time:0 np:0 sleep:1 preempt:0 state:0 sig:0
> 
> 362 P0: (base_task/764:3) job_completion().
> 
> 363 P0: (base_task/764:4) add_release(), rel=250936000000
> 
> 364 P0: (base_task/770:3) linking to local CPU 0 to avoid IPI
> 
> 365 P0: (base_task/770:3) scheduled_on = P0
> 
> 366 P0: (base_task/764:4) scheduled_on = NO_CPU
> 
> 367 P5: (swapper/5/0:0) will be preempted by base_task/769
> 
> 368 P5: (base_task/769:3) scheduled_on = P5
> 
> 369 P5: (base_task/769:3) migrate from 0
> 
> 370 P5: (base_task/769:3) stack_in_use=-1
> 
> 371 P5: (base_task/769:3) blocks:0 out_of_time:0 np:0 sleep:1 preempt:0 state:0 sig:0
> 
> 372 P5: (base_task/769:3) job_completion().
> 
> 373 P5: (base_task/769:4) add_release(), rel=250997000000
> 
> 374 P5: (base_task/771:3) linking to local CPU 5 to avoid IPI
> 
> 375 P5: (base_task/771:3) scheduled_on = P5
> 
> 376 P5: (base_task/769:4) scheduled_on = NO_CPU
> 
> 377 P5: (base_task/771:3) migrate from 0
> 
> 378 P5: (base_task/771:3) stack_in_use=-1
> 
> 379 P0: (base_task/770:3) blocks:0 out_of_time:0 np:0 sleep:1 preempt:0 state:0 sig:0
> 
> 380 P0: (base_task/770:3) job_completion().
> 
> 381 P0: (base_task/770:4) add_release(), rel=251001000000
> 
> 382 P0: (base_task/772:3) linking to local CPU 0 to avoid IPI
> 
> 383 P0: (base_task/772:3) scheduled_on = P0
> 
> 384 P0: (base_task/770:4) scheduled_on = NO_CPU
> 
> 385 P0: (base_task/772:3) blocks:0 out_of_time:0 np:0 sleep:1 preempt:0 state:0 sig:0
> 
> 386 P0: (base_task/772:3) job_completion().
> 
> 387 P0: (base_task/772:4) add_release(), rel=251026000000
> 
> 388 P0: (base_task/772:4) scheduled_on = NO_CPU
> 
> 389 P1: (swapper/1/0:0) will be preempted by base_task/765
> 
> 390 P1: (base_task/765:3) scheduled_on = P1
> 
> 391 P1: (base_task/765:3) migrate from 0
> 
> 392 P1: (base_task/765:3) stack_in_use=-1
> 
> 393 P4: (swapper/4/0:0) will be preempted by base_task/768
> 
> 394 P4: (base_task/768:3) scheduled_on = P4
> 
> 395 P4: (base_task/768:3) migrate from 0
> 
> 396 P4: (base_task/768:3) stack_in_use=-1
> 
> 397 P3: (swapper/3/0:0) will be preempted by base_task/767
> 
> 398 P3: (base_task/767:3) scheduled_on = P3
> 
> 399 P3: (base_task/767:3) migrate from 0
> 
> 400 P3: (base_task/767:3) stack_in_use=-1
> 
> 401 P2: (swapper/2/0:0) will be preempted by base_task/766
> 
> 402 P2: (base_task/766:3) scheduled_on = P2
> 
> 403 P2: (base_task/766:3) migrate from 0
> 
> 404 P2: (base_task/766:3) stack_in_use=-1
> 
> 405 P5: (base_task/771:3) blocks:0 out_of_time:0 np:0 sleep:1 preempt:0 state:0 sig:0
> 
> 406 P5: (base_task/771:3) job_completion().
> 
> 407 P5: (base_task/771:4) add_release(), rel=251013000000
> 
> 408 P5: (base_task/771:4) scheduled_on = NO_CPU
> 
> 409 P3: (base_task/767:3) blocks:0 out_of_time:0 np:0 sleep:1 preempt:0 state:0 sig:0
> 
> 410 P3: (base_task/767:3) job_completion().
> 
> 411 P3: (base_task/767:4) add_release(), rel=250979000000
> 
> 412 P3: (base_task/767:4) scheduled_on = NO_CPU
> 
> 413 P0: (base_task/764:4) linking to local CPU 0 to avoid IPI
> 
> 414 P0: (swapper/0/0:0) will be preempted by base_task/764
> 
> 415 P0: (base_task/764:4) scheduled_on = P0
> 
> ...
> 
> 688 P5: (swapper/5/0:0) will be preempted by base_task/771
> 
> 689 P5: (base_task/771:8) scheduled_on = P5
> 
> 690 P0: (base_task/770:8) blocks:0 out_of_time:0 np:0 sleep:1 preempt:0 state:0 sig:0
> 
> 691 P0: (base_task/770:8) job_completion().
> 
> 692 P0: (base_task/770:9) add_release(), rel=254331000000
> 
> 693 P0: (base_task/770:9) scheduled_on = NO_CPU
> 
> 694 P3: (base_task/772:8) linking to local CPU 3 to avoid IPI
> 
> 695 P3: (swapper/3/0:0) will be preempted by base_task/772
> 
> 696 P3: (base_task/772:8) scheduled_on = P3
> 
> 697 P2: (base_task/766:8) blocks:0 out_of_time:0 np:0 sleep:1 preempt:0 state:0 sig:0
> 
> 698 P2: (base_task/766:8) job_completion().
> 
> 699 P2: (base_task/766:9) add_release(), rel=254151000000
> 
> 700 P2: (base_task/766:9) scheduled_on = NO_CPU
> 
> 701 P0: (base_task/764:9) linking to local CPU 0 to avoid IPI
> 
> 702 P0: (swapper/0/0:0) will be preempted by base_task/764
> 
> 703 P0: (base_task/764:9) scheduled_on = P0
> 
> 704 P3: (base_task/772:8) blocks:0 out_of_time:0 np:0 sleep:1 preempt:0 state:0 sig:0
> 
> 705 P3: (base_task/772:8) job_completion().
> 
> 706 P3: (base_task/772:9) add_release(), rel=254481000000
> 
> 707 P3: (base_task/772:9) scheduled_on = NO_CPU
> 
> 708 P0: (base_task/764:9) blocks:0 out_of_time:0 np:0 sleep:1 preempt:0 state:0 sig:0
> 
> 709 P0: (base_task/764:9) job_completion().
> 
> 710 P0: (base_task/764:10) add_release(), rel=254542000000
> 
> 711 P0: (base_task/764:10) scheduled_on = NO_CPU
> 
> 712 P5: (base_task/771:8) blocks:0 out_of_time:0 np:0 sleep:1 preempt:0 state:0 sig:0
> 
> 713 P5: (base_task/771:8) job_completion().
> 
> 714 P5: (base_task/771:9) add_release(), rel=254403000000
> 
> 715 P5: (base_task/771:9) scheduled_on = NO_CPU
> 
> 716 P1: (base_task/765:8) blocks:0 out_of_time:0 np:0 sleep:1 preempt:0 state:0 sig:0
> 
> 717 P1: (base_task/765:8) job_completion().
> 
> 718 P1: (base_task/765:9) add_release(), rel=254139000000
> 
> 719 P1: (base_task/765:9) scheduled_on = NO_CPU
> 
> 720 P4: (base_task/768:8) blocks:0 out_of_time:0 np:0 sleep:1 preempt:0 state:0 sig:0
> 
> 721 P4: (base_task/768:8) job_completion().
> 
> 722 P4: (base_task/768:9) add_release(), rel=254205000000
> 
> 723 P4: (base_task/768:9) scheduled_on = NO_CPU
> 
> 724 P1: (base_task/765:9) linking to local CPU 1 to avoid IPI
> 
> 725 P1: (swapper/1/0:0) will be preempted by base_task/765
> 
> 726 P1: (base_task/765:9) scheduled_on = P1
> 
> 727 P2: (base_task/766:9) linking to local CPU 2 to avoid IPI
> 
> 728 P2: (swapper/2/0:0) will be preempted by base_task/766
> 
> 729 P2: (base_task/766:9) scheduled_on = P2
> 
> 730 P3: (base_task/767:9) linking to local CPU 3 to avoid IPI
> 
> 731 P3: (swapper/3/0:0) will be preempted by base_task/767
> 
> 732 P3: (base_task/767:9) scheduled_on = P3
> 
> 733 P4: (base_task/768:9) linking to local CPU 4 to avoid IPI
> 
> 734 P4: (swapper/4/0:0) will be preempted by base_task/768
> 
> 735 P4: (base_task/768:9) scheduled_on = P4
> 
> 736 P5: (base_task/769:9) linking to local CPU 5 to avoid IPI
> 
> 737 P5: (swapper/5/0:0) will be preempted by base_task/769
> 
> 738 P5: (base_task/769:9) scheduled_on = P5
> 
> 739 P5: (base_task/769:9) blocks:0 out_of_time:0 np:0 sleep:1 preempt:0 state:0 sig:0
> 
> 740 P5: (base_task/769:9) job_completion().
> 
> 741 P5: (base_task/769:10) add_release(), rel=254969000000
> 
> 742 P5: (base_task/769:10) scheduled_on = NO_CPU
> 
> 743 P0: (base_task/770:9) linking to local CPU 0 to avoid IPI
> 
> 744 P0: (swapper/0/0:0) will be preempted by base_task/770
> 
> 745 P0: (base_task/770:9) scheduled_on = P0
> 
> 746 P3: (base_task/767:9) blocks:0 out_of_time:0 np:0 sleep:1 preempt:0 state:0 sig:0
> 
> 747 P3: (base_task/767:9) job_completion().
> 
> 748 P3: (base_task/767:10) add_release(), rel=254843000000
> 
> 749 P3: (base_task/767:10) scheduled_on = NO_CPU
> 
> 750 P5: (base_task/771:9) linking to local CPU 5 to avoid IPI
> 
> 751 P5: (swapper/5/0:0) will be preempted by base_task/771
> 
> 752 P5: (base_task/771:9) scheduled_on = P5
> 
> 753 P0: (base_task/770:9) blocks:0 out_of_time:0 np:0 sleep:1 preempt:0 state:0 sig:0
> 
> 754 P0: (base_task/770:9) job_completion().
> 
> 755 P0: (base_task/770:10) add_release(), rel=254997000000
> 
> 756 P0: (base_task/770:10) scheduled_on = NO_CPU
> 
> 757 P3: (base_task/772:9) linking to local CPU 3 to avoid IPI
> 
> 758 P3: (swapper/3/0:0) will be preempted by base_task/772
> 
> 759 P3: (base_task/772:9) scheduled_on = P3
> 
> 



Sorry to hear you are still facing the issue. I'm not seeing a crash in the log. What sort of crash are you facing? The domain crashes? Xen itself crashes? Is it a BUG_ON() triggering? If so, which?

Thanks,
Björn