[61.442360] Initializing watchdogs [61.442426] /dev/watchdog0 [61.461893] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [61.472118] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [61.475724] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.478031] [001/131] (960s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [61.673158] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [61.674978] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [61.858679] [002/131] (960s left) gem_exec_fence (submit3) [62.056482] Starting subtest: submit3 [62.058730] Subtest submit3: SKIP (0.000s) [62.804528] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true [62.806420] [003/131] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [62.994764] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [62.996412] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [63.188597] [004/131] (959s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [63.379554] Starting subtest: fbc-rgb101010-draw-mmap-wc [63.381227] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s) [63.572918] [005/131] (958s left) gem_exec_balancer (noheartbeat) [63.931080] Starting subtest: noheartbeat [63.932958] Subtest noheartbeat: SKIP (0.000s) [64.128146] [006/131] (958s left) kms_chamelium_color (ctm-blue-to-red) [64.312542] Subtest ctm-blue-to-red: SKIP (0.000s) [64.369647] [007/131] (958s left) gem_workarounds (suspend-resume) [64.464940] Starting subtest: suspend-resume [83.531410] Subtest suspend-resume: SUCCESS (3.866s) [84.689557] [008/131] (938s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [84.878017] Starting subtest: planes-downscale-factor-0-75-unity-scaling [84.878813] Starting dynamic subtest: pipe-A [84.970765] Dynamic subtest pipe-A: SUCCESS (0.093s) [84.982865] Starting dynamic subtest: pipe-B [85.201884] Dynamic subtest pipe-B: SUCCESS (0.231s) [85.214267] Starting dynamic subtest: pipe-C [85.399737] Dynamic subtest pipe-C: SUCCESS (0.197s) [85.418437] Starting dynamic subtest: pipe-D [85.611187] Dynamic subtest pipe-D: SUCCESS (0.211s) [85.611977] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (0.733s) [85.980274] [009/131] (937s left) gem_pxp (create-regular-buffer) [88.581975] Starting subtest: create-regular-buffer [88.584661] Subtest create-regular-buffer: SKIP (0.000s) [88.719678] [010/131] (934s left) gem_exec_params (rel-constants-invalid-rel-gen5) [88.801969] Starting subtest: rel-constants-invalid-rel-gen5 [88.802889] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [88.970586] [011/131] (934s left) gem_exec_nop (basic-series) [89.058023] Starting subtest: basic-series [93.404813] Subtest basic-series: SUCCESS (4.346s) [93.721730] [012/131] (930s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [93.918096] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [93.919821] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [94.124550] [013/131] (929s left) kms_psr (fbc-psr-primary-page-flip) [94.316433] Subtest fbc-psr-primary-page-flip: SKIP (0.000s) [94.382280] [014/131] (929s left) i915_pm_rps (engine-order) [94.468431] Starting subtest: engine-order [105.176093] Subtest engine-order: SUCCESS (10.707s) [105.409515] [015/131] (918s left) gem_softpin (evict-active) [105.495913] Starting subtest: evict-active [105.514014] Subtest evict-active: SUCCESS (0.018s) [105.704571] [016/131] (918s left) syncobj_timeline (wait-delayed-signal) [105.778748] Starting subtest: wait-delayed-signal [105.880809] Subtest wait-delayed-signal: SUCCESS (0.102s) [106.061026] [017/131] (918s left) kms_panel_fitting (atomic-fastset) [106.248060] Starting subtest: atomic-fastset [106.249883] Subtest atomic-fastset: SKIP (0.000s) [106.411588] [018/131] (917s left) kms_big_fb (x-tiled-16bpp-rotate-270) [106.606771] Starting subtest: x-tiled-16bpp-rotate-270 [106.659111] Subtest x-tiled-16bpp-rotate-270: SKIP (0.052s) [106.875305] [019/131] (917s left) api_intel_bb (render-ccs) [106.948811] Starting subtest: render-ccs [107.048247] Subtest render-ccs: SUCCESS (0.098s) [107.222265] [020/131] (917s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [107.406356] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [107.407204] Starting dynamic subtest: pipe-A-DP-3 [107.415603] Dynamic subtest pipe-A-DP-3: SKIP (0.001s) [107.426764] Starting dynamic subtest: pipe-B-DP-3 [107.435174] Dynamic subtest pipe-B-DP-3: SKIP (0.001s) [107.445977] Starting dynamic subtest: pipe-C-DP-3 [107.454067] Dynamic subtest pipe-C-DP-3: SKIP (0.001s) [107.464982] Starting dynamic subtest: pipe-D-DP-3 [107.475542] Dynamic subtest pipe-D-DP-3: SKIP (0.001s) [107.477691] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s) [107.865573] [021/131] (916s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [107.948905] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [108.057138] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s) [108.182703] [022/131] (916s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [108.373865] Starting subtest: psr-2p-primscrn-cur-indfb-move [108.375582] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [108.568945] [023/131] (915s left) gem_lmem_swapping (heavy-multi) [111.231841] Starting subtest: heavy-multi [111.232774] Starting dynamic subtest: lmem0 [116.492437] Dynamic subtest lmem0: SUCCESS (5.264s) [116.493355] Subtest heavy-multi: SUCCESS (5.264s) [118.293850] [FACT gem_lmem_swapping (heavy-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [118.295082] [FACT gem_lmem_swapping (heavy-multi)] deleted: kernel.kmod_is_loaded.i915: true [118.296568] [024/131] (906s left) kms_async_flips (test-cursor) [119.962149] Starting subtest: test-cursor [120.194916] Starting dynamic subtest: pipe-A-DP-3 [120.482400] Dynamic subtest pipe-A-DP-3: SUCCESS (0.287s) [120.699815] Starting dynamic subtest: pipe-B-DP-3 [120.799736] Dynamic subtest pipe-B-DP-3: SUCCESS (0.110s) [120.990649] Starting dynamic subtest: pipe-C-DP-3 [121.084105] Dynamic subtest pipe-C-DP-3: SUCCESS (0.106s) [121.293642] Starting dynamic subtest: pipe-D-DP-3 [121.403517] Dynamic subtest pipe-D-DP-3: SUCCESS (0.120s) [121.404497] Subtest test-cursor: SUCCESS (1.441s) [121.907401] [FACT kms_async_flips (test-cursor)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [121.909680] [FACT kms_async_flips (test-cursor)] new: kernel.kmod_is_loaded.i915: true [121.912203] [025/131] (902s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [122.100497] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [122.160974] [026/131] (902s left) kms_plane_multiple (2x-tiling-4) [122.342980] Starting subtest: 2x-tiling-4 [122.344802] Subtest 2x-tiling-4: SKIP (0.000s) [122.502702] [027/131] (902s left) gem_ctx_param (invalid-param-set) [122.577040] Starting subtest: invalid-param-set [122.577977] Subtest invalid-param-set: SUCCESS (0.000s) [122.742465] [028/131] (902s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [122.930654] Starting subtest: bad-pixel-format-y-tiled-ccs [122.931515] Starting dynamic subtest: pipe-A-DP-3 [122.939979] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [122.951140] Starting dynamic subtest: pipe-B-DP-3 [122.959547] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [122.970379] Starting dynamic subtest: pipe-C-DP-3 [122.978585] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [122.989727] Starting dynamic subtest: pipe-D-DP-3 [123.007786] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [123.009555] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s) [123.388965] [029/131] (901s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [123.569565] Starting subtest: plane-downscale-factor-0-5-with-modifiers [123.570379] Starting dynamic subtest: pipe-A [124.124196] Dynamic subtest pipe-A: SUCCESS (0.554s) [124.145323] Starting dynamic subtest: pipe-B [124.772456] Dynamic subtest pipe-B: SUCCESS (0.647s) [124.799891] Starting dynamic subtest: pipe-C [125.416987] Dynamic subtest pipe-C: SUCCESS (0.644s) [125.439461] Starting dynamic subtest: pipe-D [126.083673] Dynamic subtest pipe-D: SUCCESS (0.666s) [126.084702] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (2.514s) [126.461943] [030/131] (898s left) syncobj_timeline (multi-wait-all-available-submitted-signaled) [126.543795] Starting subtest: multi-wait-all-available-submitted-signaled [126.544773] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s) [126.703321] [031/131] (898s left) perf (missing-sample-flags) [127.121525] Starting subtest: missing-sample-flags [127.122442] Subtest missing-sample-flags: SUCCESS (0.000s) [127.176517] [032/131] (897s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [127.367353] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [130.497451] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (3.130s) [130.680747] [033/131] (894s left) kms_pm_rpm (system-suspend-idle) [132.197263] Starting subtest: system-suspend-idle [151.635704] Subtest system-suspend-idle: SUCCESS (5.373s) [152.049149] [034/131] (873s left) kms_vblank (wait-forked) [152.242647] Starting subtest: wait-forked [152.243584] Starting dynamic subtest: pipe-A-DP-3 [154.691194] Dynamic subtest pipe-A-DP-3: SUCCESS (2.397s) [154.720803] Starting dynamic subtest: pipe-D-DP-3 [157.048237] Dynamic subtest pipe-D-DP-3: SUCCESS (2.313s) [157.049223] Subtest wait-forked: SUCCESS (4.723s) [157.328243] [035/131] (868s left) kms_big_fb (y-tiled-32bpp-rotate-0) [157.533491] Starting subtest: y-tiled-32bpp-rotate-0 [157.535200] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [157.748660] [036/131] (867s left) kms_pipe_crc_basic (read-crc) [157.935638] Starting subtest: read-crc [157.936588] Starting dynamic subtest: pipe-A-DP-3 [158.632235] Dynamic subtest pipe-A-DP-3: SUCCESS (0.688s) [158.647455] Starting dynamic subtest: pipe-B-DP-3 [159.206331] Dynamic subtest pipe-B-DP-3: SUCCESS (0.567s) [159.228095] Starting dynamic subtest: pipe-C-DP-3 [159.764849] Dynamic subtest pipe-C-DP-3: SUCCESS (0.551s) [159.784257] Starting dynamic subtest: pipe-D-DP-3 [160.305965] Dynamic subtest pipe-D-DP-3: SUCCESS (0.533s) [160.306875] Subtest read-crc: SUCCESS (2.347s) [160.606693] [037/131] (864s left) kms_cursor_legacy (single-move) [160.790654] Starting subtest: single-move [160.791585] Starting dynamic subtest: pipe-A [166.202500] Dynamic subtest pipe-A: SUCCESS (5.379s) [166.215015] Starting dynamic subtest: pipe-B [171.597950] Dynamic subtest pipe-B: SUCCESS (5.379s) [171.610090] Starting dynamic subtest: pipe-C [176.986719] Dynamic subtest pipe-C: SUCCESS (5.379s) [176.999017] Starting dynamic subtest: pipe-D [182.371956] Dynamic subtest pipe-D: SUCCESS (5.379s) [182.384049] Starting dynamic subtest: all-pipes [187.753167] Dynamic subtest all-pipes: SUCCESS (5.379s) [187.754041] Subtest single-move: SUCCESS (26.898s) [187.890348] [038/131] (837s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [188.081814] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [188.159286] [039/131] (837s left) gem_unref_active_buffers [188.536012] [040/131] (837s left) kms_psr (fbc-psr2-primary-mmap-gtt) [188.730039] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.000s) [188.784139] [041/131] (836s left) syncobj_wait (invalid-signal-zero-handles) [188.862862] Starting subtest: invalid-signal-zero-handles [188.863799] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [189.053609] [042/131] (836s left) gen9_exec_parse (bb-oversize) [189.136018] Subtest bb-oversize: SKIP (0.000s) [189.220483] [043/131] (836s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [189.294854] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [189.407627] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s) [189.606218] [044/131] (836s left) gem_exec_reloc (basic-write-cpu-noreloc) [189.693246] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [189.767202] [045/131] (836s left) gem_mmap_offset (bad-flags) [189.845742] Starting subtest: bad-flags [189.846718] Subtest bad-flags: SUCCESS (0.000s) [190.040791] [046/131] (836s left) kms_cursor_legacy (cursor-vs-flip-legacy) [190.227791] Starting subtest: cursor-vs-flip-legacy [220.495065] Subtest cursor-vs-flip-legacy: SUCCESS (30.256s) [220.774822] [047/131] (805s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [220.956481] Starting subtest: sprite-rotation-90-pos-100-0 [220.958128] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [221.116350] [048/131] (805s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [221.309592] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [222.577687] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.256s) [222.817004] [049/131] (803s left) gem_create (busy-create) [222.897218] Starting subtest: busy-create [222.898090] Starting dynamic subtest: lmem0 [255.190851] Dynamic subtest lmem0: SUCCESS (32.286s) [255.203708] Starting dynamic subtest: smem0 [287.460850] Dynamic subtest smem0: SUCCESS (32.272s) [287.461879] Subtest busy-create: SUCCESS (64.560s) [287.755244] [050/131] (738s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render) [287.946483] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render [290.876894] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (2.931s) [291.137147] [051/131] (735s left) perf (invalid-open-flags) [291.381458] Starting subtest: invalid-open-flags [291.382423] Subtest invalid-open-flags: SUCCESS (0.000s) [291.435255] [052/131] (735s left) perf (oa-formats) [291.650306] Starting subtest: oa-formats [291.651166] Starting dynamic subtest: 0-rcs0 [291.678700] Dynamic subtest 0-rcs0: SUCCESS (0.028s) [291.679931] Subtest oa-formats: SUCCESS (0.029s) [291.737150] [053/131] (734s left) kms_big_fb (4-tiled-8bpp-rotate-270) [291.930962] Starting subtest: 4-tiled-8bpp-rotate-270 [291.992940] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.059s) [292.198314] [054/131] (734s left) kms_cursor_crc (cursor-onscreen-64x21) [292.541856] Starting subtest: cursor-onscreen-64x21 [292.546175] Starting dynamic subtest: pipe-A-DP-3 [295.149177] Dynamic subtest pipe-A-DP-3: SUCCESS (2.602s) [295.197105] Starting dynamic subtest: pipe-D-DP-3 [297.836154] Dynamic subtest pipe-D-DP-3: SUCCESS (2.651s) [297.837062] Subtest cursor-onscreen-64x21: SUCCESS (5.293s) [298.317146] [055/131] (728s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [298.501711] Starting subtest: primary-4-tiled-reflect-x-180 [308.681635] Subtest primary-4-tiled-reflect-x-180: SUCCESS (10.178s) [309.040428] [056/131] (717s left) kms_cursor_crc (cursor-onscreen-256x256) [309.445952] Starting subtest: cursor-onscreen-256x256 [309.450685] Starting dynamic subtest: pipe-A-DP-3 [312.217923] Dynamic subtest pipe-A-DP-3: SUCCESS (2.766s) [312.253959] Starting dynamic subtest: pipe-D-DP-3 [314.980898] Dynamic subtest pipe-D-DP-3: SUCCESS (2.737s) [314.981900] Subtest cursor-onscreen-256x256: SUCCESS (5.533s) [315.435624] [057/131] (711s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [315.624437] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [315.626051] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [315.831676] [058/131] (711s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [316.017750] Starting subtest: async-flip-with-page-flip-events-tiled [316.276068] Starting dynamic subtest: pipe-A-DP-3-4 [318.534249] Dynamic subtest pipe-A-DP-3-4: SUCCESS (2.257s) [318.547642] Starting dynamic subtest: pipe-A-DP-3-x [320.716130] Dynamic subtest pipe-A-DP-3-x: SUCCESS (2.181s) [320.966463] Starting dynamic subtest: pipe-B-DP-3-4 [323.184171] Dynamic subtest pipe-B-DP-3-4: SUCCESS (2.231s) [323.197223] Starting dynamic subtest: pipe-B-DP-3-x [325.349604] Dynamic subtest pipe-B-DP-3-x: SUCCESS (2.164s) [325.565620] Starting dynamic subtest: pipe-C-DP-3-4 [327.788362] Dynamic subtest pipe-C-DP-3-4: SUCCESS (2.233s) [327.823779] Starting dynamic subtest: pipe-C-DP-3-x [329.969272] Dynamic subtest pipe-C-DP-3-x: SUCCESS (2.178s) [330.184064] Starting dynamic subtest: pipe-D-DP-3-4 [332.401349] Dynamic subtest pipe-D-DP-3-4: SUCCESS (2.230s) [332.413756] Starting dynamic subtest: pipe-D-DP-3-x [334.566614] Dynamic subtest pipe-D-DP-3-x: SUCCESS (2.164s) [334.567530] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (18.545s) [335.088145] [059/131] (692s left) perf (polling) [335.329071] Starting subtest: polling [335.329986] Starting dynamic subtest: 0-rcs0 [345.352461] Dynamic subtest 0-rcs0: SUCCESS (10.020s) [345.353428] Subtest polling: SUCCESS (10.021s) [345.405369] [060/131] (681s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [345.607448] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [345.609486] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [345.800597] [061/131] (681s left) syncobj_timeline (reset-signaled) [345.875950] Starting subtest: reset-signaled [345.876902] Subtest reset-signaled: SUCCESS (0.000s) [346.069743] [062/131] (681s left) kms_rmfb (rmfb-ioctl) [346.257753] Starting subtest: rmfb-ioctl [346.258694] Starting dynamic subtest: pipe-A-DP-3 [346.408012] Dynamic subtest pipe-A-DP-3: SUCCESS (0.150s) [346.433181] Starting dynamic subtest: pipe-B-DP-3 [346.691350] Dynamic subtest pipe-B-DP-3: SUCCESS (0.281s) [346.706710] Starting dynamic subtest: pipe-C-DP-3 [346.937127] Dynamic subtest pipe-C-DP-3: SUCCESS (0.244s) [346.952911] Starting dynamic subtest: pipe-D-DP-3 [347.199336] Dynamic subtest pipe-D-DP-3: SUCCESS (0.260s) [347.200200] Subtest rmfb-ioctl: SUCCESS (0.943s) [347.530842] [063/131] (679s left) gem_userptr_blits (create-destroy-sync) [347.616740] Starting subtest: create-destroy-sync [352.639287] Subtest create-destroy-sync: SUCCESS (5.021s) [352.851926] [064/131] (674s left) gem_exec_reloc (basic-gtt-cpu-active) [352.931987] Subtest basic-gtt-cpu-active: SKIP (0.000s) [353.012891] [065/131] (674s left) api_intel_allocator (execbuf-with-allocator) [353.086803] Starting subtest: execbuf-with-allocator [353.118647] Subtest execbuf-with-allocator: SUCCESS (0.032s) [353.358372] [066/131] (674s left) kms_lease (cursor-implicit-plane) [353.548945] Starting subtest: cursor-implicit-plane [353.549824] Starting dynamic subtest: pipe-A-DP-3 [353.890836] Dynamic subtest pipe-A-DP-3: SUCCESS (0.342s) [353.916012] Starting dynamic subtest: pipe-B-DP-3 [354.190587] Dynamic subtest pipe-B-DP-3: SUCCESS (0.296s) [354.206518] Starting dynamic subtest: pipe-C-DP-3 [354.460511] Dynamic subtest pipe-C-DP-3: SUCCESS (0.268s) [354.476765] Starting dynamic subtest: pipe-D-DP-3 [354.733510] Dynamic subtest pipe-D-DP-3: SUCCESS (0.271s) [354.734384] Subtest cursor-implicit-plane: SUCCESS (1.186s) [355.059922] [067/131] (672s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [355.248797] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [355.250613] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [355.414095] [068/131] (672s left) syncobj_wait (invalid-signal-illegal-handle) [355.490825] Starting subtest: invalid-signal-illegal-handle [355.491741] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [355.658378] [069/131] (672s left) kms_psr (psr-primary-blt) [355.843767] Subtest psr-primary-blt: SKIP (0.000s) [355.903179] [070/131] (672s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [356.089838] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [356.090738] Starting dynamic subtest: pipe-A-DP-3 [356.111574] Dynamic subtest pipe-A-DP-3: SKIP (0.002s) [356.124607] Starting dynamic subtest: pipe-B-DP-3 [356.145280] Dynamic subtest pipe-B-DP-3: SKIP (0.002s) [356.158200] Starting dynamic subtest: pipe-C-DP-3 [356.185000] Dynamic subtest pipe-C-DP-3: SKIP (0.002s) [356.198240] Starting dynamic subtest: pipe-D-DP-3 [356.222467] Dynamic subtest pipe-D-DP-3: SKIP (0.002s) [356.224698] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.015s) [356.568402] [071/131] (671s left) kms_psr (pr-primary-blt) [356.761176] Subtest pr-primary-blt: SKIP (0.000s) [356.811968] [072/131] (671s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [357.006519] Starting subtest: psr-2p-primscrn-spr-indfb-move [357.008748] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [357.202958] [073/131] (670s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [357.391828] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [357.392720] Starting dynamic subtest: pipe-A-valid-mode [359.916376] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.522s) [359.918083] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (2.525s) [360.238883] [074/131] (668s left) gem_exec_schedule (u-semaphore-noskip) [360.337963] Starting subtest: u-semaphore-noskip [361.090884] Subtest u-semaphore-noskip: SUCCESS (0.754s) [361.561019] [075/131] (666s left) i915_drm_fdinfo (memory-info-idle) [361.631144] Starting subtest: memory-info-idle [361.632036] Starting dynamic subtest: lmem0 [361.731249] Dynamic subtest lmem0: SUCCESS (0.099s) [361.747621] Starting dynamic subtest: smem0 [361.771417] Dynamic subtest smem0: SUCCESS (0.038s) [361.772293] Subtest memory-info-idle: SUCCESS (0.141s) [361.994509] [076/131] (666s left) i915_selftest (live) [363.157445] Starting subtest: live [363.158476] Starting dynamic subtest: sanitycheck [364.642608] Dynamic subtest sanitycheck: SUCCESS (1.484s) [364.653366] Starting dynamic subtest: uncore [366.163474] Dynamic subtest uncore: SUCCESS (1.519s) [366.174508] Starting dynamic subtest: workarounds [369.322428] Dynamic subtest workarounds: SUCCESS (3.157s) [369.333193] Starting dynamic subtest: gt_engines [371.620570] Dynamic subtest gt_engines: SUCCESS (2.296s) [371.631618] Starting dynamic subtest: gt_timelines [391.037784] Dynamic subtest gt_timelines: SUCCESS (19.419s) [391.051792] Starting dynamic subtest: gt_contexts [392.614501] Dynamic subtest gt_contexts: SUCCESS (1.576s) [392.626864] Starting dynamic subtest: gt_lrc [398.888982] Dynamic subtest gt_lrc: SUCCESS (6.274s) [398.901710] Starting dynamic subtest: gt_mocs [401.752740] Dynamic subtest gt_mocs: SUCCESS (2.862s) [401.766676] Starting dynamic subtest: gt_pm [405.915681] Dynamic subtest gt_pm: SUCCESS (4.162s) [405.926823] Starting dynamic subtest: gt_heartbeat [407.427504] Dynamic subtest gt_heartbeat: SUCCESS (1.511s) [407.438228] Starting dynamic subtest: gt_tlb [420.005928] Dynamic subtest gt_tlb: SUCCESS (12.578s) [420.028067] Starting dynamic subtest: requests [433.370793] Dynamic subtest requests: SUCCESS (13.363s) [433.382865] Starting dynamic subtest: migrate [438.622452] Dynamic subtest migrate: SUCCESS (5.250s) [438.634751] Starting dynamic subtest: active [440.148727] Dynamic subtest active: SUCCESS (1.525s) [440.160084] Starting dynamic subtest: objects [442.430727] Dynamic subtest objects: SUCCESS (2.281s) [442.441944] Starting dynamic subtest: mman [448.966655] Dynamic subtest mman: SUCCESS (6.534s) [448.977819] Starting dynamic subtest: dmabuf [450.591616] Dynamic subtest dmabuf: SUCCESS (1.624s) [450.602738] Starting dynamic subtest: vma [452.084502] Dynamic subtest vma: SUCCESS (1.492s) [452.095311] Starting dynamic subtest: coherency [456.466499] Dynamic subtest coherency: SUCCESS (4.380s) [456.477613] Starting dynamic subtest: gtt [466.444514] Dynamic subtest gtt: SUCCESS (9.976s) [466.455518] Starting dynamic subtest: gem [468.146827] Dynamic subtest gem: SUCCESS (1.695s) [468.157190] Starting dynamic subtest: evict [471.072601] Dynamic subtest evict: SUCCESS (2.930s) [471.083895] Starting dynamic subtest: hugepages [489.032573] Dynamic subtest hugepages: SUCCESS (17.956s) [489.044964] Starting dynamic subtest: gem_contexts [521.960762] Dynamic subtest gem_contexts: SUCCESS (32.921s) [521.972368] Starting dynamic subtest: client [523.523702] Dynamic subtest client: SUCCESS (1.561s) [523.535505] Starting dynamic subtest: gem_migrate [526.938667] Dynamic subtest gem_migrate: SUCCESS (3.413s) [526.950090] Starting dynamic subtest: reset [528.514683] Dynamic subtest reset: SUCCESS (1.574s) [528.526792] Starting dynamic subtest: memory_region [531.661685] Dynamic subtest memory_region: SUCCESS (3.145s) [531.673001] Starting dynamic subtest: hangcheck [561.927674] Dynamic subtest hangcheck: SUCCESS (30.258s) [561.939910] Starting dynamic subtest: execlists [563.416451] Dynamic subtest execlists: SUCCESS (1.487s) [563.427105] Starting dynamic subtest: ring_submission [564.875592] Dynamic subtest ring_submission: SUCCESS (1.458s) [564.886405] Starting dynamic subtest: perf [566.467862] Dynamic subtest perf: SUCCESS (1.591s) [566.479236] Starting dynamic subtest: slpc [573.671929] Dynamic subtest slpc: SUCCESS (7.201s) [573.683288] Starting dynamic subtest: guc [576.550669] Dynamic subtest guc: SUCCESS (2.877s) [576.562789] Starting dynamic subtest: guc_multi_lrc [578.069542] Dynamic subtest guc_multi_lrc: SUCCESS (1.517s) [578.081213] Starting dynamic subtest: guc_hang [580.345661] Dynamic subtest guc_hang: SUCCESS (2.274s) [580.357148] Starting dynamic subtest: late_gt_pm [581.900587] Dynamic subtest late_gt_pm: SUCCESS (1.553s) [581.901538] Subtest live: SUCCESS (218.725s) [581.961132] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [581.962581] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [581.964906] [077/131] (446s left) gem_userptr_blits (nohangcheck) [583.507687] Starting subtest: nohangcheck [583.853378] Subtest nohangcheck: SUCCESS (0.346s) [583.999441] [FACT gem_userptr_blits (nohangcheck)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [584.001718] [FACT gem_userptr_blits (nohangcheck)] new: kernel.kmod_is_loaded.i915: true [584.004511] [078/131] (444s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [584.196050] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [584.198205] Starting dynamic subtest: pipe-A-DP-3 [584.206510] Dynamic subtest pipe-A-DP-3: SKIP (0.001s) [584.219002] Starting dynamic subtest: pipe-B-DP-3 [584.227505] Dynamic subtest pipe-B-DP-3: SKIP (0.001s) [584.240509] Starting dynamic subtest: pipe-C-DP-3 [584.248716] Dynamic subtest pipe-C-DP-3: SKIP (0.001s) [584.260954] Starting dynamic subtest: pipe-D-DP-3 [584.271021] Dynamic subtest pipe-D-DP-3: SKIP (0.001s) [584.273132] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SKIP (0.009s) [584.676706] [079/131] (444s left) gem_softpin (allocator-nopin) [584.762417] Starting subtest: allocator-nopin [585.017989] Subtest allocator-nopin: SUCCESS (0.255s) [585.201211] [080/131] (443s left) kms_draw_crc (draw-method-pwrite) [585.385980] Starting subtest: draw-method-pwrite [585.386846] Starting dynamic subtest: xrgb8888-untiled [585.803033] Dynamic subtest xrgb8888-untiled: SUCCESS (0.417s) [585.826159] Starting dynamic subtest: rgb565-untiled [586.237276] Dynamic subtest rgb565-untiled: SUCCESS (0.432s) [586.279524] Starting dynamic subtest: xrgb2101010-untiled [586.619752] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.379s) [586.634049] Starting dynamic subtest: xbgr16161616f-untiled [587.003090] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.382s) [587.017966] Starting dynamic subtest: xrgb8888-xtiled [587.537030] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.533s) [587.553611] Starting dynamic subtest: rgb565-xtiled [588.104726] Dynamic subtest rgb565-xtiled: SUCCESS (0.565s) [588.121063] Starting dynamic subtest: xrgb2101010-xtiled [588.620137] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.512s) [588.634897] Starting dynamic subtest: xbgr16161616f-xtiled [589.220390] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.599s) [589.233612] Starting dynamic subtest: xrgb8888-4tiled [589.622024] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.400s) [589.667042] Starting dynamic subtest: rgb565-4tiled [589.971663] Dynamic subtest rgb565-4tiled: SUCCESS (0.346s) [589.986887] Starting dynamic subtest: xrgb2101010-4tiled [590.370735] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.398s) [590.385472] Starting dynamic subtest: xbgr16161616f-4tiled [590.970794] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.599s) [590.971615] Subtest draw-method-pwrite: SUCCESS (5.585s) [591.137068] [081/131] (437s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [591.329395] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [591.331134] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [591.520789] [082/131] (437s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [591.713594] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [591.715379] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [591.905990] [083/131] (437s left) syncobj_timeline (host-signal-points) [591.981933] Starting subtest: host-signal-points [591.988656] Subtest host-signal-points: SUCCESS (0.007s) [592.157821] [084/131] (436s left) gem_mmap_gtt (basic-small-bo) [592.235748] Subtest basic-small-bo: SKIP (0.000s) [592.300726] [085/131] (436s left) perf_pmu (semaphore-wait-idle) [592.370143] Starting subtest: semaphore-wait-idle [592.371038] Starting dynamic subtest: rcs0 [592.912397] Dynamic subtest rcs0: SUCCESS (0.540s) [592.927803] Starting dynamic subtest: bcs0 [593.426478] Dynamic subtest bcs0: SUCCESS (0.510s) [593.442801] Starting dynamic subtest: vcs0 [593.941176] Dynamic subtest vcs0: SUCCESS (0.510s) [593.957382] Starting dynamic subtest: vcs1 [594.454870] Dynamic subtest vcs1: SUCCESS (0.509s) [594.471198] Starting dynamic subtest: vecs0 [594.968123] Dynamic subtest vecs0: SUCCESS (0.509s) [594.984720] Starting dynamic subtest: vecs1 [595.481940] Dynamic subtest vecs1: SUCCESS (0.509s) [595.498153] Starting dynamic subtest: ccs0 [595.995298] Dynamic subtest ccs0: SUCCESS (0.509s) [595.999605] Subtest semaphore-wait-idle: SUCCESS (3.626s) [596.205031] [086/131] (432s left) kms_addfb_basic (no-handle) [596.294567] Starting subtest: no-handle [596.295522] Subtest no-handle: SUCCESS (0.000s) [596.583587] [087/131] (432s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [596.770584] Starting subtest: fbcpsr-rgb101010-draw-pwrite [596.772228] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s) [596.961085] [088/131] (432s left) gem_render_copy (yf-tiled-ccs-to-linear) [597.042201] Starting subtest: yf-tiled-ccs-to-linear [597.044184] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [597.290464] [089/131] (432s left) kms_flip (wf_vblank-ts-check) [597.471221] Starting subtest: wf_vblank-ts-check [597.476002] Starting dynamic subtest: A-DP3 [605.609085] Dynamic subtest A-DP3: SUCCESS (8.131s) [605.625185] Starting dynamic subtest: B-DP3 [613.663121] Dynamic subtest B-DP3: SUCCESS (8.050s) [613.678922] Starting dynamic subtest: C-DP3 [621.716049] Dynamic subtest C-DP3: SUCCESS (8.050s) [621.731658] Starting dynamic subtest: D-DP3 [629.767419] Dynamic subtest D-DP3: SUCCESS (8.048s) [629.769762] Subtest wf_vblank-ts-check: SUCCESS (32.291s) [630.130651] [090/131] (399s left) gem_exec_schedule (deep) [630.370263] Starting subtest: deep [630.371716] Starting dynamic subtest: rcs0 [645.042740] Dynamic subtest rcs0: SUCCESS (14.682s) [645.056154] Starting dynamic subtest: bcs0 [660.264689] Dynamic subtest bcs0: SUCCESS (15.229s) [660.278367] Starting dynamic subtest: vcs0 [675.221366] Dynamic subtest vcs0: SUCCESS (14.961s) [675.234940] Starting dynamic subtest: vcs1 [690.312313] Dynamic subtest vcs1: SUCCESS (15.079s) [690.338337] Starting dynamic subtest: vecs0 [705.119159] Dynamic subtest vecs0: SUCCESS (14.821s) [705.132500] Starting dynamic subtest: vecs1 [720.093764] Dynamic subtest vecs1: SUCCESS (14.975s) [720.110298] Starting dynamic subtest: ccs0 [736.078095] Dynamic subtest ccs0: SUCCESS (15.984s) [736.079038] Subtest deep: SUCCESS (105.745s) [737.091404] [091/131] (292s left) kms_sequence (queue-idle) [737.277823] Starting subtest: queue-idle [737.278732] Starting dynamic subtest: pipe-A-DP-3 [739.641177] Dynamic subtest pipe-A-DP-3: SUCCESS (2.362s) [739.660458] Starting dynamic subtest: pipe-B-DP-3 [741.942950] Dynamic subtest pipe-B-DP-3: SUCCESS (2.301s) [741.958003] Starting dynamic subtest: pipe-C-DP-3 [744.210193] Dynamic subtest pipe-C-DP-3: SUCCESS (2.265s) [744.226494] Starting dynamic subtest: pipe-D-DP-3 [746.502727] Dynamic subtest pipe-D-DP-3: SUCCESS (2.290s) [746.503684] Subtest queue-idle: SUCCESS (9.226s) [746.852163] [092/131] (282s left) gem_gtt_cpu_tlb [747.028297] [093/131] (282s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [747.213790] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [747.215511] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [747.452224] [094/131] (282s left) gem_eio (create-ext) [747.750427] Starting subtest: create-ext [748.258609] Subtest create-ext: SUCCESS (0.508s) [748.551214] [095/131] (281s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [748.634554] Subtest writes-after-reads-uncached: SKIP (0.000s) [748.719080] [096/131] (281s left) sysfs_preempt_timeout (idempotent) [748.803729] Starting subtest: idempotent [748.805981] Starting dynamic subtest: vecs0 [748.806850] Dynamic subtest vecs0: SUCCESS (0.001s) [748.820724] Starting dynamic subtest: ccs0 [748.821631] Dynamic subtest ccs0: SUCCESS (0.001s) [748.835384] Starting dynamic subtest: vcs0 [748.836636] Dynamic subtest vcs0: SUCCESS (0.001s) [748.850221] Starting dynamic subtest: bcs0 [748.851375] Dynamic subtest bcs0: SUCCESS (0.001s) [748.864519] Starting dynamic subtest: vecs1 [748.865775] Dynamic subtest vecs1: SUCCESS (0.001s) [748.879154] Starting dynamic subtest: rcs0 [748.880381] Dynamic subtest rcs0: SUCCESS (0.001s) [748.896521] Starting dynamic subtest: vcs1 [748.897773] Dynamic subtest vcs1: SUCCESS (0.001s) [748.899033] Subtest idempotent: SUCCESS (0.013s) [748.947217] [097/131] (281s left) gem_busy (semaphore) [749.186777] Subtest semaphore: SKIP (0.000s) [749.537294] [098/131] (280s left) sriov_basic (enable-vfs-bind-unbind-each) [749.612761] Subtest enable-vfs-bind-unbind-each: SKIP (0.000s) [749.712456] [099/131] (280s left) kms_pm_lpsp (screens-disabled) [750.901740] Starting subtest: screens-disabled [750.903581] Subtest screens-disabled: SKIP (0.000s) [751.089753] [100/131] (279s left) gem_exec_capture (capture-invisible) [751.177824] Starting subtest: capture-invisible [751.178752] Starting dynamic subtest: lmem0 [751.180660] Dynamic subtest lmem0: SKIP (0.000s) [751.194569] Starting dynamic subtest: smem0 [751.196780] Dynamic subtest smem0: SKIP (0.000s) [751.199155] Subtest capture-invisible: SKIP (0.002s) [751.387446] [101/131] (279s left) gem_lmem_swapping (verify-ccs) [754.079450] Starting subtest: verify-ccs [754.080189] Starting dynamic subtest: lmem0 [799.126076] Dynamic subtest lmem0: SUCCESS (45.042s) [799.126995] Subtest verify-ccs: SUCCESS (45.044s) [801.184837] [FACT gem_lmem_swapping (verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [801.185854] [FACT gem_lmem_swapping (verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true [801.187893] [102/131] (229s left) kms_joiner (basic-force-ultra-joiner) [802.846693] Starting subtest: basic-force-ultra-joiner [802.848427] Subtest basic-force-ultra-joiner: SKIP (0.000s) [803.056735] [FACT kms_joiner (basic-force-ultra-joiner)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [803.059301] [FACT kms_joiner (basic-force-ultra-joiner)] new: kernel.kmod_is_loaded.i915: true [803.061932] [103/131] (227s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [803.253510] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [803.255273] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [803.459822] [104/131] (227s left) kms_color (legacy-gamma) [803.643018] Starting subtest: legacy-gamma [803.643948] Starting dynamic subtest: pipe-A-DP-3 [804.289182] Dynamic subtest pipe-A-DP-3: SUCCESS (0.646s) [804.318555] Starting dynamic subtest: pipe-B-DP-3 [804.853453] Dynamic subtest pipe-B-DP-3: SUCCESS (0.561s) [804.869835] Starting dynamic subtest: pipe-C-DP-3 [805.442763] Dynamic subtest pipe-C-DP-3: SUCCESS (0.588s) [805.456564] Starting dynamic subtest: pipe-D-DP-3 [806.048702] Dynamic subtest pipe-D-DP-3: SUCCESS (0.605s) [806.049613] Subtest legacy-gamma: SUCCESS (2.407s) [806.381510] [105/131] (224s left) gem_exec_schedule (wide) [806.591790] Starting subtest: wide [806.592738] Starting dynamic subtest: rcs0 [819.398873] Dynamic subtest rcs0: SUCCESS (12.805s) [819.413387] Starting dynamic subtest: bcs0 [833.422282] Dynamic subtest bcs0: SUCCESS (14.021s) [833.436482] Starting dynamic subtest: vcs0 [847.272947] Dynamic subtest vcs0: SUCCESS (13.848s) [847.290392] Starting dynamic subtest: vcs1 [861.329879] Dynamic subtest vcs1: SUCCESS (14.052s) [861.348780] Starting dynamic subtest: vecs0 [875.076795] Dynamic subtest vecs0: SUCCESS (13.738s) [875.093767] Starting dynamic subtest: vecs1 [888.742616] Dynamic subtest vecs1: SUCCESS (13.666s) [888.759439] Starting dynamic subtest: ccs0 [903.108328] Dynamic subtest ccs0: SUCCESS (14.363s) [903.114766] Subtest wide: SUCCESS (96.510s) [904.870857] [106/131] (125s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [905.061286] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [905.063751] Starting dynamic subtest: pipe-A-valid-mode [905.152097] Dynamic subtest pipe-A-valid-mode: SKIP (0.088s) [905.153964] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.090s) [905.412283] [107/131] (125s left) kms_big_fb (linear-64bpp-rotate-180) [905.608420] Starting subtest: linear-64bpp-rotate-180 [907.558384] Subtest linear-64bpp-rotate-180: SUCCESS (1.949s) [907.839020] [108/131] (123s left) gem_ppgtt (blt-vs-render-ctxn) [907.922000] Starting subtest: blt-vs-render-ctxN [940.960552] Subtest blt-vs-render-ctxN: SUCCESS (33.040s) [941.217055] [109/131] ( 89s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [941.440949] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [941.442738] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [941.652218] [110/131] ( 89s left) kms_chamelium_frames (dp-frame-dump) [941.915087] Subtest dp-frame-dump: SKIP (0.000s) [942.085341] [111/131] ( 89s left) kms_psr2_su (page_flip-nv12) [942.176885] Subtest page_flip-NV12: SKIP (0.000s) [942.307281] [112/131] ( 89s left) gem_tiling_max_stride [942.490038] [113/131] ( 88s left) perf_pmu (busy-idle) [942.565067] Starting subtest: busy-idle [942.565990] Starting dynamic subtest: rcs0 [943.296036] Dynamic subtest rcs0: SUCCESS (0.730s) [943.315358] Starting dynamic subtest: bcs0 [943.959062] Dynamic subtest bcs0: SUCCESS (0.659s) [943.976479] Starting dynamic subtest: vcs0 [944.625195] Dynamic subtest vcs0: SUCCESS (0.662s) [944.643006] Starting dynamic subtest: vcs1 [945.290211] Dynamic subtest vcs1: SUCCESS (0.661s) [945.307753] Starting dynamic subtest: vecs0 [945.957151] Dynamic subtest vecs0: SUCCESS (0.663s) [946.003969] Starting dynamic subtest: vecs1 [946.642997] Dynamic subtest vecs1: SUCCESS (0.682s) [946.660914] Starting dynamic subtest: ccs0 [947.308280] Dynamic subtest ccs0: SUCCESS (0.661s) [947.313610] Subtest busy-idle: SUCCESS (4.745s) [947.522645] [114/131] ( 83s left) dmabuf_sync_file (export-before-signal) [947.588685] Starting subtest: export-before-signal [947.589561] Subtest export-before-signal: SUCCESS (0.001s) [947.747891] [115/131] ( 83s left) gem_exec_reloc (basic-cpu-read) [947.834934] Subtest basic-cpu-read: SKIP (0.000s) [947.919987] [116/131] ( 83s left) kms_hdr (bpc-switch) [948.111034] Starting subtest: bpc-switch [951.434705] Starting dynamic subtest: pipe-A-DP-3 [952.494826] Dynamic subtest pipe-A-DP-3: SUCCESS (1.059s) [952.500054] Subtest bpc-switch: SUCCESS (4.387s) [952.900490] [117/131] ( 78s left) perf (i915-ref-count) [953.081695] Starting subtest: i915-ref-count [953.368882] Subtest i915-ref-count: SUCCESS (0.287s) [953.605149] [118/131] ( 78s left) gem_ctx_isolation (nonpriv) [953.693337] Starting subtest: nonpriv [953.694193] Starting dynamic subtest: rcs0 [954.550472] Dynamic subtest rcs0: SUCCESS (0.856s) [954.566945] Starting dynamic subtest: bcs0 [955.442165] Dynamic subtest bcs0: SUCCESS (0.891s) [955.459424] Starting dynamic subtest: vcs0 [956.343372] Dynamic subtest vcs0: SUCCESS (0.900s) [956.359322] Starting dynamic subtest: vcs1 [957.217647] Dynamic subtest vcs1: SUCCESS (0.873s) [957.234444] Starting dynamic subtest: vecs0 [958.099347] Dynamic subtest vecs0: SUCCESS (0.881s) [958.115610] Starting dynamic subtest: vecs1 [959.021077] Dynamic subtest vecs1: SUCCESS (0.921s) [959.037564] Starting dynamic subtest: ccs0 [959.933376] Dynamic subtest ccs0: SUCCESS (0.911s) [959.934277] Subtest nonpriv: SUCCESS (6.241s) [960.268067] [119/131] ( 71s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [960.355362] Starting subtest: y-tiled-to-vebox-x-tiled [960.357733] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [960.627551] [120/131] ( 71s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [960.826014] Starting subtest: plane-use-after-nonblocking-unbind [960.826952] Starting dynamic subtest: pipe-A-DP-3 [960.900219] Dynamic subtest pipe-A-DP-3: SUCCESS (0.074s) [961.021377] Starting dynamic subtest: pipe-B-DP-3 [961.216461] Dynamic subtest pipe-B-DP-3: SUCCESS (0.223s) [961.290412] Subtest plane-use-after-nonblocking-unbind: SUCCESS (0.464s) [961.566039] [121/131] ( 70s left) i915_hangman (engine-error-state-capture) [961.661459] Starting subtest: engine-error-state-capture [961.662375] Starting dynamic subtest: rcs0 [963.851500] Dynamic subtest rcs0: SUCCESS (2.190s) [963.869435] Starting dynamic subtest: bcs0 [967.844823] Dynamic subtest bcs0: SUCCESS (3.991s) [967.861229] Starting dynamic subtest: vcs0 [971.787876] Dynamic subtest vcs0: SUCCESS (3.942s) [971.803686] Starting dynamic subtest: vcs1 [975.854116] Dynamic subtest vcs1: SUCCESS (4.065s) [975.872190] Starting dynamic subtest: vecs0 [979.787809] Dynamic subtest vecs0: SUCCESS (3.932s) [979.803707] Starting dynamic subtest: vecs1 [983.814941] Dynamic subtest vecs1: SUCCESS (4.026s) [983.830755] Starting dynamic subtest: ccs0 [987.801122] Dynamic subtest ccs0: SUCCESS (3.985s) [987.801992] Subtest engine-error-state-capture: SUCCESS (26.141s) [988.017367] [122/131] ( 44s left) gem_exec_schedule (pi-shared-iova) [988.223980] Starting subtest: pi-shared-iova [988.224954] Starting dynamic subtest: rcs0 [988.490201] Dynamic subtest rcs0: SUCCESS (0.266s) [988.504787] Starting dynamic subtest: bcs0 [988.667629] Dynamic subtest bcs0: SUCCESS (0.176s) [988.682245] Starting dynamic subtest: vcs0 [988.854973] Dynamic subtest vcs0: SUCCESS (0.186s) [988.869571] Starting dynamic subtest: vcs1 [989.045934] Dynamic subtest vcs1: SUCCESS (0.190s) [989.060604] Starting dynamic subtest: vecs0 [989.233470] Dynamic subtest vecs0: SUCCESS (0.186s) [989.248083] Starting dynamic subtest: vecs1 [989.421291] Dynamic subtest vecs1: SUCCESS (0.187s) [989.436074] Starting dynamic subtest: ccs0 [989.614715] Dynamic subtest ccs0: SUCCESS (0.192s) [989.615686] Subtest pi-shared-iova: SUCCESS (1.391s) [990.079815] [123/131] ( 42s left) syncobj_wait (invalid-reset-illegal-handle) [990.160021] Starting subtest: invalid-reset-illegal-handle [990.160969] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [990.375116] [124/131] ( 41s left) syncobj_wait (single-wait-all-for-submit-signaled) [990.459020] Starting subtest: single-wait-all-for-submit-signaled [990.459957] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [990.663688] [125/131] ( 41s left) kms_cursor_crc (cursor-sliding-512x170) [991.145714] Starting subtest: cursor-sliding-512x170 [991.147523] Subtest cursor-sliding-512x170: SKIP (0.001s) [991.388378] [126/131] ( 41s left) kms_chamelium_hpd (hdmi-hpd-fast) [991.663284] Subtest hdmi-hpd-fast: SKIP (0.000s) [991.813361] [127/131] ( 40s left) gem_ctx_persistence (hostile) [991.905404] Starting subtest: hostile [1000.788374] Subtest hostile: SUCCESS (8.879s) [1001.006403] [128/131] ( 31s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [1001.196854] Starting subtest: fbc-rgb565-draw-blt [1003.824096] Subtest fbc-rgb565-draw-blt: SUCCESS (2.627s) [1004.077324] [129/131] ( 28s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [1004.265485] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [1004.267146] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s) [1004.459853] [130/131] ( 28s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [1004.650747] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [1004.652584] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [1004.840025] [131/131] ( 28s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [1005.031853] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [1005.033671] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [1005.223326] Closing watchdogs results: parsing output: 0/ for test: kms_big_fb results: parsing output: 1/ for test: gem_exec_fence results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: gem_exec_balancer results: parsing output: 5/ for test: kms_chamelium_color results: parsing output: 6/ for test: gem_workarounds results: parsing output: 7/ for test: kms_plane_scaling results: parsing output: 8/ for test: gem_pxp results: parsing output: 9/ for test: gem_exec_params results: parsing output: 10/ for test: gem_exec_nop results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_psr results: parsing output: 13/ for test: i915_pm_rps results: parsing output: 14/ for test: gem_softpin results: parsing output: 15/ for test: syncobj_timeline results: parsing output: 16/ for test: kms_panel_fitting results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: api_intel_bb results: parsing output: 19/ for test: kms_ccs results: parsing output: 20/ for test: syncobj_wait results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: gem_lmem_swapping results: parsing output: 23/ for test: kms_async_flips results: parsing output: 24/ for test: kms_psr2_sf results: parsing output: 25/ for test: kms_plane_multiple results: parsing output: 26/ for test: gem_ctx_param results: parsing output: 27/ for test: kms_ccs results: parsing output: 28/ for test: kms_plane_scaling results: parsing output: 29/ for test: syncobj_timeline results: parsing output: 30/ for test: perf results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_pm_rpm results: parsing output: 33/ for test: kms_vblank results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: kms_pipe_crc_basic results: parsing output: 36/ for test: kms_cursor_legacy results: parsing output: 37/ for test: kms_psr2_sf results: parsing output: 38/ for test: gem_unref_active_buffers results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: syncobj_wait results: parsing output: 41/ for test: gen9_exec_parse results: parsing output: 42/ for test: syncobj_timeline results: parsing output: 43/ for test: gem_exec_reloc results: parsing output: 44/ for test: gem_mmap_offset results: parsing output: 45/ for test: kms_cursor_legacy results: parsing output: 46/ for test: kms_rotation_crc results: parsing output: 47/ for test: kms_big_fb results: parsing output: 48/ for test: gem_create results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: perf results: parsing output: 51/ for test: perf results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: kms_cursor_crc results: parsing output: 54/ for test: kms_rotation_crc results: parsing output: 55/ for test: kms_cursor_crc results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_async_flips results: parsing output: 58/ for test: perf results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: syncobj_timeline results: parsing output: 61/ for test: kms_rmfb results: parsing output: 62/ for test: gem_userptr_blits results: parsing output: 63/ for test: gem_exec_reloc results: parsing output: 64/ for test: api_intel_allocator results: parsing output: 65/ for test: kms_lease results: parsing output: 66/ for test: kms_cursor_legacy results: parsing output: 67/ for test: syncobj_wait results: parsing output: 68/ for test: kms_psr results: parsing output: 69/ for test: kms_ccs results: parsing output: 70/ for test: kms_psr results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_flip_scaled_crc results: parsing output: 73/ for test: gem_exec_schedule results: parsing output: 74/ for test: i915_drm_fdinfo results: parsing output: 75/ for test: i915_selftest results: parsing output: 76/ for test: gem_userptr_blits results: parsing output: 77/ for test: kms_ccs results: parsing output: 78/ for test: gem_softpin results: parsing output: 79/ for test: kms_draw_crc results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: syncobj_timeline results: parsing output: 83/ for test: gem_mmap_gtt results: parsing output: 84/ for test: perf_pmu results: parsing output: 85/ for test: kms_addfb_basic results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: gem_render_copy results: parsing output: 88/ for test: kms_flip results: parsing output: 89/ for test: gem_exec_schedule results: parsing output: 90/ for test: kms_sequence results: parsing output: 91/ for test: gem_gtt_cpu_tlb results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: gem_eio results: parsing output: 94/ for test: gem_partial_pwrite_pread results: parsing output: 95/ for test: sysfs_preempt_timeout results: parsing output: 96/ for test: gem_busy results: parsing output: 97/ for test: sriov_basic results: parsing output: 98/ for test: kms_pm_lpsp results: parsing output: 99/ for test: gem_exec_capture results: parsing output: 100/ for test: gem_lmem_swapping results: parsing output: 101/ for test: kms_joiner results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_color results: parsing output: 104/ for test: gem_exec_schedule results: parsing output: 105/ for test: kms_flip_scaled_crc results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: gem_ppgtt results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_chamelium_frames results: parsing output: 110/ for test: kms_psr2_su results: parsing output: 111/ for test: gem_tiling_max_stride results: parsing output: 112/ for test: perf_pmu results: parsing output: 113/ for test: dmabuf_sync_file results: parsing output: 114/ for test: gem_exec_reloc results: parsing output: 115/ for test: kms_hdr results: parsing output: 116/ for test: perf results: parsing output: 117/ for test: gem_ctx_isolation results: parsing output: 118/ for test: gem_render_copy results: parsing output: 119/ for test: kms_atomic_transition results: parsing output: 120/ for test: i915_hangman results: parsing output: 121/ for test: gem_exec_schedule results: parsing output: 122/ for test: syncobj_wait results: parsing output: 123/ for test: syncobj_wait results: parsing output: 124/ for test: kms_cursor_crc results: parsing output: 125/ for test: kms_chamelium_hpd results: parsing output: 126/ for test: gem_ctx_persistence results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_frontbuffer_tracking Done.