[56.828329] Initializing watchdogs
[56.828376]   /dev/watchdog0
[56.843557] [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]
[56.848179] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.850556] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.854171] [001/133] (960s left) gen9_exec_parse (cmd-crossing-page)
[56.940481] Subtest cmd-crossing-page: SKIP (0.000s)
[56.999209] [002/133] (960s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[57.129246] Starting subtest: basic-flip-after-cursor-atomic
[58.902094] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.771s)
[59.275866] [003/133] (958s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[59.387214] Starting subtest: extended-modeset-hang-newfb-with-reset
[59.389436] Starting dynamic subtest: pipe-A
[75.317521] Dynamic subtest pipe-A: SUCCESS (15.928s)
[75.327329] Starting dynamic subtest: pipe-D
[90.808041] Dynamic subtest pipe-D: SUCCESS (15.488s)
[90.810178] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (31.420s)
[91.613980] [004/133] (925s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[91.728318] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[98.635076] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.909s)
[98.770971] [005/133] (918s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[98.867824] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[105.630465] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.766s)
[105.764168] [006/133] (911s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[105.858354] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[105.886665] Starting dynamic subtest: pipe-A-plane-0
[106.175415] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[106.184886] Starting dynamic subtest: pipe-A-plane-3
[106.409738] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[107.540527] Starting dynamic subtest: pipe-B-plane-0
[107.833513] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[107.842649] Starting dynamic subtest: pipe-B-plane-3
[108.100145] Dynamic subtest pipe-B-plane-3: SUCCESS (0.265s)
[108.432493] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.572s)
[109.232143] [007/133] (908s left) perf_pmu (pmu-read)
[109.273692] Starting subtest: pmu-read
[109.276065] Subtest pmu-read: SUCCESS (0.002s)
[109.382115] [008/133] (908s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[109.436197] Starting subtest: invalid-bsd1-flag-on-vebox
[109.438454] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[109.549227] [009/133] (908s left) gem_mmap_offset (bad-flags)
[109.606053] Starting subtest: bad-flags
[109.607939] Subtest bad-flags: SUCCESS (0.000s)
[109.722088] [010/133] (907s left) syncobj_wait (invalid-signal-illegal-handle)
[109.771499] Starting subtest: invalid-signal-illegal-handle
[109.773661] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[109.884681] [011/133] (907s left) kms_psr (fbc-psr2-primary-render)
[109.982023] Starting subtest: fbc-psr2-primary-render
[109.984365] Starting dynamic subtest: eDP-1
[109.988783] Dynamic subtest eDP-1: SKIP (0.000s)
[109.993279] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[110.052589] [012/133] (907s left) syncobj_wait (wait-any-snapshot)
[110.114038] Starting subtest: wait-any-snapshot
[110.193767] Subtest wait-any-snapshot: SUCCESS (0.081s)
[110.268876] [013/133] (907s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[110.321038] Starting subtest: yf-tiled-ccs-to-x-tiled
[110.324473] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[110.499777] [014/133] (907s left) gem_ctx_exec (basic-nohangcheck)
[110.562211] Starting subtest: basic-nohangcheck
[110.810217] Subtest basic-nohangcheck: SUCCESS (0.250s)
[110.939359] [015/133] (906s left) gem_exec_reloc (basic-write-read)
[111.009907] Subtest basic-write-read: SKIP (0.000s)
[111.075601] [016/133] (906s left) core_debugfs (read-all-entries)
[111.141245] Starting subtest: read-all-entries
[111.234555] Subtest read-all-entries: SUCCESS (0.095s)
[111.311745] [017/133] (906s left) kms_psr (psr-cursor-plane-onoff)
[111.403719] Starting subtest: psr-cursor-plane-onoff
[111.406156] Starting dynamic subtest: eDP-1
[113.127035] Dynamic subtest eDP-1: SUCCESS (1.726s)
[113.129363] Subtest psr-cursor-plane-onoff: SUCCESS (1.727s)
[113.997047] [018/133] (904s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[114.058042] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[114.162282] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[114.246296] [019/133] (903s left) gem_ctx_param (invalid-ctx-get)
[114.311152] Starting subtest: invalid-ctx-get
[114.313584] Subtest invalid-ctx-get: SUCCESS (0.000s)
[114.385810] [020/133] (903s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[114.474600] Starting subtest: random-ccs-data-yf-tiled-ccs
[114.476962] Starting dynamic subtest: pipe-A-eDP-1
[114.501606] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[114.509971] Starting dynamic subtest: pipe-B-eDP-1
[114.534424] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[114.542887] Starting dynamic subtest: pipe-C-eDP-1
[114.567446] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[114.576627] Starting dynamic subtest: pipe-D-eDP-1
[114.600698] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[114.604764] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.003s)
[116.750139] [021/133] (901s left) gem_ppgtt (blt-vs-render-ctx0)
[116.809700] Starting subtest: blt-vs-render-ctx0
[149.659050] Subtest blt-vs-render-ctx0: SUCCESS (32.845s)
[149.779717] [022/133] (868s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[149.921783] Starting subtest: fbc-pr-cursor-plane-update-sf
[149.925913] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[149.997728] [023/133] (868s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[150.088826] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[150.092794] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[150.171112] [024/133] (868s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[150.264029] Starting subtest: primary-4-tiled-reflect-x-0
[157.359756] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.097s)
[158.497848] [025/133] (859s left) api_intel_allocator (reserve-simple)
[158.557848] Starting subtest: reserve-simple
[158.560344] Subtest reserve-simple: SUCCESS (0.002s)
[158.681580] [026/133] (859s left) kms_big_fb (linear-32bpp-rotate-0)
[158.783791] Starting subtest: linear-32bpp-rotate-0
[160.340196] Subtest linear-32bpp-rotate-0: SUCCESS (1.557s)
[160.486551] [027/133] (857s left) kms_setmode (invalid-clone-exclusive-crtc)
[160.547827] Starting subtest: invalid-clone-exclusive-crtc
[160.553419] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[160.661323] [028/133] (857s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[160.725599] Starting subtest: yf-tiled-ccs-to-y-tiled
[160.729437] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[160.930833] [029/133] (857s left) gem_exec_params (no-vebox)
[161.000069] Starting subtest: no-vebox
[161.002394] Subtest no-vebox: SUCCESS (0.004s)
[162.915713] [030/133] (855s left) kms_dsc (dsc-with-bpc-formats)
[163.015886] Starting subtest: dsc-with-bpc-formats
[163.127465] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[163.163992] [031/133] (855s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[163.267728] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[163.272252] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[163.344616] [032/133] (855s left) gem_exec_fence (syncobj-signal)
[163.829836] Starting subtest: syncobj-signal
[163.835110] Subtest syncobj-signal: SUCCESS (0.005s)
[164.955700] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true
[164.959080] [033/133] (853s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[165.059593] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[165.064118] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[165.170907] [034/133] (853s left) i915_pm_rpm (debugfs-read)
[167.115796] Starting subtest: debugfs-read
[168.284935] Subtest debugfs-read: SUCCESS (1.168s)
[168.668381] [035/133] (850s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[168.771581] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[168.780586] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s)
[168.875640] [036/133] (849s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[168.969475] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[173.220599] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.254s)
[174.366527] [037/133] (844s left) kms_invalid_mode (uint-max-clock)
[174.468477] Starting subtest: uint-max-clock
[174.470975] Starting dynamic subtest: pipe-A-eDP-1
[174.752841] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[174.762419] Starting dynamic subtest: pipe-B-eDP-1
[174.764612] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[174.772693] Starting dynamic subtest: pipe-C-eDP-1
[174.774830] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[174.783049] Starting dynamic subtest: pipe-D-eDP-1
[174.784934] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[174.788410] Subtest uint-max-clock: SUCCESS (0.294s)
[175.592080] [038/133] (843s left) i915_query (query-regions-garbage-items)
[175.659280] Starting subtest: query-regions-garbage-items
[175.661712] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[175.753857] [039/133] (843s left) kms_pm_dc (dc5-dpms)
[176.863824] Starting subtest: dc5-dpms
[178.970439] Subtest dc5-dpms: SUCCESS (2.106s)
[179.051468] [040/133] (839s left) gem_eio (wait-wedge-immediate)
[179.274778] Starting subtest: wait-wedge-immediate
[180.985204] Subtest wait-wedge-immediate: SUCCESS (1.710s)
[181.099046] [041/133] (837s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[181.191990] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[185.686352] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.498s)
[186.836390] [042/133] (832s left) gem_exec_schedule (fifo)
[186.904153] Starting subtest: fifo
[186.906398] Starting dynamic subtest: rcs0
[186.996856] Dynamic subtest rcs0: SUCCESS (0.103s)
[187.010418] Starting dynamic subtest: vcs0
[187.084100] Dynamic subtest vcs0: SUCCESS (0.086s)
[187.097232] Starting dynamic subtest: vcs1
[187.168665] Dynamic subtest vcs1: SUCCESS (0.084s)
[187.180024] Starting dynamic subtest: vecs0
[187.247367] Dynamic subtest vecs0: SUCCESS (0.077s)
[187.259088] Starting dynamic subtest: ccs0
[187.339205] Dynamic subtest ccs0: SUCCESS (0.091s)
[187.341893] Subtest fifo: SUCCESS (0.446s)
[188.981020] [043/133] (830s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[189.376102] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[190.213201] [044/133] (828s left) kms_cursor_legacy (single-bo)
[190.339053] Starting subtest: single-bo
[190.341312] Starting dynamic subtest: pipe-A
[195.722705] Dynamic subtest pipe-A: SUCCESS (5.380s)
[195.731452] Starting dynamic subtest: pipe-B
[201.104861] Dynamic subtest pipe-B: SUCCESS (5.380s)
[201.113410] Starting dynamic subtest: pipe-C
[206.486237] Dynamic subtest pipe-C: SUCCESS (5.379s)
[206.494815] Starting dynamic subtest: pipe-D
[211.879354] Dynamic subtest pipe-D: SUCCESS (5.380s)
[211.888325] Starting dynamic subtest: all-pipes
[217.255753] Dynamic subtest all-pipes: SUCCESS (5.386s)
[217.258142] Subtest single-bo: SUCCESS (26.915s)
[217.402191] [045/133] (801s left) kms_color (gamma)
[217.493112] Starting subtest: gamma
[217.495134] Starting dynamic subtest: pipe-A-eDP-1
[218.212025] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s)
[218.220913] Starting dynamic subtest: pipe-B-eDP-1
[219.683953] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.471s)
[219.693158] Starting dynamic subtest: pipe-C-eDP-1
[221.022281] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.339s)
[221.032884] Starting dynamic subtest: pipe-D-eDP-1
[222.351061] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[222.353479] Subtest gamma: SUCCESS (4.858s)
[223.159200] [046/133] (796s left) kms_rotation_crc (primary-rotation-180)
[223.265044] Starting subtest: primary-rotation-180
[230.141646] Subtest primary-rotation-180: SUCCESS (6.878s)
[231.329498] [047/133] (787s left) kms_legacy_colorkey (invalid-plane)
[231.429893] Starting subtest: invalid-plane
[231.432176] Starting dynamic subtest: zero-id
[231.434300] Dynamic subtest zero-id: SUCCESS (0.000s)
[231.443646] Starting dynamic subtest: outrange-id
[231.445540] Dynamic subtest outrange-id: SUCCESS (0.000s)
[231.447453] Subtest invalid-plane: SUCCESS (0.001s)
[231.503899] [048/133] (787s left) kms_psr (fbc-psr-sprite-blt)
[231.594971] Starting subtest: fbc-psr-sprite-blt
[231.597246] Starting dynamic subtest: eDP-1
[231.601450] Dynamic subtest eDP-1: SKIP (0.000s)
[231.605713] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[231.670406] [049/133] (787s left) gem_exec_balancer (waits)
[231.725477] Starting subtest: waits
[238.267783] Subtest waits: SUCCESS (6.540s)
[238.573183] [050/133] (780s left) i915_drm_fdinfo (all-busy-check-all)
[238.619682] Starting subtest: all-busy-check-all
[238.624133] Subtest all-busy-check-all: SKIP (0.004s)
[238.708233] [051/133] (780s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[238.839974] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[245.926202] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.088s)
[246.051345] [052/133] (773s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[246.144282] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[246.148619] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[246.238694] [053/133] (773s left) gem_userptr_blits (nohangcheck)
[246.312514] Starting subtest: nohangcheck
[246.551922] Subtest nohangcheck: SUCCESS (0.235s)
[246.673202] [054/133] (772s left) vgem_basic (bad-pad)
[246.739467] Starting subtest: bad-pad
[246.741741] Subtest bad-pad: SUCCESS (0.000s)
[246.795160] [055/133] (772s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[246.910817] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[246.915094] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[247.017853] [056/133] (772s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[247.161389] Starting subtest: cursorB-vs-flipB-toggle
[247.165898] Subtest cursorB-vs-flipB-toggle: SKIP (0.002s)
[247.320159] [057/133] (772s left) sw_sync (sync_random_merge)
[247.358668] Starting subtest: sync_random_merge
[247.415055] Subtest sync_random_merge: SUCCESS (0.059s)
[247.473854] [058/133] (772s left) kms_cursor_crc (cursor-onscreen-max-size)
[247.800074] Starting subtest: cursor-onscreen-max-size
[247.805251] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[247.938387] [059/133] (771s left) gem_exec_params (secure-non-master)
[248.003360] Starting subtest: secure-non-master
[248.006928] Subtest secure-non-master: SKIP (0.000s)
[248.093550] [060/133] (771s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[248.196800] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[271.303173] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (23.109s)
[271.454926] [061/133] (748s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[271.564300] Starting subtest: x-tiled-32bpp-rotate-180
[273.057945] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.493s)
[273.194085] [062/133] (746s left) dmabuf_sync_file (export-multiwait)
[273.243089] Starting subtest: export-multiwait
[273.245106] Subtest export-multiwait: SUCCESS (0.000s)
[273.313127] [063/133] (746s left) gem_eio (execbuf)
[273.557980] Starting subtest: execbuf
[273.902456] Subtest execbuf: SUCCESS (0.344s)
[274.027947] [064/133] (745s left) perf (global-sseu-config-invalid)
[274.161202] Starting subtest: global-sseu-config-invalid
[274.164736] Subtest global-sseu-config-invalid: SKIP (0.000s)
[274.201818] [065/133] (745s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[274.292483] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[274.296274] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[275.424118] [066/133] (744s left) gem_lmem_swapping (parallel-random-engines)
[275.463373] Subtest parallel-random-engines: SKIP (0.000s)
[275.504898] [067/133] (744s left) kms_atomic_interruptible (legacy-cursor)
[275.597998] Starting subtest: legacy-cursor
[275.600297] Starting dynamic subtest: pipe-A-eDP-1
[283.027275] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.428s)
[283.029731] Subtest legacy-cursor: SUCCESS (7.430s)
[283.881540] [068/133] (736s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[283.936069] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[283.938317] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[284.044944] [069/133] (736s left) gem_mmap_wc (bad-object)
[284.106744] Subtest bad-object: SKIP (0.000s)
[284.175540] [070/133] (735s left) gem_lmem_swapping (verify-random)
[284.217358] Subtest verify-random: SKIP (0.000s)
[284.265999] [071/133] (735s left) kms_frontbuffer_tracking (psr-1p-rte)
[284.362583] Starting subtest: psr-1p-rte
[289.794536] Subtest psr-1p-rte: SUCCESS (5.435s)
[289.930135] [072/133] (730s left) gem_exec_balancer (bonded-chain)
[289.987766] Starting subtest: bonded-chain
[296.995896] Subtest bonded-chain: SUCCESS (7.006s)
[297.326111] [073/133] (722s left) perf (missing-sample-flags)
[297.421709] Starting subtest: missing-sample-flags
[297.424015] Subtest missing-sample-flags: SUCCESS (0.000s)
[297.465102] [074/133] (722s left) gem_ctx_shared (exec-shared-gtt)
[297.543799] Starting subtest: exec-shared-gtt
[297.546341] Starting dynamic subtest: rcs0
[297.555183] Dynamic subtest rcs0: SUCCESS (0.011s)
[297.565554] Starting dynamic subtest: bcs0
[297.568644] Dynamic subtest bcs0: SUCCESS (0.009s)
[297.577127] Starting dynamic subtest: vcs0
[297.579110] Dynamic subtest vcs0: SUCCESS (0.009s)
[297.587910] Starting dynamic subtest: vcs1
[297.590298] Dynamic subtest vcs1: SUCCESS (0.010s)
[297.601981] Starting dynamic subtest: vecs0
[297.603947] Dynamic subtest vecs0: SUCCESS (0.010s)
[297.613242] Starting dynamic subtest: ccs0
[297.615630] Dynamic subtest ccs0: SUCCESS (0.013s)
[297.617688] Subtest exec-shared-gtt: SUCCESS (0.067s)
[297.801494] [075/133] (722s left) kms_cursor_crc (cursor-random-128x128)
[298.009366] Starting subtest: cursor-random-128x128
[298.014774] Starting dynamic subtest: pipe-A-eDP-1
[301.348300] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.334s)
[301.380097] Starting dynamic subtest: pipe-D-eDP-1
[305.326425] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.954s)
[305.328838] Subtest cursor-random-128x128: SUCCESS (7.316s)
[306.176071] [076/133] (714s left) kms_atomic (plane-invalid-params-fence)
[306.267726] Starting subtest: plane-invalid-params-fence
[306.270022] Starting dynamic subtest: pipe-A-eDP-1
[306.622277] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.354s)
[306.624453] Subtest plane-invalid-params-fence: SUCCESS (0.355s)
[307.511711] [077/133] (712s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[307.603364] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[307.607520] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[307.682638] [078/133] (712s left) kms_pm_rpm (system-suspend-modeset)
[309.208319] Starting subtest: system-suspend-modeset
[328.131971] Subtest system-suspend-modeset: SUCCESS (4.388s)
[328.512211] [079/133] (692s left) gem_exec_schedule (u-submit-golden-slice)
[328.604896] Starting subtest: u-submit-golden-slice
[328.606931] Starting dynamic subtest: rcs0
[328.640338] Dynamic subtest rcs0: SUCCESS (0.036s)
[328.651366] Starting dynamic subtest: bcs0
[328.672160] Dynamic subtest bcs0: SUCCESS (0.031s)
[328.681634] Starting dynamic subtest: vcs0
[328.707364] Dynamic subtest vcs0: SUCCESS (0.035s)
[328.716491] Starting dynamic subtest: vcs1
[328.735430] Dynamic subtest vcs1: SUCCESS (0.027s)
[328.744722] Starting dynamic subtest: vecs0
[328.772608] Dynamic subtest vecs0: SUCCESS (0.036s)
[328.784011] Starting dynamic subtest: ccs0
[328.807329] Dynamic subtest ccs0: SUCCESS (0.033s)
[328.809557] Subtest u-submit-golden-slice: SUCCESS (0.203s)
[330.487645] [080/133] (690s left) sriov_basic (enable-vfs-autoprobe-on)
[330.545785] Starting subtest: enable-vfs-autoprobe-on
[330.548427] Starting dynamic subtest: numvfs-1
[330.630480] Dynamic subtest numvfs-1: FAIL (0.029s)
[330.641762] Starting dynamic subtest: numvfs-2
[330.715679] Dynamic subtest numvfs-2: FAIL (0.004s)
[330.726675] Starting dynamic subtest: numvfs-3
[330.799055] Dynamic subtest numvfs-3: FAIL (0.003s)
[330.809817] Starting dynamic subtest: numvfs-4
[330.882696] Dynamic subtest numvfs-4: FAIL (0.003s)
[330.894486] Starting dynamic subtest: numvfs-5
[330.967723] Dynamic subtest numvfs-5: FAIL (0.004s)
[330.977521] Starting dynamic subtest: numvfs-6
[331.050498] Dynamic subtest numvfs-6: FAIL (0.003s)
[331.060689] Starting dynamic subtest: numvfs-7
[331.133284] Dynamic subtest numvfs-7: FAIL (0.003s)
[331.143797] Starting dynamic subtest: numvfs-random
[331.213751] Dynamic subtest numvfs-random: FAIL (0.004s)
[331.224593] Starting dynamic subtest: numvfs-all
[331.297493] Dynamic subtest numvfs-all: FAIL (0.517s)
[331.299785] Subtest enable-vfs-autoprobe-on: FAIL (0.579s)
[331.340005] [081/133] (689s left) gem_partial_pwrite_pread (write-display)
[331.400893] Subtest write-display: SKIP (0.000s)
[331.469779] [082/133] (689s left) gem_exec_schedule (preempt-engines)
[331.530317] Starting subtest: preempt-engines
[331.531921] Starting dynamic subtest: rcs0
[333.880470] Dynamic subtest rcs0: SUCCESS (2.351s)
[333.893283] Starting dynamic subtest: bcs0
[336.208463] Dynamic subtest bcs0: SUCCESS (2.324s)
[336.222389] Starting dynamic subtest: vcs0
[338.493528] Dynamic subtest vcs0: SUCCESS (2.283s)
[338.503100] Starting dynamic subtest: vcs1
[340.762570] Dynamic subtest vcs1: SUCCESS (2.267s)
[340.771725] Starting dynamic subtest: vecs0
[343.038153] Dynamic subtest vecs0: SUCCESS (2.273s)
[343.047295] Starting dynamic subtest: ccs0
[345.334762] Dynamic subtest ccs0: SUCCESS (2.294s)
[345.337455] Subtest preempt-engines: SUCCESS (13.806s)
[345.636620] [083/133] (675s left) i915_getparams_basic (basic-subslice-total)
[345.689547] Starting subtest: basic-subslice-total
[345.694013] Subtest basic-subslice-total: SUCCESS (0.000s)
[345.780511] [084/133] (674s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[345.831913] Starting subtest: etime-multi-wait-all-available-unsubmitted
[345.937083] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.104s)
[346.015228] [085/133] (674s left) gem_exec_reloc (basic-write-gtt)
[346.080823] Subtest basic-write-gtt: SKIP (0.000s)
[346.148835] [086/133] (674s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[346.250364] Starting subtest: plane-upscale-20x20-with-pixel-format
[346.252658] Starting dynamic subtest: pipe-A
[347.298162] Dynamic subtest pipe-A: SUCCESS (1.050s)
[347.309873] Starting dynamic subtest: pipe-B
[349.419944] Dynamic subtest pipe-B: SUCCESS (2.121s)
[349.430590] Starting dynamic subtest: pipe-C
[350.607795] Dynamic subtest pipe-C: SUCCESS (1.186s)
[350.623702] Starting dynamic subtest: pipe-D
[351.843089] Dynamic subtest pipe-D: SUCCESS (1.234s)
[351.845289] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.595s)
[353.035027] [087/133] (667s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[353.137153] Starting subtest: psr-shrfb-scaledprimary
[358.931163] Subtest psr-shrfb-scaledprimary: SUCCESS (5.796s)
[359.058609] [088/133] (661s left) kms_selftest (drm_cmdline_parser)
[359.105584] Starting subtest: drm_cmdline_parser
[359.139000] Starting dynamic subtest: drm_test_cmdline_force_d_only
[359.231771] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.093s)
[359.242709] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[359.321699] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.088s)
[359.332701] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[359.417426] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.094s)
[359.428422] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[359.532601] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.113s)
[359.541624] Starting dynamic subtest: drm_test_cmdline_force_e_only
[359.627465] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.096s)
[359.638033] Starting dynamic subtest: drm_test_cmdline_res
[359.730640] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.099s)
[359.740642] Starting dynamic subtest: drm_test_cmdline_res_vesa
[359.824523] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.093s)
[359.834758] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[359.929299] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.102s)
[359.939688] Starting dynamic subtest: drm_test_cmdline_res_rblank
[360.036888] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.106s)
[360.047517] Starting dynamic subtest: drm_test_cmdline_res_bpp
[360.131098] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.092s)
[360.142514] Starting dynamic subtest: drm_test_cmdline_res_refresh
[360.238612] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.106s)
[360.248528] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[360.332657] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.093s)
[360.342548] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[360.440393] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.107s)
[360.449777] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[360.543379] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.101s)
[360.553570] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[360.652004] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.108s)
[360.662682] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[360.745096] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.090s)
[360.755163] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[360.840968] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.094s)
[360.851306] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[360.930763] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.087s)
[360.940013] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[361.035120] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.103s)
[361.045936] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[361.148977] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.111s)
[361.159235] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[361.245006] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.094s)
[361.255081] Starting dynamic subtest: drm_test_cmdline_name
[361.330755] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.084s)
[361.339407] Starting dynamic subtest: drm_test_cmdline_name_bpp
[361.428883] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.098s)
[361.437610] Starting dynamic subtest: drm_test_cmdline_name_option
[361.528139] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.098s)
[361.538142] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[361.623849] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.094s)
[361.633729] Starting dynamic subtest: drm_test_cmdline_rotate_0
[361.712714] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.088s)
[361.722105] Starting dynamic subtest: drm_test_cmdline_rotate_90
[361.819048] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.106s)
[361.828063] Starting dynamic subtest: drm_test_cmdline_rotate_180
[361.906861] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.085s)
[361.916908] Starting dynamic subtest: drm_test_cmdline_rotate_270
[361.994938] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.088s)
[362.004698] Starting dynamic subtest: drm_test_cmdline_hmirror
[362.075953] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.080s)
[362.085622] Starting dynamic subtest: drm_test_cmdline_vmirror
[362.178908] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.102s)
[362.189408] Starting dynamic subtest: drm_test_cmdline_margin_options
[362.287804] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.108s)
[362.298313] Starting dynamic subtest: drm_test_cmdline_multiple_options
[362.389971] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.101s)
[362.400315] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[362.478395] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.086s)
[362.488997] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[362.569615] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.091s)
[362.578218] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[362.653481] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.083s)
[362.661934] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[362.743528] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.089s)
[362.752113] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[362.839560] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.095s)
[362.848385] Starting dynamic subtest: drm_test_cmdline_invalid
[362.940084] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.099s)
[362.948993] Starting dynamic subtest: drm_test_cmdline_tv_options
[363.049575] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.109s)
[363.051107] Subtest drm_cmdline_parser: SUCCESS (3.946s)
[363.201325] [089/133] (657s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[363.294864] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[363.296712] Starting dynamic subtest: pipe-A-eDP-1
[369.139121] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.847s)
[369.149876] Starting dynamic subtest: pipe-B-eDP-1
[375.797900] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.655s)
[375.800339] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.505s)
[376.666006] [090/133] (644s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[376.769135] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[376.773551] Starting dynamic subtest: pipe-A-default-mode
[379.520739] Dynamic subtest pipe-A-default-mode: SUCCESS (2.755s)
[379.522915] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.756s)
[380.364624] [091/133] (640s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[380.495108] Starting subtest: cursor-tearing-framebuffer-change
[380.497312] Starting dynamic subtest: pipe-A-eDP-1
[381.047044] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s)
[381.057184] Starting dynamic subtest: pipe-D-eDP-1
[382.265239] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.217s)
[382.267607] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.771s)
[383.102389] [092/133] (637s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[383.220902] Starting subtest: flip-vs-cursor-toggle
[391.889092] Subtest flip-vs-cursor-toggle: SUCCESS (8.668s)
[392.725085] [093/133] (628s left) kms_chamelium_edid (vga-edid-read)
[393.121227] Subtest vga-edid-read: SKIP (0.000s)
[393.942760] [094/133] (627s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[394.045316] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[394.049456] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[394.157761] [095/133] (627s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[394.244351] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[394.246662] Starting dynamic subtest: pipe-A
[395.403659] Dynamic subtest pipe-A: SUCCESS (1.162s)
[395.414927] Starting dynamic subtest: pipe-B
[397.619823] Dynamic subtest pipe-B: SUCCESS (2.213s)
[397.629057] Starting dynamic subtest: pipe-C
[398.772545] Dynamic subtest pipe-C: SUCCESS (1.151s)
[398.783056] Starting dynamic subtest: pipe-D
[399.997733] Dynamic subtest pipe-D: SUCCESS (1.224s)
[400.000023] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.756s)
[401.189632] [096/133] (620s left) kms_plane_multiple (2x-tiling-x)
[401.282526] Starting subtest: 2x-tiling-x
[401.286658] Subtest 2x-tiling-x: SKIP (0.000s)
[401.361420] [097/133] (619s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[401.409363] Starting subtest: single-wait-for-submit-available-signaled
[401.411630] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[401.515798] [098/133] (619s left) kms_plane_alpha_blend (constant-alpha-mid)
[401.611538] Starting subtest: constant-alpha-mid
[401.901092] Starting dynamic subtest: pipe-A-eDP-1
[402.820104] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.917s)
[402.829582] Starting dynamic subtest: pipe-D-eDP-1
[404.361439] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.539s)
[404.363897] Subtest constant-alpha-mid: SUCCESS (2.750s)
[405.177993] [099/133] (616s left) gem_ctx_engines (invalid-engines)
[405.242162] Starting subtest: invalid-engines
[405.249337] Subtest invalid-engines: SUCCESS (0.007s)
[405.493034] [100/133] (615s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[405.597014] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[405.601364] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[405.688347] [101/133] (615s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[405.823560] Starting subtest: 4-tiled-64bpp-rotate-0
[407.326370] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.503s)
[407.471922] [102/133] (614s left) intel_hwmon (hwmon-write)
[407.539591] Subtest hwmon-write: SKIP (0.000s)
[407.602116] [103/133] (613s left) kms_hdr (invalid-hdr)
[407.694793] Starting subtest: invalid-hdr
[409.779297] Starting dynamic subtest: pipe-A-eDP-1
[412.774651] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.995s)
[412.777172] Subtest invalid-hdr: SUCCESS (5.083s)
[412.883494] [104/133] (608s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[412.989064] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[412.993308] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[413.062008] [105/133] (608s left) gem_userptr_blits (process-exit)
[413.132510] Starting subtest: process-exit
[413.138066] Subtest process-exit: SUCCESS (0.008s)
[413.259525] [106/133] (608s left) gem_exec_params (invalid-fence-in)
[413.314017] Starting subtest: invalid-fence-in
[413.316381] Subtest invalid-fence-in: SUCCESS (0.000s)
[413.420535] [107/133] (608s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[413.549194] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[413.553716] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[413.695304] [108/133] (608s left) gem_spin_batch (legacy-resubmit)
[413.760008] Starting subtest: legacy-resubmit
[413.762400] Starting dynamic subtest: default
[413.767691] Dynamic subtest default: SUCCESS (0.004s)
[413.778117] Starting dynamic subtest: render
[413.779994] Dynamic subtest render: SUCCESS (0.001s)
[413.788871] Starting dynamic subtest: bsd
[413.790715] Dynamic subtest bsd: SUCCESS (0.002s)
[413.799304] Starting dynamic subtest: bsd1
[413.801195] Dynamic subtest bsd1: SUCCESS (0.001s)
[413.809831] Starting dynamic subtest: bsd2
[413.811665] Dynamic subtest bsd2: SUCCESS (0.003s)
[413.820230] Starting dynamic subtest: blt
[413.822114] Dynamic subtest blt: SUCCESS (0.002s)
[413.831289] Starting dynamic subtest: vebox
[413.833179] Dynamic subtest vebox: SUCCESS (0.003s)
[413.835072] Subtest legacy-resubmit: SUCCESS (0.022s)
[414.039007] [109/133] (607s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[414.139044] Starting subtest: x-tiled-addfb-size-offset-overflow
[414.141029] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[414.234062] [110/133] (607s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[414.321624] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[414.323573] Starting dynamic subtest: pipe-A-eDP-1
[416.213847] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.881s)
[416.224952] Starting dynamic subtest: pipe-B-eDP-1
[417.850411] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.635s)
[417.860891] Starting dynamic subtest: pipe-C-eDP-1
[419.364471] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.514s)
[419.376534] Starting dynamic subtest: pipe-D-eDP-1
[420.918931] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.554s)
[420.921048] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.589s)
[422.072461] [111/133] (599s left) gem_ctx_bad_destroy (invalid-ctx)
[422.142605] Starting subtest: invalid-ctx
[422.144987] Subtest invalid-ctx: SUCCESS (0.000s)
[422.235421] [112/133] (599s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[422.362104] Starting subtest: cursor-vs-flip-atomic-transitions
[452.276525] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.918s)
[453.092901] [113/133] (568s left) gem_ctx_persistence (legacy-engines-mixed)
[453.156610] Starting subtest: legacy-engines-mixed
[453.158869] Starting dynamic subtest: render
[453.241340] Dynamic subtest render: SUCCESS (0.084s)
[453.254116] Starting dynamic subtest: bsd1
[453.296364] Dynamic subtest bsd1: SUCCESS (0.052s)
[453.310907] Starting dynamic subtest: bsd2
[453.345087] Dynamic subtest bsd2: SUCCESS (0.047s)
[453.359115] Starting dynamic subtest: blt
[453.394404] Dynamic subtest blt: SUCCESS (0.047s)
[453.406799] Starting dynamic subtest: vebox
[453.447394] Dynamic subtest vebox: SUCCESS (0.050s)
[453.450005] Subtest legacy-engines-mixed: SUCCESS (0.291s)
[453.543382] [114/133] (568s left) gem_exec_flush (basic-batch-kernel-default-uc)
[453.612993] Starting subtest: basic-batch-kernel-default-uc
[460.096214] Subtest basic-batch-kernel-default-uc: SUCCESS (6.483s)
[460.291719] [115/133] (561s left) gem_exec_schedule (u-semaphore-noskip)
[460.372688] Starting subtest: u-semaphore-noskip
[460.805689] Subtest u-semaphore-noskip: SUCCESS (0.440s)
[461.146770] [116/133] (560s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[461.250471] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[461.254731] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[461.349080] [117/133] (560s left) kms_psr (pr-primary-page-flip)
[461.452751] Starting subtest: pr-primary-page-flip
[461.457210] Subtest pr-primary-page-flip: SKIP (0.000s)
[461.526763] [118/133] (560s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[461.612462] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[461.614893] Starting dynamic subtest: pipe-A-eDP-1
[462.115283] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.482s)
[462.125222] Starting dynamic subtest: pipe-B-eDP-1
[463.561083] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.436s)
[463.575886] Starting dynamic subtest: pipe-C-eDP-1
[464.917037] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.356s)
[464.928614] Starting dynamic subtest: pipe-D-eDP-1
[466.375598] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.458s)
[466.377975] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.738s)
[467.508486] [119/133] (554s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[467.605777] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[467.609883] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[467.698308] [120/133] (554s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[467.796181] Starting subtest: y-tiled-8bpp-rotate-180
[467.800564] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[467.893836] [121/133] (554s left) kms_pwrite_crc
[469.549253] [122/133] (552s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[469.637638] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[469.642123] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[469.714767] [123/133] (552s left) syncobj_timeline (reset-unsignaled)
[469.771065] Starting subtest: reset-unsignaled
[469.773284] Subtest reset-unsignaled: SUCCESS (0.000s)
[469.869063] [124/133] (552s left) gem_ccs (block-copy-uncompressed)
[469.922937] Starting subtest: block-copy-uncompressed
[469.925138] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[469.945485] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[469.955858] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[469.963318] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[469.973047] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[469.980283] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[469.989530] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[469.997802] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[470.000068] Subtest block-copy-uncompressed: SUCCESS (0.075s)
[470.110443] [125/133] (552s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[470.251304] Starting subtest: dp-mst-type-0-suspend-resume
[470.255610] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[470.383919] [126/133] (552s left) gem_exec_params (dr1-dirt)
[470.434575] Starting subtest: DR1-dirt
[470.436860] Subtest DR1-dirt: SUCCESS (0.000s)
[470.535842] [127/133] (552s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[470.629397] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[470.632990] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[470.729426] [128/133] (551s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[470.801476] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[470.875923] [129/133] (551s left) gem_workarounds (reset-fd)
[470.951794] Starting subtest: reset-fd
[471.138969] Subtest reset-fd: SUCCESS (0.187s)
[471.265717] [130/133] (551s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[471.362418] Starting subtest: bad-aux-stride-y-tiled-ccs
[471.364234] Starting dynamic subtest: pipe-A-eDP-1
[471.382817] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[471.393474] Starting dynamic subtest: pipe-B-eDP-1
[471.410314] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[471.419014] Starting dynamic subtest: pipe-C-eDP-1
[471.435901] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[471.446263] Starting dynamic subtest: pipe-D-eDP-1
[471.464302] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[471.467689] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[473.609366] [131/133] (549s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[473.703328] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[473.707588] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[473.807910] [132/133] (548s left) kms_vblank (ts-continuation-modeset-hang)
[473.893233] Starting subtest: ts-continuation-modeset-hang
[473.895489] Starting dynamic subtest: pipe-A-eDP-1
[500.205833] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.311s)
[500.220407] Starting dynamic subtest: pipe-D-eDP-1
[525.215379] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.008s)
[525.217631] Subtest ts-continuation-modeset-hang: SUCCESS (51.324s)
[526.035962] [133/133] (496s left) kms_flip (flip-vs-panning-interruptible)
[526.154329] Starting subtest: flip-vs-panning-interruptible
[526.156777] Starting dynamic subtest: A-eDP1
[534.839687] Dynamic subtest A-eDP1: SUCCESS (8.685s)
[534.850569] Starting dynamic subtest: B-eDP1
[543.567206] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[543.576478] Starting dynamic subtest: C-eDP1
[552.287585] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[552.297099] Starting dynamic subtest: D-eDP1
[561.024551] Dynamic subtest D-eDP1: SUCCESS (8.735s)
[561.028826] Subtest flip-vs-panning-interruptible: SUCCESS (34.875s)
[562.187606] Closing watchdogs
results: parsing output: 0/ for test: gen9_exec_parse
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: kms_busy
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_plane
results: parsing output: 6/ for test: perf_pmu
results: parsing output: 7/ for test: gem_exec_params
results: parsing output: 8/ for test: gem_mmap_offset
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: gem_render_copy
results: parsing output: 13/ for test: gem_ctx_exec
results: parsing output: 14/ for test: gem_exec_reloc
results: parsing output: 15/ for test: core_debugfs
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: gem_ctx_param
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: gem_ppgtt
results: parsing output: 21/ for test: kms_psr2_sf
results: parsing output: 22/ for test: kms_flip_scaled_crc
results: parsing output: 23/ for test: kms_rotation_crc
results: parsing output: 24/ for test: api_intel_allocator
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_setmode
results: parsing output: 27/ for test: gem_render_copy
results: parsing output: 28/ for test: gem_exec_params
results: parsing output: 29/ for test: kms_dsc
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_fence
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: i915_pm_rpm
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_invalid_mode
results: parsing output: 37/ for test: i915_query
results: parsing output: 38/ for test: kms_pm_dc
results: parsing output: 39/ for test: gem_eio
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: kms_chamelium_hpd
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: kms_color
results: parsing output: 45/ for test: kms_rotation_crc
results: parsing output: 46/ for test: kms_legacy_colorkey
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: gem_exec_balancer
results: parsing output: 49/ for test: i915_drm_fdinfo
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_userptr_blits
results: parsing output: 53/ for test: vgem_basic
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: sw_sync
results: parsing output: 57/ for test: kms_cursor_crc
results: parsing output: 58/ for test: gem_exec_params
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: dmabuf_sync_file
results: parsing output: 62/ for test: gem_eio
results: parsing output: 63/ for test: perf
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: gem_lmem_swapping
results: parsing output: 66/ for test: kms_atomic_interruptible
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: gem_mmap_wc
results: parsing output: 69/ for test: gem_lmem_swapping
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_exec_balancer
results: parsing output: 72/ for test: perf
results: parsing output: 73/ for test: gem_ctx_shared
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: kms_atomic
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_pm_rpm
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: sriov_basic
results: parsing output: 80/ for test: gem_partial_pwrite_pread
results: parsing output: 81/ for test: gem_exec_schedule
results: parsing output: 82/ for test: i915_getparams_basic
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: kms_plane_scaling
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_selftest
results: parsing output: 88/ for test: kms_psr2_sf
results: parsing output: 89/ for test: kms_flip_scaled_crc
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: kms_chamelium_edid
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_plane_scaling
results: parsing output: 95/ for test: kms_plane_multiple
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_plane_alpha_blend
results: parsing output: 98/ for test: gem_ctx_engines
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: intel_hwmon
results: parsing output: 102/ for test: kms_hdr
results: parsing output: 103/ for test: kms_psr2_sf
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: gem_exec_params
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: gem_spin_batch
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: gem_ctx_bad_destroy
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: gem_ctx_persistence
results: parsing output: 113/ for test: gem_exec_flush
results: parsing output: 114/ for test: gem_exec_schedule
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_pwrite_crc
results: parsing output: 121/ for test: kms_flip_scaled_crc
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: gem_ccs
results: parsing output: 124/ for test: kms_content_protection
results: parsing output: 125/ for test: gem_exec_params
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_exec_reloc
results: parsing output: 128/ for test: gem_workarounds
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_vblank
results: parsing output: 132/ for test: kms_flip
Done.