igt@gem_ctx_create@basic-files|igt@prime_mmap_coherency@ioctl-errors - dmesg-fail - ODEBUG: deactivate not available (active state 0) object type: i915_active hint: 0x6b6b6b6b6b6b6b6b, pstore logs are available
Err
Starting subtest: basic-files
Subtest basic-files failed.
No log.
Subtest basic-files: FAIL (2.280s)
Dmesg
<6> [150.208512] Console: switching to colour dummy device 80x25
<6> [150.208677] [IGT] gem_ctx_create: executing
<7> [150.218187] i915 0000:00:02.0: [drm:i915_gem_context_create_ioctl [i915]] HW context 1 created
<6> [150.222156] [IGT] gem_ctx_create: starting subtest basic-files
<4> [152.226724] ------------[ cut here ]------------
<3> [152.226753] ODEBUG: deactivate not available (active state 0) object type: i915_active hint: 0x6b6b6b6b6b6b6b6b
<4> [152.226873] WARNING: CPU: 3 PID: 1185 at lib/debugobjects.c:508 debug_print_object+0x6a/0x80
<4> [152.226881] Modules linked in: snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_codec_generic ledtrig_audio i915 mei_hdcp x86_pkg_temp_thermal coretemp crct10dif_pclmul snd_hda_intel crc32_pclmul snd_intel_dspcfg snd_hda_codec ghash_clmulni_intel snd_hwdep snd_hda_core e1000e cdc_ether usbnet mii snd_pcm ptp pps_core mei_me mei ttm prime_numbers intel_lpss_pci
<4> [152.226921] CPU: 3 PID: 1185 Comm: gem_ctx_create Not tainted 5.13.0-CI-CI_DRM_10294+ #1
<4> [152.226924] Hardware name: Intel Corporation Ice Lake Client Platform/IceLake U DDR4 SODIMM PD RVP TLC, BIOS ICLSFWR1.R00.3234.A01.1906141750 06/14/2019
<4> [152.226926] RIP: 0010:debug_print_object+0x6a/0x80
<4> [152.226928] Code: 8b 43 10 83 c2 01 8b 4b 14 4c 89 e6 89 15 32 7a a0 02 4c 8b 45 00 48 c7 c7 c0 c7 36 82 48 8b 14 c5 40 59 07 82 e8 cc ac 51 00 <0f> 0b 5b 83 05 08 84 30 01 01 5d 41 5c c3 83 05 fd 83 30 01 01 c3
<4> [152.226930] RSP: 0018:ffffc900007d3bb0 EFLAGS: 00010082
<4> [152.226933] RAX: 0000000000000000 RBX: ffffc900007d3bd0 RCX: 0000000000000003
<4> [152.226935] RDX: 0000000080000003 RSI: ffffffff8236743f RDI: 00000000ffffffff
<4> [152.226937] RBP: ffffffffa042f4c0 R08: 0000000000000000 R09: c0000000ffff7fff
<4> [152.226938] R10: 0000000000000001 R11: ffffc900007d39c8 R12: ffffffff8232cda7
<4> [152.226940] R13: ffff888118f1fa70 R14: ffffffff83fe9c80 R15: ffff888130b2bf40
<4> [152.226942] FS: 00007f021c955980(0000) GS:ffff88849fb80000(0000) knlGS:0000000000000000
<4> [152.226944] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
<4> [152.226945] CR2: 00007f021c566038 CR3: 000000010ee0e002 CR4: 0000000000770ee0
<4> [152.226947] PKRU: 55555554
<4> [152.226948] Call Trace:
<4> [152.226952] debug_object_deactivate+0x108/0x180
<4> [152.226960] __active_retire+0x17b/0x1f0 [i915]
<4> [152.227071] dma_fence_signal_timestamp_locked+0x99/0x1a0
<4> [152.227078] dma_fence_signal+0x31/0x70
<4> [152.227083] i915_request_wait+0x5b6/0x610 [i915]
<4> [152.227182] i915_gem_object_wait+0xb7/0x420 [i915]
<4> [152.227272] i915_gem_wait_ioctl+0xf6/0x2b0 [i915]
<4> [152.227355] ? i915_gem_object_wait+0x420/0x420 [i915]
<4> [152.227436] drm_ioctl_kernel+0xa8/0xf0
<4> [152.227443] drm_ioctl+0x1e8/0x390
<4> [152.227447] ? i915_gem_object_wait+0x420/0x420 [i915]
<4> [152.227529] ? do_user_addr_fault+0x1fd/0x660
<4> [152.227541] __x64_sys_ioctl+0x6a/0xa0
<4> [152.227546] do_syscall_64+0x39/0xb0
<4> [152.227551] entry_SYSCALL_64_after_hwframe+0x44/0xae
<4> [152.227554] RIP: 0033:0x7f021bbb15d7
<4> [152.227556] 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> [152.227558] RSP: 002b:00007ffed68ac1e8 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
<4> [152.227561] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007f021bbb15d7
<4> [152.227563] RDX: 00007ffed68ac220 RSI: 00000000c010646c RDI: 0000000000000006
<4> [152.227564] RBP: 00007ffed68ac220 R08: 00007ffed6901080 R09: 0000000000000000
<4> [152.227566] R10: 0000000000000057 R11: 0000000000000246 R12: 00000000c010646c
<4> [152.227567] R13: 0000000000000006 R14: 00007ffed68ac220 R15: 0000560906205200
<4> [152.227578] irq event stamp: 2854788
<4> [152.227580] hardirqs last enabled at (2854787): [<ffffffff8126c311>] __slab_alloc.isra.87.constprop.97+0x91/0xb0
<4> [152.227584] hardirqs last disabled at (2854788): [<ffffffff81ad48d7>] _raw_spin_lock_irqsave+0x47/0x50
<4> [152.227587] softirqs last enabled at (2854652): [<ffffffffa027c1e0>] __intel_engine_flush_submission+0x50/0x80 [i915]
<4> [152.227661] softirqs last disabled at (2854650): [<ffffffffa027c1a2>] __intel_engine_flush_submission+0x12/0x80 [i915]
<4> [152.227728] ---[ end trace 0b6f504410d2cd88 ]---
<4> [152.227736] general protection fault, probably for non-canonical address 0x6b6b6b6b6b6b6b7b: 0000 [#1] PREEMPT SMP NOPTI
<4> [152.227742] CPU: 3 PID: 1185 Comm: gem_ctx_create Tainted: G W 5.13.0-CI-CI_DRM_10294+ #1
<4> [152.227747] Hardware name: Intel Corporation Ice Lake Client Platform/IceLake U DDR4 SODIMM PD RVP TLC, BIOS ICLSFWR1.R00.3234.A01.1906141750 06/14/2019
<4> [152.227752] RIP: 0010:rb_erase+0x0/0x310
<4> [152.227756] Code: c0 49 83 c8 01 4c 89 01 48 89 38 48 89 f8 48 8b 4f 10 e9 60 ff ff ff 48 89 41 10 c3 48 89 d7 48 c7 07 01 00 00 00 c3 c3 66 90 <48> 8b 4f 10 4c 8b 47 08 48 85 c9 0f 84 f1 01 00 00 4d 85 c0 0f 84
<4> [152.227763] RSP: 0018:ffffc900007d3c28 EFLAGS: 00010002
<4> [152.227766] RAX: 0000000000000000 RBX: ffff888118f1fa70 RCX: 0000000000000003
<4> [152.227769] RDX: 0000000080000003 RSI: ffff888118f1fb50 RDI: 6b6b6b6b6b6b6b6b
<4> [152.227772] RBP: ffff888118f1fb08 R08: 0000000000000000 R09: c0000000ffff7fff
<4> [152.227775] R10: 0000000000000001 R11: ffffc900007d39c8 R12: ffff888118f1fb50
<4> [152.227778] R13: 0000000000000246 R14: 0000000000000003 R15: ffff888130b2bf40
<4> [152.227782] FS: 00007f021c955980(0000) GS:ffff88849fb80000(0000) knlGS:0000000000000000
<4> [152.227786] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
<4> [152.227788] CR2: 00007f021c566038 CR3: 000000010ee0e002 CR4: 0000000000770ee0
<4> [152.227792] PKRU: 55555554
<4> [152.227794] Call Trace:
<4> [152.227796] __active_retire+0x90/0x1f0 [i915]
<4> [152.227887] dma_fence_signal_timestamp_locked+0x99/0x1a0
<4> [152.227894] dma_fence_signal+0x31/0x70
<4> [152.227899] i915_request_wait+0x5b6/0x610 [i915]
<4> [152.228031] i915_gem_object_wait+0xb7/0x420 [i915]
<4> [152.228119] i915_gem_wait_ioctl+0xf6/0x2b0 [i915]
<4> [152.228201] ? i915_gem_object_wait+0x420/0x420 [i915]
<4> [152.228283] drm_ioctl_kernel+0xa8/0xf0
<4> [152.228287] drm_ioctl+0x1e8/0x390
<4> [152.228290] ? i915_gem_object_wait+0x420/0x420 [i915]
<4> [152.228374] ? do_user_addr_fault+0x1fd/0x660
<4> [152.228379] __x64_sys_ioctl+0x6a/0xa0
<4> [152.228382] do_syscall_64+0x39/0xb0
<4> [152.228386] entry_SYSCALL_64_after_hwframe+0x44/0xae
<4> [152.228390] RIP: 0033:0x7f021bbb15d7
<4> [152.228392] 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> [152.228399] RSP: 002b:00007ffed68ac1e8 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
<4> [152.228404] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007f021bbb15d7
<4> [152.228407] RDX: 00007ffed68ac220 RSI: 00000000c010646c RDI: 0000000000000006
<4> [152.228411] RBP: 00007ffed68ac220 R08: 00007ffed6901080 R09: 0000000000000000
<4> [152.228414] R10: 0000000000000057 R11: 0000000000000246 R12: 00000000c010646c
<4> [152.228417] R13: 0000000000000006 R14: 00007ffed68ac220 R15: 0000560906205200
<4> [152.228422] Modules linked in: snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_codec_generic ledtrig_audio i915 mei_hdcp x86_pkg_temp_thermal coretemp crct10dif_pclmul snd_hda_intel crc32_pclmul snd_intel_dspcfg snd_hda_codec ghash_clmulni_intel snd_hwdep snd_hda_core e1000e cdc_ether usbnet mii snd_pcm ptp pps_core mei_me mei ttm prime_numbers intel_lpss_pci
<4> [152.228447] ---[ end trace 0b6f504410d2cd89 ]---
<4> [152.496389] RIP: 0010:rb_erase+0x0/0x310
<4> [152.496409] Code: c0 49 83 c8 01 4c 89 01 48 89 38 48 89 f8 48 8b 4f 10 e9 60 ff ff ff 48 89 41 10 c3 48 89 d7 48 c7 07 01 00 00 00 c3 c3 66 90 <48> 8b 4f 10 4c 8b 47 08 48 85 c9 0f 84 f1 01 00 00 4d 85 c0 0f 84
<4> [152.496417] RSP: 0018:ffffc900007d3c28 EFLAGS: 00010002
<4> [152.496421] RAX: 0000000000000000 RBX: ffff888118f1fa70 RCX: 0000000000000003
<4> [152.496425] RDX: 0000000080000003 RSI: ffff888118f1fb50 RDI: 6b6b6b6b6b6b6b6b
<4> [152.496428] RBP: ffff888118f1fb08 R08: 0000000000000000 R09: c0000000ffff7fff
<4> [152.496432] R10: 0000000000000001 R11: ffffc900007d39c8 R12: ffff888118f1fb50
<4> [152.496435] R13: 0000000000000246 R14: 0000000000000003 R15: ffff888130b2bf40
<4> [152.496438] FS: 00007f021c955980(0000) GS:ffff88849fb80000(0000) knlGS:0000000000000000
<4> [152.496443] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
<4> [152.496446] CR2: 00007f021c566038 CR3: 000000010ee0e002 CR4: 0000000000770ee0
<4> [152.496449] PKRU: 55555554
<6> [152.496451] note: gem_ctx_create[1185] exited with preempt_count 2
<3> [152.496455] BUG: sleeping function called from invalid context at include/linux/percpu-rwsem.h:49
<3> [152.496459] in_atomic(): 0, irqs_disabled(): 1, non_block: 0, pid: 1185, name: gem_ctx_create
<4> [152.496463] INFO: lockdep is turned off.
<4> [152.496465] irq event stamp: 2854788
<4> [152.496467] hardirqs last enabled at (2854787): [<ffffffff8126c311>] __slab_alloc.isra.87.constprop.97+0x91/0xb0
<4> [152.496475] hardirqs last disabled at (2854788): [<ffffffff81ad48d7>] _raw_spin_lock_irqsave+0x47/0x50
<4> [152.496481] softirqs last enabled at (2854652): [<ffffffffa027c1e0>] __intel_engine_flush_submission+0x50/0x80 [i915]
<4> [152.496575] softirqs last disabled at (2854650): [<ffffffffa027c1a2>] __intel_engine_flush_submission+0x12/0x80 [i915]Edited by Tejasree Illipilli