[64.064883] Initializing watchdogs
[64.064967]   /dev/watchdog0
[64.095821] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[64.111139] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[64.116433] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.119169] [001/155] (960s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[65.670126] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[65.806317] [002/155] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[67.312334] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[67.314485] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[67.673604] [003/155] (957s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[69.274264] Starting subtest: short-busy-flip-before-cursor-toggle
[69.276263] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[69.387541] [004/155] (955s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[70.901042] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[70.903200] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[71.076078] [005/155] (953s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[72.577680] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[72.597729] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.019s)
[72.760686] [006/155] (952s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[74.259236] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[74.261402] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[74.411562] [007/155] (950s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[75.920228] Starting subtest: fbc-farfromfence-mmap-gtt
[75.921954] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[76.092807] [008/155] (949s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[77.596042] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[77.598228] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[77.762611] [009/155] (947s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[79.263253] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[79.264941] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[79.415682] [010/155] (946s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[80.926929] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[80.929057] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[81.154514] [011/155] (944s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[82.653553] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[82.655253] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[82.837619] [012/155] (942s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[84.354157] Starting subtest: x-tiled-16bpp-rotate-90
[84.476209] Subtest x-tiled-16bpp-rotate-90: SKIP (0.119s)
[84.623135] [013/155] (941s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[86.114836] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[86.115776] Starting dynamic subtest: pipe-A
[86.983940] Dynamic subtest pipe-A: SUCCESS (0.869s)
[86.993999] Starting dynamic subtest: pipe-B
[87.759546] Dynamic subtest pipe-B: SUCCESS (0.775s)
[87.768988] Starting dynamic subtest: pipe-C
[88.534392] Dynamic subtest pipe-C: SUCCESS (0.774s)
[88.545528] Starting dynamic subtest: pipe-D
[89.326394] Dynamic subtest pipe-D: SUCCESS (0.791s)
[89.327397] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (3.211s)
[89.574196] [014/155] (936s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[91.067303] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[91.068227] Starting dynamic subtest: pipe-A-HDMI-A-3
[91.077288] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[91.085588] Starting dynamic subtest: pipe-B-HDMI-A-3
[91.094996] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[91.103372] Starting dynamic subtest: pipe-C-HDMI-A-3
[91.112464] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[91.120588] Starting dynamic subtest: pipe-D-HDMI-A-3
[91.130023] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[91.131924] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.009s)
[91.371102] [015/155] (934s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[92.868911] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-wc
[92.871048] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[93.059847] [016/155] (933s left) gem_create (create-ext-set-pat)
[93.237943] Starting subtest: create-ext-set-pat
[93.242362] Subtest create-ext-set-pat: SKIP (0.000s)
[93.437944] [017/155] (932s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[93.484369] Starting subtest: etime-single-wait-for-submit-unsubmitted
[93.589186] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[93.750364] [018/155] (932s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-cpu)
[95.246228] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-cpu
[95.247950] Subtest fbcpsrhdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[95.428305] [019/155] (930s left) gem_ctx_param (set-priority-invalid-size)
[95.475603] Starting subtest: set-priority-invalid-size
[95.476456] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[95.576907] [020/155] (930s left) kms_psr (psr2-primary-render)
[97.070783] Subtest psr2-primary-render: SKIP (0.000s)
[97.137194] [021/155] (929s left) gem_userptr_blits (create-destroy-sync)
[97.202458] Starting subtest: create-destroy-sync
[102.220557] Subtest create-destroy-sync: SUCCESS (5.015s)
[102.386442] [022/155] (924s left) i915_query (query-garbage)
[102.432093] Starting subtest: query-garbage
[102.433153] Subtest query-garbage: SUCCESS (0.000s)
[102.603509] [023/155] (924s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[102.655949] Starting subtest: y-tiled-to-vebox-x-tiled
[102.656903] Starting dynamic subtest: smem
[102.745839] Dynamic subtest smem: SUCCESS (0.090s)
[102.754429] Starting dynamic subtest: lmem0
[103.497290] Dynamic subtest lmem0: SUCCESS (0.748s)
[103.498198] Subtest y-tiled-to-vebox-x-tiled: SUCCESS (0.838s)
[103.766817] [024/155] (922s left) gem_exec_reloc (basic-gtt-wc)
[103.818784] Subtest basic-gtt-wc: SKIP (0.000s)
[103.904013] [025/155] (922s left) i915_pm_rpm (gem-pread)
[108.065794] Starting subtest: gem-pread
[109.293093] Subtest gem-pread: SUCCESS (1.229s)
[110.194424] [026/155] (916s left) kms_psr (psr2-basic)
[111.693702] Subtest psr2-basic: SKIP (0.000s)
[111.846183] [027/155] (915s left) gem_tiled_partial_pwrite_pread (reads)
[111.896980] Subtest reads: SKIP (0.000s)
[111.961266] [028/155] (915s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[112.007541] Starting subtest: single-wait-for-submit-available-submitted
[112.008369] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.001s)
[112.127899] [029/155] (915s left) syncobj_wait (multi-wait-submitted)
[112.173934] Starting subtest: multi-wait-submitted
[112.286724] Subtest multi-wait-submitted: SUCCESS (0.108s)
[112.418123] [030/155] (914s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[113.915033] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[113.917207] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[114.081393] [031/155] (913s left) gem_exec_parallel (basic)
[114.144152] Starting subtest: basic
[114.145172] Starting dynamic subtest: rcs0
[116.182933] Dynamic subtest rcs0: SUCCESS (2.039s)
[116.192655] Starting dynamic subtest: bcs0
[117.698046] Dynamic subtest bcs0: SUCCESS (1.514s)
[117.709478] Starting dynamic subtest: vcs0
[119.275260] Dynamic subtest vcs0: SUCCESS (1.577s)
[119.285492] Starting dynamic subtest: vcs1
[120.817989] Dynamic subtest vcs1: SUCCESS (1.542s)
[120.828519] Starting dynamic subtest: vecs0
[122.374017] Dynamic subtest vecs0: SUCCESS (1.555s)
[122.374937] Subtest basic: SUCCESS (8.231s)
[122.732955] [032/155] (904s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[124.229224] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[124.231436] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[124.388235] [033/155] (903s left) syncobj_wait (single-wait-for-submit-submitted)
[124.445559] Starting subtest: single-wait-for-submit-submitted
[124.550786] Subtest single-wait-for-submit-submitted: SUCCESS (0.101s)
[124.713140] [034/155] (902s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[126.211165] Starting subtest: fbcpsr-rgb565-draw-blt
[126.213213] Subtest fbcpsr-rgb565-draw-blt: SKIP (0.000s)
[126.398754] [035/155] (901s left) perf_pmu (busy-accuracy-98)
[126.448971] Starting subtest: busy-accuracy-98
[126.449973] Starting dynamic subtest: rcs0
[129.498233] Dynamic subtest rcs0: SUCCESS (3.048s)
[129.508479] Starting dynamic subtest: bcs0
[132.550263] Dynamic subtest bcs0: SUCCESS (3.051s)
[132.560466] Starting dynamic subtest: vcs0
[135.597338] Dynamic subtest vcs0: SUCCESS (3.046s)
[135.607441] Starting dynamic subtest: vcs1
[138.643616] Dynamic subtest vcs1: SUCCESS (3.046s)
[138.653641] Starting dynamic subtest: vecs0
[141.692665] Dynamic subtest vecs0: SUCCESS (3.048s)
[141.693524] Subtest busy-accuracy-98: SUCCESS (15.243s)
[141.842656] [036/155] (885s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[143.332840] Starting subtest: dsc-fractional-bpp-with-bpc
[143.349847] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[143.449728] [037/155] (884s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[144.953212] Starting subtest: cursorB-vs-flipB-toggle
[144.955221] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[145.059753] [038/155] (882s left) syncobj_wait (wait-all-delayed-signal)
[145.117021] Starting subtest: wait-all-delayed-signal
[145.222608] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[145.393669] [039/155] (882s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[146.890179] Starting subtest: psr-rgb565-draw-mmap-wc
[146.892231] Subtest psr-rgb565-draw-mmap-wc: SKIP (0.000s)
[147.083716] [040/155] (881s left) gem_wait (busy)
[147.145376] Starting subtest: busy
[147.146365] Starting dynamic subtest: all-engines
[147.706500] Dynamic subtest all-engines: SUCCESS (0.561s)
[147.716593] Starting dynamic subtest: rcs0
[148.245049] Dynamic subtest rcs0: SUCCESS (0.538s)
[148.254914] Starting dynamic subtest: bcs0
[148.786883] Dynamic subtest bcs0: SUCCESS (0.541s)
[148.796834] Starting dynamic subtest: vcs0
[149.328355] Dynamic subtest vcs0: SUCCESS (0.539s)
[149.338049] Starting dynamic subtest: vcs1
[149.864805] Dynamic subtest vcs1: SUCCESS (0.539s)
[149.874532] Starting dynamic subtest: vecs0
[150.403695] Dynamic subtest vecs0: SUCCESS (0.538s)
[150.404507] Subtest busy: SUCCESS (3.259s)
[150.669592] [041/155] (877s left) gem_close_race (basic-threads)
[150.745047] Starting subtest: basic-threads
[151.892649] Subtest basic-threads: SUCCESS (1.148s)
[152.256479] [042/155] (876s left) kms_lease (possible-crtcs-filtering)
[153.746666] Starting subtest: possible-crtcs-filtering
[153.753718] Subtest possible-crtcs-filtering: SUCCESS (0.007s)
[153.854737] [043/155] (874s left) prime_busy (hang)
[153.909152] Starting subtest: hang
[153.911047] Starting dynamic subtest: rcs0
[180.404536] Dynamic subtest rcs0: SUCCESS (26.494s)
[180.414545] Starting dynamic subtest: bcs0
[187.551628] Dynamic subtest bcs0: SUCCESS (7.147s)
[187.561727] Starting dynamic subtest: vcs0
[194.529048] Dynamic subtest vcs0: SUCCESS (6.976s)
[194.539155] Starting dynamic subtest: vcs1
[201.569045] Dynamic subtest vcs1: SUCCESS (7.039s)
[201.579261] Starting dynamic subtest: vecs0
[208.543446] Dynamic subtest vecs0: SUCCESS (6.974s)
[208.544253] Subtest hang: SUCCESS (54.634s)
[208.693962] [044/155] (819s left) kms_getfb (getfb2-handle-zero)
[210.186177] Starting subtest: getfb2-handle-zero
[210.187241] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[210.419853] [045/155] (818s left) gem_close (basic)
[210.471313] Starting subtest: basic
[210.472243] Subtest basic: SUCCESS (0.000s)
[210.659298] [046/155] (818s left) gem_ccs (ctrl-surf-copy)
[210.709975] Starting subtest: ctrl-surf-copy
[210.712117] Subtest ctrl-surf-copy: SKIP (0.000s)
[210.860853] [047/155] (817s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[212.356429] Starting subtest: fbc-indfb-scaledprimary
[213.709358] Subtest fbc-indfb-scaledprimary: SUCCESS (1.353s)
[213.919155] [048/155] (814s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[215.409348] Starting subtest: crc-primary-suspend-y-tiled-ccs
[215.411240] Starting dynamic subtest: pipe-A-HDMI-A-3
[215.414663] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[215.424734] Starting dynamic subtest: pipe-B-HDMI-A-3
[215.427885] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[215.437808] Starting dynamic subtest: pipe-C-HDMI-A-3
[215.440989] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[215.450932] Starting dynamic subtest: pipe-D-HDMI-A-3
[215.454303] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[215.455984] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.006s)
[215.708570] [049/155] (813s left) gem_userptr_blits (readonly-pwrite-unsync)
[215.762960] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[215.974505] [050/155] (813s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-move)
[217.476373] Starting subtest: fbchdr-1p-primscrn-spr-indfb-move
[217.478127] Subtest fbchdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[217.651941] [051/155] (811s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[219.187460] Starting subtest: 4-tiled-64bpp-rotate-0
[219.189204] Subtest 4-tiled-64bpp-rotate-0: SKIP (0.000s)
[219.367590] [052/155] (809s left) kms_cursor_crc (cursor-random-512x512)
[221.124901] Starting subtest: cursor-random-512x512
[221.126583] Subtest cursor-random-512x512: SKIP (0.001s)
[221.363068] [053/155] (808s left) core_getclient (basic)
[221.407458] Starting subtest: basic
[221.408269] Subtest basic: SUCCESS (0.000s)
[221.536531] [054/155] (807s left) gem_mmap_gtt (fault-concurrent)
[221.580029] Subtest fault-concurrent: SKIP (0.000s)
[221.661129] [055/155] (807s left) kms_flip (flip-vs-absolute-wf_vblank)
[223.151191] Starting subtest: flip-vs-absolute-wf_vblank
[223.157897] Starting dynamic subtest: A-HDMI-A3
[231.356755] Dynamic subtest A-HDMI-A3: SUCCESS (8.198s)
[231.400076] Starting dynamic subtest: B-HDMI-A3
[239.372298] Dynamic subtest B-HDMI-A3: SUCCESS (8.011s)
[239.384646] Starting dynamic subtest: C-HDMI-A3
[247.359348] Dynamic subtest C-HDMI-A3: SUCCESS (7.986s)
[247.370363] Starting dynamic subtest: D-HDMI-A3
[255.347389] Dynamic subtest D-HDMI-A3: SUCCESS (7.987s)
[255.349526] Subtest flip-vs-absolute-wf_vblank: SUCCESS (32.197s)
[255.589758] [056/155] (774s left) kms_flip (flip-vs-panning-vs-hang)
[257.081510] Starting subtest: flip-vs-panning-vs-hang
[257.085325] Starting dynamic subtest: A-HDMI-A3
[308.425425] Dynamic subtest A-HDMI-A3: SUCCESS (51.340s)
[308.437235] Starting dynamic subtest: D-HDMI-A3
[358.459231] Dynamic subtest D-HDMI-A3: SUCCESS (50.032s)
[358.461261] Subtest flip-vs-panning-vs-hang: SUCCESS (101.378s)
[358.681298] [057/155] (670s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[360.172618] Starting subtest: primary-x-tiled-reflect-x-0
[370.864814] Subtest primary-x-tiled-reflect-x-0: SUCCESS (10.691s)
[371.124010] [058/155] (658s left) gem_mmap_gtt (fault-concurrent-y)
[371.169947] Subtest fault-concurrent-Y: SKIP (0.000s)
[371.237579] [059/155] (658s left) gem_huc_copy (huc-copy)
[371.306233] Starting subtest: huc-copy
[371.310764] Subtest huc-copy: SUCCESS (0.006s)
[371.516159] [060/155] (658s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[373.027119] Starting subtest: y-tiled-8bpp-rotate-90
[373.146944] Subtest y-tiled-8bpp-rotate-90: SKIP (0.118s)
[373.301223] [061/155] (656s left) kms_psr (pr-cursor-mmap-cpu)
[374.792996] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[374.876203] [062/155] (655s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-move)
[376.378266] Starting subtest: psrhdr-1p-primscrn-cur-indfb-move
[376.379921] Subtest psrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[376.567487] [063/155] (653s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-fullscreen)
[378.065514] Starting subtest: psrhdr-2p-primscrn-spr-indfb-fullscreen
[378.067648] Subtest psrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[378.239077] [064/155] (652s left) kms_psr (fbc-pr-cursor-plane-onoff)
[379.735573] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[379.805769] [065/155] (650s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[381.307724] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[381.309496] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[381.468427] [066/155] (648s left) i915_drm_fdinfo (basics)
[381.522333] Starting subtest: basics
[381.523243] Subtest basics: SUCCESS (0.000s)
[381.644804] [067/155] (648s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-msflip-blt)
[383.141559] Starting subtest: psrhdr-2p-scndscrn-shrfb-msflip-blt
[383.143129] Subtest psrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[383.285562] [068/155] (647s left) gem_mmap_gtt (basic-wc)
[383.341413] Subtest basic-wc: SKIP (0.000s)
[383.422637] [069/155] (647s left) kms_big_fb (linear-16bpp-rotate-0)
[384.934133] Starting subtest: linear-16bpp-rotate-0
[386.868308] Subtest linear-16bpp-rotate-0: SUCCESS (1.931s)
[387.050922] [070/155] (643s left) gem_ctx_persistence (engines-queued)
[387.102629] Starting subtest: engines-queued
[387.103591] Starting dynamic subtest: rcs0
[387.167202] Dynamic subtest rcs0: SUCCESS (0.064s)
[387.177733] Starting dynamic subtest: bcs0
[387.214264] Dynamic subtest bcs0: SUCCESS (0.046s)
[387.228028] Starting dynamic subtest: vcs0
[387.268446] Dynamic subtest vcs0: SUCCESS (0.053s)
[387.290302] Starting dynamic subtest: vcs1
[387.307552] Dynamic subtest vcs1: SUCCESS (0.038s)
[387.325699] Starting dynamic subtest: vecs0
[387.366455] Dynamic subtest vecs0: SUCCESS (0.058s)
[387.367506] Subtest engines-queued: SUCCESS (0.264s)
[387.517722] [071/155] (643s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-render)
[389.014726] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-render
[389.016381] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[389.195762] [072/155] (641s left) gem_spin_batch (resubmit-all)
[389.253409] Starting subtest: resubmit-all
[389.254329] Starting dynamic subtest: rcs0
[389.279233] Dynamic subtest rcs0: SUCCESS (0.025s)
[389.290423] Starting dynamic subtest: bcs0
[389.291490] Dynamic subtest bcs0: SUCCESS (0.002s)
[389.302224] Starting dynamic subtest: vcs0
[389.303391] Dynamic subtest vcs0: SUCCESS (0.002s)
[389.313849] Starting dynamic subtest: vcs1
[389.315013] Dynamic subtest vcs1: SUCCESS (0.002s)
[389.325223] Starting dynamic subtest: vecs0
[389.326313] Dynamic subtest vecs0: SUCCESS (0.002s)
[389.327478] Subtest resubmit-all: SUCCESS (0.039s)
[389.653464] [073/155] (641s left) kms_cursor_crc (cursor-offscreen-128x42)
[391.340195] Starting subtest: cursor-offscreen-128x42
[391.346366] Starting dynamic subtest: pipe-A-HDMI-A-3
[393.839232] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.492s)
[393.876535] Starting dynamic subtest: pipe-D-HDMI-A-3
[396.275958] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.410s)
[396.276887] Subtest cursor-offscreen-128x42: SUCCESS (4.936s)
[396.682276] [074/155] (634s left) perf_pmu (idle-no-semaphores)
[396.734209] Starting subtest: idle-no-semaphores
[396.735129] Starting dynamic subtest: rcs0
[397.297442] Dynamic subtest rcs0: SUCCESS (0.560s)
[397.307990] Starting dynamic subtest: bcs0
[397.814530] Dynamic subtest bcs0: SUCCESS (0.513s)
[397.825133] Starting dynamic subtest: vcs0
[398.329517] Dynamic subtest vcs0: SUCCESS (0.511s)
[398.340158] Starting dynamic subtest: vcs1
[398.848543] Dynamic subtest vcs1: SUCCESS (0.515s)
[398.859230] Starting dynamic subtest: vecs0
[399.366558] Dynamic subtest vecs0: SUCCESS (0.514s)
[399.367451] Subtest idle-no-semaphores: SUCCESS (2.632s)
[399.524252] [075/155] (631s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[401.020675] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[401.022291] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[401.201450] [076/155] (630s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[402.692923] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[402.694933] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[402.816982] [077/155] (628s left) kms_chamelium_hpd (dp-hpd-storm)
[404.362256] Subtest dp-hpd-storm: SKIP (0.000s)
[404.498782] [078/155] (626s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[405.990883] Starting subtest: 2x-long-flip-vs-cursor-legacy
[405.994210] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.002s)
[406.114870] [079/155] (625s left) kms_properties (colorop-properties-legacy)
[407.618488] Starting subtest: colorop-properties-legacy
[407.620637] Starting dynamic subtest: pipe-A-HDMI-A-3
[407.744668] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.125s)
[407.761368] Starting dynamic subtest: pipe-B-HDMI-A-3
[407.908925] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.161s)
[407.921479] Starting dynamic subtest: pipe-C-HDMI-A-3
[408.044099] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.133s)
[408.056517] Starting dynamic subtest: pipe-D-HDMI-A-3
[408.175955] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.130s)
[408.177019] Subtest colorop-properties-legacy: SUCCESS (0.557s)
[408.385316] [080/155] (623s left) gem_mmap_offset (partial-remap)
[408.430762] Starting subtest: partial-remap
[408.431804] Starting dynamic subtest: lmem0
[408.436696] Dynamic subtest lmem0: SUCCESS (0.005s)
[408.448181] Starting dynamic subtest: smem0
[408.450668] Dynamic subtest smem0: SUCCESS (0.005s)
[408.451986] Subtest partial-remap: SUCCESS (0.012s)
[408.596639] [081/155] (623s left) gem_exec_fence (concurrent)
[408.771720] Starting subtest: concurrent
[408.773653] Subtest concurrent: SKIP (0.000s)
[409.472713] [FACT gem_exec_fence (concurrent)] new: kernel.kmod_is_loaded.vgem: true
[409.474954] [082/155] (622s left) sysfs_timeslice_duration (invalid)
[409.525398] Starting subtest: invalid
[409.526293] Starting dynamic subtest: vecs0
[409.527209] Dynamic subtest vecs0: SUCCESS (0.000s)
[409.539563] Starting dynamic subtest: vcs0
[409.540475] Dynamic subtest vcs0: SUCCESS (0.000s)
[409.551216] Starting dynamic subtest: bcs0
[409.552239] Dynamic subtest bcs0: SUCCESS (0.000s)
[409.562630] Starting dynamic subtest: rcs0
[409.563785] Dynamic subtest rcs0: SUCCESS (0.000s)
[409.574194] Starting dynamic subtest: vcs1
[409.575359] Dynamic subtest vcs1: SUCCESS (0.000s)
[409.576469] Subtest invalid: SUCCESS (0.009s)
[409.658124] [083/155] (622s left) gem_exec_fence (nb-await)
[409.878759] Starting subtest: nb-await
[409.880197] Starting dynamic subtest: rcs0
[409.971425] Dynamic subtest rcs0: SUCCESS (0.093s)
[409.988511] Starting dynamic subtest: bcs0
[410.040291] Dynamic subtest bcs0: SUCCESS (0.067s)
[410.085262] Starting dynamic subtest: vcs0
[410.137506] Dynamic subtest vcs0: SUCCESS (0.093s)
[410.170410] Starting dynamic subtest: vcs1
[410.220210] Dynamic subtest vcs1: SUCCESS (0.080s)
[410.258802] Starting dynamic subtest: vecs0
[410.308466] Dynamic subtest vecs0: SUCCESS (0.085s)
[410.310162] Subtest nb-await: SUCCESS (0.433s)
[410.901987] [084/155] (621s left) syncobj_wait (wait-any-complex)
[410.947977] Starting subtest: wait-any-complex
[411.010546] Subtest wait-any-complex: SUCCESS (0.062s)
[411.128407] [085/155] (620s left) kms_vblank (query-idle)
[412.620181] Starting subtest: query-idle
[412.621083] Starting dynamic subtest: pipe-A-HDMI-A-3
[414.948430] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.327s)
[414.962195] Starting dynamic subtest: pipe-D-HDMI-A-3
[417.145902] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.194s)
[417.146899] Subtest query-idle: SUCCESS (4.527s)
[417.350156] [086/155] (614s left) kms_busy (extended-modeset-hang-newfb)
[418.847477] Starting subtest: extended-modeset-hang-newfb
[418.849596] Starting dynamic subtest: pipe-A
[434.467394] Dynamic subtest pipe-A: SUCCESS (15.617s)
[434.481686] Starting dynamic subtest: pipe-D
[450.046732] Dynamic subtest pipe-D: SUCCESS (15.574s)
[450.047600] Subtest extended-modeset-hang-newfb: SUCCESS (31.199s)
[450.290119] [087/155] (581s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[451.787058] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[451.788764] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[451.944370] [088/155] (580s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[453.447078] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[453.448937] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[453.608844] [089/155] (578s left) kms_vblank (ts-continuation-dpms-rpm)
[455.103137] Starting subtest: ts-continuation-dpms-rpm
[455.103969] Starting dynamic subtest: pipe-A-HDMI-A-3
[457.523041] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.418s)
[457.537331] Starting dynamic subtest: pipe-D-HDMI-A-3
[459.601713] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.075s)
[459.602557] Subtest ts-continuation-dpms-rpm: SUCCESS (4.500s)
[459.810466] [090/155] (572s left) kms_addfb_basic (addfb25-4-tiled)
[461.303132] Starting subtest: addfb25-4-tiled
[461.303961] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[461.496061] [091/155] (571s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[463.018846] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[463.020657] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[463.172382] [092/155] (569s left) i915_query (query-regions-unallocated)
[463.221209] Starting subtest: query-regions-unallocated
[463.698264] Subtest query-regions-unallocated: SUCCESS (0.478s)
[463.837726] [093/155] (568s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[463.884258] Starting subtest: multi-wait-all-available-submitted-signaled
[463.885210] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[464.022213] [094/155] (568s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-render)
[465.518654] Starting subtest: fbchdr-rgb101010-draw-render
[465.520270] Subtest fbchdr-rgb101010-draw-render: SKIP (0.000s)
[465.711356] [095/155] (567s left) dmabuf_sync_file (export-multiwait)
[465.772145] Starting subtest: export-multiwait
[465.773276] Subtest export-multiwait: SUCCESS (0.001s)
[465.893677] [096/155] (567s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[467.403213] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[468.671766] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.268s)
[468.962779] [097/155] (564s left) kms_atomic (plane-primary-legacy)
[470.456259] Starting subtest: plane-primary-legacy
[470.457259] Starting dynamic subtest: pipe-A-HDMI-A-3
[471.028115] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.571s)
[471.028982] Subtest plane-primary-legacy: SUCCESS (0.573s)
[471.229151] [098/155] (562s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[472.721424] Starting subtest: read-crc-frame-sequence
[472.723921] Starting dynamic subtest: pipe-A-HDMI-A-3
[473.419790] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.696s)
[473.432484] Starting dynamic subtest: pipe-B-HDMI-A-3
[473.966351] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.545s)
[473.980838] Starting dynamic subtest: pipe-C-HDMI-A-3
[474.532557] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.563s)
[474.545347] Starting dynamic subtest: pipe-D-HDMI-A-3
[475.091048] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.555s)
[475.091965] Subtest read-crc-frame-sequence: SUCCESS (2.370s)
[475.294185] [099/155] (558s left) kms_pm_rpm (dpms-non-lpsp)
[479.024044] Starting subtest: dpms-non-lpsp
[479.141607] Subtest dpms-non-lpsp: SUCCESS (0.118s)
[480.041381] [100/155] (553s left) kms_chamelium_audio (dp-audio)
[481.584286] Subtest dp-audio: SKIP (0.000s)
[481.728338] [101/155] (551s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[481.775684] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[481.776624] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[481.895497] [102/155] (551s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[483.391420] Starting subtest: fbc-rgb565-draw-mmap-wc
[483.393062] Subtest fbc-rgb565-draw-mmap-wc: SKIP (0.000s)
[483.572810] [103/155] (550s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[485.095953] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[485.098322] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[485.266343] [104/155] (548s left) gem_wait (invalid-flags)
[485.318755] Starting subtest: invalid-flags
[485.319831] Subtest invalid-flags: SUCCESS (0.000s)
[485.608364] [105/155] (548s left) gem_pxp (hw-rejects-pxp-context)
[488.181652] Starting subtest: hw-rejects-pxp-context
[488.182912] Subtest hw-rejects-pxp-context: SUCCESS (0.002s)
[488.302906] [106/155] (545s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[489.799838] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[489.801622] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[489.959802] [107/155] (544s left) kms_content_protection (atomic-dpms)
[491.512894] Starting subtest: atomic-dpms
[491.516969] Subtest atomic-dpms: SKIP (0.002s)
[491.740066] [108/155] (542s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-blt)
[493.237269] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-blt
[493.238923] Subtest fbchdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[493.427846] [109/155] (540s left) kms_prop_blob (blob-prop-lifetime)
[493.474891] Starting subtest: blob-prop-lifetime
[493.475777] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[493.596009] [110/155] (540s left) gem_exec_schedule (u-semaphore-user)
[493.660347] Starting subtest: u-semaphore-user
[493.689872] Subtest u-semaphore-user: SUCCESS (0.031s)
[494.065944] [111/155] (540s left) gem_exec_balancer (indices)
[494.123862] Starting subtest: indices
[496.185403] Subtest indices: SUCCESS (2.061s)
[496.609328] [112/155] (537s left) gem_exec_params (rel-constants-invalid-ring)
[496.660400] Starting subtest: rel-constants-invalid-ring
[496.661311] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[496.797241] [113/155] (537s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-msflip-blt)
[498.296129] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-msflip-blt
[498.298066] Subtest fbcpsrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[498.471283] [114/155] (536s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[498.524396] Starting subtest: legacy-engines-hostile-preempt
[498.525228] Starting dynamic subtest: render
[498.585150] Dynamic subtest render: SUCCESS (0.060s)
[498.599139] Starting dynamic subtest: bsd1
[498.633171] Dynamic subtest bsd1: SUCCESS (0.046s)
[498.651355] Starting dynamic subtest: bsd2
[498.681398] Dynamic subtest bsd2: SUCCESS (0.046s)
[498.710726] Starting dynamic subtest: blt
[498.744438] Dynamic subtest blt: SUCCESS (0.060s)
[498.776417] Starting dynamic subtest: vebox
[498.807287] Dynamic subtest vebox: SUCCESS (0.059s)
[498.810605] Subtest legacy-engines-hostile-preempt: SUCCESS (0.284s)
[499.020774] [115/155] (535s left) syncobj_timeline (signal-point-0)
[499.067246] Starting subtest: signal-point-0
[499.068174] Subtest signal-point-0: SUCCESS (0.000s)
[499.175352] [116/155] (535s left) gem_userptr_blits (relocations)
[499.228786] Starting subtest: relocations
[499.230447] Subtest relocations: SKIP (0.001s)
[499.447078] [117/155] (535s left) kms_plane_multiple (tiling-y)
[500.938473] Starting subtest: tiling-y
[500.939502] Starting dynamic subtest: pipe-A-HDMI-A-3
[501.961977] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (1.021s)
[501.973373] Starting dynamic subtest: pipe-B-HDMI-A-3
[502.864855] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.902s)
[502.878222] Starting dynamic subtest: pipe-C-HDMI-A-3
[503.734050] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.866s)
[503.747090] Starting dynamic subtest: pipe-D-HDMI-A-3
[504.640930] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.905s)
[504.641914] Subtest tiling-y: SUCCESS (3.703s)
[504.854907] [118/155] (530s left) gem_exec_await (wide-all)
[504.996819] Starting subtest: wide-all
[527.284165] Subtest wide-all: SUCCESS (22.287s)
[527.537017] [119/155] (507s left) gem_exec_params (invalid-fence-in-submit)
[527.646368] Starting subtest: invalid-fence-in-submit
[527.649200] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[527.830130] [120/155] (507s left) kms_flip (2x-wf_vblank-ts-check)
[529.329257] Starting subtest: 2x-wf_vblank-ts-check
[529.348114] Subtest 2x-wf_vblank-ts-check: SKIP (0.019s)
[529.558987] [121/155] (505s left) api_intel_bb (crc32)
[529.605939] Starting subtest: crc32
[529.607921] Subtest crc32: SKIP (0.000s)
[529.770483] [122/155] (505s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[531.286051] Starting subtest: yf-tiled-addfb-size-overflow
[531.287824] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[531.483822] [123/155] (504s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-plflip-blt)
[532.980897] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-plflip-blt
[532.983280] Subtest fbcpsrhdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[533.192710] [124/155] (502s left) gem_exec_whisper (basic-fds-forked-all)
[533.256237] Starting subtest: basic-fds-forked-all
[546.824996] Subtest basic-fds-forked-all: SUCCESS (13.564s)
[547.076173] [125/155] (488s left) syncobj_wait (signal)
[547.130479] Starting subtest: signal
[547.131397] Subtest signal: SUCCESS (0.000s)
[547.246608] [126/155] (488s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[548.738472] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[548.774162] Starting dynamic subtest: pipe-A-plane-0
[549.324162] Dynamic subtest pipe-A-plane-0: SUCCESS (0.549s)
[549.364349] Starting dynamic subtest: pipe-A-plane-3
[549.640181] Dynamic subtest pipe-A-plane-3: SUCCESS (0.312s)
[549.679074] Starting dynamic subtest: pipe-A-plane-5
[549.990256] Dynamic subtest pipe-A-plane-5: SUCCESS (0.347s)
[550.209526] Starting dynamic subtest: pipe-B-plane-0
[550.564596] Dynamic subtest pipe-B-plane-0: SUCCESS (0.366s)
[550.602105] Starting dynamic subtest: pipe-B-plane-3
[550.914775] Dynamic subtest pipe-B-plane-3: SUCCESS (0.347s)
[550.955056] Starting dynamic subtest: pipe-B-plane-5
[551.231603] Dynamic subtest pipe-B-plane-5: SUCCESS (0.313s)
[551.338165] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.600s)
[551.559460] [127/155] (484s left) kms_psr (psr-sprite-mmap-gtt)
[553.054955] Subtest psr-sprite-mmap-gtt: SKIP (0.000s)
[553.141800] [128/155] (482s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[554.633368] Starting subtest: bad-rotation-90-y-tiled-ccs
[554.634241] Starting dynamic subtest: pipe-A-HDMI-A-3
[554.642834] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[554.655295] Starting dynamic subtest: pipe-B-HDMI-A-3
[554.664198] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[554.676428] Starting dynamic subtest: pipe-C-HDMI-A-3
[554.685233] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[554.697118] Starting dynamic subtest: pipe-D-HDMI-A-3
[554.706131] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[554.707925] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.010s)
[554.948902] [129/155] (481s left) vgem_basic (setversion)
[555.012321] Starting subtest: setversion
[555.014230] Subtest setversion: SUCCESS (0.000s)
[555.116474] [130/155] (481s left) gem_exec_create (madvise)
[555.173269] Starting subtest: madvise
[555.174313] Starting dynamic subtest: smem
[575.306885] Dynamic subtest smem: SUCCESS (20.133s)
[575.321282] Starting dynamic subtest: lmem0
[595.534212] Dynamic subtest lmem0: SUCCESS (20.226s)
[595.535168] Subtest madvise: SUCCESS (40.361s)
[596.627821] [131/155] (439s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-gtt)
[598.124684] Starting subtest: hdr-rgb101010-draw-mmap-gtt
[598.126286] Subtest hdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[598.335776] [132/155] (438s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[599.829567] Starting subtest: plane-lut1d-pre-ctm3x4
[600.033459] Starting dynamic subtest: pipe-A-plane-0
[600.295242] Dynamic subtest pipe-A-plane-0: SUCCESS (0.264s)
[600.336926] Starting dynamic subtest: pipe-A-plane-1
[600.493304] Dynamic subtest pipe-A-plane-1: SUCCESS (0.192s)
[600.507276] Starting dynamic subtest: pipe-A-plane-2
[600.664292] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[600.998284] Starting dynamic subtest: pipe-B-plane-0
[601.158569] Dynamic subtest pipe-B-plane-0: SUCCESS (0.196s)
[601.193774] Starting dynamic subtest: pipe-B-plane-1
[601.352542] Dynamic subtest pipe-B-plane-1: SUCCESS (0.192s)
[601.366354] Starting dynamic subtest: pipe-B-plane-2
[601.538048] Dynamic subtest pipe-B-plane-2: SUCCESS (0.182s)
[601.850167] Starting dynamic subtest: pipe-C-plane-0
[602.032814] Dynamic subtest pipe-C-plane-0: SUCCESS (0.199s)
[602.047789] Starting dynamic subtest: pipe-C-plane-1
[602.218263] Dynamic subtest pipe-C-plane-1: SUCCESS (0.183s)
[602.257913] Starting dynamic subtest: pipe-C-plane-2
[602.435111] Dynamic subtest pipe-C-plane-2: SUCCESS (0.209s)
[602.777485] Starting dynamic subtest: pipe-D-plane-0
[602.958211] Dynamic subtest pipe-D-plane-0: SUCCESS (0.199s)
[602.983588] Starting dynamic subtest: pipe-D-plane-1
[603.157035] Dynamic subtest pipe-D-plane-1: SUCCESS (0.195s)
[603.175756] Starting dynamic subtest: pipe-D-plane-2
[603.356767] Dynamic subtest pipe-D-plane-2: SUCCESS (0.198s)
[603.380762] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (3.551s)
[603.595765] [133/155] (432s left) kms_pm_backlight (fade)
[605.089986] Subtest fade: SKIP (0.000s)
[605.177216] [134/155] (431s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[606.671552] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[606.759483] [135/155] (429s left) i915_pciid
[606.924579] [136/155] (429s left) perf_pmu (all-busy-idle-check-all)
[606.975303] Starting subtest: all-busy-idle-check-all
[607.655392] Subtest all-busy-idle-check-all: SUCCESS (0.680s)
[607.814488] [137/155] (428s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[609.307862] Starting subtest: 2x-cursor-vs-flip-legacy
[609.310238] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s)
[609.467165] [138/155] (427s left) kms_joiner (basic-force-big-joiner)
[610.982381] Starting subtest: basic-force-big-joiner
[610.984107] Subtest basic-force-big-joiner: SKIP (0.000s)
[611.125768] [139/155] (425s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[612.626719] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[612.628326] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[612.820929] [140/155] (424s left) kms_psr (fbc-psr2-suspend)
[614.313604] Subtest fbc-psr2-suspend: SKIP (0.000s)
[614.393663] [141/155] (422s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-onoff)
[615.890296] Starting subtest: hdr-1p-primscrn-cur-indfb-onoff
[615.892320] Subtest hdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[616.069844] [142/155] (421s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt)
[617.571173] Starting subtest: fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt
[617.573204] Subtest fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[617.737938] [143/155] (419s left) gem_fence_thrash (bo-write-verify-x)
[617.784335] Starting subtest: bo-write-verify-x
[617.787588] Subtest bo-write-verify-x: SKIP (0.003s)
[617.881478] [144/155] (419s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[619.373980] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[619.375964] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[619.488172] [145/155] (418s left) gem_ppgtt (shrink-vs-evict-pinned)
[619.546219] Starting subtest: shrink-vs-evict-pinned
[624.930831] Subtest shrink-vs-evict-pinned: SUCCESS (5.384s)
[625.046705] [146/155] (412s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[626.540507] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[626.541472] Starting dynamic subtest: pipe-A-HDMI-A-3
[626.568965] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.003s)
[626.581492] Starting dynamic subtest: pipe-B-HDMI-A-3
[626.603335] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.003s)
[626.615424] Starting dynamic subtest: pipe-C-HDMI-A-3
[626.637195] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.003s)
[626.649504] Starting dynamic subtest: pipe-D-HDMI-A-3
[626.675910] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.003s)
[626.677957] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.021s)
[626.867706] [147/155] (410s left) gen9_exec_parse (secure-batches)
[626.921059] Subtest secure-batches: SKIP (0.000s)
[627.008410] [148/155] (410s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[628.506878] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[628.508642] Subtest psr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[628.711808] [149/155] (409s left) gem_exec_reloc (basic-gtt-noreloc)
[628.771284] Subtest basic-gtt-noreloc: SKIP (0.000s)
[628.882276] [150/155] (409s left) kms_frontbuffer_tracking (hdr-1p-rte)
[630.379148] Starting subtest: hdr-1p-rte
[630.381084] Subtest hdr-1p-rte: SKIP (0.000s)
[630.582559] [151/155] (407s left) gem_exec_schedule (preempt-hang)
[630.765818] Starting subtest: preempt-hang
[630.766859] Starting dynamic subtest: rcs0
[631.038675] Dynamic subtest rcs0: SUCCESS (0.274s)
[631.051214] Starting dynamic subtest: bcs0
[631.340293] Dynamic subtest bcs0: SUCCESS (0.300s)
[631.352730] Starting dynamic subtest: vcs0
[631.612293] Dynamic subtest vcs0: SUCCESS (0.268s)
[631.624476] Starting dynamic subtest: vcs1
[631.888272] Dynamic subtest vcs1: SUCCESS (0.277s)
[631.900776] Starting dynamic subtest: vecs0
[632.170732] Dynamic subtest vecs0: SUCCESS (0.281s)
[632.171642] Subtest preempt-hang: SUCCESS (1.408s)
[632.458708] [152/155] (405s left) gem_ctx_shared (q-smoketest-all)
[632.519504] Starting subtest: Q-smoketest-all
[664.824111] Subtest Q-smoketest-all: SUCCESS (32.295s)
[665.177787] [153/155] (373s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[665.226702] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[665.334803] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.105s)
[665.466748] [154/155] (372s left) kms_cursor_edge_walk (64x64-top-edge)
[666.959539] Starting subtest: 64x64-top-edge
[666.960784] Starting dynamic subtest: pipe-A-HDMI-A-3
[670.337614] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.377s)
[670.351761] Starting dynamic subtest: pipe-D-HDMI-A-3
[673.598407] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.257s)
[673.599291] Subtest 64x64-top-edge: SUCCESS (6.639s)
[673.809959] [155/155] (364s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-pwrite)
[675.309925] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-pwrite
[675.312197] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[675.505315] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_frames
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
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_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: kms_plane_scaling
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_create
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_ctx_param
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: gem_userptr_blits
results: parsing output: 21/ for test: i915_query
results: parsing output: 22/ for test: gem_render_copy
results: parsing output: 23/ for test: gem_exec_reloc
results: parsing output: 24/ for test: i915_pm_rpm
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: syncobj_wait
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_exec_parallel
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: perf_pmu
results: parsing output: 35/ for test: kms_dsc
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_wait
results: parsing output: 40/ for test: gem_close_race
results: parsing output: 41/ for test: kms_lease
results: parsing output: 42/ for test: prime_busy
results: parsing output: 43/ for test: kms_getfb
results: parsing output: 44/ for test: gem_close
results: parsing output: 45/ for test: gem_ccs
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: gem_userptr_blits
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: core_getclient
results: parsing output: 53/ for test: gem_mmap_gtt
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_rotation_crc
results: parsing output: 57/ for test: gem_mmap_gtt
results: parsing output: 58/ for test: gem_huc_copy
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: i915_drm_fdinfo
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_mmap_gtt
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: gem_ctx_persistence
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_spin_batch
results: parsing output: 72/ for test: kms_cursor_crc
results: parsing output: 73/ for test: perf_pmu
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: kms_chamelium_hpd
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: kms_properties
results: parsing output: 79/ for test: gem_mmap_offset
results: parsing output: 80/ for test: gem_exec_fence
results: parsing output: 81/ for test: sysfs_timeslice_duration
results: parsing output: 82/ for test: gem_exec_fence
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: kms_busy
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_vblank
results: parsing output: 89/ for test: kms_addfb_basic
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: i915_query
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: dmabuf_sync_file
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_atomic
results: parsing output: 97/ for test: kms_pipe_crc_basic
results: parsing output: 98/ for test: kms_pm_rpm
results: parsing output: 99/ for test: kms_chamelium_audio
results: parsing output: 100/ for test: syncobj_wait
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_wait
results: parsing output: 104/ for test: gem_pxp
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_content_protection
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_prop_blob
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: gem_exec_balancer
results: parsing output: 111/ for test: gem_exec_params
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_ctx_persistence
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: gem_userptr_blits
results: parsing output: 116/ for test: kms_plane_multiple
results: parsing output: 117/ for test: gem_exec_await
results: parsing output: 118/ for test: gem_exec_params
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: api_intel_bb
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_exec_whisper
results: parsing output: 124/ for test: syncobj_wait
results: parsing output: 125/ for test: kms_plane
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: vgem_basic
results: parsing output: 129/ for test: gem_exec_create
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_color_pipeline
results: parsing output: 132/ for test: kms_pm_backlight
results: parsing output: 133/ for test: kms_psr2_sf
results: parsing output: 134/ for test: i915_pciid
results: parsing output: 135/ for test: perf_pmu
results: parsing output: 136/ for test: kms_cursor_legacy
results: parsing output: 137/ for test: kms_joiner
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_psr
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: gem_fence_thrash
results: parsing output: 143/ for test: kms_flip_scaled_crc
results: parsing output: 144/ for test: gem_ppgtt
results: parsing output: 145/ for test: kms_ccs
results: parsing output: 146/ for test: gen9_exec_parse
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: gem_exec_reloc
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: gem_exec_schedule
results: parsing output: 151/ for test: gem_ctx_shared
results: parsing output: 152/ for test: syncobj_timeline
results: parsing output: 153/ for test: kms_cursor_edge_walk
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.