[72.323777] Initializing watchdogs
[72.323859]   /dev/watchdog0
[72.354962] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[72.370857] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[72.376352] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[72.380008] [001/156] (960s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[73.936241] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[74.070607] [002/156] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[75.569099] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[75.572114] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[75.746190] [003/156] (957s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[77.243462] Starting subtest: short-busy-flip-before-cursor-toggle
[77.246544] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[77.349821] [004/156] (955s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[78.853343] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[78.856184] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[79.011180] [005/156] (954s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[80.520034] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[80.539362] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.018s)
[80.651352] [006/156] (952s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[82.158257] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[82.160936] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[82.308698] [007/156] (951s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[83.822922] Starting subtest: fbc-farfromfence-mmap-gtt
[83.826580] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[83.999163] [008/156] (949s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[85.502304] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[85.504854] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[85.674499] [009/156] (947s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[87.180988] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[87.184876] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[87.375349] [010/156] (946s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[88.881718] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[88.885738] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[89.081647] [011/156] (944s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[90.585645] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[90.588994] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[90.716476] [012/156] (943s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[92.249828] Starting subtest: x-tiled-16bpp-rotate-90
[92.358215] Subtest x-tiled-16bpp-rotate-90: SKIP (0.108s)
[92.548617] [013/156] (941s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[94.042386] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[94.044247] Starting dynamic subtest: pipe-A
[94.891287] Dynamic subtest pipe-A: SUCCESS (0.851s)
[94.900984] Starting dynamic subtest: pipe-B
[95.665393] Dynamic subtest pipe-B: SUCCESS (0.774s)
[95.675996] Starting dynamic subtest: pipe-C
[96.439312] Dynamic subtest pipe-C: SUCCESS (0.774s)
[96.449549] Starting dynamic subtest: pipe-D
[97.214284] Dynamic subtest pipe-D: SUCCESS (0.774s)
[97.215825] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (3.174s)
[97.415240] [014/156] (936s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[98.949215] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[98.950746] Starting dynamic subtest: pipe-A-HDMI-A-4
[98.965602] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[98.974823] Starting dynamic subtest: pipe-B-HDMI-A-4
[98.992819] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[99.001533] Starting dynamic subtest: pipe-C-HDMI-A-4
[99.017060] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[99.025790] Starting dynamic subtest: pipe-D-HDMI-A-4
[99.042839] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[99.046832] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.008s)
[99.254117] [015/156] (934s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[100.754620] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-wc
[100.757161] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[100.919803] [016/156] (933s left) gem_create (create-ext-set-pat)
[101.106781] Starting subtest: create-ext-set-pat
[101.111939] Subtest create-ext-set-pat: SKIP (0.000s)
[101.280593] [017/156] (933s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[101.327815] Starting subtest: etime-single-wait-for-submit-unsubmitted
[101.439258] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[101.600612] [018/156] (932s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-cpu)
[103.100624] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-cpu
[103.103491] Subtest fbcpsrhdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[103.274571] [019/156] (931s left) gem_ctx_param (set-priority-invalid-size)
[103.326054] Starting subtest: set-priority-invalid-size
[103.327602] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[103.434926] [020/156] (931s left) kms_psr (psr2-primary-render)
[104.929639] Subtest psr2-primary-render: SKIP (0.000s)
[105.005575] [021/156] (929s left) gem_userptr_blits (create-destroy-sync)
[105.073638] Starting subtest: create-destroy-sync
[110.108486] Subtest create-destroy-sync: SUCCESS (5.032s)
[110.269390] [022/156] (924s left) i915_query (query-garbage)
[110.317231] Starting subtest: query-garbage
[110.318951] Subtest query-garbage: SUCCESS (0.000s)
[110.438460] [023/156] (924s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[110.496247] Starting subtest: y-tiled-to-vebox-x-tiled
[110.497804] Starting dynamic subtest: smem
[110.585628] Dynamic subtest smem: SUCCESS (0.091s)
[110.594991] Starting dynamic subtest: lmem0
[111.342047] Dynamic subtest lmem0: SUCCESS (0.753s)
[111.343960] Subtest y-tiled-to-vebox-x-tiled: SUCCESS (0.844s)
[111.599461] [024/156] (923s left) gem_exec_reloc (basic-gtt-wc)
[111.655884] Subtest basic-gtt-wc: SKIP (0.000s)
[111.771738] [025/156] (923s left) i915_pm_rpm (gem-pread)
[116.045735] Starting subtest: gem-pread
[117.326482] Subtest gem-pread: SUCCESS (1.281s)
[118.178440] [026/156] (916s left) kms_psr (psr2-basic)
[119.686693] Subtest psr2-basic: SKIP (0.000s)
[119.765323] [027/156] (915s left) gem_tiled_partial_pwrite_pread (reads)
[119.821932] Subtest reads: SKIP (0.000s)
[119.901292] [028/156] (915s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[119.951618] Starting subtest: single-wait-for-submit-available-submitted
[119.953386] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[120.055188] [029/156] (915s left) syncobj_wait (multi-wait-submitted)
[120.105160] Starting subtest: multi-wait-submitted
[120.215550] Subtest multi-wait-submitted: SUCCESS (0.106s)
[120.360451] [030/156] (914s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[121.859709] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[121.862311] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[122.027296] [031/156] (913s left) gem_exec_parallel (basic)
[122.090249] Starting subtest: basic
[122.091670] Starting dynamic subtest: rcs0
[123.669612] Dynamic subtest rcs0: SUCCESS (1.579s)
[123.682813] Starting dynamic subtest: bcs0
[125.220513] Dynamic subtest bcs0: SUCCESS (1.550s)
[125.229812] Starting dynamic subtest: vcs0
[126.742550] Dynamic subtest vcs0: SUCCESS (1.521s)
[126.752233] Starting dynamic subtest: vcs1
[128.262517] Dynamic subtest vcs1: SUCCESS (1.519s)
[128.272240] Starting dynamic subtest: vecs0
[129.765565] Dynamic subtest vecs0: SUCCESS (1.502s)
[129.767196] Subtest basic: SUCCESS (7.675s)
[130.086079] [032/156] (905s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[131.585153] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[131.588054] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[131.731624] [033/156] (903s left) syncobj_wait (single-wait-for-submit-submitted)
[131.797693] Starting subtest: single-wait-for-submit-submitted
[131.902415] Subtest single-wait-for-submit-submitted: SUCCESS (0.103s)
[132.113525] [034/156] (903s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[133.611960] Starting subtest: fbcpsr-rgb565-draw-blt
[133.614814] Subtest fbcpsr-rgb565-draw-blt: SKIP (0.000s)
[133.776976] [035/156] (902s left) perf_pmu (busy-accuracy-98)
[133.838111] Starting subtest: busy-accuracy-98
[133.839594] Starting dynamic subtest: rcs0
[136.886306] Dynamic subtest rcs0: SUCCESS (3.048s)
[136.896991] Starting dynamic subtest: bcs0
[139.956528] Dynamic subtest bcs0: SUCCESS (3.067s)
[139.966891] Starting dynamic subtest: vcs0
[143.004598] Dynamic subtest vcs0: SUCCESS (3.048s)
[143.015326] Starting dynamic subtest: vcs1
[146.052940] Dynamic subtest vcs1: SUCCESS (3.048s)
[146.063399] Starting dynamic subtest: vecs0
[149.098831] Dynamic subtest vecs0: SUCCESS (3.046s)
[149.100588] Subtest busy-accuracy-98: SUCCESS (15.261s)
[149.242194] [036/156] (886s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[150.734655] Starting subtest: dsc-fractional-bpp-with-bpc
[150.758527] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[150.842083] [037/156] (885s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[152.341554] Starting subtest: cursorB-vs-flipB-toggle
[152.344555] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[152.551787] [038/156] (883s left) syncobj_wait (wait-all-delayed-signal)
[152.604624] Starting subtest: wait-all-delayed-signal
[152.711068] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[152.920469] [039/156] (883s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[154.419926] Starting subtest: psr-rgb565-draw-mmap-wc
[154.422883] Subtest psr-rgb565-draw-mmap-wc: SKIP (0.000s)
[154.614531] [040/156] (881s left) gem_wait (busy)
[154.680198] Starting subtest: busy
[154.681782] Starting dynamic subtest: all-engines
[155.250898] Dynamic subtest all-engines: SUCCESS (0.571s)
[155.261476] Starting dynamic subtest: rcs0
[155.793530] Dynamic subtest rcs0: SUCCESS (0.542s)
[155.804035] Starting dynamic subtest: bcs0
[156.333551] Dynamic subtest bcs0: SUCCESS (0.540s)
[156.344068] Starting dynamic subtest: vcs0
[156.872488] Dynamic subtest vcs0: SUCCESS (0.539s)
[156.882859] Starting dynamic subtest: vcs1
[157.411552] Dynamic subtest vcs1: SUCCESS (0.539s)
[157.422226] Starting dynamic subtest: vecs0
[157.949740] Dynamic subtest vecs0: SUCCESS (0.538s)
[157.951402] Subtest busy: SUCCESS (3.270s)
[158.239851] [041/156] (878s left) gem_close_race (basic-threads)
[158.315206] Starting subtest: basic-threads
[159.569357] Subtest basic-threads: SUCCESS (1.254s)
[159.935102] [042/156] (876s left) kms_lease (possible-crtcs-filtering)
[161.425648] Starting subtest: possible-crtcs-filtering
[161.435507] Subtest possible-crtcs-filtering: SUCCESS (0.007s)
[161.544133] [043/156] (875s left) prime_busy (hang)
[161.606932] Starting subtest: hang
[161.608968] Starting dynamic subtest: rcs0
[187.446409] Dynamic subtest rcs0: SUCCESS (25.841s)
[187.456916] Starting dynamic subtest: bcs0
[194.591228] Dynamic subtest bcs0: SUCCESS (7.145s)
[194.604271] Starting dynamic subtest: vcs0
[201.568220] Dynamic subtest vcs0: SUCCESS (6.977s)
[201.579201] Starting dynamic subtest: vcs1
[208.545726] Dynamic subtest vcs1: SUCCESS (6.977s)
[208.556252] Starting dynamic subtest: vecs0
[215.584117] Dynamic subtest vecs0: SUCCESS (7.038s)
[215.585617] Subtest hang: SUCCESS (53.982s)
[215.746235] [044/156] (820s left) kms_getfb (getfb2-handle-zero)
[217.239192] Starting subtest: getfb2-handle-zero
[217.251156] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[217.435673] [045/156] (819s left) gem_close (basic)
[217.496112] Starting subtest: basic
[217.497641] Subtest basic: SUCCESS (0.000s)
[217.639330] [046/156] (819s left) gem_ccs (ctrl-surf-copy)
[217.693130] Starting subtest: ctrl-surf-copy
[217.698777] Subtest ctrl-surf-copy: SKIP (0.000s)
[217.809675] [047/156] (819s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[219.309187] Starting subtest: fbc-indfb-scaledprimary
[220.707069] Subtest fbc-indfb-scaledprimary: SUCCESS (1.400s)
[220.939544] [048/156] (816s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[222.430465] Starting subtest: crc-primary-suspend-y-tiled-ccs
[222.432124] Starting dynamic subtest: pipe-A-HDMI-A-4
[222.438574] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[222.449522] Starting dynamic subtest: pipe-B-HDMI-A-4
[222.456042] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[222.466894] Starting dynamic subtest: pipe-C-HDMI-A-4
[222.473403] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[222.483878] Starting dynamic subtest: pipe-D-HDMI-A-4
[222.490622] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[222.496506] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.006s)
[222.726236] [049/156] (814s left) gem_userptr_blits (readonly-pwrite-unsync)
[222.783906] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[222.971917] [050/156] (814s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-move)
[224.472037] Starting subtest: fbchdr-1p-primscrn-spr-indfb-move
[224.484936] Subtest fbchdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[224.648900] [051/156] (812s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[226.164566] Starting subtest: 4-tiled-64bpp-rotate-0
[226.167263] Subtest 4-tiled-64bpp-rotate-0: SKIP (0.000s)
[226.348419] [052/156] (811s left) kms_cursor_crc (cursor-random-512x512)
[228.115113] Starting subtest: cursor-random-512x512
[228.118042] Subtest cursor-random-512x512: SKIP (0.001s)
[228.363589] [053/156] (809s left) core_getclient (basic)
[228.412560] Starting subtest: basic
[228.414127] Subtest basic: SUCCESS (0.000s)
[228.515219] [054/156] (809s left) gem_mmap_gtt (fault-concurrent)
[228.565541] Subtest fault-concurrent: SKIP (0.000s)
[228.644975] [055/156] (808s left) kms_flip (flip-vs-absolute-wf_vblank)
[230.139153] Starting subtest: flip-vs-absolute-wf_vblank
[230.144327] Starting dynamic subtest: A-HDMI-A4
[238.190842] Dynamic subtest A-HDMI-A4: SUCCESS (8.046s)
[238.203434] Starting dynamic subtest: B-HDMI-A4
[246.171131] Dynamic subtest B-HDMI-A4: SUCCESS (7.979s)
[246.183040] Starting dynamic subtest: C-HDMI-A4
[254.158260] Dynamic subtest C-HDMI-A4: SUCCESS (7.986s)
[254.169964] Starting dynamic subtest: D-HDMI-A4
[262.144520] Dynamic subtest D-HDMI-A4: SUCCESS (7.985s)
[262.146208] Subtest flip-vs-absolute-wf_vblank: SUCCESS (32.009s)
[262.363479] [056/156] (775s left) kms_flip (flip-vs-panning-vs-hang)
[263.855374] Starting subtest: flip-vs-panning-vs-hang
[263.859648] Starting dynamic subtest: A-HDMI-A4
[315.482347] Dynamic subtest A-HDMI-A4: SUCCESS (51.625s)
[315.519709] Starting dynamic subtest: D-HDMI-A4
[366.462116] Dynamic subtest D-HDMI-A4: SUCCESS (50.976s)
[366.464044] Subtest flip-vs-panning-vs-hang: SUCCESS (102.611s)
[366.686676] [057/156] (671s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[368.177802] Starting subtest: primary-x-tiled-reflect-x-0
[378.879925] Subtest primary-x-tiled-reflect-x-0: SUCCESS (10.702s)
[379.127834] [058/156] (658s left) gem_mmap_gtt (fault-concurrent-y)
[379.181294] Subtest fault-concurrent-Y: SKIP (0.000s)
[379.258975] [059/156] (658s left) gem_huc_copy (huc-copy)
[379.329261] Starting subtest: huc-copy
[379.334746] Subtest huc-copy: SUCCESS (0.005s)
[379.513878] [060/156] (658s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[381.028905] Starting subtest: y-tiled-8bpp-rotate-90
[381.141305] Subtest y-tiled-8bpp-rotate-90: SKIP (0.111s)
[381.350348] [061/156] (656s left) kms_psr (pr-cursor-mmap-cpu)
[382.846049] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[382.924327] [062/156] (655s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-move)
[384.425305] Starting subtest: psrhdr-1p-primscrn-cur-indfb-move
[384.428211] Subtest psrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[384.570278] [063/156] (653s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-fullscreen)
[386.085881] Starting subtest: psrhdr-2p-primscrn-spr-indfb-fullscreen
[386.089475] Subtest psrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[386.266704] [064/156] (652s left) kms_psr (fbc-pr-cursor-plane-onoff)
[387.771293] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[387.840544] [065/156] (650s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[389.341122] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[389.344370] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[389.583073] [066/156] (649s left) i915_drm_fdinfo (basics)
[389.635333] Starting subtest: basics
[389.637251] Subtest basics: SUCCESS (0.000s)
[389.775845] [067/156] (648s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-msflip-blt)
[391.275972] Starting subtest: psrhdr-2p-scndscrn-shrfb-msflip-blt
[391.279880] Subtest psrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[391.473747] [068/156] (647s left) gem_mmap_gtt (basic-wc)
[391.525866] Subtest basic-wc: SKIP (0.000s)
[391.589469] [069/156] (647s left) kms_big_fb (linear-16bpp-rotate-0)
[393.100868] Starting subtest: linear-16bpp-rotate-0
[395.087371] Subtest linear-16bpp-rotate-0: SUCCESS (1.983s)
[395.351527] [070/156] (643s left) gem_ctx_persistence (engines-queued)
[395.416098] Starting subtest: engines-queued
[395.417535] Starting dynamic subtest: rcs0
[395.477664] Dynamic subtest rcs0: SUCCESS (0.061s)
[395.488541] Starting dynamic subtest: bcs0
[395.521663] Dynamic subtest bcs0: SUCCESS (0.043s)
[395.534680] Starting dynamic subtest: vcs0
[395.571797] Dynamic subtest vcs0: SUCCESS (0.049s)
[395.591330] Starting dynamic subtest: vcs1
[395.609967] Dynamic subtest vcs1: SUCCESS (0.037s)
[395.626382] Starting dynamic subtest: vecs0
[395.682801] Dynamic subtest vecs0: SUCCESS (0.072s)
[395.684678] Subtest engines-queued: SUCCESS (0.267s)
[395.847094] [071/156] (643s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-render)
[397.345767] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-render
[397.348529] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[397.533396] [072/156] (641s left) gem_spin_batch (resubmit-all)
[397.591512] Starting subtest: resubmit-all
[397.593034] Starting dynamic subtest: rcs0
[397.616391] Dynamic subtest rcs0: SUCCESS (0.025s)
[397.627656] Starting dynamic subtest: bcs0
[397.629129] Dynamic subtest bcs0: SUCCESS (0.002s)
[397.640107] Starting dynamic subtest: vcs0
[397.641899] Dynamic subtest vcs0: SUCCESS (0.002s)
[397.652274] Starting dynamic subtest: vcs1
[397.653921] Dynamic subtest vcs1: SUCCESS (0.002s)
[397.664248] Starting dynamic subtest: vecs0
[397.665917] Dynamic subtest vecs0: SUCCESS (0.002s)
[397.667683] Subtest resubmit-all: SUCCESS (0.037s)
[398.004867] [073/156] (641s left) kms_cursor_crc (cursor-offscreen-128x42)
[399.688101] Starting subtest: cursor-offscreen-128x42
[399.695946] Starting dynamic subtest: pipe-A-HDMI-A-4
[402.209151] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.511s)
[402.240909] Starting dynamic subtest: pipe-D-HDMI-A-4
[404.636514] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.405s)
[404.638049] Subtest cursor-offscreen-128x42: SUCCESS (4.949s)
[405.042398] [074/156] (634s left) perf_pmu (idle-no-semaphores)
[405.095869] Starting subtest: idle-no-semaphores
[405.097598] Starting dynamic subtest: rcs0
[405.658978] Dynamic subtest rcs0: SUCCESS (0.558s)
[405.670390] Starting dynamic subtest: bcs0
[406.174208] Dynamic subtest bcs0: SUCCESS (0.511s)
[406.185336] Starting dynamic subtest: vcs0
[406.697197] Dynamic subtest vcs0: SUCCESS (0.519s)
[406.708308] Starting dynamic subtest: vcs1
[407.215231] Dynamic subtest vcs1: SUCCESS (0.514s)
[407.226548] Starting dynamic subtest: vecs0
[407.733257] Dynamic subtest vecs0: SUCCESS (0.514s)
[407.735043] Subtest idle-no-semaphores: SUCCESS (2.636s)
[407.856019] [075/156] (631s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[409.355267] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[409.358140] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[409.513972] [076/156] (630s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[411.013090] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[411.016292] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[411.114957] [077/156] (628s left) kms_chamelium_hpd (dp-hpd-storm)
[412.658153] Subtest dp-hpd-storm: SKIP (0.000s)
[412.786722] [078/156] (626s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[414.279027] Starting subtest: 2x-long-flip-vs-cursor-legacy
[414.284926] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.002s)
[414.473954] [079/156] (625s left) kms_properties (colorop-properties-legacy)
[415.969732] Starting subtest: colorop-properties-legacy
[415.971530] Starting dynamic subtest: pipe-A-HDMI-A-4
[416.078806] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.110s)
[416.090211] Starting dynamic subtest: pipe-B-HDMI-A-4
[416.206741] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.127s)
[416.219796] Starting dynamic subtest: pipe-C-HDMI-A-4
[416.341512] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.131s)
[416.352473] Starting dynamic subtest: pipe-D-HDMI-A-4
[416.464845] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.123s)
[416.466503] Subtest colorop-properties-legacy: SUCCESS (0.498s)
[416.671479] [080/156] (623s left) gem_mmap_offset (partial-remap)
[416.719234] Starting subtest: partial-remap
[416.720576] Starting dynamic subtest: lmem0
[416.724919] Dynamic subtest lmem0: SUCCESS (0.005s)
[416.735906] Starting dynamic subtest: smem0
[416.738844] Dynamic subtest smem0: SUCCESS (0.005s)
[416.740461] Subtest partial-remap: SUCCESS (0.012s)
[416.883772] [081/156] (623s left) gem_exec_fence (concurrent)
[417.060081] Starting subtest: concurrent
[417.063455] Subtest concurrent: SKIP (0.000s)
[417.771007] [FACT gem_exec_fence (concurrent)] new: kernel.kmod_is_loaded.vgem: true
[417.774763] [082/156] (622s left) sysfs_timeslice_duration (invalid)
[417.825826] Starting subtest: invalid
[417.827367] Starting dynamic subtest: vecs0
[417.828886] Dynamic subtest vecs0: SUCCESS (0.000s)
[417.840301] Starting dynamic subtest: vcs0
[417.843989] Dynamic subtest vcs0: SUCCESS (0.001s)
[417.854915] Starting dynamic subtest: bcs0
[417.856461] Dynamic subtest bcs0: SUCCESS (0.000s)
[417.867650] Starting dynamic subtest: rcs0
[417.869284] Dynamic subtest rcs0: SUCCESS (0.000s)
[417.880247] Starting dynamic subtest: vcs1
[417.881949] Dynamic subtest vcs1: SUCCESS (0.000s)
[417.883822] Subtest invalid: SUCCESS (0.008s)
[417.961106] [083/156] (622s left) gem_exec_fence (nb-await)
[418.138376] Starting subtest: nb-await
[418.140035] Starting dynamic subtest: rcs0
[418.225290] Dynamic subtest rcs0: SUCCESS (0.086s)
[418.238717] Starting dynamic subtest: bcs0
[418.291335] Dynamic subtest bcs0: SUCCESS (0.065s)
[418.305903] Starting dynamic subtest: vcs0
[418.356806] Dynamic subtest vcs0: SUCCESS (0.064s)
[418.384066] Starting dynamic subtest: vcs1
[418.436577] Dynamic subtest vcs1: SUCCESS (0.077s)
[418.479277] Starting dynamic subtest: vecs0
[418.530133] Dynamic subtest vecs0: SUCCESS (0.090s)
[418.532305] Subtest nb-await: SUCCESS (0.393s)
[419.116354] [084/156] (621s left) syncobj_wait (wait-any-complex)
[419.167073] Starting subtest: wait-any-complex
[419.228457] Subtest wait-any-complex: SUCCESS (0.062s)
[419.440748] [085/156] (620s left) kms_vblank (query-idle)
[420.929635] Starting subtest: query-idle
[420.931198] Starting dynamic subtest: pipe-A-HDMI-A-4
[423.284617] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.353s)
[423.299296] Starting dynamic subtest: pipe-D-HDMI-A-4
[425.475171] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.187s)
[425.476636] Subtest query-idle: SUCCESS (4.546s)
[425.662466] [086/156] (614s left) kms_busy (extended-modeset-hang-newfb)
[427.160636] Starting subtest: extended-modeset-hang-newfb
[427.162137] Starting dynamic subtest: pipe-A
[442.727101] Dynamic subtest pipe-A: SUCCESS (15.563s)
[442.741169] Starting dynamic subtest: pipe-D
[458.276178] Dynamic subtest pipe-D: SUCCESS (15.545s)
[458.277900] Subtest extended-modeset-hang-newfb: SUCCESS (31.116s)
[458.487244] [087/156] (581s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[459.986972] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[459.990117] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[460.148638] [088/156] (580s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[461.653748] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[461.656716] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[461.808324] [089/156] (578s left) kms_vblank (ts-continuation-dpms-rpm)
[463.304802] Starting subtest: ts-continuation-dpms-rpm
[463.306242] Starting dynamic subtest: pipe-A-HDMI-A-4
[465.731159] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.425s)
[465.744818] Starting dynamic subtest: pipe-D-HDMI-A-4
[467.780910] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.047s)
[467.782552] Subtest ts-continuation-dpms-rpm: SUCCESS (4.478s)
[468.004569] [090/156] (572s left) kms_addfb_basic (addfb25-4-tiled)
[469.497037] Starting subtest: addfb25-4-tiled
[469.498522] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[469.684056] [091/156] (571s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[471.182912] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[471.185883] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[471.385647] [092/156] (569s left) i915_query (query-regions-unallocated)
[471.433630] Starting subtest: query-regions-unallocated
[471.923074] Subtest query-regions-unallocated: SUCCESS (0.490s)
[472.031760] [093/156] (569s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[472.079715] Starting subtest: multi-wait-all-available-submitted-signaled
[472.081216] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[472.201305] [094/156] (568s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-render)
[473.702961] Starting subtest: fbchdr-rgb101010-draw-render
[473.706268] Subtest fbchdr-rgb101010-draw-render: SKIP (0.000s)
[473.860340] [095/156] (567s left) dmabuf_sync_file (export-multiwait)
[473.915099] Starting subtest: export-multiwait
[473.916995] Subtest export-multiwait: SUCCESS (0.001s)
[474.010847] [096/156] (567s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[475.521112] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[476.777364] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.257s)
[476.969469] [097/156] (564s left) kms_atomic (plane-primary-legacy)
[478.463231] Starting subtest: plane-primary-legacy
[478.464802] Starting dynamic subtest: pipe-A-HDMI-A-4
[479.018205] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.554s)
[479.019802] Subtest plane-primary-legacy: SUCCESS (0.556s)
[479.240073] [098/156] (562s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[480.732677] Starting subtest: read-crc-frame-sequence
[480.734198] Starting dynamic subtest: pipe-A-HDMI-A-4
[481.465684] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.731s)
[481.480183] Starting dynamic subtest: pipe-B-HDMI-A-4
[481.977029] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.509s)
[481.990731] Starting dynamic subtest: pipe-C-HDMI-A-4
[482.455466] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.476s)
[482.469491] Starting dynamic subtest: pipe-D-HDMI-A-4
[482.946336] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.487s)
[482.947666] Subtest read-crc-frame-sequence: SUCCESS (2.214s)
[483.159582] [099/156] (558s left) kms_pm_rpm (dpms-non-lpsp)
[487.086426] Starting subtest: dpms-non-lpsp
[487.203969] Subtest dpms-non-lpsp: SUCCESS (0.123s)
[488.056932] [100/156] (553s left) kms_chamelium_audio (dp-audio)
[489.597265] Subtest dp-audio: SKIP (0.000s)
[489.729545] [101/156] (551s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[489.783166] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[489.784976] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[489.902499] [102/156] (551s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[491.402320] Starting subtest: fbc-rgb565-draw-mmap-wc
[491.405063] Subtest fbc-rgb565-draw-mmap-wc: SKIP (0.000s)
[491.615924] [103/156] (550s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[493.116873] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[493.120259] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[493.315095] [104/156] (548s left) gem_wait (invalid-flags)
[493.370572] Starting subtest: invalid-flags
[493.371992] Subtest invalid-flags: SUCCESS (0.000s)
[493.697630] [105/156] (548s left) gem_pxp (hw-rejects-pxp-context)
[496.272650] Starting subtest: hw-rejects-pxp-context
[496.274214] Subtest hw-rejects-pxp-context: SUCCESS (0.002s)
[496.428602] [106/156] (545s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[497.932564] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[497.935429] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[498.101768] [107/156] (544s left) kms_content_protection (atomic-dpms)
[499.655400] Starting subtest: atomic-dpms
[499.659377] Subtest atomic-dpms: SKIP (0.002s)
[499.860243] [108/156] (542s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-blt)
[501.361108] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-blt
[501.364904] Subtest fbchdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[501.542838] [109/156] (540s left) kms_prop_blob (blob-prop-lifetime)
[501.593557] Starting subtest: blob-prop-lifetime
[501.595298] Subtest blob-prop-lifetime: SUCCESS (0.002s)
[501.730472] [110/156] (540s left) gem_exec_schedule (u-semaphore-user)
[501.795524] Starting subtest: u-semaphore-user
[501.826204] Subtest u-semaphore-user: SUCCESS (0.031s)
[502.249404] [111/156] (540s left) gem_exec_balancer (indices)
[502.307755] Starting subtest: indices
[504.386826] Subtest indices: SUCCESS (2.079s)
[504.809876] [112/156] (537s left) gem_exec_params (rel-constants-invalid-ring)
[504.862124] Starting subtest: rel-constants-invalid-ring
[504.863648] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[505.089955] [113/156] (537s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-msflip-blt)
[506.588121] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-msflip-blt
[506.591115] Subtest fbcpsrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[506.790892] [114/156] (536s left) gem_exec_alignment (single)
[506.846289] Starting subtest: single
[506.853399] Subtest single: SUCCESS (0.007s)
[507.032142] [115/156] (536s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[507.088812] Starting subtest: legacy-engines-hostile-preempt
[507.090442] Starting dynamic subtest: render
[507.149872] Dynamic subtest render: SUCCESS (0.062s)
[507.162141] Starting dynamic subtest: bsd1
[507.199107] Dynamic subtest bsd1: SUCCESS (0.047s)
[507.230322] Starting dynamic subtest: bsd2
[507.255256] Dynamic subtest bsd2: SUCCESS (0.052s)
[507.285787] Starting dynamic subtest: blt
[507.310114] Dynamic subtest blt: SUCCESS (0.051s)
[507.332224] Starting dynamic subtest: vebox
[507.363224] Dynamic subtest vebox: SUCCESS (0.050s)
[507.365301] Subtest legacy-engines-hostile-preempt: SUCCESS (0.278s)
[507.555118] [116/156] (535s left) syncobj_timeline (signal-point-0)
[507.607971] Starting subtest: signal-point-0
[507.609896] Subtest signal-point-0: SUCCESS (0.000s)
[507.756104] [117/156] (535s left) gem_userptr_blits (relocations)
[507.814926] Starting subtest: relocations
[507.817590] Subtest relocations: SKIP (0.001s)
[507.996119] [118/156] (535s left) kms_plane_multiple (tiling-y)
[509.489823] Starting subtest: tiling-y
[509.491560] Starting dynamic subtest: pipe-A-HDMI-A-4
[510.414700] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.924s)
[510.426361] Starting dynamic subtest: pipe-B-HDMI-A-4
[511.263533] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.846s)
[511.275193] Starting dynamic subtest: pipe-C-HDMI-A-4
[512.151946] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.887s)
[512.164360] Starting dynamic subtest: pipe-D-HDMI-A-4
[513.015174] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.859s)
[513.016873] Subtest tiling-y: SUCCESS (3.526s)
[513.227429] [119/156] (530s left) gem_exec_await (wide-all)
[513.378315] Starting subtest: wide-all
[535.637059] Subtest wide-all: SUCCESS (22.259s)
[535.924028] [120/156] (507s left) gem_exec_params (invalid-fence-in-submit)
[536.035836] Starting subtest: invalid-fence-in-submit
[536.039824] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[536.219616] [121/156] (507s left) kms_flip (2x-wf_vblank-ts-check)
[537.721584] Starting subtest: 2x-wf_vblank-ts-check
[537.739105] Subtest 2x-wf_vblank-ts-check: SKIP (0.018s)
[537.880622] [122/156] (505s left) api_intel_bb (crc32)
[537.937280] Starting subtest: crc32
[537.941111] Subtest crc32: SKIP (0.000s)
[538.095533] [123/156] (505s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[539.611328] Starting subtest: yf-tiled-addfb-size-overflow
[539.614295] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[539.787776] [124/156] (504s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-plflip-blt)
[541.289435] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-plflip-blt
[541.292525] Subtest fbcpsrhdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[541.486969] [125/156] (502s left) gem_exec_whisper (basic-fds-forked-all)
[541.551300] Starting subtest: basic-fds-forked-all
[553.773197] Subtest basic-fds-forked-all: SUCCESS (12.218s)
[554.102365] [126/156] (490s left) syncobj_wait (signal)
[554.162789] Starting subtest: signal
[554.164340] Subtest signal: SUCCESS (0.000s)
[554.288427] [127/156] (489s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[555.782211] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[555.812228] Starting dynamic subtest: pipe-A-plane-0
[556.362476] Dynamic subtest pipe-A-plane-0: SUCCESS (0.549s)
[556.412350] Starting dynamic subtest: pipe-A-plane-3
[556.695917] Dynamic subtest pipe-A-plane-3: SUCCESS (0.329s)
[556.738238] Starting dynamic subtest: pipe-A-plane-5
[557.012175] Dynamic subtest pipe-A-plane-5: SUCCESS (0.312s)
[557.210637] Starting dynamic subtest: pipe-B-plane-0
[557.600100] Dynamic subtest pipe-B-plane-0: SUCCESS (0.400s)
[557.647330] Starting dynamic subtest: pipe-B-plane-3
[557.916150] Dynamic subtest pipe-B-plane-3: SUCCESS (0.311s)
[557.953968] Starting dynamic subtest: pipe-B-plane-5
[558.249232] Dynamic subtest pipe-B-plane-5: SUCCESS (0.329s)
[558.338166] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.557s)
[558.555232] [128/156] (485s left) kms_psr (psr-sprite-mmap-gtt)
[560.050303] Subtest psr-sprite-mmap-gtt: SKIP (0.000s)
[560.226008] [129/156] (484s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[561.718103] Starting subtest: bad-rotation-90-y-tiled-ccs
[561.719754] Starting dynamic subtest: pipe-A-HDMI-A-4
[561.738806] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[561.751750] Starting dynamic subtest: pipe-B-HDMI-A-4
[561.768217] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[561.780537] Starting dynamic subtest: pipe-C-HDMI-A-4
[561.797130] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[561.809765] Starting dynamic subtest: pipe-D-HDMI-A-4
[561.830879] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[561.834645] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.010s)
[562.033985] [130/156] (482s left) vgem_basic (setversion)
[562.096226] Starting subtest: setversion
[562.100027] Subtest setversion: SUCCESS (0.000s)
[562.197961] [131/156] (482s left) gem_exec_create (madvise)
[562.256371] Starting subtest: madvise
[562.258302] Starting dynamic subtest: smem
[582.388290] Dynamic subtest smem: SUCCESS (20.132s)
[582.403678] Starting dynamic subtest: lmem0
[602.625032] Dynamic subtest lmem0: SUCCESS (20.236s)
[602.626616] Subtest madvise: SUCCESS (40.371s)
[603.790570] [132/156] (440s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-gtt)
[605.292105] Starting subtest: hdr-rgb101010-draw-mmap-gtt
[605.295592] Subtest hdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[605.514996] [133/156] (439s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[607.007516] Starting subtest: plane-lut1d-pre-ctm3x4
[607.213078] Starting dynamic subtest: pipe-A-plane-0
[607.459718] Dynamic subtest pipe-A-plane-0: SUCCESS (0.246s)
[607.502693] Starting dynamic subtest: pipe-A-plane-1
[607.659837] Dynamic subtest pipe-A-plane-1: SUCCESS (0.192s)
[607.706101] Starting dynamic subtest: pipe-A-plane-2
[607.863335] Dynamic subtest pipe-A-plane-2: SUCCESS (0.192s)
[608.157975] Starting dynamic subtest: pipe-B-plane-0
[608.326364] Dynamic subtest pipe-B-plane-0: SUCCESS (0.196s)
[608.361668] Starting dynamic subtest: pipe-B-plane-1
[608.526282] Dynamic subtest pipe-B-plane-1: SUCCESS (0.192s)
[608.563453] Starting dynamic subtest: pipe-B-plane-2
[608.726700] Dynamic subtest pipe-B-plane-2: SUCCESS (0.192s)
[609.052914] Starting dynamic subtest: pipe-C-plane-0
[609.232719] Dynamic subtest pipe-C-plane-0: SUCCESS (0.213s)
[609.273983] Starting dynamic subtest: pipe-C-plane-1
[609.455379] Dynamic subtest pipe-C-plane-1: SUCCESS (0.209s)
[609.495751] Starting dynamic subtest: pipe-C-plane-2
[609.682907] Dynamic subtest pipe-C-plane-2: SUCCESS (0.226s)
[610.042601] Starting dynamic subtest: pipe-D-plane-0
[610.217493] Dynamic subtest pipe-D-plane-0: SUCCESS (0.213s)
[610.248056] Starting dynamic subtest: pipe-D-plane-1
[610.417233] Dynamic subtest pipe-D-plane-1: SUCCESS (0.193s)
[610.461729] Starting dynamic subtest: pipe-D-plane-2
[610.633858] Dynamic subtest pipe-D-plane-2: SUCCESS (0.209s)
[610.688962] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (3.681s)
[610.900213] [134/156] (434s left) kms_pm_backlight (fade)
[612.393835] Subtest fade: SKIP (0.000s)
[612.469700] [135/156] (432s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[613.968155] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[614.052148] [136/156] (431s left) i915_pciid
[614.217671] [137/156] (430s left) perf_pmu (all-busy-idle-check-all)
[614.268642] Starting subtest: all-busy-idle-check-all
[614.939121] Subtest all-busy-idle-check-all: SUCCESS (0.670s)
[615.062687] [138/156] (430s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[616.557691] Starting subtest: 2x-cursor-vs-flip-legacy
[616.560841] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s)
[616.687440] [139/156] (428s left) kms_joiner (basic-force-big-joiner)
[618.193242] Starting subtest: basic-force-big-joiner
[618.195879] Subtest basic-force-big-joiner: SKIP (0.000s)
[618.320240] [140/156] (427s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[619.828372] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[619.832151] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[619.996435] [141/156] (425s left) kms_psr (fbc-psr2-suspend)
[621.492038] Subtest fbc-psr2-suspend: SKIP (0.000s)
[621.569275] [142/156] (424s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-onoff)
[623.070870] Starting subtest: hdr-1p-primscrn-cur-indfb-onoff
[623.074140] Subtest hdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[623.281843] [143/156] (422s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt)
[624.783864] Starting subtest: fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt
[624.787270] Subtest fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[624.977632] [144/156] (420s left) gem_fence_thrash (bo-write-verify-x)
[625.025464] Starting subtest: bo-write-verify-x
[625.031281] Subtest bo-write-verify-x: SKIP (0.002s)
[625.103613] [145/156] (420s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[626.598544] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[626.603832] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[626.714338] [146/156] (419s left) gem_ppgtt (shrink-vs-evict-pinned)
[626.775171] Starting subtest: shrink-vs-evict-pinned
[634.855478] Subtest shrink-vs-evict-pinned: SUCCESS (8.077s)
[634.977097] [147/156] (411s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[636.466923] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[636.468423] Starting dynamic subtest: pipe-A-HDMI-A-4
[636.506601] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s)
[636.519295] Starting dynamic subtest: pipe-B-HDMI-A-4
[636.563210] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s)
[636.575731] Starting dynamic subtest: pipe-C-HDMI-A-4
[636.619930] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s)
[636.633182] Starting dynamic subtest: pipe-D-HDMI-A-4
[636.671802] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s)
[636.674859] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.020s)
[636.780265] [148/156] (409s left) gen9_exec_parse (secure-batches)
[636.836613] Subtest secure-batches: SKIP (0.000s)
[636.918311] [149/156] (409s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[638.417377] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[638.420347] Subtest psr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[638.609116] [150/156] (407s left) gem_exec_reloc (basic-gtt-noreloc)
[638.664803] Subtest basic-gtt-noreloc: SKIP (0.000s)
[638.779093] [151/156] (407s left) kms_frontbuffer_tracking (hdr-1p-rte)
[640.277922] Starting subtest: hdr-1p-rte
[640.280917] Subtest hdr-1p-rte: SKIP (0.000s)
[640.477856] [152/156] (406s left) gem_exec_schedule (preempt-hang)
[640.674959] Starting subtest: preempt-hang
[640.678074] Starting dynamic subtest: rcs0
[640.981718] Dynamic subtest rcs0: SUCCESS (0.306s)
[640.994956] Starting dynamic subtest: bcs0
[641.279781] Dynamic subtest bcs0: SUCCESS (0.296s)
[641.292990] Starting dynamic subtest: vcs0
[641.548038] Dynamic subtest vcs0: SUCCESS (0.267s)
[641.561385] Starting dynamic subtest: vcs1
[641.823499] Dynamic subtest vcs1: SUCCESS (0.274s)
[641.836374] Starting dynamic subtest: vecs0
[642.135415] Dynamic subtest vecs0: SUCCESS (0.310s)
[642.137370] Subtest preempt-hang: SUCCESS (1.464s)
[642.483465] [153/156] (404s left) gem_ctx_shared (q-smoketest-all)
[642.551026] Starting subtest: Q-smoketest-all
[674.856738] Subtest Q-smoketest-all: SUCCESS (32.294s)
[675.218972] [154/156] (371s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[675.274912] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[675.381489] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.109s)
[675.547128] [155/156] (371s left) kms_cursor_edge_walk (64x64-top-edge)
[677.038196] Starting subtest: 64x64-top-edge
[677.042811] Starting dynamic subtest: pipe-A-HDMI-A-4
[680.413514] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.368s)
[680.426351] Starting dynamic subtest: pipe-D-HDMI-A-4
[683.647134] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.235s)
[683.648747] Subtest 64x64-top-edge: SUCCESS (6.609s)
[683.855754] [156/156] (363s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-pwrite)
[685.358672] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-pwrite
[685.361677] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[685.551631] 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_exec_alignment
results: parsing output: 114/ for test: gem_ctx_persistence
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: kms_plane_multiple
results: parsing output: 118/ for test: gem_exec_await
results: parsing output: 119/ for test: gem_exec_params
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: api_intel_bb
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_whisper
results: parsing output: 125/ for test: syncobj_wait
results: parsing output: 126/ for test: kms_plane
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: vgem_basic
results: parsing output: 130/ for test: gem_exec_create
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_color_pipeline
results: parsing output: 133/ for test: kms_pm_backlight
results: parsing output: 134/ for test: kms_psr2_sf
results: parsing output: 135/ for test: i915_pciid
results: parsing output: 136/ for test: perf_pmu
results: parsing output: 137/ for test: kms_cursor_legacy
results: parsing output: 138/ for test: kms_joiner
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_psr
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: gem_fence_thrash
results: parsing output: 144/ for test: kms_flip_scaled_crc
results: parsing output: 145/ for test: gem_ppgtt
results: parsing output: 146/ for test: kms_ccs
results: parsing output: 147/ for test: gen9_exec_parse
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: gem_exec_reloc
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: gem_exec_schedule
results: parsing output: 152/ for test: gem_ctx_shared
results: parsing output: 153/ for test: syncobj_timeline
results: parsing output: 154/ for test: kms_cursor_edge_walk
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.