[106.287582] Initializing watchdogs [106.287766] /dev/watchdog0 [106.327753] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600] [106.342837] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [106.350442] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [106.355812] [001/133] (960s left) kms_fbcon_fbt (psr) [106.481219] Starting subtest: psr [106.485689] Subtest psr: SKIP (0.001s) [106.707501] [002/133] (960s left) syncobj_timeline (invalid-signal-illegal-point) [106.814112] Starting subtest: invalid-signal-illegal-point [106.817374] Subtest invalid-signal-illegal-point: SUCCESS (0.000s) [106.944756] [003/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt) [107.138583] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt [110.294421] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (3.152s) [110.602396] [004/133] (956s left) i915_query (query-garbage) [110.704829] Starting subtest: query-garbage [110.706828] Subtest query-garbage: SUCCESS (0.000s) [110.874984] [005/133] (956s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt) [111.081169] Starting subtest: fbc-rgb101010-draw-blt [114.111455] Subtest fbc-rgb101010-draw-blt: SUCCESS (3.028s) [114.358054] [006/133] (952s left) i915_drm_fdinfo (all-busy-check-all) [114.474245] Starting subtest: all-busy-check-all [115.000140] Subtest all-busy-check-all: SUCCESS (0.525s) [115.126307] [007/133] (952s left) kms_psr (fbc-psr-no-drrs) [115.304319] Subtest fbc-psr-no-drrs: SKIP (0.000s) [115.396313] [008/133] (952s left) api_intel_bb (blit-reloc-purge-cache) [115.500245] Starting subtest: blit-reloc-purge-cache [115.519249] Subtest blit-reloc-purge-cache: SUCCESS (0.022s) [115.660288] [009/133] (951s left) gem_eio (wait-1us) [115.787192] Starting subtest: wait-1us [115.888706] Subtest wait-1us: SUCCESS (0.107s) [116.126189] [010/133] (951s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [116.326229] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [116.331890] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [116.458071] [011/133] (951s left) gem_tiled_partial_pwrite_pread (reads) [116.575832] Starting subtest: reads [117.930388] Subtest reads: SUCCESS (1.353s) [118.079370] [012/133] (949s left) gem_exec_parallel (contexts) [118.208224] Starting subtest: contexts [118.210066] Starting dynamic subtest: rcs0 [122.393076] Dynamic subtest rcs0: SUCCESS (4.187s) [122.412269] Starting dynamic subtest: bcs0 [126.872562] Dynamic subtest bcs0: SUCCESS (4.477s) [126.891803] Starting dynamic subtest: vcs0 [131.940933] Dynamic subtest vcs0: SUCCESS (5.069s) [131.964266] Starting dynamic subtest: vecs0 [136.187661] Dynamic subtest vecs0: SUCCESS (4.243s) [136.190248] Subtest contexts: SUCCESS (17.982s) [136.450493] [013/133] (931s left) kms_big_fb (yf-tiled-8bpp-rotate-0) [136.645563] Starting subtest: yf-tiled-8bpp-rotate-0 [136.650126] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s) [136.780096] [014/133] (931s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [136.989835] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [139.098049] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SUCCESS (2.105s) [139.299314] [015/133] (928s left) gem_exec_parallel (basic) [139.424180] Starting subtest: basic [139.426139] Starting dynamic subtest: rcs0 [142.546880] Dynamic subtest rcs0: SUCCESS (3.125s) [142.567409] Starting dynamic subtest: bcs0 [145.857403] Dynamic subtest bcs0: SUCCESS (3.304s) [145.879081] Starting dynamic subtest: vcs0 [149.000635] Dynamic subtest vcs0: SUCCESS (3.147s) [149.020757] Starting dynamic subtest: vecs0 [152.168384] Dynamic subtest vecs0: SUCCESS (3.167s) [152.170293] Subtest basic: SUCCESS (12.747s) [152.427408] [016/133] (915s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render) [152.616339] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render [152.619649] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [152.763806] [017/133] (915s left) gen9_exec_parse (batch-without-end) [152.885898] Starting subtest: batch-without-end [152.890209] Subtest batch-without-end: SUCCESS (0.004s) [153.160397] [018/133] (915s left) gem_exec_fence (long-history) [153.832844] Starting subtest: long-history [159.554665] Subtest long-history: SUCCESS (5.693s) [160.229890] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true [160.234911] [019/133] (908s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled) [160.349479] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled [160.352761] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [160.622078] [020/133] (907s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [160.813755] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [160.818111] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [160.987179] [021/133] (907s left) gem_linear_blits (interruptible) [161.656023] Starting subtest: interruptible [177.052557] Subtest interruptible: SUCCESS (15.397s) [177.199320] [022/133] (891s left) gem_mmap_gtt (basic-wc) [177.439049] Starting subtest: basic-wc [178.066614] Subtest basic-wc: SUCCESS (0.632s) [178.228099] [023/133] (890s left) kms_addfb_basic (invalid-set-prop-any) [178.332127] Starting subtest: invalid-set-prop-any [178.335912] Subtest invalid-set-prop-any: SUCCESS (0.000s) [178.573867] [024/133] (890s left) syncobj_eventfd (timeline-wait-before-signal) [178.696462] Starting subtest: timeline-wait-before-signal [178.735296] Subtest timeline-wait-before-signal: SUCCESS (0.036s) [178.877467] [025/133] (890s left) gem_mmap_offset (oob-read) [178.981083] Starting subtest: oob-read [178.984135] Subtest oob-read: SUCCESS (0.002s) [179.140157] [026/133] (889s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling) [179.331441] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling [179.337494] Starting dynamic subtest: pipe-A-valid-mode [180.383912] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.054s) [180.386226] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SUCCESS (1.058s) [180.791758] [027/133] (888s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs) [180.970170] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs [180.972072] Starting dynamic subtest: pipe-A-HDMI-A-1 [180.996627] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [181.044805] Starting dynamic subtest: pipe-A-HDMI-A-2 [181.086260] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s) [181.114192] Starting dynamic subtest: pipe-B-HDMI-A-1 [181.130935] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [181.152406] Starting dynamic subtest: pipe-B-HDMI-A-2 [181.167949] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s) [181.189833] Starting dynamic subtest: pipe-C-HDMI-A-1 [181.204911] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [181.226136] Starting dynamic subtest: pipe-C-HDMI-A-2 [181.240940] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s) [181.243954] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.018s) [181.923892] [028/133] (887s left) perf (gen12-group-exclusive-stream-ctx-handle) [182.170749] Starting subtest: gen12-group-exclusive-stream-ctx-handle [182.175451] Subtest gen12-group-exclusive-stream-ctx-handle: SKIP (0.000s) [182.275974] [029/133] (887s left) kms_plane_multiple (tiling-4) [182.457177] Starting subtest: tiling-4 [182.462277] Subtest tiling-4: SKIP (0.000s) [182.612943] [030/133] (886s left) gem_userptr_blits (sync-unmap-cycles) [182.749152] Starting subtest: sync-unmap-cycles [188.128794] Subtest sync-unmap-cycles: SUCCESS (5.378s) [188.312477] [031/133] (881s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [188.508406] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [188.513219] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [188.660956] [032/133] (881s left) gem_exec_params (invalid-bsd2-flag-on-render) [188.775607] Starting subtest: invalid-bsd2-flag-on-render [188.777875] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.001s) [188.925574] [033/133] (880s left) gem_mmap_gtt (cpuset-big-copy-odd) [189.029086] Starting subtest: cpuset-big-copy-odd [207.123137] Subtest cpuset-big-copy-odd: SUCCESS (18.088s) [207.312588] [034/133] (862s left) gem_ctx_persistence (heartbeat-many) [207.563752] Starting subtest: heartbeat-many [208.056210] Subtest heartbeat-many: SUCCESS (0.493s) [208.242890] [035/133] (861s left) kms_flip (absolute-wf_vblank) [208.442228] Starting subtest: absolute-wf_vblank [208.445115] Starting dynamic subtest: A-HDMI-A1 [214.330686] Dynamic subtest A-HDMI-A1: SUCCESS (5.888s) [214.354836] Starting dynamic subtest: B-HDMI-A1 [219.923177] Dynamic subtest B-HDMI-A1: SUCCESS (5.585s) [219.944715] Starting dynamic subtest: C-HDMI-A1 [225.307307] Dynamic subtest C-HDMI-A1: SUCCESS (5.382s) [225.329938] Starting dynamic subtest: A-HDMI-A2 [230.727214] Dynamic subtest A-HDMI-A2: SUCCESS (5.419s) [230.757763] Starting dynamic subtest: B-HDMI-A2 [236.127754] Dynamic subtest B-HDMI-A2: SUCCESS (5.397s) [236.151692] Starting dynamic subtest: C-HDMI-A2 [241.538195] Dynamic subtest C-HDMI-A2: SUCCESS (5.405s) [241.541108] Subtest absolute-wf_vblank: SUCCESS (33.099s) [242.031801] [036/133] (828s left) syncobj_timeline (wait-all-complex) [242.155500] Starting subtest: wait-all-complex [242.378138] Subtest wait-all-complex: SUCCESS (0.224s) [242.532378] [037/133] (827s left) perf_pmu (render-node-busy-idle) [242.658272] Starting subtest: render-node-busy-idle [242.661131] Starting dynamic subtest: rcs0 [243.285146] Dynamic subtest rcs0: SUCCESS (0.625s) [243.307919] Starting dynamic subtest: bcs0 [243.913513] Dynamic subtest bcs0: SUCCESS (0.628s) [243.939621] Starting dynamic subtest: vcs0 [244.546081] Dynamic subtest vcs0: SUCCESS (0.633s) [244.569482] Starting dynamic subtest: vecs0 [245.170955] Dynamic subtest vecs0: SUCCESS (0.624s) [245.173577] Subtest render-node-busy-idle: SUCCESS (2.514s) [245.315973] [038/133] (824s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [245.506066] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [245.618487] [039/133] (824s left) kms_big_fb (y-tiled-64bpp-rotate-90) [245.833111] Starting subtest: y-tiled-64bpp-rotate-90 [246.162415] Subtest y-tiled-64bpp-rotate-90: SKIP (0.327s) [246.413862] [040/133] (824s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render) [246.627436] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render [246.630660] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [246.780070] [041/133] (823s left) kms_flip (flip-vs-blocking-wf-vblank) [246.966896] Starting subtest: flip-vs-blocking-wf-vblank [246.969219] Starting dynamic subtest: A-HDMI-A1 [252.948872] Dynamic subtest A-HDMI-A1: SUCCESS (5.980s) [252.976047] Starting dynamic subtest: B-HDMI-A1 [258.652916] Dynamic subtest B-HDMI-A1: SUCCESS (5.697s) [258.678726] Starting dynamic subtest: C-HDMI-A1 [264.363825] Dynamic subtest C-HDMI-A1: SUCCESS (5.709s) [264.387768] Starting dynamic subtest: A-HDMI-A2 [270.078976] Dynamic subtest A-HDMI-A2: SUCCESS (5.711s) [270.106719] Starting dynamic subtest: B-HDMI-A2 [275.756860] Dynamic subtest B-HDMI-A2: SUCCESS (5.674s) [275.782264] Starting dynamic subtest: C-HDMI-A2 [281.450207] Dynamic subtest C-HDMI-A2: SUCCESS (5.686s) [281.455094] Subtest flip-vs-blocking-wf-vblank: SUCCESS (34.481s) [281.960534] [042/133] (788s left) syncobj_basic (create-signaled) [282.065976] Starting subtest: create-signaled [282.067624] Subtest create-signaled: SUCCESS (0.000s) [282.246812] [043/133] (788s left) kms_plane_alpha_blend (alpha-basic) [282.438087] Starting subtest: alpha-basic [282.643687] Starting dynamic subtest: pipe-A-HDMI-A-1 [284.043582] Dynamic subtest pipe-A-HDMI-A-1: FAIL (0.616s) [284.070424] Starting dynamic subtest: pipe-C-HDMI-A-1 [284.736402] Dynamic subtest pipe-C-HDMI-A-1: FAIL (0.828s) [284.737984] Subtest alpha-basic: FAIL (1.770s) [284.837141] [044/133] (786s left) kms_cursor_crc (cursor-offscreen-512x512) [285.056703] Starting subtest: cursor-offscreen-512x512 [285.062242] Subtest cursor-offscreen-512x512: SKIP (0.004s) [285.235631] [045/133] (785s left) gem_exec_whisper (basic-normal) [285.373157] Starting subtest: basic-normal [290.072241] Subtest basic-normal: SUCCESS (4.699s) [290.325419] [046/133] (780s left) kms_psr (fbc-pr-cursor-render) [290.504544] Subtest fbc-pr-cursor-render: SKIP (0.000s) [290.615673] [047/133] (780s left) kms_frontbuffer_tracking (fbcpsr-suspend) [290.830109] Starting subtest: fbcpsr-suspend [290.833984] Subtest fbcpsr-suspend: SKIP (0.000s) [290.989470] [048/133] (780s left) syncobj_wait (invalid-reset-bad-pad) [291.100210] Starting subtest: invalid-reset-bad-pad [291.103109] Subtest invalid-reset-bad-pad: SUCCESS (0.000s) [291.299597] [049/133] (780s left) gem_exec_schedule (pi-distinct-iova) [291.563337] Starting subtest: pi-distinct-iova [291.567201] Starting dynamic subtest: rcs0 [291.618227] Dynamic subtest rcs0: SUCCESS (0.057s) [291.653989] Starting dynamic subtest: bcs0 [291.698988] Dynamic subtest bcs0: SUCCESS (0.074s) [291.725709] Starting dynamic subtest: vcs0 [291.770088] Dynamic subtest vcs0: SUCCESS (0.065s) [291.794626] Starting dynamic subtest: vecs0 [291.836350] Dynamic subtest vecs0: SUCCESS (0.064s) [291.840230] Subtest pi-distinct-iova: SUCCESS (0.273s) [292.109087] [050/133] (779s left) kms_color (invalid-degamma-lut-sizes) [292.288543] Starting subtest: invalid-degamma-lut-sizes [292.293415] Starting dynamic subtest: pipe-A [292.666289] Dynamic subtest pipe-A: SUCCESS (0.381s) [292.719579] Starting dynamic subtest: pipe-B [292.722387] Dynamic subtest pipe-B: SUCCESS (0.003s) [292.774404] Starting dynamic subtest: pipe-C [292.777274] Dynamic subtest pipe-C: SUCCESS (0.005s) [292.780078] Subtest invalid-degamma-lut-sizes: SUCCESS (0.395s) [293.058690] [051/133] (778s left) gem_pxp (create-regular-context-2) [295.709179] Starting subtest: create-regular-context-2 [295.714230] Subtest create-regular-context-2: SKIP (0.000s) [295.861471] [052/133] (775s left) gem_eio (wait-wedge-immediate) [295.997933] Starting subtest: wait-wedge-immediate [296.089766] Subtest wait-wedge-immediate: SUCCESS (0.097s) [296.368981] [053/133] (775s left) perf (non-sampling-read-error) [296.657319] Starting subtest: non-sampling-read-error [296.678453] Subtest non-sampling-read-error: SUCCESS (0.022s) [296.798618] [054/133] (775s left) i915_pm_freq_api (freq-basic-api) [296.912328] Subtest freq-basic-api: SKIP (0.000s) [297.032935] [055/133] (774s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [297.223097] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [297.228082] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [297.375300] [056/133] (774s left) gem_ctx_engines (invalid-engines) [297.505757] Starting subtest: invalid-engines [297.523473] Subtest invalid-engines: SUCCESS (0.017s) [297.791405] [057/133] (774s left) syncobj_timeline (multi-wait-all-signaled) [297.891838] Starting subtest: multi-wait-all-signaled [297.896053] Subtest multi-wait-all-signaled: SUCCESS (0.003s) [298.042609] [058/133] (774s left) kms_busy (extended-pageflip-hang-oldfb) [298.238222] Starting subtest: extended-pageflip-hang-oldfb [298.243114] Starting dynamic subtest: pipe-A [298.792238] Dynamic subtest pipe-A: SUCCESS (0.550s) [298.840058] Starting dynamic subtest: pipe-C [299.222626] Dynamic subtest pipe-C: SUCCESS (0.421s) [299.233573] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.995s) [299.617038] [059/133] (772s left) kms_chamelium_hpd (common-hpd-after-suspend) [300.249134] Subtest common-hpd-after-suspend: SKIP (0.000s) [300.531573] [060/133] (771s left) syncobj_timeline (etime-single-wait-submitted) [300.641209] Starting subtest: etime-single-wait-submitted [300.746135] Subtest etime-single-wait-submitted: SUCCESS (0.104s) [300.892674] [061/133] (771s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [301.080109] Starting subtest: plane-downscale-factor-0-5-with-rotation [301.082273] Starting dynamic subtest: pipe-A [307.650613] Dynamic subtest pipe-A: SKIP (6.565s) [307.697406] Starting dynamic subtest: pipe-B [313.425096] Dynamic subtest pipe-B: SKIP (5.773s) [313.471346] Starting dynamic subtest: pipe-C [318.036225] Dynamic subtest pipe-C: SKIP (4.600s) [318.043151] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (16.947s) [318.553829] [062/133] (754s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling) [318.789068] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling [318.791061] Starting dynamic subtest: pipe-A-valid-mode [319.441260] Dynamic subtest pipe-A-valid-mode: SKIP (0.652s) [319.446470] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.658s) [319.979097] [063/133] (752s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render) [320.210320] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render [320.214768] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [320.367841] [064/133] (752s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size) [320.571113] Starting subtest: basic-busy-flip-before-cursor-varying-size [320.574982] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s) [320.728853] [065/133] (752s left) gem_ctx_isolation (preservation-reset) [320.973121] Starting subtest: preservation-reset [320.982975] Starting dynamic subtest: rcs0 [321.425481] Dynamic subtest rcs0: SUCCESS (0.448s) [321.475061] Starting dynamic subtest: bcs0 [322.137115] Dynamic subtest bcs0: SUCCESS (0.704s) [322.185203] Starting dynamic subtest: vcs0 [322.544681] Dynamic subtest vcs0: SUCCESS (0.406s) [322.601082] Starting dynamic subtest: vecs0 [322.958730] Dynamic subtest vecs0: SUCCESS (0.408s) [322.966319] Subtest preservation-reset: SUCCESS (1.989s) [323.128882] [066/133] (750s left) syncobj_wait (reset-during-wait-for-submit) [323.235701] Starting subtest: reset-during-wait-for-submit [323.340076] Subtest reset-during-wait-for-submit: SUCCESS (0.104s) [323.499213] [067/133] (749s left) gem_exec_whisper (basic-queues-forked-all) [323.642082] Starting subtest: basic-queues-forked-all [335.195122] Subtest basic-queues-forked-all: SUCCESS (11.553s) [335.504277] [068/133] (737s left) kms_selftest (drm_plane_helper) [335.640049] Starting subtest: drm_plane_helper [335.669052] Starting dynamic subtest: drm_test_check_plane_state [335.760804] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.091s) [335.823589] Starting dynamic subtest: drm_test_check_invalid_plane_state [335.842472] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.054s) [335.846274] Subtest drm_plane_helper: SUCCESS (0.205s) [336.180876] [069/133] (737s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite) [336.438968] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite [336.446154] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [336.602947] [070/133] (737s left) kms_flip (dpms-vs-vblank-race-interruptible) [336.817436] Starting subtest: dpms-vs-vblank-race-interruptible [336.825235] Starting dynamic subtest: A-HDMI-A1 [339.763382] Dynamic subtest A-HDMI-A1: SUCCESS (2.934s) [339.816263] Starting dynamic subtest: B-HDMI-A1 [342.092401] Dynamic subtest B-HDMI-A1: SUCCESS (2.321s) [342.141397] Starting dynamic subtest: C-HDMI-A1 [344.482077] Dynamic subtest C-HDMI-A1: SUCCESS (2.384s) [344.540076] Starting dynamic subtest: A-HDMI-A2 [346.944098] Dynamic subtest A-HDMI-A2: SUCCESS (2.453s) [346.990055] Starting dynamic subtest: B-HDMI-A2 [349.273181] Dynamic subtest B-HDMI-A2: SUCCESS (2.318s) [349.299243] Starting dynamic subtest: C-HDMI-A2 [351.630018] Dynamic subtest C-HDMI-A2: SUCCESS (2.354s) [351.632073] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (14.813s) [352.048866] [071/133] (721s left) gem_exec_balancer (full-pulse) [352.194365] Starting subtest: full-pulse [356.795290] Subtest full-pulse: SUCCESS (4.602s) [357.085278] [072/133] (716s left) kms_lease (invalid-create-leases) [357.287477] Starting subtest: invalid-create-leases [357.321110] Subtest invalid-create-leases: SUCCESS (0.034s) [357.468304] [073/133] (716s left) kms_cursor_crc (cursor-random-64x21) [357.678112] Starting subtest: cursor-random-64x21 [357.753927] Starting dynamic subtest: pipe-A-HDMI-A-1 [361.957151] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.200s) [362.116486] Starting dynamic subtest: pipe-C-HDMI-A-1 [365.962826] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.898s) [365.964769] Subtest cursor-random-64x21: SUCCESS (8.288s) [366.297890] [074/133] (707s left) kms_cursor_legacy (cursorb-vs-flipa-legacy) [366.503683] Starting subtest: cursorB-vs-flipA-legacy [377.898195] Subtest cursorB-vs-flipA-legacy: SUCCESS (11.390s) [378.240557] [075/133] (695s left) i915_pm_rpm (debugfs-read) [380.186498] Starting subtest: debugfs-read [380.332783] Subtest debugfs-read: SUCCESS (0.138s) [380.747904] [076/133] (693s left) gem_eio (create-ext) [380.882336] Starting subtest: create-ext [380.951611] Subtest create-ext: SUCCESS (0.068s) [381.213918] [077/133] (693s left) gem_render_copy_redux (flink) [381.338163] Starting subtest: flink [384.202566] Subtest flink: SUCCESS (2.866s) [384.367202] [078/133] (690s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic) [384.549682] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic [388.346991] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (3.794s) [388.702698] [079/133] (685s left) prime_busy (after) [388.831051] Starting subtest: after [388.841084] Starting dynamic subtest: rcs0 [388.855471] Dynamic subtest rcs0: SUCCESS (0.013s) [388.911386] Starting dynamic subtest: bcs0 [388.914184] Dynamic subtest bcs0: SUCCESS (0.020s) [388.946745] Starting dynamic subtest: vcs0 [388.948302] Dynamic subtest vcs0: SUCCESS (0.020s) [388.973140] Starting dynamic subtest: vecs0 [388.974783] Dynamic subtest vecs0: SUCCESS (0.015s) [389.043175] Subtest after: SUCCESS (0.216s) [389.218115] [080/133] (685s left) gem_fenced_exec_thrash (no-spare-fences) [389.339101] Starting subtest: no-spare-fences [391.525013] Subtest no-spare-fences: SUCCESS (2.170s) [391.669795] [081/133] (683s left) gem_pxp (protected-raw-src-copy-not-readible) [394.320175] Starting subtest: protected-raw-src-copy-not-readible [394.323579] Subtest protected-raw-src-copy-not-readible: SKIP (0.000s) [394.471405] [082/133] (680s left) syncobj_timeline (wait-for-submit-snapshot) [394.582356] Starting subtest: wait-for-submit-snapshot [394.666673] Subtest wait-for-submit-snapshot: SUCCESS (0.086s) [394.820680] [083/133] (680s left) gem_spin_batch (resubmit) [394.952758] Starting subtest: resubmit [394.956561] Starting dynamic subtest: rcs0 [394.958719] Dynamic subtest rcs0: SUCCESS (0.007s) [394.999597] Starting dynamic subtest: bcs0 [395.002526] Dynamic subtest bcs0: SUCCESS (0.007s) [395.027178] Starting dynamic subtest: vcs0 [395.029156] Dynamic subtest vcs0: SUCCESS (0.005s) [395.053472] Starting dynamic subtest: vecs0 [395.056131] Dynamic subtest vecs0: SUCCESS (0.005s) [395.058226] Subtest resubmit: SUCCESS (0.037s) [395.285171] [084/133] (679s left) kms_invalid_mode (zero-hdisplay) [395.472174] Starting subtest: zero-hdisplay [395.474481] Starting dynamic subtest: pipe-A-HDMI-A-1 [395.936495] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.460s) [395.970865] Starting dynamic subtest: pipe-A-HDMI-A-2 [395.972486] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.004s) [395.998898] Starting dynamic subtest: pipe-B-HDMI-A-1 [396.003394] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.004s) [396.034769] Starting dynamic subtest: pipe-B-HDMI-A-2 [396.039516] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.004s) [396.090564] Starting dynamic subtest: pipe-C-HDMI-A-1 [396.093410] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.002s) [396.147347] Starting dynamic subtest: pipe-C-HDMI-A-2 [396.150424] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.005s) [396.153616] Subtest zero-hdisplay: SUCCESS (0.533s) [396.469195] [085/133] (678s left) i915_selftest (mock) [398.057197] Starting subtest: mock [398.059117] Starting dynamic subtest: sanitycheck [399.873205] Dynamic subtest sanitycheck: SUCCESS (1.812s) [399.897273] Starting dynamic subtest: shmem [401.566422] Dynamic subtest shmem: SUCCESS (1.688s) [401.590199] Starting dynamic subtest: fence [410.092223] Dynamic subtest fence: SUCCESS (8.524s) [410.120255] Starting dynamic subtest: scatterlist [412.790744] Dynamic subtest scatterlist: SUCCESS (2.694s) [412.819191] Starting dynamic subtest: syncmap [416.553668] Dynamic subtest syncmap: SUCCESS (3.758s) [416.582180] Starting dynamic subtest: uncore [418.249666] Dynamic subtest uncore: SUCCESS (1.691s) [418.279167] Starting dynamic subtest: ring [419.941583] Dynamic subtest ring: SUCCESS (1.688s) [419.972193] Starting dynamic subtest: engine [421.634643] Dynamic subtest engine: SUCCESS (1.688s) [421.663156] Starting dynamic subtest: timelines [431.319489] Dynamic subtest timelines: SUCCESS (9.681s) [431.350342] Starting dynamic subtest: requests [435.222644] Dynamic subtest requests: SUCCESS (3.899s) [435.253206] Starting dynamic subtest: objects [437.054327] Dynamic subtest objects: SUCCESS (1.827s) [437.081449] Starting dynamic subtest: phys [438.911379] Dynamic subtest phys: SUCCESS (1.851s) [438.939199] Starting dynamic subtest: dmabuf [440.795710] Dynamic subtest dmabuf: SUCCESS (1.881s) [440.824160] Starting dynamic subtest: vma [461.528202] Dynamic subtest vma: SUCCESS (20.727s) [461.554425] Starting dynamic subtest: evict [465.672259] Dynamic subtest evict: SUCCESS (4.139s) [465.704078] Starting dynamic subtest: gtt [471.317065] Dynamic subtest gtt: SUCCESS (5.639s) [471.345280] Starting dynamic subtest: hugepages [473.659914] Dynamic subtest hugepages: SUCCESS (2.338s) [473.686560] Starting dynamic subtest: memory_region [482.048105] Dynamic subtest memory_region: SUCCESS (8.383s) [482.049910] Subtest mock: SUCCESS (83.991s) [482.129398] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [482.132644] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true [482.138209] [086/133] (593s left) gem_softpin (invalid) [485.079083] Starting subtest: invalid [485.138402] Subtest invalid: SUCCESS (0.060s) [485.340535] [FACT gem_softpin (invalid)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [485.343536] [FACT gem_softpin (invalid)] new: kernel.kmod_is_loaded.i915: true [485.352555] [087/133] (590s left) gem_tiled_partial_pwrite_pread (writes-after-reads) [485.485229] Starting subtest: writes-after-reads [489.117778] Subtest writes-after-reads: SUCCESS (3.632s) [489.287618] [088/133] (586s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [489.487185] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [489.492355] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [489.663975] [089/133] (586s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [489.866730] Starting subtest: primary-4-tiled-reflect-x-180 [489.872046] Subtest primary-4-tiled-reflect-x-180: SKIP (0.004s) [490.019867] [090/133] (585s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [490.223461] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [490.338901] [091/133] (585s left) syncobj_wait (invalid-wait-bad-flags) [490.450346] Starting subtest: invalid-wait-bad-flags [490.453076] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [490.607252] [092/133] (585s left) gem_userptr_blits (userfault) [490.738177] Starting subtest: userfault [490.746026] Subtest userfault: SUCCESS (0.011s) [490.956540] [093/133] (585s left) kms_psr (pr-dpms) [491.160049] Subtest pr-dpms: SKIP (0.000s) [491.277631] [094/133] (584s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt) [491.487977] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt [491.491643] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [491.636902] [095/133] (584s left) kms_explicit_fence (multiplane-atomic-fence-wait) [491.860121] Starting subtest: multiplane-atomic-fence-wait [492.450218] Subtest multiplane-atomic-fence-wait: SUCCESS (0.592s) [493.115773] [096/133] (583s left) kms_frontbuffer_tracking (fbc-suspend) [493.316241] Starting subtest: fbc-suspend