[65.274506] Initializing watchdogs
[65.274588]   /dev/watchdog0
[65.304451] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[65.319734] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[65.324499] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[65.327415] [001/132] (960s left) kms_plane (pixel-format-linear-modifier)
[66.818093] Starting subtest: pixel-format-linear-modifier
[66.867452] Starting dynamic subtest: pipe-A-plane-0
[72.870488] Dynamic subtest pipe-A-plane-0: SUCCESS (6.000s)
[72.877995] Starting dynamic subtest: pipe-A-plane-3
[77.621551] Dynamic subtest pipe-A-plane-3: SUCCESS (4.749s)
[77.630233] Starting dynamic subtest: pipe-A-plane-5
[80.455179] Dynamic subtest pipe-A-plane-5: SUCCESS (2.833s)
[80.463909] Starting dynamic subtest: pipe-A-plane-7
[80.705555] Dynamic subtest pipe-A-plane-7: SUCCESS (0.250s)
[80.868393] Starting dynamic subtest: pipe-B-plane-0
[86.530455] Dynamic subtest pipe-B-plane-0: SUCCESS (5.667s)
[86.563072] Starting dynamic subtest: pipe-B-plane-3
[91.513220] Dynamic subtest pipe-B-plane-3: SUCCESS (4.982s)
[91.541681] Starting dynamic subtest: pipe-B-plane-5
[94.712575] Dynamic subtest pipe-B-plane-5: SUCCESS (3.199s)
[94.721078] Starting dynamic subtest: pipe-B-plane-7
[94.946020] Dynamic subtest pipe-B-plane-7: SUCCESS (0.233s)
[95.002293] Subtest pixel-format-linear-modifier: SUCCESS (28.179s)
[95.253643] [002/132] (930s left) kms_big_fb (yf-tiled-addfb)
[96.763415] Starting subtest: yf-tiled-addfb
[96.765440] Subtest yf-tiled-addfb: SKIP (0.000s)
[96.901189] [003/132] (929s left) gem_busy (close-race)
[96.965527] Starting subtest: close-race
[119.232598] Subtest close-race: SUCCESS (22.267s)
[119.633496] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[119.636501] [004/132] (906s left) gem_exec_reloc (basic-cpu)
[119.737188] Subtest basic-cpu: SKIP (0.000s)
[119.843277] [005/132] (906s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[121.354921] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[122.491213] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.131s)
[122.658615] [006/132] (903s left) kms_pm_rpm (cursor)
[127.105311] Starting subtest: cursor
[127.109150] Subtest cursor: SKIP (0.000s)
[128.063758] [007/132] (898s left) gem_softpin (noreloc-s3)
[128.130123] Starting subtest: noreloc-S3
[154.374162] Subtest noreloc-S3: SUCCESS (10.543s)
[161.528182] [008/132] (871s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[163.020832] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[163.022545] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[163.179928] [009/132] (870s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[164.672186] Starting subtest: fbcpsr-suspend
[164.674265] Subtest fbcpsr-suspend: SKIP (0.000s)
[164.877095] [010/132] (868s left) kms_psr (psr-basic)
[166.363986] Subtest psr-basic: SKIP (0.000s)
[166.538094] [011/132] (867s left) i915_pm_rc6_residency (rc6-accuracy)
[166.602083] Starting subtest: rc6-accuracy
[166.603045] Starting dynamic subtest: gt0
[169.778101] Dynamic subtest gt0: SUCCESS (3.170s)
[169.779140] Subtest rc6-accuracy: SUCCESS (3.172s)
[169.908333] [012/132] (863s left) gem_ctx_persistence (engines-mixed-process)
[169.958390] Starting subtest: engines-mixed-process
[169.959294] Starting dynamic subtest: rcs0
[171.580104] Dynamic subtest rcs0: SUCCESS (1.622s)
[171.591842] Starting dynamic subtest: bcs0
[173.566140] Dynamic subtest bcs0: SUCCESS (1.986s)
[173.578351] Starting dynamic subtest: vcs0
[175.555494] Dynamic subtest vcs0: SUCCESS (1.989s)
[175.567945] Starting dynamic subtest: vcs1
[177.595077] Dynamic subtest vcs1: SUCCESS (2.039s)
[177.607074] Starting dynamic subtest: vecs0
[179.573046] Dynamic subtest vecs0: SUCCESS (1.978s)
[179.574158] Subtest engines-mixed-process: SUCCESS (9.615s)
[179.717950] [013/132] (854s left) gem_exec_whisper (basic-fds-forked)
[179.775537] Starting subtest: basic-fds-forked
[193.417327] Subtest basic-fds-forked: SUCCESS (13.636s)
[193.714621] [014/132] (840s left) gem_eio (wait-wedge-immediate)
[193.908485] Starting subtest: wait-wedge-immediate
[195.566687] Subtest wait-wedge-immediate: SUCCESS (1.659s)
[197.151819] [015/132] (836s left) syncobj_wait (multi-wait-all-signaled)
[197.216656] Starting subtest: multi-wait-all-signaled
[197.217596] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[197.348844] [016/132] (836s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[198.837996] Starting subtest: plane-ctm3x4-lut1d
[199.030827] Starting dynamic subtest: pipe-A-plane-0
[199.280434] Dynamic subtest pipe-A-plane-0: SUCCESS (0.249s)
[199.319099] Starting dynamic subtest: pipe-A-plane-1
[199.478614] Dynamic subtest pipe-A-plane-1: SUCCESS (0.197s)
[199.491448] Starting dynamic subtest: pipe-A-plane-2
[199.645987] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[199.909279] Starting dynamic subtest: pipe-B-plane-0
[200.061531] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[200.096255] Starting dynamic subtest: pipe-B-plane-1
[200.262101] Dynamic subtest pipe-B-plane-1: SUCCESS (0.198s)
[200.296478] Starting dynamic subtest: pipe-B-plane-2
[200.461628] Dynamic subtest pipe-B-plane-2: SUCCESS (0.198s)
[200.762757] Starting dynamic subtest: pipe-C-plane-0
[200.932795] Dynamic subtest pipe-C-plane-0: SUCCESS (0.183s)
[200.969770] Starting dynamic subtest: pipe-C-plane-1
[201.149688] Dynamic subtest pipe-C-plane-1: SUCCESS (0.214s)
[201.175012] Starting dynamic subtest: pipe-C-plane-2
[201.349591] Dynamic subtest pipe-C-plane-2: SUCCESS (0.198s)
[201.679090] Starting dynamic subtest: pipe-D-plane-0
[201.852676] Dynamic subtest pipe-D-plane-0: SUCCESS (0.199s)
[201.876095] Starting dynamic subtest: pipe-D-plane-1
[202.053377] Dynamic subtest pipe-D-plane-1: SUCCESS (0.199s)
[202.087382] Starting dynamic subtest: pipe-D-plane-2
[202.270235] Dynamic subtest pipe-D-plane-2: SUCCESS (0.214s)
[202.325683] Subtest plane-ctm3x4-lut1d: SUCCESS (3.487s)
[202.508372] [017/132] (831s left) kms_psr (pr-sprite-mmap-gtt)
[203.994549] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[204.152562] [018/132] (830s left) gem_eio (in-flight-contexts-10ms)
[204.342132] Starting subtest: in-flight-contexts-10ms
[217.613394] Subtest in-flight-contexts-10ms: SUCCESS (13.271s)
[219.264521] [019/132] (815s left) gem_pread (snoop)
[219.309346] Subtest snoop: SKIP (0.000s)
[219.403079] [020/132] (815s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[219.446984] Starting subtest: multi-wait-all-for-submit-submitted
[219.553141] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.103s)
[219.717328] [021/132] (814s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[221.202315] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[221.203247] Starting dynamic subtest: pipe-A-HDMI-A-3
[221.212422] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[221.224256] Starting dynamic subtest: pipe-B-HDMI-A-3
[221.233664] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[221.245261] Starting dynamic subtest: pipe-C-HDMI-A-3
[221.259033] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[221.270394] Starting dynamic subtest: pipe-D-HDMI-A-3
[221.278341] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[221.279961] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s)
[221.459026] [022/132] (813s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[222.942866] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[222.945001] Starting dynamic subtest: pipe-A-HDMI-A-3
[222.948547] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[222.960315] Starting dynamic subtest: pipe-B-HDMI-A-3
[222.964095] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[222.975709] Starting dynamic subtest: pipe-C-HDMI-A-3
[222.979183] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[222.990578] Starting dynamic subtest: pipe-D-HDMI-A-3
[222.994342] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[222.996288] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.007s)
[223.204533] [023/132] (811s left) i915_drm_fdinfo (busy)
[223.252451] Starting subtest: busy
[223.253305] Starting dynamic subtest: rcs0
[223.254999] Dynamic subtest rcs0: SKIP (0.001s)
[223.266960] Starting dynamic subtest: bcs0
[223.268553] Dynamic subtest bcs0: SKIP (0.000s)
[223.280381] Starting dynamic subtest: vcs0
[223.282503] Dynamic subtest vcs0: SKIP (0.000s)
[223.294369] Starting dynamic subtest: vcs1
[223.296447] Dynamic subtest vcs1: SKIP (0.000s)
[223.309634] Starting dynamic subtest: vecs0
[223.311648] Dynamic subtest vecs0: SKIP (0.000s)
[223.313526] Subtest busy: SKIP (0.005s)
[223.375314] [024/132] (811s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[224.866625] Starting subtest: fbc-rgb565-draw-pwrite
[227.886072] Subtest fbc-rgb565-draw-pwrite: SUCCESS (3.020s)
[228.067851] [025/132] (806s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[229.594057] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[229.708804] [026/132] (805s left) kms_feature_discovery (psr1)
[231.195741] Starting subtest: psr1
[231.197343] Subtest psr1: SKIP (0.000s)
[231.334518] [027/132] (803s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[232.830060] Starting subtest: psr-dirtyfb-ioctl
[232.835286] Subtest psr-dirtyfb-ioctl: SKIP (0.000s)
[233.009243] [028/132] (802s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[234.500255] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[234.502235] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[234.668883] [029/132] (800s left) gem_mmap_wc (write-cpu-read-wc)
[234.717174] Subtest write-cpu-read-wc: SKIP (0.000s)
[234.790404] [030/132] (800s left) syncobj_basic (bad-handle-to-fd)
[234.834692] Starting subtest: bad-handle-to-fd
[234.835628] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[234.952892] [031/132] (800s left) kms_addfb_basic (addfb25-modifier-no-flag)
[236.440291] Starting subtest: addfb25-modifier-no-flag
[236.441100] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[236.594036] [032/132] (799s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[238.082265] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[238.083165] Starting dynamic subtest: pipe-A-valid-mode
[239.232286] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.149s)
[239.233195] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (1.151s)
[239.416762] [033/132] (796s left) kms_plane_lowres (tiling-y)
[240.901771] Starting subtest: tiling-y
[240.903908] Starting dynamic subtest: pipe-A-HDMI-A-3
[250.364294] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (9.461s)
[250.450012] Starting dynamic subtest: pipe-B-HDMI-A-3
[259.698207] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (9.259s)
[259.799617] Starting dynamic subtest: pipe-C-HDMI-A-3
[269.039169] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (9.250s)
[269.124398] Starting dynamic subtest: pipe-D-HDMI-A-3
[278.363479] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (9.250s)
[278.437179] Subtest tiling-y: SUCCESS (37.535s)
[278.626024] [034/132] (757s left) kms_flip (flip-vs-blocking-wf-vblank)
[280.115427] Starting subtest: flip-vs-blocking-wf-vblank
[280.121413] Starting dynamic subtest: A-HDMI-A3
[288.137889] Dynamic subtest A-HDMI-A3: SUCCESS (8.016s)
[288.152912] Starting dynamic subtest: B-HDMI-A3
[296.103251] Dynamic subtest B-HDMI-A3: SUCCESS (7.962s)
[296.117312] Starting dynamic subtest: C-HDMI-A3
[304.071028] Dynamic subtest C-HDMI-A3: SUCCESS (7.966s)
[304.085046] Starting dynamic subtest: D-HDMI-A3
[312.207388] Dynamic subtest D-HDMI-A3: SUCCESS (8.133s)
[312.217997] Subtest flip-vs-blocking-wf-vblank: SUCCESS (32.103s)
[312.485607] [035/132] (723s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[313.107876] Starting subtest: syncobj-backward-timeline-chain-engines
[313.244803] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.137s)
[313.570664] [036/132] (722s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[315.058088] Starting subtest: addfb25-yf-tiled-legacy
[315.059011] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[315.262406] [037/132] (720s left) kms_lease (lease-unleased-crtc)
[316.748476] Starting subtest: lease-unleased-crtc
[316.749423] Starting dynamic subtest: pipe-A-HDMI-A-3
[316.818198] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.068s)
[316.831621] Starting dynamic subtest: pipe-B-HDMI-A-3
[316.851975] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.029s)
[316.863986] Starting dynamic subtest: pipe-C-HDMI-A-3
[316.884194] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.029s)
[316.896172] Starting dynamic subtest: pipe-D-HDMI-A-3
[316.915271] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.029s)
[316.916359] Subtest lease-unleased-crtc: SUCCESS (0.168s)
[317.067594] [038/132] (719s left) gem_lmem_swapping (basic)
[321.489264] Starting subtest: basic
[321.490117] Starting dynamic subtest: lmem0
[344.969356] Dynamic subtest lmem0: SUCCESS (23.501s)
[344.970318] Subtest basic: SUCCESS (23.503s)
[347.300976] [FACT gem_lmem_swapping (basic)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[347.302074] [FACT gem_lmem_swapping (basic)] deleted: kernel.kmod_is_loaded.i915: true
[347.304306] [039/132] (688s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[352.022462] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[352.139021] [FACT kms_chamelium_hpd (vga-hpd-for-each-pipe)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[352.142411] [FACT kms_chamelium_hpd (vga-hpd-for-each-pipe)] new: kernel.kmod_is_loaded.i915: true
[352.145939] [040/132] (684s left) kms_cursor_crc (cursor-sliding-256x85)
[353.891978] Starting subtest: cursor-sliding-256x85
[353.898442] Starting dynamic subtest: pipe-A-HDMI-A-3
[358.307723] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.409s)
[358.344252] Starting dynamic subtest: pipe-D-HDMI-A-3
[362.660384] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.325s)
[362.661319] Subtest cursor-sliding-256x85: SUCCESS (8.769s)
[362.977598] [041/132] (673s left) gem_mmap_wc (read-write)
[363.021623] Subtest read-write: SKIP (0.000s)
[363.136194] [042/132] (673s left) syncobj_timeline (wait-all-snapshot)
[363.182901] Starting subtest: wait-all-snapshot
[363.266059] Subtest wait-all-snapshot: SUCCESS (0.082s)
[363.395235] [043/132] (673s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[364.879486] Starting subtest: bad-pixel-format-yf-tiled-ccs
[364.880367] Starting dynamic subtest: pipe-A-HDMI-A-3
[364.889131] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[364.899802] Starting dynamic subtest: pipe-B-HDMI-A-3
[364.908613] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[364.919191] Starting dynamic subtest: pipe-C-HDMI-A-3
[364.928478] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[364.938721] Starting dynamic subtest: pipe-D-HDMI-A-3
[364.948274] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[364.950258] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.011s)
[365.145161] [044/132] (671s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[366.632500] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[366.802463] [045/132] (669s left) perf_pmu (busy)
[366.856640] Starting subtest: busy
[366.857527] Starting dynamic subtest: rcs0
[367.458622] Dynamic subtest rcs0: SUCCESS (0.601s)
[367.474256] Starting dynamic subtest: bcs0
[368.021136] Dynamic subtest bcs0: SUCCESS (0.560s)
[368.036672] Starting dynamic subtest: vcs0
[368.583196] Dynamic subtest vcs0: SUCCESS (0.560s)
[368.598949] Starting dynamic subtest: vcs1
[369.146188] Dynamic subtest vcs1: SUCCESS (0.561s)
[369.161763] Starting dynamic subtest: vecs0
[369.713743] Dynamic subtest vecs0: SUCCESS (0.564s)
[369.719086] Subtest busy: SUCCESS (2.860s)
[369.844125] [046/132] (667s left) i915_hangman (engine-error-state-capture)
[369.904570] Starting subtest: engine-error-state-capture
[369.905441] Starting dynamic subtest: rcs0
[372.205684] Dynamic subtest rcs0: SUCCESS (2.301s)
[372.220664] Starting dynamic subtest: bcs0
[376.145173] Dynamic subtest bcs0: SUCCESS (3.938s)
[376.158387] Starting dynamic subtest: vcs0
[380.194680] Dynamic subtest vcs0: SUCCESS (4.048s)
[380.208609] Starting dynamic subtest: vcs1
[384.155567] Dynamic subtest vcs1: SUCCESS (3.959s)
[384.168792] Starting dynamic subtest: vecs0
[388.189593] Dynamic subtest vecs0: SUCCESS (4.033s)
[388.190626] Subtest engine-error-state-capture: SUCCESS (18.286s)
[388.350299] [047/132] (648s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[389.837176] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[389.920902] [048/132] (647s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[391.425508] Starting subtest: y-tiled-32bpp-rotate-0
[393.364805] Subtest y-tiled-32bpp-rotate-0: SUCCESS (1.935s)
[393.568905] [049/132] (643s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[393.615962] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[393.616867] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[393.742322] [050/132] (643s left) gem_exec_balancer (full-pulse)
[393.799800] Starting subtest: full-pulse
[396.230479] Subtest full-pulse: SUCCESS (2.431s)
[396.704763] [051/132] (640s left) gem_exec_schedule (preempt-user)
[396.766072] Starting subtest: preempt-user
[396.766934] Starting dynamic subtest: rcs0
[396.832974] Dynamic subtest rcs0: SUCCESS (0.066s)
[396.846371] Starting dynamic subtest: bcs0
[396.879093] Dynamic subtest bcs0: SUCCESS (0.045s)
[396.892411] Starting dynamic subtest: vcs0
[396.926324] Dynamic subtest vcs0: SUCCESS (0.046s)
[396.939595] Starting dynamic subtest: vcs1
[396.974443] Dynamic subtest vcs1: SUCCESS (0.047s)
[396.987703] Starting dynamic subtest: vecs0
[397.022800] Dynamic subtest vecs0: SUCCESS (0.047s)
[397.023647] Subtest preempt-user: SUCCESS (0.258s)
[397.476688] [052/132] (639s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[398.961773] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[398.962856] Starting dynamic subtest: pipe-A-HDMI-A-3
[399.546069] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.580s)
[399.558088] Starting dynamic subtest: pipe-B-HDMI-A-3
[400.152475] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.604s)
[400.164325] Starting dynamic subtest: pipe-C-HDMI-A-3
[400.760794] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.605s)
[400.773294] Starting dynamic subtest: pipe-D-HDMI-A-3
[401.367913] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.605s)
[401.369405] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SUCCESS (2.405s)
[401.555918] [053/132] (635s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[403.046615] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[403.048183] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[403.209670] [054/132] (634s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[404.701031] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[404.702727] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[404.890028] [055/132] (632s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[406.375604] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[406.376560] Starting dynamic subtest: pipe-A
[406.512016] Dynamic subtest pipe-A: SUCCESS (0.137s)
[406.525072] Starting dynamic subtest: pipe-B
[406.652877] Dynamic subtest pipe-B: SUCCESS (0.139s)
[406.666513] Starting dynamic subtest: pipe-C
[406.792865] Dynamic subtest pipe-C: SUCCESS (0.139s)
[406.806409] Starting dynamic subtest: pipe-D
[406.932726] Dynamic subtest pipe-D: SUCCESS (0.138s)
[406.933656] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.559s)
[407.123191] [056/132] (630s left) gem_userptr_blits (process-exit)
[407.184098] Starting subtest: process-exit
[407.195687] Subtest process-exit: SUCCESS (0.012s)
[407.414067] [057/132] (630s left) kms_prop_blob (blob-multiple)
[407.459871] Starting subtest: blob-multiple
[407.462687] Subtest blob-multiple: SUCCESS (0.002s)
[407.574887] [058/132] (630s left) gem_mmap_wc (write-wc-read-gtt)
[407.622422] Subtest write-wc-read-gtt: SKIP (0.000s)
[407.702225] [059/132] (630s left) kms_selftest (drm_format)
[407.751397] Starting subtest: drm_format
[407.824534] Starting dynamic subtest: drm_test_format_block_width_invalid
[407.866241] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.061s)
[407.891009] Starting dynamic subtest: drm_test_format_block_width_one_plane
[407.938049] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.067s)
[407.990254] Starting dynamic subtest: drm_test_format_block_width_two_plane
[408.020008] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.076s)
[408.039650] Starting dynamic subtest: drm_test_format_block_width_three_plane
[408.087964] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.064s)
[408.130565] Starting dynamic subtest: drm_test_format_block_width_tiled
[408.155968] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.065s)
[408.174304] Starting dynamic subtest: drm_test_format_block_height_invalid
[408.227104] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.068s)
[408.266946] Starting dynamic subtest: drm_test_format_block_height_one_plane
[408.297103] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.066s)
[408.316845] Starting dynamic subtest: drm_test_format_block_height_two_plane
[408.371886] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.071s)
[408.415032] Starting dynamic subtest: drm_test_format_block_height_three_plane
[408.444210] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.065s)
[408.459649] Starting dynamic subtest: drm_test_format_block_height_tiled
[408.511383] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.065s)
[408.530290] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[408.592018] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.075s)
[408.605364] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[408.659236] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.064s)
[408.694660] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[408.729483] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.068s)
[408.761237] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[408.796941] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.063s)
[408.825282] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[408.872440] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.072s)
[408.887719] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[408.954828] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.076s)
[409.002076] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[409.037045] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.075s)
[409.052441] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[409.116919] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.076s)
[409.124790] Subtest drm_format: SUCCESS (1.367s)
[409.321989] [060/132] (628s left) syncobj_wait (reset-signaled)
[409.368185] Starting subtest: reset-signaled
[409.369194] Subtest reset-signaled: SUCCESS (0.000s)
[409.486287] [061/132] (628s left) gem_create (create-ext-placement-sanity-check)
[409.649698] Starting subtest: create-ext-placement-sanity-check
[409.650609] Subtest create-ext-placement-sanity-check: SUCCESS (0.003s)
[409.870466] [062/132] (628s left) gem_exec_fence (basic-busy)
[410.042533] Starting subtest: basic-busy
[410.043550] Starting dynamic subtest: rcs0
[410.138196] Dynamic subtest rcs0: SUCCESS (0.094s)
[410.187435] Starting dynamic subtest: bcs0
[410.206231] Dynamic subtest bcs0: SUCCESS (0.061s)
[410.223338] Starting dynamic subtest: vcs0
[410.260248] Dynamic subtest vcs0: SUCCESS (0.052s)
[410.283794] Starting dynamic subtest: vcs1
[410.322698] Dynamic subtest vcs1: SUCCESS (0.060s)
[410.358213] Starting dynamic subtest: vecs0
[410.383310] Dynamic subtest vecs0: SUCCESS (0.057s)
[410.384511] Subtest basic-busy: SUCCESS (0.342s)
[411.029198] [063/132] (627s left) kms_rotation_crc (sprite-rotation-270)
[412.516473] Starting subtest: sprite-rotation-270
[423.003182] Subtest sprite-rotation-270: SUCCESS (10.487s)
[423.236778] [064/132] (615s left) gem_mmap_wc (read)
[423.284458] Subtest read: SKIP (0.000s)
[423.365396] [065/132] (615s left) gem_exec_parallel (basic)
[423.424569] Starting subtest: basic
[423.425535] Starting dynamic subtest: rcs0
[425.132233] Dynamic subtest rcs0: SUCCESS (1.708s)
[425.145766] Starting dynamic subtest: bcs0
[426.647201] Dynamic subtest bcs0: SUCCESS (1.513s)
[426.660885] Starting dynamic subtest: vcs0
[428.166330] Dynamic subtest vcs0: SUCCESS (1.513s)
[428.180259] Starting dynamic subtest: vcs1
[429.695088] Dynamic subtest vcs1: SUCCESS (1.531s)
[429.711393] Starting dynamic subtest: vecs0
[431.207013] Dynamic subtest vecs0: SUCCESS (1.510s)
[431.207912] Subtest basic: SUCCESS (7.785s)
[431.534973] [066/132] (607s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[431.588032] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[431.788543] [067/132] (606s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[431.835660] Starting subtest: etime-multi-wait-all-submitted-signaled
[431.947410] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.108s)
[432.078634] [068/132] (606s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[433.568251] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[433.570140] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[433.757806] [069/132] (605s left) kms_async_flips (crc-atomic)
[435.243379] Starting subtest: crc-atomic
[435.485963] Starting dynamic subtest: pipe-A-HDMI-A-3
[437.924019] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.434s)
[438.118253] Starting dynamic subtest: pipe-B-HDMI-A-3
[440.278106] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.167s)
[440.447291] Starting dynamic subtest: pipe-C-HDMI-A-3
[442.620486] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.181s)
[442.799303] Starting dynamic subtest: pipe-D-HDMI-A-3
[444.963532] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.171s)
[444.964634] Subtest crc-atomic: SUCCESS (9.718s)
[445.307396] [070/132] (593s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[446.794469] Starting subtest: basic-flip-after-cursor-legacy
[447.827548] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.033s)
[448.022692] [071/132] (590s left) kms_addfb_basic (invalid-set-prop-any)
[448.068449] Starting subtest: invalid-set-prop-any
[448.069317] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[449.667273] [072/132] (589s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[451.154598] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[451.233350] [073/132] (587s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[452.722961] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[452.724557] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[452.915042] [074/132] (586s left) syncobj_timeline (multi-wait-all-signaled)
[452.962321] Starting subtest: multi-wait-all-signaled
[452.963216] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[453.072980] [075/132] (586s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[454.557491] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[454.558432] Starting dynamic subtest: pipe-A-valid-mode
[455.467241] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.908s)
[455.468117] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SUCCESS (0.910s)
[455.658270] [076/132] (583s left) kms_flip (2x-flip-vs-expired-vblank)
[457.144890] Starting subtest: 2x-flip-vs-expired-vblank
[457.163444] Subtest 2x-flip-vs-expired-vblank: SKIP (0.019s)
[457.319004] [077/132] (582s left) vgem_basic (bad-flag)
[457.374127] Starting subtest: bad-flag
[457.374998] Subtest bad-flag: SUCCESS (0.000s)
[457.473616] [078/132] (582s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[458.978014] Starting subtest: x-tiled-addfb-size-offset-overflow
[458.978999] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.001s)
[459.153593] [079/132] (580s left) gem_ctx_persistence (idempotent)
[459.204566] Starting subtest: idempotent
[459.205439] Subtest idempotent: SUCCESS (0.000s)
[459.343779] [080/132] (580s left) gem_basic (multigpu-create-close)
[459.388910] Starting subtest: multigpu-create-close
[459.390605] Subtest multigpu-create-close: SKIP (0.000s)
[459.531940] [081/132] (580s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[461.023438] Starting subtest: 2x-absolute-wf_vblank-interruptible
[461.043388] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.019s)
[461.181501] [082/132] (578s left) kms_content_protection (lic-type-0-hdcp14)
[462.721656] Starting subtest: lic-type-0-hdcp14
[462.730348] Subtest lic-type-0-hdcp14: SKIP (0.005s)
[462.931010] [083/132] (577s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[464.420522] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[464.422421] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[464.603694] [084/132] (575s left) gem_exec_schedule (preempt-hang)
[464.802740] Starting subtest: preempt-hang
[464.804938] Starting dynamic subtest: rcs0
[465.129285] Dynamic subtest rcs0: SUCCESS (0.332s)
[465.141716] Starting dynamic subtest: bcs0
[465.416018] Dynamic subtest bcs0: SUCCESS (0.285s)
[465.428716] Starting dynamic subtest: vcs0
[465.737881] Dynamic subtest vcs0: SUCCESS (0.320s)
[465.750588] Starting dynamic subtest: vcs1
[466.058313] Dynamic subtest vcs1: SUCCESS (0.319s)
[466.070929] Starting dynamic subtest: vecs0
[466.378102] Dynamic subtest vecs0: SUCCESS (0.318s)
[466.379021] Subtest preempt-hang: SUCCESS (1.585s)
[466.773915] [085/132] (573s left) drm_buddy (drm_buddy)
[466.818472] Starting subtest: drm_buddy
[466.820229] Subtest drm_buddy: SKIP (0.000s)
[466.926068] [086/132] (573s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[468.432264] Starting subtest: x-tiled-16bpp-rotate-90
[468.546368] Subtest x-tiled-16bpp-rotate-90: SKIP (0.114s)
[468.715853] [087/132] (571s left) gem_exec_schedule (fairslice-all)
[468.776001] Starting subtest: fairslice-all
[470.857257] Subtest fairslice-all: SUCCESS (2.081s)
[471.308115] [088/132] (569s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[472.794418] Starting subtest: primary-yf-tiled-reflect-x-90
[472.889747] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.095s)
[473.101136] [089/132] (567s left) sw_sync (sync_multi_consumer)
[473.160550] Starting subtest: sync_multi_consumer
[473.601794] Subtest sync_multi_consumer: SUCCESS (0.439s)
[473.741258] [090/132] (567s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[475.230777] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[475.232708] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[475.396304] [091/132] (565s left) i915_pm_sseu (full-enable)
[475.449641] Subtest full-enable: SKIP (0.000s)
[475.559811] [092/132] (565s left) kms_setmode (basic-clone-single-crtc)
[475.605416] Starting subtest: basic-clone-single-crtc
[475.608126] Subtest basic-clone-single-crtc: SKIP (0.000s)
[475.727308] [093/132] (565s left) prime_vgem (fence-write-hang)
[475.782410] Subtest fence-write-hang: SKIP (0.000s)
[475.962862] [094/132] (565s left) kms_vblank (wait-idle-hang)
[477.448414] Starting subtest: wait-idle-hang
[477.449735] Starting dynamic subtest: pipe-A-HDMI-A-3
[504.178390] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (26.728s)
[504.194646] Starting dynamic subtest: pipe-D-HDMI-A-3
[529.124425] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (24.941s)
[529.125306] Subtest wait-idle-hang: SUCCESS (51.678s)
[529.316018] [095/132] (511s left) api_intel_bb (reset-bb)
[529.362064] Starting subtest: reset-bb
[529.378001] Subtest reset-bb: SUCCESS (0.017s)
[529.582336] [096/132] (511s left) kms_invalid_mode (bad-htotal)
[531.066348] Starting subtest: bad-htotal
[531.068544] Starting dynamic subtest: pipe-A-HDMI-A-3
[531.105851] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.038s)
[531.120378] Starting dynamic subtest: pipe-B-HDMI-A-3
[531.121522] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s)
[531.133945] Starting dynamic subtest: pipe-C-HDMI-A-3
[531.134868] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s)
[531.147952] Starting dynamic subtest: pipe-D-HDMI-A-3
[531.148794] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s)
[531.149650] Subtest bad-htotal: SUCCESS (0.050s)
[531.289790] [097/132] (510s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[533.860755] Starting subtest: verify-pxp-execution-after-suspend-resume
[533.863084] Subtest verify-pxp-execution-after-suspend-resume: SKIP (0.000s)
[533.980771] [098/132] (507s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[535.469514] Starting subtest: cursorA-vs-flipB-atomic
[535.471191] Subtest cursorA-vs-flipB-atomic: SKIP (0.002s)
[535.578350] [099/132] (505s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[537.070706] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[537.071733] Starting dynamic subtest: pipe-A-HDMI-A-3
[537.081210] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[537.093346] Starting dynamic subtest: pipe-B-HDMI-A-3
[537.103134] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[537.115418] Starting dynamic subtest: pipe-C-HDMI-A-3
[537.125456] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[537.137585] Starting dynamic subtest: pipe-D-HDMI-A-3
[537.147675] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[537.149701] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.010s)
[537.338368] [100/132] (504s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[538.823384] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[538.897820] [101/132] (502s left) kms_big_fb (linear-32bpp-rotate-180)
[540.401468] Starting subtest: linear-32bpp-rotate-180
[542.923655] Subtest linear-32bpp-rotate-180: SUCCESS (2.517s)
[543.122297] [102/132] (498s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[544.612428] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[544.614106] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[544.764762] [103/132] (497s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[546.256548] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[546.257524] Starting dynamic subtest: pipe-A
[548.926205] Dynamic subtest pipe-A: SUCCESS (2.670s)
[548.950700] Starting dynamic subtest: pipe-B
[551.500487] Dynamic subtest pipe-B: SUCCESS (2.572s)
[551.525452] Starting dynamic subtest: pipe-C
[551.808543] Dynamic subtest pipe-C: SUCCESS (0.306s)
[551.829963] Starting dynamic subtest: pipe-D
[552.114926] Dynamic subtest pipe-D: SUCCESS (0.304s)
[552.115989] Subtest plane-downscale-factor-0-5-with-pixel-format: SUCCESS (5.860s)
[552.306843] [104/132] (489s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[552.359326] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[552.435424] [105/132] (489s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[553.940383] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[553.942398] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[554.119428] [106/132] (487s left) gem_sync (basic-store-all)
[554.176575] Starting subtest: basic-store-all
[556.533496] Subtest basic-store-all: SUCCESS (2.356s)
[556.769002] [107/132] (485s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[558.447957] Starting subtest: cursor-rapid-movement-128x42
[558.454581] Starting dynamic subtest: pipe-A-HDMI-A-3
[558.894464] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.439s)
[558.932540] Starting dynamic subtest: pipe-D-HDMI-A-3
[559.243758] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.323s)
[559.244599] Subtest cursor-rapid-movement-128x42: SUCCESS (0.797s)
[559.661505] [108/132] (482s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[559.707460] Starting subtest: invalid-multi-wait-all-unsubmitted
[559.708367] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[559.841025] [109/132] (482s left) gen9_exec_parse (bb-start-out)
[559.891590] Subtest bb-start-out: SKIP (0.000s)
[559.973245] [110/132] (482s left) gem_spin_batch (legacy-resubmit-new)
[560.028635] Starting subtest: legacy-resubmit-new
[560.029477] Starting dynamic subtest: default
[560.051173] Dynamic subtest default: SUCCESS (0.021s)
[560.065363] Starting dynamic subtest: render
[560.066339] Dynamic subtest render: SUCCESS (0.004s)
[560.078675] Starting dynamic subtest: bsd
[560.079654] Dynamic subtest bsd: SUCCESS (0.004s)
[560.092364] Starting dynamic subtest: bsd1
[560.093598] Dynamic subtest bsd1: SUCCESS (0.004s)
[560.105995] Starting dynamic subtest: bsd2
[560.107196] Dynamic subtest bsd2: SUCCESS (0.005s)
[560.119137] Starting dynamic subtest: blt
[560.120364] Dynamic subtest blt: SUCCESS (0.006s)
[560.132277] Starting dynamic subtest: vebox
[560.133475] Dynamic subtest vebox: SUCCESS (0.004s)
[560.134671] Subtest legacy-resubmit-new: SUCCESS (0.062s)
[560.380756] [111/132] (482s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[561.869594] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[561.871312] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[562.063273] [112/132] (480s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[563.558875] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[563.560752] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[563.750135] [113/132] (478s left) gem_exec_reloc (basic-wc-cpu-active)
[563.802586] Subtest basic-wc-cpu-active: SKIP (0.000s)
[563.930275] [114/132] (478s left) kms_cursor_crc (cursor-onscreen-max-size)
[565.715862] Starting subtest: cursor-onscreen-max-size
[565.718333] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[565.885606] [115/132] (477s left) gem_ringfill (engines-basic)
[566.318395] Starting subtest: engines-basic
[566.323459] Starting dynamic subtest: rcs0
[566.407382] Dynamic subtest rcs0: SUCCESS (0.088s)
[566.425318] Starting dynamic subtest: bcs0
[566.450297] Dynamic subtest bcs0: SUCCESS (0.041s)
[566.477663] Starting dynamic subtest: vcs0
[566.497393] Dynamic subtest vcs0: SUCCESS (0.044s)
[566.520585] Starting dynamic subtest: vcs1
[566.542126] Dynamic subtest vcs1: SUCCESS (0.042s)
[566.560624] Starting dynamic subtest: vecs0
[566.585141] Dynamic subtest vecs0: SUCCESS (0.041s)
[566.586144] Subtest engines-basic: SUCCESS (0.268s)
[566.759003] [116/132] (476s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[568.248892] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[568.250452] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[568.425206] [117/132] (474s left) perf_pmu (busy-hang)
[568.474291] Starting subtest: busy-hang
[568.475186] Starting dynamic subtest: rcs0
[569.727525] Dynamic subtest rcs0: SUCCESS (1.249s)
[569.740423] Starting dynamic subtest: bcs0
[570.925578] Dynamic subtest bcs0: SUCCESS (1.195s)
[570.938400] Starting dynamic subtest: vcs0
[572.114805] Dynamic subtest vcs0: SUCCESS (1.189s)
[572.129613] Starting dynamic subtest: vcs1
[573.310228] Dynamic subtest vcs1: SUCCESS (1.193s)
[573.325389] Starting dynamic subtest: vecs0
[574.504180] Dynamic subtest vecs0: SUCCESS (1.190s)
[574.507058] Subtest busy-hang: SUCCESS (6.032s)
[574.646508] [118/132] (468s left) syncobj_wait (multi-wait-all-submitted-signaled)
[574.701663] Starting subtest: multi-wait-all-submitted-signaled
[574.808349] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.105s)
[574.949531] [119/132] (468s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[576.440257] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[576.441738] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[576.631599] [120/132] (466s left) gem_lmem_swapping (random-engines)
[580.799621] Starting subtest: random-engines
[580.800889] Starting dynamic subtest: lmem0
[582.033125] Dynamic subtest lmem0: SUCCESS (1.230s)
[582.034017] Subtest random-engines: SUCCESS (1.232s)
[583.905824] [FACT gem_lmem_swapping (random-engines)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[583.906895] [FACT gem_lmem_swapping (random-engines)] deleted: kernel.kmod_is_loaded.i915: true
[583.909382] [121/132] (459s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[588.663624] Starting subtest: 2x-flip-vs-cursor-legacy
[588.667196] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.003s)
[589.632961] [FACT kms_cursor_legacy (2x-flip-vs-cursor-legacy)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[589.636123] [FACT kms_cursor_legacy (2x-flip-vs-cursor-legacy)] new: kernel.kmod_is_loaded.i915: true
[589.643865] [122/132] (453s left) gem_mmap_gtt (ptrace)
[589.691444] Subtest ptrace: SKIP (0.000s)
[589.765825] [123/132] (453s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[591.256213] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[591.258052] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[591.428273] [124/132] (452s left) prime_vgem (basic-blt)
[591.515563] Starting subtest: basic-blt
[591.568341] Subtest basic-blt: SUCCESS (0.053s)
[591.771692] [125/132] (452s left) syncobj_eventfd (invalid-bad-flags)
[591.822479] Starting subtest: invalid-bad-flags
[591.823331] Subtest invalid-bad-flags: SUCCESS (0.000s)
[591.938764] [126/132] (452s left) gem_readwrite (read-bad-handle)
[591.982398] Subtest read-bad-handle: SKIP (0.000s)
[592.086041] [127/132] (451s left) sw_sync (timeline_closed)
[592.129250] Starting subtest: timeline_closed
[592.130061] Subtest timeline_closed: SUCCESS (0.000s)
[592.219946] [128/132] (451s left) kms_plane_alpha_blend (constant-alpha-max)
[593.706760] Starting subtest: constant-alpha-max
[593.982847] Starting dynamic subtest: pipe-A-HDMI-A-3
[594.877082] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.896s)
[594.890303] Starting dynamic subtest: pipe-D-HDMI-A-3
[595.767338] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.887s)
[595.768185] Subtest constant-alpha-max: SUCCESS (2.062s)
[595.967493] [129/132] (448s left) syncobj_wait (wait-all-delayed-signal)
[596.014747] Starting subtest: wait-all-delayed-signal
[596.119276] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[596.312256] [130/132] (447s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[597.796553] Starting subtest: multiplane-rotation-cropping-bottom
[646.169004] Subtest multiplane-rotation-cropping-bottom: SUCCESS (48.374s)
[646.369801] [131/132] (397s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[647.860575] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[648.019578] [132/132] (396s left) gem_ctx_shared (exec-shared-gtt)
[648.079820] Starting subtest: exec-shared-gtt
[648.080642] Starting dynamic subtest: rcs0
[648.093403] Dynamic subtest rcs0: SUCCESS (0.013s)
[648.108275] Starting dynamic subtest: bcs0
[648.109141] Dynamic subtest bcs0: SUCCESS (0.008s)
[648.122288] Starting dynamic subtest: vcs0
[648.123197] Dynamic subtest vcs0: SUCCESS (0.008s)
[648.135714] Starting dynamic subtest: vcs1
[648.136662] Dynamic subtest vcs1: SUCCESS (0.007s)
[648.149324] Starting dynamic subtest: vecs0
[648.150330] Dynamic subtest vecs0: SUCCESS (0.007s)
[648.151325] Subtest exec-shared-gtt: SUCCESS (0.052s)
[648.424798] Closing watchdogs
results: parsing output: 0/ for test: kms_plane
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: gem_busy
results: parsing output: 3/ for test: gem_exec_reloc
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_pm_rpm
results: parsing output: 6/ for test: gem_softpin
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: i915_pm_rc6_residency
results: parsing output: 11/ for test: gem_ctx_persistence
results: parsing output: 12/ for test: gem_exec_whisper
results: parsing output: 13/ for test: gem_eio
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: kms_color_pipeline
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gem_eio
results: parsing output: 18/ for test: gem_pread
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: i915_drm_fdinfo
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_chamelium_edid
results: parsing output: 25/ for test: kms_feature_discovery
results: parsing output: 26/ for test: kms_dirtyfb
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_mmap_wc
results: parsing output: 29/ for test: syncobj_basic
results: parsing output: 30/ for test: kms_addfb_basic
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: kms_plane_lowres
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: gem_exec_fence
results: parsing output: 35/ for test: kms_addfb_basic
results: parsing output: 36/ for test: kms_lease
results: parsing output: 37/ for test: gem_lmem_swapping
results: parsing output: 38/ for test: kms_chamelium_hpd
results: parsing output: 39/ for test: kms_cursor_crc
results: parsing output: 40/ for test: gem_mmap_wc
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_psr2_sf
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: i915_hangman
results: parsing output: 46/ for test: kms_psr2_sf
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: gem_exec_balancer
results: parsing output: 50/ for test: gem_exec_schedule
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_plane_scaling
results: parsing output: 55/ for test: gem_userptr_blits
results: parsing output: 56/ for test: kms_prop_blob
results: parsing output: 57/ for test: gem_mmap_wc
results: parsing output: 58/ for test: kms_selftest
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: gem_create
results: parsing output: 61/ for test: gem_exec_fence
results: parsing output: 62/ for test: kms_rotation_crc
results: parsing output: 63/ for test: gem_mmap_wc
results: parsing output: 64/ for test: gem_exec_parallel
results: parsing output: 65/ for test: gem_userptr_blits
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_async_flips
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: kms_addfb_basic
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: kms_flip_scaled_crc
results: parsing output: 75/ for test: kms_flip
results: parsing output: 76/ for test: vgem_basic
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_ctx_persistence
results: parsing output: 79/ for test: gem_basic
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_content_protection
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: drm_buddy
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_exec_schedule
results: parsing output: 87/ for test: kms_rotation_crc
results: parsing output: 88/ for test: sw_sync
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: i915_pm_sseu
results: parsing output: 91/ for test: kms_setmode
results: parsing output: 92/ for test: prime_vgem
results: parsing output: 93/ for test: kms_vblank
results: parsing output: 94/ for test: api_intel_bb
results: parsing output: 95/ for test: kms_invalid_mode
results: parsing output: 96/ for test: gem_pxp
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_plane_scaling
results: parsing output: 103/ for test: gem_fenced_exec_thrash
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: gem_sync
results: parsing output: 106/ for test: kms_cursor_crc
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: gen9_exec_parse
results: parsing output: 109/ for test: gem_spin_batch
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: kms_cursor_crc
results: parsing output: 114/ for test: gem_ringfill
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: perf_pmu
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_lmem_swapping
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: gem_mmap_gtt
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: prime_vgem
results: parsing output: 124/ for test: syncobj_eventfd
results: parsing output: 125/ for test: gem_readwrite
results: parsing output: 126/ for test: sw_sync
results: parsing output: 127/ for test: kms_plane_alpha_blend
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: kms_rotation_crc
results: parsing output: 130/ for test: kms_addfb_basic
results: parsing output: 131/ for test: gem_ctx_shared
Done.