[64.134414] Initializing watchdogs
[64.134496]   /dev/watchdog0
[64.164826] [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.180132] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[64.185403] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.188204] [001/156] (960s left) gem_mmap_gtt (bad-object)
[64.251467] Subtest bad-object: SKIP (0.000s)
[64.356074] [002/156] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[65.849788] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc
[65.851733] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[66.007851] [003/156] (958s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[67.499638] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[78.505562] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.015s)
[78.699095] [004/156] (946s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[80.191524] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[80.193240] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[80.292605] [005/156] (944s left) kms_vblank (query-idle-hang)
[81.788209] Starting subtest: query-idle-hang
[81.789215] Starting dynamic subtest: pipe-A-HDMI-A-3
[108.447410] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (26.663s)
[108.459171] Starting dynamic subtest: pipe-D-HDMI-A-3
[133.451856] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (25.002s)
[133.452664] Subtest query-idle-hang: SUCCESS (51.671s)
[133.679416] [006/156] (891s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[135.174576] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[135.176875] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[135.333180] [007/156] (889s left) gem_caching (writes)
[135.396331] Starting subtest: writes
[140.643391] Subtest writes: SUCCESS (5.247s)
[140.797958] [008/156] (884s left) kms_chamelium_color (ctm-blue-to-red)
[142.287936] Subtest ctm-blue-to-red: SKIP (0.000s)
[142.357359] [009/156] (882s left) gem_wait (busy)
[142.420942] Starting subtest: busy
[142.421992] Starting dynamic subtest: all-engines
[142.993446] Dynamic subtest all-engines: SUCCESS (0.572s)
[143.002701] Starting dynamic subtest: rcs0
[143.536972] Dynamic subtest rcs0: SUCCESS (0.543s)
[143.546046] Starting dynamic subtest: bcs0
[144.075158] Dynamic subtest bcs0: SUCCESS (0.538s)
[144.084199] Starting dynamic subtest: vcs0
[144.613831] Dynamic subtest vcs0: SUCCESS (0.538s)
[144.622910] Starting dynamic subtest: vcs1
[145.151881] Dynamic subtest vcs1: SUCCESS (0.537s)
[145.160886] Starting dynamic subtest: vecs0
[145.689978] Dynamic subtest vecs0: SUCCESS (0.537s)
[145.690961] Subtest busy: SUCCESS (3.269s)
[145.995612] [010/156] (879s left) i915_fb_tiling (basic-x-tiling)
[146.041616] Subtest basic-x-tiling: SKIP (0.000s)
[146.106310] [011/156] (879s left) kms_chamelium_hpd (common-hpd-after-suspend)
[147.643277] Subtest common-hpd-after-suspend: SKIP (0.000s)
[147.770321] [012/156] (877s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[147.817325] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[147.885288] [013/156] (877s left) syncobj_basic (create-signaled)
[147.931408] Starting subtest: create-signaled
[147.932291] Subtest create-signaled: SUCCESS (0.000s)
[148.049487] [014/156] (877s left) kms_draw_crc (draw-method-mmap-cpu)
[149.537224] Starting subtest: draw-method-mmap-cpu
[149.538247] Starting dynamic subtest: xrgb8888-untiled
[149.914738] Dynamic subtest xrgb8888-untiled: SUCCESS (0.376s)
[149.952777] Starting dynamic subtest: rgb565-untiled
[150.247883] Dynamic subtest rgb565-untiled: SUCCESS (0.330s)
[150.286976] Starting dynamic subtest: xrgb2101010-untiled
[150.581082] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.330s)
[150.621169] Starting dynamic subtest: xbgr16161616f-untiled
[150.947864] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.363s)
[150.987043] Starting dynamic subtest: xrgb8888-xtiled
[151.148089] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.197s)
[151.190035] Starting dynamic subtest: rgb565-xtiled
[151.348090] Dynamic subtest rgb565-xtiled: SUCCESS (0.196s)
[151.390483] Starting dynamic subtest: xrgb2101010-xtiled
[151.531413] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.179s)
[151.571393] Starting dynamic subtest: xbgr16161616f-xtiled
[151.731310] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.196s)
[151.771260] Starting dynamic subtest: xrgb8888-ytiled
[151.931421] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.197s)
[151.971150] Starting dynamic subtest: rgb565-ytiled
[152.131574] Dynamic subtest rgb565-ytiled: SUCCESS (0.197s)
[152.171248] Starting dynamic subtest: xrgb2101010-ytiled
[152.314861] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.177s)
[152.355838] Starting dynamic subtest: xbgr16161616f-ytiled
[152.514927] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.196s)
[152.517399] Subtest draw-method-mmap-cpu: SUCCESS (2.978s)
[152.704130] [015/156] (873s left) prime_mmap (test_correct)
[152.753050] Starting subtest: test_correct
[152.754537] Starting dynamic subtest: test_correct-smem
[152.817437] Dynamic subtest test_correct-smem: SUCCESS (0.065s)
[152.826738] Starting dynamic subtest: test_correct-lmem0
[152.882667] Dynamic subtest test_correct-lmem0: SUCCESS (0.065s)
[152.883801] Subtest test_correct: SUCCESS (0.130s)
[153.019237] [016/156] (872s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-plflip-blt)
[154.511782] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-plflip-blt
[154.513456] Subtest fbcpsrhdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[154.694404] [017/156] (871s left) sysfs_heartbeat_interval (precise)
[154.747451] Starting subtest: precise
[154.748336] Starting dynamic subtest: vecs0
[155.956153] Dynamic subtest vecs0: SUCCESS (1.207s)
[155.965787] Starting dynamic subtest: vcs0
[157.161522] Dynamic subtest vcs0: SUCCESS (1.205s)
[157.171256] Starting dynamic subtest: bcs0
[158.381518] Dynamic subtest bcs0: SUCCESS (1.219s)
[158.391107] Starting dynamic subtest: rcs0
[162.761567] Dynamic subtest rcs0: SUCCESS (4.379s)
[162.771140] Starting dynamic subtest: vcs1
[165.697965] Dynamic subtest vcs1: SUCCESS (2.935s)
[165.698897] Subtest precise: SUCCESS (10.950s)
[165.843585] [018/156] (860s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[165.888838] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[165.952563] [019/156] (860s left) api_intel_allocator (fork-simple-once)
[165.998165] Starting subtest: fork-simple-once
[166.031767] Subtest fork-simple-once: SUCCESS (0.034s)
[166.224374] [020/156] (859s left) gem_exec_balancer (parallel-bb-first)
[166.593100] Starting subtest: parallel-bb-first
[168.687287] Subtest parallel-bb-first: SUCCESS (2.096s)
[168.796899] [021/156] (857s left) kms_invalid_mode (uint-max-clock)
[170.285476] Starting subtest: uint-max-clock
[170.286500] Starting dynamic subtest: pipe-A-HDMI-A-3
[170.321564] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.034s)
[170.331029] Starting dynamic subtest: pipe-B-HDMI-A-3
[170.332072] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s)
[170.341571] Starting dynamic subtest: pipe-C-HDMI-A-3
[170.342810] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s)
[170.351697] Starting dynamic subtest: pipe-D-HDMI-A-3
[170.352615] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s)
[170.353648] Subtest uint-max-clock: SUCCESS (0.043s)
[170.514477] [022/156] (855s left) kms_addfb_basic (bad-pitch-999)
[170.559380] Starting subtest: bad-pitch-999
[170.560317] Subtest bad-pitch-999: SUCCESS (0.000s)
[172.159740] [023/156] (854s left) gen9_exec_parse (basic-rejected-ctx-param)
[172.217162] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[172.285179] [024/156] (854s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[173.796272] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[173.798291] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[173.961883] [025/156] (852s left) gem_exec_basic (basic)
[174.014815] Starting subtest: basic
[174.015828] Starting dynamic subtest: rcs0-smem
[174.018111] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[174.032033] Starting dynamic subtest: bcs0-smem
[174.033033] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[174.042255] Starting dynamic subtest: vcs0-smem
[174.043338] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[174.052524] Starting dynamic subtest: vcs1-smem
[174.053470] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[174.062552] Starting dynamic subtest: vecs0-smem
[174.063528] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[174.072481] Starting dynamic subtest: rcs0-lmem0
[174.073578] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[174.082424] Starting dynamic subtest: bcs0-lmem0
[174.083525] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[174.092421] Starting dynamic subtest: vcs0-lmem0
[174.093523] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[174.102411] Starting dynamic subtest: vcs1-lmem0
[174.103514] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[174.112427] Starting dynamic subtest: vecs0-lmem0
[174.113520] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[174.114495] Subtest basic: SUCCESS (0.015s)
[174.263712] [026/156] (852s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[174.318139] Starting subtest: y-tiled-ccs-to-y-tiled
[174.319113] Starting dynamic subtest: smem
[174.410215] Dynamic subtest smem: SUCCESS (0.093s)
[174.419743] Starting dynamic subtest: lmem0
[175.348416] Dynamic subtest lmem0: SUCCESS (0.933s)
[175.349653] Subtest y-tiled-ccs-to-y-tiled: SUCCESS (1.027s)
[175.616634] [027/156] (851s left) gem_close (basic)
[175.667194] Starting subtest: basic
[175.668084] Subtest basic: SUCCESS (0.000s)
[175.819519] [028/156] (851s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[177.306636] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[177.308968] Starting dynamic subtest: pipe-A-HDMI-A-3
[177.317092] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.002s)
[177.326537] Starting dynamic subtest: pipe-B-HDMI-A-3
[177.335171] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s)
[177.344508] Starting dynamic subtest: pipe-C-HDMI-A-3
[177.353159] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.002s)
[177.362272] Starting dynamic subtest: pipe-D-HDMI-A-3
[177.371152] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.002s)
[177.372135] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SUCCESS (0.012s)
[177.646252] [029/156] (849s left) kms_psr (psr2-sprite-mmap-gtt)
[179.134247] Subtest psr2-sprite-mmap-gtt: SKIP (0.000s)
[179.213253] [030/156] (847s left) i915_pm_rpm (system-suspend)
[183.037192] Starting subtest: system-suspend
[210.920266] Subtest system-suspend: SUCCESS (11.943s)
[215.859575] [031/156] (815s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[217.349807] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[217.350752] Starting dynamic subtest: pipe-A-HDMI-A-3
[217.354305] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[217.365897] Starting dynamic subtest: pipe-B-HDMI-A-3
[217.369597] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[217.381127] Starting dynamic subtest: pipe-C-HDMI-A-3
[217.384696] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[217.395709] Starting dynamic subtest: pipe-D-HDMI-A-3
[217.399545] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[217.401319] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[217.633632] [032/156] (813s left) kms_psr (fbc-pr-sprite-plane-move)
[219.125993] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[219.203738] [033/156] (812s left) drm_read (invalid-buffer)
[220.764206] Starting subtest: invalid-buffer
[220.765121] Subtest invalid-buffer: SUCCESS (0.000s)
[221.005905] [034/156] (810s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[222.505598] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[222.507624] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[222.668379] [035/156] (808s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[222.719161] Starting subtest: multi-wait-all-for-submit-unsubmitted
[222.828284] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[222.990062] [036/156] (808s left) perf_pmu (render-node-busy)
[223.044820] Starting subtest: render-node-busy
[223.045751] Starting dynamic subtest: rcs0
[223.648682] Dynamic subtest rcs0: SUCCESS (0.604s)
[223.663313] Starting dynamic subtest: bcs0
[224.204571] Dynamic subtest bcs0: SUCCESS (0.555s)
[224.218956] Starting dynamic subtest: vcs0
[224.759710] Dynamic subtest vcs0: SUCCESS (0.554s)
[224.774544] Starting dynamic subtest: vcs1
[225.320239] Dynamic subtest vcs1: SUCCESS (0.558s)
[225.336463] Starting dynamic subtest: vecs0
[225.882246] Dynamic subtest vecs0: SUCCESS (0.558s)
[225.884785] Subtest render-node-busy: SUCCESS (2.839s)
[226.002548] [037/156] (805s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[226.552089] Starting subtest: syncobj-timeline-multiple-ext-nodes
[226.553282] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[226.853685] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[226.856221] [038/156] (804s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[228.389098] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[228.522958] [039/156] (803s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[230.014202] Starting subtest: flip-vs-cursor-crc-legacy
[230.545190] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.532s)
[230.755351] [040/156] (801s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-render)
[232.252055] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-render
[232.254306] Subtest fbchdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[232.455290] [041/156] (799s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-blt)
[233.965967] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-blt
[233.968208] Subtest hdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[234.145195] [042/156] (797s left) vgem_basic (sysfs)
[234.207430] Starting subtest: sysfs
[234.208471] Subtest sysfs: SUCCESS (0.000s)
[234.313741] [043/156] (797s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[234.361433] Starting subtest: invalid-single-wait-all-unsubmitted
[234.362446] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[234.496430] [044/156] (797s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-pwrite)
[235.991427] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-pwrite
[235.993205] Subtest hdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[236.170573] [045/156] (796s left) gem_ctx_persistence (legacy-engines-queued)
[236.224168] Starting subtest: legacy-engines-queued
[236.225115] Starting dynamic subtest: render
[236.290903] Dynamic subtest render: SUCCESS (0.066s)
[236.305909] Starting dynamic subtest: bsd1
[236.337865] Dynamic subtest bsd1: SUCCESS (0.046s)
[236.353712] Starting dynamic subtest: bsd2
[236.381937] Dynamic subtest bsd2: SUCCESS (0.043s)
[236.400698] Starting dynamic subtest: blt
[236.412072] Dynamic subtest blt: SUCCESS (0.029s)
[236.430539] Starting dynamic subtest: vebox
[236.464997] Dynamic subtest vebox: SUCCESS (0.052s)
[236.466018] Subtest legacy-engines-queued: SUCCESS (0.241s)
[236.647710] [046/156] (795s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[238.148235] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[238.150482] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[238.329132] [047/156] (794s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[239.837209] Starting subtest: x-tiled-8bpp-rotate-180
[241.545716] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.704s)
[241.735286] [048/156] (790s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[243.230143] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[243.231822] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[243.432500] [049/156] (789s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-gtt)
[244.927219] Starting subtest: psrhdr-rgb101010-draw-mmap-gtt
[244.929559] Subtest psrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[245.110782] [050/156] (787s left) gem_pxp (reject-modify-context-protection-off-2)
[247.683633] Starting subtest: reject-modify-context-protection-off-2
[247.686081] Subtest reject-modify-context-protection-off-2: SKIP (0.000s)
[247.800144] [051/156] (785s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[249.289827] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[249.291590] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (0.000s)
[249.435711] [052/156] (783s left) kms_psr (fbc-psr-primary-render)
[250.930808] Subtest fbc-psr-primary-render: SKIP (0.000s)
[251.003525] [053/156] (782s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[252.499760] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[252.518221] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.019s)
[252.671213] [054/156] (780s left) kms_psr (psr-sprite-render)
[254.159938] Subtest psr-sprite-render: SKIP (0.000s)
[254.237471] [055/156] (779s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[255.733881] Starting subtest: psr-rgb565-draw-pwrite
[255.735784] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s)
[255.940892] [056/156] (777s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[257.442254] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[257.444629] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[257.639750] [057/156] (775s left) kms_vblank (query-forked)
[259.127646] Starting subtest: query-forked
[259.130143] Starting dynamic subtest: pipe-A-HDMI-A-3
[261.512120] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.382s)
[261.528438] Starting dynamic subtest: pipe-D-HDMI-A-3
[263.784009] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.268s)
[263.784910] Subtest query-forked: SUCCESS (4.657s)
[263.991107] [058/156] (769s left) gem_softpin (evict-single-offset)
[264.044332] Starting subtest: evict-single-offset
[293.778778] Subtest evict-single-offset: SUCCESS (29.730s)
[293.889932] [059/156] (739s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-pwrite)
[295.438935] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-pwrite
[295.440805] Subtest fbchdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[295.616349] [060/156] (738s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[295.673038] Starting subtest: invalid-multi-wait-unsubmitted
[295.674065] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[295.792736] [061/156] (738s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[297.288495] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (0.000s)
[297.365910] [062/156] (736s left) gem_softpin (noreloc-interruptible)
[297.422893] Starting subtest: noreloc-interruptible
[302.853137] Subtest noreloc-interruptible: SUCCESS (5.425s)
[303.008306] [063/156] (731s left) syncobj_timeline (signal)
[303.053894] Starting subtest: signal
[303.054770] Subtest signal: SUCCESS (0.000s)
[303.197376] [064/156] (731s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-pwrite)
[304.691296] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-pwrite
[304.693006] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[304.867646] [065/156] (729s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[306.379847] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[306.382012] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[306.594385] [066/156] (727s left) kms_pm_rpm (dpms-non-lpsp)
[310.962509] Starting subtest: dpms-non-lpsp
[311.074053] Subtest dpms-non-lpsp: SUCCESS (0.111s)
[311.941412] [067/156] (722s left) gem_ctx_isolation (preservation-reset)
[312.147588] Starting subtest: preservation-reset
[312.150058] Starting dynamic subtest: rcs0
[312.851695] Dynamic subtest rcs0: SUCCESS (0.707s)
[312.866941] Starting dynamic subtest: bcs0
[313.591538] Dynamic subtest bcs0: SUCCESS (0.739s)
[313.605804] Starting dynamic subtest: vcs0
[314.312252] Dynamic subtest vcs0: SUCCESS (0.720s)
[314.326977] Starting dynamic subtest: vcs1
[315.051836] Dynamic subtest vcs1: SUCCESS (0.738s)
[315.066683] Starting dynamic subtest: vecs0
[315.760169] Dynamic subtest vecs0: SUCCESS (0.708s)
[315.761313] Subtest preservation-reset: SUCCESS (3.621s)
[315.993916] [068/156] (718s left) kms_prop_blob (blob-prop-core)
[316.040888] Starting subtest: blob-prop-core
[316.041806] Subtest blob-prop-core: SUCCESS (0.000s)
[316.180710] [069/156] (718s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-blt)
[317.673533] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-blt
[317.675457] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[317.866377] [070/156] (716s left) i915_query (query-regions-sanity-check)
[317.913130] Starting subtest: query-regions-sanity-check
[317.944199] Subtest query-regions-sanity-check: SUCCESS (0.031s)
[318.156346] [071/156] (716s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[319.657581] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[319.659385] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[319.910364] [072/156] (715s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-pgflip-blt)
[321.405604] Starting subtest: psrhdr-2p-primscrn-indfb-pgflip-blt
[321.408117] Subtest psrhdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[321.598452] [073/156] (713s left) gem_exec_parallel (fds)
[321.656281] Starting subtest: fds
[321.657309] Starting dynamic subtest: rcs0
[324.879926] Dynamic subtest rcs0: SUCCESS (3.223s)
[324.895788] Starting dynamic subtest: bcs0
[327.857293] Dynamic subtest bcs0: SUCCESS (2.972s)
[327.872176] Starting dynamic subtest: vcs0
[330.767677] Dynamic subtest vcs0: SUCCESS (2.909s)
[330.782554] Starting dynamic subtest: vcs1
[333.823599] Dynamic subtest vcs1: SUCCESS (3.055s)
[333.839129] Starting dynamic subtest: vecs0
[336.862840] Dynamic subtest vecs0: SUCCESS (3.038s)
[336.864014] Subtest fds: SUCCESS (15.203s)
[337.186353] [074/156] (698s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[338.701547] Starting subtest: y-tiled-8bpp-rotate-90
[338.808074] Subtest y-tiled-8bpp-rotate-90: SKIP (0.105s)
[338.988811] [075/156] (696s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[339.045118] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[339.046064] Starting dynamic subtest: smem
[339.145128] Dynamic subtest smem: SUCCESS (0.099s)
[339.161748] Starting dynamic subtest: lmem0
[340.254347] Dynamic subtest lmem0: SUCCESS (1.104s)
[340.255478] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SUCCESS (1.205s)
[340.511375] [076/156] (694s left) kms_frontbuffer_tracking (hdr-modesetfrombusy)
[342.005889] Starting subtest: hdr-modesetfrombusy
[342.007840] Subtest hdr-modesetfrombusy: SKIP (0.000s)
[342.229121] [077/156] (693s left) kms_display_modes (extended-mode-basic)
[343.737446] Starting subtest: extended-mode-basic
[343.740599] Subtest extended-mode-basic: SKIP (0.000s)
[343.824553] [078/156] (691s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[345.319219] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[345.320918] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[345.480598] [079/156] (690s left) kms_frontbuffer_tracking (psr-slowdraw)
[346.976907] Starting subtest: psr-slowdraw
[346.978991] Subtest psr-slowdraw: SKIP (0.000s)
[347.160478] [080/156] (688s left) gem_exec_whisper (basic-queues-all)
[347.222165] Starting subtest: basic-queues-all
[353.988609] Subtest basic-queues-all: SUCCESS (6.767s)
[354.293267] [081/156] (681s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[355.788625] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[355.791141] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[356.013427] [082/156] (680s left) kms_flip (2x-modeset-vs-vblank-race)
[357.503214] Starting subtest: 2x-modeset-vs-vblank-race
[357.523619] Subtest 2x-modeset-vs-vblank-race: SKIP (0.019s)
[357.663881] [083/156] (678s left) gem_blits (basic)
[357.742403] Starting subtest: basic
[365.569625] Subtest basic: SUCCESS (7.823s)
[365.734152] [084/156] (670s left) gem_ctx_sseu (invalid-sseu)
[365.785312] Subtest invalid-sseu: SKIP (0.000s)
[365.873591] [085/156] (670s left) gem_exec_schedule (noreorder-priority)
[366.075279] Starting subtest: noreorder-priority
[366.076210] Starting dynamic subtest: rcs0
[367.213892] Dynamic subtest rcs0: SUCCESS (1.138s)
[367.230449] Starting dynamic subtest: bcs0
[368.333923] Dynamic subtest bcs0: SUCCESS (1.119s)
[368.350315] Starting dynamic subtest: vcs0
[369.456929] Dynamic subtest vcs0: SUCCESS (1.122s)
[369.473170] Starting dynamic subtest: vcs1
[370.583926] Dynamic subtest vcs1: SUCCESS (1.126s)
[370.600211] Starting dynamic subtest: vecs0
[371.709882] Dynamic subtest vecs0: SUCCESS (1.125s)
[371.710906] Subtest noreorder-priority: SUCCESS (5.635s)
[371.983446] [086/156] (664s left) gem_render_linear_blits (basic)
[372.034918] Starting subtest: basic
[372.104484] Subtest basic: SUCCESS (0.070s)
[372.222665] [087/156] (664s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[373.718813] Starting subtest: fbcpsr-shrfb-scaledprimary
[373.720995] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s)
[373.953541] [088/156] (662s left) gem_mmap_offset (partial-unmap)
[374.001596] Starting subtest: partial-unmap
[374.002822] Starting dynamic subtest: lmem0
[374.009294] Dynamic subtest lmem0: SUCCESS (0.009s)
[374.026231] Starting dynamic subtest: smem0
[374.031424] Dynamic subtest smem0: SUCCESS (0.006s)
[374.032499] Subtest partial-unmap: SUCCESS (0.017s)
[374.202896] [089/156] (662s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[375.729234] Starting subtest: cursor-tearing-framebuffer-change
[375.731767] Starting dynamic subtest: pipe-A-HDMI-A-3
[376.211803] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.481s)
[376.228716] Starting dynamic subtest: pipe-D-HDMI-A-3
[376.568989] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.354s)
[376.570191] Subtest cursor-tearing-framebuffer-change: SUCCESS (0.840s)
[377.234688] [090/156] (659s left) drm_read (short-buffer-nonblock)
[378.790709] Starting subtest: short-buffer-nonblock
[378.791757] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[379.048910] [091/156] (657s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[380.557881] Starting subtest: fbc-rgb565-draw-pwrite
[383.557781] Subtest fbc-rgb565-draw-pwrite: SUCCESS (3.000s)
[383.746641] [092/156] (653s left) kms_lease (possible-crtcs-filtering)
[385.237160] Starting subtest: possible-crtcs-filtering
[385.244437] Subtest possible-crtcs-filtering: SUCCESS (0.007s)
[385.376768] [093/156] (651s left) i915_drm_fdinfo (memory-info-active)
[385.429211] Starting subtest: memory-info-active
[385.430153] Starting dynamic subtest: lmem0
[389.636590] Dynamic subtest lmem0: SUCCESS (4.206s)
[389.665091] Starting dynamic subtest: smem0
[393.757892] Dynamic subtest smem0: SUCCESS (4.113s)
[393.758969] Subtest memory-info-active: SUCCESS (8.325s)
[393.882406] [094/156] (643s left) gem_exec_schedule (u-lateslice)
[393.942466] Starting subtest: u-lateslice
[393.943429] Starting dynamic subtest: rcs0
[393.981341] Dynamic subtest rcs0: SUCCESS (0.038s)
[393.998324] Starting dynamic subtest: bcs0
[394.002223] Dynamic subtest bcs0: SUCCESS (0.020s)
[394.019114] Starting dynamic subtest: vcs0
[394.024811] Dynamic subtest vcs0: SUCCESS (0.021s)
[394.041700] Starting dynamic subtest: vcs1
[394.048617] Dynamic subtest vcs1: SUCCESS (0.022s)
[394.065409] Starting dynamic subtest: vecs0
[394.070339] Dynamic subtest vecs0: SUCCESS (0.020s)
[394.071299] Subtest u-lateslice: SUCCESS (0.129s)
[394.555056] [095/156] (642s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[396.056208] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[396.058644] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[396.265454] [096/156] (641s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[397.760892] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[397.763250] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[397.938229] [097/156] (639s left) prime_vgem (shrink)
[397.999009] Starting subtest: shrink
[398.030735] Subtest shrink: SUCCESS (0.032s)
[398.212430] [098/156] (639s left) sw_sync (alloc_fence_invalid_timeline)
[398.257641] Starting subtest: alloc_fence_invalid_timeline
[398.258688] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[398.375286] [099/156] (639s left) kms_cursor_crc (cursor-onscreen-128x42)
[400.058980] Starting subtest: cursor-onscreen-128x42
[400.065065] Starting dynamic subtest: pipe-A-HDMI-A-3
[402.845045] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.780s)
[402.883028] Starting dynamic subtest: pipe-D-HDMI-A-3
[405.504696] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.635s)
[405.505788] Subtest cursor-onscreen-128x42: SUCCESS (5.445s)
[405.913563] [100/156] (632s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[407.404565] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[407.406348] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[407.538729] [101/156] (630s left) core_setmaster (master-drop-set-root)
[407.638413] Starting subtest: master-drop-set-root
[407.667335] Subtest master-drop-set-root: SUCCESS (0.028s)
[407.754553] [102/156] (630s left) kms_async_flips (test-time-stamp-atomic)
[409.245207] Starting subtest: test-time-stamp-atomic
[409.467844] Starting dynamic subtest: pipe-A-HDMI-A-3
[409.841756] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.373s)
[410.054007] Starting dynamic subtest: pipe-B-HDMI-A-3
[410.163041] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.122s)
[410.355320] Starting dynamic subtest: pipe-C-HDMI-A-3
[410.460633] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.118s)
[410.663988] Starting dynamic subtest: pipe-D-HDMI-A-3
[410.774793] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.124s)
[410.775760] Subtest test-time-stamp-atomic: SUCCESS (1.531s)
[411.179114] [103/156] (627s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-render)
[412.674585] Starting subtest: fbcpsrhdr-rgb565-draw-render
[412.676430] Subtest fbcpsrhdr-rgb565-draw-render: SKIP (0.000s)
[412.838315] [104/156] (625s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[414.329568] Starting subtest: bad-aux-stride-yf-tiled-ccs
[414.332090] Starting dynamic subtest: pipe-A-HDMI-A-3
[414.341118] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[414.357176] Starting dynamic subtest: pipe-B-HDMI-A-3
[414.366764] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[414.381906] Starting dynamic subtest: pipe-C-HDMI-A-3
[414.391858] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[414.407015] Starting dynamic subtest: pipe-D-HDMI-A-3
[414.418062] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[414.420589] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.010s)
[414.664181] [105/156] (623s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[416.159176] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[416.160938] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[416.358550] [106/156] (622s left) sw_sync (sync_busy_fork)
[416.403024] Starting subtest: sync_busy_fork
[417.422876] Subtest sync_busy_fork: SUCCESS (1.015s)
[417.516588] [107/156] (621s left) perf (invalid-oa-exponent)
[417.752332] Starting subtest: invalid-oa-exponent
[417.782864] Subtest invalid-oa-exponent: SUCCESS (0.030s)
[417.878004] [108/156] (620s left) kms_psr2_su (frontbuffer-xrgb8888)
[417.925919] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[418.012524] [109/156] (620s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[419.508704] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[419.510505] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[419.714251] [110/156] (619s left) kms_frontbuffer_tracking (psrhdr-shrfb-scaledprimary)
[421.214575] Starting subtest: psrhdr-shrfb-scaledprimary
[421.216557] Subtest psrhdr-shrfb-scaledprimary: SKIP (0.000s)
[421.400446] [111/156] (617s left) kms_big_fb (linear-64bpp-rotate-270)
[422.907890] Starting subtest: linear-64bpp-rotate-270
[422.985465] Subtest linear-64bpp-rotate-270: SKIP (0.076s)
[423.163542] [112/156] (615s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[424.659646] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[424.661848] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[424.878938] [113/156] (614s left) gem_ppgtt (shrink-vs-evict-any)
[424.932154] Starting subtest: shrink-vs-evict-any
[432.801694] Subtest shrink-vs-evict-any: SUCCESS (7.867s)
[432.930629] [114/156] (606s left) gem_ctx_exec (basic-invalid-context)
[432.978570] Starting subtest: basic-invalid-context
[432.983235] Subtest basic-invalid-context: SUCCESS (0.005s)
[433.134645] [115/156] (606s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-blt)
[434.629790] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-blt
[434.631637] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[434.819767] [116/156] (604s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[436.310171] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[436.311155] Starting dynamic subtest: pipe-A-HDMI-A-3
[436.320368] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[436.335794] Starting dynamic subtest: pipe-B-HDMI-A-3
[436.345097] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[436.359961] Starting dynamic subtest: pipe-C-HDMI-A-3
[436.369775] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[436.384816] Starting dynamic subtest: pipe-D-HDMI-A-3
[436.395523] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[436.398081] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SKIP (0.010s)
[436.599811] [117/156] (603s left) prime_vgem (coherency-gtt)
[436.679284] Starting subtest: coherency-gtt
[436.681124] Subtest coherency-gtt: SKIP (0.000s)
[436.844748] [118/156] (602s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[438.334087] Starting subtest: cursorA-vs-flipB-atomic
[438.335940] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[438.450554] [119/156] (601s left) kms_addfb_basic (basic-y-tiled-legacy)
[438.502604] Starting subtest: basic-y-tiled-legacy
[438.504430] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[440.164390] [120/156] (599s left) kms_plane_alpha_blend (coverage-7efc)
[441.655527] Starting subtest: coverage-7efc
[441.922211] Starting dynamic subtest: pipe-A-HDMI-A-3
[442.430953] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.507s)
[442.466638] Starting dynamic subtest: pipe-D-HDMI-A-3
[443.015683] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.564s)
[443.016554] Subtest coverage-7efc: SUCCESS (1.362s)
[443.220367] [121/156] (596s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[444.717100] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[444.718825] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[444.964520] [122/156] (595s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[446.459630] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[446.461595] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[446.657632] [123/156] (593s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[448.148229] Starting subtest: sprite-rotation-90-pos-100-0
[458.474633] Subtest sprite-rotation-90-pos-100-0: SUCCESS (10.326s)
[458.735924] [124/156] (581s left) kms_pm_backlight (fade)
[460.227209] Subtest fade: SKIP (0.000s)
[460.306654] [125/156] (580s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt)
[461.801642] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt
[461.803532] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[461.966195] [126/156] (578s left) gem_exec_schedule (implicit-read-write)
[462.026566] Starting subtest: implicit-read-write
[462.027704] Starting dynamic subtest: rcs0
[462.227173] Dynamic subtest rcs0: SUCCESS (0.196s)
[462.242923] Starting dynamic subtest: bcs0
[462.359624] Dynamic subtest bcs0: SUCCESS (0.135s)
[462.376386] Starting dynamic subtest: vcs0
[462.499774] Dynamic subtest vcs0: SUCCESS (0.139s)
[462.517106] Starting dynamic subtest: vcs1
[462.639972] Dynamic subtest vcs1: SUCCESS (0.139s)
[462.657444] Starting dynamic subtest: vecs0
[462.792612] Dynamic subtest vecs0: SUCCESS (0.151s)
[462.793644] Subtest implicit-read-write: SUCCESS (0.767s)
[463.265257] [127/156] (577s left) kms_psr (pr-primary-page-flip)
[464.765371] Subtest pr-primary-page-flip: SKIP (0.000s)
[464.939948] [128/156] (575s left) gem_softpin (evict-snoop)
[464.995602] Starting subtest: evict-snoop
[464.997597] Subtest evict-snoop: SKIP (0.000s)
[465.194797] [129/156] (575s left) kms_properties (plane-properties-legacy)
[466.685138] Starting subtest: plane-properties-legacy
[466.686153] Starting dynamic subtest: pipe-A-HDMI-A-3
[467.147093] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.460s)
[467.162713] Starting dynamic subtest: pipe-B-HDMI-A-3
[467.604993] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.456s)
[467.623594] Starting dynamic subtest: pipe-C-HDMI-A-3
[468.069074] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.461s)
[468.087967] Starting dynamic subtest: pipe-D-HDMI-A-3
[468.541033] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.469s)
[468.541952] Subtest plane-properties-legacy: SUCCESS (1.856s)
[468.792145] [130/156] (572s left) syncobj_timeline (etime-multi-wait-all-submitted)
[468.839231] Starting subtest: etime-multi-wait-all-submitted
[468.945900] Subtest etime-multi-wait-all-submitted: SUCCESS (0.104s)
[469.078939] [131/156] (572s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[473.559928] Starting subtest: heavy-verify-multi-ccs
[473.561156] Starting dynamic subtest: lmem0
[473.563232] Dynamic subtest lmem0: SKIP (0.000s)
[473.565576] Subtest heavy-verify-multi-ccs: SKIP (0.002s)
[477.405944] [FACT gem_lmem_swapping (heavy-verify-multi-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[477.407051] [FACT gem_lmem_swapping (heavy-verify-multi-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[477.409565] [132/156] (563s left) gem_exec_suspend (basic-s3)
[480.728458] Starting subtest: basic-S3
[480.729390] Starting dynamic subtest: smem
[510.289213] Dynamic subtest smem: SUCCESS (14.180s)
[510.304893] Starting dynamic subtest: lmem0
[540.220590] Dynamic subtest lmem0: SUCCESS (13.859s)
[540.221671] Subtest basic-S3: SUCCESS (28.043s)
[544.442634] [FACT gem_exec_suspend (basic-s3)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[544.445877] [FACT gem_exec_suspend (basic-s3)] new: kernel.kmod_is_loaded.i915: true
[544.453535] [133/156] (500s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-blt)
[545.951658] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-blt
[545.953558] Subtest fbchdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[546.130399] [134/156] (499s left) kms_flip (2x-wf_vblank-ts-check)
[547.621673] Starting subtest: 2x-wf_vblank-ts-check
[547.640115] Subtest 2x-wf_vblank-ts-check: SKIP (0.019s)
[547.798882] [135/156] (497s left) syncobj_timeline (wait-all-for-submit-complex)
[547.846658] Starting subtest: wait-all-for-submit-complex
[548.069771] Subtest wait-all-for-submit-complex: SUCCESS (0.218s)
[548.190452] [136/156] (497s left) gem_userptr_blits (readonly-pwrite-unsync)
[548.246700] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[548.463046] [137/156] (497s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[549.972912] Starting subtest: yf-tiled-32bpp-rotate-90
[549.974781] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[550.175226] [138/156] (495s left) api_intel_bb (render)
[550.222344] Starting subtest: render
[550.223381] Starting dynamic subtest: render-none-512
[550.268867] Dynamic subtest render-none-512: SUCCESS (0.046s)
[550.284404] Starting dynamic subtest: render-none-1024
[550.342668] Dynamic subtest render-none-1024: SUCCESS (0.072s)
[550.358149] Starting dynamic subtest: render-x-512
[550.365170] Dynamic subtest render-x-512: SUCCESS (0.021s)
[550.380750] Starting dynamic subtest: render-x-1024
[550.429286] Dynamic subtest render-x-1024: SUCCESS (0.062s)
[550.446823] Starting dynamic subtest: render-y-512
[550.451679] Dynamic subtest render-y-512: SUCCESS (0.021s)
[550.467164] Starting dynamic subtest: render-y-1024
[550.511070] Dynamic subtest render-y-1024: SUCCESS (0.058s)
[550.512068] Subtest render: SUCCESS (0.290s)
[550.718479] [139/156] (495s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[552.507771] Starting subtest: cursor-rapid-movement-512x170
[552.511128] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[552.723038] [140/156] (493s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-blt)
[554.219445] Starting subtest: fbcpsrhdr-rgb565-draw-blt
[554.221637] Subtest fbcpsrhdr-rgb565-draw-blt: SKIP (0.000s)
[554.410763] [141/156] (491s left) kms_flip (flip-vs-rmfb-interruptible)
[555.905417] Starting subtest: flip-vs-rmfb-interruptible
[555.912875] Starting dynamic subtest: A-HDMI-A3
[563.646305] Dynamic subtest A-HDMI-A3: SUCCESS (7.732s)
[563.702489] Starting dynamic subtest: B-HDMI-A3
[571.342337] Dynamic subtest B-HDMI-A3: SUCCESS (7.687s)
[571.392838] Starting dynamic subtest: C-HDMI-A3
[579.038668] Dynamic subtest C-HDMI-A3: SUCCESS (7.690s)
[579.083507] Starting dynamic subtest: D-HDMI-A3
[586.738245] Dynamic subtest D-HDMI-A3: SUCCESS (7.695s)
[586.744614] Subtest flip-vs-rmfb-interruptible: SUCCESS (30.839s)
[587.025735] [142/156] (459s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[588.518428] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[588.520682] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SKIP (0.000s)
[588.646263] [143/156] (457s left) gem_userptr_blits (create-destroy-sync)
[588.715510] Starting subtest: create-destroy-sync
[593.748397] Subtest create-destroy-sync: SUCCESS (5.029s)
[593.915316] [144/156] (452s left) kms_content_protection (atomic-dpms-hdcp14)
[595.462782] Starting subtest: atomic-dpms-hdcp14
[595.467814] Subtest atomic-dpms-hdcp14: SKIP (0.002s)
[595.706101] [145/156] (450s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[597.195989] Starting subtest: plane-ctm3x4-lut1d
[597.399696] Starting dynamic subtest: pipe-A-plane-0
[597.654942] Dynamic subtest pipe-A-plane-0: SUCCESS (0.248s)
[597.685997] Starting dynamic subtest: pipe-A-plane-1
[597.846155] Dynamic subtest pipe-A-plane-1: SUCCESS (0.190s)
[597.888755] Starting dynamic subtest: pipe-A-plane-2
[598.047277] Dynamic subtest pipe-A-plane-2: SUCCESS (0.192s)
[598.360216] Starting dynamic subtest: pipe-B-plane-0
[598.517442] Dynamic subtest pipe-B-plane-0: SUCCESS (0.196s)
[598.557991] Starting dynamic subtest: pipe-B-plane-1
[598.732242] Dynamic subtest pipe-B-plane-1: SUCCESS (0.209s)
[598.765632] Starting dynamic subtest: pipe-B-plane-2
[598.919601] Dynamic subtest pipe-B-plane-2: SUCCESS (0.176s)
[599.232792] Starting dynamic subtest: pipe-C-plane-0
[599.396841] Dynamic subtest pipe-C-plane-0: SUCCESS (0.180s)
[599.434085] Starting dynamic subtest: pipe-C-plane-1
[599.594784] Dynamic subtest pipe-C-plane-1: SUCCESS (0.191s)
[599.609017] Starting dynamic subtest: pipe-C-plane-2
[599.779235] Dynamic subtest pipe-C-plane-2: SUCCESS (0.183s)
[600.103151] Starting dynamic subtest: pipe-D-plane-0
[600.284515] Dynamic subtest pipe-D-plane-0: SUCCESS (0.213s)
[600.320309] Starting dynamic subtest: pipe-D-plane-1
[600.501159] Dynamic subtest pipe-D-plane-1: SUCCESS (0.209s)
[600.535579] Starting dynamic subtest: pipe-D-plane-2
[600.701142] Dynamic subtest pipe-D-plane-2: SUCCESS (0.192s)
[600.740192] Subtest plane-ctm3x4-lut1d: SUCCESS (3.544s)
[600.954522] [146/156] (445s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[602.444941] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[602.445888] Starting dynamic subtest: pipe-A-HDMI-A-3
[602.454800] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[602.469403] Starting dynamic subtest: pipe-B-HDMI-A-3
[602.478916] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[602.492861] Starting dynamic subtest: pipe-C-HDMI-A-3
[602.501964] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[602.515944] Starting dynamic subtest: pipe-D-HDMI-A-3
[602.525376] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[602.527262] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.010s)
[602.722365] [147/156] (443s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[604.218724] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[604.220522] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[604.389779] [148/156] (442s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[605.883015] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[605.883960] Starting dynamic subtest: pipe-A
[608.564878] Dynamic subtest pipe-A: SUCCESS (2.682s)
[608.588222] Starting dynamic subtest: pipe-B
[611.206424] Dynamic subtest pipe-B: SUCCESS (2.640s)
[611.228728] Starting dynamic subtest: pipe-C
[611.512897] Dynamic subtest pipe-C: SUCCESS (0.304s)
[611.530147] Starting dynamic subtest: pipe-D
[611.820482] Dynamic subtest pipe-D: SUCCESS (0.306s)
[611.821591] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.939s)
[612.082376] [149/156] (434s left) perf (mi-rpc)
[612.207924] Starting subtest: mi-rpc
[612.209647] Subtest mi-rpc: SKIP (0.000s)
[612.294585] [150/156] (434s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[613.789951] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[613.792243] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[613.982991] [151/156] (433s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[615.473179] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[615.557188] [152/156] (431s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[617.052305] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[617.054661] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[617.240835] [153/156] (429s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[618.736959] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[618.739178] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[618.891177] [154/156] (428s left) perf_pmu (busy-accuracy-50)
[618.945813] Starting subtest: busy-accuracy-50
[618.946916] Starting dynamic subtest: rcs0
[620.492947] Dynamic subtest rcs0: SUCCESS (1.546s)
[620.507735] Starting dynamic subtest: bcs0
[622.038974] Dynamic subtest bcs0: SUCCESS (1.544s)
[622.053520] Starting dynamic subtest: vcs0
[623.584864] Dynamic subtest vcs0: SUCCESS (1.544s)
[623.599439] Starting dynamic subtest: vcs1
[625.131895] Dynamic subtest vcs1: SUCCESS (1.545s)
[625.146880] Starting dynamic subtest: vecs0
[626.677014] Dynamic subtest vecs0: SUCCESS (1.544s)
[626.677942] Subtest busy-accuracy-50: SUCCESS (7.731s)
[626.838736] [155/156] (420s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[628.334073] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc
[628.336190] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[628.516518] [156/156] (418s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[630.025958] Starting subtest: yf-tiled-addfb-size-overflow
[630.027731] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[630.202828] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_gtt
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_plane
results: parsing output: 4/ for test: kms_vblank
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_caching
results: parsing output: 7/ for test: kms_chamelium_color
results: parsing output: 8/ for test: gem_wait
results: parsing output: 9/ for test: i915_fb_tiling
results: parsing output: 10/ for test: kms_chamelium_hpd
results: parsing output: 11/ for test: gem_mmap_wc
results: parsing output: 12/ for test: syncobj_basic
results: parsing output: 13/ for test: kms_draw_crc
results: parsing output: 14/ for test: prime_mmap
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: sysfs_heartbeat_interval
results: parsing output: 17/ for test: gem_mmap_gtt
results: parsing output: 18/ for test: api_intel_allocator
results: parsing output: 19/ for test: gem_exec_balancer
results: parsing output: 20/ for test: kms_invalid_mode
results: parsing output: 21/ for test: kms_addfb_basic
results: parsing output: 22/ for test: gen9_exec_parse
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: gem_exec_basic
results: parsing output: 25/ for test: gem_render_copy
results: parsing output: 26/ for test: gem_close
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: i915_pm_rpm
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: drm_read
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: perf_pmu
results: parsing output: 36/ for test: gem_exec_fence
results: parsing output: 37/ for test: kms_chamelium_edid
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: vgem_basic
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_ctx_persistence
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_pxp
results: parsing output: 50/ for test: kms_flip_scaled_crc
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_vblank
results: parsing output: 57/ for test: gem_softpin
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: gem_softpin
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_pm_rpm
results: parsing output: 66/ for test: gem_ctx_isolation
results: parsing output: 67/ for test: kms_prop_blob
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: i915_query
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_exec_parallel
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_render_copy
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_display_modes
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_whisper
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: gem_blits
results: parsing output: 83/ for test: gem_ctx_sseu
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: gem_render_linear_blits
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_mmap_offset
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: drm_read
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_lease
results: parsing output: 92/ for test: i915_drm_fdinfo
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: prime_vgem
results: parsing output: 97/ for test: sw_sync
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: kms_flip_scaled_crc
results: parsing output: 100/ for test: core_setmaster
results: parsing output: 101/ for test: kms_async_flips
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: sw_sync
results: parsing output: 106/ for test: perf
results: parsing output: 107/ for test: kms_psr2_su
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_ppgtt
results: parsing output: 113/ for test: gem_ctx_exec
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: prime_vgem
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: kms_addfb_basic
results: parsing output: 119/ for test: kms_plane_alpha_blend
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_rotation_crc
results: parsing output: 123/ for test: kms_pm_backlight
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_exec_schedule
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: gem_softpin
results: parsing output: 128/ for test: kms_properties
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: gem_lmem_swapping
results: parsing output: 131/ for test: gem_exec_suspend
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_flip
results: parsing output: 134/ for test: syncobj_timeline
results: parsing output: 135/ for test: gem_userptr_blits
results: parsing output: 136/ for test: kms_big_fb
results: parsing output: 137/ for test: api_intel_bb
results: parsing output: 138/ for test: kms_cursor_crc
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_flip
results: parsing output: 141/ for test: kms_plane
results: parsing output: 142/ for test: gem_userptr_blits
results: parsing output: 143/ for test: kms_content_protection
results: parsing output: 144/ for test: kms_color_pipeline
results: parsing output: 145/ for test: kms_ccs
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_plane_scaling
results: parsing output: 148/ for test: perf
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_psr2_sf
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: perf_pmu
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: kms_big_fb
Done.