[67.926274] Initializing watchdogs [67.926356] /dev/watchdog0 [67.957050] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics] [67.971800] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [67.976825] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [67.979803] [001/132] (960s left) kms_psr (psr-primary-blt) [69.467414] Subtest psr-primary-blt: SKIP (0.000s) [69.542364] [002/132] (958s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt) [71.040398] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt [71.042632] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [71.567407] [003/132] (957s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render) [73.242229] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render [76.114963] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (2.875s) [76.300481] [004/132] (952s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [77.782969] Starting subtest: crc-primary-basic-y-tiled-ccs [77.783882] Starting dynamic subtest: pipe-A-HDMI-A-4 [77.791881] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s) [77.799778] Starting dynamic subtest: pipe-B-HDMI-A-4 [77.807705] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s) [77.815362] Starting dynamic subtest: pipe-C-HDMI-A-4 [77.823037] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s) [77.831442] Starting dynamic subtest: pipe-D-HDMI-A-4 [77.839653] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s) [77.841270] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.009s) [78.035946] [005/132] (950s left) kms_cursor_crc (cursor-sliding-32x32) [79.615854] Starting subtest: cursor-sliding-32x32 [79.669572] Subtest cursor-sliding-32x32: SKIP (0.052s) [80.131178] [006/132] (948s left) gem_exec_schedule (preempt-self) [80.196822] Starting subtest: preempt-self [80.197792] Starting dynamic subtest: rcs0 [80.241477] Dynamic subtest rcs0: SUCCESS (0.045s) [80.249479] Starting dynamic subtest: bcs0 [80.268675] Dynamic subtest bcs0: SUCCESS (0.027s) [80.276564] Starting dynamic subtest: vcs0 [80.294284] Dynamic subtest vcs0: SUCCESS (0.025s) [80.302203] Starting dynamic subtest: vcs1 [80.318318] Dynamic subtest vcs1: SUCCESS (0.024s) [80.326317] Starting dynamic subtest: vecs0 [80.344913] Dynamic subtest vecs0: SUCCESS (0.026s) [80.345962] Subtest preempt-self: SUCCESS (0.148s) [80.774918] [007/132] (948s left) gem_exec_whisper (basic-fds-priority) [80.832353] Starting subtest: basic-fds-priority [93.731125] Subtest basic-fds-priority: SUCCESS (12.895s) [94.005868] [008/132] (935s left) kms_big_fb (yf-tiled-16bpp-rotate-0) [95.514141] Starting subtest: yf-tiled-16bpp-rotate-0 [95.516074] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s) [95.672783] [009/132] (933s left) i915_pm_rc6_residency (media-rc6-accuracy) [95.732640] Starting subtest: media-rc6-accuracy [95.734343] Subtest media-rc6-accuracy: SKIP (0.000s) [95.832879] [010/132] (933s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [97.322043] Starting subtest: fbcpsr-rgb101010-draw-pwrite [97.324036] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s) [97.520806] [011/132] (931s left) gem_lmem_swapping (heavy-verify-multi-ccs) [101.786963] Starting subtest: heavy-verify-multi-ccs [101.788645] Starting dynamic subtest: lmem0 [101.792394] Dynamic subtest lmem0: SKIP (0.000s) [101.794387] Subtest heavy-verify-multi-ccs: SKIP (0.000s) [105.572493] [FACT gem_lmem_swapping (heavy-verify-multi-ccs)] deleted: kernel.kmod_is_loaded.i915: true [105.574448] [012/132] (923s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c) [108.873455] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s) [108.949560] [FACT kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)] new: kernel.kmod_is_loaded.i915: true [108.952692] [013/132] (920s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite) [110.444296] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite [110.445932] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [110.630672] [014/132] (918s left) kms_cursor_legacy (forked-bo) [112.118809] Starting subtest: forked-bo [112.119851] Starting dynamic subtest: pipe-A [117.544414] Dynamic subtest pipe-A: SUCCESS (5.422s) [117.556656] Starting dynamic subtest: pipe-B [122.972427] Dynamic subtest pipe-B: SUCCESS (5.426s) [122.986138] Starting dynamic subtest: pipe-C [128.425218] Dynamic subtest pipe-C: SUCCESS (5.452s) [128.441752] Starting dynamic subtest: pipe-D [133.872227] Dynamic subtest pipe-D: SUCCESS (5.446s) [133.887667] Starting dynamic subtest: all-pipes [139.423241] Dynamic subtest all-pipes: SUCCESS (5.551s) [139.424442] Subtest forked-bo: SUCCESS (27.301s) [139.548929] [015/132] (890s left) perf_pmu (busy-accuracy-50) [139.604780] Starting subtest: busy-accuracy-50 [139.605598] Starting dynamic subtest: rcs0 [141.177417] Dynamic subtest rcs0: SUCCESS (1.570s) [141.187344] Starting dynamic subtest: bcs0 [142.727181] Dynamic subtest bcs0: SUCCESS (1.550s) [142.736479] Starting dynamic subtest: vcs0 [144.271262] Dynamic subtest vcs0: SUCCESS (1.544s) [144.280628] Starting dynamic subtest: vcs1 [145.817166] Dynamic subtest vcs1: SUCCESS (1.545s) [145.826463] Starting dynamic subtest: vecs0 [147.362304] Dynamic subtest vecs0: SUCCESS (1.545s) [147.363153] Subtest busy-accuracy-50: SUCCESS (7.757s) [147.515636] [016/132] (882s left) kms_psr (fbc-pr-basic) [149.000495] Subtest fbc-pr-basic: SKIP (0.000s) [149.074413] [017/132] (880s left) prime_mmap (test_errors) [149.121472] Starting subtest: test_errors [149.122523] Starting dynamic subtest: test_errors-smem [149.312295] Dynamic subtest test_errors-smem: SUCCESS (0.189s) [149.321473] Starting dynamic subtest: test_errors-lmem0 [149.500677] Dynamic subtest test_errors-lmem0: SUCCESS (0.188s) [149.501823] Subtest test_errors: SUCCESS (0.377s) [149.631397] [018/132] (880s left) gem_mmap_wc (bad-object) [149.675952] Subtest bad-object: SKIP (0.000s) [149.740340] [019/132] (880s left) kms_lease (empty-lease) [151.222442] Starting subtest: empty-lease [151.223262] Starting dynamic subtest: pipe-A-HDMI-A-4 [151.224136] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.001s) [151.234858] Starting dynamic subtest: pipe-B-HDMI-A-4 [151.235821] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s) [151.245202] Starting dynamic subtest: pipe-C-HDMI-A-4 [151.246073] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s) [151.255268] Starting dynamic subtest: pipe-D-HDMI-A-4 [151.256175] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s) [151.257159] Subtest empty-lease: SUCCESS (0.010s) [151.355009] [020/132] (878s left) i915_selftest (live) [152.259751] Starting subtest: live [152.260803] Starting dynamic subtest: sanitycheck [153.692962] Dynamic subtest sanitycheck: SUCCESS (1.433s) [153.701149] Starting dynamic subtest: uncore [155.107725] Dynamic subtest uncore: SUCCESS (1.414s) [155.115879] Starting dynamic subtest: workarounds [158.413905] Dynamic subtest workarounds: SUCCESS (3.306s) [158.422673] Starting dynamic subtest: gt_engines [160.345660] Dynamic subtest gt_engines: SUCCESS (1.931s) [160.353768] Starting dynamic subtest: gt_timelines [226.030868] Dynamic subtest gt_timelines: SUCCESS (65.684s) [226.039106] Starting dynamic subtest: gt_contexts [227.464930] Dynamic subtest gt_contexts: SUCCESS (1.434s) [227.473313] Starting dynamic subtest: gt_lrc [233.466905] Dynamic subtest gt_lrc: SUCCESS (6.001s) [233.475046] Starting dynamic subtest: gt_mocs [235.789878] Dynamic subtest gt_mocs: SUCCESS (2.322s) [235.798042] Starting dynamic subtest: gt_pm [239.752845] Dynamic subtest gt_pm: SUCCESS (3.962s) [239.760805] Starting dynamic subtest: gt_heartbeat [241.145801] Dynamic subtest gt_heartbeat: SUCCESS (1.392s) [241.154449] Starting dynamic subtest: gt_tlb [255.017938] Dynamic subtest gt_tlb: SUCCESS (13.872s) [255.025974] Starting dynamic subtest: requests [265.441026] Dynamic subtest requests: SUCCESS (10.422s) [265.449199] Starting dynamic subtest: migrate [269.959780] Dynamic subtest migrate: SUCCESS (4.518s) [269.968249] Starting dynamic subtest: active [271.373599] Dynamic subtest active: SUCCESS (1.413s) [271.381435] Starting dynamic subtest: objects [273.874818] Dynamic subtest objects: SUCCESS (2.500s) [273.883842] Starting dynamic subtest: mman [277.379724] Dynamic subtest mman: SUCCESS (3.504s) [277.387891] Starting dynamic subtest: dmabuf [278.848868] Dynamic subtest dmabuf: SUCCESS (1.468s) [278.857229] Starting dynamic subtest: vma [280.222809] Dynamic subtest vma: SUCCESS (1.373s) [280.231103] Starting dynamic subtest: coherency [290.258754] Dynamic subtest coherency: SUCCESS (10.035s) [290.267621] Starting dynamic subtest: gtt [299.203156] Dynamic subtest gtt: SUCCESS (8.944s) [299.211210] Starting dynamic subtest: gem [300.749672] Dynamic subtest gem: SUCCESS (1.546s) [300.758189] Starting dynamic subtest: evict [312.137997] Dynamic subtest evict: SUCCESS (11.387s) [312.146115] Starting dynamic subtest: hugepages [329.499311] Dynamic subtest hugepages: SUCCESS (17.360s) [329.507458] Starting dynamic subtest: gem_contexts [357.709746] Dynamic subtest gem_contexts: SUCCESS (28.209s) [357.717684] Starting dynamic subtest: client [359.147771] Dynamic subtest client: SUCCESS (1.437s) [359.156184] Starting dynamic subtest: gem_migrate [361.762628] Dynamic subtest gem_migrate: SUCCESS (2.616s) [361.771494] Starting dynamic subtest: reset [363.211737] Dynamic subtest reset: SUCCESS (1.446s) [363.219860] Starting dynamic subtest: memory_region [366.207967] Dynamic subtest memory_region: SUCCESS (2.995s) [366.216870] Starting dynamic subtest: hangcheck [396.356876] Dynamic subtest hangcheck: SUCCESS (30.148s) [396.365084] Starting dynamic subtest: execlists [397.753998] Dynamic subtest execlists: SUCCESS (1.396s) [397.762645] Starting dynamic subtest: ring_submission [399.172821] Dynamic subtest ring_submission: SUCCESS (1.418s) [399.181235] Starting dynamic subtest: perf [400.716898] Dynamic subtest perf: SUCCESS (1.543s) [400.725448] Starting dynamic subtest: slpc [406.611914] Dynamic subtest slpc: SUCCESS (5.894s) [406.620159] Starting dynamic subtest: guc [410.078748] Dynamic subtest guc: SUCCESS (3.466s) [410.086982] Starting dynamic subtest: guc_multi_lrc [411.515677] Dynamic subtest guc_multi_lrc: SUCCESS (1.436s) [411.524011] Starting dynamic subtest: guc_hang [413.706841] Dynamic subtest guc_hang: SUCCESS (2.190s) [413.715147] Starting dynamic subtest: late_gt_pm [415.146564] Dynamic subtest late_gt_pm: SUCCESS (1.439s) [415.147529] Subtest live: SUCCESS (262.885s) [415.187786] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [415.190230] [021/132] (614s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [419.970220] Starting subtest: bad-pixel-format-yf-tiled-ccs [419.972351] Starting dynamic subtest: pipe-A-HDMI-A-4 [419.980484] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s) [419.989590] Starting dynamic subtest: pipe-B-HDMI-A-4 [419.997750] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s) [420.006692] Starting dynamic subtest: pipe-C-HDMI-A-4 [420.014887] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s) [420.023790] Starting dynamic subtest: pipe-D-HDMI-A-4 [420.032042] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s) [420.033733] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.010s) [420.307627] [FACT kms_ccs (bad-pixel-format-yf-tiled-ccs)] new: kernel.kmod_is_loaded.i915: true [420.310898] [022/132] (609s left) gem_ppgtt (blt-vs-render-ctx0) [420.367331] Starting subtest: blt-vs-render-ctx0 [453.232413] Subtest blt-vs-render-ctx0: SUCCESS (32.865s) [453.484680] [023/132] (576s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [455.031689] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [455.033311] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [455.195393] [024/132] (575s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [455.253126] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [455.254069] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s) [455.366739] [025/132] (575s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled) [455.414346] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [455.415253] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [455.526630] [026/132] (574s left) gem_exec_flush (basic-wb-prw-default) [455.579432] Subtest basic-wb-prw-default: SKIP (0.000s) [455.668150] [027/132] (574s left) perf_pmu (idle) [455.719792] Starting subtest: idle [455.720736] Starting dynamic subtest: rcs0 [456.275038] Dynamic subtest rcs0: SUCCESS (0.551s) [456.285332] Starting dynamic subtest: bcs0 [456.798022] Dynamic subtest bcs0: SUCCESS (0.518s) [456.808455] Starting dynamic subtest: vcs0 [457.317445] Dynamic subtest vcs0: SUCCESS (0.511s) [457.327609] Starting dynamic subtest: vcs1 [457.833030] Dynamic subtest vcs1: SUCCESS (0.514s) [457.843190] Starting dynamic subtest: vecs0 [458.349075] Dynamic subtest vecs0: SUCCESS (0.511s) [458.350006] Subtest idle: SUCCESS (2.629s) [458.463491] [028/132] (572s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic) [459.948256] Starting subtest: async-flip-with-page-flip-events-linear-atomic [460.188269] Starting dynamic subtest: pipe-A-HDMI-A-4 [462.497661] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.305s) [462.704210] Starting dynamic subtest: pipe-B-HDMI-A-4 [464.759776] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.062s) [464.926220] Starting dynamic subtest: pipe-C-HDMI-A-4 [466.985936] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.066s) [467.162293] Starting dynamic subtest: pipe-D-HDMI-A-4 [469.211544] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.055s) [469.212603] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (9.262s) [469.578095] [029/132] (561s left) kms_dsc (dsc-with-bpc-formats) [471.064612] Starting subtest: dsc-with-bpc-formats [471.116009] Subtest dsc-with-bpc-formats: SKIP (0.005s) [471.186019] [030/132] (559s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move) [472.683446] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move [472.685295] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [472.890565] [031/132] (557s left) kms_flip (flip-vs-panning) [474.376715] Starting subtest: flip-vs-panning [474.385027] Starting dynamic subtest: A-HDMI-A4 [482.163850] Dynamic subtest A-HDMI-A4: SUCCESS (7.778s) [482.204874] Starting dynamic subtest: B-HDMI-A4 [489.895393] Dynamic subtest B-HDMI-A4: SUCCESS (7.722s) [489.935328] Starting dynamic subtest: C-HDMI-A4 [497.630782] Dynamic subtest C-HDMI-A4: SUCCESS (7.726s) [497.669824] Starting dynamic subtest: D-HDMI-A4 [505.364858] Dynamic subtest D-HDMI-A4: SUCCESS (7.725s) [505.369811] Subtest flip-vs-panning: SUCCESS (30.991s) [505.583783] [032/132] (525s left) kms_flip (flip-vs-expired-vblank) [507.071408] Starting subtest: flip-vs-expired-vblank [507.078461] Starting dynamic subtest: A-HDMI-A4 [514.818051] Dynamic subtest A-HDMI-A4: SUCCESS (7.738s) [514.857249] Starting dynamic subtest: B-HDMI-A4 [522.529773] Dynamic subtest B-HDMI-A4: SUCCESS (7.704s) [522.542411] Starting dynamic subtest: C-HDMI-A4 [530.216672] Dynamic subtest C-HDMI-A4: SUCCESS (7.684s) [530.260515] Starting dynamic subtest: D-HDMI-A4 [537.934184] Dynamic subtest D-HDMI-A4: SUCCESS (7.709s) [537.935042] Subtest flip-vs-expired-vblank: SUCCESS (30.865s) [538.138344] [033/132] (492s left) kms_cursor_crc (cursor-rapid-movement-64x21) [539.773494] Starting subtest: cursor-rapid-movement-64x21 [539.780444] Starting dynamic subtest: pipe-A-HDMI-A-4 [540.231144] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.451s) [540.265442] Starting dynamic subtest: pipe-D-HDMI-A-4 [540.578788] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.322s) [540.579642] Subtest cursor-rapid-movement-64x21: SUCCESS (0.806s) [541.038197] [034/132] (490s left) kms_big_fb (x-tiled-addfb) [542.549286] Starting subtest: x-tiled-addfb [542.550207] Subtest x-tiled-addfb: SUCCESS (0.000s) [542.760370] [035/132] (488s left) gem_render_copy (yf-tiled-ccs-to-x-tiled) [542.814481] Starting subtest: yf-tiled-ccs-to-x-tiled [542.815331] Starting dynamic subtest: smem [542.904658] Dynamic subtest smem: SUCCESS (0.089s) [542.916708] Starting dynamic subtest: lmem0 [543.832314] Dynamic subtest lmem0: SUCCESS (0.923s) [543.833381] Subtest yf-tiled-ccs-to-x-tiled: SUCCESS (1.015s) [544.127518] [036/132] (487s left) gem_ctx_persistence (engines-hang) [544.178636] Starting subtest: engines-hang [544.179464] Starting dynamic subtest: rcs0 [544.237133] Dynamic subtest rcs0: SUCCESS (0.058s) [544.250892] Starting dynamic subtest: bcs0 [544.334606] Dynamic subtest bcs0: SUCCESS (0.095s) [544.380460] Starting dynamic subtest: vcs0 [544.400168] Dynamic subtest vcs0: SUCCESS (0.059s) [544.417822] Starting dynamic subtest: vcs1 [544.494485] Dynamic subtest vcs1: SUCCESS (0.091s) [544.542648] Starting dynamic subtest: vecs0 [544.557206] Dynamic subtest vecs0: SUCCESS (0.056s) [544.560234] Subtest engines-hang: SUCCESS (0.380s) [544.746349] [037/132] (486s left) syncobj_timeline (multi-wait-all-available-submitted-signaled) [544.792984] Starting subtest: multi-wait-all-available-submitted-signaled [544.793901] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s) [544.904636] [038/132] (486s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite) [546.394945] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite [546.396738] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [546.561343] [039/132] (484s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic) [548.052341] Starting subtest: nonblocking-modeset-vs-cursor-atomic [548.261861] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.209s) [548.449419] [040/132] (483s left) api_intel_bb (simple-bb-ctx) [548.496183] Starting subtest: simple-bb-ctx [548.517850] Subtest simple-bb-ctx: SUCCESS (0.022s) [548.724283] [041/132] (482s left) gem_mmap_gtt (flink-race) [548.771051] Subtest flink-race: SKIP (0.000s) [548.875769] [042/132] (482s left) gem_mmap (bad-object) [548.921874] Subtest bad-object: SKIP (0.000s) [548.992598] [043/132] (482s left) gem_exec_fence (syncobj-invalid-wait) [549.488942] Starting subtest: syncobj-invalid-wait [549.489966] Subtest syncobj-invalid-wait: SUCCESS (0.001s) [549.940935] [FACT gem_exec_fence (syncobj-invalid-wait)] new: kernel.kmod_is_loaded.vgem: true [549.949121] [044/132] (482s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs) [551.434358] Starting subtest: random-ccs-data-4-tiled-lnl-ccs [551.436043] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s) [551.622738] [045/132] (480s left) gem_wait (invalid-buf) [551.673848] Starting subtest: invalid-buf [551.674887] Subtest invalid-buf: SUCCESS (0.000s) [551.984527] [046/132] (480s left) kms_cursor_crc (cursor-offscreen-512x512) [553.742283] Starting subtest: cursor-offscreen-512x512 [553.744033] Subtest cursor-offscreen-512x512: SKIP (0.001s) [554.009121] [047/132] (478s left) gem_ctx_engines (execute-one) [554.064859] Starting subtest: execute-one [556.427572] Subtest execute-one: SUCCESS (2.362s) [556.731446] [048/132] (475s left) kms_content_protection (atomic-dpms-hdcp14) [558.276583] Starting subtest: atomic-dpms-hdcp14 [558.284756] Subtest atomic-dpms-hdcp14: SKIP (0.006s) [558.487123] [049/132] (473s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render) [559.977446] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render [559.979357] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [560.172183] [050/132] (472s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite) [561.665884] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite [561.667556] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [561.838902] [051/132] (470s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [561.887827] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [561.993257] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.101s) [562.151857] [052/132] (470s left) perf_pmu (rc6) [562.200903] Starting subtest: rc6 [562.201829] Starting dynamic subtest: gt0 [568.546245] Dynamic subtest gt0: SUCCESS (6.341s) [568.557231] Starting dynamic subtest: runtime-pm-gt0 [576.116310] Dynamic subtest runtime-pm-gt0: SUCCESS (7.565s) [576.127272] Starting dynamic subtest: runtime-pm-long-gt0 [588.677128] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.560s) [588.688621] Starting dynamic subtest: other-idle-gt0 [588.690337] Dynamic subtest other-idle-gt0: SKIP (0.000s) [588.691234] Subtest rc6: SUCCESS (26.475s) [589.395920] [053/132] (443s left) vgem_slow (nohang) [589.445393] Starting subtest: nohang [599.627405] Subtest nohang: SUCCESS (10.178s) [599.692600] [054/132] (433s left) i915_drm_fdinfo (most-busy-check-all) [599.744397] Starting subtest: most-busy-check-all [599.745277] Starting dynamic subtest: rcs0 [599.760912] Dynamic subtest rcs0: SKIP (0.016s) [599.772662] Starting dynamic subtest: bcs0 [599.774941] Dynamic subtest bcs0: SKIP (0.001s) [599.786219] Starting dynamic subtest: vcs0 [599.788585] Dynamic subtest vcs0: SKIP (0.000s) [599.799625] Starting dynamic subtest: vcs1 [599.802027] Dynamic subtest vcs1: SKIP (0.000s) [599.812598] Starting dynamic subtest: vecs0 [599.814814] Dynamic subtest vecs0: SKIP (0.000s) [599.817123] Subtest most-busy-check-all: SKIP (0.026s) [599.880721] [055/132] (433s left) perf (disabled-read-error) [599.990558] Starting subtest: disabled-read-error [600.031598] Subtest disabled-read-error: SUCCESS (0.041s) [600.110970] [056/132] (432s left) kms_color (ctm-negative) [601.632417] Starting subtest: ctm-negative [601.633285] Starting dynamic subtest: pipe-A-HDMI-A-4 [602.351847] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.719s) [602.363113] Starting dynamic subtest: pipe-B-HDMI-A-4 [602.861962] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.508s) [602.873188] Starting dynamic subtest: pipe-C-HDMI-A-4 [603.404098] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.541s) [603.415483] Starting dynamic subtest: pipe-D-HDMI-A-4 [603.920095] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.515s) [603.921029] Subtest ctm-negative: SUCCESS (2.289s) [604.068261] [057/132] (429s left) kms_plane_alpha_blend (alpha-7efc) [605.555435] Starting subtest: alpha-7efc [605.823198] Starting dynamic subtest: pipe-A-HDMI-A-4 [606.340527] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.516s) [606.373632] Starting dynamic subtest: pipe-D-HDMI-A-4 [606.947680] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.584s) [606.948711] Subtest alpha-7efc: SUCCESS (1.393s) [607.100220] [058/132] (426s left) sysfs_preempt_timeout (idempotent) [607.153744] Starting subtest: idempotent [607.154789] Starting dynamic subtest: vecs0 [607.155824] Dynamic subtest vecs0: SUCCESS (0.001s) [607.167295] Starting dynamic subtest: vcs0 [607.168649] Dynamic subtest vcs0: SUCCESS (0.001s) [607.179953] Starting dynamic subtest: bcs0 [607.181367] Dynamic subtest bcs0: SUCCESS (0.001s) [607.192186] Starting dynamic subtest: rcs0 [607.193340] Dynamic subtest rcs0: SUCCESS (0.001s) [607.204684] Starting dynamic subtest: vcs1 [607.206032] Dynamic subtest vcs1: SUCCESS (0.001s) [607.207345] Subtest idempotent: SUCCESS (0.013s) [607.271725] [059/132] (425s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [608.756652] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [608.758503] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s) [608.831694] [060/132] (424s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip) [610.337775] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip [610.339482] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [610.456316] [061/132] (422s left) gem_workarounds (basic-read-context) [610.536425] Starting subtest: basic-read-context [610.566769] Subtest basic-read-context: SUCCESS (0.029s) [610.694674] [062/132] (422s left) syncobj_wait (single-wait-for-submit-signaled) [610.741324] Starting subtest: single-wait-for-submit-signaled [610.742210] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s) [610.813840] [063/132] (422s left) gem_ctx_persistence (heartbeat-many) [610.865507] Starting subtest: heartbeat-many [610.867440] Subtest heartbeat-many: SKIP (0.000s) [610.975557] [064/132] (422s left) kms_plane_multiple (2x-tiling-4) [612.462451] Starting subtest: 2x-tiling-4 [612.464126] Subtest 2x-tiling-4: SKIP (0.000s) [612.547364] [065/132] (421s left) kms_flip (2x-flip-vs-fences-interruptible) [614.037930] Starting subtest: 2x-flip-vs-fences-interruptible [614.039906] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s) [614.113591] [066/132] (419s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [614.166759] Starting subtest: yf-tiled-to-vebox-x-tiled [614.167635] Starting dynamic subtest: smem [614.251973] Dynamic subtest smem: SUCCESS (0.084s) [614.264699] Starting dynamic subtest: lmem0 [615.001241] Dynamic subtest lmem0: SUCCESS (0.744s) [615.002470] Subtest yf-tiled-to-vebox-x-tiled: SUCCESS (0.832s) [615.234615] [067/132] (418s left) kms_chamelium_edid (hdmi-edid-change-during-suspend) [616.772740] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s) [616.895032] [068/132] (417s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc) [618.406658] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc [618.408588] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [618.511032] [069/132] (415s left) kms_pm_rpm (dpms-mode-unset-lpsp) [622.045309] Starting subtest: dpms-mode-unset-lpsp [623.028965] Subtest dpms-mode-unset-lpsp: SKIP (0.987s) [623.371673] [070/132] (410s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [623.418697] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [623.419372] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s) [624.061589] [071/132] (410s left) kms_psr (fbc-psr2-cursor-mmap-gtt) [625.547318] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s) [625.625125] [072/132] (408s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt) [627.116199] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt [627.117879] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [627.212199] [073/132] (407s left) gem_wait (await) [627.273811] Starting subtest: await [627.274641] Starting dynamic subtest: all-engines [628.394166] Dynamic subtest all-engines: SUCCESS (1.120s) [628.409975] Starting dynamic subtest: rcs0 [629.462948] Dynamic subtest rcs0: SUCCESS (1.067s) [629.479132] Starting dynamic subtest: bcs0 [630.525924] Dynamic subtest bcs0: SUCCESS (1.061s) [630.541957] Starting dynamic subtest: vcs0 [631.586937] Dynamic subtest vcs0: SUCCESS (1.059s) [631.602973] Starting dynamic subtest: vcs1 [632.645669] Dynamic subtest vcs1: SUCCESS (1.055s) [632.670216] Starting dynamic subtest: vecs0 [633.715758] Dynamic subtest vecs0: SUCCESS (1.062s) [633.719484] Subtest await: SUCCESS (6.445s) [634.011811] [074/132] (400s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt) [635.501472] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt [635.503478] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [635.596520] [075/132] (398s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [637.083432] Starting subtest: basic-flip-before-cursor-legacy [638.086255] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.003s) [638.236558] [076/132] (396s left) gem_exec_balancer (waits) [638.294442] Starting subtest: waits [646.016214] Subtest waits: SUCCESS (7.718s) [646.466969] [077/132] (388s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc) [647.952932] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc [647.953892] Starting dynamic subtest: pipe-A-HDMI-A-4 [647.962953] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s) [647.974410] Starting dynamic subtest: pipe-B-HDMI-A-4 [647.983254] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s) [647.994548] Starting dynamic subtest: pipe-C-HDMI-A-4 [648.004105] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s) [648.015035] Starting dynamic subtest: pipe-D-HDMI-A-4 [648.025483] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s) [648.027083] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.014s) [648.184062] [078/132] (386s left) kms_plane (pixel-format-linear-modifier) [649.672640] Starting subtest: pixel-format-linear-modifier [649.698956] Starting dynamic subtest: pipe-A-plane-0 [655.149586] Dynamic subtest pipe-A-plane-0: SUCCESS (5.449s) [655.193940] Starting dynamic subtest: pipe-A-plane-3 [660.314795] Dynamic subtest pipe-A-plane-3: SUCCESS (5.159s) [660.329537] Starting dynamic subtest: pipe-A-plane-5 [663.314863] Dynamic subtest pipe-A-plane-5: SUCCESS (2.998s) [663.330875] Starting dynamic subtest: pipe-A-plane-7 [663.565227] Dynamic subtest pipe-A-plane-7: SUCCESS (0.248s) [663.746168] Starting dynamic subtest: pipe-B-plane-0 [669.718929] Dynamic subtest pipe-B-plane-0: SUCCESS (5.983s) [669.735542] Starting dynamic subtest: pipe-B-plane-3 [675.002219] Dynamic subtest pipe-B-plane-3: SUCCESS (5.282s) [675.017604] Starting dynamic subtest: pipe-B-plane-5 [678.335611] Dynamic subtest pipe-B-plane-5: SUCCESS (3.332s) [678.351324] Starting dynamic subtest: pipe-B-plane-7 [678.586107] Dynamic subtest pipe-B-plane-7: SUCCESS (0.249s) [678.675473] Subtest pixel-format-linear-modifier: SUCCESS (29.003s) [678.935170] [079/132] (355s left) gem_exec_balancer (bonded-pair) [678.997483] Starting subtest: bonded-pair [678.999320] Subtest bonded-pair: SKIP (0.000s) [679.395757] [080/132] (355s left) gem_mmap_gtt (cpuset-medium-copy-odd) [679.446780] Subtest cpuset-medium-copy-odd: SKIP (0.000s) [679.526487] [081/132] (355s left) kms_addfb_basic (addfb25-modifier-no-flag) [681.013819] Starting subtest: addfb25-modifier-no-flag [681.014863] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [681.121441] [082/132] (353s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [682.613562] Starting subtest: plane-scaler-with-clipping-clamping-rotation [682.614461] Starting dynamic subtest: pipe-A [683.066996] Dynamic subtest pipe-A: SKIP (0.450s) [683.078392] Starting dynamic subtest: pipe-B [683.510235] Dynamic subtest pipe-B: SKIP (0.444s) [683.521517] Starting dynamic subtest: pipe-C [683.950151] Dynamic subtest pipe-C: SKIP (0.437s) [683.961572] Starting dynamic subtest: pipe-D [684.390640] Dynamic subtest pipe-D: SKIP (0.440s) [684.392514] Subtest plane-scaler-with-clipping-clamping-rotation: SKIP (1.777s) [684.546631] [083/132] (350s left) gem_exec_reloc (basic-write-read-active) [684.602181] Subtest basic-write-read-active: SKIP (0.000s) [684.688734] [084/132] (350s left) kms_big_fb (linear-8bpp-rotate-180) [686.192058] Starting subtest: linear-8bpp-rotate-180 [687.844841] Subtest linear-8bpp-rotate-180: SUCCESS (1.650s) [687.976445] [085/132] (347s left) syncobj_basic (bad-create-flags) [688.022558] Starting subtest: bad-create-flags [688.023411] Subtest bad-create-flags: SUCCESS (0.000s) [688.107203] [086/132] (347s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal [688.155790] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled [688.265681] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.107s) [688.343083] [087/132] (346s left) kms_prime (basic-crc-vgem) [689.852534] Subtest basic-crc-vgem: SKIP (0.000s) [689.926461] [088/132] (345s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [691.417293] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [691.419123] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [691.540403] [089/132] (343s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180) [693.056238] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180 [694.308280] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.252s) [694.654107] [090/132] (340s left) syncobj_wait (invalid-signal-zero-handles) [694.707302] Starting subtest: invalid-signal-zero-handles [694.708213] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [694.791979] [091/132] (340s left) gem_caching (reads) [694.845375] Starting subtest: reads [698.575902] Subtest reads: SUCCESS (3.730s) [698.696974] [092/132] (336s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [700.186235] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [700.271215] [093/132] (335s left) prime_vgem (busy) [700.346793] Starting subtest: busy [700.347682] Starting dynamic subtest: rcs0 [700.431553] Dynamic subtest rcs0: SUCCESS (0.084s) [700.446951] Starting dynamic subtest: bcs0 [700.486899] Dynamic subtest bcs0: SUCCESS (0.054s) [700.499795] Starting dynamic subtest: vcs0 [700.525982] Dynamic subtest vcs0: SUCCESS (0.037s) [700.540846] Starting dynamic subtest: vcs1 [700.567024] Dynamic subtest vcs1: SUCCESS (0.039s) [700.586103] Starting dynamic subtest: vecs0 [700.608723] Dynamic subtest vecs0: SUCCESS (0.040s) [700.611766] Subtest busy: SUCCESS (0.263s) [700.727888] [094/132] (335s left) kms_joiner (invalid-modeset-ultra-joiner) [702.217217] Starting subtest: invalid-modeset-ultra-joiner [702.218888] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s) [702.291097] [095/132] (333s left) syncobj_basic (bad-destroy) [702.336247] Starting subtest: bad-destroy [702.337046] Subtest bad-destroy: SUCCESS (0.000s) [702.407812] [096/132] (333s left) kms_cursor_legacy (cursora-vs-flipb-atomic) [703.892512] Starting subtest: cursorA-vs-flipB-atomic [703.894323] Subtest cursorA-vs-flipB-atomic: SKIP (0.002s) [703.974568] [097/132] (332s left) prime_self_import (basic-with_two_bos) [704.018392] Starting subtest: basic-with_two_bos [704.022544] Subtest basic-with_two_bos: SUCCESS (0.004s) [704.139027] [098/132] (331s left) gem_mmap_gtt (coherency) [704.183954] Subtest coherency: SKIP (0.000s) [704.254860] [099/132] (331s left) gem_exec_schedule (pi-common) [704.452965] Starting subtest: pi-common [704.453925] Starting dynamic subtest: rcs0 [704.484413] Dynamic subtest rcs0: SUCCESS (0.031s) [704.498183] Starting dynamic subtest: bcs0 [704.516464] Dynamic subtest bcs0: SUCCESS (0.030s) [704.530047] Starting dynamic subtest: vcs0 [704.547682] Dynamic subtest vcs0: SUCCESS (0.030s) [704.561210] Starting dynamic subtest: vcs1 [704.579643] Dynamic subtest vcs1: SUCCESS (0.030s) [704.593178] Starting dynamic subtest: vecs0 [704.611741] Dynamic subtest vecs0: SUCCESS (0.031s) [704.612728] Subtest pi-common: SUCCESS (0.160s) [704.909647] [100/132] (331s left) kms_psr (fbc-psr-cursor-render) [706.394627] Subtest fbc-psr-cursor-render: SKIP (0.000s) [706.472231] [101/132] (329s left) gem_spin_batch (legacy-resubmit-new) [706.530257] Starting subtest: legacy-resubmit-new [706.533084] Starting dynamic subtest: default [706.552636] Dynamic subtest default: SUCCESS (0.021s) [706.566531] Starting dynamic subtest: render [706.567474] Dynamic subtest render: SUCCESS (0.005s) [706.579683] Starting dynamic subtest: bsd [706.580717] Dynamic subtest bsd: SUCCESS (0.005s) [706.592824] Starting dynamic subtest: bsd1 [706.594238] Dynamic subtest bsd1: SUCCESS (0.004s) [706.606055] Starting dynamic subtest: bsd2 [706.607368] Dynamic subtest bsd2: SUCCESS (0.004s) [706.618721] Starting dynamic subtest: blt [706.619911] Dynamic subtest blt: SUCCESS (0.004s) [706.631170] Starting dynamic subtest: vebox [706.632486] Dynamic subtest vebox: SUCCESS (0.004s) [706.633783] Subtest legacy-resubmit-new: SUCCESS (0.060s) [706.846021] [102/132] (329s left) kms_psr (psr-cursor-plane-onoff) [708.330462] Subtest psr-cursor-plane-onoff: SKIP (0.000s) [708.405661] [103/132] (328s left) gem_busy (close-race) [708.465651] Starting subtest: close-race [730.459386] Subtest close-race: SUCCESS (21.994s) [731.001275] [104/132] (305s left) api_intel_allocator (simple-allocator) [731.099199] Starting subtest: simple-allocator [731.100034] Starting dynamic subtest: basic [731.116140] Dynamic subtest basic: SUCCESS (0.018s) [731.129175] Starting dynamic subtest: parallel-one [731.319733] Dynamic subtest parallel-one: SUCCESS (0.199s) [731.331149] Starting dynamic subtest: print [731.331987] Dynamic subtest print: SUCCESS (0.000s) [731.343555] Starting dynamic subtest: reuse [731.344377] Dynamic subtest reuse: SUCCESS (0.000s) [731.355933] Starting dynamic subtest: reserve [731.356856] Dynamic subtest reserve: SUCCESS (0.000s) [731.368387] Starting dynamic subtest: fork-reopen-allocator [731.369282] Dynamic subtest fork-reopen-allocator: SUCCESS (0.017s) [731.370427] Subtest simple-allocator: SUCCESS (0.243s) [731.458305] [105/132] (305s left) kms_psr (pr-dpms) [732.951661] Subtest pr-dpms: SKIP (0.000s) [733.021921] [106/132] (303s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25) [734.510065] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25 [734.511227] Starting dynamic subtest: pipe-A [734.665456] Dynamic subtest pipe-A: SUCCESS (0.156s) [734.681954] Starting dynamic subtest: pipe-B [734.824171] Dynamic subtest pipe-B: SUCCESS (0.157s) [734.837806] Starting dynamic subtest: pipe-C [734.963544] Dynamic subtest pipe-C: SUCCESS (0.138s) [734.977323] Starting dynamic subtest: pipe-D [735.104671] Dynamic subtest pipe-D: SUCCESS (0.140s) [735.105754] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.597s) [735.248378] [107/132] (301s left) gem_workarounds (basic-read) [735.326233] Starting subtest: basic-read [735.357317] Subtest basic-read: SUCCESS (0.030s) [735.461424] [108/132] (301s left) kms_async_flips (invalid-async-flip-atomic) [736.948975] Starting subtest: invalid-async-flip-atomic [737.201276] Starting dynamic subtest: pipe-A-HDMI-A-4 [737.633731] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.432s) [737.817510] Starting dynamic subtest: pipe-B-HDMI-A-4 [737.905836] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.099s) [738.083418] Starting dynamic subtest: pipe-C-HDMI-A-4 [738.175752] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.103s) [738.363202] Starting dynamic subtest: pipe-D-HDMI-A-4 [738.462588] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.110s) [738.463590] Subtest invalid-async-flip-atomic: SUCCESS (1.516s) [738.778946] [109/132] (298s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu) [740.271809] Starting subtest: fbc-rgb101010-draw-mmap-cpu [743.194489] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.922s) [743.312862] [110/132] (293s left) gem_eio (in-flight-contexts-1us) [743.501996] Starting subtest: in-flight-contexts-1us [756.859545] Subtest in-flight-contexts-1us: SUCCESS (13.359s) [758.466828] [111/132] (278s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs) [759.953609] Starting subtest: missing-ccs-buffer-y-tiled-ccs [759.954553] Starting dynamic subtest: pipe-A-HDMI-A-4 [759.963162] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s) [759.975963] Starting dynamic subtest: pipe-B-HDMI-A-4 [759.984908] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s) [759.997392] Starting dynamic subtest: pipe-C-HDMI-A-4 [760.006609] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s) [760.018808] Starting dynamic subtest: pipe-D-HDMI-A-4 [760.028132] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s) [760.029867] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.011s) [760.313185] [112/132] (276s left) gem_exec_schedule (fifo) [760.378456] Starting subtest: fifo [760.379281] Starting dynamic subtest: rcs0 [760.565715] Dynamic subtest rcs0: SUCCESS (0.183s) [760.577804] Starting dynamic subtest: bcs0 [760.692637] Dynamic subtest bcs0: SUCCESS (0.128s) [760.706154] Starting dynamic subtest: vcs0 [760.826885] Dynamic subtest vcs0: SUCCESS (0.133s) [760.840923] Starting dynamic subtest: vcs1 [760.972510] Dynamic subtest vcs1: SUCCESS (0.144s) [760.986519] Starting dynamic subtest: vecs0 [761.118171] Dynamic subtest vecs0: SUCCESS (0.144s) [761.119060] Subtest fifo: SUCCESS (0.740s) [761.512703] [113/132] (275s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt) [763.004303] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt [763.006185] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [763.094807] [114/132] (274s left) gem_exec_flush (basic-wb-ro-before-default) [763.146410] Subtest basic-wb-ro-before-default: SKIP (0.000s) [763.259090] [115/132] (274s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [764.745354] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [764.747815] Starting dynamic subtest: pipe-A-valid-mode [765.548037] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.801s) [765.549326] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SUCCESS (0.804s) [765.700876] [116/132] (271s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [767.191830] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [767.193708] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [767.282106] [117/132] (270s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf) [768.772029] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s) [768.845400] [118/132] (268s left) kms_big_fb (y-tiled-64bpp-rotate-180) [770.351555] Starting subtest: y-tiled-64bpp-rotate-180 [773.034530] Subtest y-tiled-64bpp-rotate-180: SUCCESS (2.680s) [773.210593] [119/132] (264s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [774.732045] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip [774.734250] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [774.835289] [120/132] (262s left) gen9_exec_parse (allowed-all) [774.891405] Subtest allowed-all: SKIP (0.000s) [774.963265] [121/132] (262s left) kms_getfb (getfb-reject-nv12) [776.449630] Starting subtest: getfb-reject-nv12 [776.450927] Subtest getfb-reject-nv12: SUCCESS (0.002s) [776.550523] [122/132] (261s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [778.090990] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [778.203232] [123/132] (259s left) drm_buddy (drm_buddy) [778.248710] Starting subtest: drm_buddy [778.250276] Subtest drm_buddy: SKIP (0.001s) [778.318858] [124/132] (259s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled) [778.365324] Starting subtest: invalid-multi-wait-unsubmitted-signaled [778.366135] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s) [778.438355] [125/132] (259s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible) [779.928328] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible [779.946773] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.018s) [780.035303] [126/132] (258s left) i915_hangman (engine-engine-hang) [780.096889] Starting subtest: engine-engine-hang [780.097862] Starting dynamic subtest: rcs0 [780.799590] Dynamic subtest rcs0: SUCCESS (0.702s) [780.814939] Starting dynamic subtest: bcs0 [781.468450] Dynamic subtest bcs0: SUCCESS (0.667s) [781.483742] Starting dynamic subtest: vcs0 [782.136456] Dynamic subtest vcs0: SUCCESS (0.666s) [782.156927] Starting dynamic subtest: vcs1 [782.809449] Dynamic subtest vcs1: SUCCESS (0.671s) [782.825176] Starting dynamic subtest: vecs0 [783.481367] Dynamic subtest vecs0: SUCCESS (0.670s) [783.482404] Subtest engine-engine-hang: SUCCESS (3.385s) [783.595967] [127/132] (254s left) gem_mmap_gtt (basic-wc) [783.643862] Subtest basic-wc: SKIP (0.000s) [783.717996] [128/132] (254s left) fbdev (info) [783.760793] Starting subtest: info [783.761589] Subtest info: SUCCESS (0.000s) [783.845341] [129/132] (254s left) gem_ctx_shared (q-promotion) [783.903604] Starting subtest: Q-promotion [783.904432] Starting dynamic subtest: rcs0 [784.101457] Dynamic subtest rcs0: SUCCESS (0.194s) [784.114161] Starting dynamic subtest: bcs0 [784.239513] Dynamic subtest bcs0: SUCCESS (0.137s) [784.252348] Starting dynamic subtest: vcs0 [784.368783] Dynamic subtest vcs0: SUCCESS (0.128s) [784.381530] Starting dynamic subtest: vcs1 [784.508939] Dynamic subtest vcs1: SUCCESS (0.139s) [784.521672] Starting dynamic subtest: vecs0 [784.650226] Dynamic subtest vecs0: SUCCESS (0.140s) [784.650976] Subtest Q-promotion: SUCCESS (0.744s) [784.924780] [130/132] (253s left) kms_sequence (queue-busy) [786.411130] Starting subtest: queue-busy [786.412176] Starting dynamic subtest: pipe-A-HDMI-A-4 [789.011155] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.599s) [789.025989] Starting dynamic subtest: pipe-B-HDMI-A-4 [791.426606] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.410s) [791.439401] Starting dynamic subtest: pipe-C-HDMI-A-4 [793.857938] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.432s) [793.872793] Starting dynamic subtest: pipe-D-HDMI-A-4 [796.283120] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.423s) [796.284134] Subtest queue-busy: SUCCESS (9.874s) [796.432710] [131/132] (242s left) syncobj_timeline (single-wait-all-available-submitted) [796.479879] Starting subtest: single-wait-all-available-submitted [796.480909] Subtest single-wait-all-available-submitted: SUCCESS (0.000s) [796.565299] [132/132] (242s left) kms_vblank (ts-continuation-modeset-hang) [798.070291] Starting subtest: ts-continuation-modeset-hang [798.072753] Starting dynamic subtest: pipe-A-HDMI-A-4 [824.488212] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (26.415s) [824.504894] Starting dynamic subtest: pipe-D-HDMI-A-4 [849.488591] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (24.995s) [849.490926] Subtest ts-continuation-modeset-hang: SUCCESS (51.420s) [849.649740] Closing watchdogs results: parsing output: 0/ for test: kms_psr results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_ccs results: parsing output: 4/ for test: kms_cursor_crc results: parsing output: 5/ for test: gem_exec_schedule results: parsing output: 6/ for test: gem_exec_whisper results: parsing output: 7/ for test: kms_big_fb results: parsing output: 8/ for test: i915_pm_rc6_residency results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: gem_lmem_swapping results: parsing output: 11/ for test: kms_pipe_b_c_ivb results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_cursor_legacy results: parsing output: 14/ for test: perf_pmu results: parsing output: 15/ for test: kms_psr results: parsing output: 16/ for test: prime_mmap results: parsing output: 17/ for test: gem_mmap_wc results: parsing output: 18/ for test: kms_lease results: parsing output: 19/ for test: i915_selftest results: parsing output: 20/ for test: kms_ccs results: parsing output: 21/ for test: gem_ppgtt results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: syncobj_timeline results: parsing output: 24/ for test: syncobj_wait results: parsing output: 25/ for test: gem_exec_flush results: parsing output: 26/ for test: perf_pmu results: parsing output: 27/ for test: kms_async_flips results: parsing output: 28/ for test: kms_dsc results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: kms_flip results: parsing output: 31/ for test: kms_flip results: parsing output: 32/ for test: kms_cursor_crc results: parsing output: 33/ for test: kms_big_fb results: parsing output: 34/ for test: gem_render_copy results: parsing output: 35/ for test: gem_ctx_persistence results: parsing output: 36/ for test: syncobj_timeline results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_cursor_legacy results: parsing output: 39/ for test: api_intel_bb results: parsing output: 40/ for test: gem_mmap_gtt results: parsing output: 41/ for test: gem_mmap results: parsing output: 42/ for test: gem_exec_fence results: parsing output: 43/ for test: kms_ccs results: parsing output: 44/ for test: gem_wait results: parsing output: 45/ for test: kms_cursor_crc results: parsing output: 46/ for test: gem_ctx_engines results: parsing output: 47/ for test: kms_content_protection results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: syncobj_wait results: parsing output: 51/ for test: perf_pmu results: parsing output: 52/ for test: vgem_slow results: parsing output: 53/ for test: i915_drm_fdinfo results: parsing output: 54/ for test: perf results: parsing output: 55/ for test: kms_color results: parsing output: 56/ for test: kms_plane_alpha_blend results: parsing output: 57/ for test: sysfs_preempt_timeout results: parsing output: 58/ for test: kms_flip_scaled_crc results: parsing output: 59/ for test: kms_big_fb results: parsing output: 60/ for test: gem_workarounds results: parsing output: 61/ for test: syncobj_wait results: parsing output: 62/ for test: gem_ctx_persistence results: parsing output: 63/ for test: kms_plane_multiple results: parsing output: 64/ for test: kms_flip results: parsing output: 65/ for test: gem_render_copy results: parsing output: 66/ for test: kms_chamelium_edid results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: kms_pm_rpm results: parsing output: 69/ for test: syncobj_timeline results: parsing output: 70/ for test: kms_psr results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: gem_wait results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_cursor_legacy results: parsing output: 75/ for test: gem_exec_balancer results: parsing output: 76/ for test: kms_ccs results: parsing output: 77/ for test: kms_plane results: parsing output: 78/ for test: gem_exec_balancer results: parsing output: 79/ for test: gem_mmap_gtt results: parsing output: 80/ for test: kms_addfb_basic results: parsing output: 81/ for test: kms_plane_scaling results: parsing output: 82/ for test: gem_exec_reloc results: parsing output: 83/ for test: kms_big_fb results: parsing output: 84/ for test: syncobj_basic results: parsing output: 85/ for test: syncobj_timeline results: parsing output: 86/ for test: kms_prime results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_big_fb results: parsing output: 89/ for test: syncobj_wait results: parsing output: 90/ for test: gem_caching results: parsing output: 91/ for test: kms_psr2_sf results: parsing output: 92/ for test: prime_vgem results: parsing output: 93/ for test: kms_joiner results: parsing output: 94/ for test: syncobj_basic results: parsing output: 95/ for test: kms_cursor_legacy results: parsing output: 96/ for test: prime_self_import results: parsing output: 97/ for test: gem_mmap_gtt results: parsing output: 98/ for test: gem_exec_schedule results: parsing output: 99/ for test: kms_psr results: parsing output: 100/ for test: gem_spin_batch results: parsing output: 101/ for test: kms_psr results: parsing output: 102/ for test: gem_busy results: parsing output: 103/ for test: api_intel_allocator results: parsing output: 104/ for test: kms_psr results: parsing output: 105/ for test: kms_plane_scaling results: parsing output: 106/ for test: gem_workarounds results: parsing output: 107/ for test: kms_async_flips results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: gem_eio results: parsing output: 110/ for test: kms_ccs results: parsing output: 111/ for test: gem_exec_schedule results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: gem_exec_flush results: parsing output: 114/ for test: kms_flip_scaled_crc results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_psr2_sf results: parsing output: 117/ for test: kms_big_fb results: parsing output: 118/ for test: kms_big_fb results: parsing output: 119/ for test: gen9_exec_parse results: parsing output: 120/ for test: kms_getfb results: parsing output: 121/ for test: kms_chamelium_hpd results: parsing output: 122/ for test: drm_buddy results: parsing output: 123/ for test: syncobj_wait results: parsing output: 124/ for test: kms_flip results: parsing output: 125/ for test: i915_hangman results: parsing output: 126/ for test: gem_mmap_gtt results: parsing output: 127/ for test: fbdev results: parsing output: 128/ for test: gem_ctx_shared results: parsing output: 129/ for test: kms_sequence results: parsing output: 130/ for test: syncobj_timeline results: parsing output: 131/ for test: kms_vblank Done.