https://intel-gfx-ci.01.org/tree/drm-tip/IGTPW_1980/fi-icl-u/igt%40drv_selftest%40live_contexts.html <3> [509.859079] process_csb:953 GEM_BUG_ON(buf[2 * head + 1] != port->context_id) <4> [509.859207] ------------[ cut here ]------------ <2> [509.859209] kernel BUG at drivers/gpu/drm/i915/intel_lrc.c:953! <4> [509.859217] invalid opcode: 0000 [#1] PREEMPT SMP PTI <4> [509.859220] CPU: 2 PID: 4657 Comm: drv_selftest Tainted: G U W 4.19.0-rc8-CI-CI_DRM_5020+ #1 <4> [509.859222] Hardware name: Intel Corporation Ice Lake Client Platform/IceLake U DDR4 SODIMM PD RVP, BIOS ICLSFWR1.R00.2392.A04.1809260455 09/26/2018 <4> [509.859283] RIP: 0010:process_csb+0x5c6/0x790 [i915] <4> [509.859286] Code: 69 87 b9 e0 48 8b 35 99 f9 19 00 49 c7 c0 e0 7b 66 a0 b9 b9 03 00 00 48 c7 c2 10 fc 62 a0 48 c7 c7 e1 18 56 a0 e8 3a 17 c0 e0 <0f> 0b 48 c7 c1 28 9b 64 a0 ba bb 03 00 00 48 c7 c6 10 fc 62 a0 48 <4> [509.859288] RSP: 0018:ffff8804afe83e20 EFLAGS: 00010082 <4> [509.859291] RAX: 000000000000000e RBX: ffff8804aa16c2a8 RCX: 0000000000000000 <4> [509.859293] RDX: 0000000000000001 RSI: 0000000000000004 RDI: ffff8804ae250aa8 <4> [509.859295] RBP: ffff8804afe83e88 R08: 00000000009ccca1 R09: ffff8804ae3f4000 <4> [509.859297] R10: 0000000000000001 R11: ffff8804ae250aa8 R12: ffff8804a122c05c <4> [509.859299] R13: 0000000000000003 R14: ffff880425d896c0 R15: ffff8804a122c040 <4> [509.859301] FS: 00007f53c3ea6980(0000) GS:ffff8804afe80000(0000) knlGS:0000000000000000 <4> [509.859303] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 <4> [509.859305] CR2: 00007f7f12bc0140 CR3: 000000047cc10005 CR4: 0000000000760ee0 <4> [509.859307] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 <4> [509.859309] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 <4> [509.859311] PKRU: 55555554 <4> [509.859312] Call Trace: <4> [509.859315] <IRQ> <4> [509.859360] __execlists_submission_tasklet+0x2c/0xc20 [i915] <4> [509.859397] execlists_submission_tasklet+0x46/0x60 [i915] <4> [509.859403] tasklet_action_common.isra.5+0x47/0xb0 <4> [509.859408] __do_softirq+0xd8/0x483 <4> [509.859412] ? _raw_spin_unlock+0x29/0x40 <4> [509.859415] irq_exit+0xa9/0xc0 <4> [509.859418] do_IRQ+0x9a/0x120 <4> [509.859422] common_interrupt+0xf/0xf <4> [509.859424] </IRQ> <4> [509.859427] RIP: 0010:_raw_spin_unlock_irqrestore+0x4e/0x60 <4> [509.859429] Code: c7 02 75 1f 53 9d e8 d1 28 82 ff bf 01 00 00 00 e8 27 17 77 ff 65 8b 05 e0 3b 6d 7e 85 c0 74 0c 5b 5d c3 e8 c4 26 82 ff 53 9d <eb> df e8 85 06 6c ff 5b 5d c3 0f 1f 84 00 00 00 00 00 53 48 8b 54 <4> [509.859431] RSP: 0018:ffffc90000357868 EFLAGS: 00000282 ORIG_RAX: ffffffffffffffde <4> [509.859434] RAX: ffff8804610f4040 RBX: 0000000000000282 RCX: 0000000000000006 <4> [509.859436] RDX: 000000000000153b RSI: ffffffff8212508a RDI: ffffffff820d3a9f <4> [509.859438] RBP: ffff8804a9d41c40 R08: 00000000efd5b9de R09: 0000000000000000 <4> [509.859440] R10: 0000000000000000 R11: 0000000000000000 R12: ffffea0010976200 <4> [509.859442] R13: 0000000000000001 R14: ffff880425d88000 R15: 0000000000000001 <4> [509.859449] free_debug_processing+0x27d/0x380 <4> [509.859489] ? i915_request_retire_upto+0xfd/0x150 [i915] <4> [509.859493] __slab_free+0x33c/0x4f0 <4> [509.859496] ? _raw_spin_unlock_irqrestore+0x4c/0x60 <4> [509.859500] ? lockdep_hardirqs_on+0xe0/0x1b0 <4> [509.859503] ? _raw_spin_unlock_irqrestore+0x39/0x60 <4> [509.859507] ? debug_check_no_obj_freed+0x132/0x210 <4> [509.859541] ? i915_request_retire_upto+0xfd/0x150 [i915] <4> [509.859544] ? kmem_cache_free+0x279/0x2e0 <4> [509.859547] kmem_cache_free+0x279/0x2e0 <4> [509.859577] i915_request_retire_upto+0xfd/0x150 [i915] <4> [509.859607] i915_request_add+0x3ba/0x7e0 [i915] <4> [509.859650] live_nop_switch+0x229/0x470 [i915] <4> [509.859704] __i915_subtests+0x5e/0xf0 [i915] <4> [509.859751] __run_selftests+0x10b/0x190 [i915] <4> [509.859786] i915_live_selftests+0x2c/0x60 [i915] <4> [509.859823] i915_pci_probe+0x50/0xa0 [i915] <4> [509.859828] pci_device_probe+0xa1/0x130 <4> [509.859833] really_probe+0x25d/0x3c0 <4> [509.859836] driver_probe_device+0x10a/0x120 <4> [509.859840] __driver_attach+0xdb/0x100 <4> [509.859843] ? driver_probe_device+0x120/0x120 <4> [509.859845] bus_for_each_dev+0x74/0xc0 <4> [509.859849] bus_add_driver+0x15f/0x250 <4> [509.859851] ? 0xffffffffa0a0b000 <4> [509.859854] driver_register+0x56/0xe0 <4> [509.859857] ? 0xffffffffa0a0b000 <4> [509.859860] do_one_initcall+0x58/0x2e0 <4> [509.859863] ? rcu_lockdep_current_cpu_online+0x8f/0xd0 <4> [509.859866] ? do_init_module+0x1d/0x1ea <4> [509.859870] ? rcu_read_lock_sched_held+0x6f/0x80 <4> [509.859873] ? kmem_cache_alloc_trace+0x264/0x290 <4> [509.859876] do_init_module+0x56/0x1ea <4> [509.859882] load_module+0x26f5/0x29d0 <4> [509.859887] ? vfs_read+0x122/0x140 <4> [509.859893] ? __se_sys_finit_module+0xd3/0xf0 <4> [509.859896] __se_sys_finit_module+0xd3/0xf0 <4> [509.859902] do_syscall_64+0x55/0x190 <4> [509.859905] entry_SYSCALL_64_after_hwframe+0x49/0xbe <4> [509.859907] RIP: 0033:0x7f53c3770839 <4> [509.859910] Code: 00 f3 c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 40 00 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 1f f6 2c 00 f7 d8 64 89 01 48 <4> [509.859912] RSP: 002b:00007ffd743b33e8 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 <4> [509.859915] RAX: ffffffffffffffda RBX: 000055e0b973eda0 RCX: 00007f53c3770839 <4> [509.859917] RDX: 0000000000000000 RSI: 000055e0b973fb40 RDI: 0000000000000006 <4> [509.859919] RBP: 000055e0b973fb40 R08: 0000000000000004 R09: 0000000000000000 <4> [509.859921] R10: 00007ffd743b3560 R11: 0000000000000246 R12: 0000000000000000 <4> [509.859923] R13: 000055e0b97387e0 R14: 0000000000000020 R15: 000000000000003c <4> [509.859928] Modules linked in: i915(+) amdgpu chash gpu_sched ttm vgem snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_codec_generic ax88179_178a usbnet x86_pkg_temp_thermal mii coretemp crct10dif_pclmul crc32_pclmul ghash_clmulni_intel snd_hda_codec snd_hwdep snd_hda_core e1000e snd_pcm prime_numbers [last unloaded: i915] <0> [509.859952] Dumping ftrace buffer: <0> [509.859954] --------------------------------- [...] <0> [509.882872] --------------------------------- <4> [509.882876] ---[ end trace 96e50b0269c85436 ]---
^ was moved from https://bugs.freedesktop.org/show_bug.cgi?id=106702 And in addition, we have: https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_5023/fi-icl-u/igt@gem_ctx_switch@basic-default.html <6> [43.806521] [IGT] gem_ctx_switch: starting subtest basic-default <3> [44.031558] process_csb:953 GEM_BUG_ON(buf[2 * head + 1] != port->context_id) <4> [44.031691] ------------[ cut here ]------------ <2> [44.031693] kernel BUG at drivers/gpu/drm/i915/intel_lrc.c:953! <4> [44.031716] invalid opcode: 0000 [#1] PREEMPT SMP PTI <4> [44.031724] CPU: 2 PID: 1065 Comm: gem_ctx_switch Tainted: G U W 4.19.0-rc8-CI-CI_DRM_5023+ #1 <4> [44.031734] Hardware name: Intel Corporation Ice Lake Client Platform/IceLake U DDR4 SODIMM PD RVP, BIOS ICLSFWR1.R00.2392.A04.1809260455 09/26/2018 <4> [44.031788] RIP: 0010:process_csb+0x5c6/0x790 [i915] <4> [44.031795] Code: 69 87 ee e0 48 8b 35 a1 f9 19 00 49 c7 c0 10 7c 31 a0 b9 b9 03 00 00 48 c7 c2 10 fc 2d a0 48 c7 c7 e1 18 21 a0 e8 3a 17 f5 e0 <0f> 0b 48 c7 c1 68 9b 2f a0 ba bb 03 00 00 48 c7 c6 10 fc 2d a0 48 <4> [44.031816] RSP: 0018:ffff8804afe83e20 EFLAGS: 00010082 <4> [44.031826] RAX: 000000000000000e RBX: ffff8804a44c0008 RCX: 0000000000000000 <4> [44.031834] RDX: 0000000000000001 RSI: 0000000000000004 RDI: ffff8804ae250aa8 <4> [44.031842] RBP: ffff8804afe83e88 R08: 0000000000056df9 R09: ffff8804ae3f4000 <4> [44.031850] R10: 0000000000000001 R11: ffff8804ae250aa8 R12: ffff8804995b4054 <4> [44.031857] R13: 0000000000000002 R14: ffff8804512496c0 R15: ffff8804995b4040 <4> [44.031865] FS: 00007f67fd3cb980(0000) GS:ffff8804afe80000(0000) knlGS:0000000000000000 <4> [44.031874] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 <4> [44.031883] CR2: 00007ffc6e4a2910 CR3: 0000000445b52005 CR4: 0000000000760ee0 <4> [44.031892] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 <4> [44.031900] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 <4> [44.031908] PKRU: 55555554 <4> [44.031912] Call Trace: <4> [44.031923] <IRQ> <4> [44.031961] __execlists_submission_tasklet+0x2c/0xc20 [i915] <4> [44.031997] execlists_submission_tasklet+0x46/0x60 [i915] <4> [44.032007] tasklet_action_common.isra.5+0x47/0xb0 <4> [44.032016] __do_softirq+0xd8/0x483 <4> [44.032023] ? _raw_spin_unlock+0x29/0x40 <4> [44.032029] irq_exit+0xa9/0xc0 <4> [44.032035] do_IRQ+0x9a/0x120 <4> [44.032041] common_interrupt+0xf/0xf <4> [44.032046] </IRQ> <4> [44.032053] RIP: 0010:__list_del_entry_valid+0x28/0x90 <4> [44.032059] Code: 40 00 48 8b 07 48 b9 00 01 00 00 00 00 ad de 48 8b 57 08 48 39 c8 74 26 48 b9 00 02 00 00 00 00 ad de 48 39 ca 74 2e 48 8b 32 <48> 39 fe 75 3a 48 8b 50 08 48 39 f2 75 48 b8 01 00 00 00 c3 48 89 <4> [44.032077] RSP: 0018:ffffc900003afa18 EFLAGS: 00000202 ORIG_RAX: ffffffffffffffdc <4> [44.032086] RAX: ffff88044fcd6098 RBX: ffff88044fcd60d0 RCX: dead000000000200 <4> [44.032094] RDX: ffff88044fcd6098 RSI: ffff88044fcd60d8 RDI: ffff88044fcd60d8 <4> [44.032101] RBP: ffff88042be0bca8 R08: 00000000c74ca243 R09: 0000000000000000 <4> [44.032109] R10: ffffc900003af9a0 R11: ffffffffa039e318 R12: ffff88042be0bc98 <4> [44.032116] R13: ffff88042be0bc90 R14: dead000000000100 R15: ffff88049fac0000 <4> [44.032155] i915_sched_node_fini+0x1db/0x350 [i915] <4> [44.032188] i915_request_retire+0x47e/0x930 [i915] <4> [44.032221] i915_request_alloc+0xea/0x800 [i915] <4> [44.032251] i915_gem_do_execbuffer+0x6f4/0x1590 [i915] <4> [44.032260] ? deactivate_slab.isra.26+0x7a4/0x7e0 <4> [44.032270] ? ___slab_alloc.constprop.34+0x221/0x390 <4> [44.032277] ? ___slab_alloc.constprop.34+0x221/0x390 <4> [44.032307] ? i915_gem_execbuffer2_ioctl+0xc4/0x3f0 [i915] <4> [44.032316] ? lock_acquire+0xa6/0x1c0 <4> [44.032345] ? i915_gem_execbuffer_ioctl+0x300/0x300 [i915] <4> [44.032373] i915_gem_execbuffer2_ioctl+0x21b/0x3f0 [i915] <4> [44.032401] ? i915_gem_execbuffer_ioctl+0x300/0x300 [i915] <4> [44.032411] drm_ioctl_kernel+0x81/0xf0 <4> [44.032418] drm_ioctl+0x2e6/0x3a0 <4> [44.032444] ? i915_gem_execbuffer_ioctl+0x300/0x300 [i915] <4> [44.032453] ? trace_hardirqs_on_thunk+0x1a/0x1c <4> [44.032460] ? lockdep_hardirqs_on+0xe0/0x1b0 <4> [44.032466] ? trace_hardirqs_on_thunk+0x1a/0x1c <4> [44.032474] do_vfs_ioctl+0xa0/0x6d0 <4> [44.032480] ? retint_kernel+0x2d/0x2d <4> [44.032487] ksys_ioctl+0x35/0x60 <4> [44.032493] __x64_sys_ioctl+0x11/0x20 <4> [44.032499] do_syscall_64+0x55/0x190 <4> [44.032505] entry_SYSCALL_64_after_hwframe+0x49/0xbe <4> [44.032511] RIP: 0033:0x7f67fc8695d7 <4> [44.032517] Code: b3 66 90 48 8b 05 b1 48 2d 00 64 c7 00 26 00 00 00 48 c7 c0 ff ff ff ff c3 66 2e 0f 1f 84 00 00 00 00 00 b8 10 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 81 48 2d 00 f7 d8 64 89 01 48 <4> [44.032534] RSP: 002b:00007ffc6e419e68 EFLAGS: 00000246 ORIG_RAX: 0000000000000010 <4> [44.032544] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007f67fc8695d7 <4> [44.032551] RDX: 00007ffc6e419fd0 RSI: 0000000040406469 RDI: 0000000000000005 <4> [44.032559] RBP: 00007ffc6e419fd0 R08: 00014b3e3aa912c0 R09: 00007ffc6e49f080 <4> [44.032566] R10: 000000000000e766 R11: 0000000000000246 R12: 0000000040406469 <4> [44.032574] R13: 0000000000000005 R14: 0000000000000000 R15: 0000000000000000 <4> [44.032584] Modules linked in: snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_codec_generic i915 ax88179_178a usbnet snd_hda_intel x86_pkg_temp_thermal mii coretemp crct10dif_pclmul snd_hda_codec crc32_pclmul snd_hwdep ghash_clmulni_intel snd_hda_core snd_pcm e1000e prime_numbers
If you look at an example like: <0>[ 44.057849] gem_ctx_-1065 2.... 44089852us : i915_request_add: rcs0 fence 20ff:80 <0>[ 44.057881] gem_ctx_-1065 2..s1 44089865us : execlists_submission_tasklet: rcs0 awake?=1, active=5 <0>[ 44.057915] gem_ctx_-1065 2d.s2 44089866us : process_csb: rcs0 cs-irq head=1, tail=2 <0>[ 44.057948] gem_ctx_-1065 2d.s2 44089866us : process_csb: rcs0 csb[2]: status=0x10000014:0x000002a0, active=0x5 <0>[ 44.057982] gem_ctx_-1065 2d.s2 44089867us : process_csb: rcs0 out[0]: ctx=672.1, global=3670 (fence 20e1:58) (current 3670), prio=0 <0>[ 44.058017] gem_ctx_-1065 2d.s2 44089867us : process_csb: rcs0 completed ctx=672 <0>[ 44.058051] gem_ctx_-1065 2d.s2 44089868us : __i915_request_submit: rcs0 fence 20e3:58 -> global=3672, current 3670 <0>[ 44.058086] gem_ctx_-1065 2d.s2 44089870us : __execlists_submission_tasklet: rcs0 in[1]: ctx=736.1, global=3672 (fence 20e3:58) (current 3671), prio=0 <0>[ 44.058123] gem_ctx_-1065 2d.s2 44089871us : __execlists_submission_tasklet: rcs0 in[0]: ctx=704.2, global=3671 (fence 20e2:58) (current 3671), prio=0 <0>[ 44.058159] gem_ctx_-1065 2..s1 44089886us : execlists_submission_tasklet: rcs0 awake?=1, active=1 <0>[ 44.058192] gem_ctx_-1065 2d.s2 44089887us : process_csb: rcs0 cs-irq head=2, tail=4 <0>[ 44.058224] gem_ctx_-1065 2d.s2 44089888us : process_csb: rcs0 csb[3]: status=0x10000018:0x000002c0, active=0x1 <0>[ 44.058258] gem_ctx_-1065 2d.s2 44089889us : process_csb: rcs0 out[0]: ctx=704.2, global=3671 (fence 20e2:58) (current 3671), prio=0 <0>[ 44.058292] gem_ctx_-1065 2d.s2 44089890us : process_csb: rcs0 csb[4]: status=0x10000001:0x00000000, active=0x1 <0>[ 44.058328] gem_ctx_-1065 2.... 44089895us : i915_request_retire: rcs0 fence 2100:57, global=3637, current 3670 <0>[ 44.058363] gem_ctx_-1065 2.... 44089896us : i915_request_retire: __retire_engine_request(rcs0) fence 2100:57, global=3637, current 3671 <0>[ 44.058398] gem_ctx_-1065 2..s. 44089901us : execlists_submission_tasklet: rcs0 awake?=1, active=5 <0>[ 44.058430] gem_ctx_-1065 2d.s1 44089902us : process_csb: rcs0 cs-irq head=4, tail=4 <0>[ 44.058462] gem_ctx_-1065 2.... 44089915us : i915_request_add: rcs0 fence 2100:80 <0>[ 44.058494] gem_ctx_-1065 2.... 44089930us : i915_request_retire: rcs0 fence 2101:57, global=3638, current 3671 <0>[ 44.058528] gem_ctx_-1065 2.... 44089931us : i915_request_retire: __retire_engine_request(rcs0) fence 2101:57, global=3638, current 3671 <0>[ 44.058563] gem_ctx_-1065 2.... 44089941us : i915_request_add: rcs0 fence 2101:80 <0>[ 44.058595] gem_ctx_-1065 2..s1 44089948us : execlists_submission_tasklet: rcs0 awake?=1, active=5 <0>[ 44.058627] gem_ctx_-1065 2d.s2 44089949us : process_csb: rcs0 cs-irq head=4, tail=5 <0>[ 44.058659] gem_ctx_-1065 2d.s2 44089949us : process_csb: rcs0 csb[5]: status=0x10000014:0x000002c0, active=0x5 <0>[ 44.058692] gem_ctx_-1065 2d.s2 44089950us : process_csb: rcs0 out[0]: ctx=704.1, global=3671 (fence 20e2:58) (current 3672), prio=0 <0>[ 44.058727] gem_ctx_-1065 2d.s2 44089950us : process_csb: rcs0 completed ctx=704 <0>[ 44.058759] gem_ctx_-1065 2d.s2 44089951us : __i915_request_submit: rcs0 fence 20e4:58 -> global=3673, current 3672 <0>[ 44.058793] gem_ctx_-1065 2d.s2 44089953us : __execlists_submission_tasklet: rcs0 in[1]: ctx=768.1, global=3673 (fence 20e4:58) (current 3672), prio=0 <0>[ 44.058830] gem_ctx_-1065 2d.s2 44089954us : __execlists_submission_tasklet: rcs0 in[0]: ctx=736.2, global=3672 (fence 20e3:58) (current 3672), prio=0 <0>[ 44.058865] gem_ctx_-1065 2..s1 44089961us : execlists_submission_tasklet: rcs0 awake?=1, active=1 <0>[ 44.058897] gem_ctx_-1065 2d.s2 44089962us : process_csb: rcs0 cs-irq head=5, tail=1 <0>[ 44.058928] gem_ctx_-1065 2d.s2 44089963us : process_csb: rcs0 csb[0]: status=0x10000018:0x000002e0, active=0x1 <0>[ 44.058962] gem_ctx_-1065 2d.s2 44089963us : process_csb: rcs0 out[0]: ctx=736.2, global=3672 (fence 20e3:58) (current 3672), prio=0 <0>[ 44.058996] gem_ctx_-1065 2d.s2 44089964us : process_csb: rcs0 csb[1]: status=0x10000001:0x00000000, active=0x1 <0>[ 44.059031] gem_ctx_-1065 2.... 44089972us : i915_request_retire: rcs0 fence 2102:57, global=3639, current 3672 <0>[ 44.059065] gem_ctx_-1065 2.... 44089973us : i915_request_retire: __retire_engine_request(rcs0) fence 2102:57, global=3639, current 3672 <0>[ 44.059100] gem_ctx_-1065 2..s1 44089980us : execlists_submission_tasklet: rcs0 awake?=1, active=5 <0>[ 44.059133] gem_ctx_-1065 2d.s2 44089983us : process_csb: rcs0 cs-irq head=1, tail=2 <0>[ 44.059164] gem_ctx_-1065 2d.s2 44089983us : process_csb: rcs0 csb[2]: status=0x10000014:0x000002a0, active=0x5 <0>[ 44.059197] gem_ctx_-1065 2d.s2 44089984us : process_csb: rcs0 out[0]: ctx=736.1, global=3672 (fence 20e3:58) (current 3672), prio=0 <0>[ 44.059232] gem_ctx_-1065 2d.s2 44090144us : process_csb: process_csb:953 GEM_BUG_ON(buf[2 * head + 1] != port->context_id) Quite clearly we did not receive a CS event for the last submission.
*** This bug has been marked as a duplicate of bug 108315 ***
The CI Bug Log issue associated to this bug has been archived. New failures matching the above filters will not be associated to this bug anymore.
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.