[61.156441] Initializing watchdogs
[61.156485]   /dev/watchdog0
[61.174221] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[61.178887] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.181271] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.184620] [001/133] (960s left) gem_exec_fence (syncobj-import)
[61.662101] Starting subtest: syncobj-import
[61.670266] Subtest syncobj-import: SUCCESS (0.008s)
[63.075022] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[63.078066] [002/133] (958s left) api_intel_bb (delta-check)
[63.136673] Starting subtest: delta-check
[63.144789] Subtest delta-check: SUCCESS (0.010s)
[63.263207] [003/133] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[63.370167] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[63.374386] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[63.497097] [004/133] (958s left) gem_pwrite (basic-exhaustion)
[63.554992] Subtest basic-exhaustion: SKIP (0.000s)
[63.611486] [005/133] (958s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[63.725685] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[81.228233] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.504s)
[82.131280] [006/133] (939s left) gem_lmem_swapping (random-engines)
[82.178963] Subtest random-engines: SKIP (0.000s)
[82.215320] [007/133] (939s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[82.255522] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[82.294311] [008/133] (939s left) kms_selftest (drm_dp_mst_helper)
[82.335839] Starting subtest: drm_dp_mst_helper
[82.343047] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[82.485431] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.142s)
[82.494111] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[82.641101] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.154s)
[82.649207] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[82.788112] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.148s)
[82.789930] Subtest drm_dp_mst_helper: SUCCESS (0.454s)
[83.012065] [009/133] (938s left) gem_softpin (softpin)
[83.089922] Starting subtest: softpin
[115.321863] Subtest softpin: SUCCESS (32.225s)
[115.485146] [010/133] (906s left) gem_exec_reloc (basic-write-cpu-active)
[115.547231] Subtest basic-write-cpu-active: SKIP (0.000s)
[115.623475] [011/133] (906s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[115.884531] Starting subtest: cursor-rapid-movement-256x85
[115.936037] Subtest cursor-rapid-movement-256x85: SKIP (0.048s)
[116.147926] [012/133] (905s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[116.251054] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[116.253353] Starting dynamic subtest: pipe-A-eDP-1
[116.276092] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[116.284934] Starting dynamic subtest: pipe-B-eDP-1
[116.306611] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[116.313966] Starting dynamic subtest: pipe-C-eDP-1
[116.335529] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[116.342461] Starting dynamic subtest: pipe-D-eDP-1
[116.360372] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[116.363851] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[118.517168] [013/133] (903s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[118.616672] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[119.583970] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.967s)
[119.757249] [014/133] (902s left) kms_flip (2x-plain-flip-fb-recreate)
[119.854522] Starting subtest: 2x-plain-flip-fb-recreate
[119.864733] Subtest 2x-plain-flip-fb-recreate: SKIP (0.010s)
[119.999967] [015/133] (902s left) kms_properties (colorop-properties-atomic)
[120.094327] Starting subtest: colorop-properties-atomic
[120.096222] Starting dynamic subtest: pipe-A-eDP-1
[120.433045] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.338s)
[120.440803] Starting dynamic subtest: pipe-B-eDP-1
[121.547649] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.113s)
[121.558334] Starting dynamic subtest: pipe-C-eDP-1
[122.583386] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.033s)
[122.592298] Starting dynamic subtest: pipe-D-eDP-1
[123.609038] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.026s)
[123.611354] Subtest colorop-properties-atomic: SUCCESS (3.514s)
[124.426356] [016/133] (897s left) syncobj_wait (invalid-signal-one-illegal-handle)
[124.494748] Starting subtest: invalid-signal-one-illegal-handle
[124.497125] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[124.637857] [017/133] (897s left) kms_panel_fitting (legacy)
[124.742405] Starting subtest: legacy
[124.744616] Starting dynamic subtest: pipe-A-eDP-1
[125.277265] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.535s)
[125.302738] Starting dynamic subtest: pipe-B-eDP-1
[126.848864] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.552s)
[126.875799] Starting dynamic subtest: pipe-C-eDP-1
[128.373601] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.504s)
[128.397996] Starting dynamic subtest: pipe-D-eDP-1
[129.922866] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.530s)
[129.925322] Subtest legacy: SUCCESS (5.181s)
[131.147915] [018/133] (891s left) kms_draw_crc (draw-method-pwrite)
[131.244310] Starting subtest: draw-method-pwrite
[131.246444] Starting dynamic subtest: xrgb8888-untiled
[131.798404] Dynamic subtest xrgb8888-untiled: SUCCESS (0.556s)
[131.806823] Starting dynamic subtest: rgb565-untiled
[132.242705] Dynamic subtest rgb565-untiled: SUCCESS (0.442s)
[132.251986] Starting dynamic subtest: xrgb2101010-untiled
[132.776971] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.533s)
[132.785551] Starting dynamic subtest: xbgr16161616f-untiled
[133.575772] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.798s)
[133.585523] Starting dynamic subtest: xrgb8888-xtiled
[135.275667] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.700s)
[135.283889] Starting dynamic subtest: rgb565-xtiled
[136.331295] Dynamic subtest rgb565-xtiled: SUCCESS (1.055s)
[136.338576] Starting dynamic subtest: xrgb2101010-xtiled
[138.053703] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.722s)
[138.062096] Starting dynamic subtest: xbgr16161616f-xtiled
[141.220722] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.166s)
[141.228068] Starting dynamic subtest: xrgb8888-4tiled
[142.298188] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.077s)
[142.307691] Starting dynamic subtest: rgb565-4tiled
[142.842790] Dynamic subtest rgb565-4tiled: SUCCESS (0.544s)
[142.851881] Starting dynamic subtest: xrgb2101010-4tiled
[143.909308] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.066s)
[143.917308] Starting dynamic subtest: xbgr16161616f-4tiled
[146.788052] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.877s)
[146.790264] Subtest draw-method-pwrite: SUCCESS (15.545s)
[146.915751] [019/133] (875s left) syncobj_timeline (host-signal-points)
[146.983903] Starting subtest: host-signal-points
[146.988404] Subtest host-signal-points: SUCCESS (0.004s)
[147.128386] [020/133] (875s left) gem_exec_params (invalid-batch-start-offset)
[147.191216] Starting subtest: invalid-batch-start-offset
[147.193606] Subtest invalid-batch-start-offset: SUCCESS (0.005s)
[147.359284] [021/133] (875s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[147.464529] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[154.790213] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.327s)
[154.950511] [022/133] (867s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[155.043869] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[155.046227] Starting dynamic subtest: A-eDP1
[163.980125] Dynamic subtest A-eDP1: SUCCESS (8.935s)
[163.991080] Starting dynamic subtest: B-eDP1
[172.898607] Dynamic subtest B-eDP1: SUCCESS (8.915s)
[172.907141] Starting dynamic subtest: C-eDP1
[181.820379] Dynamic subtest C-eDP1: SUCCESS (8.920s)
[181.829703] Starting dynamic subtest: D-eDP1
[190.670762] Dynamic subtest D-eDP1: SUCCESS (8.850s)
[190.673286] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.629s)
[191.911766] [023/133] (830s left) gem_exec_nop (basic-sequential)
[191.985300] Starting subtest: basic-sequential
[208.009952] Subtest basic-sequential: SUCCESS (16.033s)
[208.289421] [024/133] (814s left) kms_chamelium_frames (hdmi-frame-dump)
[208.676487] Subtest hdmi-frame-dump: SKIP (0.000s)
[209.498401] [025/133] (813s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[209.589293] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[216.936561] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.349s)
[217.086837] [026/133] (805s left) gem_ctx_shared (q-in-order)
[217.144200] Starting subtest: Q-in-order
[217.146595] Starting dynamic subtest: rcs0
[217.255882] Dynamic subtest rcs0: SUCCESS (0.110s)
[217.265859] Starting dynamic subtest: vcs0
[217.347463] Dynamic subtest vcs0: SUCCESS (0.091s)
[217.363274] Starting dynamic subtest: vcs1
[217.437114] Dynamic subtest vcs1: SUCCESS (0.089s)
[217.448996] Starting dynamic subtest: vecs0
[217.508853] Dynamic subtest vecs0: SUCCESS (0.070s)
[217.523709] Starting dynamic subtest: ccs0
[217.589365] Dynamic subtest ccs0: SUCCESS (0.080s)
[217.591660] Subtest Q-in-order: SUCCESS (0.446s)
[219.038966] [027/133] (803s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[219.104159] Starting subtest: single-wait-for-submit-available-submitted
[219.106436] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[219.237437] [028/133] (803s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[219.332660] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[219.334849] Starting dynamic subtest: pipe-A-eDP-1
[235.802482] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.565s)
[235.812606] Starting dynamic subtest: pipe-B-eDP-1
[252.782390] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.359s)
[252.790802] Starting dynamic subtest: pipe-C-eDP-1
[269.785310] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.363s)
[269.794466] Starting dynamic subtest: pipe-D-eDP-1
[286.787833] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.347s)
[286.790060] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.639s)
[288.008922] [029/133] (734s left) i915_drm_fdinfo (virtual-busy-hang-all)
[288.059465] Starting subtest: virtual-busy-hang-all
[288.063887] Subtest virtual-busy-hang-all: SKIP (0.000s)
[288.157986] [030/133] (734s left) kms_legacy_colorkey (invalid-plane)
[288.249174] Starting subtest: invalid-plane
[288.251333] Starting dynamic subtest: zero-id
[288.253255] Dynamic subtest zero-id: SUCCESS (0.000s)
[288.262198] Starting dynamic subtest: outrange-id
[288.264352] Dynamic subtest outrange-id: SUCCESS (0.000s)
[288.266512] Subtest invalid-plane: SUCCESS (0.001s)
[288.345646] [031/133] (734s left) gem_exec_flush (basic-wb-ro-default)
[288.409482] Starting subtest: basic-wb-ro-default
[293.861588] Subtest basic-wb-ro-default: SUCCESS (5.449s)
[294.072461] [032/133] (728s left) gem_exec_reloc (basic-wc-active)
[294.139947] Subtest basic-wc-active: SKIP (0.000s)
[294.221420] [033/133] (728s left) gem_mmap_wc (coherency)
[294.283310] Subtest coherency: SKIP (0.000s)
[294.347642] [034/133] (728s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[294.439902] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[301.743761] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.303s)
[301.917407] [035/133] (721s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[302.022042] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[305.982701] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (3.962s)
[307.168495] [036/133] (715s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[307.307225] Starting subtest: extended-modeset-hang-newfb-with-reset
[307.309381] Starting dynamic subtest: pipe-A
[322.946377] Dynamic subtest pipe-A: SUCCESS (15.636s)
[322.956289] Starting dynamic subtest: pipe-D
[338.531567] Dynamic subtest pipe-D: SUCCESS (15.582s)
[338.533895] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (31.223s)
[339.370622] [037/133] (683s left) gen7_exec_parse (basic-rejected)
[339.437614] Subtest basic-rejected: SKIP (0.000s)
[339.513019] [038/133] (683s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[339.604792] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[339.607043] Starting dynamic subtest: pipe-A-default-mode
[339.894426] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[339.899104] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.288s)
[340.705085] [039/133] (682s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[340.762062] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[340.843109] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.031s)
[340.893885] [040/133] (682s left) gem_userptr_blits (sync-unmap-cycles)
[340.966192] Starting subtest: sync-unmap-cycles
[346.346224] Subtest sync-unmap-cycles: SUCCESS (5.381s)
[346.517396] [041/133] (676s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[346.619473] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[346.623153] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[346.759797] [042/133] (676s left) kms_pm_rpm (system-suspend-modeset)
[348.882093] Starting subtest: system-suspend-modeset
[368.839097] Subtest system-suspend-modeset: SUCCESS (4.304s)
[369.222234] [043/133] (654s left) gem_ctx_param (non-root-set)
[369.281103] Starting subtest: non-root-set
[369.307272] Subtest non-root-set: SUCCESS (0.029s)
[369.429135] [044/133] (653s left) sw_sync (sync_merge_same)
[369.469012] Starting subtest: sync_merge_same
[369.471168] Subtest sync_merge_same: SUCCESS (0.000s)
[369.550244] [045/133] (653s left) gem_ccs (block-copy-compressed)
[369.607669] Starting subtest: block-copy-compressed
[369.612281] Subtest block-copy-compressed: SKIP (0.000s)
[369.739858] [046/133] (653s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[369.841852] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[376.417787] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.574s)
[376.593018] [047/133] (646s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[376.687722] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[376.689979] Starting dynamic subtest: pipe-A-eDP-1
[376.747399] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[376.757896] Starting dynamic subtest: pipe-B-eDP-1
[376.815059] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[376.825898] Starting dynamic subtest: pipe-C-eDP-1
[376.884955] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[376.895065] Starting dynamic subtest: pipe-D-eDP-1
[376.953326] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[376.957594] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[378.948350] [048/133] (644s left) gem_exec_schedule (u-lateslice)
[379.032609] Starting subtest: u-lateslice
[379.034444] Starting dynamic subtest: rcs0
[379.046065] Dynamic subtest rcs0: SUCCESS (0.023s)
[379.054832] Starting dynamic subtest: bcs0
[379.063598] Dynamic subtest bcs0: SUCCESS (0.017s)
[379.072240] Starting dynamic subtest: vcs0
[379.083489] Dynamic subtest vcs0: SUCCESS (0.019s)
[379.092171] Starting dynamic subtest: vcs1
[379.100808] Dynamic subtest vcs1: SUCCESS (0.017s)
[379.109230] Starting dynamic subtest: vecs0
[379.117946] Dynamic subtest vecs0: SUCCESS (0.017s)
[379.127433] Starting dynamic subtest: ccs0
[379.136983] Dynamic subtest ccs0: SUCCESS (0.018s)
[379.139193] Subtest u-lateslice: SUCCESS (0.115s)
[380.488966] [049/133] (643s left) gem_exec_fence (basic-wait)
[380.681511] Starting subtest: basic-wait
[380.683762] Starting dynamic subtest: rcs0
[380.774780] Dynamic subtest rcs0: SUCCESS (0.096s)
[380.784230] Starting dynamic subtest: bcs0
[380.838927] Dynamic subtest bcs0: SUCCESS (0.062s)
[380.848077] Starting dynamic subtest: vcs0
[380.891577] Dynamic subtest vcs0: SUCCESS (0.051s)
[380.903894] Starting dynamic subtest: vcs1
[380.956491] Dynamic subtest vcs1: SUCCESS (0.061s)
[380.969168] Starting dynamic subtest: vecs0
[381.023729] Dynamic subtest vecs0: SUCCESS (0.065s)
[381.035283] Starting dynamic subtest: ccs0
[381.091028] Dynamic subtest ccs0: SUCCESS (0.065s)
[381.093426] Subtest basic-wait: SUCCESS (0.414s)
[382.518226] [050/133] (641s left) kms_invalid_mode (uint-max-clock)
[382.625938] Starting subtest: uint-max-clock
[382.628201] Starting dynamic subtest: pipe-A-eDP-1
[382.911908] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[382.921506] Starting dynamic subtest: pipe-B-eDP-1
[382.923481] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[382.931820] Starting dynamic subtest: pipe-C-eDP-1
[382.934149] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[382.942924] Starting dynamic subtest: pipe-D-eDP-1
[382.945214] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[382.947441] Subtest uint-max-clock: SUCCESS (0.293s)
[383.768393] [051/133] (639s left) kms_cursor_crc (cursor-onscreen-max-size)
[384.073794] Starting subtest: cursor-onscreen-max-size
[384.080257] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[384.239556] [052/133] (639s left) gem_exec_balancer (bonded-sync)
[384.310695] Starting subtest: bonded-sync
[384.315311] Subtest bonded-sync: SKIP (0.000s)
[384.629394] [053/133] (639s left) vgem_basic (dmabuf-fence)
[384.675159] Starting subtest: dmabuf-fence
[384.677231] Subtest dmabuf-fence: SUCCESS (0.000s)
[384.764570] [054/133] (639s left) kms_getfb (getfb-repeated-different-handles)
[384.854696] Starting subtest: getfb-repeated-different-handles
[384.856940] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[384.975735] [055/133] (638s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[385.085384] Starting subtest: fbc-1p-pri-indfb-multidraw
[398.148049] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.063s)
[399.585730] [056/133] (624s left) kms_async_flips (alternate-sync-async-flip-atomic)
[399.693926] Starting subtest: alternate-sync-async-flip-atomic
[400.066998] Starting dynamic subtest: pipe-A-eDP-1
[402.839417] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.775s)
[403.230652] Starting dynamic subtest: pipe-B-eDP-1
[405.976798] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.754s)
[406.360280] Starting dynamic subtest: pipe-C-eDP-1
[409.103056] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.758s)
[409.467243] Starting dynamic subtest: pipe-D-eDP-1
[412.227181] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s)
[412.229218] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.537s)
[413.413163] [057/133] (610s left) prime_mmap (test_invalid_sync_flags)
[413.487249] Starting subtest: test_invalid_sync_flags
[413.489634] Starting dynamic subtest: test_invalid_sync_flags-smem
[413.491654] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[413.493698] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[413.620792] [058/133] (610s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[413.724926] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[413.729252] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[413.856807] [059/133] (610s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[413.975965] Starting subtest: cursor-vs-flip-atomic-transitions
[443.739352] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.759s)
[444.556816] [060/133] (579s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[444.674003] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[444.678367] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[444.797315] [061/133] (579s left) kms_content_protection (lic-type-1)
[444.937253] Starting subtest: lic-type-1
[444.941848] Subtest lic-type-1: SKIP (0.000s)
[445.093188] [062/133] (579s left) gen3_render_tiledx_blits
[445.209121] [063/133] (579s left) sysfs_heartbeat_interval (precise)
[445.272464] Starting subtest: precise
[445.274853] Starting dynamic subtest: vecs0
[453.390407] Dynamic subtest vecs0: SUCCESS (8.115s)
[453.406982] Starting dynamic subtest: ccs0
[454.594492] Dynamic subtest ccs0: SUCCESS (1.201s)
[454.606155] Starting dynamic subtest: vcs0
[462.342246] Dynamic subtest vcs0: SUCCESS (7.741s)
[462.354160] Starting dynamic subtest: bcs0
[463.528620] Dynamic subtest bcs0: SUCCESS (1.187s)
[463.539819] Starting dynamic subtest: rcs0
[464.615515] Dynamic subtest rcs0: SUCCESS (1.087s)
[464.627212] Starting dynamic subtest: vcs1
[472.387494] Dynamic subtest vcs1: SUCCESS (7.771s)
[472.389837] Subtest precise: SUCCESS (27.113s)
[472.488185] [064/133] (551s left) kms_pm_dc (dc5-psr)
[473.589501] Starting subtest: dc5-psr
[476.461159] Subtest dc5-psr: SUCCESS (2.872s)
[477.294470] [065/133] (547s left) gem_madvise (dontneed-before-pwrite)
[477.334708] Starting subtest: dontneed-before-pwrite
[477.364722] Subtest dontneed-before-pwrite: SKIP (0.029s)
[477.429108] [066/133] (546s left) kms_psr (pr-cursor-render)
[477.536575] Starting subtest: pr-cursor-render
[477.540633] Subtest pr-cursor-render: SKIP (0.000s)
[477.633983] [067/133] (546s left) gem_pxp (hw-rejects-pxp-context)
[477.759998] Starting subtest: hw-rejects-pxp-context
[477.764790] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[477.910629] [068/133] (546s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[478.009109] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[484.036528] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.031s)
[485.200340] [069/133] (539s left) kms_psr (fbc-pr-cursor-render)
[485.295765] Starting subtest: fbc-pr-cursor-render
[485.300261] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[485.394468] [070/133] (539s left) gem_ctx_param (set-priority-range)
[485.445552] Starting subtest: set-priority-range
[485.462856] Subtest set-priority-range: SUCCESS (0.017s)
[485.609004] [071/133] (538s left) vgem_basic (unload)
[485.648539] Starting subtest: unload
[514.853328] Subtest unload: SUCCESS (29.202s)
[514.975476] [072/133] (509s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[515.078656] Starting subtest: y-tiled-64bpp-rotate-180
[515.083292] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[515.212577] [073/133] (509s left) kms_psr2_su (page_flip-nv12)
[515.268146] Subtest page_flip-NV12: SKIP (0.000s)
[515.339641] [074/133] (509s left) gem_ctx_isolation (clean)
[515.398095] Starting subtest: clean
[515.400423] Starting dynamic subtest: rcs0
[515.453182] Dynamic subtest rcs0: SUCCESS (0.055s)
[515.464239] Starting dynamic subtest: bcs0
[515.539883] Dynamic subtest bcs0: SUCCESS (0.085s)
[515.550758] Starting dynamic subtest: vcs0
[515.634127] Dynamic subtest vcs0: SUCCESS (0.094s)
[515.642976] Starting dynamic subtest: vcs1
[517.428886] Dynamic subtest vcs1: SUCCESS (1.781s)
[517.438276] Starting dynamic subtest: vecs0
[519.362352] Dynamic subtest vecs0: SUCCESS (1.945s)
[519.373657] Starting dynamic subtest: ccs0
[521.411351] Dynamic subtest ccs0: SUCCESS (2.048s)
[521.413844] Subtest clean: SUCCESS (6.013s)
[521.689611] [075/133] (503s left) i915_pm_rpm (sysfs-read)
[523.512865] Starting subtest: sysfs-read
[524.674340] Subtest sysfs-read: SUCCESS (1.162s)
[525.060875] [076/133] (499s left) kms_frontbuffer_tracking (psr-2p-rte)
[525.171197] Starting subtest: psr-2p-rte
[525.175519] Subtest psr-2p-rte: SKIP (0.000s)
[525.302242] [077/133] (499s left) gem_exec_whisper (basic-fds-all)
[525.369872] Starting subtest: basic-fds-all
[537.304761] Subtest basic-fds-all: SUCCESS (11.931s)
[537.509539] [078/133] (487s left) i915_drm_fdinfo (virtual-busy)
[537.552570] Starting subtest: virtual-busy
[537.557097] Subtest virtual-busy: SKIP (0.000s)
[537.640677] [079/133] (487s left) gem_spin_batch (legacy)
[537.719528] Starting subtest: legacy
[537.721962] Starting dynamic subtest: default
[540.961565] Dynamic subtest default: SUCCESS (3.236s)
[540.973894] Starting dynamic subtest: render
[544.192306] Dynamic subtest render: SUCCESS (3.228s)
[544.204208] Starting dynamic subtest: bsd
[547.445356] Dynamic subtest bsd: SUCCESS (3.230s)
[547.457580] Starting dynamic subtest: bsd1
[550.662928] Dynamic subtest bsd1: SUCCESS (3.234s)
[550.675111] Starting dynamic subtest: bsd2
[553.896485] Dynamic subtest bsd2: SUCCESS (3.230s)
[553.908721] Starting dynamic subtest: blt
[557.130533] Dynamic subtest blt: SUCCESS (3.230s)
[557.142891] Starting dynamic subtest: vebox
[560.368561] Dynamic subtest vebox: SUCCESS (3.235s)
[560.370984] Subtest legacy: SUCCESS (22.642s)
[562.421969] [080/133] (462s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[562.548074] Starting subtest: x-tiled-64bpp-rotate-0
[564.431938] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.884s)
[564.620554] [081/133] (460s left) gem_exec_nop (basic-parallel)
[564.682730] Starting subtest: basic-parallel
[581.368586] Subtest basic-parallel: SUCCESS (16.690s)
[581.662639] [082/133] (443s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[581.724739] Starting subtest: etime-multi-wait-for-submit-submitted
[581.827019] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.102s)
[581.935731] [083/133] (443s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[582.028668] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[582.030873] Starting dynamic subtest: pipe-A-eDP-1
[582.052951] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[582.068207] Starting dynamic subtest: pipe-B-eDP-1
[582.089435] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[582.098725] Starting dynamic subtest: pipe-C-eDP-1
[582.119882] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[582.129264] Starting dynamic subtest: pipe-D-eDP-1
[582.150677] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[582.154712] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[584.309671] [084/133] (440s left) dmabuf_sync_file (import-basic)
[584.350961] Starting subtest: import-basic
[584.353150] Subtest import-basic: SUCCESS (0.001s)
[584.439654] [085/133] (440s left) gem_wait (write-busy)
[584.492058] Starting subtest: write-busy
[584.494265] Starting dynamic subtest: all-engines
[585.129919] Dynamic subtest all-engines: SUCCESS (0.640s)
[585.144722] Starting dynamic subtest: rcs0
[585.686248] Dynamic subtest rcs0: SUCCESS (0.555s)
[585.704226] Starting dynamic subtest: bcs0
[586.237618] Dynamic subtest bcs0: SUCCESS (0.550s)
[586.254612] Starting dynamic subtest: vcs0
[587.384210] Dynamic subtest vcs0: SUCCESS (1.144s)
[587.401580] Starting dynamic subtest: vcs1
[589.367056] Dynamic subtest vcs1: SUCCESS (1.980s)
[589.383624] Starting dynamic subtest: vecs0
[591.351297] Dynamic subtest vecs0: SUCCESS (1.981s)
[591.367884] Starting dynamic subtest: ccs0
[591.901725] Dynamic subtest ccs0: SUCCESS (0.549s)
[591.904237] Subtest write-busy: SUCCESS (7.412s)
[592.117442] [086/133] (433s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[592.216708] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[592.220762] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[592.359990] [087/133] (432s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[592.475540] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[592.480080] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[592.619297] [088/133] (432s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[592.683447] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[592.685422] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[592.819802] [089/133] (432s left) prime_vgem (sync)
[592.904857] Starting subtest: sync
[592.906749] Starting dynamic subtest: rcs0
[592.951837] Dynamic subtest rcs0: SUCCESS (0.049s)
[592.961267] Starting dynamic subtest: bcs0
[593.022870] Dynamic subtest bcs0: SUCCESS (0.070s)
[593.032025] Starting dynamic subtest: vcs0
[593.068509] Dynamic subtest vcs0: SUCCESS (0.045s)
[593.077770] Starting dynamic subtest: vcs1
[593.117829] Dynamic subtest vcs1: SUCCESS (0.048s)
[593.126869] Starting dynamic subtest: vecs0
[593.162370] Dynamic subtest vecs0: SUCCESS (0.044s)
[593.171728] Starting dynamic subtest: ccs0
[593.209266] Dynamic subtest ccs0: SUCCESS (0.045s)
[593.211334] Subtest sync: SUCCESS (0.307s)
[593.368357] [090/133] (432s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[593.472329] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[594.464171] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.990s)
[594.621057] [091/133] (430s left) kms_vblank (query-forked-busy-hang)
[594.720880] Starting subtest: query-forked-busy-hang
[594.722654] Starting dynamic subtest: pipe-A-eDP-1
[621.118423] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.397s)
[621.133381] Starting dynamic subtest: pipe-D-eDP-1
[636.145162] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.026s)
[636.147595] Subtest query-forked-busy-hang: SUCCESS (41.427s)
[636.967958] [092/133] (388s left) api_intel_allocator (execbuf-with-allocator)
[637.042967] Starting subtest: execbuf-with-allocator
[637.049240] Subtest execbuf-with-allocator: SUCCESS (0.009s)
[637.179764] [093/133] (388s left) kms_plane_multiple (tiling-x)
[637.281582] Starting subtest: tiling-x
[637.283878] Starting dynamic subtest: pipe-A-eDP-1
[641.002317] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.722s)
[641.013933] Starting dynamic subtest: pipe-B-eDP-1
[645.385271] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.381s)
[645.394934] Starting dynamic subtest: pipe-C-eDP-1
[649.698341] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.312s)
[649.709311] Starting dynamic subtest: pipe-D-eDP-1
[654.029655] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.329s)
[654.032013] Subtest tiling-x: SUCCESS (16.749s)
[654.858565] [094/133] (370s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[654.939150] Starting subtest: map-fixed-invalidate-overlap-busy
[654.943304] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[655.106762] [095/133] (370s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[655.207734] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[655.210008] Starting dynamic subtest: pipe-A-default-mode
[655.499891] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[655.504173] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.292s)
[656.378108] [096/133] (369s left) gem_exec_suspend (basic)
[656.435824] Starting subtest: basic
[656.438224] Starting dynamic subtest: smem
[658.360377] Dynamic subtest smem: SUCCESS (1.922s)
[658.363372] Subtest basic: SUCCESS (1.924s)
[658.572461] [097/133] (367s left) kms_psr (psr-cursor-render)
[658.672822] Starting subtest: psr-cursor-render
[658.675114] Starting dynamic subtest: eDP-1
[660.360145] Dynamic subtest eDP-1: SUCCESS (1.688s)
[660.362426] Subtest psr-cursor-render: SUCCESS (1.689s)
[661.250721] [098/133] (364s left) kms_chamelium_hpd (vga-hpd)
[661.643445] Subtest vga-hpd: SKIP (0.000s)
[662.439058] [099/133] (363s left) gem_reg_read (bad-register)
[662.489290] Starting subtest: bad-register
[662.491252] Subtest bad-register: SUCCESS (0.000s)
[662.635783] [100/133] (363s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[662.743867] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[662.747951] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[662.881857] [101/133] (362s left) gem_linear_blits (basic)
[663.304237] Starting subtest: basic
[663.308791] Subtest basic: SUCCESS (0.008s)
[663.481205] [102/133] (362s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[668.532032] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[668.534390] Starting dynamic subtest: pipe-A-eDP-1
[669.338102] Dynamic subtest pipe-A-eDP-1: SKIP (0.805s)
[669.349646] Starting dynamic subtest: pipe-B-eDP-1
[670.460831] Dynamic subtest pipe-B-eDP-1: SKIP (1.118s)
[670.465391] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.927s)
[671.671548] [103/133] (354s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[671.732293] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[671.734784] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[671.829613] [104/133] (354s left) kms_plane_alpha_blend (alpha-7efc)
[671.929763] Starting subtest: alpha-7efc
[672.224528] Starting dynamic subtest: pipe-A-eDP-1
[672.848745] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.623s)
[672.880363] Starting dynamic subtest: pipe-D-eDP-1
[674.175804] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.301s)
[674.178170] Subtest alpha-7efc: SUCCESS (2.245s)
[675.036218] [105/133] (350s left) gem_ctx_persistence (heartbeat-many)
[675.098744] Starting subtest: heartbeat-many
[675.103459] Subtest heartbeat-many: SKIP (0.000s)
[675.221629] [106/133] (350s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[675.323080] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[675.327467] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[675.449939] [107/133] (350s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[675.557040] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[682.482118] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.927s)
[682.611310] [108/133] (343s left) gem_exec_schedule (manyslice)
[682.685261] Starting subtest: manyslice
[682.687548] Starting dynamic subtest: rcs0
[687.296708] Dynamic subtest rcs0: SUCCESS (4.618s)
[687.311175] Starting dynamic subtest: bcs0
[693.930112] Dynamic subtest bcs0: SUCCESS (6.631s)
[693.946484] Starting dynamic subtest: vcs0
[700.015377] Dynamic subtest vcs0: SUCCESS (6.082s)
[700.026220] Starting dynamic subtest: vcs1
[706.594755] Dynamic subtest vcs1: SUCCESS (6.579s)
[706.609703] Starting dynamic subtest: vecs0
[712.162584] Dynamic subtest vecs0: SUCCESS (5.565s)
[712.180030] Starting dynamic subtest: ccs0
[717.304851] Dynamic subtest ccs0: SUCCESS (5.140s)
[717.307318] Subtest manyslice: SUCCESS (34.625s)
[717.631187] [109/133] (308s left) kms_vrr (flip-basic-fastset)
[717.726074] Starting subtest: flip-basic-fastset
[717.732733] Subtest flip-basic-fastset: SKIP (0.000s)
[717.827801] [110/133] (308s left) gem_exec_reloc (basic-write-gtt-noreloc)
[717.900238] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[717.983033] [111/133] (308s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[718.096787] Starting subtest: cursorB-vs-flipB-legacy
[718.100994] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[718.269977] [112/133] (308s left) perf_pmu (busy-idle-check-all)
[718.307610] Starting subtest: busy-idle-check-all
[718.309942] Starting dynamic subtest: rcs0
[718.998617] Dynamic subtest rcs0: SUCCESS (0.690s)
[719.011430] Starting dynamic subtest: bcs0
[719.649139] Dynamic subtest bcs0: SUCCESS (0.648s)
[719.661745] Starting dynamic subtest: vcs0
[721.336011] Dynamic subtest vcs0: SUCCESS (1.682s)
[721.347608] Starting dynamic subtest: vcs1
[723.381644] Dynamic subtest vcs1: SUCCESS (2.044s)
[723.396091] Starting dynamic subtest: vecs0
[725.367923] Dynamic subtest vecs0: SUCCESS (1.981s)
[725.381397] Starting dynamic subtest: ccs0
[726.023862] Dynamic subtest ccs0: SUCCESS (0.655s)
[726.026249] Subtest busy-idle-check-all: SUCCESS (7.717s)
[726.181779] [113/133] (300s left) gem_mmap_offset (basic-uaf)
[726.246271] Starting subtest: basic-uaf
[726.248532] Subtest basic-uaf: SUCCESS (0.001s)
[726.363897] [114/133] (299s left) kms_invalid_mode (bad-hsync-start)
[726.468709] Starting subtest: bad-hsync-start
[726.470865] Starting dynamic subtest: pipe-A-eDP-1
[726.751578] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[726.761799] Starting dynamic subtest: pipe-B-eDP-1
[726.763637] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[726.773770] Starting dynamic subtest: pipe-C-eDP-1
[726.775906] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[726.785938] Starting dynamic subtest: pipe-D-eDP-1
[726.788071] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[726.790221] Subtest bad-hsync-start: SUCCESS (0.290s)
[727.646774] [115/133] (298s left) kms_chamelium_color (ctm-0-50)
[727.748205] Subtest ctm-0-50: SKIP (0.000s)
[727.796400] [116/133] (298s left) perf (invalid-oa-format-id)
[727.940247] Starting subtest: invalid-oa-format-id
[727.955826] Subtest invalid-oa-format-id: SUCCESS (0.014s)
[727.995504] [117/133] (298s left) gem_ringfill (legacy-basic)
[733.370744] Starting subtest: legacy-basic
[733.373362] Starting dynamic subtest: default
[733.433254] Dynamic subtest default: SUCCESS (0.062s)
[733.445978] Starting dynamic subtest: render
[733.474511] Dynamic subtest render: SUCCESS (0.040s)
[733.485111] Starting dynamic subtest: bsd
[733.516784] Dynamic subtest bsd: SUCCESS (0.040s)
[733.527909] Starting dynamic subtest: bsd1
[733.559702] Dynamic subtest bsd1: SUCCESS (0.041s)
[733.573041] Starting dynamic subtest: bsd2
[733.599699] Dynamic subtest bsd2: SUCCESS (0.037s)
[733.611877] Starting dynamic subtest: blt
[733.645511] Dynamic subtest blt: SUCCESS (0.043s)
[733.656296] Starting dynamic subtest: vebox
[733.688490] Dynamic subtest vebox: SUCCESS (0.041s)
[733.690811] Subtest legacy-basic: SUCCESS (0.321s)
[733.793980] [118/133] (292s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-mmap-wc)
[733.900890] Starting subtest: fbcpsr-argb161616f-draw-mmap-wc
[733.905144] Subtest fbcpsr-argb161616f-draw-mmap-wc: SKIP (0.000s)
[734.049200] [119/133] (292s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[734.160714] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[734.163042] Starting dynamic subtest: pipe-A
[734.183188] Dynamic subtest pipe-A: SKIP (0.018s)
[734.194632] Starting dynamic subtest: pipe-B
[734.214363] Dynamic subtest pipe-B: SKIP (0.031s)
[734.224800] Starting dynamic subtest: pipe-C
[734.244550] Dynamic subtest pipe-C: SKIP (0.030s)
[734.254884] Starting dynamic subtest: pipe-D
[734.275150] Dynamic subtest pipe-D: SKIP (0.030s)
[734.278823] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.111s)
[734.403937] [120/133] (292s left) kms_psr (fbc-psr-primary-blt)
[734.502751] Starting subtest: fbc-psr-primary-blt
[734.504612] Starting dynamic subtest: eDP-1
[734.508036] Dynamic subtest eDP-1: SKIP (0.000s)
[734.511394] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[734.602733] [121/133] (292s left) i915_selftest (perf)
[739.334510] Starting subtest: perf
[739.336652] Starting dynamic subtest: engine_cs
[743.875231] Dynamic subtest engine_cs: SUCCESS (4.539s)
[743.890550] Starting dynamic subtest: request
[751.266187] Dynamic subtest request: SUCCESS (7.388s)
[751.276280] Starting dynamic subtest: migrate
[755.742751] Dynamic subtest migrate: SUCCESS (4.474s)
[755.753228] Starting dynamic subtest: region
[760.135937] Dynamic subtest region: SUCCESS (4.390s)
[760.138590] Subtest perf: SUCCESS (20.799s)
[760.167172] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[760.167969] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[760.171121] [122/133] (266s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[761.758533] Starting subtest: 4-tiled-32bpp-rotate-0
[763.190808] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.432s)
[763.371727] [FACT kms_big_fb (4-tiled-32bpp-rotate-0)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[763.372886] [FACT kms_big_fb (4-tiled-32bpp-rotate-0)] new: kernel.kmod_is_loaded.i915: true
[763.376092] [123/133] (263s left) kms_cursor_crc (cursor-sliding-64x21)
[763.586804] Starting subtest: cursor-sliding-64x21
[763.635107] Subtest cursor-sliding-64x21: SKIP (0.045s)
[763.897691] [124/133] (262s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[763.988933] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[767.904129] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.916s)
[769.099948] [125/133] (257s left) kms_async_flips (crc-atomic)
[769.208341] Starting subtest: crc-atomic
[769.598778] Starting dynamic subtest: pipe-A-eDP-1
[772.490607] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.891s)
[772.876353] Starting dynamic subtest: pipe-B-eDP-1
[775.815480] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.949s)
[776.206664] Starting dynamic subtest: pipe-C-eDP-1
[779.119686] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.923s)
[779.483500] Starting dynamic subtest: pipe-D-eDP-1
[782.347724] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.873s)
[782.350027] Subtest crc-atomic: SUCCESS (13.139s)
[783.537095] [126/133] (243s left) gem_exec_parallel (contexts)
[783.610424] Starting subtest: contexts
[783.612771] Starting dynamic subtest: rcs0
[786.275798] Dynamic subtest rcs0: SUCCESS (2.662s)
[786.287708] Starting dynamic subtest: bcs0
[789.573887] Dynamic subtest bcs0: SUCCESS (3.296s)
[789.586416] Starting dynamic subtest: vcs0
[793.821734] Dynamic subtest vcs0: SUCCESS (4.244s)
[793.838283] Starting dynamic subtest: vcs1
[797.819121] Dynamic subtest vcs1: SUCCESS (3.997s)
[797.834815] Starting dynamic subtest: vecs0
[801.810042] Dynamic subtest vecs0: SUCCESS (3.988s)
[801.822569] Starting dynamic subtest: ccs0
[805.487717] Dynamic subtest ccs0: SUCCESS (3.676s)
[805.490713] Subtest contexts: SUCCESS (21.874s)
[805.710532] [127/133] (221s left) kms_psr (psr2-cursor-mmap-cpu)
[805.816476] Starting subtest: psr2-cursor-mmap-cpu
[805.824414] Starting dynamic subtest: eDP-1
[807.500342] Dynamic subtest eDP-1: SUCCESS (1.684s)
[807.502647] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.685s)
[808.403994] [128/133] (218s left) gem_create (hog-create)
[808.469446] Starting subtest: hog-create
[808.471828] Starting dynamic subtest: smem0
[842.386294] Dynamic subtest smem0: SUCCESS (33.910s)
[842.389187] Subtest hog-create: SUCCESS (33.912s)
[842.602937] [129/133] (184s left) kms_cursor_legacy (forked-bo)
[842.723653] Starting subtest: forked-bo
[842.725908] Starting dynamic subtest: pipe-A
[848.177891] Dynamic subtest pipe-A: SUCCESS (5.451s)
[848.188737] Starting dynamic subtest: pipe-B
[853.647743] Dynamic subtest pipe-B: SUCCESS (5.468s)
[853.661249] Starting dynamic subtest: pipe-C
[859.117214] Dynamic subtest pipe-C: SUCCESS (5.468s)
[859.131516] Starting dynamic subtest: pipe-D
[864.577675] Dynamic subtest pipe-D: SUCCESS (5.459s)
[864.590014] Starting dynamic subtest: all-pipes
[870.061749] Dynamic subtest all-pipes: SUCCESS (5.482s)
[870.064318] Subtest forked-bo: SUCCESS (27.338s)
[870.234820] [130/133] (156s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[870.368210] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[870.372472] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[870.512567] [131/133] (156s left) kms_color_pipeline (plane-lut1d)
[870.613732] Starting subtest: plane-lut1d
[870.627379] Starting dynamic subtest: pipe-A-eDP-1
[871.286531] Dynamic subtest pipe-A-eDP-1: FAIL (0.308s)
[871.950908] Starting dynamic subtest: pipe-B-eDP-1
[872.765334] Dynamic subtest pipe-B-eDP-1: FAIL (0.302s)
[873.277583] Starting dynamic subtest: pipe-C-eDP-1
[874.091008] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[874.612284] Starting dynamic subtest: pipe-D-eDP-1
[875.435385] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[875.437768] Subtest plane-lut1d: FAIL (4.507s)
[876.023414] [132/133] (151s left) gem_pipe_control_store_loop (fresh-buffer)
[876.096906] Starting subtest: fresh-buffer
[878.248462] Subtest fresh-buffer: SUCCESS (2.151s)
[878.414862] [133/133] (148s left) kms_addfb_basic (bo-too-small)
[878.527672] Starting subtest: bo-too-small
[878.529964] Subtest bo-too-small: SUCCESS (0.000s)
[878.661717] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_fence
results: parsing output: 1/ for test: api_intel_bb
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_pwrite
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: gem_lmem_swapping
results: parsing output: 6/ for test: gem_lmem_swapping
results: parsing output: 7/ for test: kms_selftest
results: parsing output: 8/ for test: gem_softpin
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_cursor_crc
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: kms_properties
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: kms_panel_fitting
results: parsing output: 17/ for test: kms_draw_crc
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: gem_exec_params
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: gem_exec_nop
results: parsing output: 23/ for test: kms_chamelium_frames
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_ctx_shared
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: i915_drm_fdinfo
results: parsing output: 29/ for test: kms_legacy_colorkey
results: parsing output: 30/ for test: gem_exec_flush
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: gem_mmap_wc
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_busy
results: parsing output: 36/ for test: gen7_exec_parse
results: parsing output: 37/ for test: kms_flip_scaled_crc
results: parsing output: 38/ for test: sriov_basic
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_pm_rpm
results: parsing output: 42/ for test: gem_ctx_param
results: parsing output: 43/ for test: sw_sync
results: parsing output: 44/ for test: gem_ccs
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: gem_exec_fence
results: parsing output: 49/ for test: kms_invalid_mode
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: gem_exec_balancer
results: parsing output: 52/ for test: vgem_basic
results: parsing output: 53/ for test: kms_getfb
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_async_flips
results: parsing output: 56/ for test: prime_mmap
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_content_protection
results: parsing output: 61/ for test: gen3_render_tiledx_blits
results: parsing output: 62/ for test: sysfs_heartbeat_interval
results: parsing output: 63/ for test: kms_pm_dc
results: parsing output: 64/ for test: gem_madvise
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: gem_pxp
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: gem_ctx_param
results: parsing output: 70/ for test: vgem_basic
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_psr2_su
results: parsing output: 73/ for test: gem_ctx_isolation
results: parsing output: 74/ for test: i915_pm_rpm
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_exec_whisper
results: parsing output: 77/ for test: i915_drm_fdinfo
results: parsing output: 78/ for test: gem_spin_batch
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: gem_exec_nop
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: dmabuf_sync_file
results: parsing output: 84/ for test: gem_wait
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: prime_vgem
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_vblank
results: parsing output: 91/ for test: api_intel_allocator
results: parsing output: 92/ for test: kms_plane_multiple
results: parsing output: 93/ for test: gem_userptr_blits
results: parsing output: 94/ for test: kms_flip_scaled_crc
results: parsing output: 95/ for test: gem_exec_suspend
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_chamelium_hpd
results: parsing output: 98/ for test: gem_reg_read
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_linear_blits
results: parsing output: 101/ for test: kms_psr2_sf
results: parsing output: 102/ for test: syncobj_wait
results: parsing output: 103/ for test: kms_plane_alpha_blend
results: parsing output: 104/ for test: gem_ctx_persistence
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: kms_vrr
results: parsing output: 109/ for test: gem_exec_reloc
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: gem_mmap_offset
results: parsing output: 113/ for test: kms_invalid_mode
results: parsing output: 114/ for test: kms_chamelium_color
results: parsing output: 115/ for test: perf
results: parsing output: 116/ for test: gem_ringfill
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_plane_scaling
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: i915_selftest
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_cursor_crc
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_async_flips
results: parsing output: 125/ for test: gem_exec_parallel
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: gem_create
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_color_pipeline
results: parsing output: 131/ for test: gem_pipe_control_store_loop
results: parsing output: 132/ for test: kms_addfb_basic
Done.