[57.777352] Initializing watchdogs
[57.777399]   /dev/watchdog0
[57.792283] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.796714] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.798937] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.800749] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[57.904641] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[57.906490] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[57.985970] [002/133] (960s left) gem_flink_basic (double-flink)
[58.029081] Starting subtest: double-flink
[58.030086] Subtest double-flink: SUCCESS (0.000s)
[58.123427] [003/133] (960s left) gem_exec_fence (invalid-timeline-fence-array)
[58.683614] Starting subtest: invalid-timeline-fence-array
[58.684928] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[60.391249] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[60.392883] [004/133] (957s left) kms_joiner (invalid-modeset-ultra-joiner)
[60.479942] Starting subtest: invalid-modeset-ultra-joiner
[60.481843] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[60.544569] [005/133] (957s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[60.638270] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[65.085921] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.450s)
[66.245585] [006/133] (952s left) gem_exec_schedule (semaphore-codependency)
[66.302236] Starting subtest: semaphore-codependency
[66.315110] Subtest semaphore-codependency: SUCCESS (0.014s)
[66.669589] [007/133] (951s left) kms_cursor_edge_walk (64x64-right-edge)
[66.756103] Starting subtest: 64x64-right-edge
[66.756947] Starting dynamic subtest: pipe-A-eDP-1
[70.212076] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.456s)
[70.218647] Starting dynamic subtest: pipe-D-eDP-1
[73.322786] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.109s)
[73.323773] Subtest 64x64-right-edge: SUCCESS (6.568s)
[74.142555] [008/133] (944s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[74.234573] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[74.236740] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[74.334168] [009/133] (944s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[74.445287] Starting subtest: cursorA-vs-flipA-toggle
[85.563533] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.119s)
[86.357326] [010/133] (932s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[86.460301] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[86.462104] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[86.558874] [011/133] (932s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[86.614150] Subtest writes-after-reads-uncached: SKIP (0.000s)
[86.678862] [012/133] (931s left) kms_hdr (invalid-metadata-sizes)
[86.763881] Starting subtest: invalid-metadata-sizes
[86.766461] Subtest invalid-metadata-sizes: SKIP (0.000s)
[86.833053] [013/133] (931s left) gem_tiled_partial_pwrite_pread (reads)
[86.892671] Subtest reads: SKIP (0.000s)
[86.947510] [014/133] (931s left) kms_async_flips (test-cursor-atomic)
[87.040235] Starting subtest: test-cursor-atomic
[87.418622] Starting dynamic subtest: pipe-A-eDP-1
[88.165431] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.747s)
[88.558381] Starting dynamic subtest: pipe-B-eDP-1
[89.300129] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.748s)
[89.667506] Starting dynamic subtest: pipe-C-eDP-1
[90.435091] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.774s)
[90.798861] Starting dynamic subtest: pipe-D-eDP-1
[91.569048] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.777s)
[91.570054] Subtest test-cursor-atomic: SUCCESS (4.531s)
[92.742279] [015/133] (926s left) kms_busy (extended-modeset-hang-newfb)
[92.839348] Starting subtest: extended-modeset-hang-newfb
[92.840377] Starting dynamic subtest: pipe-A
[127.272101] Dynamic subtest pipe-A: SUCCESS (34.432s)
[127.280918] Starting dynamic subtest: pipe-D
[150.243302] Dynamic subtest pipe-D: SUCCESS (22.967s)
[150.244153] Subtest extended-modeset-hang-newfb: SUCCESS (57.403s)
[151.028219] [016/133] (867s left) syncobj_timeline (wait-all-delayed-signal)
[151.092698] Starting subtest: wait-all-delayed-signal
[151.199033] Subtest wait-all-delayed-signal: SUCCESS (0.105s)
[151.284406] [017/133] (867s left) kms_pm_dc (dc5-psr)
[152.388343] Starting subtest: dc5-psr
[155.265603] Subtest dc5-psr: SUCCESS (2.881s)
[156.065969] [018/133] (862s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[156.155844] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[156.157639] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[156.252621] [019/133] (862s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[156.347391] Starting subtest: y-tiled-16bpp-rotate-270
[156.349240] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[156.431180] [020/133] (862s left) kms_psr (fbc-psr2-suspend)
[156.519579] Starting subtest: fbc-psr2-suspend
[156.520484] Starting dynamic subtest: eDP-1
[156.522268] Dynamic subtest eDP-1: SKIP (0.000s)
[156.523825] Subtest fbc-psr2-suspend: SKIP (0.001s)
[156.597043] [021/133] (862s left) gem_exec_basic (basic)
[156.646146] Starting subtest: basic
[156.647125] Starting dynamic subtest: rcs0-smem
[156.649298] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[156.657216] Starting dynamic subtest: bcs0-smem
[156.658032] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[156.664420] Starting dynamic subtest: vcs0-smem
[156.665276] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[156.671679] Starting dynamic subtest: vcs1-smem
[156.672740] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[156.678891] Starting dynamic subtest: vecs0-smem
[156.679762] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[156.685884] Starting dynamic subtest: ccs0-smem
[156.686782] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[156.687672] Subtest basic: SUCCESS (0.013s)
[158.331805] [022/133] (860s left) gem_ctx_persistence (heartbeat-many)
[158.397617] Starting subtest: heartbeat-many
[158.399567] Subtest heartbeat-many: SKIP (0.000s)
[158.516954] [023/133] (860s left) api_intel_allocator (reloc-allocator)
[158.565445] Starting subtest: reloc-allocator
[158.566422] Starting dynamic subtest: basic
[158.568619] Dynamic subtest basic: SUCCESS (0.004s)
[158.581159] Starting dynamic subtest: parallel-one
[158.582035] Dynamic subtest parallel-one: SUCCESS (0.007s)
[158.593608] Starting dynamic subtest: print
[158.594458] Dynamic subtest print: SUCCESS (0.000s)
[158.600962] Starting dynamic subtest: reuse
[158.601830] Dynamic subtest reuse: SUCCESS (0.000s)
[158.608327] Starting dynamic subtest: fork-reopen-allocator
[158.609156] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[158.609982] Subtest reloc-allocator: SUCCESS (0.023s)
[158.722278] [024/133] (860s left) kms_flip (flip-vs-panning-vs-hang)
[158.801755] Starting subtest: flip-vs-panning-vs-hang
[158.804044] Starting dynamic subtest: A-eDP1
[209.798375] Dynamic subtest A-eDP1: SUCCESS (50.994s)
[209.808447] Starting dynamic subtest: D-eDP1
[257.799241] Dynamic subtest D-eDP1: SUCCESS (47.997s)
[257.801720] Subtest flip-vs-panning-vs-hang: SUCCESS (98.997s)
[258.947340] [025/133] (760s left) kms_chamelium_frames (vga-frame-dump)
[259.326964] Subtest vga-frame-dump: SKIP (0.000s)
[260.147258] [026/133] (758s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[260.248307] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[260.250085] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[260.356025] [027/133] (758s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[260.635321] Starting subtest: cursor-rapid-movement-max-size
[260.638185] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[260.767971] [028/133] (758s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[260.826196] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[260.927929] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.101s)
[261.025267] [029/133] (758s left) kms_psr (fbc-psr2-dpms)
[261.107508] Starting subtest: fbc-psr2-dpms
[261.108457] Starting dynamic subtest: eDP-1
[261.110286] Dynamic subtest eDP-1: SKIP (0.000s)
[261.111956] Subtest fbc-psr2-dpms: SKIP (0.001s)
[261.178618] [030/133] (758s left) kms_flip (flip-vs-rmfb-interruptible)
[261.266590] Starting subtest: flip-vs-rmfb-interruptible
[261.269187] Starting dynamic subtest: A-eDP1
[269.894964] Dynamic subtest A-eDP1: SUCCESS (8.625s)
[269.903258] Starting dynamic subtest: B-eDP1
[278.530692] Dynamic subtest B-eDP1: SUCCESS (8.633s)
[278.538839] Starting dynamic subtest: C-eDP1
[287.153261] Dynamic subtest C-eDP1: SUCCESS (8.620s)
[287.161199] Starting dynamic subtest: D-eDP1
[295.792521] Dynamic subtest D-eDP1: SUCCESS (8.637s)
[295.795800] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.527s)
[296.975054] [031/133] (722s left) i915_suspend (fence-restore-untiled)
[297.029360] Starting subtest: fence-restore-untiled
[297.031148] Subtest fence-restore-untiled: SKIP (0.000s)
[297.120757] [032/133] (722s left) gem_ctx_bad_destroy (invalid-default-ctx)
[297.175479] Starting subtest: invalid-default-ctx
[297.176709] Subtest invalid-default-ctx: SUCCESS (0.000s)
[297.255408] [033/133] (722s left) kms_flip (2x-modeset-vs-vblank-race)
[297.343169] Starting subtest: 2x-modeset-vs-vblank-race
[297.353831] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[297.438110] [034/133] (721s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[297.527753] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[297.529567] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[297.632085] [035/133] (721s left) vgem_basic (bad-flag)
[297.661826] Starting subtest: bad-flag
[297.663023] Subtest bad-flag: SUCCESS (0.000s)
[297.711920] [036/133] (721s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[297.814594] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[297.835249] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[297.876984] [037/133] (721s left) i915_drm_fdinfo (basics)
[297.916260] Starting subtest: basics
[297.917184] Subtest basics: SUCCESS (0.000s)
[297.976957] [038/133] (721s left) gem_workarounds (basic-read-fd)
[298.032802] Starting subtest: basic-read-fd
[298.044902] Subtest basic-read-fd: SUCCESS (0.012s)
[298.167837] [039/133] (721s left) kms_prop_blob (invalid-set-prop-any)
[298.230456] Starting subtest: invalid-set-prop-any
[298.231590] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[298.343684] [040/133] (721s left) i915_pm_rpm (gem-execbuf)
[300.466650] Starting subtest: gem-execbuf
[300.467963] Starting dynamic subtest: smem0
[302.197504] Dynamic subtest smem0: SUCCESS (1.733s)
[302.198429] Subtest gem-execbuf: SUCCESS (1.735s)
[302.275538] [041/133] (717s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[302.357412] Starting subtest: plane-lut1d-pre-ctm3x4
[302.505123] Starting dynamic subtest: pipe-A-plane-0
[302.707158] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[302.714060] Starting dynamic subtest: pipe-A-plane-1
[302.871686] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[302.879030] Starting dynamic subtest: pipe-A-plane-2
[303.027047] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[304.267074] Starting dynamic subtest: pipe-B-plane-0
[304.438627] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[304.445896] Starting dynamic subtest: pipe-B-plane-1
[304.605394] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[304.612361] Starting dynamic subtest: pipe-B-plane-2
[304.771972] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[305.998863] Starting dynamic subtest: pipe-C-plane-0
[306.147654] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[306.154565] Starting dynamic subtest: pipe-C-plane-1
[306.314651] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[306.321878] Starting dynamic subtest: pipe-C-plane-2
[306.458738] Dynamic subtest pipe-C-plane-2: SUCCESS (0.143s)
[307.624381] Starting dynamic subtest: pipe-D-plane-0
[307.773665] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[307.780628] Starting dynamic subtest: pipe-D-plane-1
[307.918061] Dynamic subtest pipe-D-plane-1: SUCCESS (0.143s)
[307.924875] Starting dynamic subtest: pipe-D-plane-2
[308.062460] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[308.359518] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (6.002s)
[309.181280] [042/133] (710s left) kms_async_flips (crc)
[309.280579] Starting subtest: crc
[309.663794] Starting dynamic subtest: pipe-A-eDP-1
[312.614524] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.950s)
[313.002491] Starting dynamic subtest: pipe-B-eDP-1
[315.955686] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.959s)
[316.342207] Starting dynamic subtest: pipe-C-eDP-1
[319.263512] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.928s)
[319.624758] Starting dynamic subtest: pipe-D-eDP-1
[322.493498] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.874s)
[322.494376] Subtest crc: SUCCESS (13.214s)
[323.657094] [043/133] (696s left) gem_mmap_wc (bad-offset)
[323.707203] Subtest bad-offset: SKIP (0.000s)
[323.770798] [044/133] (695s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[324.163254] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[324.962264] [045/133] (694s left) gem_ctx_create (basic)
[325.030531] Starting subtest: basic
[325.031519] Subtest basic: SUCCESS (0.000s)
[325.203566] [046/133] (694s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[325.297085] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[325.298803] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[325.414067] [047/133] (694s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[325.457724] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[325.514473] [048/133] (694s left) gem_exec_reloc (basic-cpu)
[325.582857] Subtest basic-cpu: SKIP (0.000s)
[325.650010] [049/133] (694s left) gem_mmap_offset (mmap-boundaries)
[325.700030] Starting subtest: mmap-boundaries
[325.700908] Starting dynamic subtest: smem0
[325.980168] Dynamic subtest smem0: SUCCESS (0.280s)
[325.981323] Subtest mmap-boundaries: SUCCESS (0.281s)
[326.087588] [050/133] (693s left) gem_eio (in-flight-contexts-10ms)
[326.325496] Starting subtest: in-flight-contexts-10ms
[340.268133] Subtest in-flight-contexts-10ms: SUCCESS (13.942s)
[340.437174] [051/133] (679s left) gem_exec_whisper (basic-contexts-priority-all)
[340.509508] Starting subtest: basic-contexts-priority-all
[363.475203] Subtest basic-contexts-priority-all: SUCCESS (22.954s)
[363.644399] [052/133] (656s left) kms_big_fb (linear-8bpp-rotate-180)
[363.740272] Starting subtest: linear-8bpp-rotate-180
[365.011402] Subtest linear-8bpp-rotate-180: SUCCESS (1.271s)
[365.162195] [053/133] (654s left) sw_sync (sync_busy_fork)
[365.195898] Starting subtest: sync_busy_fork
[366.216245] Subtest sync_busy_fork: SUCCESS (1.011s)
[366.262161] [054/133] (653s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[366.357440] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[366.358600] Starting dynamic subtest: pipe-A-default-mode
[369.144010] Dynamic subtest pipe-A-default-mode: SUCCESS (2.787s)
[369.144925] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.788s)
[369.976189] [055/133] (650s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[370.068392] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[370.069878] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[370.160702] [056/133] (649s left) gem_gpgpu_fill (offset-16x16)
[370.205331] Starting subtest: offset-16x16
[370.213544] Subtest offset-16x16: SUCCESS (0.008s)
[370.352835] [057/133] (649s left) dmabuf_sync_file (import-basic)
[370.391355] Starting subtest: import-basic
[370.394280] Subtest import-basic: SUCCESS (0.002s)
[370.441645] [058/133] (649s left) gem_ctx_bad_destroy (invalid-pad)
[370.480475] Starting subtest: invalid-pad
[370.481564] Subtest invalid-pad: SUCCESS (0.000s)
[370.544382] [059/133] (649s left) core_auth (basic-auth)
[370.588399] Starting subtest: basic-auth
[370.589295] Subtest basic-auth: SUCCESS (0.001s)
[370.684747] [060/133] (649s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[370.780211] Starting subtest: yf-tiled-16bpp-rotate-90
[370.782059] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[370.876070] [061/133] (649s left) kms_dp_link_training (non-uhbr-mst)
[370.954240] Starting subtest: non-uhbr-mst
[370.957466] Subtest non-uhbr-mst: SKIP (0.000s)
[371.021766] [062/133] (649s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[371.100406] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[371.101179] Starting dynamic subtest: pipe-A-eDP-1
[372.004737] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.901s)
[372.013061] Starting dynamic subtest: pipe-B-eDP-1
[373.522948] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.517s)
[373.530888] Starting dynamic subtest: pipe-C-eDP-1
[374.986823] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.462s)
[374.999432] Starting dynamic subtest: pipe-D-eDP-1
[376.545717] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.557s)
[376.546612] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.444s)
[377.705073] [063/133] (642s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[377.820367] Starting subtest: yf-tiled-8bpp-rotate-0
[377.822200] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[377.913044] [064/133] (642s left) gem_basic (multigpu-create-close)
[377.963994] Starting subtest: multigpu-create-close
[377.966183] Subtest multigpu-create-close: SKIP (0.000s)
[378.086666] [065/133] (642s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[378.174489] Starting subtest: flip-vs-dpms-off-vs-modeset
[378.175427] Starting dynamic subtest: A-eDP1
[381.757033] Dynamic subtest A-eDP1: SUCCESS (3.581s)
[381.765854] Starting dynamic subtest: B-eDP1
[384.964629] Dynamic subtest B-eDP1: SUCCESS (3.206s)
[384.972466] Starting dynamic subtest: C-eDP1
[388.077293] Dynamic subtest C-eDP1: SUCCESS (3.111s)
[388.085372] Starting dynamic subtest: D-eDP1
[391.195782] Dynamic subtest D-eDP1: SUCCESS (3.118s)
[391.197963] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.024s)
[391.991084] [066/133] (628s left) gem_exec_balancer (full)
[392.061558] Starting subtest: full
[397.291469] Subtest full: SUCCESS (5.229s)
[397.603938] [067/133] (622s left) i915_hangman (engine-engine-error)
[397.664792] Starting subtest: engine-engine-error
[397.665854] Starting dynamic subtest: rcs0
[399.300987] Dynamic subtest rcs0: SUCCESS (1.627s)
[399.312939] Starting dynamic subtest: bcs0
[401.283492] Dynamic subtest bcs0: SUCCESS (1.980s)
[401.294805] Starting dynamic subtest: vcs0
[403.331347] Dynamic subtest vcs0: SUCCESS (2.045s)
[403.342403] Starting dynamic subtest: vcs1
[405.316597] Dynamic subtest vcs1: SUCCESS (1.982s)
[405.330019] Starting dynamic subtest: vecs0
[407.300467] Dynamic subtest vecs0: SUCCESS (1.981s)
[407.310556] Starting dynamic subtest: ccs0
[409.284061] Dynamic subtest ccs0: SUCCESS (1.982s)
[409.285366] Subtest engine-engine-error: SUCCESS (11.612s)
[409.352296] [068/133] (611s left) gem_mmap_gtt (basic-small-bo-tiledy)
[409.404351] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[409.462840] [069/133] (611s left) kms_frontbuffer_tracking (basic)
[409.573328] Starting subtest: basic
[412.897793] Subtest basic: SUCCESS (3.325s)
[412.998335] [070/133] (607s left) api_intel_bb (reset-flags)
[413.055094] Starting subtest: reset-flags
[413.060949] Subtest reset-flags: SUCCESS (0.007s)
[413.175207] [071/133] (607s left) kms_flip (flip-vs-absolute-wf_vblank)
[413.273342] Starting subtest: flip-vs-absolute-wf_vblank
[413.275603] Starting dynamic subtest: A-eDP1
[422.242072] Dynamic subtest A-eDP1: SUCCESS (8.966s)
[422.256231] Starting dynamic subtest: B-eDP1
[431.172679] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[431.183819] Starting dynamic subtest: C-eDP1
[440.133061] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[440.143232] Starting dynamic subtest: D-eDP1
[449.033248] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[449.037362] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.763s)
[450.262405] [072/133] (570s left) kms_plane_scaling (planes-upscale-20x20)
[450.354787] Starting subtest: planes-upscale-20x20
[450.355699] Starting dynamic subtest: pipe-A
[450.415948] Dynamic subtest pipe-A: SUCCESS (0.062s)
[450.426355] Starting dynamic subtest: pipe-B
[451.592550] Dynamic subtest pipe-B: SUCCESS (1.175s)
[451.604201] Starting dynamic subtest: pipe-C
[452.717467] Dynamic subtest pipe-C: SUCCESS (1.123s)
[452.732526] Starting dynamic subtest: pipe-D
[453.852968] Dynamic subtest pipe-D: SUCCESS (1.134s)
[453.853870] Subtest planes-upscale-20x20: SUCCESS (3.500s)
[455.002952] [073/133] (565s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[455.094439] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[455.096244] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[455.159660] [074/133] (565s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[455.247104] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[455.248855] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[455.339765] [075/133] (565s left) kms_sequence (get-busy)
[455.428491] Starting subtest: get-busy
[455.429423] Starting dynamic subtest: pipe-A-eDP-1
[457.362806] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s)
[457.371312] Starting dynamic subtest: pipe-B-eDP-1
[460.019800] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.656s)
[460.028062] Starting dynamic subtest: pipe-C-eDP-1
[462.634121] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.614s)
[462.642608] Starting dynamic subtest: pipe-D-eDP-1
[465.257871] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.623s)
[465.258656] Subtest get-busy: SUCCESS (9.831s)
[466.066041] [076/133] (554s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[466.160343] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[466.162087] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[466.251155] [077/133] (554s left) gem_vm_create (execbuf)
[466.308061] Starting subtest: execbuf
[466.313465] Subtest execbuf: SUCCESS (0.007s)
[466.424375] [078/133] (554s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[466.528350] Starting subtest: 4-tiled-32bpp-rotate-90
[466.550243] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.021s)
[466.659304] [079/133] (554s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[466.706507] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[466.773527] [080/133] (554s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[466.823544] Starting subtest: single-wait-all-for-submit-unsubmitted
[466.929376] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[467.003430] [081/133] (553s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[467.084945] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[467.086635] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[467.181030] [082/133] (553s left) gen7_exec_parse (oacontrol-tracking)
[467.225454] Subtest oacontrol-tracking: SKIP (0.000s)
[467.285600] [083/133] (553s left) kms_vrr (negative-basic)
[467.376518] Starting subtest: negative-basic
[467.379322] Starting dynamic subtest: pipe-A-eDP-1
[472.839223] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.413s)
[473.078484] Subtest negative-basic: SUCCESS (5.702s)
[473.873567] [084/133] (547s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[473.974620] Starting subtest: stress-xrgb8888-4tiled
[479.762519] Subtest stress-xrgb8888-4tiled: SUCCESS (5.788s)
[479.808642] [085/133] (541s left) kms_addfb_basic (no-handle)
[479.857187] Starting subtest: no-handle
[479.858198] Subtest no-handle: SUCCESS (0.000s)
[479.981039] [086/133] (541s left) kms_psr (psr2-dpms)
[480.066066] Starting subtest: psr2-dpms
[480.066824] Starting dynamic subtest: eDP-1
[482.921520] Dynamic subtest eDP-1: SUCCESS (2.854s)
[482.922429] Subtest psr2-dpms: SUCCESS (2.856s)
[483.793285] [087/133] (537s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[483.846985] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[483.903178] [088/133] (537s left) gem_exec_params (no-bsd)
[483.957705] Starting subtest: no-bsd
[483.958909] Subtest no-bsd: SUCCESS (0.002s)
[485.395141] [089/133] (535s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[485.479267] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[485.480971] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[485.565022] [090/133] (535s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[485.644465] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[485.671761] Starting dynamic subtest: pipe-A-plane-0
[486.093693] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[486.101713] Starting dynamic subtest: pipe-A-plane-3
[486.349080] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[487.491915] Starting dynamic subtest: pipe-B-plane-0
[487.915806] Dynamic subtest pipe-B-plane-0: SUCCESS (0.432s)
[487.923911] Starting dynamic subtest: pipe-B-plane-3
[488.182669] Dynamic subtest pipe-B-plane-3: SUCCESS (0.266s)
[488.492096] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.849s)
[489.401365] [091/133] (531s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[489.527613] Starting subtest: dp-mst-type-1-suspend-resume
[489.529538] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[489.651353] [092/133] (531s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[489.742093] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[496.526508] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.786s)
[496.669845] [093/133] (524s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[496.765409] Starting subtest: plane-use-after-nonblocking-unbind
[496.766305] Starting dynamic subtest: pipe-A-eDP-1
[496.828095] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[497.124330] Starting dynamic subtest: pipe-B-eDP-1
[497.899764] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.787s)
[498.228553] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.462s)
[499.056244] [094/133] (522s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[499.112832] Starting subtest: etime-multi-wait-all-for-submit-submitted
[499.216382] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.103s)
[499.291128] [095/133] (522s left) kms_psr (psr-sprite-plane-onoff)
[499.381145] Starting subtest: psr-sprite-plane-onoff
[499.381978] Starting dynamic subtest: eDP-1
[501.120428] Dynamic subtest eDP-1: SUCCESS (1.739s)
[501.121299] Subtest psr-sprite-plane-onoff: SUCCESS (1.740s)
[501.945841] [096/133] (519s left) perf_pmu (busy-no-semaphores)
[501.988487] Starting subtest: busy-no-semaphores
[501.989589] Starting dynamic subtest: rcs0
[502.527480] Dynamic subtest rcs0: SUCCESS (0.528s)
[502.538298] Starting dynamic subtest: bcs0
[503.078332] Dynamic subtest bcs0: SUCCESS (0.548s)
[503.088961] Starting dynamic subtest: vcs0
[503.629184] Dynamic subtest vcs0: SUCCESS (0.547s)
[503.639661] Starting dynamic subtest: vcs1
[504.871517] Dynamic subtest vcs1: SUCCESS (1.239s)
[504.881330] Starting dynamic subtest: vecs0
[506.853691] Dynamic subtest vecs0: SUCCESS (1.978s)
[506.863617] Starting dynamic subtest: ccs0
[508.841936] Dynamic subtest ccs0: SUCCESS (1.985s)
[508.843218] Subtest busy-no-semaphores: SUCCESS (6.845s)
[508.946887] [097/133] (512s left) kms_vblank (wait-forked)
[509.030249] Starting subtest: wait-forked
[509.031058] Starting dynamic subtest: pipe-A-eDP-1
[510.853095] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.822s)
[510.862936] Starting dynamic subtest: pipe-D-eDP-1
[513.343205] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.488s)
[513.344083] Subtest wait-forked: SUCCESS (4.313s)
[514.201036] [098/133] (507s left) gem_mmap_gtt (basic-write-read-distinct)
[514.248741] Subtest basic-write-read-distinct: SKIP (0.000s)
[514.300900] [099/133] (507s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[514.386739] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[518.778541] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.392s)
[519.930750] [100/133] (501s left) kms_psr (pr-dpms)
[520.016367] Starting subtest: pr-dpms
[520.018077] Subtest pr-dpms: SKIP (0.000s)
[520.083702] [101/133] (501s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[520.171910] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[520.173718] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[520.267878] [102/133] (501s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[520.356614] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[520.357681] Starting dynamic subtest: pipe-A-eDP-1
[531.683449] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.325s)
[531.692463] Starting dynamic subtest: pipe-B-eDP-1
[543.677248] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.991s)
[543.678085] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.319s)
[544.520306] [103/133] (477s left) syncobj_basic (bad-flags-handle-to-fd)
[544.583061] Starting subtest: bad-flags-handle-to-fd
[544.584034] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[544.688142] [104/133] (477s left) syncobj_timeline (multi-wait-all-available-signaled)
[544.750557] Starting subtest: multi-wait-all-available-signaled
[544.751501] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[544.845289] [105/133] (476s left) gem_spin_batch (resubmit-new-all)
[544.899997] Starting subtest: resubmit-new-all
[544.901123] Starting dynamic subtest: rcs0
[544.912177] Dynamic subtest rcs0: SUCCESS (0.012s)
[544.922591] Starting dynamic subtest: bcs0
[544.923637] Dynamic subtest bcs0: SUCCESS (0.010s)
[544.933490] Starting dynamic subtest: vcs0
[544.934367] Dynamic subtest vcs0: SUCCESS (0.008s)
[544.942234] Starting dynamic subtest: vcs1
[544.943042] Dynamic subtest vcs1: SUCCESS (0.009s)
[544.950846] Starting dynamic subtest: vecs0
[544.951748] Dynamic subtest vecs0: SUCCESS (0.009s)
[544.961359] Starting dynamic subtest: ccs0
[544.962264] Dynamic subtest ccs0: SUCCESS (0.011s)
[544.963171] Subtest resubmit-new-all: SUCCESS (0.063s)
[546.371158] [106/133] (475s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[546.469143] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[546.470717] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[546.575232] [107/133] (475s left) gem_ctx_engines (execute-one)
[546.634365] Starting subtest: execute-one
[549.237130] Subtest execute-one: SUCCESS (2.602s)
[549.424191] [108/133] (472s left) kms_pm_rpm (modeset-stress-extra-wait)
[551.458138] Starting subtest: modeset-stress-extra-wait
[605.752231] Subtest modeset-stress-extra-wait: SUCCESS (54.243s)
[605.793743] [109/133] (416s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[605.902618] Starting subtest: flip-vs-cursor-crc-legacy
[606.594063] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.691s)
[607.407518] [110/133] (414s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[607.506227] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[607.507077] Starting dynamic subtest: pipe-A-eDP-1
[608.352702] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.844s)
[608.360701] Starting dynamic subtest: pipe-B-eDP-1
[609.939924] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.586s)
[609.948656] Starting dynamic subtest: pipe-C-eDP-1
[611.412200] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.471s)
[611.420364] Starting dynamic subtest: pipe-D-eDP-1
[612.946615] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.533s)
[612.947493] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.438s)
[614.130804] [111/133] (407s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[614.196516] Starting subtest: single-wait-for-submit-unsubmitted
[614.304750] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[614.375538] [112/133] (407s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[614.425146] Starting subtest: y-tiled-to-vebox-y-tiled
[614.427043] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[614.618439] [113/133] (407s left) kms_plane_multiple (tiling-x)
[614.701274] Starting subtest: tiling-x
[614.702120] Starting dynamic subtest: pipe-A-eDP-1
[618.434091] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.731s)
[618.442355] Starting dynamic subtest: pipe-B-eDP-1
[622.780295] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.346s)
[622.788344] Starting dynamic subtest: pipe-C-eDP-1
[627.096216] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.314s)
[627.109990] Starting dynamic subtest: pipe-D-eDP-1
[631.395746] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.298s)
[631.396660] Subtest tiling-x: SUCCESS (16.694s)
[632.211787] [114/133] (389s left) gem_render_copy (yf-tiled)
[632.264789] Starting subtest: yf-tiled
[632.266568] Subtest yf-tiled: SKIP (0.000s)
[632.440532] [115/133] (389s left) gem_ctx_shared (q-smoketest-all)
[632.504377] Starting subtest: Q-smoketest-all
[664.894692] Subtest Q-smoketest-all: SUCCESS (32.362s)
[666.309513] [116/133] (355s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[666.447392] Starting subtest: multiplane-atomic-fence-wait
[666.766041] Subtest multiplane-atomic-fence-wait: SUCCESS (0.319s)
[667.932140] [117/133] (354s left) gem_shrink (reclaim)
[667.997799] Starting subtest: reclaim
[670.409643] Subtest reclaim: SUCCESS (2.410s)
[670.577599] [118/133] (351s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[670.665866] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[670.667626] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[670.753205] [119/133] (351s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[670.836691] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[670.837681] Starting dynamic subtest: pipe-A-eDP-1
[670.983462] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.142s)
[670.994860] Starting dynamic subtest: pipe-B-eDP-1
[671.003239] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[671.013798] Starting dynamic subtest: pipe-C-eDP-1
[671.021396] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[671.029304] Starting dynamic subtest: pipe-D-eDP-1
[671.037031] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[671.037970] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.180s)
[673.311960] [120/133] (349s left) gem_exec_parallel (userptr)
[673.367778] Starting subtest: userptr
[673.368751] Starting dynamic subtest: rcs0
[674.804554] Dynamic subtest rcs0: SUCCESS (1.438s)
[674.816633] Starting dynamic subtest: bcs0
[676.261835] Dynamic subtest bcs0: SUCCESS (1.455s)
[676.272879] Starting dynamic subtest: vcs0
[678.309416] Dynamic subtest vcs0: SUCCESS (2.037s)
[678.322779] Starting dynamic subtest: vcs1
[680.356624] Dynamic subtest vcs1: SUCCESS (2.045s)
[680.368932] Starting dynamic subtest: vecs0
[682.277117] Dynamic subtest vecs0: SUCCESS (1.918s)
[682.285956] Starting dynamic subtest: ccs0
[683.759635] Dynamic subtest ccs0: SUCCESS (1.489s)
[683.761936] Subtest userptr: SUCCESS (10.394s)
[683.969303] [121/133] (338s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[684.073091] Starting subtest: x-tiled-16bpp-rotate-0
[685.363673] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.291s)
[685.481882] [122/133] (336s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[685.568450] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[685.569388] Starting dynamic subtest: pipe-A-eDP-1
[685.578425] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[685.587714] Starting dynamic subtest: pipe-B-eDP-1
[685.596387] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[685.607380] Starting dynamic subtest: pipe-C-eDP-1
[685.615725] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[685.623572] Starting dynamic subtest: pipe-D-eDP-1
[685.632276] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[685.633843] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[687.859387] [123/133] (334s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[687.953299] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[687.954180] Starting dynamic subtest: pipe-A
[688.192982] Dynamic subtest pipe-A: SUCCESS (0.240s)
[688.201373] Starting dynamic subtest: pipe-B
[689.539774] Dynamic subtest pipe-B: SUCCESS (1.346s)
[689.547910] Starting dynamic subtest: pipe-C
[690.870481] Dynamic subtest pipe-C: SUCCESS (1.330s)
[690.878872] Starting dynamic subtest: pipe-D
[692.191186] Dynamic subtest pipe-D: SUCCESS (1.319s)
[692.192096] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.238s)
[693.370139] [124/133] (329s left) gem_exec_params (cliprects_ptr-dirt)
[693.427914] Starting subtest: cliprects_ptr-dirt
[693.428907] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[693.519090] [125/133] (329s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[693.570192] Starting subtest: multi-wait-available-unsubmitted-signaled
[693.571039] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[693.688281] [126/133] (328s left) kms_lease (cursor-implicit-plane)
[693.778370] Starting subtest: cursor-implicit-plane
[693.779130] Starting dynamic subtest: pipe-A-eDP-1
[694.235816] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.457s)
[694.244024] Starting dynamic subtest: pipe-B-eDP-1
[695.392308] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.156s)
[695.402726] Starting dynamic subtest: pipe-C-eDP-1
[696.514537] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.120s)
[696.525407] Starting dynamic subtest: pipe-D-eDP-1
[697.639549] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s)
[697.640620] Subtest cursor-implicit-plane: SUCCESS (3.862s)
[698.507485] [127/133] (324s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[698.607176] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[698.608899] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[698.697737] [128/133] (323s left) gem_ctx_isolation (nonpriv)
[698.754177] Starting subtest: nonpriv
[698.755229] Starting dynamic subtest: rcs0
[698.983567] Dynamic subtest rcs0: SUCCESS (0.229s)
[698.995223] Starting dynamic subtest: bcs0
[699.238096] Dynamic subtest bcs0: SUCCESS (0.253s)
[699.249848] Starting dynamic subtest: vcs0
[699.491876] Dynamic subtest vcs0: SUCCESS (0.253s)
[699.502908] Starting dynamic subtest: vcs1
[701.591855] Dynamic subtest vcs1: SUCCESS (2.099s)
[701.600301] Starting dynamic subtest: vecs0
[703.582589] Dynamic subtest vecs0: SUCCESS (1.989s)
[703.593816] Starting dynamic subtest: ccs0
[705.596964] Dynamic subtest ccs0: SUCCESS (2.013s)
[705.598090] Subtest nonpriv: SUCCESS (6.843s)
[705.834076] [129/133] (316s left) kms_cursor_crc (cursor-offscreen-32x10)
[705.992831] Starting subtest: cursor-offscreen-32x10
[706.038083] Subtest cursor-offscreen-32x10: SKIP (0.043s)
[706.299343] [130/133] (316s left) gem_exec_schedule (manyslice)
[706.353791] Starting subtest: manyslice
[706.354739] Starting dynamic subtest: rcs0
[711.539568] Dynamic subtest rcs0: SUCCESS (5.140s)
[711.552983] Starting dynamic subtest: bcs0
[718.173896] Dynamic subtest bcs0: SUCCESS (6.631s)
[718.187846] Starting dynamic subtest: vcs0
[724.255941] Dynamic subtest vcs0: SUCCESS (6.079s)
[724.268527] Starting dynamic subtest: vcs1
[730.338746] Dynamic subtest vcs1: SUCCESS (6.080s)
[730.349397] Starting dynamic subtest: vecs0
[736.908447] Dynamic subtest vecs0: SUCCESS (6.567s)
[736.919531] Starting dynamic subtest: ccs0
[743.568813] Dynamic subtest ccs0: SUCCESS (6.704s)
[743.569962] Subtest manyslice: SUCCESS (37.214s)
[743.873514] [131/133] (278s left) kms_chamelium_audio (dp-audio-edid)
[744.242984] Subtest dp-audio-edid: SKIP (0.000s)
[745.010167] [132/133] (277s left) prime_busy (before-wait)
[745.070297] Starting subtest: before-wait
[745.073504] Starting dynamic subtest: rcs0
[745.106255] Dynamic subtest rcs0: SUCCESS (0.033s)
[745.117743] Starting dynamic subtest: bcs0
[745.155366] Dynamic subtest bcs0: SUCCESS (0.049s)
[745.164372] Starting dynamic subtest: vcs0
[745.196761] Dynamic subtest vcs0: SUCCESS (0.041s)
[745.205112] Starting dynamic subtest: vcs1
[745.237200] Dynamic subtest vcs1: SUCCESS (0.040s)
[745.245415] Starting dynamic subtest: vecs0
[745.277863] Dynamic subtest vecs0: SUCCESS (0.040s)
[745.286425] Starting dynamic subtest: ccs0
[745.318127] Dynamic subtest ccs0: SUCCESS (0.039s)
[745.425029] Subtest before-wait: SUCCESS (0.354s)
[745.510888] [133/133] (277s left) gem_softpin (invalid)
[745.562265] Starting subtest: invalid
[745.568086] Subtest invalid: SUCCESS (0.006s)
[745.685450] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_flink_basic
results: parsing output: 2/ for test: gem_exec_fence
results: parsing output: 3/ for test: kms_joiner
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: kms_cursor_edge_walk
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_cursor_legacy
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_partial_pwrite_pread
results: parsing output: 11/ for test: kms_hdr
results: parsing output: 12/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 13/ for test: kms_async_flips
results: parsing output: 14/ for test: kms_busy
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_pm_dc
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: gem_exec_basic
results: parsing output: 21/ for test: gem_ctx_persistence
results: parsing output: 22/ for test: api_intel_allocator
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: kms_chamelium_frames
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: i915_suspend
results: parsing output: 31/ for test: gem_ctx_bad_destroy
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: vgem_basic
results: parsing output: 35/ for test: kms_psr2_sf
results: parsing output: 36/ for test: i915_drm_fdinfo
results: parsing output: 37/ for test: gem_workarounds
results: parsing output: 38/ for test: kms_prop_blob
results: parsing output: 39/ for test: i915_pm_rpm
results: parsing output: 40/ for test: kms_color_pipeline
results: parsing output: 41/ for test: kms_async_flips
results: parsing output: 42/ for test: gem_mmap_wc
results: parsing output: 43/ for test: kms_chamelium_hpd
results: parsing output: 44/ for test: gem_ctx_create
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_mmap_gtt
results: parsing output: 47/ for test: gem_exec_reloc
results: parsing output: 48/ for test: gem_mmap_offset
results: parsing output: 49/ for test: gem_eio
results: parsing output: 50/ for test: gem_exec_whisper
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: sw_sync
results: parsing output: 53/ for test: kms_flip_scaled_crc
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_gpgpu_fill
results: parsing output: 56/ for test: dmabuf_sync_file
results: parsing output: 57/ for test: gem_ctx_bad_destroy
results: parsing output: 58/ for test: core_auth
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_dp_link_training
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: gem_basic
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: gem_exec_balancer
results: parsing output: 66/ for test: i915_hangman
results: parsing output: 67/ for test: gem_mmap_gtt
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: api_intel_bb
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_plane_scaling
results: parsing output: 72/ for test: kms_flip_scaled_crc
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_sequence
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_vm_create
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_exec_reloc
results: parsing output: 79/ for test: syncobj_wait
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gen7_exec_parse
results: parsing output: 82/ for test: kms_vrr
results: parsing output: 83/ for test: kms_pipe_stress
results: parsing output: 84/ for test: kms_addfb_basic
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_pipe_b_c_ivb
results: parsing output: 87/ for test: gem_exec_params
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_plane
results: parsing output: 90/ for test: kms_content_protection
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_atomic_transition
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: perf_pmu
results: parsing output: 96/ for test: kms_vblank
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_psr2_sf
results: parsing output: 102/ for test: syncobj_basic
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: gem_spin_batch
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_ctx_engines
results: parsing output: 107/ for test: kms_pm_rpm
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: gem_render_copy
results: parsing output: 112/ for test: kms_plane_multiple
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: gem_ctx_shared
results: parsing output: 115/ for test: kms_explicit_fence
results: parsing output: 116/ for test: gem_shrink
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: gem_exec_parallel
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: kms_plane_scaling
results: parsing output: 123/ for test: gem_exec_params
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_lease
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_ctx_isolation
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: gem_exec_schedule
results: parsing output: 130/ for test: kms_chamelium_audio
results: parsing output: 131/ for test: prime_busy
results: parsing output: 132/ for test: gem_softpin
Done.