[58.843570] Initializing watchdogs
[58.843659]   /dev/watchdog0
[58.857179] [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.861563] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.863647] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.866900] [001/131] (960s left) gem_exec_fence (submit3)
[59.116714] Starting subtest: submit3
[59.121805] Subtest submit3: SKIP (0.000s)
[61.013125] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true
[61.016326] [002/131] (958s left) syncobj_wait (wait-delayed-signal)
[61.066914] Starting subtest: wait-delayed-signal
[61.169099] Subtest wait-delayed-signal: SUCCESS (0.103s)
[61.242233] [003/131] (958s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[61.358683] Starting subtest: psr-rgb565-draw-blt
[66.202817] Subtest psr-rgb565-draw-blt: SUCCESS (4.847s)
[66.331045] [004/131] (953s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[66.391742] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[66.393993] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[66.481205] [005/131] (953s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[66.541892] Starting subtest: etime-multi-wait-available-unsubmitted
[66.643890] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.103s)
[66.710101] [006/131] (952s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[66.837092] Starting subtest: cursorB-vs-flipA-atomic
[66.841604] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[66.964290] [007/131] (952s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[67.060021] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[67.062327] Starting dynamic subtest: pipe-A-default-mode
[67.349058] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[67.353671] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.285s)
[68.208747] [008/131] (951s left) perf_pmu (semaphore-busy)
[68.248667] Starting subtest: semaphore-busy
[68.250894] Starting dynamic subtest: rcs0
[69.905313] Dynamic subtest rcs0: SUCCESS (1.655s)
[69.913385] Starting dynamic subtest: bcs0
[71.533628] Dynamic subtest bcs0: SUCCESS (1.627s)
[71.543359] Starting dynamic subtest: vcs0
[75.430239] Dynamic subtest vcs0: SUCCESS (3.897s)
[75.439562] Starting dynamic subtest: vcs1
[81.444034] Dynamic subtest vcs1: SUCCESS (6.013s)
[81.453214] Starting dynamic subtest: vecs0
[87.459290] Dynamic subtest vecs0: SUCCESS (6.016s)
[87.468172] Starting dynamic subtest: ccs0
[90.532350] Dynamic subtest ccs0: SUCCESS (3.071s)
[90.534929] Subtest semaphore-busy: SUCCESS (22.281s)
[90.639536] [009/131] (928s left) gem_wait (invalid-buf)
[90.709968] Starting subtest: invalid-buf
[90.712700] Subtest invalid-buf: SUCCESS (0.000s)
[90.913681] [010/131] (928s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[90.970031] Starting subtest: multi-wait-all-for-submit-available-submitted
[90.972516] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[91.081417] [011/131] (928s left) kms_3d
[93.459476] [012/131] (926s left) gem_exec_create (basic)
[93.531906] Starting subtest: basic
[93.534156] Starting dynamic subtest: smem
[96.877052] Dynamic subtest smem: SUCCESS (3.343s)
[96.879979] Subtest basic: SUCCESS (3.344s)
[97.053323] [013/131] (922s left) gem_ccs (ctrl-surf-copy)
[97.111407] Starting subtest: ctrl-surf-copy
[97.115607] Subtest ctrl-surf-copy: SKIP (0.000s)
[97.221320] [014/131] (922s left) kms_plane_cursor (overlay)
[97.322910] Starting subtest: overlay
[97.327418] Starting dynamic subtest: pipe-A-eDP-1-size-64
[100.252065] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.928s)
[100.311557] Starting dynamic subtest: pipe-A-eDP-1-size-128
[103.164442] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.859s)
[103.223288] Starting dynamic subtest: pipe-A-eDP-1-size-256
[106.109659] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.892s)
[106.456121] Starting dynamic subtest: pipe-B-eDP-1-size-64
[109.984962] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.539s)
[110.043604] Starting dynamic subtest: pipe-B-eDP-1-size-128
[112.875080] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.837s)
[112.933611] Starting dynamic subtest: pipe-B-eDP-1-size-256
[115.753115] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.826s)
[116.100603] Starting dynamic subtest: pipe-C-eDP-1-size-64
[119.322120] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.231s)
[119.358012] Starting dynamic subtest: pipe-C-eDP-1-size-128
[121.855405] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.503s)
[121.891996] Starting dynamic subtest: pipe-C-eDP-1-size-256
[124.401571] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.513s)
[124.728570] Starting dynamic subtest: pipe-D-eDP-1-size-64
[127.869230] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.151s)
[127.906383] Starting dynamic subtest: pipe-D-eDP-1-size-128
[130.336873] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.435s)
[130.379119] Starting dynamic subtest: pipe-D-eDP-1-size-256
[132.792251] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.423s)
[133.118823] Subtest overlay: SUCCESS (35.795s)
[133.930466] [015/131] (885s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[134.033756] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[136.741290] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.712s)
[136.894830] [016/131] (882s left) kms_content_protection (lic-type-0)
[137.053243] Starting subtest: lic-type-0
[140.386866] Subtest lic-type-0: SKIP (3.332s)
[141.631326] [017/131] (878s left) gem_lmem_swapping (verify-ccs)
[141.676575] Subtest verify-ccs: SKIP (0.000s)
[141.719498] [018/131] (878s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[146.798257] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[146.800690] Starting dynamic subtest: pipe-A-eDP-1
[147.581552] Dynamic subtest pipe-A-eDP-1: SKIP (0.780s)
[147.589143] Starting dynamic subtest: pipe-B-eDP-1
[148.680540] Dynamic subtest pipe-B-eDP-1: SKIP (1.096s)
[148.685141] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.880s)
[149.930391] [019/131] (870s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[150.034768] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[150.037064] Starting dynamic subtest: pipe-A-eDP-1
[150.084452] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.049s)
[150.093293] Starting dynamic subtest: pipe-B-eDP-1
[150.132230] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.047s)
[150.139672] Starting dynamic subtest: pipe-C-eDP-1
[150.181669] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.048s)
[150.189126] Starting dynamic subtest: pipe-D-eDP-1
[150.230969] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.048s)
[150.233278] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.196s)
[152.432931] [020/131] (867s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[152.536618] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[157.664048] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (5.130s)
[157.816782] [021/131] (862s left) gem_ctx_param (set-priority-range)
[157.879566] Starting subtest: set-priority-range
[157.900036] Subtest set-priority-range: SUCCESS (0.020s)
[158.015396] [022/131] (862s left) perf (buffer-fill)
[158.123288] Starting subtest: buffer-fill
[158.125470] Starting dynamic subtest: 0-rcs0
[160.392318] Dynamic subtest 0-rcs0: SUCCESS (2.269s)
[160.400440] Starting dynamic subtest: 1-vcs0
[164.846365] Dynamic subtest 1-vcs0: SUCCESS (4.452s)
[164.848878] Subtest buffer-fill: SUCCESS (6.723s)
[164.890392] [023/131] (855s left) gen9_exec_parse (batch-invalid-length)
[164.947099] Subtest batch-invalid-length: SKIP (0.000s)
[165.010898] [024/131] (855s left) gem_mmap_gtt (fault-concurrent)
[165.073058] Subtest fault-concurrent: SKIP (0.000s)
[165.128396] [025/131] (855s left) perf_pmu (busy-idle-check-all)
[165.166355] Starting subtest: busy-idle-check-all
[165.168428] Starting dynamic subtest: rcs0
[165.832651] Dynamic subtest rcs0: SUCCESS (0.666s)
[165.840720] Starting dynamic subtest: bcs0
[166.487204] Dynamic subtest bcs0: SUCCESS (0.655s)
[166.497836] Starting dynamic subtest: vcs0
[167.914427] Dynamic subtest vcs0: SUCCESS (1.423s)
[167.925093] Starting dynamic subtest: vcs1
[169.898850] Dynamic subtest vcs1: SUCCESS (1.981s)
[169.910608] Starting dynamic subtest: vecs0
[171.945825] Dynamic subtest vecs0: SUCCESS (2.045s)
[171.956367] Starting dynamic subtest: ccs0
[172.603513] Dynamic subtest ccs0: SUCCESS (0.657s)
[172.606575] Subtest busy-idle-check-all: SUCCESS (7.440s)
[172.694630] [026/131] (847s left) kms_prime (basic-crc-hybrid)
[174.906293] Subtest basic-crc-hybrid: SKIP (0.000s)
[174.984328] [FACT kms_prime (basic-crc-hybrid)] new: kernel.kmod_is_loaded.amdgpu: true
[174.985080] [FACT kms_prime (basic-crc-hybrid)] new: kernel.kmod_is_loaded.xe: true
[174.990094] [027/131] (845s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[175.052326] Starting subtest: y-tiled-to-vebox-yf-tiled
[175.056966] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[175.228119] [028/131] (845s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[175.335098] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[175.337328] Starting dynamic subtest: pipe-A-eDP-1
[175.362040] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[175.371625] Starting dynamic subtest: pipe-B-eDP-1
[175.393568] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[175.401251] Starting dynamic subtest: pipe-C-eDP-1
[175.423167] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[175.430723] Starting dynamic subtest: pipe-D-eDP-1
[175.453780] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[175.458386] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[177.527387] [029/131] (842s left) syncobj_timeline (reset-multiple-signaled)
[177.592487] Starting subtest: reset-multiple-signaled
[177.594791] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[177.701429] [030/131] (842s left) gem_mmap_gtt (big-copy)
[177.766181] Subtest big-copy: SKIP (0.000s)
[177.831449] [031/131] (842s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[177.932590] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[182.459975] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (4.531s)
[182.566411] [032/131] (837s left) gem_exec_reloc (basic-cpu-gtt-active)
[182.641893] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[182.708716] [033/131] (837s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[182.814407] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[182.818882] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[182.909385] [034/131] (837s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[183.017337] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[183.019628] Starting dynamic subtest: pipe-A-default-mode
[183.308246] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[183.312988] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.288s)
[184.127289] [035/131] (836s left) kms_legacy_colorkey (basic)
[184.229443] Starting subtest: basic
[184.231773] Starting dynamic subtest: pipe-A
[184.274712] Dynamic subtest pipe-A: SUCCESS (0.045s)
[184.284854] Starting dynamic subtest: pipe-B
[184.287183] Dynamic subtest pipe-B: SUCCESS (0.000s)
[184.294055] Starting dynamic subtest: pipe-C
[184.296062] Dynamic subtest pipe-C: SUCCESS (0.000s)
[184.303216] Starting dynamic subtest: pipe-D
[184.305409] Dynamic subtest pipe-D: SUCCESS (0.000s)
[184.307634] Subtest basic: SUCCESS (0.050s)
[184.337706] [036/131] (836s left) gem_render_tiled_blits (basic)
[184.404633] Subtest basic: SKIP (0.000s)
[184.490634] [037/131] (836s left) gem_exec_params (cliprects-invalid)
[184.546547] Starting subtest: cliprects-invalid
[184.548852] Subtest cliprects-invalid: SUCCESS (0.000s)
[184.652165] [038/131] (835s left) kms_addfb_basic (addfb25-bad-modifier)
[184.756391] Starting subtest: addfb25-bad-modifier
[184.758623] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[184.857192] [039/131] (835s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[184.967347] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[188.028688] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (3.065s)
[188.194765] [040/131] (832s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[188.292806] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[188.295097] Starting dynamic subtest: pipe-A-eDP-1
[188.317522] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[188.327294] Starting dynamic subtest: pipe-B-eDP-1
[188.348314] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[188.357402] Starting dynamic subtest: pipe-C-eDP-1
[188.378495] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[188.385644] Starting dynamic subtest: pipe-D-eDP-1
[188.406700] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[188.410900] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[190.525085] [041/131] (830s left) kms_big_fb (linear-64bpp-rotate-0)
[190.623831] Starting subtest: linear-64bpp-rotate-0
[192.957249] Subtest linear-64bpp-rotate-0: SUCCESS (2.333s)
[193.175266] [042/131] (827s left) kms_feature_discovery (psr2)
[193.286254] Starting subtest: psr2
[193.288211] Subtest psr2: SUCCESS (0.000s)
[193.351302] [043/131] (827s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[193.447787] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[193.452223] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[193.547307] [044/131] (827s left) kms_vblank (ts-continuation-suspend)
[193.641843] Starting subtest: ts-continuation-suspend
[193.644218] Starting dynamic subtest: pipe-A-eDP-1
[210.082622] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.586s)
[210.098117] Starting dynamic subtest: pipe-D-eDP-1
[226.995815] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.167s)
[226.998265] Subtest ts-continuation-suspend: SUCCESS (3.757s)
[227.825785] [045/131] (822s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[227.926855] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[227.931401] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[228.018631] [046/131] (822s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[228.138178] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[228.142507] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[228.267725] [047/131] (822s left) prime_vgem (basic-blt)
[228.341565] Starting subtest: basic-blt
[228.370869] Subtest basic-blt: SUCCESS (0.029s)
[228.512995] [048/131] (822s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[228.614415] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[228.618867] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[228.719137] [049/131] (821s left) gem_exec_balancer (bonded-dual)
[228.777152] Starting subtest: bonded-dual
[228.780917] Subtest bonded-dual: SKIP (0.000s)
[229.060434] [050/131] (821s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[229.162653] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[233.705341] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (4.545s)
[233.847717] [051/131] (816s left) kms_psr (fbc-pr-sprite-blt)
[233.952908] Starting subtest: fbc-pr-sprite-blt
[233.957012] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[234.016937] [052/131] (816s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[234.128274] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[234.132188] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[234.221891] [053/131] (816s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[234.319112] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[238.881522] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (4.564s)
[239.036480] [054/131] (811s left) gem_ctx_engines (invalid-engines)
[239.107399] Starting subtest: invalid-engines
[239.118448] Subtest invalid-engines: SUCCESS (0.010s)
[239.372749] [055/131] (811s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[239.478203] Starting subtest: drrs-dirtyfb-ioctl
[239.491741] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[239.580599] [056/131] (811s left) kms_cursor_crc (cursor-sliding-64x64)
[239.734429] Starting subtest: cursor-sliding-64x64
[239.739444] Starting dynamic subtest: pipe-A-eDP-1
[243.255749] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.516s)
[243.280273] Starting dynamic subtest: pipe-D-eDP-1
[247.620707] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.348s)
[247.623318] Subtest cursor-sliding-64x64: SUCCESS (7.885s)
[248.422612] [057/131] (802s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[248.526748] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[248.531358] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[249.623874] [058/131] (801s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[249.733600] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[252.344384] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.615s)
[252.489274] [059/131] (798s left) kms_psr (psr-suspend)
[252.581070] Starting subtest: psr-suspend
[252.583044] Starting dynamic subtest: eDP-1
[270.185064] Dynamic subtest eDP-1: SUCCESS (2.900s)
[270.187662] Subtest psr-suspend: SUCCESS (2.901s)
[271.017023] [060/131] (794s left) kms_atomic (test-only)
[271.107364] Starting subtest: test-only
[271.166334] Starting dynamic subtest: pipe-A-eDP-1
[273.683367] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.514s)
[273.686066] Subtest test-only: SUCCESS (2.573s)
[274.519004] [061/131] (791s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[274.629111] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[274.634265] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[274.732345] [062/131] (791s left) syncobj_timeline (wait-for-submit-complex)
[274.787788] Starting subtest: wait-for-submit-complex
[274.848815] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[274.920090] [063/131] (790s left) gem_exec_await (wide-contexts)
[275.125797] Starting subtest: wide-contexts
[298.271315] Subtest wide-contexts: SUCCESS (23.140s)
[298.465828] [064/131] (767s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[303.601626] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[303.604469] Starting dynamic subtest: pipe-A-eDP-1
[315.614033] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.008s)
[315.625109] Starting dynamic subtest: pipe-B-eDP-1
[327.616202] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.994s)
[327.618770] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.006s)
[328.422567] [065/131] (737s left) gem_render_copy (yf-tiled)
[328.480693] Starting subtest: yf-tiled
[328.486593] Subtest yf-tiled: SKIP (0.000s)
[328.661467] [066/131] (737s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[328.718257] Starting subtest: invalid-bsd2-flag-on-blt
[328.720657] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[328.826415] [067/131] (737s left) gen3_render_linear_blits
[328.934296] [068/131] (737s left) api_intel_allocator (simple-allocator)
[328.998315] Starting subtest: simple-allocator
[329.000813] Starting dynamic subtest: basic
[329.003036] Dynamic subtest basic: SUCCESS (0.004s)
[329.013519] Starting dynamic subtest: parallel-one
[329.180784] Dynamic subtest parallel-one: SUCCESS (0.180s)
[329.189725] Starting dynamic subtest: print
[329.192503] Dynamic subtest print: SUCCESS (0.000s)
[329.201976] Starting dynamic subtest: reuse
[329.204461] Dynamic subtest reuse: SUCCESS (0.000s)
[329.213322] Starting dynamic subtest: reserve
[329.215655] Dynamic subtest reserve: SUCCESS (0.000s)
[329.223797] Starting dynamic subtest: fork-reopen-allocator
[329.226254] Dynamic subtest fork-reopen-allocator: SUCCESS (0.015s)
[329.228454] Subtest simple-allocator: SUCCESS (0.202s)
[329.315397] [069/131] (736s left) kms_async_flips (test-time-stamp)
[329.411828] Starting subtest: test-time-stamp
[329.769479] Starting dynamic subtest: pipe-A-eDP-1
[330.602420] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.831s)
[330.964795] Starting dynamic subtest: pipe-B-eDP-1
[331.802778] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.842s)
[332.163775] Starting dynamic subtest: pipe-C-eDP-1
[333.002834] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.843s)
[333.363270] Starting dynamic subtest: pipe-D-eDP-1
[334.204673] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.846s)
[334.207705] Subtest test-time-stamp: SUCCESS (4.792s)
[335.421174] [070/131] (730s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[335.533584] Starting subtest: fbcpsr-tiling-y
[335.538642] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[335.637506] [071/131] (730s left) gem_mmap_wc (write-prefaulted)
[335.697636] Subtest write-prefaulted: SKIP (0.000s)
[335.751349] [072/131] (730s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[335.859475] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[336.727806] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.870s)
[336.893865] [073/131] (729s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[337.000500] Starting subtest: yf-tiled-addfb-size-overflow
[337.005103] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[337.113152] [074/131] (729s left) syncobj_wait (single-wait-for-submit-signaled)
[337.179678] Starting subtest: single-wait-for-submit-signaled
[337.182641] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[337.285940] [075/131] (728s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[337.391865] Starting subtest: fbc-psr2-sprite-mmap-cpu
[337.394216] Starting dynamic subtest: eDP-1
[337.398836] Dynamic subtest eDP-1: SKIP (0.000s)
[337.403465] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[337.459438] [076/131] (728s left) gem_userptr_blits (input-checking)
[337.531860] Starting subtest: input-checking
[337.534224] Subtest input-checking: SUCCESS (0.000s)
[337.675178] [077/131] (728s left) gen7_exec_parse (chained-batch)
[337.741717] Subtest chained-batch: SKIP (0.000s)
[337.816010] [078/131] (728s left) vgem_basic (bad-flag)
[337.864852] Starting subtest: bad-flag
[337.867004] Subtest bad-flag: SUCCESS (0.000s)
[337.915487] [079/131] (728s left) gem_exec_balancer (full)
[337.988161] Starting subtest: full
[343.033854] Subtest full: SUCCESS (5.045s)
[343.359214] [080/131] (723s left) kms_invalid_mode (zero-clock)
[343.473962] Starting subtest: zero-clock
[343.476680] Starting dynamic subtest: pipe-A-eDP-1
[343.756267] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[343.766716] Starting dynamic subtest: pipe-B-eDP-1
[343.769283] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[343.778375] Starting dynamic subtest: pipe-C-eDP-1
[343.780733] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[343.789669] Starting dynamic subtest: pipe-D-eDP-1
[343.792049] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[343.794367] Subtest zero-clock: SUCCESS (0.288s)
[344.624434] [081/131] (721s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[344.738799] Starting subtest: plane-all-modeset-transition-fencing
[344.743798] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[344.808444] [082/131] (721s left) gem_ctx_isolation (preservation-reset)
[344.985886] Starting subtest: preservation-reset
[344.988789] Starting dynamic subtest: rcs0
[345.405374] Dynamic subtest rcs0: SUCCESS (0.418s)
[345.417538] Starting dynamic subtest: bcs0
[345.890289] Dynamic subtest bcs0: SUCCESS (0.485s)
[345.900486] Starting dynamic subtest: vcs0
[346.366634] Dynamic subtest vcs0: SUCCESS (0.476s)
[346.378177] Starting dynamic subtest: vcs1
[347.693682] Dynamic subtest vcs1: SUCCESS (1.326s)
[347.703184] Starting dynamic subtest: vecs0
[349.707192] Dynamic subtest vecs0: SUCCESS (2.013s)
[349.719606] Starting dynamic subtest: ccs0
[351.686434] Dynamic subtest ccs0: SUCCESS (1.978s)
[351.689584] Subtest preservation-reset: SUCCESS (6.701s)
[351.894468] [083/131] (714s left) gem_exec_parallel (userptr)
[351.967086] Starting subtest: userptr
[351.969793] Starting dynamic subtest: rcs0
[353.958102] Dynamic subtest rcs0: SUCCESS (1.990s)
[353.968817] Starting dynamic subtest: bcs0
[355.780250] Dynamic subtest bcs0: SUCCESS (1.820s)
[355.796563] Starting dynamic subtest: vcs0
[359.218773] Dynamic subtest vcs0: SUCCESS (3.436s)
[359.229202] Starting dynamic subtest: vcs1
[361.218612] Dynamic subtest vcs1: SUCCESS (1.997s)
[361.230251] Starting dynamic subtest: vecs0
[363.210873] Dynamic subtest vecs0: SUCCESS (1.991s)
[363.220811] Starting dynamic subtest: ccs0
[364.991141] Dynamic subtest ccs0: SUCCESS (1.779s)
[364.994211] Subtest userptr: SUCCESS (13.023s)
[365.178868] [084/131] (701s left) core_setmaster (master-drop-set-user)
[365.263160] Starting subtest: master-drop-set-user
[365.277109] Subtest master-drop-set-user: SUCCESS (0.014s)
[365.310363] [085/131] (701s left) tools_test (tools_test)
[365.366129] Starting subtest: tools_test
[365.425853] Subtest tools_test: SUCCESS (0.076s)
[365.492371] [086/131] (701s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[365.601790] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[365.603783] Starting dynamic subtest: pipe-A-eDP-1
[365.670533] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.070s)
[365.962124] Starting dynamic subtest: pipe-B-eDP-1
[366.797495] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.846s)
[367.076383] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.473s)
[367.924287] [087/131] (698s left) kms_psr (psr2-primary-mmap-cpu)
[368.040708] Starting subtest: psr2-primary-mmap-cpu
[368.043189] Starting dynamic subtest: eDP-1
[369.776749] Dynamic subtest eDP-1: SUCCESS (1.737s)
[369.779672] Subtest psr2-primary-mmap-cpu: SUCCESS (1.738s)
[370.624068] [088/131] (696s left) dmabuf_sync_file (export-multiwait)
[370.669533] Starting subtest: export-multiwait
[370.672288] Subtest export-multiwait: SUCCESS (0.001s)
[370.721666] [089/131] (696s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[370.825316] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[375.404986] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (4.583s)
[375.526360] [090/131] (691s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[375.639630] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[375.644610] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[375.750843] [091/131] (691s left) gem_mmap_gtt (cpuset-big-copy-odd)
[375.812684] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[375.880812] [092/131] (690s left) syncobj_wait (reset-signaled)
[375.941577] Starting subtest: reset-signaled
[375.944156] Subtest reset-signaled: SUCCESS (0.000s)
[376.048213] [093/131] (690s left) kms_color (ctm-max)
[376.141602] Starting subtest: ctm-max
[376.144316] Starting dynamic subtest: pipe-A-eDP-1
[376.852421] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s)
[376.862345] Starting dynamic subtest: pipe-B-eDP-1
[378.318411] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.467s)
[378.329816] Starting dynamic subtest: pipe-C-eDP-1
[379.622704] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.302s)
[379.633661] Starting dynamic subtest: pipe-D-eDP-1
[380.929382] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.306s)
[380.931608] Subtest ctm-max: SUCCESS (4.785s)
[381.726147] [094/131] (685s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[381.825520] Starting subtest: primary-y-tiled-reflect-x-270
[381.830810] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[381.899125] [095/131] (685s left) kms_pm_rpm (modeset-lpsp-stress)
[383.442972] Starting subtest: modeset-lpsp-stress
[399.667647] Subtest modeset-lpsp-stress: SUCCESS (16.223s)
[399.752132] [096/131] (667s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[399.874570] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[430.623288] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (30.744s)
[431.423075] [097/131] (635s left) gem_exec_fence (syncobj-channel)
[431.889785] Starting subtest: syncobj-channel
[432.913728] Subtest syncobj-channel: SUCCESS (1.020s)
[433.281368] [098/131] (633s left) gem_ctx_persistence (saturated-hostile)
[433.350442] Starting subtest: saturated-hostile
[433.352790] Starting dynamic subtest: rcs0
[434.200681] Dynamic subtest rcs0: SUCCESS (0.849s)
[434.213101] Starting dynamic subtest: bcs0
[435.019340] Dynamic subtest bcs0: SUCCESS (0.818s)
[435.029840] Starting dynamic subtest: vcs0
[435.840130] Dynamic subtest vcs0: SUCCESS (0.818s)
[435.852829] Starting dynamic subtest: vcs1
[436.666477] Dynamic subtest vcs1: SUCCESS (0.823s)
[436.677809] Starting dynamic subtest: vecs0
[437.480039] Dynamic subtest vecs0: SUCCESS (0.813s)
[437.491283] Starting dynamic subtest: ccs0
[438.334703] Dynamic subtest ccs0: SUCCESS (0.853s)
[438.340074] Subtest saturated-hostile: SUCCESS (4.984s)
[438.410974] [099/131] (628s left) gem_exec_reloc (basic-wc-noreloc)
[438.477782] Subtest basic-wc-noreloc: SKIP (0.000s)
[438.540830] [100/131] (628s left) kms_cursor_crc (cursor-random-64x21)
[438.735085] Starting subtest: cursor-random-64x21
[438.768579] Subtest cursor-random-64x21: SKIP (0.035s)
[438.986266] [101/131] (628s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[439.083063] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[439.085598] Starting dynamic subtest: pipe-A
[439.103363] Dynamic subtest pipe-A: SKIP (0.015s)
[439.114032] Starting dynamic subtest: pipe-B
[439.131137] Dynamic subtest pipe-B: SKIP (0.026s)
[439.140582] Starting dynamic subtest: pipe-C
[439.157924] Dynamic subtest pipe-C: SKIP (0.026s)
[439.167253] Starting dynamic subtest: pipe-D
[439.184126] Dynamic subtest pipe-D: SKIP (0.025s)
[439.188439] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.093s)
[439.270013] [102/131] (627s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[439.367234] Starting subtest: primary-4-tiled-reflect-x-180
[446.669535] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.301s)
[447.821797] [103/131] (619s left) dumb_buffer (invalid-bpp)
[447.880797] Starting subtest: invalid-bpp
[447.883494] Subtest invalid-bpp: SUCCESS (0.000s)
[447.971669] [104/131] (619s left) gem_busy (close-race)
[448.043772] Starting subtest: close-race
[471.218829] Subtest close-race: SUCCESS (23.170s)
[471.592007] [105/131] (595s left) gem_exec_schedule (u-lateslice)
[471.715289] Starting subtest: u-lateslice
[471.717613] Starting dynamic subtest: rcs0
[471.735703] Dynamic subtest rcs0: SUCCESS (0.030s)
[471.745411] Starting dynamic subtest: bcs0
[471.759373] Dynamic subtest bcs0: SUCCESS (0.023s)
[471.768484] Starting dynamic subtest: vcs0
[471.781467] Dynamic subtest vcs0: SUCCESS (0.022s)
[471.791324] Starting dynamic subtest: vcs1
[471.802274] Dynamic subtest vcs1: SUCCESS (0.020s)
[471.811825] Starting dynamic subtest: vecs0
[471.826541] Dynamic subtest vecs0: SUCCESS (0.023s)
[471.837337] Starting dynamic subtest: ccs0
[471.848573] Dynamic subtest ccs0: SUCCESS (0.022s)
[471.850738] Subtest u-lateslice: SUCCESS (0.143s)
[473.306172] [106/131] (594s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[473.414810] Starting subtest: y-tiled-16bpp-rotate-0
[473.420476] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[473.523089] [107/131] (593s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-wc)
[473.621927] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-wc
[478.244934] Subtest psr-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (4.626s)
[478.366199] [108/131] (589s left) kms_flip (flip-vs-expired-vblank-interruptible)
[478.469520] Starting subtest: flip-vs-expired-vblank-interruptible
[478.472226] Starting dynamic subtest: A-eDP1
[487.199239] Dynamic subtest A-eDP1: SUCCESS (8.727s)
[487.209116] Starting dynamic subtest: B-eDP1
[495.896057] Dynamic subtest B-eDP1: SUCCESS (8.694s)
[495.906145] Starting dynamic subtest: C-eDP1
[504.594605] Dynamic subtest C-eDP1: SUCCESS (8.698s)
[504.605729] Starting dynamic subtest: D-eDP1
[513.297492] Dynamic subtest D-eDP1: SUCCESS (8.702s)
[513.300116] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.831s)
[514.518911] [109/131] (552s left) kms_chamelium_color (ctm-negative)
[514.626846] Subtest ctm-negative: SKIP (0.000s)
[514.668688] [110/131] (552s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[514.806832] Starting subtest: cursor-vs-flip-varying-size
[545.235849] Subtest cursor-vs-flip-varying-size: SUCCESS (30.427s)
[546.109997] [111/131] (521s left) syncobj_timeline (invalid-query-one-illegal-handle)
[546.178092] Starting subtest: invalid-query-one-illegal-handle
[546.180489] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[546.279644] [112/131] (521s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[546.394678] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[547.273982] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.881s)
[547.431618] [113/131] (520s left) syncobj_wait (single-wait-all-signaled)
[547.504051] Starting subtest: single-wait-all-signaled
[547.506797] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[547.612021] [114/131] (520s left) kms_dsc (dsc-with-bpc)
[547.712569] Starting subtest: dsc-with-bpc
[547.748576] Subtest dsc-with-bpc: SKIP (0.001s)
[547.783275] [115/131] (519s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[547.895501] Starting subtest: basic-flip-before-cursor-varying-size
[548.823014] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.927s)
[549.611504] [116/131] (518s left) gem_userptr_blits (stress-purge)
[549.682656] Starting subtest: stress-purge
[555.066737] Subtest stress-purge: SUCCESS (5.385s)
[555.218636] [117/131] (512s left) gem_exec_schedule (preempt-self)
[555.349347] Starting subtest: preempt-self
[555.351137] Starting dynamic subtest: rcs0
[555.385267] Dynamic subtest rcs0: SUCCESS (0.037s)
[555.396671] Starting dynamic subtest: bcs0
[555.411468] Dynamic subtest bcs0: SUCCESS (0.025s)
[555.420561] Starting dynamic subtest: vcs0
[555.445274] Dynamic subtest vcs0: SUCCESS (0.033s)
[555.454656] Starting dynamic subtest: vcs1
[555.475458] Dynamic subtest vcs1: SUCCESS (0.029s)
[555.484658] Starting dynamic subtest: vecs0
[555.519252] Dynamic subtest vecs0: SUCCESS (0.043s)
[555.531781] Starting dynamic subtest: ccs0
[555.554995] Dynamic subtest ccs0: SUCCESS (0.034s)
[555.557350] Subtest preempt-self: SUCCESS (0.206s)
[557.363093] [118/131] (510s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[557.481797] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[557.486692] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[557.586384] [119/131] (510s left) i915_pm_freq_api (freq-reset-multiple)
[557.658598] Starting subtest: freq-reset-multiple
[557.660832] Starting dynamic subtest: gt0
[567.467630] Dynamic subtest gt0: SUCCESS (9.806s)
[567.478363] Starting dynamic subtest: gt1
[575.776320] Dynamic subtest gt1: SUCCESS (8.309s)
[575.779266] Subtest freq-reset-multiple: SUCCESS (18.117s)
[575.849767] [120/131] (492s left) kms_chamelium_frames (hdmi-aspect-ratio)
[576.249105] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[577.087735] [121/131] (490s left) gem_flink_basic (basic)
[577.146687] Starting subtest: basic
[577.149114] Subtest basic: SUCCESS (0.000s)
[577.236152] [122/131] (490s left) perf (blocking-parameterized)
[577.336017] Starting subtest: blocking-parameterized
[597.365120] Subtest blocking-parameterized: SUCCESS (20.027s)
[597.412398] [123/131] (470s left) gem_pxp (reject-modify-context-protection-off-2)
[597.538104] Starting subtest: reject-modify-context-protection-off-2
[597.541195] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[597.642791] [124/131] (470s left) gem_exec_reloc (basic-wc-read)
[597.713492] Subtest basic-wc-read: SKIP (0.000s)
[597.791465] [125/131] (470s left) i915_query (test-query-geometry-subslices)
[597.858829] Starting subtest: test-query-geometry-subslices
[597.861792] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[597.945501] [126/131] (470s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[598.040475] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[598.042900] Starting dynamic subtest: pipe-A-eDP-1
[598.067823] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[598.077644] Starting dynamic subtest: pipe-B-eDP-1
[598.103637] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[598.112971] Starting dynamic subtest: pipe-C-eDP-1
[598.139571] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[598.149833] Starting dynamic subtest: pipe-D-eDP-1
[598.177697] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[598.183362] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[600.306014] [127/131] (467s left) i915_pm_rpm (system-suspend-devices)
[602.371503] Starting subtest: system-suspend-devices
[609.932167] Subtest system-suspend-devices: SUCCESS (7.560s)
[610.285295] [128/131] (457s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[610.385516] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[610.388080] Starting dynamic subtest: pipe-A
[610.397736] Dynamic subtest pipe-A: SKIP (0.004s)
[610.409857] Starting dynamic subtest: pipe-B
[610.420387] Dynamic subtest pipe-B: SKIP (0.015s)
[610.431051] Starting dynamic subtest: pipe-C
[610.441370] Dynamic subtest pipe-C: SKIP (0.015s)
[610.450646] Starting dynamic subtest: pipe-D
[610.459512] Dynamic subtest pipe-D: SKIP (0.015s)
[610.464469] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.051s)
[610.524214] [129/131] (457s left) gem_exec_whisper (basic-queues-forked)
[610.592705] Starting subtest: basic-queues-forked
[633.461973] Subtest basic-queues-forked: SUCCESS (22.864s)
[633.643211] [130/131] (434s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[633.758625] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[633.761435] Starting dynamic subtest: pipe-A
[633.833403] Dynamic subtest pipe-A: SUCCESS (0.077s)
[633.844287] Starting dynamic subtest: pipe-B
[635.000134] Dynamic subtest pipe-B: SUCCESS (1.166s)
[635.012587] Starting dynamic subtest: pipe-C
[636.076855] Dynamic subtest pipe-C: SUCCESS (1.076s)
[636.087144] Starting dynamic subtest: pipe-D
[637.177693] Dynamic subtest pipe-D: SUCCESS (1.100s)
[637.180624] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.423s)
[638.303095] [131/131] (430s left) kms_psr (fbc-psr-sprite-blt)
[638.411639] Starting subtest: fbc-psr-sprite-blt
[638.414401] Starting dynamic subtest: eDP-1
[638.419519] Dynamic subtest eDP-1: SKIP (0.000s)
[638.424585] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[638.478852] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_fence
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: kms_flip_scaled_crc
results: parsing output: 7/ for test: perf_pmu
results: parsing output: 8/ for test: gem_wait
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_3d
results: parsing output: 11/ for test: gem_exec_create
results: parsing output: 12/ for test: gem_ccs
results: parsing output: 13/ for test: kms_plane_cursor
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_content_protection
results: parsing output: 16/ for test: gem_lmem_swapping
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_ctx_param
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: gen9_exec_parse
results: parsing output: 23/ for test: gem_mmap_gtt
results: parsing output: 24/ for test: perf_pmu
results: parsing output: 25/ for test: kms_prime
results: parsing output: 26/ for test: gem_render_copy
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: gem_mmap_gtt
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_flip_scaled_crc
results: parsing output: 34/ for test: kms_legacy_colorkey
results: parsing output: 35/ for test: gem_render_tiled_blits
results: parsing output: 36/ for test: gem_exec_params
results: parsing output: 37/ for test: kms_addfb_basic
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_feature_discovery
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_vblank
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: prime_vgem
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_exec_balancer
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_ctx_engines
results: parsing output: 54/ for test: kms_dirtyfb
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_atomic
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: gem_exec_await
results: parsing output: 63/ for test: kms_psr2_sf
results: parsing output: 64/ for test: gem_render_copy
results: parsing output: 65/ for test: gem_exec_params
results: parsing output: 66/ for test: gen3_render_linear_blits
results: parsing output: 67/ for test: api_intel_allocator
results: parsing output: 68/ for test: kms_async_flips
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_mmap_wc
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: gem_userptr_blits
results: parsing output: 76/ for test: gen7_exec_parse
results: parsing output: 77/ for test: vgem_basic
results: parsing output: 78/ for test: gem_exec_balancer
results: parsing output: 79/ for test: kms_invalid_mode
results: parsing output: 80/ for test: kms_atomic_transition
results: parsing output: 81/ for test: gem_ctx_isolation
results: parsing output: 82/ for test: gem_exec_parallel
results: parsing output: 83/ for test: core_setmaster
results: parsing output: 84/ for test: tools_test
results: parsing output: 85/ for test: kms_atomic_transition
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: dmabuf_sync_file
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_mmap_gtt
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: kms_color
results: parsing output: 93/ for test: kms_rotation_crc
results: parsing output: 94/ for test: kms_pm_rpm
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: gem_exec_fence
results: parsing output: 97/ for test: gem_ctx_persistence
results: parsing output: 98/ for test: gem_exec_reloc
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: kms_plane_scaling
results: parsing output: 101/ for test: kms_rotation_crc
results: parsing output: 102/ for test: dumb_buffer
results: parsing output: 103/ for test: gem_busy
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: kms_chamelium_color
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: kms_dsc
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: gem_userptr_blits
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: i915_pm_freq_api
results: parsing output: 119/ for test: kms_chamelium_frames
results: parsing output: 120/ for test: gem_flink_basic
results: parsing output: 121/ for test: perf
results: parsing output: 122/ for test: gem_pxp
results: parsing output: 123/ for test: gem_exec_reloc
results: parsing output: 124/ for test: i915_query
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: i915_pm_rpm
results: parsing output: 127/ for test: kms_plane_scaling
results: parsing output: 128/ for test: gem_exec_whisper
results: parsing output: 129/ for test: kms_plane_scaling
results: parsing output: 130/ for test: kms_psr
Done.