[67.509478] Initializing watchdogs
[67.509560]   /dev/watchdog0
[67.540871] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[67.556036] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[67.561108] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[67.564714] [001/155] (960s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[69.067810] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[80.073629] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.007s)
[80.260972] [002/155] (947s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[81.857290] Starting subtest: dp-mst-type-1-suspend-resume
[81.860772] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[82.046822] [003/155] (946s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-blt)
[83.545136] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-blt
[83.548352] Subtest hdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[83.683024] [004/155] (944s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[85.197165] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s)
[85.269738] [005/155] (943s left) gem_softpin (full)
[85.328296] Starting subtest: full
[85.350641] Subtest full: SUCCESS (0.022s)
[85.546577] [006/155] (942s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[87.061725] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[88.167365] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.102s)
[88.329945] [007/155] (940s left) syncobj_wait (invalid-single-wait-unsubmitted)
[88.381237] Starting subtest: invalid-single-wait-unsubmitted
[88.383126] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[88.497428] [008/155] (940s left) kms_getfb (getfb-handle-protection)
[89.989922] Starting subtest: getfb-handle-protection
[90.006246] Subtest getfb-handle-protection: SUCCESS (0.019s)
[90.215187] [009/155] (938s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[91.729476] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[91.733088] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[91.894246] [010/155] (936s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[93.404431] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[93.407980] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[93.554540] [011/155] (935s left) kms_prop_blob (invalid-set-prop)
[93.615210] Starting subtest: invalid-set-prop
[93.617190] Subtest invalid-set-prop: SUCCESS (0.000s)
[93.751018] [012/155] (935s left) kms_chamelium_hpd (common-hpd-after-suspend)
[95.289238] Subtest common-hpd-after-suspend: SKIP (0.000s)
[95.414796] [013/155] (933s left) kms_pm_rpm (fences)
[99.833823] Starting subtest: fences
[99.839633] Subtest fences: SKIP (0.000s)
[100.891235] [014/155] (928s left) i915_fb_tiling (basic-x-tiling)
[100.941934] Subtest basic-x-tiling: SKIP (0.000s)
[101.024326] [015/155] (928s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[101.079300] Starting subtest: y-tiled-to-vebox-x-tiled
[101.080915] Starting dynamic subtest: smem
[101.161743] Dynamic subtest smem: SUCCESS (0.082s)
[101.172056] Starting dynamic subtest: lmem0
[101.916401] Dynamic subtest lmem0: SUCCESS (0.751s)
[101.918233] Subtest y-tiled-to-vebox-x-tiled: SUCCESS (0.834s)
[102.196013] [016/155] (927s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[103.692969] Starting subtest: psr-indfb-scaledprimary
[103.696237] Subtest psr-indfb-scaledprimary: SKIP (0.000s)
[103.839525] [017/155] (925s left) kms_fbcon_fbt (psr-suspend)
[103.902436] Starting subtest: psr-suspend
[103.905987] Subtest psr-suspend: SKIP (0.000s)
[104.119025] [018/155] (925s left) gem_userptr_blits (map-fixed-invalidate-busy)
[104.184637] Starting subtest: map-fixed-invalidate-busy
[104.187806] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[104.375766] [019/155] (925s left) gem_exec_fence (syncobj-timeline-unused-fence)
[104.938842] Starting subtest: syncobj-timeline-unused-fence
[104.976231] Subtest syncobj-timeline-unused-fence: SUCCESS (0.035s)
[105.264037] [FACT gem_exec_fence (syncobj-timeline-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[105.266741] [020/155] (924s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-onoff)
[106.763976] Starting subtest: psrhdr-2p-primscrn-cur-indfb-onoff
[106.766700] Subtest psrhdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[106.938270] [021/155] (922s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[108.431093] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[108.433132] Starting dynamic subtest: pipe-A
[111.130641] Dynamic subtest pipe-A: SUCCESS (2.701s)
[111.148221] Starting dynamic subtest: pipe-B
[113.855271] Dynamic subtest pipe-B: SUCCESS (2.724s)
[113.874140] Starting dynamic subtest: pipe-C
[114.179058] Dynamic subtest pipe-C: SUCCESS (0.322s)
[114.192308] Starting dynamic subtest: pipe-D
[114.484948] Dynamic subtest pipe-D: SUCCESS (0.305s)
[114.486490] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (6.057s)
[114.727430] [022/155] (915s left) kms_frontbuffer_tracking (hdr-2p-pri-indfb-multidraw)
[116.229496] Starting subtest: hdr-2p-pri-indfb-multidraw
[116.232517] Subtest hdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[116.394954] [023/155] (913s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[116.447191] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[116.448800] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[116.572720] [024/155] (913s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-pwrite)
[118.070883] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-pwrite
[118.074122] Subtest fbchdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[118.267060] [025/155] (911s left) sw_sync (timeline_closed_signaled)
[118.314251] Starting subtest: timeline_closed_signaled
[118.315996] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[118.410275] [026/155] (911s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-render)
[119.907550] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-render
[119.910572] Subtest fbchdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[120.080748] [027/155] (910s left) gem_busy (close-race)
[120.143992] Starting subtest: close-race
[142.284242] Subtest close-race: SUCCESS (22.140s)
[142.911415] [028/155] (887s left) prime_mmap (test_reprime)
[143.021658] Starting subtest: test_reprime
[143.023318] Starting dynamic subtest: test_reprime-smem
[143.082646] Dynamic subtest test_reprime-smem: SUCCESS (0.064s)
[143.093883] Starting dynamic subtest: test_reprime-lmem0
[143.146659] Dynamic subtest test_reprime-lmem0: SUCCESS (0.063s)
[143.148358] Subtest test_reprime: SUCCESS (0.129s)
[143.296075] [029/155] (887s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-render)
[144.801651] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-render
[144.805032] Subtest hdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[144.959351] [030/155] (885s left) gem_exec_schedule (manyslice)
[145.039202] Starting subtest: manyslice
[145.040614] Starting dynamic subtest: rcs0
[151.087202] Dynamic subtest rcs0: SUCCESS (6.044s)
[151.101882] Starting dynamic subtest: bcs0
[156.978395] Dynamic subtest bcs0: SUCCESS (5.891s)
[156.991712] Starting dynamic subtest: vcs0
[162.488554] Dynamic subtest vcs0: SUCCESS (5.509s)
[162.499871] Starting dynamic subtest: vcs1
[167.999949] Dynamic subtest vcs1: SUCCESS (5.510s)
[168.011103] Starting dynamic subtest: vecs0
[173.996916] Dynamic subtest vecs0: SUCCESS (5.995s)
[173.998447] Subtest manyslice: SUCCESS (28.955s)
[174.435729] [031/155] (856s left) sw_sync (sync_expired_merge)
[174.480979] Starting subtest: sync_expired_merge
[175.557487] Subtest sync_expired_merge: SUCCESS (1.074s)
[175.642705] [032/155] (855s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[177.140894] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[177.143955] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[177.324927] [033/155] (853s left) syncobj_timeline (single-wait-for-submit-signaled)
[177.375845] Starting subtest: single-wait-for-submit-signaled
[177.377415] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[177.515419] [034/155] (853s left) api_intel_bb (reset-bb)
[177.564274] Starting subtest: reset-bb
[177.578936] Subtest reset-bb: SUCCESS (0.016s)
[177.751498] [035/155] (853s left) gem_ctx_param (invalid-ctx-get)
[177.800115] Starting subtest: invalid-ctx-get
[177.801962] Subtest invalid-ctx-get: SUCCESS (0.000s)
[177.928889] [036/155] (853s left) syncobj_basic (bad-fd-to-handle)
[177.977501] Starting subtest: bad-fd-to-handle
[177.979197] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[178.098730] [037/155] (853s left) gem_partial_pwrite_pread (reads)
[178.154848] Subtest reads: SKIP (0.000s)
[178.256795] [038/155] (853s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-move)
[179.757887] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-move
[179.760994] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[179.907632] [039/155] (851s left) gem_exec_reloc (basic-gtt)
[179.971762] Subtest basic-gtt: SKIP (0.000s)
[180.075545] [040/155] (851s left) i915_drm_fdinfo (most-busy-check-all)
[180.128266] Starting subtest: most-busy-check-all
[180.130161] Starting dynamic subtest: rcs0
[180.147239] Dynamic subtest rcs0: SKIP (0.017s)
[180.158867] Starting dynamic subtest: bcs0
[180.162730] Dynamic subtest bcs0: SKIP (0.000s)
[180.174030] Starting dynamic subtest: vcs0
[180.178169] Dynamic subtest vcs0: SKIP (0.000s)
[180.189232] Starting dynamic subtest: vcs1
[180.193234] Dynamic subtest vcs1: SKIP (0.000s)
[180.205214] Starting dynamic subtest: vecs0
[180.209214] Dynamic subtest vecs0: SKIP (0.001s)
[180.213589] Subtest most-busy-check-all: SKIP (0.023s)
[180.278559] [041/155] (851s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[181.800695] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[181.804029] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[181.975812] [042/155] (849s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-blt)
[183.475630] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-blt
[183.478804] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[183.627632] [043/155] (848s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-plflip-blt)
[185.130507] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-plflip-blt
[185.133746] Subtest fbcpsrhdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[185.333575] [044/155] (846s left) gem_pxp (create-valid-protected-context)
[187.906173] Starting subtest: create-valid-protected-context
[187.909740] Subtest create-valid-protected-context: SKIP (0.000s)
[188.019616] [045/155] (844s left) kms_frontbuffer_tracking (psr-slowdraw)
[189.517125] Starting subtest: psr-slowdraw
[189.520166] Subtest psr-slowdraw: SKIP (0.000s)
[189.678851] [046/155] (842s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[191.175201] Starting subtest: flip-vs-cursor-crc-legacy
[191.733250] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.559s)
[191.946025] [047/155] (840s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[193.443495] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[193.446738] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[193.593910] [048/155] (838s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[195.098847] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[195.102111] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[195.282985] [049/155] (837s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[195.340730] Starting subtest: x-tiled-to-vebox-yf-tiled
[195.342727] Starting dynamic subtest: smem
[195.426308] Dynamic subtest smem: SUCCESS (0.085s)
[195.437347] Starting dynamic subtest: lmem0
[196.185943] Dynamic subtest lmem0: SUCCESS (0.755s)
[196.188060] Subtest x-tiled-to-vebox-yf-tiled: SUCCESS (0.842s)
[196.450400] [050/155] (836s left) prime_busy (hang)
[196.505994] Starting subtest: hang
[196.507489] Starting dynamic subtest: rcs0
[222.457404] Dynamic subtest rcs0: SUCCESS (25.949s)
[222.468399] Starting dynamic subtest: bcs0
[229.535272] Dynamic subtest bcs0: SUCCESS (7.079s)
[229.546275] Starting dynamic subtest: vcs0
[236.577088] Dynamic subtest vcs0: SUCCESS (7.041s)
[236.588250] Starting dynamic subtest: vcs1
[243.553984] Dynamic subtest vcs1: SUCCESS (6.976s)
[243.565125] Starting dynamic subtest: vecs0
[250.592181] Dynamic subtest vecs0: SUCCESS (7.037s)
[250.593675] Subtest hang: SUCCESS (54.088s)
[250.734468] [051/155] (781s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[252.252153] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[252.255103] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[252.423532] [052/155] (780s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[253.921823] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[253.924618] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[254.123913] [053/155] (778s left) perf_pmu (busy-accuracy-2)
[254.176320] Starting subtest: busy-accuracy-2
[254.177775] Starting dynamic subtest: rcs0
[257.234507] Dynamic subtest rcs0: SUCCESS (3.056s)
[257.246956] Starting dynamic subtest: bcs0
[260.289565] Dynamic subtest bcs0: SUCCESS (3.054s)
[260.301766] Starting dynamic subtest: vcs0
[263.342744] Dynamic subtest vcs0: SUCCESS (3.052s)
[263.354860] Starting dynamic subtest: vcs1
[266.399702] Dynamic subtest vcs1: SUCCESS (3.056s)
[266.411989] Starting dynamic subtest: vecs0
[269.454824] Dynamic subtest vecs0: SUCCESS (3.054s)
[269.456381] Subtest busy-accuracy-2: SUCCESS (15.277s)
[269.602833] [054/155] (763s left) api_intel_allocator (simple-allocator)
[269.653730] Starting subtest: simple-allocator
[269.655286] Starting dynamic subtest: basic
[269.671584] Dynamic subtest basic: SUCCESS (0.018s)
[269.683970] Starting dynamic subtest: parallel-one
[269.870970] Dynamic subtest parallel-one: SUCCESS (0.195s)
[269.883473] Starting dynamic subtest: print
[269.885153] Dynamic subtest print: SUCCESS (0.000s)
[269.897858] Starting dynamic subtest: reuse
[269.899790] Dynamic subtest reuse: SUCCESS (0.000s)
[269.912223] Starting dynamic subtest: reserve
[269.913985] Dynamic subtest reserve: SUCCESS (0.000s)
[269.925687] Starting dynamic subtest: fork-reopen-allocator
[269.927550] Dynamic subtest fork-reopen-allocator: SUCCESS (0.016s)
[269.929590] Subtest simple-allocator: SUCCESS (0.236s)
[270.049421] [055/155] (762s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[271.540603] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[271.613320] [056/155] (761s left) fbdev (info)
[271.661557] Starting subtest: info
[271.663460] Subtest info: SUCCESS (0.000s)
[271.779110] [057/155] (761s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-render)
[273.278828] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-render
[273.282076] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[273.434152] [058/155] (759s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[274.928322] Starting subtest: short-flip-after-cursor-atomic-transitions
[275.937834] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.011s)
[276.141116] [059/155] (757s left) kms_chamelium_audio (dp-audio)
[277.709399] Subtest dp-audio: SKIP (0.000s)
[277.857146] [060/155] (755s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[279.348795] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[279.350341] Starting dynamic subtest: pipe-A-HDMI-A-4
[279.364358] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.001s)
[279.376911] Starting dynamic subtest: pipe-B-HDMI-A-4
[279.391317] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[279.403336] Starting dynamic subtest: pipe-C-HDMI-A-4
[279.420664] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[279.432683] Starting dynamic subtest: pipe-D-HDMI-A-4
[279.448664] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[279.450340] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.011s)
[279.624870] [061/155] (753s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[281.117284] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[281.307354] [062/155] (752s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[282.809815] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[285.588815] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.785s)
[285.783132] [063/155] (747s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[287.277555] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (0.000s)
[287.349664] [064/155] (746s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[288.840631] Starting subtest: 2x-long-flip-vs-cursor-legacy
[288.843263] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.003s)
[288.971975] [065/155] (744s left) kms_lease (lease-revoke)
[290.472873] Starting subtest: lease-revoke
[290.474533] Starting dynamic subtest: pipe-A-HDMI-A-4
[290.543272] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.067s)
[290.555898] Starting dynamic subtest: pipe-B-HDMI-A-4
[290.596814] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.049s)
[290.609315] Starting dynamic subtest: pipe-C-HDMI-A-4
[290.646317] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.050s)
[290.659735] Starting dynamic subtest: pipe-D-HDMI-A-4
[290.695551] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.049s)
[290.706811] Subtest lease-revoke: SUCCESS (0.224s)
[290.872846] [066/155] (743s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[290.921734] Starting subtest: etime-multi-wait-all-for-submit-submitted
[291.031129] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.107s)
[291.227835] [067/155] (742s left) gem_exec_fence (nb-await)
[291.403747] Starting subtest: nb-await
[291.405289] Starting dynamic subtest: rcs0
[291.492417] Dynamic subtest rcs0: SUCCESS (0.088s)
[291.510711] Starting dynamic subtest: bcs0
[291.561913] Dynamic subtest bcs0: SUCCESS (0.067s)
[291.607889] Starting dynamic subtest: vcs0
[291.657492] Dynamic subtest vcs0: SUCCESS (0.091s)
[291.694892] Starting dynamic subtest: vcs1
[291.742071] Dynamic subtest vcs1: SUCCESS (0.081s)
[291.787761] Starting dynamic subtest: vecs0
[291.839513] Dynamic subtest vecs0: SUCCESS (0.093s)
[291.841553] Subtest nb-await: SUCCESS (0.437s)
[292.503810] [068/155] (741s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[293.991781] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[293.993373] Starting dynamic subtest: pipe-A
[294.106563] Dynamic subtest pipe-A: SUCCESS (0.112s)
[294.122116] Starting dynamic subtest: pipe-B
[294.280585] Dynamic subtest pipe-B: SUCCESS (0.175s)
[294.293177] Starting dynamic subtest: pipe-C
[294.438177] Dynamic subtest pipe-C: SUCCESS (0.156s)
[294.460504] Starting dynamic subtest: pipe-D
[294.594426] Dynamic subtest pipe-D: SUCCESS (0.155s)
[294.596291] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.603s)
[294.815319] [069/155] (739s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[294.871600] Subtest untiled-to-tiled: SKIP (0.000s)
[294.947622] [070/155] (739s left) gem_wait (write-busy)
[295.013317] Starting subtest: write-busy
[295.015239] Starting dynamic subtest: all-engines
[295.591104] Dynamic subtest all-engines: SUCCESS (0.577s)
[295.603817] Starting dynamic subtest: rcs0
[296.132658] Dynamic subtest rcs0: SUCCESS (0.540s)
[296.145218] Starting dynamic subtest: bcs0
[296.673586] Dynamic subtest bcs0: SUCCESS (0.540s)
[296.686167] Starting dynamic subtest: vcs0
[297.214391] Dynamic subtest vcs0: SUCCESS (0.540s)
[297.226862] Starting dynamic subtest: vcs1
[297.756659] Dynamic subtest vcs1: SUCCESS (0.541s)
[297.769524] Starting dynamic subtest: vecs0
[298.298201] Dynamic subtest vecs0: SUCCESS (0.541s)
[298.299586] Subtest write-busy: SUCCESS (3.286s)
[298.568249] [071/155] (735s left) gem_ctx_param (get-priority-new-ctx)
[298.615830] Starting subtest: get-priority-new-ctx
[298.617257] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[298.757798] [072/155] (735s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[300.255696] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[300.259047] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[300.441483] [073/155] (734s left) kms_flip (2x-plain-flip-interruptible)
[301.941902] Starting subtest: 2x-plain-flip-interruptible
[301.959288] Subtest 2x-plain-flip-interruptible: SKIP (0.018s)
[302.079011] [074/155] (732s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-fullscreen)
[303.584709] Starting subtest: hdr-2p-scndscrn-spr-indfb-fullscreen
[303.587831] Subtest hdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[303.773461] [075/155] (730s left) syncobj_basic (create-signaled)
[303.823044] Starting subtest: create-signaled
[303.824990] Subtest create-signaled: SUCCESS (0.000s)
[303.958667] [076/155] (730s left) gem_exec_reloc (basic-wc-active)
[304.014278] Subtest basic-wc-active: SKIP (0.000s)
[304.127531] [077/155] (730s left) i915_query (test-query-geometry-subslices)
[304.188343] Starting subtest: test-query-geometry-subslices
[304.191246] Subtest test-query-geometry-subslices: SKIP (0.000s)
[304.331203] [078/155] (730s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[305.819680] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[305.824651] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[305.945251] [079/155] (729s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt)
[307.452207] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt
[307.455528] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[307.623603] [080/155] (727s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[309.125573] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[309.128953] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[309.244831] [081/155] (726s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[310.753692] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[310.756781] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[311.001375] [082/155] (724s left) syncobj_timeline (host-signal-ordered)
[311.053620] Starting subtest: host-signal-ordered
[311.055527] Subtest host-signal-ordered: SUCCESS (0.001s)
[311.194680] [083/155] (724s left) gem_tiled_fence_blits (basic)
[311.251367] Subtest basic: SKIP (0.000s)
[311.334460] [084/155] (724s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[312.821778] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[312.823263] Starting dynamic subtest: pipe-A-HDMI-A-4
[312.838923] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[312.851533] Starting dynamic subtest: pipe-B-HDMI-A-4
[312.867455] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[312.879500] Starting dynamic subtest: pipe-C-HDMI-A-4
[312.895935] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[312.908173] Starting dynamic subtest: pipe-D-HDMI-A-4
[312.926899] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[312.930633] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[313.102391] [085/155] (722s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[314.613126] Starting subtest: yf-tiled-addfb-size-offset-overflow
[314.616847] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[314.865213] [086/155] (721s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[316.357563] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[316.359464] Starting dynamic subtest: pipe-A-valid-mode
[318.873243] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.514s)
[318.875016] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SUCCESS (2.516s)
[319.080828] [087/155] (716s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[320.580989] Starting subtest: fbcpsr-2p-rte
[320.584889] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[320.715114] [088/155] (715s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[322.204889] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[322.206490] Starting dynamic subtest: pipe-A-HDMI-A-4
[322.221796] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[322.234184] Starting dynamic subtest: pipe-B-HDMI-A-4
[322.249906] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[322.262222] Starting dynamic subtest: pipe-C-HDMI-A-4
[322.281115] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[322.293609] Starting dynamic subtest: pipe-D-HDMI-A-4
[322.313292] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[322.316920] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.010s)
[322.485305] [089/155] (713s left) kms_plane (planar-pixel-format-settings)
[323.980167] Starting subtest: planar-pixel-format-settings
[323.981552] Starting dynamic subtest: nv12-odd-width
[324.020989] Dynamic subtest nv12-odd-width: SUCCESS (0.043s)
[324.033375] Starting dynamic subtest: nv12-odd-height
[324.037326] Dynamic subtest nv12-odd-height: SUCCESS (0.015s)
[324.049641] Starting dynamic subtest: nv12-odd-horizontal-pan
[324.055920] Dynamic subtest nv12-odd-horizontal-pan: SUCCESS (0.016s)
[324.068260] Starting dynamic subtest: p016-odd-vertical-pan
[324.111983] Dynamic subtest p016-odd-vertical-pan: SUCCESS (0.054s)
[324.124870] Starting dynamic subtest: nv12-tile4-src-y
[324.127855] Dynamic subtest nv12-tile4-src-y: SKIP (0.000s)
[324.129383] Subtest planar-pixel-format-settings: SUCCESS (0.135s)
[324.296899] [090/155] (711s left) gem_exec_create (forked)
[324.356860] Starting subtest: forked
[324.358401] Starting dynamic subtest: smem
[344.498737] Dynamic subtest smem: SUCCESS (20.141s)
[344.519031] Starting dynamic subtest: lmem0
[364.651093] Dynamic subtest lmem0: SUCCESS (20.150s)
[364.652834] Subtest forked: SUCCESS (40.295s)
[364.988969] [091/155] (671s left) kms_dp_linktrain_fallback (dp-fallback)
[366.485471] Starting subtest: dp-fallback
[366.490212] Subtest dp-fallback: SKIP (0.000s)
[366.605084] [092/155] (669s left) gem_exec_params (invalid-bsd1-flag-on-render)
[366.666370] Starting subtest: invalid-bsd1-flag-on-render
[366.668088] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[366.851981] [093/155] (669s left) sysfs_timeslice_duration (timeout)
[366.906099] Starting subtest: timeout
[366.907811] Starting dynamic subtest: vecs0
[368.433940] Dynamic subtest vecs0: SUCCESS (1.526s)
[368.446775] Starting dynamic subtest: vcs0
[369.915044] Dynamic subtest vcs0: SUCCESS (1.479s)
[369.927638] Starting dynamic subtest: bcs0
[370.761394] Dynamic subtest bcs0: SUCCESS (0.845s)
[370.774124] Starting dynamic subtest: rcs0
[371.600358] Dynamic subtest rcs0: SUCCESS (0.837s)
[371.612951] Starting dynamic subtest: vcs1
[373.094181] Dynamic subtest vcs1: SUCCESS (1.492s)
[373.096049] Subtest timeout: SUCCESS (6.187s)
[373.235135] [094/155] (663s left) kms_cursor_crc (cursor-sliding-64x64)
[374.853026] Starting subtest: cursor-sliding-64x64
[374.860522] Starting dynamic subtest: pipe-A-HDMI-A-4
[379.286766] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.427s)
[379.321641] Starting dynamic subtest: pipe-D-HDMI-A-4
[383.646488] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.335s)
[383.647968] Subtest cursor-sliding-64x64: SUCCESS (8.792s)
[384.176779] [095/155] (652s left) gem_ctx_shared (q-out-order)
[384.237298] Starting subtest: Q-out-order
[384.239123] Starting dynamic subtest: rcs0
[384.433541] Dynamic subtest rcs0: SUCCESS (0.192s)
[384.446622] Starting dynamic subtest: bcs0
[384.571831] Dynamic subtest bcs0: SUCCESS (0.137s)
[384.584538] Starting dynamic subtest: vcs0
[384.699581] Dynamic subtest vcs0: SUCCESS (0.126s)
[384.711931] Starting dynamic subtest: vcs1
[384.835163] Dynamic subtest vcs1: SUCCESS (0.134s)
[384.847241] Starting dynamic subtest: vecs0
[384.971807] Dynamic subtest vecs0: SUCCESS (0.136s)
[384.973281] Subtest Q-out-order: SUCCESS (0.733s)
[385.342980] [096/155] (651s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[386.845119] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[386.849039] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[387.037559] [097/155] (649s left) kms_psr (pr-suspend)
[388.528786] Subtest pr-suspend: SKIP (0.000s)
[388.610461] [098/155] (648s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[390.119538] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[391.397443] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.277s)
[391.615725] [099/155] (645s left) dmabuf (all-tests)
[391.666589] Starting subtest: all-tests
[391.669845] Subtest all-tests: SKIP (0.000s)
[391.769377] [100/155] (645s left) gem_mmap_gtt (ptrace)
[391.839954] Subtest ptrace: SKIP (0.000s)
[391.911779] [101/155] (645s left) kms_cursor_crc (cursor-sliding-256x256)
[393.625056] Starting subtest: cursor-sliding-256x256
[393.632533] Starting dynamic subtest: pipe-A-HDMI-A-4
[398.001520] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.370s)
[398.037113] Starting dynamic subtest: pipe-D-HDMI-A-4
[402.368314] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.334s)
[402.369870] Subtest cursor-sliding-256x256: SUCCESS (8.734s)
[402.728019] [102/155] (634s left) gem_exec_whisper (basic-queues-forked)
[402.789947] Starting subtest: basic-queues-forked
[416.615427] Subtest basic-queues-forked: SUCCESS (13.820s)
[416.911359] [103/155] (620s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[416.960516] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[416.962216] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[417.098749] [104/155] (620s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-render)
[418.616178] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-render
[418.619279] Subtest hdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[418.796097] [105/155] (618s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[420.291890] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[420.300456] Starting dynamic subtest: A-HDMI-A4
[421.076433] Dynamic subtest A-HDMI-A4: SUCCESS (0.775s)
[421.089219] Starting dynamic subtest: B-HDMI-A4
[421.794955] Dynamic subtest B-HDMI-A4: SUCCESS (0.717s)
[421.807718] Starting dynamic subtest: C-HDMI-A4
[422.509647] Dynamic subtest C-HDMI-A4: SUCCESS (0.712s)
[422.522688] Starting dynamic subtest: D-HDMI-A4
[423.225736] Dynamic subtest D-HDMI-A4: SUCCESS (0.714s)
[423.227354] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (2.933s)
[423.432998] [106/155] (614s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[424.940215] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[424.942854] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[425.129633] [107/155] (612s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[426.644638] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[426.648235] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[426.815263] [108/155] (611s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[428.314565] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[428.317816] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[428.535518] [109/155] (609s left) gen9_exec_parse (secure-batches)
[428.592087] Subtest secure-batches: SKIP (0.000s)
[428.667704] [110/155] (609s left) kms_fb_coherency (memset-crc)
[430.157692] Starting subtest: memset-crc
[430.159258] Starting dynamic subtest: mmap-offset-fixed
[430.737875] Dynamic subtest mmap-offset-fixed: SUCCESS (0.579s)
[430.792874] Subtest memset-crc: SUCCESS (0.636s)
[431.005471] [111/155] (607s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[432.506189] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[432.509684] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[432.667109] [112/155] (605s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-y)
[434.168256] Starting subtest: fbcpsrhdr-tiling-y
[434.171730] Subtest fbcpsrhdr-tiling-y: SKIP (0.000s)
[434.341073] [113/155] (604s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[435.841088] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[435.844645] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[436.044516] [114/155] (602s left) perf_pmu (gt-awake)
[436.103316] Starting subtest: gt-awake
[439.377221] Subtest gt-awake: SUCCESS (3.274s)
[439.532748] [115/155] (599s left) kms_vblank (wait-busy-hang)
[441.042163] Starting subtest: wait-busy-hang
[441.043801] Starting dynamic subtest: pipe-A-HDMI-A-4
[467.486835] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (26.442s)
[467.503170] Starting dynamic subtest: pipe-D-HDMI-A-4
[492.424907] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (24.934s)
[492.426419] Subtest wait-busy-hang: SUCCESS (51.384s)
[492.639912] [116/155] (546s left) gem_exec_schedule (timeslicing)
[492.701116] Starting subtest: timeslicing
[492.702771] Starting dynamic subtest: rcs0
[492.723202] Dynamic subtest rcs0: SUCCESS (0.023s)
[492.736053] Starting dynamic subtest: bcs0
[492.743622] Dynamic subtest bcs0: SUCCESS (0.019s)
[492.756315] Starting dynamic subtest: vcs0
[492.765286] Dynamic subtest vcs0: SUCCESS (0.020s)
[492.778058] Starting dynamic subtest: vcs1
[492.786077] Dynamic subtest vcs1: SUCCESS (0.019s)
[492.798945] Starting dynamic subtest: vecs0
[492.807714] Dynamic subtest vecs0: SUCCESS (0.020s)
[492.809388] Subtest timeslicing: SUCCESS (0.108s)
[493.205550] [117/155] (545s left) gem_exec_balancer (bonded-false-hang)
[493.580526] Starting subtest: bonded-false-hang
[493.584161] Subtest bonded-false-hang: SKIP (0.000s)
[493.696989] [118/155] (545s left) kms_cursor_crc (cursor-dpms)
[495.251052] Starting subtest: cursor-dpms
[495.255057] Starting dynamic subtest: pipe-A-HDMI-A-4
[496.346814] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (1.093s)
[496.362630] Starting dynamic subtest: pipe-D-HDMI-A-4
[497.254940] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.906s)
[497.256396] Subtest cursor-dpms: SUCCESS (2.004s)
[497.888011] [119/155] (541s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[499.385611] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[499.404592] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.017s)
[499.562596] [120/155] (539s left) kms_scaling_modes (scaling-mode-full-aspect)
[501.055457] Starting subtest: scaling-mode-full-aspect
[501.064294] Subtest scaling-mode-full-aspect: SKIP (0.001s)
[501.168642] [121/155] (537s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[502.667142] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[503.684672] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.017s)
[503.886362] [122/155] (535s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[505.384869] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[505.387831] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[505.596917] [123/155] (533s left) kms_chamelium_frames (dp-crc-fast)
[507.137293] Subtest dp-crc-fast: SKIP (0.000s)
[507.265617] [124/155] (532s left) gem_exec_store (dword)
[507.326567] Starting subtest: dword
[507.328356] Starting dynamic subtest: rcs0
[507.391242] Dynamic subtest rcs0: SUCCESS (0.064s)
[507.407861] Starting dynamic subtest: bcs0
[507.434469] Dynamic subtest bcs0: SUCCESS (0.041s)
[507.467838] Starting dynamic subtest: vcs0
[507.481124] Dynamic subtest vcs0: SUCCESS (0.044s)
[507.504755] Starting dynamic subtest: vcs1
[507.524998] Dynamic subtest vcs1: SUCCESS (0.042s)
[507.541205] Starting dynamic subtest: vecs0
[507.567087] Dynamic subtest vecs0: SUCCESS (0.040s)
[507.569176] Subtest dword: SUCCESS (0.241s)
[507.905631] [125/155] (531s left) prime_mmap_coherency (write)
[507.959850] Starting subtest: write
[513.366882] Subtest write: SUCCESS (5.404s)
[513.538520] [126/155] (525s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[515.027912] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[515.031257] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[515.205651] [127/155] (524s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[516.708767] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[516.711802] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[516.866621] [128/155] (522s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[518.378761] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[518.981575] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.603s)
[519.197318] [129/155] (520s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[520.706334] Starting subtest: 4-tiled-16bpp-rotate-270
[520.709435] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.000s)
[520.861890] [130/155] (519s left) kms_psr (fbc-psr-primary-page-flip)
[522.355959] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[522.431876] [131/155] (517s left) gem_ctx_isolation (preservation-s3)
[522.492961] Starting subtest: preservation-S3
[522.494503] Starting dynamic subtest: rcs0
[544.021240] Dynamic subtest rcs0: SUCCESS (10.783s)
[544.037067] Starting dynamic subtest: bcs0
[565.948485] Dynamic subtest bcs0: SUCCESS (10.608s)
[565.965512] Starting dynamic subtest: vcs0
[587.943602] Dynamic subtest vcs0: SUCCESS (10.622s)
[587.959922] Starting dynamic subtest: vcs1
[609.940189] Dynamic subtest vcs1: SUCCESS (10.555s)
[609.956496] Starting dynamic subtest: vecs0
[631.941125] Dynamic subtest vecs0: SUCCESS (10.491s)
[631.944502] Subtest preservation-S3: SUCCESS (53.067s)
[637.302552] [132/155] (407s left) kms_psr (psr2-primary-page-flip)
[638.796657] Subtest psr2-primary-page-flip: SKIP (0.000s)
[638.880328] [133/155] (406s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[640.374264] Starting subtest: plane-lut1d-ctm3x4
[640.567143] Starting dynamic subtest: pipe-A-plane-0
[640.830651] Dynamic subtest pipe-A-plane-0: SUCCESS (0.264s)
[640.856080] Starting dynamic subtest: pipe-A-plane-1
[641.019625] Dynamic subtest pipe-A-plane-1: SUCCESS (0.181s)
[641.058113] Starting dynamic subtest: pipe-A-plane-2
[641.218437] Dynamic subtest pipe-A-plane-2: SUCCESS (0.193s)
[641.544005] Starting dynamic subtest: pipe-B-plane-0
[641.694974] Dynamic subtest pipe-B-plane-0: SUCCESS (0.180s)
[641.735497] Starting dynamic subtest: pipe-B-plane-1
[641.895408] Dynamic subtest pipe-B-plane-1: SUCCESS (0.192s)
[641.935634] Starting dynamic subtest: pipe-B-plane-2
[642.097732] Dynamic subtest pipe-B-plane-2: SUCCESS (0.192s)
[642.429262] Starting dynamic subtest: pipe-C-plane-0
[642.609837] Dynamic subtest pipe-C-plane-0: SUCCESS (0.213s)
[642.654748] Starting dynamic subtest: pipe-C-plane-1
[642.824257] Dynamic subtest pipe-C-plane-1: SUCCESS (0.209s)
[642.861836] Starting dynamic subtest: pipe-C-plane-2
[643.040757] Dynamic subtest pipe-C-plane-2: SUCCESS (0.209s)
[643.365777] Starting dynamic subtest: pipe-D-plane-0
[643.531632] Dynamic subtest pipe-D-plane-0: SUCCESS (0.197s)
[643.567622] Starting dynamic subtest: pipe-D-plane-1
[643.748495] Dynamic subtest pipe-D-plane-1: SUCCESS (0.209s)
[643.790267] Starting dynamic subtest: pipe-D-plane-2
[643.964870] Dynamic subtest pipe-D-plane-2: SUCCESS (0.209s)
[644.003076] Subtest plane-lut1d-ctm3x4: SUCCESS (3.631s)
[644.211342] [134/155] (401s left) gem_lmem_swapping (verify-random)
[648.617632] Starting subtest: verify-random
[648.619940] Starting dynamic subtest: lmem0
[658.589339] Dynamic subtest lmem0: SUCCESS (9.969s)
[658.590685] Subtest verify-random: SUCCESS (9.971s)
[659.578400] [FACT gem_lmem_swapping (verify-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[659.579545] [FACT gem_lmem_swapping (verify-random)] deleted: kernel.kmod_is_loaded.i915: true
[659.582493] [135/155] (385s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[664.294776] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[664.296503] Starting dynamic subtest: pipe-A-valid-mode
[666.897088] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.602s)
[666.898430] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SUCCESS (2.605s)
[667.068126] [FACT kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[667.071504] [FACT kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)] new: kernel.kmod_is_loaded.i915: true
[667.075618] [136/155] (378s left) gem_exec_balancer (persistence)
[667.510620] Starting subtest: persistence
[669.554420] Subtest persistence: SUCCESS (2.040s)
[669.766191] [137/155] (375s left) kms_sequence (get-idle)
[671.259709] Starting subtest: get-idle
[671.261126] Starting dynamic subtest: pipe-A-HDMI-A-4
[673.700046] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.439s)
[673.716526] Starting dynamic subtest: pipe-B-HDMI-A-4
[675.943105] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.240s)
[675.957715] Starting dynamic subtest: pipe-C-HDMI-A-4
[678.190550] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.244s)
[678.205753] Starting dynamic subtest: pipe-D-HDMI-A-4
[680.426526] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.234s)
[680.427951] Subtest get-idle: SUCCESS (9.167s)
[680.630032] [138/155] (365s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-pwrite)
[682.128729] Starting subtest: fbchdr-rgb565-draw-pwrite
[682.131571] Subtest fbchdr-rgb565-draw-pwrite: SKIP (0.000s)
[682.308497] [139/155] (363s left) i915_pm_rc6_residency (rc6-accuracy)
[682.358521] Starting subtest: rc6-accuracy
[682.360350] Starting dynamic subtest: gt0
[685.534999] Dynamic subtest gt0: SUCCESS (3.170s)
[685.536531] Subtest rc6-accuracy: SUCCESS (3.175s)
[685.653120] [140/155] (360s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[687.151341] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[687.154172] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[687.311736] [141/155] (358s left) kms_pipe_crc_basic (read-crc)
[688.818882] Starting subtest: read-crc
[688.820843] Starting dynamic subtest: pipe-A-HDMI-A-4
[689.482925] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.675s)
[689.500763] Starting dynamic subtest: pipe-B-HDMI-A-4
[690.029714] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.542s)
[690.044195] Starting dynamic subtest: pipe-C-HDMI-A-4
[690.503397] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.471s)
[690.517527] Starting dynamic subtest: pipe-D-HDMI-A-4
[691.023756] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.518s)
[691.025238] Subtest read-crc: SUCCESS (2.218s)
[691.249692] [142/155] (354s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[692.760711] Starting subtest: y-tiled-32bpp-rotate-90
[694.674786] Subtest y-tiled-32bpp-rotate-90: SUCCESS (1.910s)
[694.935703] [143/155] (351s left) gem_create (create-ext-set-pat)
[695.124534] Starting subtest: create-ext-set-pat
[695.129839] Subtest create-ext-set-pat: SKIP (0.000s)
[695.252980] [144/155] (350s left) gem_ctx_persistence (smoketest)
[695.310385] Starting subtest: smoketest
[734.364501] Subtest smoketest: SUCCESS (39.052s)
[734.513243] [145/155] (311s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[736.009969] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[736.029164] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.018s)
[736.157121] [146/155] (310s left) kms_flip (2x-wf_vblank-ts-check)
[737.658161] Starting subtest: 2x-wf_vblank-ts-check
[737.675192] Subtest 2x-wf_vblank-ts-check: SKIP (0.017s)
[737.803509] [147/155] (308s left) gem_workarounds (basic-read)
[737.897841] Starting subtest: basic-read
[737.928019] Subtest basic-read: SUCCESS (0.029s)
[738.100838] [148/155] (308s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[739.598106] Starting subtest: invalid-modeset-force-ultra-joiner
[739.601379] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[739.721592] [149/155] (306s left) kms_frontbuffer_tracking (fbchdr-farfromfence-mmap-gtt)
[741.230132] Starting subtest: fbchdr-farfromfence-mmap-gtt
[741.233203] Subtest fbchdr-farfromfence-mmap-gtt: SKIP (0.000s)
[741.434852] [150/155] (305s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[742.932376] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[742.935158] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[743.141922] [151/155] (303s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[744.656910] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[744.661364] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[744.871591] [152/155] (302s left) kms_rotation_crc (exhaust-fences)
[746.364704] Starting subtest: exhaust-fences
[746.368200] Subtest exhaust-fences: SKIP (0.000s)
[746.481994] [153/155] (300s left) gem_eio (throttle)
[746.685806] Starting subtest: throttle
[746.977545] Subtest throttle: SUCCESS (0.290s)
[748.571548] [154/155] (298s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-render)
[750.073488] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-render
[750.078655] Subtest psrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[750.261039] [155/155] (297s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt)
[751.758518] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt
[751.761645] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[751.932546] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: kms_content_protection
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: gem_softpin
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: kms_getfb
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_prop_blob
results: parsing output: 11/ for test: kms_chamelium_hpd
results: parsing output: 12/ for test: kms_pm_rpm
results: parsing output: 13/ for test: i915_fb_tiling
results: parsing output: 14/ for test: gem_render_copy
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_fbcon_fbt
results: parsing output: 17/ for test: gem_userptr_blits
results: parsing output: 18/ for test: gem_exec_fence
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_plane_scaling
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: sw_sync
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_busy
results: parsing output: 27/ for test: prime_mmap
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: sw_sync
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: api_intel_bb
results: parsing output: 34/ for test: gem_ctx_param
results: parsing output: 35/ for test: syncobj_basic
results: parsing output: 36/ for test: gem_partial_pwrite_pread
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_exec_reloc
results: parsing output: 39/ for test: i915_drm_fdinfo
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_pxp
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_render_copy
results: parsing output: 49/ for test: prime_busy
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: perf_pmu
results: parsing output: 53/ for test: api_intel_allocator
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: fbdev
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: kms_chamelium_audio
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_addfb_basic
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_psr2_sf
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: kms_lease
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: gem_exec_fence
results: parsing output: 67/ for test: kms_plane_scaling
results: parsing output: 68/ for test: gem_set_tiling_vs_blt
results: parsing output: 69/ for test: gem_wait
results: parsing output: 70/ for test: gem_ctx_param
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: syncobj_basic
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: i915_query
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: gem_tiled_fence_blits
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_flip_scaled_crc
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_plane
results: parsing output: 89/ for test: gem_exec_create
results: parsing output: 90/ for test: kms_dp_linktrain_fallback
results: parsing output: 91/ for test: gem_exec_params
results: parsing output: 92/ for test: sysfs_timeslice_duration
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: gem_ctx_shared
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: dmabuf
results: parsing output: 99/ for test: gem_mmap_gtt
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: gem_exec_whisper
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: gen9_exec_parse
results: parsing output: 109/ for test: kms_fb_coherency
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: kms_vblank
results: parsing output: 115/ for test: gem_exec_schedule
results: parsing output: 116/ for test: gem_exec_balancer
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: kms_scaling_modes
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_chamelium_frames
results: parsing output: 123/ for test: gem_exec_store
results: parsing output: 124/ for test: prime_mmap_coherency
results: parsing output: 125/ for test: kms_plane
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: gem_ctx_isolation
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: kms_color_pipeline
results: parsing output: 133/ for test: gem_lmem_swapping
results: parsing output: 134/ for test: kms_flip_scaled_crc
results: parsing output: 135/ for test: gem_exec_balancer
results: parsing output: 136/ for test: kms_sequence
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: i915_pm_rc6_residency
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_pipe_crc_basic
results: parsing output: 141/ for test: kms_big_fb
results: parsing output: 142/ for test: gem_create
results: parsing output: 143/ for test: gem_ctx_persistence
results: parsing output: 144/ for test: kms_flip
results: parsing output: 145/ for test: kms_flip
results: parsing output: 146/ for test: gem_workarounds
results: parsing output: 147/ for test: kms_joiner
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_big_fb
results: parsing output: 151/ for test: kms_rotation_crc
results: parsing output: 152/ for test: gem_eio
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.