[65.364469] Initializing watchdogs
[65.364550]   /dev/watchdog0
[65.394099] [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.409372] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[65.413935] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[65.417097] [001/132] (960s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[65.472750] Starting subtest: single-wait-for-submit-available-signaled
[65.474361] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[65.658186] [002/132] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[67.658709] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[67.661679] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[67.900910] [003/132] (958s left) gem_exec_schedule (submit-late-slice)
[67.968378] Starting subtest: submit-late-slice
[67.970117] Starting dynamic subtest: rcs0
[68.029903] Dynamic subtest rcs0: SUCCESS (0.061s)
[68.038586] Starting dynamic subtest: bcs0
[68.073195] Dynamic subtest bcs0: SUCCESS (0.043s)
[68.081700] Starting dynamic subtest: vcs0
[68.117097] Dynamic subtest vcs0: SUCCESS (0.044s)
[68.125784] Starting dynamic subtest: vcs1
[68.160543] Dynamic subtest vcs1: SUCCESS (0.043s)
[68.169263] Starting dynamic subtest: vecs0
[68.205127] Dynamic subtest vecs0: SUCCESS (0.044s)
[68.206962] Subtest submit-late-slice: SUCCESS (0.236s)
[68.712147] [004/132] (957s left) syncobj_wait (wait-any-interrupted)
[68.759938] Starting subtest: wait-any-interrupted
[68.861994] Subtest wait-any-interrupted: SUCCESS (0.101s)
[69.010924] [005/132] (957s left) gem_exec_params (rsvd2-dirt)
[69.060762] Starting subtest: rsvd2-dirt
[69.063523] Subtest rsvd2-dirt: SKIP (0.000s)
[69.240148] [006/132] (957s left) kms_draw_crc (draw-method-render)
[71.232866] Starting subtest: draw-method-render
[71.235555] Starting dynamic subtest: xrgb8888-untiled
[71.610943] Dynamic subtest xrgb8888-untiled: SUCCESS (0.379s)
[71.619390] Starting dynamic subtest: rgb565-untiled
[71.911223] Dynamic subtest rgb565-untiled: SUCCESS (0.300s)
[71.919982] Starting dynamic subtest: xrgb2101010-untiled
[72.194959] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.283s)
[72.203654] Starting dynamic subtest: xbgr16161616f-untiled
[72.511729] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.316s)
[72.521432] Starting dynamic subtest: xrgb8888-xtiled
[72.681590] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.168s)
[72.714337] Starting dynamic subtest: rgb565-xtiled
[72.879875] Dynamic subtest rgb565-xtiled: SUCCESS (0.197s)
[72.913081] Starting dynamic subtest: xrgb2101010-xtiled
[73.063398] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.182s)
[73.095211] Starting dynamic subtest: xbgr16161616f-xtiled
[73.263488] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.199s)
[73.295062] Starting dynamic subtest: xrgb8888-ytiled
[73.463674] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.198s)
[73.497933] Starting dynamic subtest: rgb565-ytiled
[73.663767] Dynamic subtest rgb565-ytiled: SUCCESS (0.198s)
[73.698171] Starting dynamic subtest: xrgb2101010-ytiled
[73.847368] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.182s)
[73.857777] Starting dynamic subtest: xbgr16161616f-ytiled
[74.014836] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.165s)
[74.018136] Subtest draw-method-render: SUCCESS (2.781s)
[74.280797] [007/132] (952s left) kms_content_protection (content-type-change)
[76.331203] Starting subtest: content-type-change
[76.341762] Subtest content-type-change: SKIP (0.005s)
[76.574161] [008/132] (950s left) api_intel_bb (object-noreloc-purge-cache-simple)
[76.621561] Starting subtest: object-noreloc-purge-cache-simple
[76.643919] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.023s)
[76.861413] [009/132] (949s left) kms_flip (2x-dpms-vs-vblank-race)
[78.847115] Starting subtest: 2x-dpms-vs-vblank-race
[78.865524] Subtest 2x-dpms-vs-vblank-race: SKIP (0.018s)
[79.022642] [010/132] (947s left) gem_mmap_gtt (hang)
[79.101103] Subtest hang: SKIP (0.000s)
[79.170776] [011/132] (947s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[81.180735] Starting subtest: fbc-dirtyfb-ioctl
[81.182319] Starting dynamic subtest: A-HDMI-A-4
[82.637291] Dynamic subtest A-HDMI-A-4: SUCCESS (1.457s)
[82.638681] Subtest fbc-dirtyfb-ioctl: SUCCESS (1.458s)
[82.858282] [012/132] (944s left) kms_cursor_crc (cursor-onscreen-256x256)
[85.068725] Starting subtest: cursor-onscreen-256x256
[85.076336] Starting dynamic subtest: pipe-A-HDMI-A-4
[87.865605] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.791s)
[87.895402] Starting dynamic subtest: pipe-D-HDMI-A-4
[90.540099] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.652s)
[90.541681] Subtest cursor-onscreen-256x256: SUCCESS (5.472s)
[90.976423] [013/132] (936s left) kms_flip (2x-flip-vs-modeset)
[92.962909] Starting subtest: 2x-flip-vs-modeset
[92.981224] Subtest 2x-flip-vs-modeset: SKIP (0.018s)
[93.194148] [014/132] (933s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[95.206197] Starting subtest: fbc-farfromfence-mmap-gtt
[95.209036] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[95.426408] [015/132] (931s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[97.466772] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[97.568961] [016/132] (929s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[99.579370] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[100.192816] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.614s)
[100.466530] [017/132] (926s left) gem_cs_tlb (engines)
[100.518041] Starting subtest: engines
[100.519783] Starting dynamic subtest: rcs0
[102.676420] Dynamic subtest rcs0: SUCCESS (2.154s)
[102.685330] Starting dynamic subtest: bcs0
[104.831538] Dynamic subtest bcs0: SUCCESS (2.154s)
[104.840627] Starting dynamic subtest: vcs0
[106.985098] Dynamic subtest vcs0: SUCCESS (2.154s)
[106.994121] Starting dynamic subtest: vcs1
[109.139994] Dynamic subtest vcs1: SUCCESS (2.154s)
[109.149418] Starting dynamic subtest: vecs0
[111.292961] Dynamic subtest vecs0: SUCCESS (2.153s)
[111.294946] Subtest engines: SUCCESS (10.770s)
[111.510825] [018/132] (916s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[113.507624] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[113.509315] Starting dynamic subtest: pipe-A-valid-mode
[113.550048] Dynamic subtest pipe-A-valid-mode: SKIP (0.040s)
[113.552751] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.042s)
[113.736705] [019/132] (913s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[115.743631] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[115.747467] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[115.961941] [020/132] (911s left) kms_psr2_su (page_flip-xrgb8888)
[116.042132] Subtest page_flip-XRGB8888: SKIP (0.000s)
[116.113136] [021/132] (911s left) syncobj_wait (wait-delayed-signal)
[116.158211] Starting subtest: wait-delayed-signal
[116.264276] Subtest wait-delayed-signal: SUCCESS (0.103s)
[116.444631] [022/132] (911s left) gem_ctx_shared (q-out-order)
[116.502353] Starting subtest: Q-out-order
[116.503935] Starting dynamic subtest: rcs0
[116.758167] Dynamic subtest rcs0: SUCCESS (0.253s)
[116.767158] Starting dynamic subtest: bcs0
[116.878719] Dynamic subtest bcs0: SUCCESS (0.120s)
[116.887777] Starting dynamic subtest: vcs0
[117.001651] Dynamic subtest vcs0: SUCCESS (0.123s)
[117.010823] Starting dynamic subtest: vcs1
[117.124624] Dynamic subtest vcs1: SUCCESS (0.122s)
[117.133779] Starting dynamic subtest: vecs0
[117.256279] Dynamic subtest vecs0: SUCCESS (0.131s)
[117.257990] Subtest Q-out-order: SUCCESS (0.751s)
[117.630605] [FACT gem_ctx_shared (q-out-order)] new: kernel.kmod_is_loaded.vgem: true
[117.633949] [023/132] (910s left) kms_cursor_crc (cursor-random-32x10)
[119.731113] Starting subtest: cursor-random-32x10
[119.781193] Subtest cursor-random-32x10: SKIP (0.046s)
[120.241010] [024/132] (907s left) sysfs_timeslice_duration (invalid)
[120.291741] Starting subtest: invalid
[120.293302] Starting dynamic subtest: vecs0
[120.294983] Dynamic subtest vecs0: SUCCESS (0.000s)
[120.304513] Starting dynamic subtest: vcs0
[120.305992] Dynamic subtest vcs0: SUCCESS (0.001s)
[120.315233] Starting dynamic subtest: bcs0
[120.316917] Dynamic subtest bcs0: SUCCESS (0.000s)
[120.325941] Starting dynamic subtest: rcs0
[120.327812] Dynamic subtest rcs0: SUCCESS (0.000s)
[120.336753] Starting dynamic subtest: vcs1
[120.338273] Dynamic subtest vcs1: SUCCESS (0.000s)
[120.339958] Subtest invalid: SUCCESS (0.004s)
[120.422789] [025/132] (907s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[122.429135] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[123.672679] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.244s)
[123.890792] [026/132] (904s left) gem_eio (reset-stress)
[124.084132] Starting subtest: reset-stress
[152.221219] Subtest reset-stress: SUCCESS (28.138s)
[154.432942] [027/132] (874s left) i915_drm_fdinfo (memory-info-purgeable)
[154.484807] Starting subtest: memory-info-purgeable
[154.486544] Starting dynamic subtest: lmem0
[158.819867] Dynamic subtest lmem0: SUCCESS (4.334s)
[158.833883] Starting dynamic subtest: smem0
[163.292666] Dynamic subtest smem0: SUCCESS (4.468s)
[163.294460] Subtest memory-info-purgeable: SUCCESS (8.805s)
[163.445856] [028/132] (865s left) kms_frontbuffer_tracking (fbc-2p-rte)
[165.440130] Starting subtest: fbc-2p-rte
[165.443568] Subtest fbc-2p-rte: SKIP (0.000s)
[165.694186] [029/132] (862s left) gem_exec_schedule (preempt-other)
[165.756034] Starting subtest: preempt-other
[165.757364] Starting dynamic subtest: rcs0
[165.886611] Dynamic subtest rcs0: SUCCESS (0.127s)
[165.896317] Starting dynamic subtest: bcs0
[165.991401] Dynamic subtest bcs0: SUCCESS (0.108s)
[166.001056] Starting dynamic subtest: vcs0
[166.100510] Dynamic subtest vcs0: SUCCESS (0.109s)
[166.110240] Starting dynamic subtest: vcs1
[166.209617] Dynamic subtest vcs1: SUCCESS (0.109s)
[166.219437] Starting dynamic subtest: vecs0
[166.318764] Dynamic subtest vecs0: SUCCESS (0.109s)
[166.320218] Subtest preempt-other: SUCCESS (0.563s)
[166.767418] [030/132] (862s left) gem_exec_params (invalid-fence-in)
[166.817176] Starting subtest: invalid-fence-in
[166.818922] Subtest invalid-fence-in: SUCCESS (0.000s)
[166.992251] [031/132] (861s left) kms_atomic (plane-immutable-zpos)
[168.979114] Starting subtest: plane-immutable-zpos
[168.982657] Starting dynamic subtest: pipe-A-HDMI-A-4
[169.730543] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.748s)
[169.732202] Subtest plane-immutable-zpos: SUCCESS (0.750s)
[169.992985] [032/132] (858s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[171.999914] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[173.265823] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.262s)
[173.513800] [033/132] (855s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[173.561272] Starting subtest: invalid-multi-wait-all-unsubmitted
[173.562722] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[173.769365] [034/132] (855s left) gem_exec_fence (parallel)
[173.942381] Starting subtest: parallel
[173.943968] Starting dynamic subtest: rcs0
[176.095368] Dynamic subtest rcs0: SUCCESS (2.153s)
[176.105186] Starting dynamic subtest: bcs0
[178.243114] Dynamic subtest bcs0: SUCCESS (2.148s)
[178.252826] Starting dynamic subtest: vcs0
[180.397245] Dynamic subtest vcs0: SUCCESS (2.154s)
[180.406975] Starting dynamic subtest: vcs1
[182.551339] Dynamic subtest vcs1: SUCCESS (2.154s)
[182.561329] Starting dynamic subtest: vecs0
[184.702624] Dynamic subtest vecs0: SUCCESS (2.151s)
[184.704491] Subtest parallel: SUCCESS (10.760s)
[185.395033] [035/132] (843s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[187.437593] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[187.550907] [036/132] (841s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[187.598108] Starting subtest: single-wait-all-for-submit-unsubmitted
[187.704431] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[187.912579] [037/132] (841s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[189.905839] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[189.908717] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[190.118104] [038/132] (839s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[190.173174] Starting subtest: y-tiled-to-vebox-yf-tiled
[190.174708] Starting dynamic subtest: smem
[190.258460] Dynamic subtest smem: SUCCESS (0.087s)
[190.268317] Starting dynamic subtest: lmem0
[191.019911] Dynamic subtest lmem0: SUCCESS (0.758s)
[191.021734] Subtest y-tiled-to-vebox-yf-tiled: SUCCESS (0.845s)
[191.331690] [039/132] (838s left) kms_plane_multiple (2x-tiling-4)
[193.319179] Starting subtest: 2x-tiling-4
[193.322103] Subtest 2x-tiling-4: SKIP (0.000s)
[193.495901] [040/132] (836s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[195.493245] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[195.496131] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[195.762907] [041/132] (834s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[197.755581] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[197.758199] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[198.004893] [042/132] (832s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[200.014456] Starting subtest: 4-tiled-32bpp-rotate-270
[200.028673] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.000s)
[200.279221] [043/132] (829s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[202.290555] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[202.293109] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[202.566142] [044/132] (827s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[204.551833] Starting subtest: compare-crc-sanitycheck-nv12
[204.553505] Starting dynamic subtest: pipe-A-HDMI-A-4
[205.195566] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.641s)
[205.205629] Starting dynamic subtest: pipe-B-HDMI-A-4
[205.720177] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.523s)
[205.731198] Starting dynamic subtest: pipe-C-HDMI-A-4
[206.214217] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.491s)
[206.225152] Starting dynamic subtest: pipe-D-HDMI-A-4
[206.708297] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.493s)
[206.710038] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.157s)
[206.947234] [045/132] (823s left) kms_cdclk (plane-scaling)
[206.999274] Subtest plane-scaling: SKIP (0.000s)
[207.080039] [046/132] (823s left) gem_exec_fence (syncobj-wait)
[207.485040] Starting subtest: syncobj-wait
[207.579056] Subtest syncobj-wait: SUCCESS (0.094s)
[208.003287] [047/132] (822s left) kms_sharpness_filter (filter-dpms)
[209.985449] Starting subtest: filter-dpms
[209.994829] Subtest filter-dpms: SKIP (0.002s)
[210.194213] [048/132] (820s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[210.244735] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[210.311648] [049/132] (820s left) kms_vrr (flip-basic-fastset)
[212.294362] Starting subtest: flip-basic-fastset
[212.298957] Subtest flip-basic-fastset: SKIP (0.000s)
[212.480633] [050/132] (818s left) api_intel_allocator (simple-allocator)
[212.530490] Starting subtest: simple-allocator
[212.532053] Starting dynamic subtest: basic
[212.549226] Dynamic subtest basic: SUCCESS (0.020s)
[212.559273] Starting dynamic subtest: parallel-one
[212.748298] Dynamic subtest parallel-one: SUCCESS (0.196s)
[212.758155] Starting dynamic subtest: print
[212.759799] Dynamic subtest print: SUCCESS (0.000s)
[212.770056] Starting dynamic subtest: reuse
[212.771915] Dynamic subtest reuse: SUCCESS (0.000s)
[212.781843] Starting dynamic subtest: reserve
[212.783674] Dynamic subtest reserve: SUCCESS (0.000s)
[212.793274] Starting dynamic subtest: fork-reopen-allocator
[212.795118] Dynamic subtest fork-reopen-allocator: SUCCESS (0.016s)
[212.796946] Subtest simple-allocator: SUCCESS (0.234s)
[212.979647] [051/132] (818s left) kms_getfb (getfb2-accept-nv12)
[214.969882] Starting subtest: getfb2-accept-nv12
[214.971596] Subtest getfb2-accept-nv12: SUCCESS (0.002s)
[215.253625] [052/132] (815s left) perf_pmu (busy-accuracy-50)
[215.305056] Starting subtest: busy-accuracy-50
[215.306823] Starting dynamic subtest: rcs0
[216.848943] Dynamic subtest rcs0: SUCCESS (1.542s)
[216.860338] Starting dynamic subtest: bcs0
[218.391588] Dynamic subtest bcs0: SUCCESS (1.542s)
[218.402275] Starting dynamic subtest: vcs0
[219.935046] Dynamic subtest vcs0: SUCCESS (1.543s)
[219.945629] Starting dynamic subtest: vcs1
[221.481221] Dynamic subtest vcs1: SUCCESS (1.546s)
[221.491812] Starting dynamic subtest: vecs0
[223.024253] Dynamic subtest vecs0: SUCCESS (1.542s)
[223.025703] Subtest busy-accuracy-50: SUCCESS (7.719s)
[223.222530] [053/132] (807s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[225.225262] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[225.228991] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[225.514913] [054/132] (805s left) gem_exec_reloc (basic-cpu-read)
[225.567293] Subtest basic-cpu-read: SKIP (0.000s)
[225.692732] [055/132] (805s left) gem_workarounds (basic-read-fd)
[225.761055] Starting subtest: basic-read-fd
[225.793693] Subtest basic-read-fd: SUCCESS (0.032s)
[225.991126] [056/132] (805s left) i915_pm_rpm (gem-execbuf)
[231.062675] Starting subtest: gem-execbuf
[231.064514] Starting dynamic subtest: lmem0
[235.553723] Dynamic subtest lmem0: SUCCESS (4.487s)
[235.604776] Starting dynamic subtest: smem0
[239.291646] Dynamic subtest smem0: SUCCESS (3.734s)
[239.294369] Subtest gem-execbuf: SUCCESS (8.227s)
[240.638513] [057/132] (791s left) perf_pmu (semaphore-wait)
[240.710499] Starting subtest: semaphore-wait
[240.712122] Starting dynamic subtest: rcs0
[241.240155] Dynamic subtest rcs0: SUCCESS (0.527s)
[241.251226] Starting dynamic subtest: bcs0
[241.754384] Dynamic subtest bcs0: SUCCESS (0.511s)
[241.765252] Starting dynamic subtest: vcs0
[242.268528] Dynamic subtest vcs0: SUCCESS (0.511s)
[242.279679] Starting dynamic subtest: vcs1
[242.782741] Dynamic subtest vcs1: SUCCESS (0.511s)
[242.793881] Starting dynamic subtest: vecs0
[243.297199] Dynamic subtest vecs0: SUCCESS (0.511s)
[243.298807] Subtest semaphore-wait: SUCCESS (2.586s)
[243.489536] [058/132] (788s left) gen7_exec_parse (basic-offset)
[243.541902] Subtest basic-offset: SKIP (0.000s)
[243.623259] [059/132] (788s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[245.613529] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[245.616476] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[245.901415] [060/132] (786s left) drm_read (invalid-buffer)
[247.963348] Starting subtest: invalid-buffer
[247.964848] Subtest invalid-buffer: SUCCESS (0.000s)
[248.244997] [061/132] (783s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[248.294316] Starting subtest: single-wait-for-submit-unsubmitted
[248.400713] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[248.549593] [062/132] (783s left) gem_gtt_cpu_tlb
[248.672843] [063/132] (783s left) kms_joiner (invalid-modeset-big-joiner)
[250.666146] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[250.876353] [064/132] (781s left) gem_exec_whisper (basic-fds-forked)
[250.933889] Starting subtest: basic-fds-forked
[264.550835] Subtest basic-fds-forked: SUCCESS (13.612s)
[264.862269] [065/132] (767s left) gem_eio (in-flight-immediate)
[265.058137] Starting subtest: in-flight-immediate
[269.520684] Subtest in-flight-immediate: SUCCESS (4.464s)
[271.679940] [066/132] (760s left) kms_cursor_crc (cursor-sliding-256x256)
[273.886929] Starting subtest: cursor-sliding-256x256
[273.894533] Starting dynamic subtest: pipe-A-HDMI-A-4
[278.351706] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.458s)
[278.383449] Starting dynamic subtest: pipe-D-HDMI-A-4
[282.659524] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.284s)
[282.661100] Subtest cursor-sliding-256x256: SUCCESS (8.771s)
[283.096703] [067/132] (749s left) kms_rotation_crc (primary-rotation-270)
[285.083711] Starting subtest: primary-rotation-270
[295.745120] Subtest primary-rotation-270: SUCCESS (10.661s)
[296.065407] [068/132] (736s left) gem_eio (wait-wedge-10ms)
[296.259365] Starting subtest: wait-wedge-10ms
[297.889597] Subtest wait-wedge-10ms: SUCCESS (1.629s)
[300.043396] [069/132] (732s left) gem_userptr_blits (vma-merge)
[300.157638] Starting subtest: vma-merge
[300.242988] Subtest vma-merge: SUCCESS (0.087s)
[300.420807] [070/132] (732s left) kms_psr (pr-cursor-plane-move)
[302.447936] Subtest pr-cursor-plane-move: SKIP (0.000s)
[302.523646] [071/132] (730s left) gem_eio (wait-10ms)
[302.718654] Starting subtest: wait-10ms
[303.171169] Subtest wait-10ms: SUCCESS (0.454s)
[305.327523] [072/132] (727s left) gem_ctx_param (non-root-set)
[305.374420] Starting subtest: non-root-set
[305.395370] Subtest non-root-set: SUCCESS (0.021s)
[305.586288] [073/132] (727s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[307.573804] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[307.575400] Starting dynamic subtest: pipe-A-HDMI-A-4
[307.581259] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[307.592930] Starting dynamic subtest: pipe-B-HDMI-A-4
[307.599074] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[307.610748] Starting dynamic subtest: pipe-C-HDMI-A-4
[307.616999] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[307.628369] Starting dynamic subtest: pipe-D-HDMI-A-4
[307.634701] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[307.637698] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.009s)
[307.848444] [074/132] (725s left) gem_exec_balancer (parallel-keep-submit-fence)
[308.262825] Starting subtest: parallel-keep-submit-fence
[310.550191] Subtest parallel-keep-submit-fence: SUCCESS (2.288s)
[310.678897] [075/132] (722s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[312.686223] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[312.754216] [076/132] (720s left) kms_vblank (wait-busy-hang)
[314.740451] Starting subtest: wait-busy-hang
[314.744299] Starting dynamic subtest: pipe-A-HDMI-A-4
[341.481103] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (26.738s)
[341.497591] Starting dynamic subtest: pipe-D-HDMI-A-4
[366.472188] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (24.985s)
[366.473887] Subtest wait-busy-hang: SUCCESS (51.731s)
[366.689652] [077/132] (666s left) gem_linear_blits (normal)
[367.102131] Starting subtest: normal
[375.916796] Subtest normal: SUCCESS (8.812s)
[376.548732] [078/132] (657s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[378.601647] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[378.602978] Starting dynamic subtest: pipe-A-valid-mode
[379.841489] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.238s)
[379.842919] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.241s)
[380.085315] [079/132] (653s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[382.075720] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[382.077161] Starting dynamic subtest: pipe-A
[382.230224] Dynamic subtest pipe-A: SUCCESS (0.156s)
[382.243447] Starting dynamic subtest: pipe-B
[382.371957] Dynamic subtest pipe-B: SUCCESS (0.141s)
[382.384463] Starting dynamic subtest: pipe-C
[382.511441] Dynamic subtest pipe-C: SUCCESS (0.138s)
[382.524228] Starting dynamic subtest: pipe-D
[382.651147] Dynamic subtest pipe-D: SUCCESS (0.139s)
[382.652743] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.578s)
[382.868786] [080/132] (650s left) gem_ctx_param (invalid-get-engines)
[382.918502] Starting subtest: invalid-get-engines
[382.920230] Subtest invalid-get-engines: SUCCESS (0.001s)
[383.095794] [081/132] (650s left) kms_prime (basic-crc-vgem)
[385.113871] Subtest basic-crc-vgem: SKIP (0.000s)
[385.357817] [082/132] (648s left) gem_softpin (safe-alignment)
[385.414183] Starting subtest: safe-alignment
[385.455448] Subtest safe-alignment: SUCCESS (0.041s)
[385.700955] [083/132] (648s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[387.694702] Starting subtest: fbcpsr-modesetfrombusy
[387.697756] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s)
[387.952147] [084/132] (646s left) kms_psr (psr-cursor-plane-move)
[389.941249] Subtest psr-cursor-plane-move: SKIP (0.000s)
[390.031837] [085/132] (644s left) gem_ccs (block-copy-compressed)
[390.084845] Starting subtest: block-copy-compressed
[390.087817] Subtest block-copy-compressed: SKIP (0.000s)
[390.257809] [086/132] (644s left) kms_async_flips (async-flip-suspend-resume)
[392.244905] Starting subtest: async-flip-suspend-resume
[392.488723] Starting dynamic subtest: pipe-A-HDMI-A-4
[414.143130] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (11.186s)
[414.353399] Starting dynamic subtest: pipe-B-HDMI-A-4
[437.109492] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (10.641s)
[437.283526] Starting dynamic subtest: pipe-C-HDMI-A-4
[459.118233] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (10.641s)
[459.282396] Starting dynamic subtest: pipe-D-HDMI-A-4
[481.101462] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (10.653s)
[481.103063] Subtest async-flip-suspend-resume: SUCCESS (43.898s)
[487.466311] [087/132] (553s left) kms_pwrite_crc
[490.380207] [088/132] (550s left) kms_flip (dpms-vs-vblank-race-interruptible)
[492.380425] Starting subtest: dpms-vs-vblank-race-interruptible
[492.387085] Starting dynamic subtest: A-HDMI-A4
[495.384239] Dynamic subtest A-HDMI-A4: SUCCESS (2.996s)
[495.398535] Starting dynamic subtest: B-HDMI-A4
[498.304552] Dynamic subtest B-HDMI-A4: SUCCESS (2.918s)
[498.319383] Starting dynamic subtest: C-HDMI-A4
[501.317467] Dynamic subtest C-HDMI-A4: SUCCESS (3.012s)
[501.331931] Starting dynamic subtest: D-HDMI-A4
[504.321982] Dynamic subtest D-HDMI-A4: SUCCESS (3.003s)
[504.323485] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (11.944s)
[504.562853] [089/132] (536s left) gem_render_copy_redux (flink)
[504.634583] Starting subtest: flink
[506.628550] Subtest flink: SUCCESS (1.994s)
[506.887031] [090/132] (534s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[508.878377] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[509.915167] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.038s)
[510.138620] [091/132] (530s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[512.120228] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[512.123446] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[512.373687] [092/132] (528s left) i915_suspend (basic-s3-without-i915)
[512.420262] Starting subtest: basic-s3-without-i915
[538.630236] Subtest basic-s3-without-i915: SUCCESS (14.944s)
[540.747562] [093/132] (502s left) kms_psr (pr-primary-mmap-gtt)
[542.737022] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[542.813146] [094/132] (500s left) kms_pm_rpm (fences-dpms)
[547.296543] Starting subtest: fences-dpms
[547.299652] Subtest fences-dpms: SKIP (0.000s)
[548.544750] [095/132] (494s left) gem_ctx_persistence (process)
[548.612813] Starting subtest: process
[548.784786] Subtest process: SUCCESS (0.171s)
[548.991359] [096/132] (494s left) gem_exec_balancer (hang)
[549.356582] Starting subtest: hang
[552.126608] Subtest hang: SUCCESS (2.775s)
[552.340043] [097/132] (491s left) gem_mmap_gtt (cpuset-big-copy-odd)
[552.386999] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[552.462099] [098/132] (491s left) kms_psr (fbc-psr2-cursor-plane-move)
[554.449411] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[554.527371] [099/132] (489s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[556.514721] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[556.516400] Starting dynamic subtest: pipe-A-valid-mode
[558.930452] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.413s)
[558.932199] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SUCCESS (2.416s)
[559.128145] [100/132] (484s left) vgem_basic (debugfs)
[559.177746] Starting subtest: debugfs
[559.179111] Subtest debugfs: SUCCESS (0.001s)
[559.356889] [101/132] (484s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[561.349773] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[561.353207] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[561.621985] [102/132] (482s left) sysfs_heartbeat_interval (precise)
[561.677041] Starting subtest: precise
[561.678554] Starting dynamic subtest: vecs0
[564.089670] Dynamic subtest vecs0: SUCCESS (2.412s)
[564.102857] Starting dynamic subtest: vcs0
[565.312882] Dynamic subtest vcs0: SUCCESS (1.221s)
[565.326338] Starting dynamic subtest: bcs0
[568.152916] Dynamic subtest bcs0: SUCCESS (2.838s)
[568.167837] Starting dynamic subtest: rcs0
[571.126246] Dynamic subtest rcs0: SUCCESS (2.972s)
[571.139621] Starting dynamic subtest: vcs1
[572.394400] Dynamic subtest vcs1: SUCCESS (1.266s)
[572.395875] Subtest precise: SUCCESS (10.720s)
[572.561504] [103/132] (471s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[574.556337] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[574.559689] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[574.817059] [104/132] (469s left) gem_mmap_gtt (zero-extend)
[574.864244] Subtest zero-extend: SKIP (0.000s)
[574.941416] [105/132] (469s left) kms_atomic_interruptible (atomic-setmode)
[576.931303] Starting subtest: atomic-setmode
[576.932967] Starting dynamic subtest: pipe-A-HDMI-A-4
[583.138178] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (6.206s)
[583.139571] Subtest atomic-setmode: SUCCESS (6.209s)
[583.378850] [106/132] (461s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[585.379617] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[585.381050] Starting dynamic subtest: pipe-A-HDMI-A-4
[585.395390] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[585.408843] Starting dynamic subtest: pipe-B-HDMI-A-4
[585.423717] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[585.436294] Starting dynamic subtest: pipe-C-HDMI-A-4
[585.451110] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[585.463927] Starting dynamic subtest: pipe-D-HDMI-A-4
[585.479659] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[585.482776] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.011s)
[585.663288] [107/132] (458s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[587.657273] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[587.660547] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[587.869622] [108/132] (456s left) kms_flip (plain-flip-ts-check)
[589.856711] Starting subtest: plain-flip-ts-check
[589.864378] Starting dynamic subtest: A-HDMI-A4
[598.301108] Dynamic subtest A-HDMI-A4: SUCCESS (8.436s)
[598.334298] Starting dynamic subtest: B-HDMI-A4
[606.696144] Dynamic subtest B-HDMI-A4: SUCCESS (8.390s)
[606.712190] Starting dynamic subtest: C-HDMI-A4
[615.077013] Dynamic subtest C-HDMI-A4: SUCCESS (8.377s)
[615.094205] Starting dynamic subtest: D-HDMI-A4
[623.452614] Dynamic subtest D-HDMI-A4: SUCCESS (8.371s)
[623.454227] Subtest plain-flip-ts-check: SUCCESS (33.598s)
[623.715786] [109/132] (421s left) dmabuf (all-tests)
[623.854354] Starting subtest: all-tests
[623.856325] Starting dynamic subtest: sanitycheck
[623.905123] Dynamic subtest sanitycheck: SUCCESS (0.122s)
[623.953250] Starting dynamic subtest: dma_fence
[624.146246] Dynamic subtest dma_fence: SUCCESS (0.233s)
[624.191454] Starting dynamic subtest: dma_fence_chain
[635.139989] Dynamic subtest dma_fence_chain: SUCCESS (10.987s)
[635.164242] Starting dynamic subtest: dma_fence_unwrap
[635.222571] Dynamic subtest dma_fence_unwrap: SUCCESS (0.079s)
[635.247189] Starting dynamic subtest: dma_resv
[635.319256] Dynamic subtest dma_resv: SUCCESS (0.093s)
[635.327294] Subtest all-tests: SUCCESS (11.542s)
[635.503382] [110/132] (409s left) gem_pxp (hw-rejects-pxp-context)
[638.078281] Starting subtest: hw-rejects-pxp-context
[638.080019] Subtest hw-rejects-pxp-context: SUCCESS (0.001s)
[638.231664] [111/132] (406s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[640.225442] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[640.228259] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[640.478018] [112/132] (404s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[642.486622] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[642.557374] [113/132] (402s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[647.711114] Starting subtest: heavy-verify-multi-ccs
[647.712603] Starting dynamic subtest: lmem0
[647.715518] Dynamic subtest lmem0: SKIP (0.000s)
[647.718768] Subtest heavy-verify-multi-ccs: SKIP (0.002s)
[651.714771] [FACT gem_lmem_swapping (heavy-verify-multi-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[651.715923] [FACT gem_lmem_swapping (heavy-verify-multi-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[651.719112] [114/132] (393s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[657.632460] Starting subtest: short-flip-after-cursor-atomic-transitions
[658.687828] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.057s)
[658.974375] [FACT kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[658.977998] [FACT kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)] new: kernel.kmod_is_loaded.i915: true
[658.982570] [115/132] (386s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[660.972382] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[660.976946] Starting dynamic subtest: pipe-A-HDMI-A-4
[660.991398] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.002s)
[661.004251] Starting dynamic subtest: pipe-B-HDMI-A-4
[661.020778] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.002s)
[661.033553] Starting dynamic subtest: pipe-C-HDMI-A-4
[661.050050] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.002s)
[661.062473] Starting dynamic subtest: pipe-D-HDMI-A-4
[661.076666] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.002s)
[661.078141] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SUCCESS (0.018s)
[661.273720] [116/132] (384s left) kms_setmode (basic)
[661.321708] Starting subtest: basic
[661.416965] Starting dynamic subtest: pipe-A-HDMI-A-4
[663.538306] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.115s)
[663.626301] Starting dynamic subtest: pipe-B-HDMI-A-4
[665.726679] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.106s)
[665.762264] Subtest basic: SUCCESS (4.437s)
[665.966140] [117/132] (379s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[666.019581] Starting subtest: etime-multi-wait-all-for-submit-submitted
[666.125718] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.104s)
[666.348016] [118/132] (379s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[668.342498] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[668.345731] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[668.564701] [119/132] (377s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[670.552363] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[670.556537] Starting dynamic subtest: pipe-A-HDMI-A-4
[670.571828] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[670.584527] Starting dynamic subtest: pipe-B-HDMI-A-4
[670.600143] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[670.612405] Starting dynamic subtest: pipe-C-HDMI-A-4
[670.628548] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[670.641176] Starting dynamic subtest: pipe-D-HDMI-A-4
[670.658184] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[670.661579] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.011s)
[670.832161] [120/132] (375s left) gem_pread (bench)
[670.888991] Subtest bench: SKIP (0.000s)
[670.990464] [121/132] (374s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[672.982137] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[672.984741] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[673.243673] [122/132] (372s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[675.230455] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[675.233942] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[675.488016] [123/132] (370s left) gem_exec_capture (userptr)
[675.550080] Starting subtest: userptr
[676.416650] Subtest userptr: SUCCESS (0.868s)
[676.588886] [124/132] (369s left) kms_plane (plane-position-hole-dpms)
[678.579412] Starting subtest: plane-position-hole-dpms
[679.008793] Starting dynamic subtest: pipe-A-plane-1
[679.492926] Dynamic subtest pipe-A-plane-1: SUCCESS (0.485s)
[679.505893] Starting dynamic subtest: pipe-A-plane-2
[679.994360] Dynamic subtest pipe-A-plane-2: SUCCESS (0.500s)
[680.007585] Starting dynamic subtest: pipe-A-plane-3
[680.479377] Dynamic subtest pipe-A-plane-3: SUCCESS (0.483s)
[680.492659] Starting dynamic subtest: pipe-A-plane-4
[680.979140] Dynamic subtest pipe-A-plane-4: SUCCESS (0.498s)
[680.992273] Starting dynamic subtest: pipe-A-plane-5
[681.463256] Dynamic subtest pipe-A-plane-5: SUCCESS (0.483s)
[681.476419] Starting dynamic subtest: pipe-A-plane-6
[681.949854] Dynamic subtest pipe-A-plane-6: SUCCESS (0.485s)
[681.963134] Starting dynamic subtest: pipe-A-plane-7
[681.972211] Dynamic subtest pipe-A-plane-7: SUCCESS (0.020s)
[682.263250] Starting dynamic subtest: pipe-B-plane-1
[682.724064] Dynamic subtest pipe-B-plane-1: SUCCESS (0.474s)
[682.737111] Starting dynamic subtest: pipe-B-plane-2
[683.189853] Dynamic subtest pipe-B-plane-2: SUCCESS (0.465s)
[683.202696] Starting dynamic subtest: pipe-B-plane-3
[683.669703] Dynamic subtest pipe-B-plane-3: SUCCESS (0.479s)
[683.682720] Starting dynamic subtest: pipe-B-plane-4
[684.134434] Dynamic subtest pipe-B-plane-4: SUCCESS (0.463s)
[684.147563] Starting dynamic subtest: pipe-B-plane-5
[684.592887] Dynamic subtest pipe-B-plane-5: SUCCESS (0.457s)
[684.607060] Starting dynamic subtest: pipe-B-plane-6
[685.058671] Dynamic subtest pipe-B-plane-6: SUCCESS (0.465s)
[685.071880] Starting dynamic subtest: pipe-B-plane-7
[685.085965] Dynamic subtest pipe-B-plane-7: SUCCESS (0.024s)
[685.088127] Subtest plane-position-hole-dpms: SUCCESS (6.508s)
[685.296367] [125/132] (361s left) kms_invalid_mode (bad-hsync-start)
[687.289362] Starting subtest: bad-hsync-start
[687.291163] Starting dynamic subtest: pipe-A-HDMI-A-4
[687.331528] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.041s)
[687.344735] Starting dynamic subtest: pipe-B-HDMI-A-4
[687.346626] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[687.359257] Starting dynamic subtest: pipe-C-HDMI-A-4
[687.361231] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[687.375034] Starting dynamic subtest: pipe-D-HDMI-A-4
[687.376765] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[687.378517] Subtest bad-hsync-start: SUCCESS (0.054s)
[687.568124] [126/132] (358s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[687.617226] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[687.619102] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[687.795862] [127/132] (358s left) kms_psr (psr-sprite-render)
[689.784518] Subtest psr-sprite-render: SKIP (0.000s)
[689.871691] [128/132] (356s left) i915_query (query-topology-coherent-slice-mask)
[689.918740] Starting subtest: query-topology-coherent-slice-mask
[689.920479] Subtest query-topology-coherent-slice-mask: SUCCESS (0.000s)
[690.096142] [129/132] (356s left) i915_hangman (engine-engine-hang)
[690.159688] Starting subtest: engine-engine-hang
[690.161403] Starting dynamic subtest: rcs0
[690.861613] Dynamic subtest rcs0: SUCCESS (0.703s)
[690.876118] Starting dynamic subtest: bcs0
[691.532328] Dynamic subtest bcs0: SUCCESS (0.669s)
[691.552845] Starting dynamic subtest: vcs0
[692.203275] Dynamic subtest vcs0: SUCCESS (0.669s)
[692.216895] Starting dynamic subtest: vcs1
[692.887420] Dynamic subtest vcs1: SUCCESS (0.682s)
[692.905233] Starting dynamic subtest: vecs0
[693.558306] Dynamic subtest vecs0: SUCCESS (0.669s)
[693.559918] Subtest engine-engine-hang: SUCCESS (3.402s)
[693.820044] [130/132] (352s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[695.806703] Starting subtest: plane-use-after-nonblocking-unbind
[695.808118] Starting dynamic subtest: pipe-A-HDMI-A-4
[695.890478] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.084s)
[695.959528] Starting dynamic subtest: pipe-B-HDMI-A-4
[696.111423] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.164s)
[696.134926] Subtest plane-use-after-nonblocking-unbind: SUCCESS (0.329s)
[696.339910] [131/132] (350s left) prime_vgem (busy)
[696.424138] Starting subtest: busy
[696.425590] Starting dynamic subtest: rcs0
[696.481387] Dynamic subtest rcs0: SUCCESS (0.059s)
[696.497858] Starting dynamic subtest: bcs0
[696.521410] Dynamic subtest bcs0: SUCCESS (0.038s)
[696.536232] Starting dynamic subtest: vcs0
[696.565858] Dynamic subtest vcs0: SUCCESS (0.043s)
[696.581976] Starting dynamic subtest: vcs1
[696.604439] Dynamic subtest vcs1: SUCCESS (0.037s)
[696.623204] Starting dynamic subtest: vecs0
[696.645612] Dynamic subtest vecs0: SUCCESS (0.039s)
[696.647167] Subtest busy: SUCCESS (0.225s)
[696.849336] [132/132] (350s left) kms_flip (2x-plain-flip-ts-check)
[698.832243] Starting subtest: 2x-plain-flip-ts-check
[698.849990] Subtest 2x-plain-flip-ts-check: SKIP (0.018s)
[699.074790] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_exec_schedule
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: gem_exec_params
results: parsing output: 5/ for test: kms_draw_crc
results: parsing output: 6/ for test: kms_content_protection
results: parsing output: 7/ for test: api_intel_bb
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: gem_mmap_gtt
results: parsing output: 10/ for test: kms_dirtyfb
results: parsing output: 11/ for test: kms_cursor_crc
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_chamelium_hpd
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: gem_cs_tlb
results: parsing output: 17/ for test: kms_flip_scaled_crc
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_psr2_su
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: gem_ctx_shared
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: sysfs_timeslice_duration
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: gem_eio
results: parsing output: 26/ for test: i915_drm_fdinfo
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_exec_schedule
results: parsing output: 29/ for test: gem_exec_params
results: parsing output: 30/ for test: kms_atomic
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: gem_exec_fence
results: parsing output: 34/ for test: kms_chamelium_frames
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_render_copy
results: parsing output: 38/ for test: kms_plane_multiple
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_pipe_crc_basic
results: parsing output: 44/ for test: kms_cdclk
results: parsing output: 45/ for test: gem_exec_fence
results: parsing output: 46/ for test: kms_sharpness_filter
results: parsing output: 47/ for test: kms_pipe_b_c_ivb
results: parsing output: 48/ for test: kms_vrr
results: parsing output: 49/ for test: api_intel_allocator
results: parsing output: 50/ for test: kms_getfb
results: parsing output: 51/ for test: perf_pmu
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: gem_workarounds
results: parsing output: 55/ for test: i915_pm_rpm
results: parsing output: 56/ for test: perf_pmu
results: parsing output: 57/ for test: gen7_exec_parse
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: drm_read
results: parsing output: 60/ for test: syncobj_wait
results: parsing output: 61/ for test: gem_gtt_cpu_tlb
results: parsing output: 62/ for test: kms_joiner
results: parsing output: 63/ for test: gem_exec_whisper
results: parsing output: 64/ for test: gem_eio
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_rotation_crc
results: parsing output: 67/ for test: gem_eio
results: parsing output: 68/ for test: gem_userptr_blits
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: gem_eio
results: parsing output: 71/ for test: gem_ctx_param
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: gem_exec_balancer
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: kms_vblank
results: parsing output: 76/ for test: gem_linear_blits
results: parsing output: 77/ for test: kms_flip_scaled_crc
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: gem_ctx_param
results: parsing output: 80/ for test: kms_prime
results: parsing output: 81/ for test: gem_softpin
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: gem_ccs
results: parsing output: 85/ for test: kms_async_flips
results: parsing output: 86/ for test: kms_pwrite_crc
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: gem_render_copy_redux
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: i915_suspend
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_pm_rpm
results: parsing output: 94/ for test: gem_ctx_persistence
results: parsing output: 95/ for test: gem_exec_balancer
results: parsing output: 96/ for test: gem_mmap_gtt
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: vgem_basic
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: sysfs_heartbeat_interval
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: kms_atomic_interruptible
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: dmabuf
results: parsing output: 109/ for test: gem_pxp
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: gem_lmem_swapping
results: parsing output: 113/ for test: kms_cursor_legacy
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: kms_setmode
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: gem_pread
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: gem_exec_capture
results: parsing output: 123/ for test: kms_plane
results: parsing output: 124/ for test: kms_invalid_mode
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: i915_query
results: parsing output: 128/ for test: i915_hangman
results: parsing output: 129/ for test: kms_atomic_transition
results: parsing output: 130/ for test: prime_vgem
results: parsing output: 131/ for test: kms_flip
Done.