[58.001684] Initializing watchdogs [58.001737] /dev/watchdog0 [58.016279] [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] [58.020668] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.023044] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.026235] [001/131] (960s left) gem_exec_reloc (basic-gtt-cpu-active) [58.116957] Subtest basic-gtt-cpu-active: SKIP (0.000s) [58.194868] [002/131] (960s left) sw_sync (alloc_fence) [58.235142] Starting subtest: alloc_fence [58.237479] Subtest alloc_fence: SUCCESS (0.000s) [58.309668] [003/131] (960s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format) [58.403926] Starting subtest: plane-downscale-factor-0-5-with-pixel-format [58.406152] Starting dynamic subtest: pipe-A [58.425598] Dynamic subtest pipe-A: SKIP (0.018s) [58.437255] Starting dynamic subtest: pipe-B [58.460146] Dynamic subtest pipe-B: SKIP (0.034s) [58.467341] Starting dynamic subtest: pipe-C [58.493615] Dynamic subtest pipe-C: SKIP (0.034s) [58.500399] Starting dynamic subtest: pipe-D [58.526294] Dynamic subtest pipe-D: SKIP (0.034s) [58.529799] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.120s) [58.653279] [004/131] (959s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [58.769893] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt [58.774095] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [58.905353] [005/131] (959s left) gem_tiled_pread_basic [59.017978] [006/131] (959s left) gem_exec_fence (concurrent) [59.198982] Starting subtest: concurrent [59.203570] Subtest concurrent: SKIP (0.000s) [61.000373] [FACT gem_exec_fence (concurrent)] new: kernel.kmod_is_loaded.vgem: true [61.004283] [007/131] (957s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt) [61.109303] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt [61.113619] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [61.241025] [008/131] (957s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [61.329988] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc [61.332195] Starting dynamic subtest: pipe-A-eDP-1 [61.351699] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [61.361583] Starting dynamic subtest: pipe-B-eDP-1 [61.382652] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [61.396643] Starting dynamic subtest: pipe-C-eDP-1 [61.415852] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [61.429762] Starting dynamic subtest: pipe-D-eDP-1 [61.450041] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [61.452050] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s) [63.644707] [009/131] (955s left) gem_render_copy_redux (interruptible) [63.711375] Starting subtest: interruptible [63.978505] Subtest interruptible: SUCCESS (0.268s) [64.128087] [010/131] (954s left) gem_exec_whisper (basic-queues-all) [64.189830] Starting subtest: basic-queues-all [75.378783] Subtest basic-queues-all: SUCCESS (11.206s) [75.581432] [011/131] (943s left) gem_mmap_wc (coherency) [75.652629] Subtest coherency: SKIP (0.000s) [75.718793] [012/131] (943s left) kms_cursor_crc (cursor-random-256x256) [75.976657] Starting subtest: cursor-random-256x256 [75.978947] Starting dynamic subtest: pipe-A-eDP-1 [79.326300] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.348s) [79.354850] Starting dynamic subtest: pipe-D-eDP-1 [83.283769] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.933s) [83.286122] Subtest cursor-random-256x256: SUCCESS (7.308s) [84.185458] [013/131] (934s left) gem_sync (basic-store-all) [84.268259] Starting subtest: basic-store-all [86.667795] Subtest basic-store-all: SUCCESS (2.411s) [86.877115] [014/131] (932s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs) [86.985963] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs [86.988235] Starting dynamic subtest: pipe-A-eDP-1 [87.046129] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [87.059096] Starting dynamic subtest: pipe-B-eDP-1 [87.117332] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [87.126413] Starting dynamic subtest: pipe-C-eDP-1 [87.184131] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [87.193293] Starting dynamic subtest: pipe-D-eDP-1 [87.250413] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [87.254595] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.007s) [89.249156] [015/131] (929s left) kms_big_fb (linear-32bpp-rotate-180) [89.361853] Starting subtest: linear-32bpp-rotate-180 [90.818434] Subtest linear-32bpp-rotate-180: SUCCESS (1.457s) [90.997849] [016/131] (928s left) perf (rc6-disable) [91.140963] Starting subtest: rc6-disable [91.320174] Subtest rc6-disable: SUCCESS (0.180s) [91.363451] [017/131] (927s left) gem_mmap_offset (open-flood) [91.421167] Starting subtest: open-flood [112.913692] Subtest open-flood: SUCCESS (21.492s) [113.071619] [018/131] (906s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render) [113.181185] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render [119.905485] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.725s) [120.075229] [019/131] (899s left) perf_pmu (busy-no-semaphores) [120.120059] Starting subtest: busy-no-semaphores [120.122922] Starting dynamic subtest: rcs0 [120.697614] Dynamic subtest rcs0: SUCCESS (0.577s) [120.708481] Starting dynamic subtest: bcs0 [121.246594] Dynamic subtest bcs0: SUCCESS (0.546s) [121.258056] Starting dynamic subtest: vcs0 [121.796298] Dynamic subtest vcs0: SUCCESS (0.547s) [121.807331] Starting dynamic subtest: vcs1 [123.418458] Dynamic subtest vcs1: SUCCESS (1.619s) [123.429628] Starting dynamic subtest: vecs0 [125.401517] Dynamic subtest vecs0: SUCCESS (1.980s) [125.412516] Starting dynamic subtest: ccs0 [127.449675] Dynamic subtest ccs0: SUCCESS (2.045s) [127.452733] Subtest busy-no-semaphores: SUCCESS (7.331s) [127.616960] [020/131] (891s left) gem_fence_thrash (bo-write-verify-threaded-y) [127.657612] Starting subtest: bo-write-verify-threaded-y [127.683420] Subtest bo-write-verify-threaded-y: SKIP (0.024s) [127.747310] [021/131] (891s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu) [127.863218] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu [127.867772] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [127.992602] [022/131] (891s left) kms_cursor_crc (cursor-sliding-64x21) [128.188578] Starting subtest: cursor-sliding-64x21 [128.235493] Subtest cursor-sliding-64x21: SKIP (0.041s) [128.488647] [023/131] (890s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [128.596327] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [128.599760] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [128.728516] [024/131] (890s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c) [128.792111] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s) [128.857744] [025/131] (890s left) gem_exec_schedule (preemptive-hang) [129.021037] Starting subtest: preemptive-hang [129.023854] Starting dynamic subtest: rcs0 [138.050283] Dynamic subtest rcs0: SUCCESS (9.028s) [138.058111] Starting dynamic subtest: bcs0 [147.004457] Dynamic subtest bcs0: SUCCESS (8.954s) [147.012392] Starting dynamic subtest: vcs0 [156.032057] Dynamic subtest vcs0: SUCCESS (9.025s) [156.042399] Starting dynamic subtest: vcs1 [165.054747] Dynamic subtest vcs1: SUCCESS (9.021s) [165.066099] Starting dynamic subtest: vecs0 [174.005774] Dynamic subtest vecs0: SUCCESS (8.950s) [174.015981] Starting dynamic subtest: ccs0 [183.035290] Dynamic subtest ccs0: SUCCESS (9.028s) [183.037788] Subtest preemptive-hang: SUCCESS (54.017s) [183.304289] [026/131] (836s left) perf (invalid-remove-userspace-config) [183.412224] Starting subtest: invalid-remove-userspace-config [183.422958] Subtest invalid-remove-userspace-config: SUCCESS (0.011s) [183.464640] [027/131] (836s left) kms_pm_rpm (modeset-pc8-residency-stress) [185.090034] Starting subtest: modeset-pc8-residency-stress [185.095193] Subtest modeset-pc8-residency-stress: SKIP (0.000s) [185.713474] [028/131] (833s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt) [185.809675] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt [185.814067] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [185.948474] [029/131] (833s left) kms_chamelium_audio (dp-audio) [186.340043] Subtest dp-audio: SKIP (0.000s) [187.186427] [030/131] (832s left) gem_eio (wait-wedge-10ms) [187.380936] Starting subtest: wait-wedge-10ms [188.940139] Subtest wait-wedge-10ms: SUCCESS (1.558s) [189.130632] [031/131] (830s left) gem_exec_schedule (smoketest) [189.305712] Starting subtest: smoketest [189.308364] Starting dynamic subtest: rcs0 [194.861343] Dynamic subtest rcs0: SUCCESS (5.508s) [194.873362] Starting dynamic subtest: bcs0 [200.368837] Dynamic subtest bcs0: SUCCESS (5.509s) [200.378947] Starting dynamic subtest: vcs0 [205.885083] Dynamic subtest vcs0: SUCCESS (5.509s) [205.900777] Starting dynamic subtest: vcs1 [211.381470] Dynamic subtest vcs1: SUCCESS (5.498s) [211.396303] Starting dynamic subtest: vecs0 [216.878307] Dynamic subtest vecs0: SUCCESS (5.500s) [216.889874] Starting dynamic subtest: ccs0 [222.393823] Dynamic subtest ccs0: SUCCESS (5.511s) [222.396159] Subtest smoketest: SUCCESS (33.041s) [222.619881] [032/131] (797s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [222.686243] Starting subtest: yf-tiled-to-vebox-x-tiled [222.690585] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s) [222.896974] [033/131] (796s left) kms_color_pipeline (plane-ctm3x4) [222.996923] Starting subtest: plane-ctm3x4 [223.009870] Starting dynamic subtest: pipe-A-eDP-1 [223.701584] Dynamic subtest pipe-A-eDP-1: FAIL (0.302s) [224.376246] Starting dynamic subtest: pipe-B-eDP-1 [225.178116] Dynamic subtest pipe-B-eDP-1: FAIL (0.291s) [225.704994] Starting dynamic subtest: pipe-C-eDP-1 [226.526075] Dynamic subtest pipe-C-eDP-1: FAIL (0.225s) [227.034596] Starting dynamic subtest: pipe-D-eDP-1 [227.839487] Dynamic subtest pipe-D-eDP-1: FAIL (0.213s) [227.841845] Subtest plane-ctm3x4: FAIL (4.535s) [228.442890] [034/131] (791s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt) [228.544135] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt [228.548106] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [228.674624] [035/131] (791s left) kms_async_flips (test-time-stamp) [228.765178] Starting subtest: test-time-stamp [229.136341] Starting dynamic subtest: pipe-A-eDP-1 [229.915499] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.777s) [230.292104] Starting dynamic subtest: pipe-B-eDP-1 [231.052028] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.764s) [231.435082] Starting dynamic subtest: pipe-C-eDP-1 [232.179706] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.749s) [232.543352] Starting dynamic subtest: pipe-D-eDP-1 [233.310352] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.772s) [233.312783] Subtest test-time-stamp: SUCCESS (4.545s) [234.497751] [036/131] (785s left) syncobj_timeline (reset-signaled) [234.563051] Starting subtest: reset-signaled [234.565436] Subtest reset-signaled: SUCCESS (0.000s) [234.705187] [037/131] (785s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [234.821607] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [234.825907] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [234.944931] [038/131] (785s left) gem_exec_params (invalid-ring) [235.013583] Starting subtest: invalid-ring [235.015860] Subtest invalid-ring: SUCCESS (0.000s) [235.169319] [039/131] (784s left) kms_addfb_basic (tile-pitch-mismatch) [235.237498] Starting subtest: tile-pitch-mismatch [235.241767] Subtest tile-pitch-mismatch: SKIP (0.000s) [235.392889] [040/131] (784s left) i915_drm_fdinfo (all-busy-idle-check-all) [235.438655] Starting subtest: all-busy-idle-check-all [235.444424] Subtest all-busy-idle-check-all: SKIP (0.004s) [235.556965] [041/131] (784s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [235.726558] Starting subtest: verify-pxp-execution-after-suspend-resume [247.296735] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (11.567s) [247.471075] [042/131] (772s left) gem_readwrite (beyond-eob) [247.551055] Subtest beyond-EOB: SKIP (0.000s) [247.630417] [043/131] (772s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [247.719659] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [247.724047] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [247.862260] [044/131] (772s left) kms_chamelium_frames (dp-crc-single) [248.254572] Subtest dp-crc-single: SKIP (0.000s) [249.052124] [045/131] (771s left) api_intel_allocator (alloc-simple) [249.115425] Starting subtest: alloc-simple [249.120958] Subtest alloc-simple: SUCCESS (0.005s) [249.274239] [046/131] (771s left) gem_busy (busy) [249.338979] Starting subtest: busy [249.341352] Starting dynamic subtest: all-engines [249.403995] Dynamic subtest all-engines: SUCCESS (0.065s) [249.415190] Starting dynamic subtest: rcs0 [250.908045] Dynamic subtest rcs0: SUCCESS (1.502s) [250.917697] Starting dynamic subtest: bcs0 [250.974209] Dynamic subtest bcs0: SUCCESS (0.064s) [250.984028] Starting dynamic subtest: vcs0 [251.015269] Dynamic subtest vcs0: SUCCESS (0.042s) [251.023710] Starting dynamic subtest: vcs1 [252.889746] Dynamic subtest vcs1: SUCCESS (1.869s) [252.898521] Starting dynamic subtest: vecs0 [254.937913] Dynamic subtest vecs0: SUCCESS (2.047s) [254.946744] Starting dynamic subtest: ccs0 [256.923775] Dynamic subtest ccs0: SUCCESS (1.984s) [256.926342] Subtest busy: SUCCESS (7.581s) [257.326317] [047/131] (763s left) kms_prop_blob (blob-prop-validate) [257.394685] Starting subtest: blob-prop-validate [257.397063] Subtest blob-prop-validate: SUCCESS (0.000s) [257.535115] [048/131] (762s left) kms_flip (2x-nonexisting-fb-interruptible) [257.631984] Starting subtest: 2x-nonexisting-fb-interruptible [257.645071] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s) [257.790463] [049/131] (762s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted) [257.852788] Starting subtest: etime-single-wait-all-for-submit-unsubmitted [257.961106] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s) [258.061031] [050/131] (762s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [258.121582] Starting subtest: multi-wait-available-unsubmitted-signaled [258.123883] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s) [258.264995] [051/131] (762s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [258.366600] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [258.371070] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [258.498951] [052/131] (762s left) kms_cursor_crc (cursor-size-change) [258.599622] Starting subtest: cursor-size-change [258.601897] Starting dynamic subtest: pipe-A-eDP-1 [259.385670] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.786s) [259.395584] Starting dynamic subtest: pipe-D-eDP-1 [260.827411] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.438s) [260.829327] Subtest cursor-size-change: SUCCESS (2.227s) [261.658347] [053/131] (758s left) gem_mmap_gtt (basic-read-write) [261.724543] Subtest basic-read-write: SKIP (0.000s) [261.796330] [054/131] (758s left) prime_vgem (wait) [261.893414] Starting subtest: wait [261.895728] Starting dynamic subtest: rcs0 [261.978628] Dynamic subtest rcs0: SUCCESS (0.084s) [261.989052] Starting dynamic subtest: bcs0 [262.041548] Dynamic subtest bcs0: SUCCESS (0.063s) [262.051279] Starting dynamic subtest: vcs0 [262.082908] Dynamic subtest vcs0: SUCCESS (0.040s) [262.091436] Starting dynamic subtest: vcs1 [262.129987] Dynamic subtest vcs1: SUCCESS (0.046s) [262.138911] Starting dynamic subtest: vecs0 [262.174718] Dynamic subtest vecs0: SUCCESS (0.044s) [262.183771] Starting dynamic subtest: ccs0 [262.222832] Dynamic subtest ccs0: SUCCESS (0.047s) [262.225079] Subtest wait: SUCCESS (0.330s) [262.369440] [055/131] (758s left) kms_cursor_crc (cursor-dpms) [262.499869] Starting subtest: cursor-dpms [262.502138] Starting dynamic subtest: pipe-A-eDP-1 [265.503803] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.002s) [265.513221] Starting dynamic subtest: pipe-D-eDP-1 [269.183152] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.678s) [269.185585] Subtest cursor-dpms: SUCCESS (6.683s) [270.038171] [056/131] (750s left) kms_pipe_crc_basic (read-crc-frame-sequence) [270.139592] Starting subtest: read-crc-frame-sequence [270.141683] Starting dynamic subtest: pipe-A-eDP-1 [270.852134] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s) [270.861551] Starting dynamic subtest: pipe-B-eDP-1 [272.196211] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.344s) [272.211483] Starting dynamic subtest: pipe-C-eDP-1 [273.561760] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.361s) [273.573942] Starting dynamic subtest: pipe-D-eDP-1 [274.903500] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.341s) [274.905837] Subtest read-crc-frame-sequence: SUCCESS (4.764s) [275.756328] [057/131] (745s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render) [275.857529] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render [282.596408] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.742s) [282.746937] [058/131] (738s left) gem_exec_params (rsvd2-dirt) [282.805226] Starting subtest: rsvd2-dirt [282.809767] Subtest rsvd2-dirt: SKIP (0.000s) [282.945971] [059/131] (737s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation) [283.046410] Starting subtest: plane-upscale-factor-0-25-with-rotation [283.048751] Starting dynamic subtest: pipe-A [283.273673] Dynamic subtest pipe-A: SUCCESS (0.229s) [283.283358] Starting dynamic subtest: pipe-B [284.531657] Dynamic subtest pipe-B: SUCCESS (1.256s) [284.541399] Starting dynamic subtest: pipe-C [285.862242] Dynamic subtest pipe-C: SUCCESS (1.330s) [285.873050] Starting dynamic subtest: pipe-D [287.183142] Dynamic subtest pipe-D: SUCCESS (1.318s) [287.185513] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.140s) [288.393312] [060/131] (732s left) kms_psr (fbc-psr-primary-blt) [288.492061] Starting subtest: fbc-psr-primary-blt [288.494383] Starting dynamic subtest: eDP-1 [288.498774] Dynamic subtest eDP-1: SKIP (0.000s) [288.503193] Subtest fbc-psr-primary-blt: SKIP (0.002s) [288.586554] [061/131] (732s left) i915_query (query-regions-sanity-check) [288.642126] Starting subtest: query-regions-sanity-check [288.654101] Subtest query-regions-sanity-check: SUCCESS (0.014s) [288.794646] [062/131] (732s left) gem_exec_fence (syncobj-unused-fence) [289.209899] Starting subtest: syncobj-unused-fence [289.215684] Subtest syncobj-unused-fence: SUCCESS (0.005s) [290.988677] [063/131] (730s left) kms_invalid_mode (uint-max-clock) [291.102607] Starting subtest: uint-max-clock [291.104987] Starting dynamic subtest: pipe-A-eDP-1 [291.393208] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s) [291.402331] Starting dynamic subtest: pipe-B-eDP-1 [291.404193] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [291.412422] Starting dynamic subtest: pipe-C-eDP-1 [291.414798] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [291.423485] Starting dynamic subtest: pipe-D-eDP-1 [291.425948] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [291.428653] Subtest uint-max-clock: SUCCESS (0.297s) [292.221729] [064/131] (728s left) kms_selftest (drm_plane_helper) [292.263105] Starting subtest: drm_plane_helper [292.269434] Starting dynamic subtest: drm_test_check_plane_state [292.419276] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.150s) [292.430419] Starting dynamic subtest: drm_test_check_invalid_plane_state [292.556052] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.134s) [292.557897] Subtest drm_plane_helper: SUCCESS (0.291s) [292.781611] [065/131] (728s left) kms_plane (pixel-format-source-clamping) [292.873687] Starting subtest: pixel-format-source-clamping [292.900342] Starting dynamic subtest: pipe-A-plane-0 [297.634231] Dynamic subtest pipe-A-plane-0: SUCCESS (4.733s) [297.643257] Starting dynamic subtest: pipe-A-plane-3 [300.112534] Dynamic subtest pipe-A-plane-3: SUCCESS (2.476s) [300.121356] Starting dynamic subtest: pipe-A-plane-5 [300.123352] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s) [301.188903] Starting dynamic subtest: pipe-B-plane-0 [306.014471] Dynamic subtest pipe-B-plane-0: SUCCESS (4.833s) [306.023081] Starting dynamic subtest: pipe-B-plane-3 [308.304611] Dynamic subtest pipe-B-plane-3: SUCCESS (2.288s) [308.323107] Starting dynamic subtest: pipe-B-plane-5 [308.325086] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s) [308.611412] Subtest pixel-format-source-clamping: SUCCESS (15.739s) [309.480259] [066/131] (711s left) i915_drm_fdinfo (virtual-busy-idle) [309.526939] Starting subtest: virtual-busy-idle [309.531305] Subtest virtual-busy-idle: SKIP (0.000s) [309.627698] [067/131] (711s left) syncobj_timeline (invalid-signal-bad-pad) [309.687414] Starting subtest: invalid-signal-bad-pad [309.689598] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [309.822808] [068/131] (711s left) gem_fenced_exec_thrash (no-spare-fences) [309.891114] Subtest no-spare-fences: SKIP (0.000s) [309.966057] [069/131] (711s left) api_intel_bb (lot-of-buffers) [310.026849] Starting subtest: lot-of-buffers [311.068239] Subtest lot-of-buffers: SUCCESS (1.043s) [311.531499] [070/131] (709s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc) [311.633784] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc [311.636073] Starting dynamic subtest: pipe-A-eDP-1 [311.657587] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [311.668196] Starting dynamic subtest: pipe-B-eDP-1 [311.690616] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [311.701298] Starting dynamic subtest: pipe-C-eDP-1 [311.721466] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [311.730261] Starting dynamic subtest: pipe-D-eDP-1 [311.751361] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [311.755736] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s) [313.931952] [071/131] (707s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs) [314.027689] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs [314.029791] Starting dynamic subtest: pipe-A-eDP-1 [315.314394] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.288s) [315.323874] Starting dynamic subtest: pipe-B-eDP-1 [317.680070] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.364s) [317.691263] Starting dynamic subtest: pipe-C-eDP-1 [320.014491] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.333s) [320.024719] Starting dynamic subtest: pipe-D-eDP-1 [322.302458] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.286s) [322.305030] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.277s) [323.553106] [072/131] (697s left) gem_softpin (full) [323.619716] Starting subtest: full [323.632233] Subtest full: SUCCESS (0.012s) [323.787885] [073/131] (697s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode) [324.177187] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s) [324.953525] [074/131] (696s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size) [325.073836] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size [356.468078] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.392s) [357.316043] [075/131] (664s left) core_sysfs (read-all-entries) [357.386074] Starting subtest: read-all-entries [357.392984] Subtest read-all-entries: SUCCESS (0.008s) [357.531124] [076/131] (664s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [357.640316] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip [358.431715] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.793s) [358.654706] [077/131] (663s left) gem_exec_suspend (basic-s0) [358.713807] Starting subtest: basic-S0 [358.715963] Starting dynamic subtest: smem [379.144970] Dynamic subtest smem: SUCCESS (6.215s) [379.147523] Subtest basic-S0: SUCCESS (6.217s) [379.349069] [078/131] (642s left) kms_flip (flip-vs-rmfb) [379.465730] Starting subtest: flip-vs-rmfb [379.468010] Starting dynamic subtest: A-eDP1 [388.151762] Dynamic subtest A-eDP1: SUCCESS (8.822s) [388.163496] Starting dynamic subtest: B-eDP1 [396.780726] Dynamic subtest B-eDP1: SUCCESS (8.673s) [396.790347] Starting dynamic subtest: C-eDP1 [405.478742] Dynamic subtest C-eDP1: SUCCESS (8.713s) [405.501013] Starting dynamic subtest: D-eDP1 [414.204747] Dynamic subtest D-eDP1: SUCCESS (8.724s) [414.209919] Subtest flip-vs-rmfb: SUCCESS (34.946s) [415.477886] [079/131] (606s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling) [415.582159] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling [415.584549] Starting dynamic subtest: pipe-A-default-mode [415.882275] Dynamic subtest pipe-A-default-mode: SKIP (0.295s) [415.886996] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.299s) [416.709947] [080/131] (605s left) gem_exec_balancer (parallel) [416.975737] Starting subtest: parallel [417.946244] Subtest parallel: SUCCESS (0.970s) [418.260961] [081/131] (603s left) kms_vblank (wait-forked-busy-hang) [418.343853] Starting subtest: wait-forked-busy-hang [418.346073] Starting dynamic subtest: pipe-A-eDP-1 [444.933985] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.588s) [444.948992] Starting dynamic subtest: pipe-D-eDP-1 [469.891220] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.960s) [469.893489] Subtest wait-forked-busy-hang: SUCCESS (51.553s) [470.759001] [082/131] (551s left) syncobj_basic (bad-pad-handle-to-fd) [470.820742] Starting subtest: bad-pad-handle-to-fd [470.823107] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [470.956628] [083/131] (550s left) kms_psr2_sf (pr-plane-move-sf-dmg-area) [476.006307] Starting subtest: pr-plane-move-sf-dmg-area [476.011068] Subtest pr-plane-move-sf-dmg-area: SKIP (0.002s) [476.878882] [084/131] (545s left) kms_big_fb (x-tiled-8bpp-rotate-270) [476.979398] Starting subtest: x-tiled-8bpp-rotate-270 [477.003630] Subtest x-tiled-8bpp-rotate-270: SKIP (0.024s) [477.179397] [085/131] (544s left) kms_psr (psr2-sprite-mmap-gtt) [477.272369] Starting subtest: psr2-sprite-mmap-gtt [477.274587] Starting dynamic subtest: eDP-1 [478.743707] Dynamic subtest eDP-1: SKIP (1.467s) [478.748285] Subtest psr2-sprite-mmap-gtt: SKIP (1.469s) [478.965958] [086/131] (543s left) kms_cursor_legacy (cursora-vs-flipb-legacy) [479.097329] Starting subtest: cursorA-vs-flipB-legacy [479.101868] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s) [479.266071] [087/131] (542s left) kms_ccs (bad-aux-stride-yf-tiled-ccs) [479.364538] Starting subtest: bad-aux-stride-yf-tiled-ccs [479.366852] Starting dynamic subtest: pipe-A-eDP-1 [479.389479] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [479.401320] Starting dynamic subtest: pipe-B-eDP-1 [479.422389] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [479.431351] Starting dynamic subtest: pipe-C-eDP-1 [479.453040] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [479.462187] Starting dynamic subtest: pipe-D-eDP-1 [479.485510] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [479.490146] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.005s) [481.562001] [088/131] (540s left) kms_cursor_crc (cursor-random-512x512) [481.826401] Starting subtest: cursor-random-512x512 [481.830790] Subtest cursor-random-512x512: SKIP (0.001s) [482.019131] [089/131] (540s left) kms_frontbuffer_tracking (fbc-suspend) [482.119667] Starting subtest: fbc-suspend [520.572850] Subtest fbc-suspend: SUCCESS (7.544s) [521.766096] [090/131] (500s left) kms_big_fb (yf-tiled-8bpp-rotate-0) [521.879241] Starting subtest: yf-tiled-8bpp-rotate-0 [521.884399] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s) [522.022117] [091/131] (500s left) gem_exec_fence (syncobj-timeline-invalid-flags) [522.584747] Starting subtest: syncobj-timeline-invalid-flags [522.587133] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [524.281143] [092/131] (498s left) gem_userptr_blits (huge-split) [524.365424] Starting subtest: huge-split [524.374303] Subtest huge-split: SUCCESS (0.009s) [524.548683] [093/131] (497s left) syncobj_wait (invalid-signal-bad-pad) [524.616163] Starting subtest: invalid-signal-bad-pad [524.618876] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [524.755947] [094/131] (497s left) gem_ctx_shared (exec-shared-gtt) [524.832497] Starting subtest: exec-shared-gtt [524.835293] Starting dynamic subtest: rcs0 [524.844452] Dynamic subtest rcs0: SUCCESS (0.012s) [524.855159] Starting dynamic subtest: bcs0 [524.857612] Dynamic subtest bcs0: SUCCESS (0.010s) [524.866284] Starting dynamic subtest: vcs0 [524.868945] Dynamic subtest vcs0: SUCCESS (0.011s) [524.878284] Starting dynamic subtest: vcs1 [524.880970] Dynamic subtest vcs1: SUCCESS (0.011s) [524.890520] Starting dynamic subtest: vecs0 [524.892904] Dynamic subtest vecs0: SUCCESS (0.007s) [524.902508] Starting dynamic subtest: ccs0 [524.905450] Dynamic subtest ccs0: SUCCESS (0.011s) [524.908092] Subtest exec-shared-gtt: SUCCESS (0.068s) [525.117885] [095/131] (497s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [525.223545] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [525.862075] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.648s) [526.058919] [096/131] (496s left) kms_vblank (query-forked) [526.152352] Starting subtest: query-forked [526.155104] Starting dynamic subtest: pipe-A-eDP-1 [527.947347] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.812s) [527.962933] Starting dynamic subtest: pipe-D-eDP-1 [530.453302] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.525s) [530.455994] Subtest query-forked: SUCCESS (4.340s) [531.304774] [097/131] (491s left) gem_media_vme [531.436282] [098/131] (491s left) gem_pxp (create-regular-context-2) [531.548543] Starting subtest: create-regular-context-2 [531.551625] Subtest create-regular-context-2: SUCCESS (0.001s) [531.679521] [099/131] (490s left) kms_dsc (dsc-with-bpc) [531.782332] Starting subtest: dsc-with-bpc [531.818052] Subtest dsc-with-bpc: SKIP (0.001s) [531.877622] [100/131] (490s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [531.999402] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [532.004385] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [532.136903] [101/131] (490s left) gem_mmap_wc (close) [532.194376] Subtest close: SKIP (0.000s) [532.255261] [102/131] (490s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [532.361293] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [532.365360] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [532.501388] [103/131] (490s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [532.623008] Starting subtest: cursorB-vs-flipB-atomic-transitions [532.627442] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s) [532.790839] [104/131] (490s left) gem_exec_nop (basic-series) [532.865535] Starting subtest: basic-series [549.161250] Subtest basic-series: SUCCESS (16.337s) [549.418146] [105/131] (473s left) gen9_exec_parse (basic-rejected-ctx-param) [549.484345] Subtest basic-rejected-ctx-param: SKIP (0.000s) [549.578103] [106/131] (473s left) syncobj_wait (single-wait-for-submit-signaled) [549.638152] Starting subtest: single-wait-for-submit-signaled [549.640858] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s) [549.771228] [107/131] (473s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [549.873907] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu [556.944532] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.068s) [557.080127] [108/131] (465s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc) [557.184425] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc [557.189607] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [557.314985] [109/131] (465s left) gem_ctx_engines (none) [557.376272] Starting subtest: none [557.379044] Subtest none: SUCCESS (0.001s) [557.590211] [110/131] (465s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions) [557.706630] Starting subtest: cursorA-vs-flipB-atomic-transitions [557.712391] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s) [557.871857] [111/131] (465s left) kms_flip (flip-vs-suspend) [557.977342] Starting subtest: flip-vs-suspend [557.979642] Starting dynamic subtest: A-eDP1 [607.203655] Dynamic subtest A-eDP1: SUCCESS (4.589s) [607.219600] Starting dynamic subtest: B-eDP1 [656.193850] Dynamic subtest B-eDP1: SUCCESS (4.489s) [656.203843] Starting dynamic subtest: C-eDP1 [705.210442] Dynamic subtest C-eDP1: SUCCESS (4.556s) [705.227508] Starting dynamic subtest: D-eDP1 [754.185198] Dynamic subtest D-eDP1: SUCCESS (4.544s) [754.191010] Subtest flip-vs-suspend: SUCCESS (18.188s) [755.451936] [112/131] (267s left) syncobj_wait (wait-all-for-submit-complex) [755.524861] Starting subtest: wait-all-for-submit-complex [755.740719] Subtest wait-all-for-submit-complex: SUCCESS (0.220s) [755.841247] [113/131] (267s left) syncobj_timeline (single-wait-signaled) [755.902449] Starting subtest: single-wait-signaled [755.905279] Subtest single-wait-signaled: SUCCESS (0.000s) [756.039536] [114/131] (267s left) gem_flink_basic (flink-lifetime) [756.100184] Starting subtest: flink-lifetime [756.102906] Subtest flink-lifetime: SUCCESS (0.003s) [756.231764] [115/131] (267s left) perf_pmu (render-node-busy-idle) [756.312955] Starting subtest: render-node-busy-idle [756.315597] Starting dynamic subtest: rcs0 [757.013768] Dynamic subtest rcs0: SUCCESS (0.716s) [757.026765] Starting dynamic subtest: bcs0 [757.716740] Dynamic subtest bcs0: FAIL (0.644s) [757.726981] Starting dynamic subtest: vcs0 [758.372745] Dynamic subtest vcs0: FAIL (0.662s) [758.383272] Starting dynamic subtest: vcs1 [759.960952] Dynamic subtest vcs1: FAIL (1.612s) [759.970995] Starting dynamic subtest: vecs0 [762.006251] Dynamic subtest vecs0: FAIL (2.071s) [762.016382] Starting dynamic subtest: ccs0 [763.987084] Dynamic subtest ccs0: FAIL (2.005s) [763.989748] Subtest render-node-busy-idle: FAIL (7.715s) [764.029366] [116/131] (259s left) gem_ctx_persistence (userptr) [764.097165] Starting subtest: userptr [764.332704] Subtest userptr: SUCCESS (0.237s) [764.436942] [117/131] (258s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [764.540812] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [771.834027] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.335s) [772.002449] [118/131] (251s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [777.040429] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf [777.043279] Starting dynamic subtest: pipe-A-eDP-1 [777.831190] Dynamic subtest pipe-A-eDP-1: SKIP (0.787s) [777.842279] Starting dynamic subtest: pipe-B-eDP-1 [778.958176] Dynamic subtest pipe-B-eDP-1: SKIP (1.127s) [778.962860] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.919s) [780.161749] [119/131] (243s left) kms_psr (fbc-psr2-sprite-mmap-cpu) [780.266291] Starting subtest: fbc-psr2-sprite-mmap-cpu [780.268644] Starting dynamic subtest: eDP-1 [780.273240] Dynamic subtest eDP-1: SKIP (0.000s) [780.278068] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s) [780.372733] [120/131] (243s left) i915_pm_rpm (debugfs-forcewake-user) [782.506240] Starting subtest: debugfs-forcewake-user [793.918052] Subtest debugfs-forcewake-user: SUCCESS (11.413s) [794.338922] [121/131] (229s left) kms_properties (crtc-properties-atomic) [794.436343] Starting subtest: crtc-properties-atomic [794.439234] Starting dynamic subtest: pipe-A-eDP-1 [794.871482] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.435s) [794.882448] Starting dynamic subtest: pipe-B-eDP-1 [796.056282] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.185s) [796.067584] Starting dynamic subtest: pipe-C-eDP-1 [797.179655] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.122s) [797.190059] Starting dynamic subtest: pipe-D-eDP-1 [798.312285] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s) [798.315255] Subtest crtc-properties-atomic: SUCCESS (3.876s) [799.152091] [122/131] (224s left) kms_async_flips (async-flip-suspend-resume) [799.263390] Starting subtest: async-flip-suspend-resume [799.639027] Starting dynamic subtest: pipe-A-eDP-1 [818.414255] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.109s) [818.784696] Starting dynamic subtest: pipe-B-eDP-1 [837.192520] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.968s) [837.556656] Starting dynamic subtest: pipe-C-eDP-1 [855.200914] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.956s) [855.573947] Starting dynamic subtest: pipe-D-eDP-1 [873.200849] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.944s) [873.203139] Subtest async-flip-suspend-resume: SUCCESS (13.455s) [874.393033] [123/131] (149s left) kms_flip (2x-flip-vs-panning) [874.502156] Starting subtest: 2x-flip-vs-panning [874.511275] Subtest 2x-flip-vs-panning: SKIP (0.011s) [874.612411] [124/131] (149s left) kms_lease (lease-uevent) [874.709465] Starting subtest: lease-uevent [875.727600] Subtest lease-uevent: SUCCESS (1.026s) [875.862345] [125/131] (147s left) kms_psr (fbc-psr2-basic) [875.956127] Starting subtest: fbc-psr2-basic [875.958401] Starting dynamic subtest: eDP-1 [875.962622] Dynamic subtest eDP-1: SKIP (0.000s) [875.966969] Subtest fbc-psr2-basic: SKIP (0.001s) [876.055540] [126/131] (147s left) gem_ctx_persistence (engines-hostile) [876.113287] Starting subtest: engines-hostile [876.115431] Starting dynamic subtest: rcs0 [876.277214] Dynamic subtest rcs0: SUCCESS (0.166s) [876.289553] Starting dynamic subtest: bcs0 [876.386431] Dynamic subtest bcs0: SUCCESS (0.108s) [876.398173] Starting dynamic subtest: vcs0 [876.511060] Dynamic subtest vcs0: SUCCESS (0.124s) [876.523328] Starting dynamic subtest: vcs1 [876.630055] Dynamic subtest vcs1: SUCCESS (0.118s) [876.642062] Starting dynamic subtest: vecs0 [876.750116] Dynamic subtest vecs0: SUCCESS (0.119s) [876.763485] Starting dynamic subtest: ccs0 [876.860488] Dynamic subtest ccs0: SUCCESS (0.109s) [876.862665] Subtest engines-hostile: SUCCESS (0.757s) [876.963648] [127/131] (146s left) kms_dp_link_training (non-uhbr-sst) [877.061744] Starting subtest: non-uhbr-sst [877.069046] Subtest non-uhbr-sst: SKIP (0.000s) [877.158347] [128/131] (146s left) kms_flip_tiling (flip-change-tiling) [877.248253] Starting subtest: flip-change-tiling [877.250079] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs [877.444256] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.198s) [877.456876] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs [877.578749] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s) [877.591017] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [877.722154] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s) [877.734592] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4 [877.864531] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s) [877.876823] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x [878.007259] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s) [878.019552] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear [878.151021] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s) [878.162174] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs [878.283642] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s) [878.296001] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs [878.394158] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s) [878.411386] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [878.539108] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s) [878.552399] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4 [878.681487] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s) [878.694162] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x [878.824268] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s) [878.838072] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear [878.967964] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s) [878.980763] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [879.101493] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s) [879.113954] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [879.244399] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.142s) [879.255461] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [879.354976] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s) [879.366747] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4 [879.498547] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s) [879.511049] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x [879.642138] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s) [879.654563] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear [879.785536] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s) [879.800310] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs [879.929379] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s) [879.941137] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs [880.075190] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s) [880.086028] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc [880.218718] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s) [880.231743] Starting dynamic subtest: pipe-A-eDP-1-4-to-4 [880.339083] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s) [880.350751] Starting dynamic subtest: pipe-A-eDP-1-4-to-x [880.493323] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.153s) [880.505940] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear [880.637268] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s) [880.649931] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs [880.781187] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s) [880.794013] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs [880.924831] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s) [880.937097] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc [881.068302] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s) [881.081137] Starting dynamic subtest: pipe-A-eDP-1-x-to-4 [881.212130] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s) [881.224265] Starting dynamic subtest: pipe-A-eDP-1-x-to-x [881.333817] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s) [881.345893] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear [881.477928] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.142s) [881.490250] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs [881.621358] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s) [881.635757] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs [881.765270] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s) [881.779912] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc [881.909857] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s) [881.922545] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4 [882.052842] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s) [882.068053] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x [882.197260] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s) [882.209577] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear [882.318780] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.120s) [882.371295] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs [883.583643] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.223s) [883.596161] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs [883.717974] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.130s) [883.730263] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [883.850522] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [883.862500] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4 [883.993275] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s) [884.004395] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x [884.136728] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s) [884.151798] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear [884.280747] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s) [884.293060] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs [884.414710] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s) [884.427492] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs [884.525098] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s) [884.537334] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [884.670253] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s) [884.682703] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4 [884.802122] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.131s) [884.818039] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x [884.946094] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.141s) [884.958295] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear [885.089542] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s) [885.101593] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [885.223063] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s) [885.235702] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [885.357325] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s) [885.368742] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [885.478022] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.120s) [885.490232] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4 [885.622297] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s) [885.634897] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x [885.754690] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.131s) [885.765516] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear [885.898715] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s) [885.910017] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs [886.043258] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s) [886.056335] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs [886.187406] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s) [886.200109] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc [886.331609] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s) [886.344657] Starting dynamic subtest: pipe-B-eDP-1-4-to-4 [886.452810] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s) [886.463841] Starting dynamic subtest: pipe-B-eDP-1-4-to-x [886.596266] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.142s) [886.610881] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear [886.740581] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s) [886.755785] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs [886.884841] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s) [886.897842] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs [887.028857] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s) [887.043176] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc [887.172964] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s) [887.187851] Starting dynamic subtest: pipe-B-eDP-1-x-to-4 [887.316908] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s) [887.331722] Starting dynamic subtest: pipe-B-eDP-1-x-to-x [887.439067] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s) [887.451669] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear [887.583970] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s) [887.596809] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs [887.727524] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s) [887.742172] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs [887.871427] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s) [887.883529] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc [888.015423] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s) [888.030120] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4 [888.159755] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s) [888.174043] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x [888.315456] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.153s) [888.328740] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear [888.437167] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s) [888.491262] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs [889.702431] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.220s) [889.715316] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs [889.802042] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [889.815735] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [889.913044] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.108s) [889.927247] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4 [890.024044] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.108s) [890.035324] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x [890.134384] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s) [890.144891] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear [890.245187] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s) [890.259836] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs [890.356888] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.110s) [890.372239] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs [890.467863] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s) [890.481031] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [890.567748] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s) [890.580321] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4 [890.678132] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s) [890.695931] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x [890.788330] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s) [890.800448] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear [890.910620] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.121s) [890.925441] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [891.021934] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.109s) [891.034224] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [891.121962] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s) [891.134407] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [891.221655] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s) [891.233531] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4 [891.332260] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s) [891.345069] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x [891.443235] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s) [891.455745] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear [891.553698] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s) [891.565761] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs [891.665088] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s) [891.678549] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs [891.776182] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s) [891.788706] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc [891.887173] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s) [891.903175] Starting dynamic subtest: pipe-C-eDP-1-4-to-4 [891.997868] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s) [892.015687] Starting dynamic subtest: pipe-C-eDP-1-4-to-x [892.119912] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.120s) [892.132286] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear [892.230817] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.109s) [892.242322] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs [892.330744] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.098s) [892.341680] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs [892.430241] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.098s) [892.441565] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc [892.541337] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s) [892.554296] Starting dynamic subtest: pipe-C-eDP-1-x-to-4 [892.663530] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.119s) [892.675142] Starting dynamic subtest: pipe-C-eDP-1-x-to-x [892.774319] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.110s) [892.788877] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear [892.885619] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s) [892.898160] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs [892.996160] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s) [893.006254] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs [893.096000] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.098s) [893.107183] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc [893.207158] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s) [893.216870] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4 [893.317972] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.109s) [893.329713] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x [893.429904] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.109s) [893.442932] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear [893.540801] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s) [893.583673] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs [894.826065] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.251s) [894.839125] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs [894.925641] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [894.938333] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [895.025849] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s) [895.038580] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4 [895.176372] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.148s) [895.189318] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x [895.285760] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s) [895.298141] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear [895.396376] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s) [895.408310] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs [895.508287] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.109s) [895.518996] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs [895.619176] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s) [895.630948] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [895.730585] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.109s) [895.743158] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4 [895.841400] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s) [895.854134] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x [895.951697] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s) [895.963951] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear [896.062564] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s) [896.075272] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [896.162298] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s) [896.176483] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [896.262177] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.099s) [896.274119] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [896.373252] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s) [896.385280] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4 [896.484532] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s) [896.495549] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x [896.633530] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.147s) [896.645476] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear [896.744448] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s) [896.757796] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs [896.866901] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.121s) [896.879731] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs [896.978123] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s) [896.991060] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc [897.078112] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.098s) [897.090834] Starting dynamic subtest: pipe-D-eDP-1-4-to-4 [897.188890] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s) [897.201325] Starting dynamic subtest: pipe-D-eDP-1-4-to-x [897.299443] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s) [897.313401] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear [897.410258] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.109s) [897.424476] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs [897.521411] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s) [897.533365] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs [897.632312] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s) [897.644365] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc [897.743369] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s) [897.760641] Starting dynamic subtest: pipe-D-eDP-1-x-to-4 [897.855901] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s) [897.872160] Starting dynamic subtest: pipe-D-eDP-1-x-to-x [897.977567] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.121s) [897.990740] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear [898.087966] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s) [898.105480] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs [898.198425] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.110s) [898.210375] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs [898.310540] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s) [898.322588] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc [898.421031] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s) [898.432935] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4 [898.531486] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.110s) [898.546040] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x [898.643117] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.109s) [898.656956] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear [898.754035] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.108s) [898.786992] Subtest flip-change-tiling: SUCCESS (21.598s) [900.034527] [129/131] (123s left) kms_big_fb (y-tiled-16bpp-rotate-90) [900.141654] Starting subtest: y-tiled-16bpp-rotate-90 [900.146012] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s) [900.284078] [130/131] (123s left) kms_psr (psr2-primary-page-flip) [900.386744] Starting subtest: psr2-primary-page-flip [900.388979] Starting dynamic subtest: eDP-1 [902.099739] Dynamic subtest eDP-1: SUCCESS (1.723s) [902.102096] Subtest psr2-primary-page-flip: SUCCESS (1.724s) [903.002381] [131/131] (120s left) syncobj_wait (single-wait-all-for-submit-unsubmitted) [903.066948] Starting subtest: single-wait-all-for-submit-unsubmitted [903.171294] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s) [903.268563] Closing watchdogs results: parsing output: 0/ for test: gem_exec_reloc results: parsing output: 1/ for test: sw_sync results: parsing output: 2/ for test: kms_plane_scaling results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: gem_tiled_pread_basic results: parsing output: 5/ for test: gem_exec_fence results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: kms_ccs results: parsing output: 8/ for test: gem_render_copy_redux results: parsing output: 9/ for test: gem_exec_whisper results: parsing output: 10/ for test: gem_mmap_wc results: parsing output: 11/ for test: kms_cursor_crc results: parsing output: 12/ for test: gem_sync results: parsing output: 13/ for test: kms_ccs results: parsing output: 14/ for test: kms_big_fb results: parsing output: 15/ for test: perf results: parsing output: 16/ for test: gem_mmap_offset results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: perf_pmu results: parsing output: 19/ for test: gem_fence_thrash results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_cursor_crc results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_pipe_b_c_ivb results: parsing output: 24/ for test: gem_exec_schedule results: parsing output: 25/ for test: perf results: parsing output: 26/ for test: kms_pm_rpm results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_chamelium_audio results: parsing output: 29/ for test: gem_eio results: parsing output: 30/ for test: gem_exec_schedule results: parsing output: 31/ for test: gem_render_copy results: parsing output: 32/ for test: kms_color_pipeline results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_async_flips results: parsing output: 35/ for test: syncobj_timeline results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: gem_exec_params results: parsing output: 38/ for test: kms_addfb_basic results: parsing output: 39/ for test: i915_drm_fdinfo results: parsing output: 40/ for test: gem_pxp results: parsing output: 41/ for test: gem_readwrite results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_chamelium_frames results: parsing output: 44/ for test: api_intel_allocator results: parsing output: 45/ for test: gem_busy results: parsing output: 46/ for test: kms_prop_blob results: parsing output: 47/ for test: kms_flip results: parsing output: 48/ for test: syncobj_timeline results: parsing output: 49/ for test: syncobj_timeline results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: kms_cursor_crc results: parsing output: 52/ for test: gem_mmap_gtt results: parsing output: 53/ for test: prime_vgem results: parsing output: 54/ for test: kms_cursor_crc results: parsing output: 55/ for test: kms_pipe_crc_basic results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: gem_exec_params results: parsing output: 58/ for test: kms_plane_scaling results: parsing output: 59/ for test: kms_psr results: parsing output: 60/ for test: i915_query results: parsing output: 61/ for test: gem_exec_fence results: parsing output: 62/ for test: kms_invalid_mode results: parsing output: 63/ for test: kms_selftest results: parsing output: 64/ for test: kms_plane results: parsing output: 65/ for test: i915_drm_fdinfo results: parsing output: 66/ for test: syncobj_timeline results: parsing output: 67/ for test: gem_fenced_exec_thrash results: parsing output: 68/ for test: api_intel_bb results: parsing output: 69/ for test: kms_ccs results: parsing output: 70/ for test: kms_ccs results: parsing output: 71/ for test: gem_softpin results: parsing output: 72/ for test: kms_chamelium_hpd results: parsing output: 73/ for test: kms_cursor_legacy results: parsing output: 74/ for test: core_sysfs results: parsing output: 75/ for test: kms_big_fb results: parsing output: 76/ for test: gem_exec_suspend results: parsing output: 77/ for test: kms_flip results: parsing output: 78/ for test: kms_flip_scaled_crc results: parsing output: 79/ for test: gem_exec_balancer results: parsing output: 80/ for test: kms_vblank results: parsing output: 81/ for test: syncobj_basic results: parsing output: 82/ for test: kms_psr2_sf results: parsing output: 83/ for test: kms_big_fb results: parsing output: 84/ for test: kms_psr results: parsing output: 85/ for test: kms_cursor_legacy results: parsing output: 86/ for test: kms_ccs results: parsing output: 87/ for test: kms_cursor_crc results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_big_fb results: parsing output: 90/ for test: gem_exec_fence results: parsing output: 91/ for test: gem_userptr_blits results: parsing output: 92/ for test: syncobj_wait results: parsing output: 93/ for test: gem_ctx_shared results: parsing output: 94/ for test: kms_big_fb results: parsing output: 95/ for test: kms_vblank results: parsing output: 96/ for test: gem_media_vme results: parsing output: 97/ for test: gem_pxp results: parsing output: 98/ for test: kms_dsc results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: gem_mmap_wc results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_cursor_legacy results: parsing output: 103/ for test: gem_exec_nop results: parsing output: 104/ for test: gen9_exec_parse results: parsing output: 105/ for test: syncobj_wait results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: gem_ctx_engines results: parsing output: 109/ for test: kms_cursor_legacy results: parsing output: 110/ for test: kms_flip results: parsing output: 111/ for test: syncobj_wait results: parsing output: 112/ for test: syncobj_timeline results: parsing output: 113/ for test: gem_flink_basic results: parsing output: 114/ for test: perf_pmu results: parsing output: 115/ for test: gem_ctx_persistence results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_psr2_sf results: parsing output: 118/ for test: kms_psr results: parsing output: 119/ for test: i915_pm_rpm results: parsing output: 120/ for test: kms_properties results: parsing output: 121/ for test: kms_async_flips results: parsing output: 122/ for test: kms_flip results: parsing output: 123/ for test: kms_lease results: parsing output: 124/ for test: kms_psr results: parsing output: 125/ for test: gem_ctx_persistence results: parsing output: 126/ for test: kms_dp_link_training results: parsing output: 127/ for test: kms_flip_tiling results: parsing output: 128/ for test: kms_big_fb results: parsing output: 129/ for test: kms_psr results: parsing output: 130/ for test: syncobj_wait Done.