Bug 108535 - [CI][BAT] igt@* - dmesg-fail / incomplete - GEM_BUG_ON(buf[2 * head + 1] != port->context_id)
Summary: [CI][BAT] igt@* - dmesg-fail / incomplete - GEM_BUG_ON(buf[2 * head + 1] != p...
Status: CLOSED DUPLICATE of bug 108315
Alias: None
Product: DRI
Classification: Unclassified
Component: DRM/Intel (show other bugs)
Version: XOrg git
Hardware: Other All
: highest normal
Assignee: Intel GFX Bugs mailing list
QA Contact: Intel GFX Bugs mailing list
URL:
Whiteboard: ReadyForDev
Keywords:
Depends on:
Blocks:
 
Reported: 2018-10-24 10:22 UTC by Martin Peres
Modified: 2018-10-25 11:20 UTC (History)
1 user (show)

See Also:
i915 platform: ICL
i915 features: GEM/Other


Attachments

Note You need to log in before you can comment on or make changes to this bug.
Description Martin Peres 2018-10-24 10:22:45 UTC
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 ]---
Comment 1 Martin Peres 2018-10-24 10:24:09 UTC
^ 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
Comment 2 Chris Wilson 2018-10-24 11:14:31 UTC
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.
Comment 3 Chris Wilson 2018-10-24 14:15:01 UTC

*** This bug has been marked as a duplicate of bug 108315 ***


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.