[27.409428] Initializing watchdogs [27.409494] /dev/watchdog0 [27.414471] [001/142] (960s left) gem_softpin (evict-snoop) [27.473905] Starting subtest: evict-snoop [27.475425] Subtest evict-snoop: SKIP (0.000s) [27.513378] [002/142] (960s left) kms_cursor_legacy (single-bo) [27.617423] Starting subtest: single-bo [27.618225] Starting dynamic subtest: pipe-A [33.032388] Dynamic subtest pipe-A: SUCCESS (5.380s) [33.035500] Starting dynamic subtest: pipe-B [38.385322] Dynamic subtest pipe-B: SUCCESS (5.378s) [38.388484] Starting dynamic subtest: pipe-C [43.788290] Dynamic subtest pipe-C: SUCCESS (5.378s) [43.791492] Starting dynamic subtest: pipe-D [49.140728] Dynamic subtest pipe-D: SUCCESS (5.378s) [49.143845] Starting dynamic subtest: all-pipes [54.519164] Dynamic subtest all-pipes: SUCCESS (5.378s) [54.519953] Subtest single-bo: SUCCESS (26.893s) [54.540560] [003/142] (933s left) kms_color (legacy-gamma) [54.637914] Starting subtest: legacy-gamma [54.638796] Starting dynamic subtest: pipe-A [54.936152] Dynamic subtest pipe-A: SUCCESS (0.299s) [54.940491] Starting dynamic subtest: pipe-B [55.220107] Dynamic subtest pipe-B: SUCCESS (0.284s) [55.224352] Starting dynamic subtest: pipe-C [55.497465] Dynamic subtest pipe-C: SUCCESS (0.277s) [55.501437] Starting dynamic subtest: pipe-D [55.778450] Dynamic subtest pipe-D: SUCCESS (0.281s) [55.779184] Subtest legacy-gamma: SUCCESS (1.141s) [55.880393] [004/142] (932s left) kms_chamelium_hpd (dp-hpd-storm-disable) [56.026306] Subtest dp-hpd-storm-disable: SKIP (0.000s) [56.081935] [005/142] (931s left) perf_pmu (busy) [56.133213] Starting subtest: busy [56.134034] Starting dynamic subtest: rcs0 [56.667682] Dynamic subtest rcs0: SUCCESS (0.533s) [56.674217] Starting dynamic subtest: bcs0 [57.198576] Dynamic subtest bcs0: SUCCESS (0.532s) [57.205311] Starting dynamic subtest: vcs0 [57.739416] Dynamic subtest vcs0: SUCCESS (0.541s) [57.746512] Starting dynamic subtest: vcs1 [58.275626] Dynamic subtest vcs1: SUCCESS (0.536s) [58.282353] Starting dynamic subtest: vecs0 [58.814228] Dynamic subtest vecs0: SUCCESS (0.538s) [58.815464] Subtest busy: SUCCESS (2.680s) [58.862409] [006/142] (929s left) kms_rotation_crc (primary-rotation-180) [58.964032] Starting subtest: primary-rotation-180 [62.486492] Subtest primary-rotation-180: SUCCESS (3.522s) [62.638175] [007/142] (925s left) kms_setmode (basic) [62.686426] Starting subtest: basic [62.814554] Starting dynamic subtest: pipe-A-HDMI-A-1 [63.883562] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.060s) [63.957555] Starting dynamic subtest: pipe-B-HDMI-A-1 [65.026164] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.062s) [65.066787] Subtest basic: SUCCESS (2.380s) [65.163882] [008/142] (922s left) sw_sync (timeline_closed) [65.211073] Starting subtest: timeline_closed [65.211942] Subtest timeline_closed: SUCCESS (0.000s) [65.238535] [009/142] (922s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_mc_ccs) [65.504513] Starting subtest: pipe-C-bad-rotation-90-y_tiled_gen12_mc_ccs [65.506486] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_mc_ccs: SKIP (0.000s) [65.695554] [010/142] (922s left) kms_ccs (pipe-b-bad-aux-stride-y_tiled_ccs) [65.930790] Starting subtest: pipe-B-bad-aux-stride-y_tiled_ccs [65.932245] Subtest pipe-B-bad-aux-stride-y_tiled_ccs: SKIP (0.000s) [66.140968] [011/142] (921s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite) [66.241908] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite [66.243354] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [66.292787] [012/142] (921s left) kms_psr2_su (page_flip-xrgb8888) [66.344237] Subtest page_flip-XRGB8888: SKIP (0.000s) [66.359735] [013/142] (921s left) gem_workarounds (reset-context) [66.418064] Starting subtest: reset-context [66.426495] Subtest reset-context: SUCCESS (0.008s) [66.492284] [014/142] (921s left) gem_softpin (evict-single-offset) [66.542986] Starting subtest: evict-single-offset [91.538861] Subtest evict-single-offset: SUCCESS (24.995s) [91.579454] [015/142] (896s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled) [91.671146] Starting subtest: multi-wait-for-submit-submitted-signaled [91.672082] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s) [91.712933] [016/142] (896s left) gem_exec_whisper (basic-fds-priority) [91.771554] Starting subtest: basic-fds-priority [97.734218] Subtest basic-fds-priority: SUCCESS (5.953s) [97.881385] [017/142] (890s left) kms_frontbuffer_tracking (fbc-stridechange) [97.994951] Starting subtest: fbc-stridechange [98.900509] Subtest fbc-stridechange: SUCCESS (0.907s) [98.993248] [018/142] (889s left) gem_ctx_persistence (legacy-engines-queued) [99.047153] Starting subtest: legacy-engines-queued [99.047884] Starting dynamic subtest: render [99.091831] Dynamic subtest render: SUCCESS (0.044s) [99.099991] Starting dynamic subtest: bsd1 [99.127693] Dynamic subtest bsd1: SUCCESS (0.035s) [99.139255] Starting dynamic subtest: bsd2 [99.171547] Dynamic subtest bsd2: SUCCESS (0.043s) [99.183692] Starting dynamic subtest: blt [99.213755] Dynamic subtest blt: SUCCESS (0.042s) [99.225884] Starting dynamic subtest: vebox [99.253598] Dynamic subtest vebox: SUCCESS (0.039s) [99.254979] Subtest legacy-engines-queued: SUCCESS (0.206s) [99.304663] [019/142] (888s left) gen7_exec_parse (load-register-reg) [99.366245] Subtest load-register-reg: SKIP (0.000s) [99.388913] [020/142] (888s left) kms_vblank (pipe-a-wait-forked) [99.490187] Starting subtest: pipe-A-wait-forked [100.681857] Subtest pipe-A-wait-forked: SUCCESS (1.193s) [100.792286] [021/142] (887s left) gem_ctx_isolation (nonpriv) [100.845386] Starting subtest: nonpriv [100.846190] Starting dynamic subtest: rcs0 [101.011911] Dynamic subtest rcs0: SUCCESS (0.158s) [101.016112] Starting dynamic subtest: bcs0 [101.206417] Dynamic subtest bcs0: SUCCESS (0.194s) [101.210732] Starting dynamic subtest: vcs0 [101.382630] Dynamic subtest vcs0: SUCCESS (0.176s) [101.386962] Starting dynamic subtest: vcs1 [101.563871] Dynamic subtest vcs1: SUCCESS (0.181s) [101.568387] Starting dynamic subtest: vecs0 [101.746203] Dynamic subtest vecs0: SUCCESS (0.182s) [101.746995] Subtest nonpriv: SUCCESS (0.892s) [101.893637] [022/142] (886s left) kms_pipe_crc_basic (disable-crc-after-crtc) [101.994159] Starting subtest: disable-crc-after-crtc [101.994983] Starting dynamic subtest: pipe-A-HDMI-A-1 [102.310827] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.316s) [102.316572] Starting dynamic subtest: pipe-B-HDMI-A-1 [102.590627] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.278s) [102.597312] Starting dynamic subtest: pipe-C-HDMI-A-1 [102.876420] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.284s) [102.881783] Starting dynamic subtest: pipe-D-HDMI-A-1 [103.148424] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.271s) [103.149180] Subtest disable-crc-after-crtc: SUCCESS (1.154s) [103.235280] [023/142] (884s left) debugfs_test (basic-hwmon) [103.289090] Starting subtest: basic-hwmon [103.290594] Subtest basic-hwmon: SKIP (0.000s) [103.375882] [024/142] (884s left) i915_module_load (reload-no-display) [103.426057] Starting subtest: reload-no-display [105.431296] Subtest reload-no-display: SUCCESS (1.997s) [105.455114] [025/142] (882s left) kms_plane_scaling (intel-max-src-size) [106.425800] Starting subtest: intel-max-src-size [106.427250] Subtest intel-max-src-size: SKIP (0.000s) [106.498492] [026/142] (881s left) feature_discovery (display-3x) [106.595806] Starting subtest: display-3x [106.597355] Subtest display-3x: SKIP (0.000s) [106.635950] [027/142] (881s left) kms_sequence (queue-busy) [106.735227] Starting subtest: queue-busy [106.736014] Starting dynamic subtest: HDMI-A-1-pipe-A [108.010849] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (1.274s) [108.015020] Starting dynamic subtest: HDMI-A-1-pipe-B [109.263790] Dynamic subtest HDMI-A-1-pipe-B: SUCCESS (1.252s) [109.268086] Starting dynamic subtest: HDMI-A-1-pipe-C [110.521979] Dynamic subtest HDMI-A-1-pipe-C: SUCCESS (1.257s) [110.526542] Starting dynamic subtest: HDMI-A-1-pipe-D [112.607778] Dynamic subtest HDMI-A-1-pipe-D: SUCCESS (2.085s) [112.608569] Subtest queue-busy: SUCCESS (5.873s) [112.680285] [028/142] (875s left) syncobj_timeline (wait-all-for-submit-complex) [112.728649] Starting subtest: wait-all-for-submit-complex [112.950132] Subtest wait-all-for-submit-complex: SUCCESS (0.213s) [112.988426] [029/142] (875s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_mtl_rc_ccs) [113.218136] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs [113.219511] Subtest pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SKIP (0.000s) [113.458098] [030/142] (874s left) gem_set_tiling_vs_blt (untiled-to-tiled) [113.510835] Starting subtest: untiled-to-tiled [113.646670] Subtest untiled-to-tiled: SUCCESS (0.127s) [113.707611] [031/142] (874s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic) [113.813378] Starting subtest: 2x-flip-vs-cursor-atomic [113.816207] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.003s) [113.849948] [032/142] (874s left) perf_pmu (semaphore-busy) [113.899634] Starting subtest: semaphore-busy [113.900398] Starting dynamic subtest: rcs0 [115.452089] Dynamic subtest rcs0: SUCCESS (1.542s) [115.459785] Starting dynamic subtest: bcs0 [116.995395] Dynamic subtest bcs0: SUCCESS (1.542s) [117.003117] Starting dynamic subtest: vcs0 [118.546512] Dynamic subtest vcs0: SUCCESS (1.550s) [118.554688] Starting dynamic subtest: vcs1 [120.084409] Dynamic subtest vcs1: SUCCESS (1.537s) [120.092215] Starting dynamic subtest: vecs0 [121.624424] Dynamic subtest vecs0: SUCCESS (1.539s) [121.625618] Subtest semaphore-busy: SUCCESS (7.715s) [121.684394] [033/142] (866s left) syncobj_timeline (invalid-signal-illegal-point) [121.735687] Starting subtest: invalid-signal-illegal-point [121.736523] Subtest invalid-signal-illegal-point: SUCCESS (0.000s) [121.776607] [034/142] (866s left) kms_atomic (plane-primary-overlay-mutable-zpos) [121.982870] Starting subtest: plane-primary-overlay-mutable-zpos [121.985354] Subtest plane-primary-overlay-mutable-zpos: SKIP (0.001s) [122.124227] [035/142] (866s left) gem_madvise (dontneed-before-mmap) [122.171467] Starting subtest: dontneed-before-mmap [122.175030] Subtest dontneed-before-mmap: SUCCESS (0.004s) [122.231526] [036/142] (866s left) kms_pipe_crc_basic (read-crc-frame-sequence) [122.326749] Starting subtest: read-crc-frame-sequence [122.327476] Starting dynamic subtest: pipe-A-HDMI-A-1 [122.608668] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.281s) [122.614015] Starting dynamic subtest: pipe-B-HDMI-A-1 [123.162161] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.552s) [123.167425] Starting dynamic subtest: pipe-C-HDMI-A-1 [123.971440] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.807s) [123.977166] Starting dynamic subtest: pipe-D-HDMI-A-1 [124.958365] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.985s) [124.959131] Subtest read-crc-frame-sequence: SUCCESS (2.632s) [125.031803] [037/142] (863s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-render) [125.133032] Starting subtest: psr-1p-offscren-pri-indfb-draw-render [125.134485] Subtest psr-1p-offscren-pri-indfb-draw-render: SKIP (0.000s) [125.192031] [038/142] (863s left) api_intel_bb (full-batch) [125.242604] Starting subtest: full-batch [125.244587] Subtest full-batch: SUCCESS (0.003s) [125.315202] [039/142] (863s left) gem_exec_balancer (invalid-balancer) [125.369572] Starting subtest: invalid-balancer [126.265124] Subtest invalid-balancer: SUCCESS (0.881s) [126.474220] [040/142] (861s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset) [126.557129] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset [126.557847] Starting dynamic subtest: A-HDMI-A1 [127.256476] Dynamic subtest A-HDMI-A1: SUCCESS (0.700s) [127.260922] Starting dynamic subtest: B-HDMI-A1 [127.860419] Dynamic subtest B-HDMI-A1: SUCCESS (0.602s) [127.865990] Starting dynamic subtest: C-HDMI-A1 [128.530502] Dynamic subtest C-HDMI-A1: SUCCESS (0.670s) [128.536220] Starting dynamic subtest: D-HDMI-A1 [129.179290] Dynamic subtest D-HDMI-A1: SUCCESS (0.648s) [129.181523] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (2.629s) [129.261854] [041/142] (859s left) kms_scaling_modes (scaling-mode-center) [129.362873] Starting subtest: scaling-mode-center [129.365828] Subtest scaling-mode-center: SKIP (0.002s) [129.402834] [042/142] (859s left) gem_lmem_swapping (verify-random) [129.457464] Subtest verify-random: SKIP (0.000s) [129.477696] [043/142] (858s left) kms_cursor_legacy (cursor-vs-flip-atomic) [129.575053] Starting subtest: cursor-vs-flip-atomic [157.876122] Subtest cursor-vs-flip-atomic: SUCCESS (28.301s) [157.975899] [044/142] (830s left) kms_flip (busy-flip) [158.056815] Starting subtest: busy-flip [158.059724] Starting dynamic subtest: A-HDMI-A1 [158.737770] Dynamic subtest A-HDMI-A1: SUCCESS (0.678s) [158.745532] Starting dynamic subtest: B-HDMI-A1 [159.395477] Dynamic subtest B-HDMI-A1: SUCCESS (0.654s) [159.400856] Starting dynamic subtest: C-HDMI-A1 [160.038613] Dynamic subtest C-HDMI-A1: SUCCESS (0.640s) [160.043880] Starting dynamic subtest: D-HDMI-A1 [160.684679] Dynamic subtest D-HDMI-A1: SUCCESS (0.644s) [160.688882] Subtest busy-flip: SUCCESS (2.632s) [160.802480] [045/142] (827s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt) [160.904035] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt [160.905489] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [160.960743] [046/142] (827s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling) [161.059891] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling [161.060597] Starting dynamic subtest: pipe-A-valid-mode [161.799333] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.738s) [161.800053] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SUCCESS (0.740s) [161.902918] [047/142] (826s left) kms_vblank (pipe-b-ts-continuation-modeset) [161.999500] Starting subtest: pipe-B-ts-continuation-modeset [162.597975] Subtest pipe-B-ts-continuation-modeset: SUCCESS (0.598s) [162.688529] [048/142] (825s left) i915_pm_rc6_residency (rc6-fence) [162.738574] Starting subtest: rc6-fence [181.000710] Subtest rc6-fence: SUCCESS (18.237s) [181.191101] [049/142] (807s left) kms_frontbuffer_tracking (fbcpsr-tiling-4) [181.294136] Starting subtest: fbcpsr-tiling-4 [181.295597] Subtest fbcpsr-tiling-4: SKIP (0.000s) [181.349519] [050/142] (807s left) i915_fb_tiling [181.464739] [051/142] (807s left) vc4/vc4_create_bo (create-bo-0) [181.528076] Subtest create-bo-0: SKIP (0.000s) [181.557204] [052/142] (807s left) gem_flink_basic (basic) [181.610112] Starting subtest: basic [181.610855] Subtest basic: SUCCESS (0.000s) [181.667671] [053/142] (806s left) gem_ctx_persistence (engines-queued) [181.726032] Starting subtest: engines-queued [181.726781] Starting dynamic subtest: rcs0 [181.761674] Dynamic subtest rcs0: SUCCESS (0.035s) [181.771985] Starting dynamic subtest: bcs0 [181.807725] Dynamic subtest bcs0: SUCCESS (0.045s) [181.818716] Starting dynamic subtest: vcs0 [181.850671] Dynamic subtest vcs0: SUCCESS (0.041s) [181.861715] Starting dynamic subtest: vcs1 [181.896781] Dynamic subtest vcs1: SUCCESS (0.045s) [181.908106] Starting dynamic subtest: vecs0 [181.937733] Dynamic subtest vecs0: SUCCESS (0.039s) [181.938974] Subtest engines-queued: SUCCESS (0.212s) [181.990887] [054/142] (806s left) kms_cursor_crc (cursor-rapid-movement-64x64) [182.100271] Starting subtest: cursor-rapid-movement-64x64 [182.104968] Starting dynamic subtest: pipe-A-HDMI-A-1 [182.336074] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.231s) [182.361642] Starting dynamic subtest: pipe-D-HDMI-A-1 [183.361533] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.005s) [183.362334] Subtest cursor-rapid-movement-64x64: SUCCESS (1.262s) [183.467452] [055/142] (805s left) kms_big_fb (linear-8bpp-rotate-270) [183.572531] Starting subtest: linear-8bpp-rotate-270 [183.629841] Subtest linear-8bpp-rotate-270: SKIP (0.056s) [183.700273] [056/142] (804s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render) [183.803021] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render [183.804464] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [183.848145] [057/142] (804s left) kms_psr (primary_mmap_cpu) [183.896105] Subtest primary_mmap_cpu: SKIP (0.000s) [183.916375] [058/142] (804s left) kms_flip (nonblocking-read) [183.995884] Starting subtest: nonblocking-read [183.996624] Subtest nonblocking-read: SUCCESS (0.000s) [184.040343] [059/142] (804s left) kms_fence_pin_leak [184.985857] [060/142] (803s left) kms_ccs (pipe-d-bad-rotation-90-yf_tiled_ccs) [185.319039] Starting subtest: pipe-D-bad-rotation-90-yf_tiled_ccs [185.320477] Subtest pipe-D-bad-rotation-90-yf_tiled_ccs: SKIP (0.000s) [185.448223] [061/142] (803s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [185.499953] Starting subtest: yf-tiled-to-vebox-x-tiled [185.500784] Starting dynamic subtest: smem [185.596506] Dynamic subtest smem: SUCCESS (0.096s) [185.597275] Subtest yf-tiled-to-vebox-x-tiled: SUCCESS (0.097s) [185.740093] [062/142] (802s left) kms_ccs (pipe-a-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc) [185.918967] Starting subtest: pipe-A-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc [185.920474] Subtest pipe-A-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s) [186.199955] [063/142] (802s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_ccs) [186.489284] Starting subtest: pipe-C-random-ccs-data-y_tiled_ccs [186.491502] Subtest pipe-C-random-ccs-data-y_tiled_ccs: SKIP (0.000s) [186.661593] [064/142] (802s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite) [186.761064] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite [186.762499] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [186.803259] [065/142] (801s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [186.903983] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [186.905444] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [186.961662] [066/142] (801s left) kms_frontbuffer_tracking (fbc-2p-rte) [187.062095] Starting subtest: fbc-2p-rte [187.068706] Subtest fbc-2p-rte: SKIP (0.000s) [187.120112] [067/142] (801s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move) [187.220032] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move [187.221463] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [187.270048] [068/142] (801s left) kms_prop_blob (invalid-set-prop) [187.317857] Starting subtest: invalid-set-prop [187.318612] Subtest invalid-set-prop: SUCCESS (0.000s) [187.353525] [069/142] (801s left) i915_query (query-topology-matches-eu-total) [187.401387] Starting subtest: query-topology-matches-eu-total [187.402182] Subtest query-topology-matches-eu-total: SUCCESS (0.000s) [187.436326] [070/142] (801s left) gem_exec_schedule (preempt-hang) [187.596182] Starting subtest: preempt-hang [187.596939] Starting dynamic subtest: rcs0 [187.783720] Dynamic subtest rcs0: SUCCESS (0.187s) [187.789081] Starting dynamic subtest: bcs0 [187.969010] Dynamic subtest bcs0: SUCCESS (0.181s) [187.973774] Starting dynamic subtest: vcs0 [188.156271] Dynamic subtest vcs0: SUCCESS (0.190s) [188.161952] Starting dynamic subtest: vcs1 [188.348830] Dynamic subtest vcs1: SUCCESS (0.192s) [188.353747] Starting dynamic subtest: vecs0 [188.534121] Dynamic subtest vecs0: SUCCESS (0.184s) [188.534968] Subtest preempt-hang: SUCCESS (0.938s) [188.688953] [071/142] (800s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_mtl_rc_ccs) [188.908168] Starting subtest: pipe-B-bad-rotation-90-4_tiled_mtl_rc_ccs [188.909795] Subtest pipe-B-bad-rotation-90-4_tiled_mtl_rc_ccs: SKIP (0.000s) [189.166629] [072/142] (799s left) syncobj_timeline (device-signal-unordered) [189.215374] Starting subtest: device-signal-unordered [189.216103] Subtest device-signal-unordered: SUCCESS (0.000s) [189.249868] [073/142] (799s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite) [189.348899] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite [189.359270] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [189.399477] [074/142] (799s left) kms_properties (invalid-properties-legacy) [189.500826] Starting subtest: invalid-properties-legacy [189.794562] Subtest invalid-properties-legacy: SUCCESS (0.296s) [189.823678] [075/142] (799s left) syncobj_wait (wait-all-complex) [189.876614] Starting subtest: wait-all-complex [190.099512] Subtest wait-all-complex: SUCCESS (0.215s) [190.140493] [076/142] (798s left) gem_create (create-massive) [190.194879] Starting subtest: create-massive [190.195621] Subtest create-massive: SUCCESS (0.000s) [190.358952] [077/142] (798s left) gem_userptr_blits (userfault) [190.421848] Starting subtest: userfault [190.423674] Subtest userfault: SUCCESS (0.003s) [190.507366] [078/142] (798s left) i915_selftest (perf) [191.298989] Starting subtest: perf [191.300265] Starting dynamic subtest: engine_cs [191.843496] Dynamic subtest engine_cs: SUCCESS (0.546s) [191.850250] Starting dynamic subtest: request [195.463777] Dynamic subtest request: SUCCESS (3.614s) [195.469096] Starting dynamic subtest: migrate [196.065816] Dynamic subtest migrate: SUCCESS (0.601s) [196.071707] Starting dynamic subtest: region [197.640852] Dynamic subtest region: SUCCESS (1.574s) [197.641905] Subtest perf: SUCCESS (6.341s) [197.655090] [079/142] (791s left) kms_flip (basic-flip-vs-dpms) [198.309885] Starting subtest: basic-flip-vs-dpms [198.313303] Starting dynamic subtest: A-HDMI-A1 [198.970136] Dynamic subtest A-HDMI-A1: SUCCESS (0.656s) [198.974418] Starting dynamic subtest: B-HDMI-A1 [199.625707] Dynamic subtest B-HDMI-A1: SUCCESS (0.655s) [199.630174] Starting dynamic subtest: C-HDMI-A1 [200.288686] Dynamic subtest C-HDMI-A1: SUCCESS (0.662s) [200.295180] Starting dynamic subtest: D-HDMI-A1 [200.894929] Dynamic subtest D-HDMI-A1: SUCCESS (0.606s) [200.898974] Subtest basic-flip-vs-dpms: SUCCESS (2.589s) [201.043291] [080/142] (787s left) i915_pm_rpm (system-suspend) [212.582575] Starting subtest: system-suspend [223.696377] Subtest system-suspend: FAIL (11.102s) [223.841138] [081/142] (765s left) kms_ccs (pipe-b-missing-ccs-buffer-yf_tiled_ccs) [224.076194] Starting subtest: pipe-B-missing-ccs-buffer-yf_tiled_ccs [224.077690] Subtest pipe-B-missing-ccs-buffer-yf_tiled_ccs: SKIP (0.000s) [224.303486] [082/142] (764s left) gem_pxp (create-regular-context-2) [226.901292] Subtest create-regular-context-2: SKIP (0.000s) [226.916203] [083/142] (762s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt) [227.021009] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt [227.022391] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s) [227.080477] [084/142] (761s left) prime_mmap (test_aperture_limit) [227.127973] Starting subtest: test_aperture_limit [227.128788] Starting dynamic subtest: test_aperture_limit-smem [227.134651] Dynamic subtest test_aperture_limit-smem: SUCCESS (0.007s) [227.135377] Subtest test_aperture_limit: SUCCESS (0.007s) [227.183654] [085/142] (761s left) kms_cursor_crc (cursor-onscreen-128x128) [227.289032] Starting subtest: cursor-onscreen-128x128 [227.294183] Starting dynamic subtest: pipe-A-HDMI-A-1 [228.439158] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.145s) [228.464214] Starting dynamic subtest: pipe-D-HDMI-A-1 [230.412898] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.954s) [230.413766] Subtest cursor-onscreen-128x128: SUCCESS (3.124s) [230.515285] [086/142] (758s left) kms_big_fb (4-tiled-8bpp-rotate-90) [230.618368] Starting subtest: 4-tiled-8bpp-rotate-90 [230.619845] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.000s) [230.680865] [087/142] (758s left) gem_mmap (bad-object) [230.727514] Starting subtest: bad-object [230.728314] Subtest bad-object: SUCCESS (0.000s) [230.785523] [088/142] (758s left) vc4/vc4_purgeable_bo (mark-willneed) [230.843205] Subtest mark-willneed: SKIP (0.000s) [230.871953] [089/142] (758s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-blt) [230.971551] Starting subtest: fbc-1p-offscren-pri-indfb-draw-blt [231.869513] Subtest fbc-1p-offscren-pri-indfb-draw-blt: SUCCESS (0.899s) [231.951103] [090/142] (757s left) prime_udl [232.023432] [091/142] (757s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu) [232.125755] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu [232.127113] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [232.180968] [092/142] (756s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [232.278725] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [232.280122] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [232.331056] [093/142] (756s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_dg2_mc_ccs) [232.685270] Starting subtest: pipe-D-random-ccs-data-4_tiled_dg2_mc_ccs [232.687434] Subtest pipe-D-random-ccs-data-4_tiled_dg2_mc_ccs: SKIP (0.000s) [232.795195] [094/142] (756s left) kms_vblank (pipe-d-wait-idle-hang) [232.890566] Starting subtest: pipe-D-wait-idle-hang [247.782325] Subtest pipe-D-wait-idle-hang: SUCCESS (14.892s) [247.883591] [095/142] (741s left) kms_addfb_basic (invalid-get-prop) [247.937603] Starting subtest: invalid-get-prop [247.938334] Subtest invalid-get-prop: SUCCESS (0.000s) [248.047797] [096/142] (741s left) gem_render_copy_redux (normal) [248.102644] Starting subtest: normal [248.521697] Subtest normal: SUCCESS (0.410s) [248.580996] [097/142] (740s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20) [248.682017] Starting subtest: planes-downscale-factor-0-5-upscale-20x20 [248.683726] Starting dynamic subtest: pipe-A-HDMI-A-1 [248.795684] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.112s) [248.801595] Starting dynamic subtest: pipe-B-HDMI-A-1 [248.903315] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.106s) [248.909161] Starting dynamic subtest: pipe-C-HDMI-A-1 [249.012422] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.107s) [249.018174] Starting dynamic subtest: pipe-D-HDMI-A-1 [249.121452] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.107s) [249.122302] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.440s) [249.251305] [098/142] (739s left) kms_vblank (pipe-b-query-idle-hang) [249.349267] Starting subtest: pipe-B-query-idle-hang [264.162952] Subtest pipe-B-query-idle-hang: SUCCESS (14.813s) [264.277431] [099/142] (724s left) gem_exec_schedule (implicit-write-read) [264.333071] Starting subtest: implicit-write-read [264.333811] Starting dynamic subtest: rcs0 [264.386641] Dynamic subtest rcs0: SUCCESS (0.053s) [264.391784] Starting dynamic subtest: bcs0 [264.438850] Dynamic subtest bcs0: SUCCESS (0.051s) [264.448645] Starting dynamic subtest: vcs0 [264.497523] Dynamic subtest vcs0: SUCCESS (0.057s) [264.506659] Starting dynamic subtest: vcs1 [264.555633] Dynamic subtest vcs1: SUCCESS (0.057s) [264.564696] Starting dynamic subtest: vecs0 [264.614903] Dynamic subtest vecs0: SUCCESS (0.057s) [264.616258] Subtest implicit-write-read: SUCCESS (0.282s) [264.896125] [100/142] (724s left) gem_mmap_gtt (basic-wc) [264.955811] Starting subtest: basic-wc [265.592913] Subtest basic-wc: SUCCESS (0.630s) [265.628344] [101/142] (723s left) sysfs_timeslice_duration (duration) [265.677359] Starting subtest: duration [265.678157] Starting dynamic subtest: vecs0 [265.731832] Dynamic subtest vecs0: SUCCESS (0.053s) [265.741929] Starting dynamic subtest: vcs0 [265.798043] Dynamic subtest vcs0: SUCCESS (0.064s) [265.811839] Starting dynamic subtest: bcs0 [265.865169] Dynamic subtest bcs0: SUCCESS (0.065s) [265.882384] Starting dynamic subtest: rcs0 [265.931945] Dynamic subtest rcs0: SUCCESS (0.065s) [265.943823] Starting dynamic subtest: vcs1 [265.988914] Dynamic subtest vcs1: SUCCESS (0.055s) [265.990230] Subtest duration: SUCCESS (0.312s) [266.033979] [102/142] (723s left) v3d/v3d_submit_cl (bad-multisync-pad) [266.106314] Subtest bad-multisync-pad: SKIP (0.000s) [266.135544] [103/142] (723s left) kms_busy (extended-modeset-hang-oldfb-with-reset) [266.253425] Starting subtest: extended-modeset-hang-oldfb-with-reset [266.255317] Starting dynamic subtest: pipe-A [267.771909] Dynamic subtest pipe-A: SUCCESS (1.517s) [267.782468] Starting dynamic subtest: pipe-D [269.307879] Dynamic subtest pipe-D: SUCCESS (1.529s) [269.308630] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (3.055s) [269.418303] [104/142] (719s left) gem_linear_blits (normal) [269.865730] Starting subtest: normal [273.825516] Subtest normal: SUCCESS (3.950s) [273.890153] [105/142] (715s left) kms_big_fb (y-tiled-64bpp-rotate-180) [274.042338] Starting subtest: y-tiled-64bpp-rotate-180 [275.338932] Subtest y-tiled-64bpp-rotate-180: SUCCESS (1.296s) [275.430682] [106/142] (713s left) drm_fdinfo (busy-idle-check-all) [275.483837] Starting subtest: busy-idle-check-all [275.484583] Starting dynamic subtest: rcs0 [276.103504] Dynamic subtest rcs0: SUCCESS (0.619s) [276.110809] Starting dynamic subtest: bcs0 [276.722657] Dynamic subtest bcs0: SUCCESS (0.617s) [276.729965] Starting dynamic subtest: vcs0 [277.341579] Dynamic subtest vcs0: SUCCESS (0.618s) [277.349153] Starting dynamic subtest: vcs1 [277.963391] Dynamic subtest vcs1: SUCCESS (0.621s) [277.972123] Starting dynamic subtest: vecs0 [278.583649] Dynamic subtest vecs0: SUCCESS (0.618s) [278.585089] Subtest busy-idle-check-all: SUCCESS (3.100s) [278.627589] [107/142] (710s left) gem_mmap_gtt (pf-nonblock) [278.686625] Starting subtest: pf-nonblock [278.687472] Subtest pf-nonblock: SUCCESS (0.001s) [278.762809] [108/142] (710s left) gem_exec_store (basic) [278.826981] Starting subtest: basic [278.888952] Subtest basic: SUCCESS (0.061s) [279.048187] [109/142] (710s left) kms_vblank (pipe-b-query-forked) [279.153560] Starting subtest: pipe-B-query-forked [280.695439] Subtest pipe-B-query-forked: SUCCESS (1.541s) [280.786300] [110/142] (708s left) vc4/vc4_wait_bo (unused-bo-1ns) [280.855287] Subtest unused-bo-1ns: SKIP (0.000s) [280.885167] [111/142] (708s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling) [280.981481] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling [280.983395] Starting dynamic subtest: pipe-A-valid-mode [281.689020] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.706s) [281.689749] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (0.708s) [281.773158] [112/142] (707s left) kms_big_fb (yf-tiled-8bpp-rotate-180) [281.877016] Starting subtest: yf-tiled-8bpp-rotate-180 [281.878625] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s) [281.931308] [113/142] (707s left) v3d/v3d_submit_cl (bad-bo) [281.992840] Subtest bad-bo: SKIP (0.000s) [282.023452] [114/142] (707s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt) [282.123825] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt [282.125226] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [282.189487] [115/142] (707s left) gem_exec_fence (syncobj-timeline-signal) [282.640781] Starting subtest: syncobj-timeline-signal [282.641880] Subtest syncobj-timeline-signal: SUCCESS (0.006s) [282.792726] [116/142] (706s left) syncobj_wait (invalid-signal-bad-pad) [282.852602] Starting subtest: invalid-signal-bad-pad [282.853469] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [282.889704] [117/142] (706s left) gem_workarounds (suspend-resume-context) [282.952197] Starting subtest: suspend-resume-context [299.102529] Subtest suspend-resume-context: SUCCESS (1.213s) [304.824753] [118/142] (705s left) kms_chamelium_color (ctm-red-to-blue) [304.929211] Subtest ctm-red-to-blue: SKIP (0.000s) [304.947177] [119/142] (705s left) gem_exec_alignment (many) [304.997957] Starting subtest: many [317.521422] Killing the test because the kernel is tainted. [320.218113] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1856 [max: 8192] direct dependencies: 18490 [max: 32768] indirect dependencies: 139862 all direct dependencies: 395790 dependency chains: 26111 [max: 131072] dependency chain hlocks used: 110355 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 256 in-softirq chains: 718 in-process chains: 25137 stack-trace entries: 221795 [max: 1048576] number of stack traces: 10922 number of stack hash chains: 7965 combined max dependencies: 350107758 hardirq-safe locks: 108 hardirq-unsafe locks: 1100 softirq-safe locks: 222 softirq-unsafe locks: 1008 irq-safe locks: 235 irq-unsafe locks: 1100 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 326 softirq-read-safe locks: 8 softirq-read-unsafe locks: 321 irq-read-safe locks: 8 irq-read-unsafe locks: 326 uncategorized locks: 308 unused locks: 1 max locking depth: 15 max bfs queue depth: 422 max lock class index: 1855 chain lookup misses: 38290 chain lookup hits: 474565071 cyclic checks: 38531 redundant checks: 0 redundant links: 0 find-mask forwards checks: 7101 find-mask backwards checks: 4024 hardirq on events: 278632055 hardirq off events: 278632047 redundant hardirq ons: 32 redundant hardirq offs: 27 softirq on events: 1656771 softirq off events: 1656771 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 925 zapped lock chains: 12011 large chain blocks: 1 [320.219299] Closing watchdogs Done.