Bug 105501

Summary: [BAT] igt@drv_module_reload@basic-reload - dmesg-warn - BUG: unable to handle kernel paging request at ffffffffa00b4440 -
Product: DRI Reporter: Marta Löfstedt <marta.lofstedt>
Component: DRM/IntelAssignee: Intel GFX Bugs mailing list <intel-gfx-bugs>
Status: CLOSED WORKSFORME QA Contact: Intel GFX Bugs mailing list <intel-gfx-bugs>
Severity: normal    
Priority: medium CC: intel-gfx-bugs
Version: DRI git   
Hardware: Other   
OS: All   
Whiteboard: ReadyForDev
i915 platform: BSW/CHT i915 features: display/audio

Description Marta Löfstedt 2018-03-14 12:01:36 UTC 
https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_3924/fi-bsw-n3050/igt@drv_module_reload@basic-reload.html

This looks like core issue. 

<7>[  520.387024] [drm:i915_audio_component_get_eld [i915]] Not valid for port D
<6>[  520.405770] input: HDA Intel PCH Mic as /devices/pci0000:00/0000:00:1b.0/sound/card0/input9
<6>[  520.409880] input: HDA Intel PCH Headphone Front as /devices/pci0000:00/0000:00:1b.0/sound/card0/input10
<6>[  520.412090] input: HDA Intel PCH Front Headphone Surround as /devices/pci0000:00/0000:00:1b.0/sound/card0/input11
<6>[  520.414097] input: HDA Intel PCH HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:1b.0/sound/card0/input12
<1>[  520.551830] BUG: unable to handle kernel paging request at ffffffffa00b4440
<1>[  520.551871] IP: string+0x20/0x70
<6>[  520.551883] PGD 5212067 P4D 5212067 PUD 5213063 PMD 175b10067 PTE 0
<4>[  520.551912] Oops: 0000 [#1] PREEMPT SMP PTI
<0>[  520.551929] Dumping ftrace buffer:
<0>[  520.551942] ---------------------------------
<0>[  520.551979] CPU:0 [LOST 599499 EVENTS]
                  gem_sync-3465    0..s1 363157454us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bcb, prio=0
<0>[  520.552023] gem_sync-3465    0..s1 363157792us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bcc, prio=0
<0>[  520.552057] gem_sync-3465    0..s1 363158185us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bcd, prio=0
<0>[  520.552091] gem_sync-3465    0..s1 363158575us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bce, prio=0
<0>[  520.552125] gem_sync-3465    0..s1 363158914us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bcf, prio=0
<0>[  520.552158] gem_sync-3465    0..s1 363159305us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bd0, prio=0
<0>[  520.552192] gem_sync-3465    0..s1 363159669us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bd1, prio=0
<0>[  520.552226] gem_sync-3465    0..s1 363160074us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bd2, prio=0
<0>[  520.552261] gem_sync-3465    0..s1 363160367us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bd3, prio=0
<0>[  520.552295] gem_sync-3465    0..s1 363160704us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bd4, prio=0
<0>[  520.552329] gem_sync-3465    0..s1 363161100us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bd5, prio=0
<0>[  520.552364] gem_sync-3465    0..s1 363161453us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bd6, prio=0
<0>[  520.552398] gem_sync-3465    0..s1 363161814us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bd7, prio=0
<0>[  520.552432] gem_sync-3465    0..s1 363162217us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bd8, prio=0
<0>[  520.552467] gem_sync-3465    0..s1 363162578us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bd9, prio=0
<0>[  520.552501] gem_sync-3465    0..s1 363162997us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bda, prio=0
<0>[  520.552535] gem_sync-3465    0..s1 363163307us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bdb, prio=0
<0>[  520.552569] gem_sync-3465    0..s1 363163670us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bdc, prio=0
<0>[  520.552604] gem_sync-3465    0..s1 363164069us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bdd, prio=0
<0>[  520.552638] gem_sync-3465    0..s1 363164367us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bde, prio=0
<0>[  520.552672] gem_sync-3465    0..s1 363164718us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bdf, prio=0
<0>[  520.552706] gem_sync-3465    0..s1 363165115us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1be0, prio=0
<0>[  520.552740] gem_sync-3465    0..s1 363165479us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1be1, prio=0
<0>[  520.552775] gem_sync-3465    0..s1 363165841us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1be2, prio=0
<0>[  520.552809] gem_sync-3465    0..s1 363166242us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1be3, prio=0
<0>[  520.552843] gem_sync-3465    0..s1 363166628us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1be4, prio=0
<0>[  520.552877] gem_sync-3465    0..s1 363167029us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1be5, prio=0
<0>[  520.552911] gem_sync-3465    0..s1 363167344us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1be6, prio=0
<0>[  520.552945] gem_sync-3465    0..s1 363167698us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1be7, prio=0
<0>[  520.552979] gem_sync-3465    0..s1 363168102us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1be8, prio=0
<0>[  520.553013] gem_sync-3465    0..s1 363168442us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1be9, prio=0
<0>[  520.553048] gem_sync-3465    0..s1 363168814us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bea, prio=0
<0>[  520.553082] gem_sync-3465    0..s1 363169190us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1beb, prio=0
<0>[  520.553116] gem_sync-3465    0..s1 363169575us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bec, prio=0
<0>[  520.553150] gem_sync-3465    0..s1 363169965us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bed, prio=0
<0>[  520.553184] gem_sync-3465    0..s1 363170278us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bee, prio=0
<0>[  520.553218] gem_sync-3465    0..s1 363170641us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bef, prio=0
<0>[  520.553252] gem_sync-3465    0..s1 363171074us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bf0, prio=0
<0>[  520.553286] gem_sync-3465    0..s1 363171364us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bf1, prio=0
<0>[  520.553320] gem_sync-3465    0..s1 363171709us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bf2, prio=0
<0>[  520.553354] gem_sync-3465    0..s1 363172139us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bf3, prio=0
<0>[  520.553388] gem_sync-3465    0..s1 363172477us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bf4, prio=0
<0>[  520.553423] gem_sync-3465    0..s1 363172840us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bf5, prio=0
<0>[  520.553457] gem_sync-3465    0..s1 363173239us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bf6, prio=0
<0>[  520.553491] gem_sync-3465    0..s1 363173598us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bf7, prio=0
<0>[  520.553525] gem_sync-3465    0..s1 363173998us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bf8, prio=0
<0>[  520.553559] gem_sync-3465    0..s1 363174335us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bf9, prio=0
<0>[  520.553593] gem_sync-3465    0..s1 363174696us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bfa, prio=0
<0>[  520.553628] gem_sync-3465    0..s1 363175114us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bfb, prio=0
<0>[  520.553662] gem_sync-3465    0..s1 363175406us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bfc, prio=0
<0>[  520.553696] gem_sync-3465    0..s1 363175697us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bfd, prio=0
<0>[  520.553730] gem_sync-3465    0..s1 363176094us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bfe, prio=0
<0>[  520.553764] gem_sync-3465    0..s1 363176434us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1bff, prio=0
<0>[  520.553798] gem_sync-3465    0..s1 363176822us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1c00, prio=0
<0>[  520.553832] gem_sync-3465    0..s1 363177216us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1c01, prio=0
<0>[  520.553866] gem_sync-3465    0..s1 363177555us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1c02, prio=0
<0>[  520.553901] gem_wait-3480    0..s1 366083929us : 0xffffffffa015e021: rcs0 in[0]:  ctx=1.1, seqno=1, prio=0
<0>[  520.553935] gem_wait-3480    0..s1 366084507us : 0xffffffffa015e021: vcs0 in[0]:  ctx=1.1, seqno=1, prio=0
<0>[  520.553968] gem_wait-3480    0..s1 366085009us : 0xffffffffa015e021: bcs0 in[0]:  ctx=1.1, seqno=1, prio=0
<0>[  520.554002] gem_wait-3480    0..s1 366085484us : 0xffffffffa015e021: vecs0 in[0]:  ctx=1.1, seqno=1, prio=0
<0>[  520.554036] gem_wait-3488    0..s1 367055123us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1, prio=0
<0>[  520.554069] gem_wait-3488    0..s1 367055584us : 0xffffffffa015e021: vcs0 in[0]:  ctx=2.1, seqno=1, prio=0
<0>[  520.554103] gem_wait-3488    0..s1 367056115us : 0xffffffffa015e021: bcs0 in[0]:  ctx=2.1, seqno=1, prio=0
<0>[  520.554136] gem_wait-3488    0..s1 367056583us : 0xffffffffa015e021: vecs0 in[0]:  ctx=2.1, seqno=1, prio=0
<0>[  520.554170] kms_curs-3656    0..s1 391191092us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1, prio=0
<0>[  520.554204] kms_curs-3656    0..s1 391221708us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1, prio=0
<0>[  520.554237] kms_curs-3656    0..s1 391255576us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1, prio=0
<0>[  520.554271] kms_curs-3656    0..s1 391288506us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1, prio=0
<0>[  520.554304] kms_curs-3656    0..s1 391323428us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1, prio=0
<0>[  520.554338] kms_curs-3656    0..s1 391355365us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1, prio=0
<0>[  520.554371] kms_curs-3656    0..s1 391388384us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1, prio=0
<0>[  520.554405] kms_curs-3656    0..s1 391421599us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1, prio=0
<0>[  520.554440] kms_fron-3712    0..s1 471900456us : 0xffffffffa015e021: bcs0 in[0]:  ctx=2.1, seqno=1, prio=0
<0>[  520.554473] kms_fron-3712    0..s1 473055100us : 0xffffffffa015e021: bcs0 in[0]:  ctx=2.1, seqno=2, prio=0
<0>[  520.554507] kms_fron-3712    0..s1 473188185us : 0xffffffffa015e021: bcs0 in[0]:  ctx=2.1, seqno=3, prio=0
<0>[  520.554541] kms_fron-3712    0..s1 473300422us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1, prio=0
<0>[  520.554574] kms_pipe-3733    0.... 478460410us : 0xffffffffa015e64f: rcs0 seqno=0
<0>[  520.554603] kms_pipe-3733    0.... 478469013us : 0xffffffffa015e64f: bcs0 seqno=0
<0>[  520.554631] kms_pipe-3733    0.... 478469106us : 0xffffffffa015e64f: vcs0 seqno=0
<0>[  520.554660] kms_pipe-3733    0.... 478469177us : 0xffffffffa015e64f: vecs0 seqno=0
<0>[  520.554689] ksoftirq-7       0..s. 478473618us : 0xffffffffa015e021: rcs0 in[0]:  ctx=0.1, seqno=2, prio=-1024
<0>[  520.554724] ksoftirq-7       0..s. 478473635us : 0xffffffffa015e021: bcs0 in[0]:  ctx=0.1, seqno=4, prio=-1024
<0>[  520.554758] ksoftirq-7       0..s. 478473650us : 0xffffffffa015e021: vcs0 in[0]:  ctx=0.1, seqno=1, prio=-1024
<0>[  520.554792] ksoftirq-7       0..s. 478473665us : 0xffffffffa015e021: vecs0 in[0]:  ctx=0.1, seqno=1, prio=-1024
<0>[  520.554827] kworker/-2988    0..s1 493095474us : 0xffffffffa015e021: rcs0 in[0]:  ctx=0.1, seqno=3, prio=-1024
<0>[  520.554862] kworker/-2988    0..s. 493095718us : 0xffffffffa015cfb0: rcs0 cs-irq head=0 [0], tail=1 [1]
<0>[  520.554895] kworker/-2988    0..s. 493095723us : 0xffffffffa015d037: rcs0 csb[1]: status=0x00000018:0x00000000, active=0x1
<0>[  520.554931] kworker/-2988    0..s. 493095727us : 0xffffffffa015d100: rcs0 out[0]: ctx=0.1, seqno=3, prio=-1024
<0>[  520.554966] kworker/-2988    0..s. 493095734us : 0xffffffffa015d1ef: rcs0 completed ctx=0
<0>[  520.554996] kworker/-2988    0..s1 493095967us : 0xffffffffa015e021: bcs0 in[0]:  ctx=0.1, seqno=5, prio=-1024
<0>[  520.555031] kworker/-2988    0..s. 493096086us : 0xffffffffa015cfb0: bcs0 cs-irq head=0 [0], tail=1 [1]
<0>[  520.555064] kworker/-2988    0..s. 493096090us : 0xffffffffa015d037: bcs0 csb[1]: status=0x00000018:0x00000000, active=0x1
<0>[  520.555100] kworker/-2988    0..s. 493096093us : 0xffffffffa015d100: bcs0 out[0]: ctx=0.1, seqno=5, prio=-1024
<0>[  520.555134] kworker/-2988    0..s. 493096098us : 0xffffffffa015d1ef: bcs0 completed ctx=0
<0>[  520.555165] kworker/-2988    0..s1 493096307us : 0xffffffffa015e021: vcs0 in[0]:  ctx=0.1, seqno=2, prio=-1024
<0>[  520.555199] kworker/-2988    0..s. 493096425us : 0xffffffffa015cfb0: vcs0 cs-irq head=0 [0], tail=1 [1]
<0>[  520.555232] kworker/-2988    0..s. 493096429us : 0xffffffffa015d037: vcs0 csb[1]: status=0x00000018:0x00000000, active=0x1
<0>[  520.555269] kworker/-2988    0..s. 493096431us : 0xffffffffa015d100: vcs0 out[0]: ctx=0.1, seqno=2, prio=-1024
<0>[  520.555302] kworker/-2988    0..s. 493096435us : 0xffffffffa015d1ef: vcs0 completed ctx=0
<0>[  520.555333] kworker/-2988    0.Ns1 493096737us : 0xffffffffa015e021: vecs0 in[0]:  ctx=0.1, seqno=2, prio=-1024
<0>[  520.555368]  rtcwake-3783    0..s1 493096986us : 0xffffffffa015cfb0: vecs0 cs-irq head=0 [0], tail=1 [1]
<0>[  520.555402]  rtcwake-3783    0..s1 493096991us : 0xffffffffa015d037: vecs0 csb[1]: status=0x00000018:0x00000000, active=0x1
<0>[  520.555438]  rtcwake-3783    0..s1 493096993us : 0xffffffffa015d100: vecs0 out[0]: ctx=0.1, seqno=2, prio=-1024
<0>[  520.555472]  rtcwake-3783    0..s1 493096999us : 0xffffffffa015d1ef: vecs0 completed ctx=0
<0>[  520.555503] prime_bu-3828    0..s1 501854455us : 0xffffffffa015e021: rcs0 in[0]:  ctx=1.1, seqno=1, prio=0
<0>[  520.555537] prime_bu-3854    0..s1 503304487us : 0xffffffffa015e021: rcs0 in[0]:  ctx=1.1, seqno=1, prio=0
<0>[  520.555571] prime_vg-3923    0..s1 511704082us : 0xffffffffa015e021: rcs0 in[0]:  ctx=1.1, seqno=1, prio=0
<0>[  520.555605] prime_vg-3926    0..s1 512123611us : 0xffffffffa015e021: rcs0 in[0]:  ctx=2.1, seqno=1, prio=0
<0>[  520.555740] drv_modu-3978    0..s1 519178552us : execlists_submission_tasklet: rcs0 in[0]:  ctx=1.1, seqno=3, prio=0
<0>[  520.555846] drv_modu-3978    0..s1 519189853us : execlists_submission_tasklet: rcs0 in[0]:  ctx=1.1, seqno=4, prio=0
<0>[  520.555952] drv_modu-3978    0..s1 519197403us : execlists_submission_tasklet: vcs0 in[0]:  ctx=1.1, seqno=3, prio=0
<0>[  520.556058] drv_modu-3978    0..s1 519210197us : execlists_submission_tasklet: bcs0 in[0]:  ctx=1.1, seqno=3, prio=0
<0>[  520.556164] drv_modu-3978    0..s1 519222736us : execlists_submission_tasklet: vecs0 in[0]:  ctx=1.1, seqno=3, prio=0
<0>[  520.556270] drv_modu-3978    0..s1 519233833us : execlists_submission_tasklet: rcs0 in[0]:  ctx=1.1, seqno=5, prio=0
<0>[  520.556376] drv_modu-3978    0..s1 519234785us : execlists_submission_tasklet: rcs0 in[0]:  ctx=1.1, seqno=7, prio=0
<0>[  520.556482] drv_modu-3978    0..s1 519235049us : execlists_submission_tasklet: rcs0 in[0]:  ctx=1.1, seqno=8, prio=0
<0>[  520.556587] drv_modu-3978    0..s1 519235374us : execlists_submission_tasklet: vcs0 in[0]:  ctx=1.1, seqno=4, prio=0
<0>[  520.556693] drv_modu-3978    0..s1 519235723us : execlists_submission_tasklet: vcs0 in[0]:  ctx=1.1, seqno=5, prio=0
<0>[  520.556799] drv_modu-3978    0..s1 519236038us : execlists_submission_tasklet: bcs0 in[0]:  ctx=1.1, seqno=4, prio=0
<0>[  520.556905] drv_modu-3978    0..s1 519236285us : execlists_submission_tasklet: bcs0 in[0]:  ctx=1.1, seqno=5, prio=0
<0>[  520.557011] drv_modu-3978    0..s1 519236597us : execlists_submission_tasklet: vecs0 in[0]:  ctx=1.1, seqno=4, prio=0
<0>[  520.557117] drv_modu-3978    0..s1 519236922us : execlists_submission_tasklet: vecs0 in[0]:  ctx=1.1, seqno=5, prio=0
<0>[  520.557223] drv_modu-3978    0..s1 519237135us : execlists_submission_tasklet: vecs0 in[0]:  ctx=1.1, seqno=6, prio=0
<0>[  520.557328] drv_modu-3978    0..s1 519237293us : execlists_submission_tasklet: vcs0 in[0]:  ctx=1.1, seqno=6, prio=0
<0>[  520.557434] drv_modu-3978    0..s1 519237471us : execlists_submission_tasklet: rcs0 in[0]:  ctx=1.1, seqno=9, prio=0
<0>[  520.557540] drv_modu-3978    0..s1 519237930us : execlists_submission_tasklet: bcs0 in[0]:  ctx=1.1, seqno=6, prio=0
<0>[  520.557646] drv_modu-3978    0..s1 519238087us : execlists_submission_tasklet: rcs0 in[0]:  ctx=1.1, seqno=b, prio=0
<0>[  520.557753] CPU:1 [LOST 5934972 EVENTS]
                    <idle>-0       1..s1 519238184us : execlists_submission_tasklet: rcs0 csb[2]: status=0x00000001:0x00000000, active=0x1
<0>[  520.557871]   <idle>-0       1..s1 519238191us : execlists_submission_tasklet: rcs0 cs-irq head=2 [2?], tail=3 [3?]
<0>[  520.557977]   <idle>-0       1..s1 519238193us : execlists_submission_tasklet: rcs0 csb[3]: status=0x00000018:0x00000001, active=0x5
<0>[  520.558086]   <idle>-0       1..s1 519238197us : execlists_submission_tasklet: rcs0 out[0]: ctx=1.1, seqno=b, prio=0
<0>[  520.558191]   <idle>-0       1..s1 519238237us : execlists_submission_tasklet: rcs0 completed ctx=1
<0>[  520.558294]   <idle>-0       1..s1 519238256us : execlists_submission_tasklet: rcs0 in[0]:  ctx=1.1, seqno=c, prio=0
<0>[  520.558400]   <idle>-0       1..s1 519238305us : execlists_submission_tasklet: rcs0 cs-irq head=3 [3?], tail=4 [4?]
<0>[  520.558506]   <idle>-0       1..s1 519238308us : execlists_submission_tasklet: rcs0 csb[4]: status=0x00000001:0x00000000, active=0x1
<0>[  520.558615] drv_modu-3978    0..s1 519238347us : execlists_submission_tasklet: rcs0 in[0]:  ctx=1.2, seqno=d, prio=0
<0>[  520.558720]   <idle>-0       1..s1 519238394us : execlists_submission_tasklet: rcs0 cs-irq head=4 [4?], tail=0 [0?]
<0>[  520.558826]   <idle>-0       1..s1 519238397us : execlists_submission_tasklet: rcs0 csb[5]: status=0x00000018:0x00000001, active=0x1
<0>[  520.558935]   <idle>-0       1..s1 519238399us : execlists_submission_tasklet: rcs0 out[0]: ctx=1.2, seqno=d, prio=0
<0>[  520.559041]   <idle>-0       1..s1 519238401us : execlists_submission_tasklet: rcs0 csb[0]: status=0x00000001:0x00000000, active=0x1
<0>[  520.559150]   <idle>-0       1..s1 519238450us : execlists_submission_tasklet: rcs0 cs-irq head=0 [0?], tail=1 [1?]
<0>[  520.559256]   <idle>-0       1..s1 519238452us : execlists_submission_tasklet: rcs0 csb[1]: status=0x00000018:0x00000001, active=0x5
<0>[  520.559365]   <idle>-0       1..s1 519238454us : execlists_submission_tasklet: rcs0 out[0]: ctx=1.1, seqno=d, prio=0
<0>[  520.559470]   <idle>-0       1..s1 519238458us : execlists_submission_tasklet: rcs0 completed ctx=1
<0>[  520.559573] drv_modu-3978    0..s1 519238525us : execlists_submission_tasklet: vecs0 in[0]:  ctx=1.1, seqno=7, prio=0
<0>[  520.559679]   <idle>-0       1..s1 519238638us : execlists_submission_tasklet: vecs0 cs-irq head=5 [5?], tail=1 [1?]
<0>[  520.559785]   <idle>-0       1..s1 519238641us : execlists_submission_tasklet: vecs0 csb[0]: status=0x00000001:0x00000000, active=0x1
<0>[  520.559894]   <idle>-0       1..s1 519238643us : execlists_submission_tasklet: vecs0 csb[1]: status=0x00000018:0x00000001, active=0x5
<0>[  520.560003]   <idle>-0       1..s1 519238645us : execlists_submission_tasklet: vecs0 out[0]: ctx=1.1, seqno=7, prio=0
<0>[  520.560109]   <idle>-0       1..s1 519238649us : execlists_submission_tasklet: vecs0 completed ctx=1
<0>[  520.560212] drv_modu-3978    0..s1 519238724us : execlists_submission_tasklet: vcs0 in[0]:  ctx=1.1, seqno=7, prio=0
<0>[  520.560318]   <idle>-0       1..s1 519238818us : execlists_submission_tasklet: vcs0 cs-irq head=5 [5?], tail=1 [1?]
<0>[  520.560423]   <idle>-0       1..s1 519238821us : execlists_submission_tasklet: vcs0 csb[0]: status=0x00000001:0x00000000, active=0x1
<0>[  520.560532]   <idle>-0       1..s1 519238823us : execlists_submission_tasklet: vcs0 csb[1]: status=0x00000018:0x00000001, active=0x5
<0>[  520.560641]   <idle>-0       1..s1 519238825us : execlists_submission_tasklet: vcs0 out[0]: ctx=1.1, seqno=7, prio=0
<0>[  520.560746]   <idle>-0       1..s1 519238828us : execlists_submission_tasklet: vcs0 completed ctx=1
<0>[  520.560849] drv_modu-3978    0..s1 519238881us : execlists_submission_tasklet: bcs0 in[0]:  ctx=1.1, seqno=7, prio=0
<0>[  520.560955]   <idle>-0       1..s1 519238973us : execlists_submission_tasklet: bcs0 cs-irq head=5 [5?], tail=1 [1?]
<0>[  520.561061]   <idle>-0       1..s1 519238976us : execlists_submission_tasklet: bcs0 csb[0]: status=0x00000001:0x00000000, active=0x1
<0>[  520.561170]   <idle>-0       1..s1 519238978us : execlists_submission_tasklet: bcs0 csb[1]: status=0x00000018:0x00000001, active=0x5
<0>[  520.561278]   <idle>-0       1..s1 519238980us : execlists_submission_tasklet: bcs0 out[0]: ctx=1.1, seqno=7, prio=0
<0>[  520.561384]   <idle>-0       1..s1 519238984us : execlists_submission_tasklet: bcs0 completed ctx=1
<0>[  520.561486] drv_modu-3978    0..s1 519239037us : execlists_submission_tasklet: rcs0 in[0]:  ctx=1.1, seqno=e, prio=0
<0>[  520.561592]   <idle>-0       1..s1 519239157us : execlists_submission_tasklet: rcs0 cs-irq head=1 [1?], tail=2 [2?]
<0>[  520.561698]   <idle>-0       1..s1 519239201us : execlists_submission_tasklet: rcs0 csb[2]: status=0x00000001:0x00000000, active=0x1
<0>[  520.561807]   <idle>-0       1..s1 519239207us : execlists_submission_tasklet: rcs0 cs-irq head=2 [2?], tail=3 [3?]
<0>[  520.561912]   <idle>-0       1..s1 519239209us : execlists_submission_tasklet: rcs0 csb[3]: status=0x00000018:0x00000001, active=0x5
<0>[  520.562021]   <idle>-0       1..s1 519239211us : execlists_submission_tasklet: rcs0 out[0]: ctx=1.1, seqno=e, prio=0
<0>[  520.562126]   <idle>-0       1..s1 519239258us : execlists_submission_tasklet: rcs0 completed ctx=1
<0>[  520.562229]   <idle>-0       1..s1 519239276us : execlists_submission_tasklet: rcs0 in[0]:  ctx=1.1, seqno=f, prio=0
<0>[  520.562335]   <idle>-0       1..s1 519239324us : execlists_submission_tasklet: rcs0 cs-irq head=3 [3?], tail=4 [4?]
<0>[  520.562440]   <idle>-0       1..s1 519239327us : execlists_submission_tasklet: rcs0 csb[4]: status=0x00000001:0x00000000, active=0x1
<0>[  520.562549]   <idle>-0       1..s1 519239392us : execlists_submission_tasklet: rcs0 cs-irq head=4 [4?], tail=5 [5?]
<0>[  520.562655]   <idle>-0       1..s1 519239394us : execlists_submission_tasklet: rcs0 csb[5]: status=0x00000018:0x00000001, active=0x5
<0>[  520.562763]   <idle>-0       1..s1 519239397us : execlists_submission_tasklet: rcs0 out[0]: ctx=1.1, seqno=f, prio=0
<0>[  520.562869]   <idle>-0       1..s1 519239400us : execlists_submission_tasklet: rcs0 completed ctx=1
<0>[  520.562971] drv_modu-3978    0..s1 519240682us : execlists_submission_tasklet: vcs0 in[0]:  ctx=1.1, seqno=8, prio=0
<0>[  520.563077] drv_modu-3978    0..s1 519240886us : execlists_submission_tasklet: rcs0 in[0]:  ctx=1.1, seqno=10, prio=0
<0>[  520.563183]   <idle>-0       1..s1 519241072us : execlists_submission_tasklet: vcs0 cs-irq head=1 [1?], tail=3 [3?]
<0>[  520.563289]   <idle>-0       1..s1 519241076us : execlists_submission_tasklet: vcs0 csb[2]: status=0x00000001:0x00000000, active=0x1
<0>[  520.563398]   <idle>-0       1..s1 519241079us : execlists_submission_tasklet: vcs0 csb[3]: status=0x00000018:0x00000001, active=0x5
<0>[  520.563507]   <idle>-0       1..s1 519241081us : execlists_submission_tasklet: vcs0 out[0]: ctx=1.1, seqno=8, prio=0
<0>[  520.563612]   <idle>-0       1..s1 519241125us : execlists_submission_tasklet: vcs0 completed ctx=1
<0>[  520.563715]   <idle>-0       1..s1 519241135us : execlists_submission_tasklet: rcs0 cs-irq head=5 [5?], tail=1 [1?]
<0>[  520.563820]   <idle>-0       1..s1 519241137us : execlists_submission_tasklet: rcs0 csb[0]: status=0x00000001:0x00000000, active=0x1
<0>[  520.563929]   <idle>-0       1..s1 519241140us : execlists_submission_tasklet: rcs0 csb[1]: status=0x00000018:0x00000001, active=0x5
<0>[  520.564038]   <idle>-0       1..s1 519241142us : execlists_submission_tasklet: rcs0 out[0]: ctx=1.1, seqno=10, prio=0
<0>[  520.564144]   <idle>-0       1..s1 519241146us : execlists_submission_tasklet: rcs0 completed ctx=1
<0>[  520.564246] drv_modu-3978    0..s1 519242118us : execlists_submission_tasklet: vecs0 in[0]:  ctx=1.1, seqno=8, prio=0
<0>[  520.564352]   <idle>-0       1..s1 519242232us : execlists_submission_tasklet: vecs0 cs-irq head=1 [1?], tail=3 [3?]
<0>[  520.564458]   <idle>-0       1..s1 519242235us : execlists_submission_tasklet: vecs0 csb[2]: status=0x00000001:0x00000000, active=0x1
<0>[  520.564567]   <idle>-0       1..s1 519242237us : execlists_submission_tasklet: vecs0 csb[3]: status=0x00000018:0x00000001, active=0x5
<0>[  520.564676]   <idle>-0       1..s1 519242240us : execlists_submission_tasklet: vecs0 out[0]: ctx=1.1, seqno=8, prio=0
<0>[  520.564782]   <idle>-0       1..s1 519242244us : execlists_submission_tasklet: vecs0 completed ctx=1
<0>[  520.564885] drv_modu-3978    0..s1 519242295us : execlists_submission_tasklet: bcs0 in[0]:  ctx=1.1, seqno=8, prio=0
<0>[  520.564991]   <idle>-0       1..s1 519242387us : execlists_submission_tasklet: bcs0 cs-irq head=1 [1?], tail=3 [3?]
<0>[  520.565096]   <idle>-0       1..s1 519242390us : execlists_submission_tasklet: bcs0 csb[2]: status=0x00000001:0x00000000, active=0x1
<0>[  520.565205]   <idle>-0       1..s1 519242392us : execlists_submission_tasklet: bcs0 csb[3]: status=0x00000018:0x00000001, active=0x5
<0>[  520.565314]   <idle>-0       1..s1 519242395us : execlists_submission_tasklet: bcs0 out[0]: ctx=1.1, seqno=8, prio=0
<0>[  520.565419]   <idle>-0       1..s1 519242398us : execlists_submission_tasklet: bcs0 completed ctx=1
<0>[  520.565522] drv_modu-3978    0..s1 519242450us : execlists_submission_tasklet: vcs0 in[0]:  ctx=1.1, seqno=9, prio=0
<0>[  520.565628]   <idle>-0       1..s1 519242543us : execlists_submission_tasklet: vcs0 cs-irq head=3 [3?], tail=5 [5?]
<0>[  520.565733]   <idle>-0       1..s1 519242546us : execlists_submission_tasklet: vcs0 csb[4]: status=0x00000001:0x00000000, active=0x1
<0>[  520.565842]   <idle>-0       1..s1 519242548us : execlists_submission_tasklet: vcs0 csb[5]: status=0x00000018:0x00000001, active=0x5
<0>[  520.565951]   <idle>-0       1..s1 519242550us : execlists_submission_tasklet: vcs0 out[0]: ctx=1.1, seqno=9, prio=0
<0>[  520.566056]   <idle>-0       1..s1 519242554us : execlists_submission_tasklet: vcs0 completed ctx=1
<0>[  520.566159] drv_modu-3978    0..s1 519242671us : execlists_submission_tasklet: rcs0 in[0]:  ctx=1.1, seqno=11, prio=0
<0>[  520.566266] drv_modu-3978    0..s1 519243156us : execlists_submission_tasklet: bcs0 in[0]:  ctx=1.1, seqno=9, prio=0
<0>[  520.566372] drv_modu-3978    0..s1 519243309us : execlists_submission_tasklet: vcs0 in[0]:  ctx=1.1, seqno=a, prio=0
<0>[  520.566477]   <idle>-0       1..s1 519244259us : execlists_submission_tasklet: rcs0 cs-irq head=1 [1?], tail=3 [3?]
<0>[  520.566583]   <idle>-0       1..s1 519244264us : execlists_submission_tasklet: rcs0 csb[2]: status=0x00000001:0x00000000, active=0x1
<0>[  520.566692]   <idle>-0       1..s1 519244266us : execlists_submission_tasklet: rcs0 csb[3]: status=0x00000018:0x00000001, active=0x5
<0>[  520.566800]   <idle>-0       1..s1 519244269us : execlists_submission_tasklet: rcs0 out[0]: ctx=1.1, seqno=11, prio=0
<0>[  520.566905]   <idle>-0       1..s1 519244312us : execlists_submission_tasklet: rcs0 completed ctx=1
<0>[  520.567008]   <idle>-0       1..s1 519244876us : execlists_submission_tasklet: rcs0 in[0]:  ctx=1.1, seqno=12, prio=0
<0>[  520.567114]   <idle>-0       1..s1 519245483us : execlists_submission_tasklet: bcs0 cs-irq head=3 [3?], tail=5 [5?]
<0>[  520.567219]   <idle>-0       1..s1 519245486us : execlists_submission_tasklet: bcs0 csb[4]: status=0x00000001:0x00000000, active=0x1
<0>[  520.567328]   <idle>-0       1..s1 519245489us : execlists_submission_tasklet: bcs0 csb[5]: status=0x00000018:0x00000001, active=0x5
<0>[  520.567437]   <idle>-0       1..s1 519245492us : execlists_submission_tasklet: bcs0 out[0]: ctx=1.1, seqno=9, prio=0
<0>[  520.567542]   <idle>-0       1..s1 519245525us : execlists_submission_tasklet: bcs0 completed ctx=1
<0>[  520.567644]   <idle>-0       1..s1 519245555us : execlists_submission_tasklet: vcs0 cs-irq head=5 [5?], tail=1 [1?]
<0>[  520.567750]   <idle>-0       1..s1 519245557us : execlists_submission_tasklet: vcs0 csb[0]: status=0x00000001:0x00000000, active=0x1
<0>[  520.567858]   <idle>-0       1..s1 519245560us : execlists_submission_tasklet: vcs0 csb[1]: status=0x00000018:0x00000001, active=0x5
<0>[  520.567967]   <idle>-0       1..s1 519245562us : execlists_submission_tasklet: vcs0 out[0]: ctx=1.1, seqno=a, prio=0
<0>[  520.568072]   <idle>-0       1..s1 519245590us : execlists_submission_tasklet: vcs0 completed ctx=1
<0>[  520.568174] ksoftirq-17      1..s. 519245722us : execlists_submission_tasklet: rcs0 cs-irq head=3 [3?], tail=5 [5?]
<0>[  520.568280] ksoftirq-17      1..s. 519245724us : execlists_submission_tasklet: rcs0 csb[4]: status=0x00000001:0x00000000, active=0x1
<0>[  520.568388] ksoftirq-17      1..s. 519245726us : execlists_submission_tasklet: rcs0 csb[5]: status=0x00000018:0x00000001, active=0x5
<0>[  520.568496] ksoftirq-17      1..s. 519245727us : execlists_submission_tasklet: rcs0 out[0]: ctx=1.1, seqno=12, prio=0
<0>[  520.568601] ksoftirq-17      1..s. 519245746us : execlists_submission_tasklet: rcs0 completed ctx=1
<0>[  520.568704] ksoftirq-17      1..s. 519246370us : execlists_submission_tasklet: vecs0 in[0]:  ctx=1.1, seqno=9, prio=0
<0>[  520.568809] ksoftirq-17      1..s. 519247245us : execlists_submission_tasklet: bcs0 in[0]:  ctx=1.1, seqno=a, prio=0
<0>[  520.568915] ksoftirq-17      1..s. 519247340us : execlists_submission_tasklet: vecs0 cs-irq head=3 [3?], tail=5 [5?]
<0>[  520.569020] ksoftirq-17      1..s. 519247342us : execlists_submission_tasklet: vecs0 csb[4]: status=0x00000001:0x00000000, active=0x1
<0>[  520.569129] ksoftirq-17      1..s. 519247343us : execlists_submission_tasklet: vecs0 csb[5]: status=0x00000018:0x00000001, active=0x5
<0>[  520.569238] ksoftirq-17      1..s. 519247344us : execlists_submission_tasklet: vecs0 out[0]: ctx=1.1, seqno=9, prio=0
<0>[  520.569343] ksoftirq-17      1..s. 519247346us : execlists_submission_tasklet: vecs0 completed ctx=1
<0>[  520.569445] ksoftirq-17      1..s. 519247386us : execlists_submission_tasklet: rcs0 in[0]:  ctx=1.1, seqno=13, prio=0
<0>[  520.569551] ksoftirq-17      1..s. 519247656us : execlists_submission_tasklet: bcs0 cs-irq head=5 [5?], tail=1 [1?]
<0>[  520.569656] ksoftirq-17      1..s. 519247658us : execlists_submission_tasklet: bcs0 csb[0]: status=0x00000001:0x00000000, active=0x1
<0>[  520.569765] ksoftirq-17      1..s. 519247659us : execlists_submission_tasklet: bcs0 csb[1]: status=0x00000018:0x00000001, active=0x5
<0>[  520.569873] ksoftirq-17      1..s. 519247660us : execlists_submission_tasklet: bcs0 out[0]: ctx=1.1, seqno=a, prio=0
<0>[  520.569978] ksoftirq-17      1..s. 519247662us : execlists_submission_tasklet: bcs0 completed ctx=1
<0>[  520.570080] ksoftirq-17      1..s. 519247668us : execlists_submission_tasklet: rcs0 cs-irq head=5 [5?], tail=1 [1?]
<0>[  520.570186] ksoftirq-17      1..s. 519247669us : execlists_submission_tasklet: rcs0 csb[0]: status=0x00000001:0x00000000, active=0x1
<0>[  520.570294] ksoftirq-17      1..s. 519247670us : execlists_submission_tasklet: rcs0 csb[1]: status=0x00000018:0x00000001, active=0x5
<0>[  520.570402] ksoftirq-17      1..s. 519247671us : execlists_submission_tasklet: rcs0 out[0]: ctx=1.1, seqno=13, prio=0
<0>[  520.570507] ksoftirq-17      1..s. 519247673us : execlists_submission_tasklet: rcs0 completed ctx=1
<0>[  520.570610] ksoftirq-17      1..s. 519247685us : execlists_submission_tasklet: vecs0 in[0]:  ctx=1.1, seqno=a, prio=0
<0>[  520.570715] ksoftirq-17      1..s. 519247816us : execlists_submission_tasklet: vcs0 in[0]:  ctx=1.1, seqno=b, prio=0
<0>[  520.570820] ksoftirq-17      1..s. 519247904us : execlists_submission_tasklet: vecs0 cs-irq head=5 [5?], tail=1 [1?]
<0>[  520.570926] ksoftirq-17      1..s. 519247906us : execlists_submission_tasklet: vecs0 csb[0]: status=0x00000001:0x00000000, active=0x1
<0>[  520.571035] ksoftirq-17      1..s. 519247907us : execlists_submission_tasklet: vecs0 csb[1]: status=0x00000018:0x00000001, active=0x5
<0>[  520.571143] ksoftirq-17      1..s. 519247908us : execlists_submission_tasklet: vecs0 out[0]: ctx=1.1, seqno=a, prio=0
<0>[  520.571248] ksoftirq-17      1..s. 519247910us : execlists_submission_tasklet: vecs0 completed ctx=1
<0>[  520.571351] ksoftirq-17      1..s. 519247923us : execlists_submission_tasklet: rcs0 in[0]:  ctx=1.1, seqno=14, prio=0
<0>[  520.571456] ksoftirq-17      1..s. 519248012us : execlists_submission_tasklet: vcs0 cs-irq head=1 [1?], tail=3 [3?]
<0>[  520.571562] ksoftirq-17      1..s. 519248014us : execlists_submission_tasklet: vcs0 csb[2]: status=0x00000001:0x00000000, active=0x1
<0>[  520.571670] ksoftirq-17      1..s. 519248015us : execlists_submission_tasklet: vcs0 csb[3]: status=0x00000018:0x00000001, active=0x5
<0>[  520.571778] ksoftirq-17      1..s. 519248016us : execlists_submission_tasklet: vcs0 out[0]: ctx=1.1, seqno=b, prio=0
<0>[  520.571883] ksoftirq-17      1..s. 519248018us : execlists_submission_tasklet: vcs0 completed ctx=1
<0>[  520.571985] ksoftirq-17      1..s. 519248024us : execlists_submission_tasklet: rcs0 cs-irq head=1 [1?], tail=3 [3?]
<0>[  520.572091] ksoftirq-17      1..s. 519248025us : execlists_submission_tasklet: rcs0 csb[2]: status=0x00000001:0x00000000, active=0x1
<0>[  520.572199] ksoftirq-17      1..s. 519248027us : execlists_submission_tasklet: rcs0 csb[3]: status=0x00000018:0x00000001, active=0x5
<0>[  520.572308] ksoftirq-17      1..s. 519248028us : execlists_submission_tasklet: rcs0 out[0]: ctx=1.1, seqno=14, prio=0
<0>[  520.572413] ksoftirq-17      1..s. 519248029us : execlists_submission_tasklet: rcs0 completed ctx=1
<0>[  520.572515] ksoftirq-17      1..s. 519248040us : execlists_submission_tasklet: bcs0 in[0]:  ctx=1.1, seqno=b, prio=0
<0>[  520.572621] ksoftirq-17      1..s. 519248584us : execlists_submission_tasklet: vecs0 in[0]:  ctx=1.1, seqno=b, prio=0
<0>[  520.572727] ksoftirq-17      1..s. 519248680us : execlists_submission_tasklet: bcs0 cs-irq head=1 [1?], tail=3 [3?]
<0>[  520.572833] ksoftirq-17      1..s. 519248682us : execlists_submission_tasklet: bcs0 csb[2]: status=0x00000001:0x00000000, active=0x1
<0>[  520.572942] ksoftirq-17      1..s. 519248683us : execlists_submission_tasklet: bcs0 csb[3]: status=0x00000018:0x00000001, active=0x5
<0>[  520.573051] ksoftirq-17      1..s. 519248684us : execlists_submission_tasklet: bcs0 out[0]: ctx=1.1, seqno=b, prio=0
<0>[  520.573157] ksoftirq-17      1..s. 519248686us : execlists_submission_tasklet: bcs0 completed ctx=1
<0>[  520.573259] ksoftirq-17      1..s. 519248693us : execlists_submission_tasklet: vecs0 cs-irq head=1 [1?], tail=3 [3?]
<0>[  520.573366] ksoftirq-17      1..s. 519248694us : execlists_submission_tasklet: vecs0 csb[2]: status=0x00000001:0x00000000, active=0x1
<0>[  520.573475] ksoftirq-17      1..s. 519248695us : execlists_submission_tasklet: vecs0 csb[3]: status=0x00000018:0x00000001, active=0x5
<0>[  520.573584] ksoftirq-17      1..s. 519248697us : execlists_submission_tasklet: vecs0 out[0]: ctx=1.1, seqno=b, prio=0
<0>[  520.573689] ksoftirq-17      1..s. 519248698us : execlists_submission_tasklet: vecs0 completed ctx=1
<0>[  520.573715] ---------------------------------
<4>[  520.573729] Modules linked in: i915(-) vgem snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_codec_generic intel_powerclamp coretemp crct10dif_pclmul crc32_pclmul ghash_clmulni_intel snd_hda_codec snd_hwdep r8169 snd_hda_core mii lpc_ich snd_pcm prime_numbers pinctrl_cherryview [last unloaded: snd_hda_intel]
<4>[  520.573837] CPU: 1 PID: 4037 Comm: systemd-udevd Tainted: G     U           4.16.0-rc5-CI-CI_DRM_3924+ #1
<4>[  520.573863] Hardware name:  /NUC5CPYB, BIOS PYBSWCEL.86A.0058.2016.1102.1842 11/02/2016
<4>[  520.573888] RIP: 0010:string+0x20/0x70
<4>[  520.573901] RSP: 0018:ffffc9000024fc78 EFLAGS: 00010286
<4>[  520.573919] RAX: ffffffffa00b4441 RBX: ffff88016963c66b RCX: ffff0a00ffffff04
<4>[  520.573939] RDX: ffffffffa00b4440 RSI: ffffffffffffffff RDI: ffff88016963c66b
<4>[  520.573959] RBP: ffff88016963ce64 R08: fffffffffffffffe R09: ffff88016963ce64
<4>[  520.573979] R10: ffffc9000024fd40 R11: ffffffff821074c5 R12: 0000000000000800
<4>[  520.573999] R13: ffffc9000024fcd0 R14: ffffffff821074ce R15: ffffffff821074ce
<4>[  520.574020] FS:  00007f33aff8b8c0(0000) GS:ffff88017fd00000(0000) knlGS:0000000000000000
<4>[  520.574043] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
<4>[  520.574060] CR2: ffffffffa00b4440 CR3: 0000000174616000 CR4: 00000000001006e0
<4>[  520.574080] Call Trace:
<4>[  520.574094]  vsnprintf+0x297/0x4a0
<4>[  520.574113]  add_uevent_var+0x6e/0xf0
<4>[  520.574135]  dev_uevent+0x61/0x2b0
<4>[  520.574151]  ? kmem_cache_alloc_trace+0x245/0x2b0
<4>[  520.574169]  uevent_show+0x97/0x100
<4>[  520.574185]  dev_attr_show+0x14/0x40
<4>[  520.574201]  sysfs_kf_seq_show+0xb7/0x110
<4>[  520.574219]  seq_read+0xe8/0x3b0
<4>[  520.574237]  __vfs_read+0x1e/0x120
<4>[  520.574254]  ? SyS_newfstat+0x29/0x40
<4>[  520.574269]  vfs_read+0x9e/0x150
<4>[  520.574284]  SyS_read+0x40/0xa0
<4>[  520.574300]  do_syscall_64+0x65/0x1a0
<4>[  520.574315]  entry_SYSCALL_64_after_hwframe+0x42/0xb7
<4>[  520.574332] RIP: 0033:0x7f33aee12260
<4>[  520.574345] RSP: 002b:00007fff34c45b78 EFLAGS: 00000246 ORIG_RAX: 0000000000000000
<4>[  520.574369] RAX: ffffffffffffffda RBX: 0000555a929b2b40 RCX: 00007f33aee12260
<4>[  520.574389] RDX: 0000000000001000 RSI: 0000555a92983a60 RDI: 0000000000000007
<4>[  520.574409] RBP: 0000000000000000 R08: 00007f33af0dfd18 R09: 0000555a92983a60
<4>[  520.574429] R10: 00007f33aff8b8c0 R11: 0000000000000246 R12: 0000000000001000
<4>[  520.574449] R13: 0000000000001000 R14: 0000555a92983a60 R15: 0000555a92983a60
<4>[  520.574476] Code: 77 ff ff ff 0f 1f 80 00 00 00 00 49 89 f1 48 89 ce 48 c1 fe 30 48 81 fa ff 0f 00 00 4c 8d 46 ff 76 3e 48 85 f6 74 4c 48 8d 42 01 <0f> b6 12 84 d2 74 41 49 01 c0 31 f6 eb 0c 48 83 c0 01 0f b6 50 
<1>[  520.574633] RIP: string+0x20/0x70 RSP: ffffc9000024fc78
<4>[  520.574649] CR2: ffffffffa00b4440
<4>[  520.574664] ---[ end trace 9489b928d1cf4256 ]---
<3>[  520.828845] BUG: sleeping function called from invalid context at ./include/linux/percpu-rwsem.h:34
<3>[  520.828876] in_atomic(): 0, irqs_disabled(): 1, pid: 4037, name: systemd-udevd
<4>[  520.828898] INFO: lockdep is turned off.
<4>[  520.828911] irq event stamp: 4102
<4>[  520.828927] hardirqs last  enabled at (4101): [<0000000055f72741>] restore_regs_and_return_to_kernel+0x0/0x1f
<4>[  520.828955] hardirqs last disabled at (4102): [<0000000023430876>] error_entry+0x78/0xf0
<4>[  520.828980] softirqs last  enabled at (4096): [<0000000043c1a61d>] __do_softirq+0x3a1/0x4aa
<4>[  520.829005] softirqs last disabled at (4089): [<00000000f4da7ba6>] irq_exit+0xa4/0xb0
<4>[  520.829030] CPU: 1 PID: 4037 Comm: systemd-udevd Tainted: G     UD          4.16.0-rc5-CI-CI_DRM_3924+ #1
<4>[  520.829056] Hardware name:  /NUC5CPYB, BIOS PYBSWCEL.86A.0058.2016.1102.1842 11/02/2016
<4>[  520.829078] Call Trace:
<4>[  520.829094]  dump_stack+0x5f/0x86
<4>[  520.829111]  ___might_sleep+0x1d9/0x240
<4>[  520.829130]  exit_signals+0x1b/0x2a0
<4>[  520.829146]  do_exit+0x93/0xcb0
<4>[  520.829160]  ? SyS_read+0x40/0xa0
<4>[  520.829179]  rewind_stack_do_exit+0x17/0x20
<7>[  520.862454] [drm:intel_power_well_enable [i915]] enabling dpio-common-bc
Comment 1 Chris Wilson 2018-05-11 16:42:09 UTC 
Because of the dev link, I wonder if

commit 44a182b9d17765514fa2b1cc911e4e65134eef93
Author: Mathias Nyman <mathias.nyman@linux.intel.com>
Date:   Thu May 3 17:30:07 2018 +0300

    xhci: Fix use-after-free in xhci_free_virt_device
    
    KASAN found a use-after-free in xhci_free_virt_device+0x33b/0x38e
    where xhci_free_virt_device() sets slot id to 0 if udev exists:
    if (dev->udev && dev->udev->slot_id)
            dev->udev->slot_id = 0;
    
    dev->udev will be true even if udev is freed because dev->udev is
    not set to NULL.
    
    set dev->udev pointer to NULL in xhci_free_dev()
    
    The original patch went to stable so this fix needs to be applied
    there as well.
    
    Fixes: a400efe455f7 ("xhci: zero usb device slot_id member when disabling and freeing a xhci slot")
Comment 2 Martin Peres 2018-06-15 08:25:32 UTC 
Last seen: CI_DRM_3924 (3 months / 1212 runs ago)

Chris may be right, so let's close this bug!
Comment 3 Jani Saarinen 2018-06-19 14:25:53 UTC 
Closing, thanks.

Use of freedesktop.org services, including Bugzilla, is subject to our Code of Conduct. How we collect and use information is described in our Privacy Policy.