https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_7194/shard-glk3/igt@i915_selftest@mock_requests.html <6> [1921.044124] [IGT] i915_selftest: executing <6> [1921.051813] [IGT] i915_selftest: starting subtest mock_requests <5> [1921.162892] Setting dangerous option mock_selftests - tainting kernel <6> [1921.223109] i915: Performing mock selftests with st_random_seed=0xcd0fc2d st_timeout=500 <6> [1921.223114] i915: Running requests <7> [1921.227519] mock: [drm:intel_uc_init_early [i915]] enable_guc=0 (guc:no submission:no huc:no) <7> [1921.231342] [drm:intel_engines_driver_register [i915]] renamed mock to rcs0 <6> [1921.231363] i915: Running i915_request_mock_selftests/igt_add_request <6> [1921.231970] i915: Running i915_request_mock_selftests/igt_wait_request <6> [1921.744648] i915: Running i915_request_mock_selftests/igt_fence_wait <6> [1922.255083] i915: Running i915_request_mock_selftests/igt_request_rewind <6> [1922.259109] i915: Running i915_request_mock_selftests/mock_breadcrumbs_smoketest <6> [1922.852986] Completed 29 waits for 14557 fence across 2 cpus <4> [1922.934719] ------------[ cut here ]------------ <4> [1922.934744] WARNING: CPU: 1 PID: 16 at kernel/workqueue.c:1415 __queue_work+0x547/0x660 <4> [1922.934746] Modules linked in: i915(+) vgem snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_codec_generic mei_hdcp x86_pkg_temp_thermal btusb coretemp btrtl btbcm btintel crct10dif_pclmul crc32_pclmul bluetooth ghash_clmulni_intel ecdh_generic snd_intel_nhlt ecc snd_hda_codec snd_hwdep snd_hda_core snd_pcm r8169 realtek mei_me mei prime_numbers i2c_hid pinctrl_geminilake pinctrl_intel [last unloaded: i915] <4> [1922.934778] CPU: 1 PID: 16 Comm: ksoftirqd/1 Tainted: G U 5.4.0-rc4-CI-CI_DRM_7194+ #1 <4> [1922.934781] Hardware name: Intel Corporation NUC7CJYH/NUC7JYB, BIOS JYGLKCPX.86A.0027.2018.0125.1347 01/25/2018 <4> [1922.934785] RIP: 0010:__queue_work+0x547/0x660 <4> [1922.934789] Code: 00 75 27 65 48 8b 3c 25 00 5f 01 00 f6 47 24 20 74 18 e8 2c 87 00 00 48 85 c0 74 0e 48 8b 40 20 4c 3b 60 08 0f 84 15 fb ff ff <0f> 0b 48 8d 65 d8 5b 41 5c 41 5d 41 5e 41 5f 5d c3 0f 0b e9 34 fc <4> [1922.934792] RSP: 0018:ffffc900000c7da8 EFLAGS: 00010006 <4> [1922.934795] RAX: 0000000080000100 RBX: ffff88823e600808 RCX: 0000000000000000 <4> [1922.934797] RDX: 0000000080000101 RSI: 0000000000000000 RDI: 00000000ffffffff <4> [1922.934800] RBP: ffffc900000c7de0 R08: 0000000000000000 R09: 0000000000000001 <4> [1922.934802] R10: ffffc900000c7da8 R11: 00000000ffd37363 R12: ffff88827051e800 <4> [1922.934804] R13: 0000000000000010 R14: 0000000000000010 R15: ffff88823e600848 <4> [1922.934807] FS: 0000000000000000(0000) GS:ffff888277e80000(0000) knlGS:0000000000000000 <4> [1922.934810] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 <4> [1922.934812] CR2: 00007f79a1395100 CR3: 0000000219464000 CR4: 0000000000340ee0 <4> [1922.934814] Call Trace: <4> [1922.934822] ? delayed_work_timer_fn+0x10/0x10 <4> [1922.934827] ? rcu_core+0x420/0x750 <4> [1922.934831] rcu_work_rcufn+0x1c/0x30 <4> [1922.934835] rcu_core+0x480/0x750 <4> [1922.934847] __do_softirq+0xdf/0x47f <4> [1922.934856] ? smpboot_thread_fn+0x23/0x280 <4> [1922.934859] ? smpboot_thread_fn+0x6b/0x280 <4> [1922.934864] run_ksoftirqd+0x2b/0x50 <4> [1922.934867] smpboot_thread_fn+0x1d3/0x280 <4> [1922.934873] ? sort_range+0x20/0x20 <4> [1922.934877] kthread+0x119/0x130 <4> [1922.934880] ? kthread_park+0x80/0x80 <4> [1922.934887] ret_from_fork+0x24/0x50 <4> [1922.934900] irq event stamp: 10637771 <4> [1922.934904] hardirqs last enabled at (10637770): [<ffffffff819e30ac>] _raw_spin_unlock_irqrestore+0x4c/0x60 <4> [1922.934908] hardirqs last disabled at (10637771): [<ffffffff810d4baa>] rcu_work_rcufn+0xa/0x30 <4> [1922.934911] softirqs last enabled at (10637714): [<ffffffff81c00385>] __do_softirq+0x385/0x47f <4> [1922.934914] softirqs last disabled at (10637719): [<ffffffff810b7d9b>] run_ksoftirqd+0x2b/0x50 <4> [1922.934916] ---[ end trace 63f3542ef3b6ed51 ]--- <6> [1923.025832] [IGT] i915_selftest: exiting, ret=0
The CI Bug Log issue associated to this bug has been updated. ### New filters associated * GLK: igt@i915_selftest@mock_requests - dmesg-warn - WARNING: CPU: 1 PID: 16 at kernel/workqueue.c:1415 __queue_work+0x547/0x660 - https://intel-gfx-ci.01.org/tree/drm-tip/IGTPW_3618/shard-glk9/igt@i915_selftest@mock_requests.html - https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_7194/shard-glk3/igt@i915_selftest@mock_requests.html
Hmm, this is the race between draining the wq on shutdown and something queuing to the wq. Usually a missing sync in the test (i.e. shutting down before finishing all threads).
*** Bug 112247 has been marked as a duplicate of this bug. ***
A CI Bug Log filter associated to this bug has been updated: {- GLK: igt@i915_selftest@mock_requests - dmesg-warn - WARNING: CPU: 1 PID: 16 at kernel/workqueue.c:1415 __queue_work+0x547/0x660 -} {+ GLK: igt@i915_selftest@mock_requests - dmesg-warn - WARNING: CPU: 1 PID: 16 at kernel/workqueue.c:1415 __queue_work+0x547/0x660 +} New failures caught by the filter: * https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_7291/shard-glk1/igt@i915_selftest@mock_requests.html * https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_7306/shard-glk9/igt@i915_selftest@mock_requests.html * https://intel-gfx-ci.01.org/tree/drm-tip/IGT_5271/shard-glk7/igt@i915_selftest@mock_requests.html * https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_7309/shard-glk6/igt@i915_selftest@mock_requests.html
Should be fixed by the intel_gt_wait_for_idle updates I believe.
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.