[62.474195] Initializing watchdogs
[62.474239]   /dev/watchdog0
[62.489055] [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]
[62.493610] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.495925] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.497900] [001/133] (960s left) gem_spin_batch (legacy-resubmit)
[62.565094] Starting subtest: legacy-resubmit
[62.566066] Starting dynamic subtest: default
[62.574561] Dynamic subtest default: SUCCESS (0.010s)
[62.582471] Starting dynamic subtest: render
[62.583323] Dynamic subtest render: SUCCESS (0.002s)
[62.588768] Starting dynamic subtest: bsd
[62.589666] Dynamic subtest bsd: SUCCESS (0.003s)
[62.595367] Starting dynamic subtest: bsd1
[62.596367] Dynamic subtest bsd1: SUCCESS (0.004s)
[62.601951] Starting dynamic subtest: bsd2
[62.602971] Dynamic subtest bsd2: SUCCESS (0.001s)
[62.609977] Starting dynamic subtest: blt
[62.610926] Dynamic subtest blt: SUCCESS (0.003s)
[62.616089] Starting dynamic subtest: vebox
[62.616901] Dynamic subtest vebox: SUCCESS (0.003s)
[62.617785] Subtest legacy-resubmit: SUCCESS (0.029s)
[62.831932] [002/133] (960s left) perf (gen12-group-exclusive-stream-sample-oa)
[62.964273] Starting subtest: gen12-group-exclusive-stream-sample-oa
[62.975559] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.020s)
[63.006353] [003/133] (960s left) gem_ctx_persistence (heartbeat-close)
[63.067964] Starting subtest: heartbeat-close
[63.069923] Subtest heartbeat-close: SKIP (0.000s)
[63.189321] [004/133] (959s left) perf_pmu (rc6-all-gts)
[63.221616] Starting subtest: rc6-all-gts
[69.593248] Subtest rc6-all-gts: SUCCESS (6.369s)
[69.950922] [005/133] (953s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[70.048433] Starting subtest: psr-rgb565-draw-mmap-gtt
[70.049982] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[70.183678] [006/133] (952s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[70.303377] Starting subtest: yf-tiled-addfb-size-overflow
[70.305362] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[70.420302] [007/133] (952s left) kms_flip (dpms-vs-vblank-race)
[70.500035] Starting subtest: dpms-vs-vblank-race
[70.502391] Starting dynamic subtest: A-eDP1
[74.387245] Dynamic subtest A-eDP1: SUCCESS (3.887s)
[74.394173] Starting dynamic subtest: B-eDP1
[79.016974] Dynamic subtest B-eDP1: SUCCESS (4.628s)
[79.027848] Starting dynamic subtest: C-eDP1
[82.536355] Dynamic subtest C-eDP1: SUCCESS (3.521s)
[82.543233] Starting dynamic subtest: D-eDP1
[87.161630] Dynamic subtest D-eDP1: SUCCESS (4.624s)
[87.162705] Subtest dpms-vs-vblank-race: SUCCESS (16.666s)
[88.037782] [008/133] (935s left) gem_eio (in-flight-internal-immediate)
[88.200611] Starting subtest: in-flight-internal-immediate
[89.978936] Subtest in-flight-internal-immediate: SUCCESS (1.779s)
[90.152725] [009/133] (933s left) gem_exec_whisper (basic-queues-forked-all)
[90.221424] Starting subtest: basic-queues-forked-all
[112.274032] Subtest basic-queues-forked-all: SUCCESS (22.005s)
[112.415428] [010/133] (910s left) gem_mmap_gtt (basic-small-copy-xy)
[112.467320] Subtest basic-small-copy-XY: SKIP (0.000s)
[112.519081] [011/133] (910s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[112.613356] Starting subtest: y-tiled-32bpp-rotate-180
[112.615218] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[112.728327] [012/133] (910s left) gem_exec_capture (userptr)
[112.789146] Starting subtest: userptr
[113.623533] Subtest userptr: SUCCESS (0.834s)
[113.783423] [013/133] (909s left) gem_userptr_blits (map-fixed-invalidate)
[113.847493] Starting subtest: map-fixed-invalidate
[113.849100] Subtest map-fixed-invalidate: SKIP (0.000s)
[113.960738] [014/133] (909s left) kms_pm_backlight (fade)
[114.053392] Starting subtest: fade
[114.123158] Starting dynamic subtest: eDP-1
[116.805267] Dynamic subtest eDP-1: SUCCESS (2.679s)
[116.806143] Subtest fade: SUCCESS (2.750s)
[117.684784] [015/133] (905s left) gem_render_copy_redux (interruptible)
[117.735818] Starting subtest: interruptible
[118.023493] Subtest interruptible: SUCCESS (0.288s)
[118.151410] [016/133] (905s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[118.251477] Starting subtest: 4-tiled-16bpp-rotate-0
[119.520359] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.269s)
[119.675413] [017/133] (903s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[119.731914] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[119.733725] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[119.918721] [018/133] (903s left) gem_flink_basic (double-flink)
[119.974207] Starting subtest: double-flink
[119.975090] Subtest double-flink: SUCCESS (0.000s)
[120.088310] [019/133] (903s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[120.183062] Starting subtest: crc-primary-basic-yf-tiled-ccs
[120.184035] Starting dynamic subtest: pipe-A-eDP-1
[120.192601] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[120.201736] Starting dynamic subtest: pipe-B-eDP-1
[120.209767] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[120.217324] Starting dynamic subtest: pipe-C-eDP-1
[120.225576] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[120.233980] Starting dynamic subtest: pipe-D-eDP-1
[120.241637] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[120.243354] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.004s)
[122.428820] [020/133] (901s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[122.530615] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[122.532513] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[122.669510] [021/133] (900s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[122.760347] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[122.761224] Starting dynamic subtest: pipe-A-eDP-1
[122.769464] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[122.776622] Starting dynamic subtest: pipe-B-eDP-1
[122.785815] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[122.795091] Starting dynamic subtest: pipe-C-eDP-1
[122.803687] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[122.810531] Starting dynamic subtest: pipe-D-eDP-1
[122.818426] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[122.820036] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[125.013381] [022/133] (898s left) i915_suspend (sysfs-reader)
[125.072098] Starting subtest: sysfs-reader
[143.646267] Subtest sysfs-reader: SUCCESS (3.654s)
[149.766264] [023/133] (880s left) gem_ctx_exec (basic-close-race)
[149.832560] Starting subtest: basic-close-race
[155.469865] Subtest basic-close-race: SUCCESS (5.638s)
[155.580473] [024/133] (874s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[157.093109] Starting subtest: modeset-non-lpsp-stress-no-wait
[157.135059] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.042s)
[157.806903] [025/133] (872s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[157.905927] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[157.907649] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[158.023973] [026/133] (871s left) vgem_basic (unload)
[158.056232] Starting subtest: unload
[187.358334] Subtest unload: SUCCESS (29.297s)
[187.409441] [FACT vgem_basic (unload)] new: kernel.kmod_is_loaded.vgem: true
[187.411011] [027/133] (842s left) api_intel_bb (crc32)
[187.462892] Starting subtest: crc32
[187.463783] Starting dynamic subtest: rcs0-smem0
[187.840778] Dynamic subtest rcs0-smem0: SUCCESS (0.368s)
[187.852215] Starting dynamic subtest: bcs0-smem0
[188.182432] Dynamic subtest bcs0-smem0: SUCCESS (0.340s)
[188.193975] Starting dynamic subtest: vcs0-smem0
[188.600749] Dynamic subtest vcs0-smem0: SUCCESS (0.416s)
[188.612624] Starting dynamic subtest: vcs1-smem0
[188.967062] Dynamic subtest vcs1-smem0: SUCCESS (0.365s)
[188.978056] Starting dynamic subtest: vecs0-smem0
[189.313172] Dynamic subtest vecs0-smem0: SUCCESS (0.344s)
[189.324577] Starting dynamic subtest: ccs0-smem0
[189.709713] Dynamic subtest ccs0-smem0: SUCCESS (0.395s)
[189.711217] Subtest crc32: SUCCESS (2.239s)
[189.838955] [028/133] (840s left) core_setmaster (master-drop-set-shared-fd)
[189.918063] Starting subtest: master-drop-set-shared-fd
[189.927753] Subtest master-drop-set-shared-fd: SUCCESS (0.011s)
[189.958421] [029/133] (840s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[190.049740] Starting subtest: plane-use-after-nonblocking-unbind
[190.050723] Starting dynamic subtest: pipe-A-eDP-1
[190.112097] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[190.431636] Starting dynamic subtest: pipe-B-eDP-1
[191.259559] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.836s)
[191.555340] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.505s)
[192.430353] [030/133] (837s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[192.545709] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[199.410978] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.868s)
[199.531588] [031/133] (830s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[199.622515] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[199.624442] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[199.734120] [032/133] (830s left) gem_exec_balancer (nop)
[199.800590] Starting subtest: nop
[246.437316] Subtest nop: SUCCESS (46.646s)
[246.753606] [033/133] (783s left) gem_mmap_wc (coherency)
[246.814870] Subtest coherency: SKIP (0.000s)
[246.892847] [034/133] (783s left) gem_mmap_offset (mmap-unmap)
[246.952332] Starting subtest: mmap-unmap
[246.953295] Starting dynamic subtest: smem0
[271.574177] Dynamic subtest smem0: SUCCESS (24.603s)
[271.575437] Subtest mmap-unmap: SUCCESS (24.604s)
[271.665731] [035/133] (758s left) gem_exec_schedule (u-semaphore-resolve)
[271.722578] Starting subtest: u-semaphore-resolve
[271.784666] Subtest u-semaphore-resolve: SUCCESS (0.062s)
[272.151733] [036/133] (758s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[272.250429] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[272.251367] Starting dynamic subtest: pipe-A-eDP-1
[272.339276] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[272.347879] Starting dynamic subtest: pipe-B-eDP-1
[273.438265] Dynamic subtest pipe-B-eDP-1: SKIP (1.097s)
[273.440085] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.188s)
[274.643222] [037/133] (755s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[274.746504] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[274.748381] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[274.840779] [038/133] (755s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[274.935887] Starting subtest: fbcpsr-1p-rte
[282.012875] Subtest fbcpsr-1p-rte: SUCCESS (7.078s)
[282.180537] [039/133] (748s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[282.236154] Starting subtest: framebuffer-vs-set-tiling
[282.237829] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[282.398105] [040/133] (747s left) kms_lease (lease-revoke)
[282.484308] Starting subtest: lease-revoke
[282.485247] Starting dynamic subtest: pipe-A-eDP-1
[282.513762] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.030s)
[282.522878] Starting dynamic subtest: pipe-B-eDP-1
[282.542508] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.028s)
[282.555961] Starting dynamic subtest: pipe-C-eDP-1
[282.574451] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.029s)
[282.587419] Starting dynamic subtest: pipe-D-eDP-1
[282.603264] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.028s)
[282.604161] Subtest lease-revoke: SUCCESS (0.119s)
[282.740949] [041/133] (747s left) kms_vblank (wait-forked-busy-hang)
[282.827715] Starting subtest: wait-forked-busy-hang
[282.830023] Starting dynamic subtest: pipe-A-eDP-1
[309.598812] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.772s)
[309.609444] Starting dynamic subtest: pipe-D-eDP-1
[334.562348] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.965s)
[334.563369] Subtest wait-forked-busy-hang: SUCCESS (51.741s)
[335.426031] [042/133] (695s left) kms_big_fb (linear-8bpp-rotate-270)
[335.536780] Starting subtest: linear-8bpp-rotate-270
[335.559155] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[335.694594] [043/133] (694s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[335.757675] Starting subtest: y-tiled-ccs-to-x-tiled
[335.759513] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[335.944984] [044/133] (694s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[336.050717] Starting subtest: 2x-flip-vs-rmfb-interruptible
[336.063613] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.011s)
[336.146971] [045/133] (694s left) gem_pxp (create-regular-context-1)
[336.255320] Starting subtest: create-regular-context-1
[336.256602] Subtest create-regular-context-1: SUCCESS (0.002s)
[336.367286] [046/133] (694s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[336.454394] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[336.465930] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[336.586933] [047/133] (694s left) gem_softpin (evict-snoop)
[336.653291] Starting subtest: evict-snoop
[336.655278] Subtest evict-snoop: SKIP (0.000s)
[336.780139] [048/133] (693s left) kms_color_pipeline (plane-lut1d)
[336.873370] Starting subtest: plane-lut1d
[336.888009] Starting dynamic subtest: pipe-A-eDP-1
[337.380651] Dynamic subtest pipe-A-eDP-1: FAIL (0.356s)
[338.301087] Starting dynamic subtest: pipe-B-eDP-1
[338.765676] Dynamic subtest pipe-B-eDP-1: FAIL (0.290s)
[339.627934] Starting dynamic subtest: pipe-C-eDP-1
[340.116558] Dynamic subtest pipe-C-eDP-1: FAIL (0.291s)
[340.962741] Starting dynamic subtest: pipe-D-eDP-1
[341.417173] Dynamic subtest pipe-D-eDP-1: FAIL (0.245s)
[341.491852] Subtest plane-lut1d: FAIL (4.621s)
[342.348866] [049/133] (688s left) kms_cursor_crc (cursor-onscreen-32x32)
[342.495853] Starting subtest: cursor-onscreen-32x32
[342.539398] Subtest cursor-onscreen-32x32: SKIP (0.041s)
[342.851797] [050/133] (687s left) kms_chamelium_hpd (hdmi-hpd)
[343.257729] Subtest hdmi-hpd: SKIP (0.000s)
[344.058636] [051/133] (686s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[344.156119] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[348.419279] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.264s)
[349.594270] [052/133] (681s left) syncobj_timeline (single-wait-all-available-signaled)
[349.641286] Starting subtest: single-wait-all-available-signaled
[349.642295] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[349.759359] [053/133] (681s left) perf (i915-ref-count)
[349.832504] Starting subtest: i915-ref-count
[349.859378] Subtest i915-ref-count: SUCCESS (0.026s)
[349.911471] [054/133] (680s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[350.020708] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[357.457838] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.439s)
[357.581575] [055/133] (673s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[357.671201] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[357.672932] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[357.794100] [056/133] (673s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[357.894419] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[365.281908] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.391s)
[365.470598] [057/133] (665s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[365.574315] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[372.477046] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.901s)
[372.624878] [058/133] (658s left) kms_psr (psr-cursor-plane-onoff)
[372.722153] Starting subtest: psr-cursor-plane-onoff
[372.723222] Starting dynamic subtest: eDP-1
[374.435195] Dynamic subtest eDP-1: SUCCESS (1.712s)
[374.436154] Subtest psr-cursor-plane-onoff: SUCCESS (1.713s)
[375.314196] [059/133] (655s left) gem_eio (hibernate)
[375.539008] Starting subtest: hibernate
[390.227813] Subtest hibernate: SUCCESS (14.684s)
[398.445742] [060/133] (640s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[398.572195] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[398.573852] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[398.683653] [061/133] (640s left) kms_chamelium_color (ctm-0-75)
[398.785874] Subtest ctm-0-75: SKIP (0.000s)
[398.826488] [062/133] (640s left) kms_psr (fbc-psr-cursor-blt)
[398.923059] Starting subtest: fbc-psr-cursor-blt
[398.923896] Starting dynamic subtest: eDP-1
[398.925642] Dynamic subtest eDP-1: SKIP (0.000s)
[398.927499] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[399.003359] [063/133] (640s left) gem_shrink (reclaim)
[399.063217] Starting subtest: reclaim
[401.523372] Subtest reclaim: SUCCESS (2.460s)
[401.723317] [064/133] (637s left) gem_eio (banned)
[401.943412] Starting subtest: banned
[402.604161] Subtest banned: SUCCESS (0.662s)
[402.808900] [065/133] (636s left) kms_psr (psr-sprite-mmap-gtt)
[402.894373] Starting subtest: psr-sprite-mmap-gtt
[402.895437] Starting dynamic subtest: eDP-1
[404.391166] Dynamic subtest eDP-1: SKIP (1.487s)
[404.393330] Subtest psr-sprite-mmap-gtt: SKIP (1.489s)
[404.572192] [066/133] (634s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[404.636144] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[404.637188] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s)
[404.777242] [067/133] (634s left) gem_exec_reloc (basic-wc-noreloc)
[404.842514] Subtest basic-wc-noreloc: SKIP (0.000s)
[404.945573] [068/133] (634s left) sriov_basic (enable-vfs-bind-unbind-each)
[405.005508] Starting subtest: enable-vfs-bind-unbind-each
[405.006535] Starting dynamic subtest: numvfs-1
[405.034356] Dynamic subtest numvfs-1: FAIL (0.005s)
[405.046153] Starting dynamic subtest: numvfs-2
[405.072945] Dynamic subtest numvfs-2: FAIL (0.004s)
[405.081846] Starting dynamic subtest: numvfs-3
[405.109506] Dynamic subtest numvfs-3: FAIL (0.005s)
[405.118697] Starting dynamic subtest: numvfs-4
[405.144484] Dynamic subtest numvfs-4: FAIL (0.005s)
[405.152730] Starting dynamic subtest: numvfs-5
[405.179308] Dynamic subtest numvfs-5: FAIL (0.004s)
[405.187669] Starting dynamic subtest: numvfs-6
[405.213362] Dynamic subtest numvfs-6: FAIL (0.005s)
[405.221851] Starting dynamic subtest: numvfs-7
[405.247759] Dynamic subtest numvfs-7: FAIL (0.006s)
[405.256065] Starting dynamic subtest: numvfs-random
[405.281590] Dynamic subtest numvfs-random: FAIL (0.004s)
[405.282451] Subtest enable-vfs-bind-unbind-each: FAIL (0.044s)
[405.312152] [069/133] (634s left) i915_pm_rps (fence-order)
[405.380292] Starting subtest: fence-order
[408.301564] Subtest fence-order: SUCCESS (2.914s)
[408.455221] [070/133] (631s left) gem_exec_fence (syncobj-timeline-wait)
[409.044303] Starting subtest: syncobj-timeline-wait
[410.902512] Subtest syncobj-timeline-wait: SUCCESS (1.859s)
[412.913430] [071/133] (626s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[413.021425] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[413.023116] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[413.141822] [072/133] (626s left) kms_properties (colorop-properties-legacy)
[413.222772] Starting subtest: colorop-properties-legacy
[413.223647] Starting dynamic subtest: pipe-A-eDP-1
[413.577003] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.354s)
[413.587085] Starting dynamic subtest: pipe-B-eDP-1
[414.653431] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.075s)
[414.667214] Starting dynamic subtest: pipe-C-eDP-1
[415.683047] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.028s)
[415.693193] Starting dynamic subtest: pipe-D-eDP-1
[416.725626] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.041s)
[416.726504] Subtest colorop-properties-legacy: SUCCESS (3.503s)
[417.532411] [073/133] (622s left) kms_psr (pr-cursor-mmap-gtt)
[417.627048] Starting subtest: pr-cursor-mmap-gtt
[417.628860] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[417.710230] [074/133] (621s left) kms_panel_fitting (legacy)
[417.799834] Starting subtest: legacy
[417.800874] Starting dynamic subtest: pipe-A-eDP-1
[418.333034] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.533s)
[418.359783] Starting dynamic subtest: pipe-B-eDP-1
[419.867839] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.517s)
[419.897261] Starting dynamic subtest: pipe-C-eDP-1
[421.380942] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.493s)
[421.408969] Starting dynamic subtest: pipe-D-eDP-1
[422.957829] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.557s)
[422.958690] Subtest legacy: SUCCESS (5.159s)
[424.146696] [075/133] (615s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[424.260733] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[424.262474] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[424.406691] [076/133] (615s left) gem_wait (write-busy)
[424.478578] Starting subtest: write-busy
[424.479532] Starting dynamic subtest: all-engines
[425.090664] Dynamic subtest all-engines: SUCCESS (0.613s)
[425.109831] Starting dynamic subtest: rcs0
[425.640687] Dynamic subtest rcs0: SUCCESS (0.548s)
[425.657010] Starting dynamic subtest: bcs0
[426.188405] Dynamic subtest bcs0: SUCCESS (0.547s)
[426.204218] Starting dynamic subtest: vcs0
[427.818014] Dynamic subtest vcs0: SUCCESS (1.615s)
[427.827515] Starting dynamic subtest: vcs1
[429.865763] Dynamic subtest vcs1: SUCCESS (2.045s)
[429.877186] Starting dynamic subtest: vecs0
[431.849483] Dynamic subtest vecs0: SUCCESS (1.982s)
[431.859026] Starting dynamic subtest: ccs0
[432.387686] Dynamic subtest ccs0: SUCCESS (0.549s)
[432.388849] Subtest write-busy: SUCCESS (7.912s)
[432.601784] [077/133] (607s left) kms_cursor_crc (cursor-random-256x256)
[432.852545] Starting subtest: cursor-random-256x256
[432.855610] Starting dynamic subtest: pipe-A-eDP-1
[436.394389] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.538s)
[436.424026] Starting dynamic subtest: pipe-D-eDP-1
[440.389373] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.973s)
[440.390254] Subtest cursor-random-256x256: SUCCESS (7.537s)
[441.233120] [078/133] (598s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[441.346620] Starting subtest: x-tiled-64bpp-rotate-0
[442.885667] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.540s)
[443.061097] [079/133] (596s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[443.170780] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[444.195298] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.025s)
[444.347087] [080/133] (595s left) api_intel_bb (reset-flags)
[444.411386] Starting subtest: reset-flags
[444.424776] Subtest reset-flags: SUCCESS (0.015s)
[444.601422] [081/133] (595s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[444.699930] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[444.710934] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[444.856294] [082/133] (595s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[444.918285] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[445.001465] [083/133] (594s left) perf (blocking)
[445.115040] Starting subtest: blocking
[445.116087] Starting dynamic subtest: 0-rcs0
[455.175261] Dynamic subtest 0-rcs0: SUCCESS (10.015s)
[455.187085] Starting dynamic subtest: 1-vcs0
[465.164771] Dynamic subtest 1-vcs0: SUCCESS (10.025s)
[465.166142] Subtest blocking: SUCCESS (20.042s)
[465.201084] [084/133] (574s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[465.301065] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[472.778657] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.479s)
[472.911438] [085/133] (567s left) gem_ctx_sseu (mmap-args)
[472.957118] Subtest mmap-args: SKIP (0.000s)
[473.019523] [086/133] (567s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[473.111149] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[473.112890] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[473.194049] [087/133] (566s left) sysfs_heartbeat_interval (nopreempt)
[473.261350] Starting subtest: nopreempt
[473.262318] Starting dynamic subtest: vecs0
[482.879739] Dynamic subtest vecs0: SUCCESS (9.610s)
[482.891354] Starting dynamic subtest: ccs0
[487.020828] Dynamic subtest ccs0: SUCCESS (4.148s)
[487.034350] Starting dynamic subtest: vcs0
[496.821259] Dynamic subtest vcs0: SUCCESS (9.790s)
[496.832731] Starting dynamic subtest: bcs0
[500.817158] Dynamic subtest bcs0: SUCCESS (4.002s)
[500.827083] Starting dynamic subtest: rcs0
[504.887550] Dynamic subtest rcs0: SUCCESS (4.070s)
[504.898407] Starting dynamic subtest: vcs1
[514.870693] Dynamic subtest vcs1: SUCCESS (9.974s)
[514.872007] Subtest nopreempt: SUCCESS (41.606s)
[514.947730] [088/133] (525s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[515.054694] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[515.880401] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.826s)
[516.050711] [089/133] (524s left) kms_selftest (drm_format)
[516.088955] Starting subtest: drm_format
[516.129677] Starting dynamic subtest: drm_test_format_block_width_invalid
[516.213414] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.083s)
[516.223925] Starting dynamic subtest: drm_test_format_block_width_one_plane
[516.356395] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.134s)
[516.367581] Starting dynamic subtest: drm_test_format_block_width_two_plane
[516.495340] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.136s)
[516.505920] Starting dynamic subtest: drm_test_format_block_width_three_plane
[516.600194] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.112s)
[516.609683] Starting dynamic subtest: drm_test_format_block_width_tiled
[516.754211] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.148s)
[516.764063] Starting dynamic subtest: drm_test_format_block_height_invalid
[516.886354] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.133s)
[516.896585] Starting dynamic subtest: drm_test_format_block_height_one_plane
[516.999081] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.117s)
[517.007720] Starting dynamic subtest: drm_test_format_block_height_two_plane
[517.139789] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.131s)
[517.150458] Starting dynamic subtest: drm_test_format_block_height_three_plane
[517.280203] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.140s)
[517.295040] Starting dynamic subtest: drm_test_format_block_height_tiled
[517.361336] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.089s)
[517.373200] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[517.498917] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.127s)
[517.507865] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[517.628839] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.127s)
[517.644607] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[517.753355] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.133s)
[517.764512] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[517.903515] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.139s)
[517.913933] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[518.046428] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.141s)
[518.057303] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[518.188489] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.141s)
[518.198078] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[518.327416] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.138s)
[518.336854] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[518.417003] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.098s)
[518.420241] Subtest drm_format: SUCCESS (2.330s)
[518.614398] [090/133] (521s left) kms_chamelium_frames (hdmi-crc-single)
[518.989945] Subtest hdmi-crc-single: SKIP (0.000s)
[519.821384] [091/133] (520s left) kms_dp_link_training (non-uhbr-sst)
[519.916247] Starting subtest: non-uhbr-sst
[519.919589] Subtest non-uhbr-sst: SKIP (0.000s)
[520.014773] [092/133] (520s left) fbdev (read)
[520.052267] Starting subtest: read
[520.593761] Subtest read: SUCCESS (0.532s)
[520.657417] [093/133] (519s left) gem_exec_schedule (preempt-contexts)
[520.711180] Starting subtest: preempt-contexts
[520.712060] Starting dynamic subtest: rcs0
[520.761397] Dynamic subtest rcs0: SUCCESS (0.050s)
[520.770827] Starting dynamic subtest: bcs0
[520.818300] Dynamic subtest bcs0: SUCCESS (0.056s)
[520.833868] Starting dynamic subtest: vcs0
[520.868571] Dynamic subtest vcs0: SUCCESS (0.050s)
[520.878045] Starting dynamic subtest: vcs1
[520.915952] Dynamic subtest vcs1: SUCCESS (0.047s)
[520.925339] Starting dynamic subtest: vecs0
[520.959405] Dynamic subtest vecs0: SUCCESS (0.042s)
[520.968966] Starting dynamic subtest: ccs0
[521.014055] Dynamic subtest ccs0: SUCCESS (0.054s)
[521.015013] Subtest preempt-contexts: SUCCESS (0.303s)
[522.935864] [094/133] (517s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[523.055860] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[523.057554] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[523.230099] [095/133] (517s left) kms_cursor_crc (cursor-suspend)
[523.360591] Starting subtest: cursor-suspend
[523.361537] Starting dynamic subtest: pipe-A-eDP-1
[558.134208] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.998s)
[558.154690] Starting dynamic subtest: pipe-D-eDP-1
[593.111299] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.506s)
[593.112238] Subtest cursor-suspend: SUCCESS (8.508s)
[599.008241] [096/133] (446s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[599.112012] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[599.113742] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[599.236250] [097/133] (446s left) kms_plane (plane-position-covered)
[599.334648] Starting subtest: plane-position-covered
[599.868750] Starting dynamic subtest: pipe-A-plane-1
[601.095777] Dynamic subtest pipe-A-plane-1: SUCCESS (1.241s)
[601.105354] Starting dynamic subtest: pipe-A-plane-2
[602.389307] Dynamic subtest pipe-A-plane-2: SUCCESS (1.304s)
[602.398589] Starting dynamic subtest: pipe-A-plane-3
[603.605830] Dynamic subtest pipe-A-plane-3: SUCCESS (1.225s)
[603.615199] Starting dynamic subtest: pipe-A-plane-4
[604.830370] Dynamic subtest pipe-A-plane-4: SUCCESS (1.231s)
[604.839908] Starting dynamic subtest: pipe-A-plane-5
[604.853299] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[605.989030] Starting dynamic subtest: pipe-B-plane-1
[607.236776] Dynamic subtest pipe-B-plane-1: SUCCESS (1.262s)
[607.246203] Starting dynamic subtest: pipe-B-plane-2
[608.550743] Dynamic subtest pipe-B-plane-2: SUCCESS (1.319s)
[608.565696] Starting dynamic subtest: pipe-B-plane-3
[609.774328] Dynamic subtest pipe-B-plane-3: SUCCESS (1.227s)
[609.784040] Starting dynamic subtest: pipe-B-plane-4
[610.990360] Dynamic subtest pipe-B-plane-4: SUCCESS (1.219s)
[611.000241] Starting dynamic subtest: pipe-B-plane-5
[611.016767] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[611.017589] Subtest plane-position-covered: SUCCESS (11.751s)
[611.815731] [098/133] (433s left) i915_pm_freq_api (freq-basic-api)
[611.888580] Starting subtest: freq-basic-api
[611.889514] Starting dynamic subtest: gt0
[611.891747] Dynamic subtest gt0: SUCCESS (0.002s)
[611.901471] Starting dynamic subtest: gt1
[611.902258] Dynamic subtest gt1: SUCCESS (0.003s)
[611.903095] Subtest freq-basic-api: SUCCESS (0.007s)
[612.022584] [099/133] (433s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[612.078656] Starting subtest: single-wait-for-submit-unsubmitted
[612.188200] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[612.273355] [100/133] (433s left) kms_psr (fbc-psr2-primary-blt)
[612.386833] Starting subtest: fbc-psr2-primary-blt
[612.387686] Starting dynamic subtest: eDP-1
[612.389307] Dynamic subtest eDP-1: SKIP (0.000s)
[612.390923] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[612.467363] [101/133] (433s left) gem_exec_params (invalid-fence-in)
[612.525900] Starting subtest: invalid-fence-in
[612.526951] Subtest invalid-fence-in: SUCCESS (0.000s)
[612.644636] [102/133] (433s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[612.736010] Starting subtest: read-crc-frame-sequence
[612.736927] Starting dynamic subtest: pipe-A-eDP-1
[613.433697] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s)
[613.443962] Starting dynamic subtest: pipe-B-eDP-1
[614.771456] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.338s)
[614.785688] Starting dynamic subtest: pipe-C-eDP-1
[616.069895] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.300s)
[616.080183] Starting dynamic subtest: pipe-D-eDP-1
[617.401864] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[617.402727] Subtest read-crc-frame-sequence: SUCCESS (4.676s)
[618.261712] [103/133] (427s left) kms_async_flips (alternate-sync-async-flip)
[618.366966] Starting subtest: alternate-sync-async-flip
[618.751967] Starting dynamic subtest: pipe-A-eDP-1
[621.528157] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.779s)
[621.896927] Starting dynamic subtest: pipe-B-eDP-1
[624.654185] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.768s)
[625.038127] Starting dynamic subtest: pipe-C-eDP-1
[627.782970] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.756s)
[628.157003] Starting dynamic subtest: pipe-D-eDP-1
[630.905740] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.761s)
[630.906752] Subtest alternate-sync-async-flip: SUCCESS (12.552s)
[632.101211] [104/133] (413s left) gem_exec_flush (basic-uc-prw-default)
[632.166164] Starting subtest: basic-uc-prw-default
[637.638789] Subtest basic-uc-prw-default: SUCCESS (5.470s)
[637.834794] [105/133] (408s left) syncobj_timeline (multi-wait-all-available-submitted)
[637.879238] Starting subtest: multi-wait-all-available-submitted
[637.880104] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[638.004433] [106/133] (407s left) gem_exec_parallel (basic)
[638.070505] Starting subtest: basic
[638.071453] Starting dynamic subtest: rcs0
[639.644929] Dynamic subtest rcs0: SUCCESS (1.573s)
[639.655200] Starting dynamic subtest: bcs0
[641.164050] Dynamic subtest bcs0: SUCCESS (1.517s)
[641.175771] Starting dynamic subtest: vcs0
[643.103872] Dynamic subtest vcs0: SUCCESS (1.929s)
[643.115548] Starting dynamic subtest: vcs1
[645.024438] Dynamic subtest vcs1: SUCCESS (1.918s)
[645.036879] Starting dynamic subtest: vecs0
[647.072857] Dynamic subtest vecs0: SUCCESS (2.045s)
[647.082631] Starting dynamic subtest: ccs0
[648.582618] Dynamic subtest ccs0: SUCCESS (1.516s)
[648.585766] Subtest basic: SUCCESS (10.512s)
[648.779171] [107/133] (397s left) gem_tiled_swapping (non-threaded)
[648.837328] Subtest non-threaded: SKIP (0.000s)
[648.907894] [108/133] (397s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[649.004529] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[649.006363] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[649.114842] [109/133] (396s left) gem_exec_balancer (sequential)
[649.178952] Starting subtest: sequential
[652.311910] Subtest sequential: SUCCESS (3.133s)
[652.658980] [110/133] (393s left) i915_drm_fdinfo (idle)
[652.698284] Starting subtest: idle
[652.699364] Starting dynamic subtest: rcs0
[653.288197] Dynamic subtest rcs0: SUCCESS (0.589s)
[653.302651] Starting dynamic subtest: bcs0
[653.804017] Dynamic subtest bcs0: SUCCESS (0.504s)
[653.815680] Starting dynamic subtest: vcs0
[654.311918] Dynamic subtest vcs0: SUCCESS (0.504s)
[654.323742] Starting dynamic subtest: vcs1
[654.816128] Dynamic subtest vcs1: SUCCESS (0.502s)
[654.825557] Starting dynamic subtest: vecs0
[655.322496] Dynamic subtest vecs0: SUCCESS (0.503s)
[655.334430] Starting dynamic subtest: ccs0
[655.827949] Dynamic subtest ccs0: SUCCESS (0.503s)
[655.828829] Subtest idle: SUCCESS (3.122s)
[655.904523] [111/133] (390s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[656.011894] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[659.592225] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.581s)
[660.817807] [112/133] (385s left) gen9_exec_parse (cmd-crossing-page)
[660.877017] Subtest cmd-crossing-page: SKIP (0.000s)
[660.959396] [113/133] (385s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[661.016426] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[661.018346] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[661.207867] [114/133] (384s left) gem_ctx_param (invalid-get-ringsize)
[661.269163] Starting subtest: invalid-get-ringsize
[661.271971] Subtest invalid-get-ringsize: SUCCESS (0.002s)
[661.395168] [115/133] (384s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[661.447244] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[661.448094] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[661.578674] [116/133] (384s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[661.670708] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[661.671739] Starting dynamic subtest: pipe-A-eDP-1
[661.680160] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[661.689651] Starting dynamic subtest: pipe-B-eDP-1
[661.698103] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[661.707498] Starting dynamic subtest: pipe-C-eDP-1
[661.716638] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[661.725575] Starting dynamic subtest: pipe-D-eDP-1
[661.733853] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[661.735545] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[663.873513] [117/133] (382s left) prime_self_import (basic-llseek-bad)
[663.903108] Starting subtest: basic-llseek-bad
[663.930541] Subtest basic-llseek-bad: SUCCESS (0.027s)
[664.056809] [118/133] (382s left) kms_invalid_mode (uint-max-clock)
[664.154435] Starting subtest: uint-max-clock
[664.155378] Starting dynamic subtest: pipe-A-eDP-1
[664.440768] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[664.452326] Starting dynamic subtest: pipe-B-eDP-1
[664.453209] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[664.462321] Starting dynamic subtest: pipe-C-eDP-1
[664.463212] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[664.471887] Starting dynamic subtest: pipe-D-eDP-1
[664.472763] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[664.473645] Subtest uint-max-clock: SUCCESS (0.292s)
[665.295945] [119/133] (381s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[665.387700] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[665.414741] Starting dynamic subtest: pipe-A-plane-0
[666.036335] Dynamic subtest pipe-A-plane-0: SUCCESS (0.622s)
[666.045936] Starting dynamic subtest: pipe-A-plane-3
[666.436467] Dynamic subtest pipe-A-plane-3: SUCCESS (0.399s)
[667.575171] Starting dynamic subtest: pipe-B-plane-0
[668.230546] Dynamic subtest pipe-B-plane-0: SUCCESS (0.666s)
[668.241353] Starting dynamic subtest: pipe-B-plane-3
[668.630488] Dynamic subtest pipe-B-plane-3: SUCCESS (0.398s)
[668.939579] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.554s)
[669.766811] [120/133] (376s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[669.860542] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[669.870891] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s)
[669.959965] [121/133] (376s left) kms_psr2_su (frontbuffer-xrgb8888)
[670.013793] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[670.080660] [122/133] (376s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[670.171553] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[670.172461] Starting dynamic subtest: pipe-A
[671.234379] Dynamic subtest pipe-A: SUCCESS (1.062s)
[671.251337] Starting dynamic subtest: pipe-B
[673.360426] Dynamic subtest pipe-B: SUCCESS (2.126s)
[673.369973] Starting dynamic subtest: pipe-C
[674.560629] Dynamic subtest pipe-C: SUCCESS (1.200s)
[674.570077] Starting dynamic subtest: pipe-D
[675.702290] Dynamic subtest pipe-D: SUCCESS (1.141s)
[675.703131] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.533s)
[676.919711] [123/133] (369s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[677.013433] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[677.014241] Starting dynamic subtest: pipe-A-eDP-1
[677.022724] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[677.032580] Starting dynamic subtest: pipe-B-eDP-1
[677.041669] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[677.052696] Starting dynamic subtest: pipe-C-eDP-1
[677.061099] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[677.070327] Starting dynamic subtest: pipe-D-eDP-1
[677.078797] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[677.080310] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[679.283343] [124/133] (367s left) gem_exec_fence (parallel)
[679.462153] Starting subtest: parallel
[679.463297] Starting dynamic subtest: rcs0
[681.611163] Dynamic subtest rcs0: SUCCESS (2.150s)
[681.621782] Starting dynamic subtest: bcs0
[683.758853] Dynamic subtest bcs0: SUCCESS (2.148s)
[683.769037] Starting dynamic subtest: vcs0
[685.906873] Dynamic subtest vcs0: SUCCESS (2.148s)
[685.917968] Starting dynamic subtest: vcs1
[688.060695] Dynamic subtest vcs1: SUCCESS (2.153s)
[688.076600] Starting dynamic subtest: vecs0
[690.209087] Dynamic subtest vecs0: SUCCESS (2.148s)
[690.220124] Starting dynamic subtest: ccs0
[692.361313] Dynamic subtest ccs0: SUCCESS (2.152s)
[692.362303] Subtest parallel: SUCCESS (12.904s)
[693.202245] [125/133] (353s left) kms_feature_discovery (display-2x)
[693.297463] Starting subtest: display-2x
[693.298983] Subtest display-2x: SKIP (0.000s)
[693.402432] [126/133] (353s left) gem_media_fill (media-fill)
[693.460010] Subtest media-fill: SKIP (0.000s)
[693.583970] [127/133] (353s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[693.680072] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[693.680981] Starting dynamic subtest: pipe-A-default-mode
[696.371501] Dynamic subtest pipe-A-default-mode: SUCCESS (2.691s)
[696.372597] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.693s)
[697.248719] [128/133] (349s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[697.346589] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[697.348335] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[697.456875] [129/133] (349s left) kms_concurrent (multi-plane-atomic-lowres)
[697.560984] Starting subtest: multi-plane-atomic-lowres
[697.561867] Starting dynamic subtest: pipe-A-eDP-1
[698.065917] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.504s)
[698.066779] Subtest multi-plane-atomic-lowres: SUCCESS (0.505s)
[698.897133] [130/133] (347s left) syncobj_timeline (device-submit-unordered)
[698.955343] Starting subtest: device-submit-unordered
[698.956484] Subtest device-submit-unordered: SUCCESS (0.000s)
[699.059817] [131/133] (347s left) syncobj_wait (multi-wait-all-submitted-signaled)
[699.113133] Starting subtest: multi-wait-all-submitted-signaled
[699.220680] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[699.306059] [132/133] (347s left) gem_softpin (noreloc-s3)
[699.355470] Starting subtest: noreloc-S3
[719.356533] Subtest noreloc-S3: SUCCESS (5.413s)
[722.564978] [133/133] (327s left) gem_exec_whisper (basic-fds-forked-all)
[722.626620] Starting subtest: basic-fds-forked-all
[744.692145] Subtest basic-fds-forked-all: SUCCESS (22.152s)
[744.887668] Closing watchdogs
results: parsing output: 0/ for test: gem_spin_batch
results: parsing output: 1/ for test: perf
results: parsing output: 2/ for test: gem_ctx_persistence
results: parsing output: 3/ for test: perf_pmu
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: gem_eio
results: parsing output: 8/ for test: gem_exec_whisper
results: parsing output: 9/ for test: gem_mmap_gtt
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: gem_exec_capture
results: parsing output: 12/ for test: gem_userptr_blits
results: parsing output: 13/ for test: kms_pm_backlight
results: parsing output: 14/ for test: gem_render_copy_redux
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: gem_render_copy
results: parsing output: 17/ for test: gem_flink_basic
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: i915_suspend
results: parsing output: 22/ for test: gem_ctx_exec
results: parsing output: 23/ for test: kms_pm_rpm
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: vgem_basic
results: parsing output: 26/ for test: api_intel_bb
results: parsing output: 27/ for test: core_setmaster
results: parsing output: 28/ for test: kms_atomic_transition
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_balancer
results: parsing output: 32/ for test: gem_mmap_wc
results: parsing output: 33/ for test: gem_mmap_offset
results: parsing output: 34/ for test: gem_exec_schedule
results: parsing output: 35/ for test: kms_psr2_sf
results: parsing output: 36/ for test: kms_flip_scaled_crc
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_addfb_basic
results: parsing output: 39/ for test: kms_lease
results: parsing output: 40/ for test: kms_vblank
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: gem_render_copy
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: gem_pxp
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: gem_softpin
results: parsing output: 47/ for test: kms_color_pipeline
results: parsing output: 48/ for test: kms_cursor_crc
results: parsing output: 49/ for test: kms_chamelium_hpd
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: perf
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: gem_eio
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_chamelium_color
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: gem_shrink
results: parsing output: 63/ for test: gem_eio
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: gem_exec_reloc
results: parsing output: 67/ for test: sriov_basic
results: parsing output: 68/ for test: i915_pm_rps
results: parsing output: 69/ for test: gem_exec_fence
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_properties
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_panel_fitting
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_wait
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: api_intel_bb
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: perf
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_ctx_sseu
results: parsing output: 85/ for test: kms_plane
results: parsing output: 86/ for test: sysfs_heartbeat_interval
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_selftest
results: parsing output: 89/ for test: kms_chamelium_frames
results: parsing output: 90/ for test: kms_dp_link_training
results: parsing output: 91/ for test: fbdev
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_plane
results: parsing output: 97/ for test: i915_pm_freq_api
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: gem_exec_params
results: parsing output: 101/ for test: kms_pipe_crc_basic
results: parsing output: 102/ for test: kms_async_flips
results: parsing output: 103/ for test: gem_exec_flush
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: gem_exec_parallel
results: parsing output: 106/ for test: gem_tiled_swapping
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_exec_balancer
results: parsing output: 109/ for test: i915_drm_fdinfo
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gen9_exec_parse
results: parsing output: 112/ for test: gem_render_copy
results: parsing output: 113/ for test: gem_ctx_param
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: prime_self_import
results: parsing output: 117/ for test: kms_invalid_mode
results: parsing output: 118/ for test: kms_plane
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: kms_psr2_su
results: parsing output: 121/ for test: kms_plane_scaling
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: gem_exec_fence
results: parsing output: 124/ for test: kms_feature_discovery
results: parsing output: 125/ for test: gem_media_fill
results: parsing output: 126/ for test: kms_flip_scaled_crc
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_concurrent
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: gem_softpin
results: parsing output: 132/ for test: gem_exec_whisper
Done.