[59.860213] Initializing watchdogs
[59.860276]   /dev/watchdog0
[59.879618] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[59.890515] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[59.894405] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.896796] [001/131] (960s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[60.087596] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[60.089328] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[60.282476] [002/131] (960s left) gem_exec_fence (submit3)
[60.511638] Starting subtest: submit3
[60.514487] Subtest submit3: SKIP (0.000s)
[61.284201] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true
[61.285874] [003/131] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[61.476575] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[61.478226] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[61.671545] [004/131] (958s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[61.863608] Starting subtest: fbc-rgb101010-draw-mmap-wc
[61.865259] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s)
[62.053360] [005/131] (958s left) gem_exec_balancer (noheartbeat)
[62.450293] Starting subtest: noheartbeat
[62.452061] Subtest noheartbeat: SKIP (0.000s)
[62.578507] [006/131] (958s left) kms_chamelium_color (ctm-blue-to-red)
[62.763293] Subtest ctm-blue-to-red: SKIP (0.000s)
[62.816342] [007/131] (958s left) gem_workarounds (suspend-resume)
[62.926055] Starting subtest: suspend-resume
[81.962976] Subtest suspend-resume: SUCCESS (3.828s)
[82.095506] [008/131] (938s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[82.288904] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[82.289700] Starting dynamic subtest: pipe-A
[82.397038] Dynamic subtest pipe-A: SUCCESS (0.108s)
[82.413056] Starting dynamic subtest: pipe-B
[82.612705] Dynamic subtest pipe-B: SUCCESS (0.215s)
[82.631077] Starting dynamic subtest: pipe-C
[82.825512] Dynamic subtest pipe-C: SUCCESS (0.212s)
[82.841880] Starting dynamic subtest: pipe-D
[83.037650] Dynamic subtest pipe-D: SUCCESS (0.212s)
[83.038549] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (0.749s)
[83.425537] [009/131] (937s left) gem_pxp (create-regular-buffer)
[86.033711] Starting subtest: create-regular-buffer
[86.036697] Subtest create-regular-buffer: SKIP (0.000s)
[86.163860] [010/131] (934s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[86.247364] Starting subtest: rel-constants-invalid-rel-gen5
[86.248326] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[86.445945] [011/131] (934s left) gem_exec_nop (basic-series)
[86.535068] Starting subtest: basic-series
[90.882681] Subtest basic-series: SUCCESS (4.348s)
[91.144591] [012/131] (929s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[91.335940] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[91.337644] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[91.521871] [013/131] (929s left) kms_psr (fbc-psr-primary-page-flip)
[91.707118] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[91.772395] [014/131] (929s left) i915_pm_rps (engine-order)
[91.859199] Starting subtest: engine-order
[102.550880] Subtest engine-order: SUCCESS (10.691s)
[102.778075] [015/131] (918s left) gem_softpin (evict-active)
[102.861761] Starting subtest: evict-active
[102.878663] Subtest evict-active: SUCCESS (0.017s)
[103.065478] [016/131] (918s left) syncobj_timeline (wait-delayed-signal)
[103.142896] Starting subtest: wait-delayed-signal
[103.246775] Subtest wait-delayed-signal: SUCCESS (0.103s)
[103.385840] [017/131] (918s left) kms_panel_fitting (atomic-fastset)
[103.564551] Starting subtest: atomic-fastset
[103.566403] Subtest atomic-fastset: SKIP (0.000s)
[103.732615] [018/131] (917s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[103.926989] Starting subtest: x-tiled-16bpp-rotate-270
[103.981722] Subtest x-tiled-16bpp-rotate-270: SKIP (0.054s)
[104.204449] [019/131] (917s left) api_intel_bb (render-ccs)
[104.283680] Starting subtest: render-ccs
[104.384828] Subtest render-ccs: SUCCESS (0.101s)
[104.592037] [020/131] (917s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[104.776223] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[104.777079] Starting dynamic subtest: pipe-A-DP-3
[104.785390] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[104.796343] Starting dynamic subtest: pipe-B-DP-3
[104.804785] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[104.815474] Starting dynamic subtest: pipe-C-DP-3
[104.823617] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[104.834382] Starting dynamic subtest: pipe-D-DP-3
[104.844636] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[104.846340] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[105.240033] [021/131] (916s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[105.320677] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[105.422668] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.101s)
[105.555850] [022/131] (916s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[105.745004] Starting subtest: psr-2p-primscrn-cur-indfb-move
[105.746684] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[105.936265] [023/131] (915s left) gem_lmem_swapping (heavy-multi)
[108.594059] Starting subtest: heavy-multi
[108.595308] Starting dynamic subtest: lmem0
[113.428447] Dynamic subtest lmem0: SUCCESS (4.834s)
[113.429400] Subtest heavy-multi: SUCCESS (4.834s)
[115.169331] [FACT gem_lmem_swapping (heavy-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[115.170779] [FACT gem_lmem_swapping (heavy-multi)] deleted: kernel.kmod_is_loaded.i915: true
[115.172313] [024/131] (906s left) kms_async_flips (test-cursor)
[116.809337] Starting subtest: test-cursor
[117.047753] Starting dynamic subtest: pipe-A-DP-3
[117.336645] Dynamic subtest pipe-A-DP-3: SUCCESS (0.289s)
[117.553440] Starting dynamic subtest: pipe-B-DP-3
[117.671253] Dynamic subtest pipe-B-DP-3: SUCCESS (0.130s)
[117.854236] Starting dynamic subtest: pipe-C-DP-3
[117.949767] Dynamic subtest pipe-C-DP-3: SUCCESS (0.107s)
[118.159598] Starting dynamic subtest: pipe-D-DP-3
[118.259875] Dynamic subtest pipe-D-DP-3: SUCCESS (0.111s)
[118.260752] Subtest test-cursor: SUCCESS (1.451s)
[118.782149] [FACT kms_async_flips (test-cursor)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[118.784393] [FACT kms_async_flips (test-cursor)] new: kernel.kmod_is_loaded.i915: true
[118.786779] [025/131] (903s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[118.983872] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[119.035094] [026/131] (902s left) kms_plane_multiple (2x-tiling-4)
[119.218980] Starting subtest: 2x-tiling-4
[119.220740] Subtest 2x-tiling-4: SKIP (0.000s)
[119.372590] [027/131] (902s left) gem_ctx_param (invalid-param-set)
[119.448970] Starting subtest: invalid-param-set
[119.449933] Subtest invalid-param-set: SUCCESS (0.000s)
[119.636760] [028/131] (902s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[119.826734] Starting subtest: bad-pixel-format-y-tiled-ccs
[119.827666] Starting dynamic subtest: pipe-A-DP-3
[119.836184] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[119.847145] Starting dynamic subtest: pipe-B-DP-3
[119.855670] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[119.866537] Starting dynamic subtest: pipe-C-DP-3
[119.874777] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[119.885824] Starting dynamic subtest: pipe-D-DP-3
[119.895821] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[119.897821] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[120.326953] [029/131] (901s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[120.511716] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[120.512569] Starting dynamic subtest: pipe-A
[121.085139] Dynamic subtest pipe-A: SUCCESS (0.573s)
[121.105760] Starting dynamic subtest: pipe-B
[121.712848] Dynamic subtest pipe-B: SUCCESS (0.627s)
[121.736684] Starting dynamic subtest: pipe-C
[122.358849] Dynamic subtest pipe-C: SUCCESS (0.645s)
[122.381916] Starting dynamic subtest: pipe-D
[123.004896] Dynamic subtest pipe-D: SUCCESS (0.645s)
[123.005982] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (2.493s)
[123.351274] [030/131] (899s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[123.428590] Starting subtest: multi-wait-all-available-submitted-signaled
[123.429523] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[123.616156] [031/131] (898s left) perf (missing-sample-flags)
[124.049681] Starting subtest: missing-sample-flags
[124.050595] Subtest missing-sample-flags: SUCCESS (0.000s)
[124.114317] [032/131] (898s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[124.313422] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[127.351382] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (3.038s)
[127.547237] [033/131] (895s left) kms_pm_rpm (system-suspend-idle)
[129.474107] Starting subtest: system-suspend-idle
[149.267645] Subtest system-suspend-idle: SUCCESS (5.168s)
[149.634989] [034/131] (873s left) kms_vblank (wait-forked)
[149.818807] Starting subtest: wait-forked
[149.821085] Starting dynamic subtest: pipe-A-DP-3
[152.212987] Dynamic subtest pipe-A-DP-3: SUCCESS (2.393s)
[152.242732] Starting dynamic subtest: pipe-D-DP-3
[154.517369] Dynamic subtest pipe-D-DP-3: SUCCESS (2.294s)
[154.518323] Subtest wait-forked: SUCCESS (4.697s)
[154.810238] [035/131] (867s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[155.005687] Starting subtest: y-tiled-32bpp-rotate-0
[155.007398] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[155.198239] [036/131] (867s left) kms_pipe_crc_basic (read-crc)
[155.397342] Starting subtest: read-crc
[155.399777] Starting dynamic subtest: pipe-A-DP-3
[156.089074] Dynamic subtest pipe-A-DP-3: SUCCESS (0.690s)
[156.105233] Starting dynamic subtest: pipe-B-DP-3
[156.642886] Dynamic subtest pipe-B-DP-3: SUCCESS (0.551s)
[156.659866] Starting dynamic subtest: pipe-C-DP-3
[157.168228] Dynamic subtest pipe-C-DP-3: SUCCESS (0.523s)
[157.189713] Starting dynamic subtest: pipe-D-DP-3
[157.730762] Dynamic subtest pipe-D-DP-3: SUCCESS (0.561s)
[157.731710] Subtest read-crc: SUCCESS (2.332s)
[158.043306] [037/131] (864s left) kms_cursor_legacy (single-move)
[158.230049] Starting subtest: single-move
[158.230921] Starting dynamic subtest: pipe-A
[163.612816] Dynamic subtest pipe-A: SUCCESS (5.380s)
[163.625104] Starting dynamic subtest: pipe-B
[168.993448] Dynamic subtest pipe-B: SUCCESS (5.378s)
[169.005409] Starting dynamic subtest: pipe-C
[174.373867] Dynamic subtest pipe-C: SUCCESS (5.379s)
[174.385977] Starting dynamic subtest: pipe-D
[179.754149] Dynamic subtest pipe-D: SUCCESS (5.379s)
[179.766254] Starting dynamic subtest: all-pipes
[185.134528] Dynamic subtest all-pipes: SUCCESS (5.379s)
[185.135402] Subtest single-move: SUCCESS (26.897s)
[185.262609] [038/131] (837s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[185.463481] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[185.523530] [039/131] (837s left) gem_unref_active_buffers
[185.939955] [040/131] (837s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[186.131196] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.000s)
[186.190775] [041/131] (836s left) syncobj_wait (invalid-signal-zero-handles)
[186.268078] Starting subtest: invalid-signal-zero-handles
[186.268985] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[186.456335] [042/131] (836s left) gen9_exec_parse (bb-oversize)
[186.549255] Subtest bb-oversize: SKIP (0.000s)
[186.652808] [043/131] (836s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[186.728337] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[186.835216] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[187.010312] [044/131] (836s left) gem_exec_reloc (basic-write-cpu-noreloc)
[187.096431] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[187.173919] [045/131] (836s left) gem_mmap_offset (bad-flags)
[187.250122] Starting subtest: bad-flags
[187.251085] Subtest bad-flags: SUCCESS (0.000s)
[187.425910] [046/131] (836s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[187.608973] Starting subtest: cursor-vs-flip-legacy
[217.957557] Subtest cursor-vs-flip-legacy: SUCCESS (30.348s)
[218.255599] [047/131] (805s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[218.438812] Starting subtest: sprite-rotation-90-pos-100-0
[218.440510] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[218.631728] [048/131] (805s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[218.825319] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[220.068809] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.234s)
[220.311587] [049/131] (803s left) gem_create (busy-create)
[220.392417] Starting subtest: busy-create
[220.393305] Starting dynamic subtest: lmem0
[252.705327] Dynamic subtest lmem0: SUCCESS (32.310s)
[252.719042] Starting dynamic subtest: smem0
[284.955272] Dynamic subtest smem0: SUCCESS (32.251s)
[284.956199] Subtest busy-create: SUCCESS (64.562s)
[285.242337] [050/131] (738s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[285.440700] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[287.866996] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (2.427s)
[288.078677] [051/131] (735s left) perf (invalid-open-flags)
[288.353282] Starting subtest: invalid-open-flags
[288.354221] Subtest invalid-open-flags: SUCCESS (0.000s)
[288.409309] [052/131] (735s left) perf (oa-formats)
[288.619078] Starting subtest: oa-formats
[288.619943] Starting dynamic subtest: 0-rcs0
[288.643288] Dynamic subtest 0-rcs0: SUCCESS (0.025s)
[288.644201] Subtest oa-formats: SUCCESS (0.026s)
[288.709458] [053/131] (735s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[288.904364] Starting subtest: 4-tiled-8bpp-rotate-270
[288.962846] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.058s)
[289.197263] [054/131] (734s left) kms_cursor_crc (cursor-onscreen-64x21)
[289.552510] Starting subtest: cursor-onscreen-64x21
[289.556981] Starting dynamic subtest: pipe-A-DP-3
[292.381980] Dynamic subtest pipe-A-DP-3: SUCCESS (2.823s)
[292.434834] Starting dynamic subtest: pipe-D-DP-3
[295.142047] Dynamic subtest pipe-D-DP-3: SUCCESS (2.719s)
[295.143100] Subtest cursor-onscreen-64x21: SUCCESS (5.590s)
[295.660231] [055/131] (728s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[295.848063] Starting subtest: primary-4-tiled-reflect-x-180
[306.159394] Subtest primary-4-tiled-reflect-x-180: SUCCESS (10.311s)
[306.588623] [056/131] (717s left) kms_cursor_crc (cursor-onscreen-256x256)
[307.007096] Starting subtest: cursor-onscreen-256x256
[307.011474] Starting dynamic subtest: pipe-A-DP-3
[309.816370] Dynamic subtest pipe-A-DP-3: SUCCESS (2.805s)
[309.867083] Starting dynamic subtest: pipe-D-DP-3
[312.557450] Dynamic subtest pipe-D-DP-3: SUCCESS (2.702s)
[312.558371] Subtest cursor-onscreen-256x256: SUCCESS (5.550s)
[312.998134] [057/131] (711s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[313.191483] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[313.193129] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[313.386409] [058/131] (711s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[313.570346] Starting subtest: async-flip-with-page-flip-events-tiled
[313.805009] Starting dynamic subtest: pipe-A-DP-3-4
[316.073420] Dynamic subtest pipe-A-DP-3-4: SUCCESS (2.268s)
[316.086735] Starting dynamic subtest: pipe-A-DP-3-x
[318.255843] Dynamic subtest pipe-A-DP-3-x: SUCCESS (2.181s)
[318.501300] Starting dynamic subtest: pipe-B-DP-3-4
[320.714133] Dynamic subtest pipe-B-DP-3-4: SUCCESS (2.226s)
[320.732317] Starting dynamic subtest: pipe-B-DP-3-x
[322.879180] Dynamic subtest pipe-B-DP-3-x: SUCCESS (2.163s)
[323.094443] Starting dynamic subtest: pipe-C-DP-3-4
[325.316452] Dynamic subtest pipe-C-DP-3-4: SUCCESS (2.234s)
[325.329761] Starting dynamic subtest: pipe-C-DP-3-x
[327.482091] Dynamic subtest pipe-C-DP-3-x: SUCCESS (2.165s)
[327.674475] Starting dynamic subtest: pipe-D-DP-3-4
[329.891469] Dynamic subtest pipe-D-DP-3-4: SUCCESS (2.229s)
[329.904124] Starting dynamic subtest: pipe-D-DP-3-x
[332.060303] Dynamic subtest pipe-D-DP-3-x: SUCCESS (2.165s)
[332.064006] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (18.487s)
[332.576735] [059/131] (691s left) perf (polling)
[332.812244] Starting subtest: polling
[332.813178] Starting dynamic subtest: 0-rcs0
[342.835204] Dynamic subtest 0-rcs0: SUCCESS (10.022s)
[342.836158] Subtest polling: SUCCESS (10.023s)
[342.891815] [060/131] (681s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[343.098035] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[343.099798] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[343.290813] [061/131] (681s left) syncobj_timeline (reset-signaled)
[343.369346] Starting subtest: reset-signaled
[343.370273] Subtest reset-signaled: SUCCESS (0.000s)
[343.571499] [062/131] (681s left) kms_rmfb (rmfb-ioctl)
[343.756092] Starting subtest: rmfb-ioctl
[343.756974] Starting dynamic subtest: pipe-A-DP-3
[343.894418] Dynamic subtest pipe-A-DP-3: SUCCESS (0.138s)
[343.911539] Starting dynamic subtest: pipe-B-DP-3
[344.157353] Dynamic subtest pipe-B-DP-3: SUCCESS (0.261s)
[344.171399] Starting dynamic subtest: pipe-C-DP-3
[344.405623] Dynamic subtest pipe-C-DP-3: SUCCESS (0.247s)
[344.419863] Starting dynamic subtest: pipe-D-DP-3
[344.651896] Dynamic subtest pipe-D-DP-3: SUCCESS (0.244s)
[344.652897] Subtest rmfb-ioctl: SUCCESS (0.897s)
[344.993775] [063/131] (679s left) gem_userptr_blits (create-destroy-sync)
[345.084876] Starting subtest: create-destroy-sync
[350.097769] Subtest create-destroy-sync: SUCCESS (5.012s)
[350.296647] [064/131] (674s left) gem_exec_reloc (basic-gtt-cpu-active)
[350.382360] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[350.459796] [065/131] (674s left) api_intel_allocator (execbuf-with-allocator)
[350.537342] Starting subtest: execbuf-with-allocator
[350.565558] Subtest execbuf-with-allocator: SUCCESS (0.029s)
[350.777493] [066/131] (674s left) kms_lease (cursor-implicit-plane)
[350.962393] Starting subtest: cursor-implicit-plane
[350.964543] Starting dynamic subtest: pipe-A-DP-3
[351.308053] Dynamic subtest pipe-A-DP-3: SUCCESS (0.344s)
[351.332896] Starting dynamic subtest: pipe-B-DP-3
[351.599640] Dynamic subtest pipe-B-DP-3: SUCCESS (0.288s)
[351.616444] Starting dynamic subtest: pipe-C-DP-3
[351.868934] Dynamic subtest pipe-C-DP-3: SUCCESS (0.267s)
[351.885432] Starting dynamic subtest: pipe-D-DP-3
[352.161436] Dynamic subtest pipe-D-DP-3: SUCCESS (0.291s)
[352.162409] Subtest cursor-implicit-plane: SUCCESS (1.200s)
[352.495892] [067/131] (672s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[352.679338] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[352.681063] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[352.861558] [068/131] (672s left) syncobj_wait (invalid-signal-illegal-handle)
[352.938278] Starting subtest: invalid-signal-illegal-handle
[352.939178] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[353.086386] [069/131] (672s left) kms_psr (psr-primary-blt)
[353.269237] Subtest psr-primary-blt: SKIP (0.000s)
[353.327584] [070/131] (672s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[353.513637] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[353.515934] Starting dynamic subtest: pipe-A-DP-3
[353.537197] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[353.550442] Starting dynamic subtest: pipe-B-DP-3
[353.572041] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[353.585401] Starting dynamic subtest: pipe-C-DP-3
[353.612376] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[353.627150] Starting dynamic subtest: pipe-D-DP-3
[353.653441] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[353.655431] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.014s)
[353.998485] [071/131] (671s left) kms_psr (pr-primary-blt)
[354.183175] Subtest pr-primary-blt: SKIP (0.000s)
[354.244479] [072/131] (671s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[354.437250] Starting subtest: psr-2p-primscrn-spr-indfb-move
[354.438975] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[354.634395] [073/131] (670s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[354.816309] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[354.817198] Starting dynamic subtest: pipe-A-valid-mode
[357.274597] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.456s)
[357.276077] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (2.459s)
[357.603631] [074/131] (668s left) gem_exec_schedule (u-semaphore-noskip)
[357.695906] Starting subtest: u-semaphore-noskip
[358.456127] Subtest u-semaphore-noskip: SUCCESS (0.760s)
[358.900167] [075/131] (666s left) i915_drm_fdinfo (memory-info-idle)
[358.969514] Starting subtest: memory-info-idle
[358.970376] Starting dynamic subtest: lmem0
[359.069073] Dynamic subtest lmem0: SUCCESS (0.099s)
[359.085474] Starting dynamic subtest: smem0
[359.113509] Dynamic subtest smem0: SUCCESS (0.043s)
[359.114423] Subtest memory-info-idle: SUCCESS (0.145s)
[359.301647] [076/131] (666s left) i915_selftest (live)
[360.361822] Starting subtest: live
[360.362848] Starting dynamic subtest: sanitycheck
[361.910907] Dynamic subtest sanitycheck: SUCCESS (1.548s)
[361.922103] Starting dynamic subtest: uncore
[363.446246] Dynamic subtest uncore: SUCCESS (1.534s)
[363.460622] Starting dynamic subtest: workarounds
[379.776728] Dynamic subtest workarounds: FAIL (16.127s)
[379.786414] Starting dynamic subtest: gt_engines
[381.843830] Dynamic subtest gt_engines: SUCCESS (2.266s)
[381.855612] Starting dynamic subtest: gt_timelines
[401.472988] Dynamic subtest gt_timelines: SUCCESS (19.628s)
[401.485981] Starting dynamic subtest: gt_contexts
[403.032165] Dynamic subtest gt_contexts: SUCCESS (1.557s)
[403.043742] Starting dynamic subtest: gt_lrc
[409.308825] Dynamic subtest gt_lrc: SUCCESS (6.275s)
[409.319940] Starting dynamic subtest: gt_mocs
[412.112078] Dynamic subtest gt_mocs: SUCCESS (2.802s)
[412.123592] Starting dynamic subtest: gt_pm
[416.220900] Dynamic subtest gt_pm: SUCCESS (4.107s)
[416.232140] Starting dynamic subtest: gt_heartbeat
[417.749967] Dynamic subtest gt_heartbeat: SUCCESS (1.528s)
[417.761639] Starting dynamic subtest: gt_tlb
[430.772167] Dynamic subtest gt_tlb: SUCCESS (13.020s)
[430.783897] Starting dynamic subtest: requests
[445.351157] Dynamic subtest requests: SUCCESS (14.577s)
[445.362264] Starting dynamic subtest: migrate
[450.721912] Dynamic subtest migrate: SUCCESS (5.369s)
[450.732291] Starting dynamic subtest: active
[452.242971] Dynamic subtest active: SUCCESS (1.520s)
[452.253788] Starting dynamic subtest: objects
[454.514823] Dynamic subtest objects: SUCCESS (2.271s)
[454.526619] Starting dynamic subtest: mman
[461.076803] Dynamic subtest mman: SUCCESS (6.560s)
[461.088121] Starting dynamic subtest: dmabuf
[462.678082] Dynamic subtest dmabuf: SUCCESS (1.600s)
[462.689693] Starting dynamic subtest: vma
[464.195973] Dynamic subtest vma: SUCCESS (1.516s)
[464.208118] Starting dynamic subtest: coherency
[468.434957] Dynamic subtest coherency: SUCCESS (4.238s)
[468.447172] Starting dynamic subtest: gtt
[478.761972] Dynamic subtest gtt: SUCCESS (10.325s)
[478.773789] Starting dynamic subtest: gem
[480.444479] Dynamic subtest gem: SUCCESS (1.666s)
[480.462242] Starting dynamic subtest: evict
[483.393231] Dynamic subtest evict: SUCCESS (2.963s)
[483.408249] Starting dynamic subtest: hugepages
[501.436040] Dynamic subtest hugepages: SUCCESS (18.040s)
[501.447113] Starting dynamic subtest: gem_contexts
[537.339024] Dynamic subtest gem_contexts: SUCCESS (35.900s)
[537.354233] Starting dynamic subtest: client
[538.858082] Dynamic subtest client: SUCCESS (1.517s)
[538.869607] Starting dynamic subtest: gem_migrate
[542.217151] Dynamic subtest gem_migrate: SUCCESS (3.358s)
[542.230212] Starting dynamic subtest: reset
[543.819831] Dynamic subtest reset: SUCCESS (1.601s)
[543.831173] Starting dynamic subtest: memory_region
[546.995138] Dynamic subtest memory_region: SUCCESS (3.174s)
[547.007602] Starting dynamic subtest: hangcheck
[580.298185] Dynamic subtest hangcheck: SUCCESS (33.300s)
[580.310653] Starting dynamic subtest: execlists
[581.814061] Dynamic subtest execlists: SUCCESS (1.514s)
[581.826160] Starting dynamic subtest: ring_submission
[583.319035] Dynamic subtest ring_submission: SUCCESS (1.504s)
[583.330561] Starting dynamic subtest: perf
[584.949988] Dynamic subtest perf: SUCCESS (1.630s)
[584.961383] Starting dynamic subtest: slpc
[592.280143] Dynamic subtest slpc: SUCCESS (7.328s)
[592.291044] Starting dynamic subtest: guc
[595.144908] Dynamic subtest guc: SUCCESS (2.863s)
[595.156581] Starting dynamic subtest: guc_multi_lrc
[596.689808] Dynamic subtest guc_multi_lrc: SUCCESS (1.544s)
[596.701077] Starting dynamic subtest: guc_hang
[598.968994] Dynamic subtest guc_hang: SUCCESS (2.278s)
[598.980094] Starting dynamic subtest: late_gt_pm
[600.559538] Dynamic subtest late_gt_pm: SUCCESS (1.589s)
[600.561384] Subtest live: FAIL (240.189s)
[600.596410] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[600.597834] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[600.599948] [077/131] (425s left) gem_userptr_blits (nohangcheck)
[602.167206] Starting subtest: nohangcheck
[602.507511] Subtest nohangcheck: SUCCESS (0.339s)
[602.650310] [FACT gem_userptr_blits (nohangcheck)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[602.652554] [FACT gem_userptr_blits (nohangcheck)] new: kernel.kmod_is_loaded.i915: true
[602.655483] [078/131] (423s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[602.841792] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[602.844195] Starting dynamic subtest: pipe-A-DP-3
[602.852385] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[602.864698] Starting dynamic subtest: pipe-B-DP-3
[602.873080] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[602.886433] Starting dynamic subtest: pipe-C-DP-3
[602.894715] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[602.907375] Starting dynamic subtest: pipe-D-DP-3
[602.917597] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[602.919623] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SKIP (0.009s)
[603.336648] [079/131] (422s left) gem_softpin (allocator-nopin)
[603.423639] Starting subtest: allocator-nopin
[603.668996] Subtest allocator-nopin: SUCCESS (0.245s)
[603.869672] [080/131] (422s left) kms_draw_crc (draw-method-pwrite)
[604.060349] Starting subtest: draw-method-pwrite
[604.061210] Starting dynamic subtest: xrgb8888-untiled
[604.487978] Dynamic subtest xrgb8888-untiled: SUCCESS (0.427s)
[604.503455] Starting dynamic subtest: rgb565-untiled
[604.905558] Dynamic subtest rgb565-untiled: SUCCESS (0.415s)
[604.950793] Starting dynamic subtest: xrgb2101010-untiled
[605.338036] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.429s)
[605.352692] Starting dynamic subtest: xbgr16161616f-untiled
[605.721117] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.382s)
[605.738309] Starting dynamic subtest: xrgb8888-xtiled
[606.255304] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.533s)
[606.278980] Starting dynamic subtest: rgb565-xtiled
[606.838287] Dynamic subtest rgb565-xtiled: SUCCESS (0.581s)
[606.853885] Starting dynamic subtest: xrgb2101010-xtiled
[607.355618] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.515s)
[607.376524] Starting dynamic subtest: xbgr16161616f-xtiled
[607.972097] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.613s)
[607.988995] Starting dynamic subtest: xrgb8888-4tiled
[608.389018] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.413s)
[608.433723] Starting dynamic subtest: rgb565-4tiled
[608.739090] Dynamic subtest rgb565-4tiled: SUCCESS (0.346s)
[608.781977] Starting dynamic subtest: xrgb2101010-4tiled
[609.171286] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.429s)
[609.184819] Starting dynamic subtest: xbgr16161616f-4tiled
[609.788083] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.616s)
[609.788897] Subtest draw-method-pwrite: SUCCESS (5.728s)
[609.985342] [081/131] (416s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[610.179818] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[610.181456] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[610.388685] [082/131] (415s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[610.589040] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[610.590719] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[610.785537] [083/131] (415s left) syncobj_timeline (host-signal-points)
[610.865315] Starting subtest: host-signal-points
[610.871899] Subtest host-signal-points: SUCCESS (0.007s)
[611.043579] [084/131] (415s left) gem_mmap_gtt (basic-small-bo)
[611.120082] Subtest basic-small-bo: SKIP (0.000s)
[611.183548] [085/131] (415s left) perf_pmu (semaphore-wait-idle)
[611.252681] Starting subtest: semaphore-wait-idle
[611.253517] Starting dynamic subtest: rcs0
[611.795291] Dynamic subtest rcs0: SUCCESS (0.541s)
[611.810723] Starting dynamic subtest: bcs0
[612.306790] Dynamic subtest bcs0: SUCCESS (0.509s)
[612.323153] Starting dynamic subtest: vcs0
[612.820196] Dynamic subtest vcs0: SUCCESS (0.511s)
[612.857181] Starting dynamic subtest: vcs1
[613.338995] Dynamic subtest vcs1: SUCCESS (0.516s)
[613.355289] Starting dynamic subtest: vecs0
[613.854602] Dynamic subtest vecs0: SUCCESS (0.510s)
[613.870698] Starting dynamic subtest: vecs1
[614.367957] Dynamic subtest vecs1: SUCCESS (0.511s)
[614.384729] Starting dynamic subtest: ccs0
[614.882793] Dynamic subtest ccs0: SUCCESS (0.512s)
[614.887207] Subtest semaphore-wait-idle: SUCCESS (3.631s)
[615.088236] [086/131] (411s left) kms_addfb_basic (no-handle)
[615.165517] Starting subtest: no-handle
[615.166385] Subtest no-handle: SUCCESS (0.000s)
[615.463639] [087/131] (411s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[615.649121] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[615.650828] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[615.855165] [088/131] (410s left) gem_render_copy (yf-tiled-ccs-to-linear)
[615.955507] Starting subtest: yf-tiled-ccs-to-linear
[615.957604] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[616.236202] [089/131] (410s left) kms_flip (wf_vblank-ts-check)
[616.419826] Starting subtest: wf_vblank-ts-check
[616.424552] Starting dynamic subtest: A-DP3
[624.831321] Dynamic subtest A-DP3: SUCCESS (8.406s)
[624.858124] Starting dynamic subtest: B-DP3
[632.873112] Dynamic subtest B-DP3: SUCCESS (8.039s)
[632.888526] Starting dynamic subtest: C-DP3
[640.912544] Dynamic subtest C-DP3: SUCCESS (8.038s)
[640.928382] Starting dynamic subtest: D-DP3
[648.962428] Dynamic subtest D-DP3: SUCCESS (8.049s)
[648.964849] Subtest wf_vblank-ts-check: SUCCESS (32.544s)
[649.326938] [090/131] (377s left) gem_exec_schedule (deep)
[649.533884] Starting subtest: deep
[649.534756] Starting dynamic subtest: rcs0
[664.284332] Dynamic subtest rcs0: SUCCESS (14.750s)
[664.297910] Starting dynamic subtest: bcs0
[679.480349] Dynamic subtest bcs0: SUCCESS (15.195s)
[679.494159] Starting dynamic subtest: vcs0
[694.477769] Dynamic subtest vcs0: SUCCESS (14.996s)
[694.491283] Starting dynamic subtest: vcs1
[709.560054] Dynamic subtest vcs1: SUCCESS (15.081s)
[709.573891] Starting dynamic subtest: vecs0
[725.008301] Dynamic subtest vecs0: SUCCESS (15.446s)
[725.022261] Starting dynamic subtest: vecs1
[740.749308] Dynamic subtest vecs1: SUCCESS (15.740s)
[740.763325] Starting dynamic subtest: ccs0
[756.303159] Dynamic subtest ccs0: SUCCESS (15.552s)
[756.304078] Subtest deep: SUCCESS (106.770s)
[757.465371] [091/131] (269s left) kms_sequence (queue-idle)
[757.648438] Starting subtest: queue-idle
[757.650918] Starting dynamic subtest: pipe-A-DP-3
[760.016858] Dynamic subtest pipe-A-DP-3: SUCCESS (2.367s)
[760.031546] Starting dynamic subtest: pipe-B-DP-3
[762.281286] Dynamic subtest pipe-B-DP-3: SUCCESS (2.262s)
[762.297172] Starting dynamic subtest: pipe-C-DP-3
[764.567953] Dynamic subtest pipe-C-DP-3: SUCCESS (2.284s)
[764.588440] Starting dynamic subtest: pipe-D-DP-3
[766.863793] Dynamic subtest pipe-D-DP-3: SUCCESS (2.294s)
[766.864774] Subtest queue-idle: SUCCESS (9.215s)
[767.154630] [092/131] (259s left) gem_gtt_cpu_tlb
[767.341082] [093/131] (259s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[767.529861] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[767.531497] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[767.715240] [094/131] (259s left) gem_eio (create-ext)
[768.004397] Starting subtest: create-ext
[768.513993] Subtest create-ext: SUCCESS (0.510s)
[768.795620] [095/131] (258s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[768.883475] Subtest writes-after-reads-uncached: SKIP (0.000s)
[768.965541] [096/131] (258s left) sysfs_preempt_timeout (idempotent)
[769.053812] Starting subtest: idempotent
[769.054711] Starting dynamic subtest: vecs0
[769.055511] Dynamic subtest vecs0: SUCCESS (0.001s)
[769.071755] Starting dynamic subtest: ccs0
[769.072634] Dynamic subtest ccs0: SUCCESS (0.001s)
[769.087169] Starting dynamic subtest: vcs0
[769.088481] Dynamic subtest vcs0: SUCCESS (0.001s)
[769.102547] Starting dynamic subtest: bcs0
[769.103746] Dynamic subtest bcs0: SUCCESS (0.001s)
[769.117744] Starting dynamic subtest: vecs1
[769.118905] Dynamic subtest vecs1: SUCCESS (0.001s)
[769.132717] Starting dynamic subtest: rcs0
[769.133677] Dynamic subtest rcs0: SUCCESS (0.001s)
[769.147873] Starting dynamic subtest: vcs1
[769.149142] Dynamic subtest vcs1: SUCCESS (0.001s)
[769.150717] Subtest idempotent: SUCCESS (0.012s)
[769.203125] [097/131] (258s left) gem_busy (semaphore)
[769.443147] Subtest semaphore: SKIP (0.000s)
[769.776649] [098/131] (257s left) sriov_basic (enable-vfs-bind-unbind-each)
[769.852401] Subtest enable-vfs-bind-unbind-each: SKIP (0.000s)
[769.931494] [099/131] (257s left) kms_pm_lpsp (screens-disabled)
[771.121504] Starting subtest: screens-disabled
[771.123212] Subtest screens-disabled: SKIP (0.000s)
[771.288412] [100/131] (256s left) gem_exec_capture (capture-invisible)
[771.371889] Starting subtest: capture-invisible
[771.372874] Starting dynamic subtest: lmem0
[771.374785] Dynamic subtest lmem0: SKIP (0.000s)
[771.389067] Starting dynamic subtest: smem0
[771.391383] Dynamic subtest smem0: SKIP (0.000s)
[771.393273] Subtest capture-invisible: SKIP (0.002s)
[771.567666] [101/131] (256s left) gem_lmem_swapping (verify-ccs)
[774.182127] Starting subtest: verify-ccs
[774.182878] Starting dynamic subtest: lmem0
[819.441396] Dynamic subtest lmem0: SUCCESS (45.257s)
[819.442384] Subtest verify-ccs: SUCCESS (45.258s)
[821.504540] [FACT gem_lmem_swapping (verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[821.505538] [FACT gem_lmem_swapping (verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[821.507506] [102/131] (206s left) kms_joiner (basic-force-ultra-joiner)
[823.162100] Starting subtest: basic-force-ultra-joiner
[823.163921] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[823.360324] [FACT kms_joiner (basic-force-ultra-joiner)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[823.362900] [FACT kms_joiner (basic-force-ultra-joiner)] new: kernel.kmod_is_loaded.i915: true
[823.366087] [103/131] (204s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[823.563316] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[823.565064] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[823.733207] [104/131] (204s left) kms_color (legacy-gamma)
[823.914517] Starting subtest: legacy-gamma
[823.915410] Starting dynamic subtest: pipe-A-DP-3
[824.613102] Dynamic subtest pipe-A-DP-3: SUCCESS (0.697s)
[824.632234] Starting dynamic subtest: pipe-B-DP-3
[825.197265] Dynamic subtest pipe-B-DP-3: SUCCESS (0.581s)
[825.212362] Starting dynamic subtest: pipe-C-DP-3
[825.769191] Dynamic subtest pipe-C-DP-3: SUCCESS (0.569s)
[825.783510] Starting dynamic subtest: pipe-D-DP-3
[826.389224] Dynamic subtest pipe-D-DP-3: SUCCESS (0.620s)
[826.390152] Subtest legacy-gamma: SUCCESS (2.474s)
[826.735440] [105/131] (201s left) gem_exec_schedule (wide)
[826.978523] Starting subtest: wide
[826.979862] Starting dynamic subtest: rcs0
[840.083993] Dynamic subtest rcs0: SUCCESS (13.106s)
[840.099068] Starting dynamic subtest: bcs0
[854.076172] Dynamic subtest bcs0: SUCCESS (13.989s)
[854.090392] Starting dynamic subtest: vcs0
[868.469115] Dynamic subtest vcs0: SUCCESS (14.391s)
[868.484932] Starting dynamic subtest: vcs1
[883.649755] Dynamic subtest vcs1: SUCCESS (15.177s)
[883.666960] Starting dynamic subtest: vecs0
[897.435410] Dynamic subtest vecs0: SUCCESS (13.784s)
[897.452593] Starting dynamic subtest: vecs1
[911.786804] Dynamic subtest vecs1: SUCCESS (14.350s)
[911.800849] Starting dynamic subtest: ccs0
[926.529322] Dynamic subtest ccs0: SUCCESS (14.741s)
[926.530293] Subtest wide: SUCCESS (99.550s)
[928.626653] [106/131] ( 99s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[928.807865] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[928.810346] Starting dynamic subtest: pipe-A-valid-mode
[928.892431] Dynamic subtest pipe-A-valid-mode: SKIP (0.082s)
[928.894174] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.084s)
[929.139941] [107/131] ( 99s left) kms_big_fb (linear-64bpp-rotate-180)
[929.338431] Starting subtest: linear-64bpp-rotate-180
[931.729748] Subtest linear-64bpp-rotate-180: SUCCESS (2.391s)
[931.954318] [108/131] ( 96s left) gem_ppgtt (blt-vs-render-ctxn)
[932.038264] Starting subtest: blt-vs-render-ctxN
[965.192721] Subtest blt-vs-render-ctxN: SUCCESS (33.152s)
[965.410069] [109/131] ( 62s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[965.636267] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[965.638105] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[965.826728] [110/131] ( 62s left) kms_chamelium_frames (dp-frame-dump)
[966.123911] Subtest dp-frame-dump: SKIP (0.000s)
[966.273962] [111/131] ( 62s left) kms_psr2_su (page_flip-nv12)
[966.355111] Subtest page_flip-NV12: SKIP (0.000s)
[966.448131] [112/131] ( 62s left) gem_tiling_max_stride
[966.598735] [113/131] ( 62s left) perf_pmu (busy-idle)
[966.674246] Starting subtest: busy-idle
[966.675182] Starting dynamic subtest: rcs0
[967.408294] Dynamic subtest rcs0: SUCCESS (0.733s)
[967.427704] Starting dynamic subtest: bcs0
[968.075213] Dynamic subtest bcs0: SUCCESS (0.663s)
[968.093636] Starting dynamic subtest: vcs0
[968.747405] Dynamic subtest vcs0: SUCCESS (0.668s)
[968.767049] Starting dynamic subtest: vcs1
[969.413456] Dynamic subtest vcs1: SUCCESS (0.662s)
[969.431749] Starting dynamic subtest: vecs0
[970.079351] Dynamic subtest vecs0: SUCCESS (0.662s)
[970.101734] Starting dynamic subtest: vecs1
[970.745437] Dynamic subtest vecs1: SUCCESS (0.662s)
[970.767634] Starting dynamic subtest: ccs0
[971.413546] Dynamic subtest ccs0: SUCCESS (0.664s)
[971.418799] Subtest busy-idle: SUCCESS (4.741s)
[971.633175] [114/131] ( 57s left) dmabuf_sync_file (export-before-signal)
[971.698288] Starting subtest: export-before-signal
[971.699178] Subtest export-before-signal: SUCCESS (0.001s)
[971.864973] [115/131] ( 56s left) gem_exec_reloc (basic-cpu-read)
[971.951266] Subtest basic-cpu-read: SKIP (0.000s)
[972.048147] [116/131] ( 56s left) kms_hdr (bpc-switch)
[972.231242] Starting subtest: bpc-switch
[975.460052] Starting dynamic subtest: pipe-A-DP-3
[976.507370] Dynamic subtest pipe-A-DP-3: SUCCESS (1.047s)
[976.512805] Subtest bpc-switch: SUCCESS (4.279s)
[976.863933] [117/131] ( 52s left) perf (i915-ref-count)
[977.032306] Starting subtest: i915-ref-count
[977.330376] Subtest i915-ref-count: SUCCESS (0.297s)
[977.514946] [118/131] ( 51s left) gem_ctx_isolation (nonpriv)
[977.607903] Starting subtest: nonpriv
[977.608784] Starting dynamic subtest: rcs0
[978.470694] Dynamic subtest rcs0: SUCCESS (0.862s)
[978.487434] Starting dynamic subtest: bcs0
[979.358291] Dynamic subtest bcs0: SUCCESS (0.886s)
[979.375414] Starting dynamic subtest: vcs0
[980.265332] Dynamic subtest vcs0: SUCCESS (0.906s)
[980.282908] Starting dynamic subtest: vcs1
[981.180999] Dynamic subtest vcs1: SUCCESS (0.914s)
[981.197629] Starting dynamic subtest: vecs0
[982.056306] Dynamic subtest vecs0: SUCCESS (0.874s)
[982.073497] Starting dynamic subtest: vecs1
[982.952398] Dynamic subtest vecs1: SUCCESS (0.895s)
[982.969609] Starting dynamic subtest: ccs0
[983.871879] Dynamic subtest ccs0: SUCCESS (0.918s)
[983.872988] Subtest nonpriv: SUCCESS (6.264s)
[984.185844] [119/131] ( 44s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[984.300493] Starting subtest: y-tiled-to-vebox-x-tiled
[984.302481] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[984.604335] [120/131] ( 44s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[984.798383] Starting subtest: plane-use-after-nonblocking-unbind
[984.799334] Starting dynamic subtest: pipe-A-DP-3
[984.879080] Dynamic subtest pipe-A-DP-3: SUCCESS (0.080s)
[984.985157] Starting dynamic subtest: pipe-B-DP-3
[985.179860] Dynamic subtest pipe-B-DP-3: SUCCESS (0.220s)
[985.254011] Subtest plane-use-after-nonblocking-unbind: SUCCESS (0.456s)
[985.534365] [121/131] ( 43s left) i915_hangman (engine-error-state-capture)
[985.630320] Starting subtest: engine-error-state-capture
[985.631205] Starting dynamic subtest: rcs0
[990.413439] Dynamic subtest rcs0: SUCCESS (4.783s)
[990.431411] Starting dynamic subtest: bcs0
[993.389406] Dynamic subtest bcs0: SUCCESS (2.974s)
[993.408156] Starting dynamic subtest: vcs0
[997.411290] Dynamic subtest vcs0: SUCCESS (4.020s)
[997.428785] Starting dynamic subtest: vcs1
[1001.390503] Dynamic subtest vcs1: SUCCESS (3.978s)
[1001.409681] Starting dynamic subtest: vecs0
[1005.441481] Dynamic subtest vecs0: SUCCESS (4.049s)
[1005.460643] Starting dynamic subtest: vecs1
[1009.371163] Dynamic subtest vecs1: SUCCESS (3.928s)
[1009.388528] Starting dynamic subtest: ccs0
[1013.425176] Dynamic subtest ccs0: SUCCESS (4.053s)
[1013.426129] Subtest engine-error-state-capture: SUCCESS (27.795s)
[1013.654673] [122/131] ( 15s left) gem_exec_schedule (pi-shared-iova)
[1013.859434] Starting subtest: pi-shared-iova
[1013.860390] Starting dynamic subtest: rcs0
[1014.119064] Dynamic subtest rcs0: SUCCESS (0.259s)
[1014.134047] Starting dynamic subtest: bcs0
[1014.297493] Dynamic subtest bcs0: SUCCESS (0.177s)
[1014.312280] Starting dynamic subtest: vcs0
[1014.485303] Dynamic subtest vcs0: SUCCESS (0.187s)
[1014.500953] Starting dynamic subtest: vcs1
[1014.671766] Dynamic subtest vcs1: SUCCESS (0.185s)
[1014.686755] Starting dynamic subtest: vecs0
[1014.866386] Dynamic subtest vecs0: SUCCESS (0.194s)
[1014.881259] Starting dynamic subtest: vecs1
[1015.056444] Dynamic subtest vecs1: SUCCESS (0.186s)
[1015.071448] Starting dynamic subtest: ccs0
[1015.243140] Dynamic subtest ccs0: SUCCESS (0.189s)
[1015.244071] Subtest pi-shared-iova: SUCCESS (1.384s)
[1015.677889] [123/131] ( 13s left) syncobj_wait (invalid-reset-illegal-handle)
[1015.757174] Starting subtest: invalid-reset-illegal-handle
[1015.758090] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[1015.950381] [124/131] ( 13s left) syncobj_wait (single-wait-all-for-submit-signaled)
[1016.031217] Starting subtest: single-wait-all-for-submit-signaled
[1016.032138] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[1016.228788] [125/131] ( 13s left) kms_cursor_crc (cursor-sliding-512x170)
[1016.711268] Starting subtest: cursor-sliding-512x170
[1016.713123] Subtest cursor-sliding-512x170: SKIP (0.001s)
[1016.973089] [126/131] ( 12s left) kms_chamelium_hpd (hdmi-hpd-fast)
[1017.230387] Subtest hdmi-hpd-fast: SKIP (0.000s)
[1017.376709] [127/131] ( 12s left) gem_ctx_persistence (hostile)
[1017.465310] Starting subtest: hostile
[1026.976137] Subtest hostile: SUCCESS (9.506s)
[1027.170217] [128/131] (  2s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[1027.360139] Starting subtest: fbc-rgb565-draw-blt
[1030.002578] Subtest fbc-rgb565-draw-blt: SUCCESS (2.643s)
[1030.218036] Overall timeout time exceeded, stopping.
[1030.249877] 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: no output, setting notrun
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
Done.