[59.762272] Initializing watchdogs
[59.762316]   /dev/watchdog0
[59.775549] [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]
[59.779764] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.781911] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.785140] [001/133] (960s left) kms_flip (wf_vblank-ts-check)
[59.915324] Starting subtest: wf_vblank-ts-check
[59.917193] Starting dynamic subtest: A-eDP1
[68.819877] Dynamic subtest A-eDP1: SUCCESS (8.930s)
[68.827041] Starting dynamic subtest: B-eDP1
[77.741708] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[77.750206] Starting dynamic subtest: C-eDP1
[86.656572] Dynamic subtest C-eDP1: SUCCESS (8.914s)
[86.667212] Starting dynamic subtest: D-eDP1
[95.577937] Dynamic subtest D-eDP1: SUCCESS (8.920s)
[95.582949] Subtest wf_vblank-ts-check: SUCCESS (35.701s)
[96.818985] [002/133] (923s left) kms_cursor_crc (cursor-onscreen-256x256)
[97.068340] Starting subtest: cursor-onscreen-256x256
[97.081850] Starting dynamic subtest: pipe-A-eDP-1
[99.205347] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.122s)
[99.229072] Starting dynamic subtest: pipe-D-eDP-1
[101.990397] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.766s)
[101.992660] Subtest cursor-onscreen-256x256: SUCCESS (4.922s)
[102.791890] [003/133] (917s left) gem_mmap_gtt (big-copy-odd)
[102.866886] Subtest big-copy-odd: SKIP (0.000s)
[102.920653] [004/133] (917s left) i915_pm_rpm (sysfs-read)
[105.053065] Starting subtest: sysfs-read
[106.198948] Subtest sysfs-read: SUCCESS (1.146s)
[106.563364] [005/133] (913s left) kms_universal_plane (disable-primary-vs-flip)
[106.654335] Starting subtest: disable-primary-vs-flip
[106.656358] Starting dynamic subtest: pipe-A-eDP-1
[108.245583] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.590s)
[108.254752] Starting dynamic subtest: pipe-B-eDP-1
[110.471761] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.227s)
[110.480807] Starting dynamic subtest: pipe-C-eDP-1
[112.634880] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.162s)
[112.641959] Starting dynamic subtest: pipe-D-eDP-1
[114.828182] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.192s)
[114.830515] Subtest disable-primary-vs-flip: SUCCESS (8.175s)
[115.616896] [006/133] (904s left) perf (gen12-group-exclusive-stream-ctx-handle)
[115.753246] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[115.776855] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.023s)
[115.813929] [007/133] (904s left) kms_flip_event_leak (basic)
[116.893911] Starting subtest: basic
[116.895775] Starting dynamic subtest: pipe-A-eDP-1
[117.320864] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.427s)
[117.328550] Starting dynamic subtest: pipe-B-eDP-1
[118.450602] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.127s)
[118.458976] Starting dynamic subtest: pipe-C-eDP-1
[119.543822] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.093s)
[119.552783] Starting dynamic subtest: pipe-D-eDP-1
[120.675084] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[120.677461] Subtest basic: SUCCESS (3.780s)
[121.533427] [008/133] (899s left) gem_exec_fence (syncobj-wait)
[121.988638] Starting subtest: syncobj-wait
[123.956557] Subtest syncobj-wait: SUCCESS (1.966s)
[124.292109] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true
[124.297585] [009/133] (896s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[124.399681] Starting subtest: primary-y-tiled-reflect-x-90
[124.403894] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[124.470342] [010/133] (896s left) kms_psr (fbc-psr-no-drrs)
[124.571561] Starting subtest: fbc-psr-no-drrs
[124.573710] Starting dynamic subtest: eDP-1
[124.577642] Dynamic subtest eDP-1: SKIP (0.000s)
[124.581740] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[124.644259] [011/133] (896s left) kms_chamelium_edid (hdmi-mode-timings)
[125.030428] Subtest hdmi-mode-timings: SKIP (0.000s)
[125.835634] [012/133] (894s left) gem_exec_flush (basic-wb-ro-before-default)
[125.902017] Starting subtest: basic-wb-ro-before-default
[131.383469] Subtest basic-wb-ro-before-default: SUCCESS (5.482s)
[131.568878] [013/133] (889s left) gem_ccs (block-multicopy-inplace)
[131.631909] Starting subtest: block-multicopy-inplace
[131.636142] Subtest block-multicopy-inplace: SKIP (0.000s)
[131.727464] [014/133] (889s left) kms_invalid_mode (clock-too-high)
[131.821417] Starting subtest: clock-too-high
[131.823826] Starting dynamic subtest: pipe-A-eDP-1
[131.828410] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[131.843160] Starting dynamic subtest: pipe-B-eDP-1
[131.847799] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[131.862623] Starting dynamic subtest: pipe-C-eDP-1
[131.867399] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[131.879042] Starting dynamic subtest: pipe-D-eDP-1
[131.883594] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[131.887964] Subtest clock-too-high: SKIP (0.003s)
[131.925931] [015/133] (888s left) perf (invalid-remove-userspace-config)
[132.034104] Starting subtest: invalid-remove-userspace-config
[132.042044] Subtest invalid-remove-userspace-config: SUCCESS (0.010s)
[132.080819] [016/133] (888s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[132.174120] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[132.178560] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[132.273373] [017/133] (888s left) gem_pxp (hw-rejects-pxp-buffer)
[132.388645] Starting subtest: hw-rejects-pxp-buffer
[132.393171] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[132.492168] [018/133] (888s left) vgem_basic (dmabuf-fence)
[132.533869] Starting subtest: dmabuf-fence
[132.535469] Subtest dmabuf-fence: SUCCESS (0.000s)
[132.588893] [019/133] (888s left) core_getclient (basic)
[132.632881] Starting subtest: basic
[132.634506] Subtest basic: SUCCESS (0.000s)
[132.713234] [020/133] (888s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[132.812909] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[132.816751] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[132.896872] [021/133] (888s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[132.981216] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[132.983143] Starting dynamic subtest: pipe-A-default-mode
[135.707467] Dynamic subtest pipe-A-default-mode: SUCCESS (2.725s)
[135.709778] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.726s)
[136.539742] [022/133] (884s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[136.596200] Starting subtest: invalid-signal-one-illegal-handle
[136.598638] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[136.688911] [023/133] (884s left) kms_getfb (getfb-handle-not-fb)
[136.788752] Starting subtest: getfb-handle-not-fb
[136.791085] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[136.893407] [024/133] (884s left) kms_color (invalid-ctm-matrix-sizes)
[136.982052] Starting subtest: invalid-ctm-matrix-sizes
[136.984342] Starting dynamic subtest: pipe-A
[136.986523] Dynamic subtest pipe-A: SUCCESS (0.002s)
[136.994315] Starting dynamic subtest: pipe-B
[136.996499] Dynamic subtest pipe-B: SUCCESS (0.002s)
[137.003866] Starting dynamic subtest: pipe-C
[137.006147] Dynamic subtest pipe-C: SUCCESS (0.003s)
[137.013631] Starting dynamic subtest: pipe-D
[137.015513] Dynamic subtest pipe-D: SUCCESS (0.003s)
[137.017834] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.012s)
[137.076282] [025/133] (884s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[137.157562] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[137.159789] Starting dynamic subtest: pipe-A-eDP-1
[139.303923] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.146s)
[139.318884] Starting dynamic subtest: pipe-B-eDP-1
[141.607030] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.303s)
[141.613888] Starting dynamic subtest: pipe-C-eDP-1
[143.736600] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.126s)
[143.745520] Starting dynamic subtest: pipe-D-eDP-1
[145.735785] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.998s)
[145.738085] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.578s)
[146.970535] [026/133] (874s left) i915_drm_fdinfo (memory-info-resident)
[147.024357] Starting subtest: memory-info-resident
[147.026264] Starting dynamic subtest: smem0
[149.486068] Dynamic subtest smem0: SUCCESS (2.463s)
[149.488234] Subtest memory-info-resident: SUCCESS (2.464s)
[149.558918] [027/133] (871s left) gem_pipe_control_store_loop (reused-buffer)
[149.619487] Starting subtest: reused-buffer
[151.775546] Subtest reused-buffer: SUCCESS (2.154s)
[151.894950] [028/133] (869s left) device_reset (unbind-reset-rebind)
[151.943666] Starting subtest: unbind-reset-rebind
[156.523271] Subtest unbind-reset-rebind: SUCCESS (4.579s)
[156.580236] [029/133] (864s left) kms_content_protection (lic-type-1)
[156.723319] Starting subtest: lic-type-1
[156.727992] Subtest lic-type-1: SKIP (0.000s)
[156.841872] [030/133] (864s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[156.938324] Starting subtest: 4-tiled-8bpp-rotate-90
[156.972742] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.034s)
[157.090780] [031/133] (864s left) kms_rotation_crc (primary-rotation-270)
[157.181217] Starting subtest: primary-rotation-270
[157.185616] Subtest primary-rotation-270: SKIP (0.001s)
[157.254599] [032/133] (864s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[159.070294] Starting subtest: modeset-non-lpsp-stress-no-wait
[159.111618] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.040s)
[159.519165] [033/133] (862s left) kms_async_flips (async-flip-hang)
[159.604547] Starting subtest: async-flip-hang
[159.986060] Starting dynamic subtest: pipe-A-eDP-1
[186.361761] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.372s)
[186.761934] Starting dynamic subtest: pipe-B-eDP-1
[202.408215] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.658s)
[202.806869] Starting dynamic subtest: pipe-C-eDP-1
[218.412081] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.606s)
[218.787943] Starting dynamic subtest: pipe-D-eDP-1
[234.409975] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.628s)
[234.412322] Subtest async-flip-hang: SUCCESS (74.805s)
[235.667909] [034/133] (785s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[235.783298] Starting subtest: cursorB-vs-flipB-legacy
[235.787687] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[235.924370] [035/133] (785s left) kms_lease (master-vs-lease)
[236.003710] Starting subtest: master-vs-lease
[236.005835] Subtest master-vs-lease: SUCCESS (0.002s)
[236.106537] [036/133] (785s left) kms_plane_multiple (tiling-y)
[236.196825] Starting subtest: tiling-y
[236.201066] Subtest tiling-y: SKIP (0.000s)
[236.266064] [037/133] (785s left) i915_hangman (engine-engine-hang)
[236.337833] Starting subtest: engine-engine-hang
[236.339740] Starting dynamic subtest: rcs0
[237.875247] Dynamic subtest rcs0: SUCCESS (1.536s)
[237.884376] Starting dynamic subtest: bcs0
[239.859404] Dynamic subtest bcs0: SUCCESS (1.981s)
[239.870934] Starting dynamic subtest: vcs0
[241.844333] Dynamic subtest vcs0: SUCCESS (1.983s)
[241.855964] Starting dynamic subtest: vcs1
[243.892604] Dynamic subtest vcs1: SUCCESS (2.045s)
[243.905946] Starting dynamic subtest: vecs0
[245.876042] Dynamic subtest vecs0: SUCCESS (1.981s)
[245.888285] Starting dynamic subtest: ccs0
[247.859613] Dynamic subtest ccs0: SUCCESS (1.981s)
[247.862524] Subtest engine-engine-hang: SUCCESS (11.522s)
[247.989192] [038/133] (773s left) gem_media_fill (media-fill)
[248.050150] Subtest media-fill: SKIP (0.000s)
[248.167833] [039/133] (773s left) kms_flip (2x-busy-flip)
[248.261432] Starting subtest: 2x-busy-flip
[248.269091] Subtest 2x-busy-flip: SKIP (0.011s)
[248.370379] [040/133] (773s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[248.477023] Starting subtest: yf-tiled-16bpp-rotate-90
[248.481367] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[248.599895] [041/133] (773s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[248.978873] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[249.780593] [042/133] (772s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[250.321571] Starting subtest: syncobj-timeline-invalid-wait
[250.324172] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s)
[252.000365] [043/133] (769s left) gem_workarounds (basic-read)
[252.071064] Starting subtest: basic-read
[252.082475] Subtest basic-read: SUCCESS (0.012s)
[252.216108] [044/133] (769s left) syncobj_eventfd (invalid-illegal-eventfd)
[252.278182] Starting subtest: invalid-illegal-eventfd
[252.280504] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[252.371505] [045/133] (769s left) kms_plane_alpha_blend (alpha-7efc)
[252.459038] Starting subtest: alpha-7efc
[252.749612] Starting dynamic subtest: pipe-A-eDP-1
[253.350500] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.599s)
[253.375873] Starting dynamic subtest: pipe-D-eDP-1
[254.637487] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.266s)
[254.639763] Subtest alpha-7efc: SUCCESS (2.179s)
[255.473536] [046/133] (766s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[255.587176] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[262.335364] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.750s)
[262.460028] [047/133] (759s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[262.553639] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[262.555762] Starting dynamic subtest: pipe-A-eDP-1
[262.611793] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[262.619375] Starting dynamic subtest: pipe-B-eDP-1
[262.674470] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[262.681937] Starting dynamic subtest: pipe-C-eDP-1
[262.738265] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[262.747609] Starting dynamic subtest: pipe-D-eDP-1
[262.804751] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[262.808651] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[264.807434] [048/133] (757s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[264.905591] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[264.907972] Starting dynamic subtest: A-eDP1
[268.525401] Dynamic subtest A-eDP1: SUCCESS (3.617s)
[268.534238] Starting dynamic subtest: B-eDP1
[271.727992] Dynamic subtest B-eDP1: SUCCESS (3.201s)
[271.736326] Starting dynamic subtest: C-eDP1
[274.833358] Dynamic subtest C-eDP1: SUCCESS (3.105s)
[274.846286] Starting dynamic subtest: D-eDP1
[277.967806] Dynamic subtest D-eDP1: SUCCESS (3.132s)
[277.970460] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.064s)
[278.762597] [049/133] (743s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[278.854404] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[278.858789] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[278.943770] [050/133] (743s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[279.023293] Starting subtest: fb-8bpc-vs-panel-8bpc
[279.025558] Starting dynamic subtest: pipe-A-eDP-1
[280.465626] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.443s)
[280.467858] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.444s)
[281.350434] [051/133] (740s left) gem_pxp (fail-invalid-protected-context)
[281.473969] Starting subtest: fail-invalid-protected-context
[281.476087] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[281.591981] [052/133] (740s left) kms_force_connector_basic (prune-stale-modes)
[281.667402] Starting subtest: prune-stale-modes
[282.105451] Subtest prune-stale-modes: SUCCESS (0.441s)
[282.241891] [053/133] (740s left) gem_render_copy_redux (interruptible)
[282.301612] Starting subtest: interruptible
[282.571612] Subtest interruptible: SUCCESS (0.270s)
[282.683531] [054/133] (739s left) perf_pmu (faulting-read)
[282.725778] Starting subtest: faulting-read
[282.727815] Starting dynamic subtest: wb
[282.729942] Dynamic subtest wb: SUCCESS (0.001s)
[282.738635] Starting dynamic subtest: wc
[282.740452] Dynamic subtest wc: SUCCESS (0.000s)
[282.748126] Starting dynamic subtest: uc
[282.749943] Dynamic subtest uc: SUCCESS (0.000s)
[282.751680] Subtest faulting-read: SUCCESS (0.003s)
[282.827581] [055/133] (739s left) gem_ctx_isolation (clean)
[282.881752] Starting subtest: clean
[282.883781] Starting dynamic subtest: rcs0
[282.905995] Dynamic subtest rcs0: SUCCESS (0.024s)
[282.913966] Starting dynamic subtest: bcs0
[282.981321] Dynamic subtest bcs0: SUCCESS (0.074s)
[282.991658] Starting dynamic subtest: vcs0
[283.065506] Dynamic subtest vcs0: SUCCESS (0.083s)
[283.075321] Starting dynamic subtest: vcs1
[284.909413] Dynamic subtest vcs1: SUCCESS (1.842s)
[284.920267] Starting dynamic subtest: vecs0
[286.955110] Dynamic subtest vecs0: SUCCESS (2.045s)
[286.965707] Starting dynamic subtest: ccs0
[288.920353] Dynamic subtest ccs0: SUCCESS (1.963s)
[288.922683] Subtest clean: SUCCESS (6.038s)
[289.139814] [056/133] (733s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[289.264511] Starting subtest: flip-vs-cursor-busy-crc-atomic
[290.085573] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.819s)
[290.971106] [057/133] (731s left) gem_mmap_gtt (isolation)
[291.032379] Subtest isolation: SKIP (0.000s)
[291.130770] [058/133] (731s left) prime_busy (hang)
[291.190085] Starting subtest: hang
[291.192440] Starting dynamic subtest: rcs0
[317.425103] Dynamic subtest rcs0: SUCCESS (26.229s)
[317.433529] Starting dynamic subtest: bcs0
[324.583753] Dynamic subtest bcs0: SUCCESS (7.157s)
[324.592095] Starting dynamic subtest: vcs0
[331.549732] Dynamic subtest vcs0: SUCCESS (6.968s)
[331.557995] Starting dynamic subtest: vcs1
[338.594212] Dynamic subtest vcs1: SUCCESS (7.040s)
[338.602527] Starting dynamic subtest: vecs0
[345.563770] Dynamic subtest vecs0: SUCCESS (6.971s)
[345.572243] Starting dynamic subtest: ccs0
[359.409265] Dynamic subtest ccs0: SUCCESS (13.841s)
[359.411549] Subtest hang: SUCCESS (68.213s)
[359.553368] [059/133] (663s left) kms_cursor_crc (cursor-sliding-512x512)
[359.836086] Starting subtest: cursor-sliding-512x512
[359.840345] Subtest cursor-sliding-512x512: SKIP (0.001s)
[360.011377] [060/133] (662s left) gem_exec_balancer (sequential)
[360.081066] Starting subtest: sequential
[363.124555] Subtest sequential: SUCCESS (3.043s)
[363.450554] [061/133] (659s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[363.544367] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[370.400911] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.859s)
[370.518954] [062/133] (652s left) gem_softpin (full)
[370.581369] Starting subtest: full
[370.588685] Subtest full: SUCCESS (0.008s)
[370.708723] [063/133] (652s left) kms_psr (pr-sprite-plane-move)
[370.796562] Starting subtest: pr-sprite-plane-move
[370.800813] Subtest pr-sprite-plane-move: SKIP (0.000s)
[370.867725] [064/133] (651s left) gem_ctx_shared (q-in-order)
[370.925070] Starting subtest: Q-in-order
[370.927311] Starting dynamic subtest: rcs0
[371.020620] Dynamic subtest rcs0: SUCCESS (0.095s)
[371.035459] Starting dynamic subtest: vcs0
[371.107732] Dynamic subtest vcs0: SUCCESS (0.087s)
[371.123775] Starting dynamic subtest: vcs1
[371.185679] Dynamic subtest vcs1: SUCCESS (0.077s)
[371.200898] Starting dynamic subtest: vecs0
[371.260038] Dynamic subtest vecs0: SUCCESS (0.072s)
[371.274300] Starting dynamic subtest: ccs0
[371.341597] Dynamic subtest ccs0: SUCCESS (0.081s)
[371.344069] Subtest Q-in-order: SUCCESS (0.417s)
[372.978612] [065/133] (649s left) kms_chamelium_audio (hdmi-audio)
[373.360724] Subtest hdmi-audio: SKIP (0.000s)
[374.132988] [066/133] (648s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[374.199037] Starting subtest: single-wait-all-for-submit-available-submitted
[374.201480] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[374.314676] [067/133] (648s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[374.593283] Starting subtest: cursor-rapid-movement-512x170
[374.597818] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[374.747775] [068/133] (648s left) kms_big_fb (linear-64bpp-rotate-270)
[374.850444] Starting subtest: linear-64bpp-rotate-270
[374.869242] Subtest linear-64bpp-rotate-270: SKIP (0.018s)
[374.999761] [069/133] (648s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[375.131327] Starting subtest: flip-vs-cursor-atomic
[382.203363] Subtest flip-vs-cursor-atomic: SUCCESS (7.072s)
[383.063174] [070/133] (639s left) gem_exec_schedule (semaphore-power)
[383.245592] Subtest semaphore-power: SKIP (0.000s)
[383.430984] [071/133] (639s left) gem_ctx_persistence (legacy-engines-hang)
[383.503160] Starting subtest: legacy-engines-hang
[383.505605] Starting dynamic subtest: render
[383.620999] Dynamic subtest render: SUCCESS (0.117s)
[383.631716] Starting dynamic subtest: bsd1
[383.710527] Dynamic subtest bsd1: SUCCESS (0.086s)
[383.721466] Starting dynamic subtest: bsd2
[383.802075] Dynamic subtest bsd2: SUCCESS (0.089s)
[383.813248] Starting dynamic subtest: blt
[383.838778] Dynamic subtest blt: SUCCESS (0.034s)
[383.851275] Starting dynamic subtest: vebox
[383.933945] Dynamic subtest vebox: SUCCESS (0.093s)
[383.936781] Subtest legacy-engines-hang: SUCCESS (0.432s)
[384.014126] [072/133] (639s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[384.113903] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[384.116369] Starting dynamic subtest: pipe-A
[384.176339] Dynamic subtest pipe-A: SUCCESS (0.065s)
[384.187031] Starting dynamic subtest: pipe-B
[385.350490] Dynamic subtest pipe-B: SUCCESS (1.173s)
[385.359953] Starting dynamic subtest: pipe-C
[386.432179] Dynamic subtest pipe-C: SUCCESS (1.080s)
[386.441350] Starting dynamic subtest: pipe-D
[387.518252] Dynamic subtest pipe-D: SUCCESS (1.085s)
[387.520662] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.408s)
[388.665279] [073/133] (634s left) syncobj_timeline (multi-wait-for-submit-signaled)
[388.722246] Starting subtest: multi-wait-for-submit-signaled
[388.724602] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[388.822369] [074/133] (634s left) kms_atomic_interruptible (legacy-dpms)
[388.921519] Starting subtest: legacy-dpms
[388.923668] Starting dynamic subtest: pipe-A-eDP-1
[396.349382] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.426s)
[396.351759] Subtest legacy-dpms: SUCCESS (7.428s)
[397.150146] [075/133] (626s left) syncobj_basic (bad-pad-handle-to-fd)
[397.217253] Starting subtest: bad-pad-handle-to-fd
[397.219673] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[397.326984] [076/133] (625s left) drm_read (short-buffer-nonblock)
[397.466108] Starting subtest: short-buffer-nonblock
[397.468495] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[397.625895] [077/133] (625s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[397.735283] Starting subtest: cursorB-vs-flipB-varying-size
[397.739576] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[397.890996] [078/133] (625s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[397.982135] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[397.986057] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[398.061601] [079/133] (625s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[398.147683] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[399.260574] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.112s)
[399.383698] [080/133] (624s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[399.484378] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[403.945248] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.462s)
[405.059424] [081/133] (618s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[405.165173] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[405.169540] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[405.233894] [082/133] (618s left) kms_atomic (crtc-invalid-params)
[405.322280] Starting subtest: crtc-invalid-params
[405.324614] Starting dynamic subtest: pipe-A-eDP-1
[405.682419] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.359s)
[405.684649] Subtest crtc-invalid-params: SUCCESS (0.360s)
[406.541829] [083/133] (617s left) kms_flip (busy-flip)
[406.637071] Starting subtest: busy-flip
[406.639236] Starting dynamic subtest: A-eDP1
[408.336075] Dynamic subtest A-eDP1: SUCCESS (1.698s)
[408.345663] Starting dynamic subtest: B-eDP1
[410.029804] Dynamic subtest B-eDP1: SUCCESS (1.691s)
[410.039691] Starting dynamic subtest: C-eDP1
[411.717789] Dynamic subtest C-eDP1: SUCCESS (1.686s)
[411.727667] Starting dynamic subtest: D-eDP1
[413.436763] Dynamic subtest D-eDP1: SUCCESS (1.696s)
[413.440921] Subtest busy-flip: SUCCESS (6.780s)
[414.641606] [084/133] (609s left) gem_exec_params (cliprects-invalid)
[414.700184] Starting subtest: cliprects-invalid
[414.702655] Subtest cliprects-invalid: SUCCESS (0.000s)
[414.803161] [085/133] (608s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[414.904359] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[419.721145] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.820s)
[420.855814] [086/133] (602s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[420.919803] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[420.922524] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[421.043138] [087/133] (602s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[421.138369] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[421.142504] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[421.246504] [088/133] (602s left) syncobj_timeline (wait-zero-handles)
[421.302668] Starting subtest: wait-zero-handles
[421.305249] Subtest wait-zero-handles: SUCCESS (0.000s)
[421.406678] [089/133] (602s left) kms_psr (fbc-pr-sprite-plane-onoff)
[421.497846] Starting subtest: fbc-pr-sprite-plane-onoff
[421.502131] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[421.596440] [090/133] (602s left) gen9_exec_parse (batch-without-end)
[421.664131] Subtest batch-without-end: SKIP (0.000s)
[421.734285] [091/133] (602s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[421.841909] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[421.845648] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[421.941746] [092/133] (602s left) syncobj_wait (wait-for-submit-snapshot)
[422.012550] Starting subtest: wait-for-submit-snapshot
[422.093799] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[422.167823] [093/133] (601s left) gem_exec_suspend (basic-s0)
[422.220935] Starting subtest: basic-S0
[422.222811] Starting dynamic subtest: smem
[443.156375] Dynamic subtest smem: SUCCESS (6.700s)
[443.159093] Subtest basic-S0: SUCCESS (6.703s)
[443.344909] [094/133] (580s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[443.469897] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[443.474345] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[443.567498] [095/133] (580s left) perf (invalid-open-flags)
[443.690231] Starting subtest: invalid-open-flags
[443.692497] Subtest invalid-open-flags: SUCCESS (0.000s)
[443.736939] [096/133] (580s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[443.822923] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[443.827166] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[443.928081] [097/133] (580s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[444.020605] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[444.025179] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[444.115263] [098/133] (580s left) kms_addfb_basic (unused-modifier)
[444.168323] Starting subtest: unused-modifier
[444.170116] Subtest unused-modifier: SUCCESS (0.000s)
[444.300769] [099/133] (580s left) perf (enable-disable)
[444.377762] Starting subtest: enable-disable
[444.379716] Starting dynamic subtest: 0-rcs0
[446.619478] Dynamic subtest 0-rcs0: SUCCESS (2.280s)
[446.629500] Starting dynamic subtest: 1-vecs0
[451.036616] Dynamic subtest 1-vecs0: SUCCESS (4.469s)
[451.039132] Subtest enable-disable: SUCCESS (6.751s)
[451.083975] [100/133] (573s left) gem_exec_whisper (basic-queues-forked-all)
[451.149205] Starting subtest: basic-queues-forked-all
[471.502753] Subtest basic-queues-forked-all: SUCCESS (20.416s)
[471.683426] [101/133] (552s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[471.737123] Starting subtest: y-tiled-to-vebox-yf-tiled
[471.741509] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[471.914383] [102/133] (552s left) kms_addfb_basic (bad-pitch-0)
[471.975483] Starting subtest: bad-pitch-0
[471.977985] Subtest bad-pitch-0: SUCCESS (0.000s)
[472.118644] [103/133] (552s left) gem_ctx_engines (execute-one)
[472.176478] Starting subtest: execute-one
[474.352630] Subtest execute-one: SUCCESS (2.177s)
[474.536620] [104/133] (549s left) gem_wait (invalid-buf)
[474.606359] Starting subtest: invalid-buf
[474.608685] Subtest invalid-buf: SUCCESS (0.000s)
[474.802758] [105/133] (549s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[474.902551] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[474.904832] Starting dynamic subtest: pipe-A-eDP-1
[474.990397] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[475.000083] Starting dynamic subtest: pipe-B-eDP-1
[476.181794] Dynamic subtest pipe-B-eDP-1: SKIP (1.190s)
[476.186400] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.281s)
[477.342123] [106/133] (547s left) kms_pm_dc (dc3co-vpb-simulation)
[478.442253] Starting subtest: dc3co-vpb-simulation
[486.898394] Subtest dc3co-vpb-simulation: SKIP (8.452s)
[487.041419] [107/133] (537s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[487.139214] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[490.642154] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.506s)
[491.847495] [108/133] (532s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[491.947458] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[491.951830] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[492.036201] [109/133] (532s left) kms_plane_scaling (invalid-parameters)
[492.143703] Starting subtest: invalid-parameters
[492.145983] Starting dynamic subtest: less-than-1-height-src
[492.156642] Dynamic subtest less-than-1-height-src: SUCCESS (0.014s)
[492.166383] Starting dynamic subtest: less-than-1-width-src
[492.171700] Dynamic subtest less-than-1-width-src: SUCCESS (0.012s)
[492.173964] Subtest invalid-parameters: SUCCESS (0.027s)
[492.288588] [110/133] (532s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[492.384411] Starting subtest: yf-tiled-8bpp-rotate-0
[492.388842] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[492.477988] [111/133] (532s left) kms_psr (psr-cursor-plane-move)
[492.569211] Starting subtest: psr-cursor-plane-move
[492.571595] Starting dynamic subtest: eDP-1
[494.294982] Dynamic subtest eDP-1: SUCCESS (1.725s)
[494.297471] Subtest psr-cursor-plane-move: SUCCESS (1.726s)
[495.139029] [112/133] (529s left) i915_suspend (basic-s3-without-i915)
[495.175455] Starting subtest: basic-s3-without-i915
[496.889196] Subtest basic-s3-without-i915: SKIP (1.712s)
[498.424292] [113/133] (526s left) gem_exec_schedule (noreorder)
[498.618707] Starting subtest: noreorder
[498.621261] Starting dynamic subtest: rcs0
[498.679609] Dynamic subtest rcs0: SUCCESS (0.060s)
[498.689193] Starting dynamic subtest: vcs0
[500.175639] Dynamic subtest vcs0: SUCCESS (1.493s)
[500.184813] Starting dynamic subtest: vcs1
[502.158633] Dynamic subtest vcs1: SUCCESS (1.980s)
[502.169622] Starting dynamic subtest: vecs0
[504.139717] Dynamic subtest vecs0: SUCCESS (1.978s)
[504.150253] Starting dynamic subtest: ccs0
[504.215340] Dynamic subtest ccs0: SUCCESS (0.074s)
[504.218042] Subtest noreorder: SUCCESS (5.599s)
[504.415231] [114/133] (520s left) gem_wait (await)
[504.482633] Starting subtest: await
[504.485065] Starting dynamic subtest: all-engines
[505.595453] Dynamic subtest all-engines: SUCCESS (1.112s)
[505.612428] Starting dynamic subtest: rcs0
[506.653745] Dynamic subtest rcs0: SUCCESS (1.056s)
[506.670574] Starting dynamic subtest: bcs0
[507.712741] Dynamic subtest bcs0: SUCCESS (1.057s)
[507.728920] Starting dynamic subtest: vcs0
[508.765952] Dynamic subtest vcs0: SUCCESS (1.051s)
[508.784522] Starting dynamic subtest: vcs1
[509.819583] Dynamic subtest vcs1: SUCCESS (1.051s)
[509.834929] Starting dynamic subtest: vecs0
[510.872566] Dynamic subtest vecs0: SUCCESS (1.051s)
[510.888104] Starting dynamic subtest: ccs0
[511.929887] Dynamic subtest ccs0: SUCCESS (1.055s)
[511.932516] Subtest await: SUCCESS (7.450s)
[512.143046] [115/133] (512s left) kms_getfb (getfb2-handle-protection)
[512.246249] Starting subtest: getfb2-handle-protection
[512.272611] Subtest getfb2-handle-protection: SUCCESS (0.026s)
[512.398593] [116/133] (512s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[512.509549] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[512.513682] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[512.606905] [117/133] (512s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[512.659006] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[512.724004] [118/133] (512s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[512.778531] Starting subtest: etime-multi-wait-for-submit-submitted
[512.879218] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.101s)
[512.959012] [119/133] (512s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[513.052804] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[513.055108] Starting dynamic subtest: pipe-A-eDP-1
[513.075988] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[513.084834] Starting dynamic subtest: pipe-B-eDP-1
[513.102421] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[513.109704] Starting dynamic subtest: pipe-C-eDP-1
[513.127154] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[513.134613] Starting dynamic subtest: pipe-D-eDP-1
[513.153348] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[513.156993] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[515.319056] [120/133] (509s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[515.421508] Starting subtest: extended-pageflip-modeset-hang-oldfb
[515.423496] Starting dynamic subtest: pipe-A
[523.331788] Dynamic subtest pipe-A: SUCCESS (7.911s)
[523.341125] Starting dynamic subtest: pipe-D
[531.919303] Dynamic subtest pipe-D: SUCCESS (8.588s)
[531.921577] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.503s)
[532.788269] [121/133] (492s left) gem_exec_reloc (basic-write-read-active)
[532.854357] Subtest basic-write-read-active: SKIP (0.000s)
[532.930078] [122/133] (492s left) gem_exec_balancer (bonded-true-hang)
[533.178054] Starting subtest: bonded-true-hang
[533.183125] Subtest bonded-true-hang: SKIP (0.000s)
[533.294987] [123/133] (492s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[533.385552] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[533.387810] Starting dynamic subtest: pipe-A-eDP-1
[539.273257] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.892s)
[539.283158] Starting dynamic subtest: pipe-B-eDP-1
[545.819021] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.543s)
[545.821464] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.438s)
[546.688009] [124/133] (478s left) prime_vgem (fence-write-hang)
[546.753754] Subtest fence-write-hang: SKIP (0.000s)
[546.846716] [125/133] (478s left) kms_fb_coherency (memset-crc)
[546.937573] Starting subtest: memset-crc
[546.939905] Starting dynamic subtest: mmap-offset-wc
[547.301109] Dynamic subtest mmap-offset-wc: SUCCESS (0.364s)
[547.606615] Starting dynamic subtest: mmap-offset-uc
[553.658030] Dynamic subtest mmap-offset-uc: SUCCESS (6.057s)
[553.943081] Subtest memset-crc: SUCCESS (7.002s)
[554.763769] [126/133] (470s left) kms_vblank (wait-forked-busy-hang)
[554.856720] Starting subtest: wait-forked-busy-hang
[554.858608] Starting dynamic subtest: pipe-A-eDP-1
[580.963860] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.106s)
[580.977934] Starting dynamic subtest: pipe-D-eDP-1
[605.910074] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.945s)
[605.912347] Subtest wait-forked-busy-hang: SUCCESS (51.055s)
[606.718305] [127/133] (418s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[606.831509] Starting subtest: multiplane-rotation-cropping-bottom
[624.230293] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.404s)
[624.343176] [128/133] (401s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[624.443494] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[624.446924] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[624.549404] [129/133] (400s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[624.641825] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[624.643670] Starting dynamic subtest: pipe-A-eDP-1
[624.659692] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[624.669312] Starting dynamic subtest: pipe-B-eDP-1
[624.684377] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[624.692904] Starting dynamic subtest: pipe-C-eDP-1
[624.708863] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[624.716594] Starting dynamic subtest: pipe-D-eDP-1
[624.732370] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[624.734009] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[626.779923] [130/133] (398s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[626.871734] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[626.897881] Starting dynamic subtest: pipe-A-plane-0
[627.330914] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[627.340606] Starting dynamic subtest: pipe-A-plane-3
[627.597529] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[628.668697] Starting dynamic subtest: pipe-B-plane-0
[629.105127] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[629.114698] Starting dynamic subtest: pipe-B-plane-3
[629.382904] Dynamic subtest pipe-B-plane-3: SUCCESS (0.277s)
[629.696997] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.825s)
[630.556265] [131/133] (395s left) gem_exec_reloc (basic-cpu-gtt)
[630.616176] Subtest basic-cpu-gtt: SKIP (0.000s)
[630.682886] [132/133] (394s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[630.776207] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[637.800973] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (7.029s)
[637.911989] [133/133] (387s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[637.983208] Starting subtest: multi-wait-all-for-submit-submitted
[638.088029] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.104s)
[638.158259] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: i915_pm_rpm
results: parsing output: 4/ for test: kms_universal_plane
results: parsing output: 5/ for test: perf
results: parsing output: 6/ for test: kms_flip_event_leak
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: kms_rotation_crc
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_chamelium_edid
results: parsing output: 11/ for test: gem_exec_flush
results: parsing output: 12/ for test: gem_ccs
results: parsing output: 13/ for test: kms_invalid_mode
results: parsing output: 14/ for test: perf
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_pxp
results: parsing output: 17/ for test: vgem_basic
results: parsing output: 18/ for test: core_getclient
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_flip_scaled_crc
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_getfb
results: parsing output: 23/ for test: kms_color
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: i915_drm_fdinfo
results: parsing output: 26/ for test: gem_pipe_control_store_loop
results: parsing output: 27/ for test: device_reset
results: parsing output: 28/ for test: kms_content_protection
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_rotation_crc
results: parsing output: 31/ for test: kms_pm_rpm
results: parsing output: 32/ for test: kms_async_flips
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: kms_lease
results: parsing output: 35/ for test: kms_plane_multiple
results: parsing output: 36/ for test: i915_hangman
results: parsing output: 37/ for test: gem_media_fill
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_chamelium_hpd
results: parsing output: 41/ for test: gem_exec_fence
results: parsing output: 42/ for test: gem_workarounds
results: parsing output: 43/ for test: syncobj_eventfd
results: parsing output: 44/ for test: kms_plane_alpha_blend
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_dither
results: parsing output: 50/ for test: gem_pxp
results: parsing output: 51/ for test: kms_force_connector_basic
results: parsing output: 52/ for test: gem_render_copy_redux
results: parsing output: 53/ for test: perf_pmu
results: parsing output: 54/ for test: gem_ctx_isolation
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: prime_busy
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: gem_exec_balancer
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_softpin
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: gem_ctx_shared
results: parsing output: 64/ for test: kms_chamelium_audio
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: gem_ctx_persistence
results: parsing output: 71/ for test: kms_plane_scaling
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_atomic_interruptible
results: parsing output: 74/ for test: syncobj_basic
results: parsing output: 75/ for test: drm_read
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_psr2_sf
results: parsing output: 81/ for test: kms_atomic
results: parsing output: 82/ for test: kms_flip
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: gen9_exec_parse
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: gem_exec_suspend
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: perf
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_addfb_basic
results: parsing output: 98/ for test: perf
results: parsing output: 99/ for test: gem_exec_whisper
results: parsing output: 100/ for test: gem_render_copy
results: parsing output: 101/ for test: kms_addfb_basic
results: parsing output: 102/ for test: gem_ctx_engines
results: parsing output: 103/ for test: gem_wait
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: kms_pm_dc
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_plane_scaling
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: i915_suspend
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: gem_wait
results: parsing output: 114/ for test: kms_getfb
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_exec_reloc
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: kms_busy
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: gem_exec_balancer
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: prime_vgem
results: parsing output: 124/ for test: kms_fb_coherency
results: parsing output: 125/ for test: kms_vblank
results: parsing output: 126/ for test: kms_rotation_crc
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: kms_plane
results: parsing output: 130/ for test: gem_exec_reloc
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: syncobj_wait
Done.