Bug 103708 - [CI] igt@drv_selftest@mock_objects - dmesg-warn
Summary: [CI] igt@drv_selftest@mock_objects - dmesg-warn
Status: CLOSED FIXED
Alias: None
Product: DRI
Classification: Unclassified
Component: DRM/Intel (show other bugs)
Version: DRI git
Hardware: Other All
: medium normal
Assignee: Intel GFX Bugs mailing list
QA Contact: Intel GFX Bugs mailing list
URL:
Whiteboard: ReadyForDev
Keywords:
Depends on:
Blocks:
 
Reported: 2017-11-13 11:14 UTC by Marta Löfstedt
Modified: 2017-11-14 08:14 UTC (History)
1 user (show)

See Also:
i915 platform: BXT, GLK, HSW, KBL, SNB
i915 features:


Attachments

Description Marta Löfstedt 2017-11-13 11:14:38 UTC
https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_3332/shard-apl6/igt@drv_selftest@mock_objects.html
	

[ 1542.123924] Setting dangerous option mock_selftests - tainting kernel
[ 1542.178012] INFO: trying to register non-static key.
[ 1542.178027] the code is fine but needs lockdep annotation.
[ 1542.178032] turning off the locking correctness validator.
[ 1542.178041] CPU: 3 PID: 6008 Comm: kworker/3:7 Tainted: G     U          4.14.0-rc8-CI-CI_DRM_3332+ #1
[ 1542.178049] Hardware name:                  /NUC6CAYB, BIOS AYAPLCEL.86A.0040.2017.0619.1722 06/19/2017
[ 1542.178144] Workqueue: events __i915_gem_free_work [i915]
[ 1542.178152] Call Trace:
[ 1542.178163]  dump_stack+0x68/0x9f
[ 1542.178170]  register_lock_class+0x3fd/0x580
[ 1542.178177]  ? unwind_next_frame+0x14/0x20
[ 1542.178184]  ? __save_stack_trace+0x73/0xd0
[ 1542.178191]  __lock_acquire+0xa4/0x1b00
[ 1542.178254]  ? __i915_gem_free_work+0x28/0xa0 [i915]
[ 1542.178261]  ? __lock_acquire+0x4ab/0x1b00
[ 1542.178268]  lock_acquire+0xb0/0x200
[ 1542.178273]  ? lock_acquire+0xb0/0x200
[ 1542.178336]  ? __i915_gem_free_work+0x28/0xa0 [i915]
[ 1542.178344]  _raw_spin_lock+0x32/0x50
[ 1542.178405]  ? __i915_gem_free_work+0x28/0xa0 [i915]
[ 1542.178468]  __i915_gem_free_work+0x28/0xa0 [i915]
[ 1542.178476]  process_one_work+0x221/0x650
[ 1542.178483]  worker_thread+0x4e/0x3c0
[ 1542.178489]  kthread+0x114/0x150
[ 1542.178494]  ? process_one_work+0x650/0x650
[ 1542.178499]  ? kthread_create_on_node+0x40/0x40
[ 1542.178506]  ret_from_fork+0x27/0x40
Comment 1 Marta Löfstedt 2017-11-13 11:15:01 UTC
https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_3332/shard-kbl2/igt@drv_selftest@mock_objects.html

[   80.672408] Setting dangerous option mock_selftests - tainting kernel
[   80.698129] INFO: trying to register non-static key.
[   80.698134] the code is fine but needs lockdep annotation.
[   80.698136] turning off the locking correctness validator.
[   80.698139] CPU: 1 PID: 155 Comm: kworker/1:2 Tainted: G     U          4.14.0-rc8-CI-CI_DRM_3332+ #1
[   80.698142] Hardware name:                  /NUC7i5BNB, BIOS BNKBL357.86A.0048.2017.0704.1415 07/04/2017
[   80.698180] Workqueue: events __i915_gem_free_work [i915]
[   80.698183] Call Trace:
[   80.698186]  dump_stack+0x68/0x9f
[   80.698189]  register_lock_class+0x3fd/0x580
[   80.698192]  ? unwind_next_frame+0x14/0x20
[   80.698195]  ? __save_stack_trace+0x73/0xd0
[   80.698198]  __lock_acquire+0xa4/0x1b00
[   80.698225]  ? __i915_gem_free_work+0x28/0xa0 [i915]
[   80.698228]  ? __lock_acquire+0x4ab/0x1b00
[   80.698231]  lock_acquire+0xb0/0x200
[   80.698233]  ? lock_acquire+0xb0/0x200
[   80.698258]  ? __i915_gem_free_work+0x28/0xa0 [i915]
[   80.698261]  _raw_spin_lock+0x32/0x50
[   80.698284]  ? __i915_gem_free_work+0x28/0xa0 [i915]
[   80.698307]  __i915_gem_free_work+0x28/0xa0 [i915]
[   80.698310]  process_one_work+0x221/0x650
[   80.698313]  worker_thread+0x4e/0x3c0
[   80.698316]  kthread+0x114/0x150
[   80.698318]  ? process_one_work+0x650/0x650
[   80.698320]  ? kthread_create_on_node+0x40/0x40
[   80.698323]  ret_from_fork+0x27/0x40
Comment 2 Marta Löfstedt 2017-11-13 11:15:23 UTC
https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_3332/shard-snb2/igt@drv_selftest@mock_objects.html

	

[  937.711992] Setting dangerous option mock_selftests - tainting kernel
[  937.736518] INFO: trying to register non-static key.
[  937.736527] the code is fine but needs lockdep annotation.
[  937.736531] turning off the locking correctness validator.
[  937.736536] CPU: 7 PID: 2646 Comm: kworker/7:0 Tainted: G     U          4.14.0-rc8-CI-CI_DRM_3332+ #1
[  937.736541] Hardware name: Dell Inc. XPS 8300  /0Y2MRG, BIOS A06 10/17/2011
[  937.736592] Workqueue: events __i915_gem_free_work [i915]
[  937.736596] Call Trace:
[  937.736601]  dump_stack+0x68/0x9f
[  937.736605]  register_lock_class+0x3fd/0x580
[  937.736609]  ? unwind_next_frame+0x14/0x20
[  937.736614]  ? __save_stack_trace+0x73/0xd0
[  937.736618]  __lock_acquire+0xa4/0x1b00
[  937.736651]  ? __i915_gem_free_work+0x28/0xa0 [i915]
[  937.736655]  ? __lock_acquire+0x4ab/0x1b00
[  937.736659]  lock_acquire+0xb0/0x200
[  937.736662]  ? lock_acquire+0xb0/0x200
[  937.736692]  ? __i915_gem_free_work+0x28/0xa0 [i915]
[  937.736697]  _raw_spin_lock+0x32/0x50
[  937.736726]  ? __i915_gem_free_work+0x28/0xa0 [i915]
[  937.736754]  __i915_gem_free_work+0x28/0xa0 [i915]
[  937.736759]  process_one_work+0x221/0x650
[  937.736764]  worker_thread+0x4e/0x3c0
[  937.736767]  kthread+0x114/0x150
[  937.736770]  ? process_one_work+0x650/0x650
[  937.736774]  ? kthread_create_on_node+0x40/0x40
[  937.736777]  ret_from_fork+0x27/0x40
[  938.664505] to colour frame buffer device 128x48
Comment 3 Marta Löfstedt 2017-11-13 11:16:10 UTC
https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_3331/shard-glkb2/igt@drv_selftest@mock_objects.html

[ 4085.876707] Setting dangerous option mock_selftests - tainting kernel
[ 4085.906852] INFO: trying to register non-static key.
[ 4085.906861] the code is fine but needs lockdep annotation.
[ 4085.906864] turning off the locking correctness validator.
[ 4085.906870] CPU: 1 PID: 20119 Comm: drv_selftest Tainted: G     U  W       4.14.0-rc8-CI-CI_DRM_3331+ #1
[ 4085.906877] Hardware name: Intel Corp. Geminilake/GLK RVP2 LP4SD (07), BIOS GELKRVPA.X64.0062.B30.1708222146 08/22/2017
[ 4085.906883] Call Trace:
[ 4085.906892]  dump_stack+0x68/0x9f
[ 4085.906898]  register_lock_class+0x3fd/0x580
[ 4085.906904]  ? ___slab_alloc.constprop.29+0x157/0x3d0
[ 4085.906909]  ? ___slab_alloc.constprop.29+0x157/0x3d0
[ 4085.906914]  ? sg_kmalloc+0x1e/0x50
[ 4085.906918]  ? debug_smp_processor_id+0x17/0x20
[ 4085.906923]  __lock_acquire+0xa4/0x1b00
[ 4085.906999]  ? __i915_gem_object_set_pages+0x116/0x1f0 [i915]
[ 4085.907004]  ? __this_cpu_preempt_check+0x13/0x20
[ 4085.907009]  ? sg_kmalloc+0x1e/0x50
[ 4085.907013]  lock_acquire+0xb0/0x200
[ 4085.907017]  ? lock_acquire+0xb0/0x200
[ 4085.907061]  ? __i915_gem_object_set_pages+0x116/0x1f0 [i915]
[ 4085.907067]  _raw_spin_lock+0x32/0x50
[ 4085.907110]  ? __i915_gem_object_set_pages+0x116/0x1f0 [i915]
[ 4085.907153]  __i915_gem_object_set_pages+0x116/0x1f0 [i915]
[ 4085.907195]  i915_gem_object_get_pages_phys+0x286/0x2b0 [i915]
[ 4085.907237]  ____i915_gem_object_get_pages+0x20/0x60 [i915]
[ 4085.907281]  i915_gem_object_attach_phys+0x137/0x1a0 [i915]
[ 4085.907324]  igt_phys_object+0x45/0x120 [i915]
[ 4085.907372]  __i915_subtests+0x40/0xd0 [i915]
[ 4085.907377]  ? work_on_cpu_safe+0x60/0x60
[ 4085.907421]  i915_gem_object_mock_selftests+0x34/0x50 [i915]
[ 4085.907469]  __run_selftests+0x16c/0x1c0 [i915]
[ 4085.907473]  ? 0xffffffffa04e1000
[ 4085.907518]  i915_mock_selftests+0x30/0x60 [i915]
[ 4085.907560]  i915_init+0xc/0x78 [i915]
[ 4085.907563]  ? 0xffffffffa04e1000
[ 4085.907567]  do_one_initcall+0x43/0x170
[ 4085.907573]  ? rcu_read_lock_sched_held+0x7a/0x90
[ 4085.907577]  ? kmem_cache_alloc_trace+0x270/0x2d0
[ 4085.907583]  do_init_module+0x5f/0x206
[ 4085.907587]  load_module+0x2581/0x2dd0
[ 4085.907592]  ? show_coresize+0x30/0x30
[ 4085.907596]  ? kernel_read+0x31/0x50
[ 4085.907601]  SyS_finit_module+0xc1/0x100
[ 4085.907605]  ? SyS_finit_module+0xc1/0x100
[ 4085.907610]  entry_SYSCALL_64_fastpath+0x1c/0xb1
[ 4085.907614] RIP: 0033:0x7fe8d87999f9
[ 4085.907617] RSP: 002b:00007ffd5e281e78 EFLAGS: 00000206 ORIG_RAX: 0000000000000139
[ 4085.907623] RAX: ffffffffffffffda RBX: ffffffff81492083 RCX: 00007fe8d87999f9
[ 4085.907627] RDX: 0000000000000000 RSI: 0000561bb158cc70 RDI: 0000000000000005
[ 4085.907631] RBP: ffffc90000383f88 R08: 0000000000000000 R09: 0000000000000000
[ 4085.907635] R10: 0000000000000005 R11: 0000000000000206 R12: 0000000000000000
[ 4085.907639] R13: 0000561bb1583b20 R14: 0000000000000000 R15: 0000561bb1583a10
[ 4085.907644]  ? __this_cpu_preempt_check+0x13/0x20
Comment 4 Marta Löfstedt 2017-11-13 11:16:32 UTC
https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_3331/shard-hsw3/igt@drv_selftest@mock_objects.html

	

[ 1236.109255] Setting dangerous option mock_selftests - tainting kernel
[ 1236.122193] INFO: trying to register non-static key.
[ 1236.122198] the code is fine but needs lockdep annotation.
[ 1236.122201] turning off the locking correctness validator.
[ 1236.122205] CPU: 0 PID: 14446 Comm: drv_selftest Tainted: G     U  W       4.14.0-rc8-CI-CI_DRM_3331+ #1
[ 1236.122209] Hardware name: MSI MS-7924/Z97M-G43(MS-7924), BIOS V1.12 02/15/2016
[ 1236.122213] Call Trace:
[ 1236.122218]  dump_stack+0x68/0x9f
[ 1236.122222]  register_lock_class+0x3fd/0x580
[ 1236.122226]  ? ___slab_alloc.constprop.29+0x157/0x3d0
[ 1236.122229]  ? ___slab_alloc.constprop.29+0x157/0x3d0
[ 1236.122234]  ? sg_kmalloc+0x1e/0x50
[ 1236.122237]  ? debug_smp_processor_id+0x17/0x20
[ 1236.122241]  __lock_acquire+0xa4/0x1b00
[ 1236.122279]  ? __i915_gem_object_set_pages+0x116/0x1f0 [i915]
[ 1236.122282]  ? __this_cpu_preempt_check+0x13/0x20
[ 1236.122286]  ? sg_kmalloc+0x1e/0x50
[ 1236.122290]  lock_acquire+0xb0/0x200
[ 1236.122293]  ? lock_acquire+0xb0/0x200
[ 1236.122320]  ? __i915_gem_object_set_pages+0x116/0x1f0 [i915]
[ 1236.122325]  _raw_spin_lock+0x32/0x50
[ 1236.122351]  ? __i915_gem_object_set_pages+0x116/0x1f0 [i915]
[ 1236.122377]  __i915_gem_object_set_pages+0x116/0x1f0 [i915]
[ 1236.122403]  i915_gem_object_get_pages_phys+0x286/0x2b0 [i915]
[ 1236.122429]  ____i915_gem_object_get_pages+0x20/0x60 [i915]
[ 1236.122457]  i915_gem_object_attach_phys+0x137/0x1a0 [i915]
[ 1236.122484]  igt_phys_object+0x45/0x120 [i915]
[ 1236.122516]  __i915_subtests+0x40/0xd0 [i915]
[ 1236.122520]  ? work_on_cpu_safe+0x60/0x60
[ 1236.122549]  i915_gem_object_mock_selftests+0x34/0x50 [i915]
[ 1236.122580]  __run_selftests+0x16c/0x1c0 [i915]
[ 1236.122583]  ? 0xffffffffa0501000
[ 1236.122625]  i915_mock_selftests+0x30/0x60 [i915]
[ 1236.122655]  i915_init+0xc/0x78 [i915]
[ 1236.122658]  ? 0xffffffffa0501000
[ 1236.122661]  do_one_initcall+0x43/0x170
[ 1236.122666]  ? rcu_read_lock_sched_held+0x7a/0x90
[ 1236.122669]  ? kmem_cache_alloc_trace+0x270/0x2d0
[ 1236.122674]  do_init_module+0x5f/0x206
[ 1236.122677]  load_module+0x2581/0x2dd0
[ 1236.122680]  ? show_coresize+0x30/0x30
[ 1236.122684]  ? kernel_read+0x31/0x50
[ 1236.122688]  SyS_finit_module+0xc1/0x100
[ 1236.122691]  ? SyS_finit_module+0xc1/0x100
[ 1236.122696]  entry_SYSCALL_64_fastpath+0x1c/0xb1
[ 1236.122700] RIP: 0033:0x7f7e3194b9f9
[ 1236.122702] RSP: 002b:00007ffe64fda0d8 EFLAGS: 00000206 ORIG_RAX: 0000000000000139
[ 1236.122708] RAX: ffffffffffffffda RBX: ffffffff81492083 RCX: 00007f7e3194b9f9
[ 1236.122711] RDX: 0000000000000000 RSI: 0000563ea9384e80 RDI: 0000000000000005
[ 1236.122715] RBP: ffffc90000717f88 R08: 0000000000000000 R09: 0000000000000000
[ 1236.122718] R10: 0000000000000005 R11: 0000000000000206 R12: 0000000000000000
[ 1236.122722] R13: 0000563ea938b0e0 R14: 0000000000000000 R15: 0000563ea9381aa0
[ 1236.122726]  ? __this_cpu_preempt_check+0x13/0x20
[ 1236.377807] to colour frame buffer device 128x48
Comment 5 Chris Wilson 2017-11-13 11:17:31 UTC
commit 9c52d1c816baa5b8c97485b20d95af29c98d26ee
Author: Chris Wilson <chris@chris-wilson.co.uk>
Date:   Fri Nov 10 23:24:47 2017 +0000

    drm/i915/selftests: Yet another forgotten mock_i915->mm initialiser
    
    Move all of the i915->mm initialisation to a private function that can
    be reused by the mock i915 device to save forgetting any more steps.
    
    For example,
    <7>[ 1542.046332] [IGT] drv_selftest: starting subtest mock_objects
    <4>[ 1542.123924] Setting dangerous option mock_selftests - tainting kernel
    <6>[ 1542.167941] i915: Performing mock selftests with st_random_seed=0x246f5ab5 st_timeout=1000
    <4>[ 1542.178012] INFO: trying to register non-static key.
    <4>[ 1542.178027] the code is fine but needs lockdep annotation.
    <4>[ 1542.178032] turning off the locking correctness validator.
    <4>[ 1542.178041] CPU: 3 PID: 6008 Comm: kworker/3:7 Tainted: G     U          4.14.0-rc8-CI-CI_DRM_3332+ #1
    <4>[ 1542.178049] Hardware name:                  /NUC6CAYB, BIOS AYAPLCEL.86A.0040.2017.0619.1722 06/19/2017
    <4>[ 1542.178144] Workqueue: events __i915_gem_free_work [i915]
    <4>[ 1542.178152] Call Trace:
    <4>[ 1542.178163]  dump_stack+0x68/0x9f
    <4>[ 1542.178170]  register_lock_class+0x3fd/0x580
    <4>[ 1542.178177]  ? unwind_next_frame+0x14/0x20
    <4>[ 1542.178184]  ? __save_stack_trace+0x73/0xd0
    <4>[ 1542.178191]  __lock_acquire+0xa4/0x1b00
    <4>[ 1542.178254]  ? __i915_gem_free_work+0x28/0xa0 [i915]
    <4>[ 1542.178261]  ? __lock_acquire+0x4ab/0x1b00
    <4>[ 1542.178268]  lock_acquire+0xb0/0x200
    <4>[ 1542.178273]  ? lock_acquire+0xb0/0x200
    <4>[ 1542.178336]  ? __i915_gem_free_work+0x28/0xa0 [i915]
    <4>[ 1542.178344]  _raw_spin_lock+0x32/0x50
    <4>[ 1542.178405]  ? __i915_gem_free_work+0x28/0xa0 [i915]
    <4>[ 1542.178468]  __i915_gem_free_work+0x28/0xa0 [i915]
    <4>[ 1542.178476]  process_one_work+0x221/0x650
    <4>[ 1542.178483]  worker_thread+0x4e/0x3c0
    <4>[ 1542.178489]  kthread+0x114/0x150
    <4>[ 1542.178494]  ? process_one_work+0x650/0x650
    <4>[ 1542.178499]  ? kthread_create_on_node+0x40/0x40
    <4>[ 1542.178506]  ret_from_fork+0x27/0x40
    
    v2: Fish out i915->mm.object_stat_lock which was being inited over in
    i915_drv.c (Matthew)
    
    Signed-off-by: Chris Wilson <chris@chris-wilson.co.uk>
    Cc: Matthew Auld <matthew.auld@intel.com>
    Link: https://patchwork.freedesktop.org/patch/msgid/20171110232447.21618-1-chris@chris-wilson.co.uk
    Reviewed-by: Matthew Auld <matthew.auld@intel.com>
Comment 6 Marta Löfstedt 2017-11-14 08:14:15 UTC
The issue haven't been seen after CI_DRM_3332


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.