[60.675986] Initializing watchdogs
[60.676062]   /dev/watchdog0
[60.695341] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[60.705850] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[60.709677] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.711988] [001/131] (960s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[60.904484] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[60.906512] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[61.108603] [002/131] (960s left) gem_exec_fence (submit3)
[61.313262] Starting subtest: submit3
[61.315199] Subtest submit3: SKIP (0.000s)
[62.107008] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true
[62.108585] [003/131] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[62.300515] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[62.302186] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[62.497556] [004/131] (958s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[62.690616] Starting subtest: fbc-rgb101010-draw-mmap-wc
[62.692295] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s)
[62.878604] [005/131] (958s left) gem_exec_balancer (noheartbeat)
[63.251704] Starting subtest: noheartbeat
[63.253441] Subtest noheartbeat: SKIP (0.000s)
[63.410081] [006/131] (958s left) kms_chamelium_color (ctm-blue-to-red)
[63.598543] Subtest ctm-blue-to-red: SKIP (0.000s)
[63.656880] [007/131] (957s left) gem_workarounds (suspend-resume)
[63.750587] Starting subtest: suspend-resume
[82.968941] Subtest suspend-resume: SUCCESS (3.809s)
[83.105316] [008/131] (938s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[83.304254] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[83.305000] Starting dynamic subtest: pipe-A
[83.407185] Dynamic subtest pipe-A: SUCCESS (0.104s)
[83.420484] Starting dynamic subtest: pipe-B
[83.621347] Dynamic subtest pipe-B: SUCCESS (0.214s)
[83.639630] Starting dynamic subtest: pipe-C
[83.835266] Dynamic subtest pipe-C: SUCCESS (0.214s)
[83.850802] Starting dynamic subtest: pipe-D
[84.031214] Dynamic subtest pipe-D: SUCCESS (0.196s)
[84.032161] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (0.728s)
[84.407907] [009/131] (937s left) gem_pxp (create-regular-buffer)
[87.011406] Starting subtest: create-regular-buffer
[87.013510] Subtest create-regular-buffer: SKIP (0.000s)
[87.189065] [010/131] (934s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[87.269069] Starting subtest: rel-constants-invalid-rel-gen5
[87.269958] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[87.455428] [011/131] (934s left) gem_exec_nop (basic-series)
[87.547637] Starting subtest: basic-series
[91.891136] Subtest basic-series: SUCCESS (4.343s)
[92.168664] [012/131] (929s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[92.358846] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[92.360535] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[92.545829] [013/131] (929s left) kms_psr (fbc-psr-primary-page-flip)
[92.729898] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[92.782336] [014/131] (929s left) i915_pm_rps (engine-order)
[92.873698] Starting subtest: engine-order
[103.598321] Subtest engine-order: SUCCESS (10.724s)
[103.794397] [015/131] (918s left) gem_softpin (evict-active)
[103.884348] Starting subtest: evict-active
[103.900400] Subtest evict-active: SUCCESS (0.016s)
[104.089183] [016/131] (918s left) syncobj_timeline (wait-delayed-signal)
[104.166549] Starting subtest: wait-delayed-signal
[104.269378] Subtest wait-delayed-signal: SUCCESS (0.102s)
[104.413599] [017/131] (917s left) kms_panel_fitting (atomic-fastset)
[104.596891] Starting subtest: atomic-fastset
[104.598638] Subtest atomic-fastset: SKIP (0.000s)
[104.755036] [018/131] (917s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[104.951148] Starting subtest: x-tiled-16bpp-rotate-270
[105.009314] Subtest x-tiled-16bpp-rotate-270: SKIP (0.058s)
[105.225574] [019/131] (917s left) api_intel_bb (render-ccs)
[105.301569] Starting subtest: render-ccs
[105.400526] Subtest render-ccs: SUCCESS (0.099s)
[105.636167] [020/131] (916s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[105.819065] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[105.819933] Starting dynamic subtest: pipe-A-DP-3
[105.828388] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[105.839452] Starting dynamic subtest: pipe-B-DP-3
[105.848099] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[105.859156] Starting dynamic subtest: pipe-C-DP-3
[105.867540] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[105.878308] Starting dynamic subtest: pipe-D-DP-3
[105.888439] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[105.890390] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[106.282635] [021/131] (916s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[106.366333] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[106.468826] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.101s)
[106.612453] [022/131] (916s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[106.800794] Starting subtest: psr-2p-primscrn-cur-indfb-move
[106.802522] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[107.000840] [023/131] (915s left) gem_lmem_swapping (heavy-multi)
[109.738277] Starting subtest: heavy-multi
[109.739213] Starting dynamic subtest: lmem0
[115.081673] Dynamic subtest lmem0: SUCCESS (5.346s)
[115.082588] Subtest heavy-multi: SUCCESS (5.346s)
[116.405893] [FACT gem_lmem_swapping (heavy-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[116.406814] [FACT gem_lmem_swapping (heavy-multi)] deleted: kernel.kmod_is_loaded.i915: true
[116.408442] [024/131] (906s left) kms_async_flips (test-cursor)
[118.053249] Starting subtest: test-cursor
[118.258040] Starting dynamic subtest: pipe-A-DP-3
[118.565072] Dynamic subtest pipe-A-DP-3: SUCCESS (0.307s)
[118.836786] Starting dynamic subtest: pipe-B-DP-3
[118.954305] Dynamic subtest pipe-B-DP-3: SUCCESS (0.128s)
[119.167790] Starting dynamic subtest: pipe-C-DP-3
[119.261621] Dynamic subtest pipe-C-DP-3: SUCCESS (0.104s)
[119.470888] Starting dynamic subtest: pipe-D-DP-3
[119.572771] Dynamic subtest pipe-D-DP-3: SUCCESS (0.112s)
[119.573655] Subtest test-cursor: SUCCESS (1.520s)
[120.138818] [FACT kms_async_flips (test-cursor)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[120.141258] [FACT kms_async_flips (test-cursor)] new: kernel.kmod_is_loaded.i915: true
[120.143833] [025/131] (902s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[120.340371] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[120.435114] [026/131] (902s left) kms_plane_multiple (2x-tiling-4)
[120.618181] Starting subtest: 2x-tiling-4
[120.619889] Subtest 2x-tiling-4: SKIP (0.000s)
[120.792265] [027/131] (902s left) gem_ctx_param (invalid-param-set)
[120.865817] Starting subtest: invalid-param-set
[120.866764] Subtest invalid-param-set: SUCCESS (0.000s)
[121.039071] [028/131] (902s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[121.227365] Starting subtest: bad-pixel-format-y-tiled-ccs
[121.228330] Starting dynamic subtest: pipe-A-DP-3
[121.236579] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[121.247452] Starting dynamic subtest: pipe-B-DP-3
[121.255923] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[121.266467] Starting dynamic subtest: pipe-C-DP-3
[121.274673] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[121.285125] Starting dynamic subtest: pipe-D-DP-3
[121.296522] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[121.298751] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[121.694121] [029/131] (901s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[121.882821] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[121.883677] Starting dynamic subtest: pipe-A
[122.459811] Dynamic subtest pipe-A: SUCCESS (0.577s)
[122.478432] Starting dynamic subtest: pipe-B
[123.088804] Dynamic subtest pipe-B: SUCCESS (0.628s)
[123.112659] Starting dynamic subtest: pipe-C
[123.734707] Dynamic subtest pipe-C: SUCCESS (0.645s)
[123.754995] Starting dynamic subtest: pipe-D
[124.379942] Dynamic subtest pipe-D: SUCCESS (0.644s)
[124.381081] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (2.497s)
[124.743493] [030/131] (898s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[124.822420] Starting subtest: multi-wait-all-available-submitted-signaled
[124.823419] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[125.026426] [031/131] (898s left) perf (missing-sample-flags)
[125.434785] Starting subtest: missing-sample-flags
[125.435635] Subtest missing-sample-flags: SUCCESS (0.000s)
[125.487698] [032/131] (898s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[125.679929] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[128.743516] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (3.064s)
[128.970778] [033/131] (894s left) kms_pm_rpm (system-suspend-idle)
[131.424051] Starting subtest: system-suspend-idle
[151.343322] Subtest system-suspend-idle: SUCCESS (5.375s)
[151.750499] [034/131] (871s left) kms_vblank (wait-forked)
[151.936978] Starting subtest: wait-forked
[151.939023] Starting dynamic subtest: pipe-A-DP-3
[154.332008] Dynamic subtest pipe-A-DP-3: SUCCESS (2.391s)
[154.366192] Starting dynamic subtest: pipe-D-DP-3
[156.662796] Dynamic subtest pipe-D-DP-3: SUCCESS (2.316s)
[156.663812] Subtest wait-forked: SUCCESS (4.723s)
[156.960795] [035/131] (866s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[157.158944] Starting subtest: y-tiled-32bpp-rotate-0
[157.160796] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[157.359864] [036/131] (866s left) kms_pipe_crc_basic (read-crc)
[157.545116] Starting subtest: read-crc
[157.547030] Starting dynamic subtest: pipe-A-DP-3
[158.182394] Dynamic subtest pipe-A-DP-3: SUCCESS (0.636s)
[158.201563] Starting dynamic subtest: pipe-B-DP-3
[158.738690] Dynamic subtest pipe-B-DP-3: SUCCESS (0.553s)
[158.756468] Starting dynamic subtest: pipe-C-DP-3
[159.328955] Dynamic subtest pipe-C-DP-3: SUCCESS (0.588s)
[159.344087] Starting dynamic subtest: pipe-D-DP-3
[159.890104] Dynamic subtest pipe-D-DP-3: SUCCESS (0.558s)
[159.891105] Subtest read-crc: SUCCESS (2.343s)
[160.185773] [037/131] (863s left) kms_cursor_legacy (single-move)
[160.372284] Starting subtest: single-move
[160.373145] Starting dynamic subtest: pipe-A
[165.754817] Dynamic subtest pipe-A: SUCCESS (5.380s)
[165.766988] Starting dynamic subtest: pipe-B
[171.135143] Dynamic subtest pipe-B: SUCCESS (5.379s)
[171.146978] Starting dynamic subtest: pipe-C
[176.514896] Dynamic subtest pipe-C: SUCCESS (5.378s)
[176.526666] Starting dynamic subtest: pipe-D
[181.894599] Dynamic subtest pipe-D: SUCCESS (5.378s)
[181.906542] Starting dynamic subtest: all-pipes
[187.274789] Dynamic subtest all-pipes: SUCCESS (5.379s)
[187.275691] Subtest single-move: SUCCESS (26.898s)
[187.408843] [038/131] (836s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[187.604141] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[187.652744] [039/131] (836s left) gem_unref_active_buffers
[188.069391] [040/131] (836s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[188.256123] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.000s)
[188.321757] [041/131] (835s left) syncobj_wait (invalid-signal-zero-handles)
[188.402684] Starting subtest: invalid-signal-zero-handles
[188.403600] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[188.602767] [042/131] (835s left) gen9_exec_parse (bb-oversize)
[188.702619] Subtest bb-oversize: SKIP (0.000s)
[188.827078] [043/131] (835s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[188.904878] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[189.020185] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.106s)
[189.182667] [044/131] (835s left) gem_exec_reloc (basic-write-cpu-noreloc)
[189.264118] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[189.366419] [045/131] (835s left) gem_mmap_offset (bad-flags)
[189.442980] Starting subtest: bad-flags
[189.443849] Subtest bad-flags: SUCCESS (0.000s)
[189.640671] [046/131] (834s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[189.827504] Starting subtest: cursor-vs-flip-legacy
[220.186020] Subtest cursor-vs-flip-legacy: SUCCESS (30.357s)
[220.500850] [047/131] (804s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[220.690077] Starting subtest: sprite-rotation-90-pos-100-0
[220.691864] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[220.883217] [048/131] (803s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[221.076869] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[222.338274] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.260s)
[222.553271] [049/131] (802s left) gem_create (busy-create)
[222.631120] Starting subtest: busy-create
[222.632003] Starting dynamic subtest: lmem0
[254.911955] Dynamic subtest lmem0: SUCCESS (32.279s)
[254.924663] Starting dynamic subtest: smem0
[287.192921] Dynamic subtest smem0: SUCCESS (32.280s)
[287.193917] Subtest busy-create: SUCCESS (64.560s)
[287.509303] [050/131] (737s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[287.697434] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[289.996161] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (2.300s)
[290.205449] [051/131] (734s left) perf (invalid-open-flags)
[290.445201] Starting subtest: invalid-open-flags
[290.446039] Subtest invalid-open-flags: SUCCESS (0.000s)
[290.511469] [052/131] (734s left) perf (oa-formats)
[290.742660] Starting subtest: oa-formats
[290.743586] Starting dynamic subtest: 0-rcs0
[290.769013] Dynamic subtest 0-rcs0: SUCCESS (0.026s)
[290.770010] Subtest oa-formats: SUCCESS (0.027s)
[290.821077] [053/131] (734s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[291.016791] Starting subtest: 4-tiled-8bpp-rotate-270
[291.075482] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.058s)
[291.309899] [054/131] (733s left) kms_cursor_crc (cursor-onscreen-64x21)
[291.660069] Starting subtest: cursor-onscreen-64x21
[291.664909] Starting dynamic subtest: pipe-A-DP-3
[294.250881] Dynamic subtest pipe-A-DP-3: SUCCESS (2.586s)
[294.298808] Starting dynamic subtest: pipe-D-DP-3
[296.956087] Dynamic subtest pipe-D-DP-3: SUCCESS (2.668s)
[296.957036] Subtest cursor-onscreen-64x21: SUCCESS (5.295s)
[297.440863] [055/131] (727s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[297.625084] Starting subtest: primary-4-tiled-reflect-x-180
[308.050077] Subtest primary-4-tiled-reflect-x-180: SUCCESS (10.424s)
[308.475289] [056/131] (716s left) kms_cursor_crc (cursor-onscreen-256x256)
[308.886553] Starting subtest: cursor-onscreen-256x256
[308.891084] Starting dynamic subtest: pipe-A-DP-3
[311.636665] Dynamic subtest pipe-A-DP-3: SUCCESS (2.746s)
[311.684758] Starting dynamic subtest: pipe-D-DP-3
[314.390241] Dynamic subtest pipe-D-DP-3: SUCCESS (2.717s)
[314.391117] Subtest cursor-onscreen-256x256: SUCCESS (5.503s)
[314.769959] [057/131] (710s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[314.960138] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[314.961841] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[315.154235] [058/131] (710s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[315.339123] Starting subtest: async-flip-with-page-flip-events-tiled
[315.570369] Starting dynamic subtest: pipe-A-DP-3-4
[317.833189] Dynamic subtest pipe-A-DP-3-4: SUCCESS (2.263s)
[317.846587] Starting dynamic subtest: pipe-A-DP-3-x
[320.015371] Dynamic subtest pipe-A-DP-3-x: SUCCESS (2.181s)
[320.264772] Starting dynamic subtest: pipe-B-DP-3-4
[322.478964] Dynamic subtest pipe-B-DP-3-4: SUCCESS (2.227s)
[322.491823] Starting dynamic subtest: pipe-B-DP-3-x
[324.644806] Dynamic subtest pipe-B-DP-3-x: SUCCESS (2.165s)
[324.861809] Starting dynamic subtest: pipe-C-DP-3-4
[327.080338] Dynamic subtest pipe-C-DP-3-4: SUCCESS (2.231s)
[327.092640] Starting dynamic subtest: pipe-C-DP-3-x
[329.243978] Dynamic subtest pipe-C-DP-3-x: SUCCESS (2.163s)
[329.453767] Starting dynamic subtest: pipe-D-DP-3-4
[331.675649] Dynamic subtest pipe-D-DP-3-4: SUCCESS (2.233s)
[331.689601] Starting dynamic subtest: pipe-D-DP-3-x
[333.840996] Dynamic subtest pipe-D-DP-3-x: SUCCESS (2.164s)
[333.841947] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (18.501s)
[334.330784] [059/131] (691s left) perf (polling)
[334.565143] Starting subtest: polling
[334.566074] Starting dynamic subtest: 0-rcs0
[344.602881] Dynamic subtest 0-rcs0: SUCCESS (10.036s)
[344.603827] Subtest polling: SUCCESS (10.037s)
[344.658053] [060/131] (680s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[344.861871] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[344.863776] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[345.050519] [061/131] (680s left) syncobj_timeline (reset-signaled)
[345.129963] Starting subtest: reset-signaled
[345.131047] Subtest reset-signaled: SUCCESS (0.000s)
[345.338155] [062/131] (680s left) kms_rmfb (rmfb-ioctl)
[345.525795] Starting subtest: rmfb-ioctl
[345.526664] Starting dynamic subtest: pipe-A-DP-3
[345.677802] Dynamic subtest pipe-A-DP-3: SUCCESS (0.152s)
[345.705918] Starting dynamic subtest: pipe-B-DP-3
[345.956122] Dynamic subtest pipe-B-DP-3: SUCCESS (0.276s)
[345.969703] Starting dynamic subtest: pipe-C-DP-3
[346.202140] Dynamic subtest pipe-C-DP-3: SUCCESS (0.244s)
[346.215641] Starting dynamic subtest: pipe-D-DP-3
[346.447122] Dynamic subtest pipe-D-DP-3: SUCCESS (0.243s)
[346.448032] Subtest rmfb-ioctl: SUCCESS (0.923s)
[346.800032] [063/131] (679s left) gem_userptr_blits (create-destroy-sync)
[346.892091] Starting subtest: create-destroy-sync
[351.912491] Subtest create-destroy-sync: SUCCESS (5.020s)
[352.107076] [064/131] (673s left) gem_exec_reloc (basic-gtt-cpu-active)
[352.189792] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[352.272012] [065/131] (673s left) api_intel_allocator (execbuf-with-allocator)
[352.349892] Starting subtest: execbuf-with-allocator
[352.383096] Subtest execbuf-with-allocator: SUCCESS (0.033s)
[352.603378] [066/131] (673s left) kms_lease (cursor-implicit-plane)
[352.790974] Starting subtest: cursor-implicit-plane
[352.791867] Starting dynamic subtest: pipe-A-DP-3
[353.185984] Dynamic subtest pipe-A-DP-3: SUCCESS (0.393s)
[353.205853] Starting dynamic subtest: pipe-B-DP-3
[353.473679] Dynamic subtest pipe-B-DP-3: SUCCESS (0.286s)
[353.488360] Starting dynamic subtest: pipe-C-DP-3
[353.761031] Dynamic subtest pipe-C-DP-3: SUCCESS (0.285s)
[353.777858] Starting dynamic subtest: pipe-D-DP-3
[354.035616] Dynamic subtest pipe-D-DP-3: SUCCESS (0.272s)
[354.036626] Subtest cursor-implicit-plane: SUCCESS (1.246s)
[354.350304] [067/131] (671s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[354.536990] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[354.538779] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[354.717233] [068/131] (671s left) syncobj_wait (invalid-signal-illegal-handle)
[354.795043] Starting subtest: invalid-signal-illegal-handle
[354.795957] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[354.984522] [069/131] (671s left) kms_psr (psr-primary-blt)
[355.171059] Subtest psr-primary-blt: SKIP (0.000s)
[355.229662] [070/131] (671s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[355.413811] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[355.414684] Starting dynamic subtest: pipe-A-DP-3
[355.435920] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[355.448111] Starting dynamic subtest: pipe-B-DP-3
[355.469166] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[355.481391] Starting dynamic subtest: pipe-C-DP-3
[355.507566] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[355.520203] Starting dynamic subtest: pipe-D-DP-3
[355.542703] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[355.544753] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.014s)
[355.907954] [071/131] (670s left) kms_psr (pr-primary-blt)
[356.097058] Subtest pr-primary-blt: SKIP (0.000s)
[356.156371] [072/131] (670s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[356.352789] Starting subtest: psr-2p-primscrn-spr-indfb-move
[356.354513] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[356.559495] [073/131] (670s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[356.752572] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[356.754822] Starting dynamic subtest: pipe-A-valid-mode
[359.392058] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.636s)
[359.393747] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (2.640s)
[359.718812] [074/131] (667s left) gem_exec_schedule (u-semaphore-noskip)
[359.817367] Starting subtest: u-semaphore-noskip
[360.592479] Subtest u-semaphore-noskip: SUCCESS (0.775s)
[361.047949] [075/131] (665s left) i915_drm_fdinfo (memory-info-idle)
[361.117209] Starting subtest: memory-info-idle
[361.118092] Starting dynamic subtest: lmem0
[361.204617] Dynamic subtest lmem0: SUCCESS (0.087s)
[361.220173] Starting dynamic subtest: smem0
[361.254575] Dynamic subtest smem0: SUCCESS (0.049s)
[361.255610] Subtest memory-info-idle: SUCCESS (0.138s)
[361.435244] [076/131] (665s left) i915_selftest (live)
[362.597829] Starting subtest: live
[362.598850] Starting dynamic subtest: sanitycheck
[364.136989] Dynamic subtest sanitycheck: SUCCESS (1.538s)
[364.149253] Starting dynamic subtest: uncore
[365.587669] Dynamic subtest uncore: SUCCESS (1.449s)
[365.598185] Starting dynamic subtest: workarounds
[381.993568] Dynamic subtest workarounds: FAIL (16.206s)
[382.002925] Starting dynamic subtest: gt_engines
[384.142591] Dynamic subtest gt_engines: SUCCESS (2.346s)
[384.153522] Starting dynamic subtest: gt_timelines
[403.540790] Dynamic subtest gt_timelines: SUCCESS (19.398s)
[403.553117] Starting dynamic subtest: gt_contexts
[405.099676] Dynamic subtest gt_contexts: SUCCESS (1.557s)
[405.110339] Starting dynamic subtest: gt_lrc
[411.291486] Dynamic subtest gt_lrc: SUCCESS (6.191s)
[411.302140] Starting dynamic subtest: gt_mocs
[414.162675] Dynamic subtest gt_mocs: SUCCESS (2.870s)
[414.173554] Starting dynamic subtest: gt_pm
[418.352960] Dynamic subtest gt_pm: SUCCESS (4.189s)
[418.365150] Starting dynamic subtest: gt_heartbeat
[419.882833] Dynamic subtest gt_heartbeat: SUCCESS (1.528s)
[419.893562] Starting dynamic subtest: gt_tlb
[432.412647] Dynamic subtest gt_tlb: SUCCESS (12.529s)
[432.425954] Starting dynamic subtest: requests
[445.766611] Dynamic subtest requests: SUCCESS (13.353s)
[445.781094] Starting dynamic subtest: migrate
[451.057858] Dynamic subtest migrate: SUCCESS (5.290s)
[451.068657] Starting dynamic subtest: active
[452.558678] Dynamic subtest active: SUCCESS (1.500s)
[452.577398] Starting dynamic subtest: objects
[454.833626] Dynamic subtest objects: SUCCESS (2.274s)
[454.845011] Starting dynamic subtest: mman
[461.546620] Dynamic subtest mman: SUCCESS (6.712s)
[461.557685] Starting dynamic subtest: dmabuf
[463.150807] Dynamic subtest dmabuf: SUCCESS (1.603s)
[463.162554] Starting dynamic subtest: vma
[464.638758] Dynamic subtest vma: SUCCESS (1.487s)
[464.650266] Starting dynamic subtest: coherency
[468.844577] Dynamic subtest coherency: SUCCESS (4.204s)
[468.855241] Starting dynamic subtest: gtt
[478.887623] Dynamic subtest gtt: SUCCESS (10.042s)
[478.897992] Starting dynamic subtest: gem
[480.513498] Dynamic subtest gem: SUCCESS (1.625s)
[480.524411] Starting dynamic subtest: evict
[483.396671] Dynamic subtest evict: SUCCESS (2.882s)
[483.407706] Starting dynamic subtest: hugepages
[501.975898] Dynamic subtest hugepages: SUCCESS (18.577s)
[501.988182] Starting dynamic subtest: gem_contexts
[535.314696] Dynamic subtest gem_contexts: SUCCESS (33.336s)
[535.325689] Starting dynamic subtest: client
[536.838829] Dynamic subtest client: SUCCESS (1.523s)
[536.848852] Starting dynamic subtest: gem_migrate
[540.238712] Dynamic subtest gem_migrate: SUCCESS (3.399s)
[540.250146] Starting dynamic subtest: reset
[541.798597] Dynamic subtest reset: SUCCESS (1.558s)
[541.811175] Starting dynamic subtest: memory_region
[544.975623] Dynamic subtest memory_region: SUCCESS (3.176s)
[544.987944] Starting dynamic subtest: hangcheck
[575.707243] Dynamic subtest hangcheck: SUCCESS (30.728s)
[575.719011] Starting dynamic subtest: execlists
[577.235733] Dynamic subtest execlists: SUCCESS (1.529s)
[577.250460] Starting dynamic subtest: ring_submission
[578.763794] Dynamic subtest ring_submission: SUCCESS (1.527s)
[578.774747] Starting dynamic subtest: perf
[580.385782] Dynamic subtest perf: SUCCESS (1.621s)
[580.396881] Starting dynamic subtest: slpc
[587.360699] Dynamic subtest slpc: SUCCESS (6.973s)
[587.372201] Starting dynamic subtest: guc
[590.213923] Dynamic subtest guc: SUCCESS (2.852s)
[590.226139] Starting dynamic subtest: guc_multi_lrc
[591.762764] Dynamic subtest guc_multi_lrc: SUCCESS (1.547s)
[591.773867] Starting dynamic subtest: guc_hang
[594.048687] Dynamic subtest guc_hang: SUCCESS (2.285s)
[594.059784] Starting dynamic subtest: late_gt_pm
[595.647891] Dynamic subtest late_gt_pm: SUCCESS (1.598s)
[595.648902] Subtest live: FAIL (233.049s)
[595.735339] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[595.736889] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[595.739375] [077/131] (431s left) gem_userptr_blits (nohangcheck)
[597.288164] Starting subtest: nohangcheck
[597.614141] Subtest nohangcheck: SUCCESS (0.325s)
[597.760281] [FACT gem_userptr_blits (nohangcheck)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[597.762725] [FACT gem_userptr_blits (nohangcheck)] new: kernel.kmod_is_loaded.i915: true
[597.765326] [078/131] (429s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[597.960911] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[597.961811] Starting dynamic subtest: pipe-A-DP-3
[597.970126] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[597.981903] Starting dynamic subtest: pipe-B-DP-3
[597.990090] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[598.002571] Starting dynamic subtest: pipe-C-DP-3
[598.010735] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[598.022423] Starting dynamic subtest: pipe-D-DP-3
[598.033687] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[598.035702] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SKIP (0.009s)
[598.426250] [079/131] (428s left) gem_softpin (allocator-nopin)
[598.510914] Starting subtest: allocator-nopin
[598.798195] Subtest allocator-nopin: SUCCESS (0.287s)
[599.011959] [080/131] (428s left) kms_draw_crc (draw-method-pwrite)
[599.199869] Starting subtest: draw-method-pwrite
[599.200787] Starting dynamic subtest: xrgb8888-untiled
[599.633432] Dynamic subtest xrgb8888-untiled: SUCCESS (0.433s)
[599.648166] Starting dynamic subtest: rgb565-untiled
[600.051381] Dynamic subtest rgb565-untiled: SUCCESS (0.416s)
[600.091655] Starting dynamic subtest: xrgb2101010-untiled
[600.434428] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.379s)
[600.479370] Starting dynamic subtest: xbgr16161616f-untiled
[600.900001] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.462s)
[600.913124] Starting dynamic subtest: xrgb8888-xtiled
[601.434068] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.533s)
[601.448790] Starting dynamic subtest: rgb565-xtiled
[602.000331] Dynamic subtest rgb565-xtiled: SUCCESS (0.565s)
[602.016729] Starting dynamic subtest: xrgb2101010-xtiled
[602.516789] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.515s)
[602.531196] Starting dynamic subtest: xbgr16161616f-xtiled
[603.133573] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.616s)
[603.146749] Starting dynamic subtest: xrgb8888-4tiled
[603.550404] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.416s)
[603.565739] Starting dynamic subtest: rgb565-4tiled
[603.867213] Dynamic subtest rgb565-4tiled: SUCCESS (0.315s)
[603.889685] Starting dynamic subtest: xrgb2101010-4tiled
[604.284868] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.415s)
[604.301179] Starting dynamic subtest: xbgr16161616f-4tiled
[604.900287] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.612s)
[604.901206] Subtest draw-method-pwrite: SUCCESS (5.701s)
[605.092187] [081/131] (422s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[605.287682] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[605.289555] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[605.481349] [082/131] (421s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[605.709525] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[605.711142] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[605.899871] [083/131] (421s left) syncobj_timeline (host-signal-points)
[605.974084] Starting subtest: host-signal-points
[605.980851] Subtest host-signal-points: SUCCESS (0.007s)
[606.163451] [084/131] (421s left) gem_mmap_gtt (basic-small-bo)
[606.241861] Subtest basic-small-bo: SKIP (0.000s)
[606.312272] [085/131] (421s left) perf_pmu (semaphore-wait-idle)
[606.381944] Starting subtest: semaphore-wait-idle
[606.382865] Starting dynamic subtest: rcs0
[606.926129] Dynamic subtest rcs0: SUCCESS (0.543s)
[606.944028] Starting dynamic subtest: bcs0
[607.442019] Dynamic subtest bcs0: SUCCESS (0.511s)
[607.460537] Starting dynamic subtest: vcs0
[607.958112] Dynamic subtest vcs0: SUCCESS (0.512s)
[607.976498] Starting dynamic subtest: vcs1
[608.474024] Dynamic subtest vcs1: SUCCESS (0.511s)
[608.494793] Starting dynamic subtest: vecs0
[608.992456] Dynamic subtest vecs0: SUCCESS (0.514s)
[609.008776] Starting dynamic subtest: vecs1
[609.505959] Dynamic subtest vecs1: SUCCESS (0.509s)
[609.526809] Starting dynamic subtest: ccs0
[610.024391] Dynamic subtest ccs0: SUCCESS (0.514s)
[610.028936] Subtest semaphore-wait-idle: SUCCESS (3.644s)
[610.219370] [086/131] (417s left) kms_addfb_basic (no-handle)
[610.296150] Starting subtest: no-handle
[610.297033] Subtest no-handle: SUCCESS (0.000s)
[610.603287] [087/131] (417s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[610.790717] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[610.792387] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[610.983623] [088/131] (416s left) gem_render_copy (yf-tiled-ccs-to-linear)
[611.070078] Starting subtest: yf-tiled-ccs-to-linear
[611.072310] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[611.318052] [089/131] (416s left) kms_flip (wf_vblank-ts-check)
[611.502779] Starting subtest: wf_vblank-ts-check
[611.507541] Starting dynamic subtest: A-DP3
[619.626684] Dynamic subtest A-DP3: SUCCESS (8.119s)
[619.642289] Starting dynamic subtest: B-DP3
[627.676840] Dynamic subtest B-DP3: SUCCESS (8.048s)
[627.691755] Starting dynamic subtest: C-DP3
[635.716730] Dynamic subtest C-DP3: SUCCESS (8.038s)
[635.731264] Starting dynamic subtest: D-DP3
[643.754699] Dynamic subtest D-DP3: SUCCESS (8.036s)
[643.757045] Subtest wf_vblank-ts-check: SUCCESS (32.253s)
[644.091481] [090/131] (383s left) gem_exec_schedule (deep)
[644.301233] Starting subtest: deep
[644.302148] Starting dynamic subtest: rcs0
[659.168819] Dynamic subtest rcs0: SUCCESS (14.866s)
[659.182832] Starting dynamic subtest: bcs0
[674.260869] Dynamic subtest bcs0: SUCCESS (15.090s)
[674.273875] Starting dynamic subtest: vcs0
[689.218772] Dynamic subtest vcs0: SUCCESS (14.956s)
[689.232679] Starting dynamic subtest: vcs1
[704.529139] Dynamic subtest vcs1: SUCCESS (15.309s)
[704.542170] Starting dynamic subtest: vecs0
[719.802832] Dynamic subtest vecs0: SUCCESS (15.272s)
[719.816139] Starting dynamic subtest: vecs1
[735.538085] Dynamic subtest vecs1: SUCCESS (15.734s)
[735.551393] Starting dynamic subtest: ccs0
[751.516215] Dynamic subtest ccs0: SUCCESS (15.976s)
[751.517088] Subtest deep: SUCCESS (107.212s)
[752.691335] [091/131] (275s left) kms_sequence (queue-idle)
[752.873562] Starting subtest: queue-idle
[752.875780] Starting dynamic subtest: pipe-A-DP-3
[755.232173] Dynamic subtest pipe-A-DP-3: SUCCESS (2.357s)
[755.246808] Starting dynamic subtest: pipe-B-DP-3
[757.528086] Dynamic subtest pipe-B-DP-3: SUCCESS (2.294s)
[757.542721] Starting dynamic subtest: pipe-C-DP-3
[759.810736] Dynamic subtest pipe-C-DP-3: SUCCESS (2.281s)
[759.826858] Starting dynamic subtest: pipe-D-DP-3
[762.117061] Dynamic subtest pipe-D-DP-3: SUCCESS (2.303s)
[762.118034] Subtest queue-idle: SUCCESS (9.243s)
[762.471552] [092/131] (265s left) gem_gtt_cpu_tlb
[762.645927] [093/131] (265s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[762.832688] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[762.834458] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[763.027744] [094/131] (265s left) gem_eio (create-ext)
[763.334404] Starting subtest: create-ext
[763.870044] Subtest create-ext: SUCCESS (0.537s)
[764.150014] [095/131] (264s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[764.237056] Subtest writes-after-reads-uncached: SKIP (0.000s)
[764.350840] [096/131] (264s left) sysfs_preempt_timeout (idempotent)
[764.433228] Starting subtest: idempotent
[764.435561] Starting dynamic subtest: vecs0
[764.436504] Dynamic subtest vecs0: SUCCESS (0.001s)
[764.451154] Starting dynamic subtest: ccs0
[764.452242] Dynamic subtest ccs0: SUCCESS (0.001s)
[764.466067] Starting dynamic subtest: vcs0
[764.467273] Dynamic subtest vcs0: SUCCESS (0.001s)
[764.481058] Starting dynamic subtest: bcs0
[764.482300] Dynamic subtest bcs0: SUCCESS (0.001s)
[764.495705] Starting dynamic subtest: vecs1
[764.496822] Dynamic subtest vecs1: SUCCESS (0.001s)
[764.510264] Starting dynamic subtest: rcs0
[764.511462] Dynamic subtest rcs0: SUCCESS (0.001s)
[764.527400] Starting dynamic subtest: vcs1
[764.528415] Dynamic subtest vcs1: SUCCESS (0.001s)
[764.529588] Subtest idempotent: SUCCESS (0.013s)
[764.579030] [097/131] (263s left) gem_busy (semaphore)
[764.857621] Subtest semaphore: SKIP (0.000s)
[765.139352] [098/131] (263s left) sriov_basic (enable-vfs-bind-unbind-each)
[765.216682] Subtest enable-vfs-bind-unbind-each: SKIP (0.000s)
[765.286433] [099/131] (263s left) kms_pm_lpsp (screens-disabled)
[766.475191] Starting subtest: screens-disabled
[766.476931] Subtest screens-disabled: SKIP (0.000s)
[766.642742] [100/131] (262s left) gem_exec_capture (capture-invisible)
[766.726325] Starting subtest: capture-invisible
[766.727201] Starting dynamic subtest: lmem0
[766.728920] Dynamic subtest lmem0: SKIP (0.000s)
[766.742446] Starting dynamic subtest: smem0
[766.744602] Dynamic subtest smem0: SKIP (0.000s)
[766.746642] Subtest capture-invisible: SKIP (0.002s)
[766.921311] [101/131] (261s left) gem_lmem_swapping (verify-ccs)
[769.570821] Starting subtest: verify-ccs
[769.573955] Starting dynamic subtest: lmem0
[814.955813] Dynamic subtest lmem0: SUCCESS (45.382s)
[814.956755] Subtest verify-ccs: SUCCESS (45.384s)
[817.027800] [FACT gem_lmem_swapping (verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[817.028749] [FACT gem_lmem_swapping (verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[817.030566] [102/131] (211s left) kms_joiner (basic-force-ultra-joiner)
[818.683203] Starting subtest: basic-force-ultra-joiner
[818.684948] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[818.914207] [FACT kms_joiner (basic-force-ultra-joiner)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[818.918479] [FACT kms_joiner (basic-force-ultra-joiner)] new: kernel.kmod_is_loaded.i915: true
[818.922199] [103/131] (210s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[819.117854] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[819.119617] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[819.313255] [104/131] (209s left) kms_color (legacy-gamma)
[819.498389] Starting subtest: legacy-gamma
[819.499231] Starting dynamic subtest: pipe-A-DP-3
[820.151928] Dynamic subtest pipe-A-DP-3: SUCCESS (0.653s)
[820.180647] Starting dynamic subtest: pipe-B-DP-3
[820.770788] Dynamic subtest pipe-B-DP-3: SUCCESS (0.615s)
[820.790154] Starting dynamic subtest: pipe-C-DP-3
[821.363993] Dynamic subtest pipe-C-DP-3: SUCCESS (0.591s)
[821.383419] Starting dynamic subtest: pipe-D-DP-3
[821.979018] Dynamic subtest pipe-D-DP-3: SUCCESS (0.614s)
[821.979993] Subtest legacy-gamma: SUCCESS (2.481s)
[822.315743] [105/131] (206s left) gem_exec_schedule (wide)
[822.538291] Starting subtest: wide
[822.539188] Starting dynamic subtest: rcs0
[835.625083] Dynamic subtest rcs0: SUCCESS (13.085s)
[835.638391] Starting dynamic subtest: bcs0
[850.339182] Dynamic subtest bcs0: SUCCESS (14.712s)
[850.355507] Starting dynamic subtest: vcs0
[864.743211] Dynamic subtest vcs0: SUCCESS (14.402s)
[864.759143] Starting dynamic subtest: vcs1
[879.461116] Dynamic subtest vcs1: SUCCESS (14.715s)
[879.475824] Starting dynamic subtest: vecs0
[893.656283] Dynamic subtest vecs0: SUCCESS (14.193s)
[893.670841] Starting dynamic subtest: vecs1
[908.230246] Dynamic subtest vecs1: SUCCESS (14.572s)
[908.247386] Starting dynamic subtest: ccs0
[922.176385] Dynamic subtest ccs0: SUCCESS (13.944s)
[922.177347] Subtest wide: SUCCESS (99.633s)
[924.285984] [106/131] (104s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[924.476922] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[924.477836] Starting dynamic subtest: pipe-A-valid-mode
[924.549562] Dynamic subtest pipe-A-valid-mode: SKIP (0.070s)
[924.551169] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.072s)
[924.791585] [107/131] (104s left) kms_big_fb (linear-64bpp-rotate-180)
[924.987673] Starting subtest: linear-64bpp-rotate-180
[927.115600] Subtest linear-64bpp-rotate-180: SUCCESS (2.127s)
[927.345937] [108/131] (102s left) gem_ppgtt (blt-vs-render-ctxn)
[927.438081] Starting subtest: blt-vs-render-ctxN
[960.527045] Subtest blt-vs-render-ctxN: SUCCESS (33.087s)
[960.745929] [109/131] ( 68s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[960.976017] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[960.977811] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[961.162348] [110/131] ( 68s left) kms_chamelium_frames (dp-frame-dump)
[961.427491] Subtest dp-frame-dump: SKIP (0.000s)
[961.575232] [111/131] ( 68s left) kms_psr2_su (page_flip-nv12)
[961.664044] Subtest page_flip-NV12: SKIP (0.000s)
[961.765246] [112/131] ( 67s left) gem_tiling_max_stride
[961.933133] [113/131] ( 67s left) perf_pmu (busy-idle)
[962.010002] Starting subtest: busy-idle
[962.011009] Starting dynamic subtest: rcs0
[962.738093] Dynamic subtest rcs0: SUCCESS (0.727s)
[962.757107] Starting dynamic subtest: bcs0
[963.404282] Dynamic subtest bcs0: SUCCESS (0.662s)
[963.421864] Starting dynamic subtest: vcs0
[964.072204] Dynamic subtest vcs0: SUCCESS (0.664s)
[964.091128] Starting dynamic subtest: vcs1
[964.741205] Dynamic subtest vcs1: SUCCESS (0.665s)
[964.759142] Starting dynamic subtest: vecs0
[965.410198] Dynamic subtest vecs0: SUCCESS (0.665s)
[965.429227] Starting dynamic subtest: vecs1
[966.079180] Dynamic subtest vecs1: SUCCESS (0.665s)
[966.096681] Starting dynamic subtest: ccs0
[966.748235] Dynamic subtest ccs0: SUCCESS (0.665s)
[966.753732] Subtest busy-idle: SUCCESS (4.740s)
[966.951772] [114/131] ( 62s left) dmabuf_sync_file (export-before-signal)
[967.017950] Starting subtest: export-before-signal
[967.018880] Subtest export-before-signal: SUCCESS (0.001s)
[967.175083] [115/131] ( 62s left) gem_exec_reloc (basic-cpu-read)
[967.262187] Subtest basic-cpu-read: SKIP (0.000s)
[967.367062] [116/131] ( 62s left) kms_hdr (bpc-switch)
[967.570125] Starting subtest: bpc-switch
[970.792157] Starting dynamic subtest: pipe-A-DP-3
[971.951673] Dynamic subtest pipe-A-DP-3: SUCCESS (1.159s)
[971.956469] Subtest bpc-switch: SUCCESS (4.384s)
[972.338197] [117/131] ( 57s left) perf (i915-ref-count)
[972.521105] Starting subtest: i915-ref-count
[972.825133] Subtest i915-ref-count: SUCCESS (0.304s)
[973.009420] [118/131] ( 57s left) gem_ctx_isolation (nonpriv)
[973.112794] Starting subtest: nonpriv
[973.113774] Starting dynamic subtest: rcs0
[974.018560] Dynamic subtest rcs0: SUCCESS (0.905s)
[974.035004] Starting dynamic subtest: bcs0
[974.931811] Dynamic subtest bcs0: SUCCESS (0.912s)
[974.946482] Starting dynamic subtest: vcs0
[975.867802] Dynamic subtest vcs0: SUCCESS (0.935s)
[975.884752] Starting dynamic subtest: vcs1
[976.803259] Dynamic subtest vcs1: SUCCESS (0.934s)
[976.819234] Starting dynamic subtest: vecs0
[977.696444] Dynamic subtest vecs0: SUCCESS (0.892s)
[977.718858] Starting dynamic subtest: vecs1
[978.608887] Dynamic subtest vecs1: SUCCESS (0.911s)
[978.625051] Starting dynamic subtest: ccs0
[979.545126] Dynamic subtest ccs0: SUCCESS (0.935s)
[979.546035] Subtest nonpriv: SUCCESS (6.433s)
[979.896558] [119/131] ( 50s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[979.984423] Starting subtest: y-tiled-to-vebox-x-tiled
[979.986725] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[980.278083] [120/131] ( 49s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[980.464979] Starting subtest: plane-use-after-nonblocking-unbind
[980.465852] Starting dynamic subtest: pipe-A-DP-3
[980.540791] Dynamic subtest pipe-A-DP-3: SUCCESS (0.075s)
[980.644458] Starting dynamic subtest: pipe-B-DP-3
[980.839383] Dynamic subtest pipe-B-DP-3: SUCCESS (0.219s)
[980.913483] Subtest plane-use-after-nonblocking-unbind: SUCCESS (0.449s)
[981.187717] [121/131] ( 49s left) i915_hangman (engine-error-state-capture)
[981.285541] Starting subtest: engine-error-state-capture
[981.286512] Starting dynamic subtest: rcs0
[983.547186] Dynamic subtest rcs0: SUCCESS (2.261s)
[983.564991] Starting dynamic subtest: bcs0
[987.490217] Dynamic subtest bcs0: SUCCESS (3.941s)
[987.515776] Starting dynamic subtest: vcs0
[991.513000] Dynamic subtest vcs0: SUCCESS (4.021s)
[991.528627] Starting dynamic subtest: vcs1
[995.479923] Dynamic subtest vcs1: SUCCESS (3.966s)
[995.495453] Starting dynamic subtest: vecs0
[999.545313] Dynamic subtest vecs0: SUCCESS (4.064s)
[999.563406] Starting dynamic subtest: vecs1
[1003.535743] Dynamic subtest vecs1: SUCCESS (3.989s)
[1003.550102] Starting dynamic subtest: ccs0
[1007.528192] Dynamic subtest ccs0: SUCCESS (3.991s)
[1007.529151] Subtest engine-error-state-capture: SUCCESS (26.243s)
[1007.700346] [122/131] ( 22s left) gem_exec_schedule (pi-shared-iova)
[1007.937268] Starting subtest: pi-shared-iova
[1007.942227] Starting dynamic subtest: rcs0
[1008.212732] Dynamic subtest rcs0: SUCCESS (0.274s)
[1008.226972] Starting dynamic subtest: bcs0
[1008.392477] Dynamic subtest bcs0: SUCCESS (0.179s)
[1008.406618] Starting dynamic subtest: vcs0
[1008.580512] Dynamic subtest vcs0: SUCCESS (0.187s)
[1008.594788] Starting dynamic subtest: vcs1
[1008.769399] Dynamic subtest vcs1: SUCCESS (0.188s)
[1008.784002] Starting dynamic subtest: vecs0
[1008.956068] Dynamic subtest vecs0: SUCCESS (0.186s)
[1008.970596] Starting dynamic subtest: vecs1
[1009.142065] Dynamic subtest vecs1: SUCCESS (0.185s)
[1009.156485] Starting dynamic subtest: ccs0
[1009.330054] Dynamic subtest ccs0: SUCCESS (0.187s)
[1009.331137] Subtest pi-shared-iova: SUCCESS (1.394s)
[1009.762902] [123/131] ( 20s left) syncobj_wait (invalid-reset-illegal-handle)
[1009.842000] Starting subtest: invalid-reset-illegal-handle
[1009.842905] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[1010.042963] [124/131] ( 20s left) syncobj_wait (single-wait-all-for-submit-signaled)
[1010.120005] Starting subtest: single-wait-all-for-submit-signaled
[1010.120947] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[1010.283490] [125/131] ( 20s left) kms_cursor_crc (cursor-sliding-512x170)
[1010.777614] Starting subtest: cursor-sliding-512x170
[1010.780823] Subtest cursor-sliding-512x170: SKIP (0.001s)
[1011.078743] [126/131] ( 19s left) kms_chamelium_hpd (hdmi-hpd-fast)
[1011.355772] Subtest hdmi-hpd-fast: SKIP (0.000s)
[1011.506595] [127/131] ( 19s left) gem_ctx_persistence (hostile)
[1011.605623] Starting subtest: hostile
[1021.128621] Subtest hostile: SUCCESS (9.518s)
[1021.346688] [128/131] (  9s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[1021.539226] Starting subtest: fbc-rgb565-draw-blt
[1024.265472] Subtest fbc-rgb565-draw-blt: SUCCESS (2.727s)
[1024.484360] [129/131] (  6s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[1024.676928] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[1024.678684] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[1024.880871] [130/131] (  6s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[1025.075953] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[1025.077756] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[1025.265950] [131/131] (  5s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[1025.452771] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[1025.454539] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[1025.663649] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: gem_exec_fence
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_exec_balancer
results: parsing output: 5/ for test: kms_chamelium_color
results: parsing output: 6/ for test: gem_workarounds
results: parsing output: 7/ for test: kms_plane_scaling
results: parsing output: 8/ for test: gem_pxp
results: parsing output: 9/ for test: gem_exec_params
results: parsing output: 10/ for test: gem_exec_nop
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: i915_pm_rps
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_panel_fitting
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: api_intel_bb
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_lmem_swapping
results: parsing output: 23/ for test: kms_async_flips
results: parsing output: 24/ for test: kms_psr2_sf
results: parsing output: 25/ for test: kms_plane_multiple
results: parsing output: 26/ for test: gem_ctx_param
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_plane_scaling
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_pm_rpm
results: parsing output: 33/ for test: kms_vblank
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_pipe_crc_basic
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: kms_psr2_sf
results: parsing output: 38/ for test: gem_unref_active_buffers
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: gen9_exec_parse
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: gem_exec_reloc
results: parsing output: 44/ for test: gem_mmap_offset
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_rotation_crc
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: gem_create
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: perf
results: parsing output: 51/ for test: perf
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_cursor_crc
results: parsing output: 54/ for test: kms_rotation_crc
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_async_flips
results: parsing output: 58/ for test: perf
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_rmfb
results: parsing output: 62/ for test: gem_userptr_blits
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: api_intel_allocator
results: parsing output: 65/ for test: kms_lease
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: syncobj_wait
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_flip_scaled_crc
results: parsing output: 73/ for test: gem_exec_schedule
results: parsing output: 74/ for test: i915_drm_fdinfo
results: parsing output: 75/ for test: i915_selftest
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: gem_softpin
results: parsing output: 79/ for test: kms_draw_crc
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: gem_mmap_gtt
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: kms_addfb_basic
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_render_copy
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: kms_sequence
results: parsing output: 91/ for test: gem_gtt_cpu_tlb
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_eio
results: parsing output: 94/ for test: gem_partial_pwrite_pread
results: parsing output: 95/ for test: sysfs_preempt_timeout
results: parsing output: 96/ for test: gem_busy
results: parsing output: 97/ for test: sriov_basic
results: parsing output: 98/ for test: kms_pm_lpsp
results: parsing output: 99/ for test: gem_exec_capture
results: parsing output: 100/ for test: gem_lmem_swapping
results: parsing output: 101/ for test: kms_joiner
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_color
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: kms_flip_scaled_crc
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: gem_ppgtt
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_chamelium_frames
results: parsing output: 110/ for test: kms_psr2_su
results: parsing output: 111/ for test: gem_tiling_max_stride
results: parsing output: 112/ for test: perf_pmu
results: parsing output: 113/ for test: dmabuf_sync_file
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: kms_hdr
results: parsing output: 116/ for test: perf
results: parsing output: 117/ for test: gem_ctx_isolation
results: parsing output: 118/ for test: gem_render_copy
results: parsing output: 119/ for test: kms_atomic_transition
results: parsing output: 120/ for test: i915_hangman
results: parsing output: 121/ for test: gem_exec_schedule
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: kms_chamelium_hpd
results: parsing output: 126/ for test: gem_ctx_persistence
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.