[57.519206] Initializing watchdogs
[57.519254]   /dev/watchdog0
[57.533806] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.538341] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.540509] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.543745] [001/129] (960s left) kms_flip (2x-flip-vs-suspend-interruptible)
[57.710789] Starting subtest: 2x-flip-vs-suspend-interruptible
[57.724348] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.011s)
[57.797635] [002/129] (960s left) kms_cursor_crc (cursor-onscreen-512x170)
[58.054897] Starting subtest: cursor-onscreen-512x170
[58.059645] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[58.190601] [003/129] (959s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[58.304077] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[63.564596] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (5.197s)
[63.660852] [004/129] (954s left) i915_pm_rpm (gem-idle)
[65.229539] Starting subtest: gem-idle
[71.437676] Subtest gem-idle: SUCCESS (6.180s)
[71.753861] [005/129] (946s left) kms_panel_fitting (legacy)
[72.949107] Starting subtest: legacy
[72.951359] Starting dynamic subtest: pipe-A-eDP-1
[73.552138] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.601s)
[73.577274] Starting dynamic subtest: pipe-B-eDP-1
[75.168592] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.594s)
[75.195492] Starting dynamic subtest: pipe-C-eDP-1
[76.742591] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.549s)
[76.765694] Starting dynamic subtest: pipe-D-eDP-1
[78.285757] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.522s)
[78.288117] Subtest legacy: SUCCESS (5.327s)
[79.463513] [006/129] (938s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[79.570101] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[79.572574] Starting dynamic subtest: pipe-A-eDP-1
[79.582071] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[79.590251] Starting dynamic subtest: pipe-B-eDP-1
[79.599475] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[79.606048] Starting dynamic subtest: pipe-C-eDP-1
[79.614164] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[79.620198] Starting dynamic subtest: pipe-D-eDP-1
[79.628229] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[79.632103] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.002s)
[81.722096] [007/129] (936s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[81.832941] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[82.889851] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.057s)
[83.003180] [008/129] (935s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[83.110711] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[84.078065] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.968s)
[84.217645] [009/129] (934s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[86.076295] Starting subtest: modeset-lpsp-stress-no-wait
[95.628035] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.546s)
[95.698859] [010/129] (922s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[95.803873] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[100.398599] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (4.596s)
[100.538418] [011/129] (917s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[100.641096] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[100.643460] Starting dynamic subtest: pipe-A-eDP-1
[100.666745] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[100.673715] Starting dynamic subtest: pipe-B-eDP-1
[100.695362] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[100.701477] Starting dynamic subtest: pipe-C-eDP-1
[100.723280] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[100.729545] Starting dynamic subtest: pipe-D-eDP-1
[100.750854] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[100.755086] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[102.793742] [012/129] (915s left) gem_mmap_gtt (zero-extend)
[102.851118] Subtest zero-extend: SKIP (0.000s)
[102.905621] [013/129] (915s left) gem_ctx_persistence (engines-mixed)
[102.977295] Starting subtest: engines-mixed
[102.979765] Starting dynamic subtest: rcs0
[103.092494] Dynamic subtest rcs0: SUCCESS (0.114s)
[103.102081] Starting dynamic subtest: bcs0
[103.159795] Dynamic subtest bcs0: SUCCESS (0.067s)
[103.169155] Starting dynamic subtest: vcs0
[103.234254] Dynamic subtest vcs0: SUCCESS (0.073s)
[103.242293] Starting dynamic subtest: vcs1
[103.317443] Dynamic subtest vcs1: SUCCESS (0.082s)
[103.326683] Starting dynamic subtest: vecs0
[103.402390] Dynamic subtest vecs0: SUCCESS (0.084s)
[103.411739] Starting dynamic subtest: ccs0
[103.487235] Dynamic subtest ccs0: SUCCESS (0.084s)
[103.489966] Subtest engines-mixed: SUCCESS (0.509s)
[103.556937] [014/129] (915s left) kms_chamelium_frames (vga-frame-dump)
[103.937881] Subtest vga-frame-dump: SKIP (0.000s)
[104.694116] [015/129] (913s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[104.797338] Starting subtest: x-tiled-64bpp-rotate-0
[107.187622] Subtest x-tiled-64bpp-rotate-0: SUCCESS (2.389s)
[107.435989] [016/129] (911s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[107.532775] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[110.163643] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (2.635s)
[110.316129] [017/129] (908s left) gem_cs_tlb (engines)
[110.374364] Starting subtest: engines
[110.376492] Starting dynamic subtest: rcs0
[112.531652] Dynamic subtest rcs0: SUCCESS (2.153s)
[112.539825] Starting dynamic subtest: bcs0
[114.686618] Dynamic subtest bcs0: SUCCESS (2.152s)
[114.693535] Starting dynamic subtest: vcs0
[116.840905] Dynamic subtest vcs0: SUCCESS (2.154s)
[116.848457] Starting dynamic subtest: vcs1
[118.995080] Dynamic subtest vcs1: SUCCESS (2.153s)
[119.003116] Starting dynamic subtest: vecs0
[121.151374] Dynamic subtest vecs0: SUCCESS (2.155s)
[121.160732] Starting dynamic subtest: ccs0
[123.307158] Dynamic subtest ccs0: SUCCESS (2.155s)
[123.309595] Subtest engines: SUCCESS (12.926s)
[123.431640] [018/129] (895s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[123.493549] Starting subtest: single-wait-all-for-submit-available-submitted
[123.495872] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[123.600945] [019/129] (895s left) gem_exec_params (invalid-bsd2-flag-on-render)
[123.659714] Starting subtest: invalid-bsd2-flag-on-render
[123.662174] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[123.755984] [020/129] (895s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[123.817967] Starting subtest: mixed-tiled-to-y-tiled-ccs
[123.822464] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[123.998266] [021/129] (894s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[124.056676] Starting subtest: invalid-multi-wait-all-unsubmitted
[124.059062] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[124.145757] [022/129] (894s left) gem_exec_schedule (manyslice)
[124.218294] Starting subtest: manyslice
[124.220335] Starting dynamic subtest: rcs0
[130.392951] Dynamic subtest rcs0: SUCCESS (6.182s)
[130.406952] Starting dynamic subtest: bcs0
[136.523068] Dynamic subtest bcs0: SUCCESS (6.128s)
[136.531906] Starting dynamic subtest: vcs0
[142.092759] Dynamic subtest vcs0: SUCCESS (5.569s)
[142.100605] Starting dynamic subtest: vcs1
[147.656347] Dynamic subtest vcs1: SUCCESS (5.562s)
[147.664846] Starting dynamic subtest: vecs0
[153.217749] Dynamic subtest vecs0: SUCCESS (5.561s)
[153.224953] Starting dynamic subtest: ccs0
[158.870509] Dynamic subtest ccs0: SUCCESS (5.652s)
[158.872947] Subtest manyslice: SUCCESS (34.658s)
[159.172916] [023/129] (859s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[159.278415] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[159.291412] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[159.401568] [024/129] (859s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[159.459526] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[159.507706] [025/129] (859s left) kms_getfb (getfb-reject-ccs)
[159.567982] Starting subtest: getfb-reject-ccs
[159.570365] Subtest getfb-reject-ccs: SUCCESS (0.000s)
[159.659917] [026/129] (859s left) sriov_basic (bind-unbind-vf)
[159.722597] Starting subtest: bind-unbind-vf
[159.724946] Starting dynamic subtest: vf-1
[159.800594] Dynamic subtest vf-1: FAIL (0.012s)
[159.809677] Starting dynamic subtest: vf-2
[159.883732] Dynamic subtest vf-2: FAIL (0.003s)
[159.892438] Starting dynamic subtest: vf-3
[159.966159] Dynamic subtest vf-3: FAIL (0.003s)
[159.974745] Starting dynamic subtest: vf-4
[160.048795] Dynamic subtest vf-4: FAIL (0.003s)
[160.057250] Starting dynamic subtest: vf-5
[160.130342] Dynamic subtest vf-5: FAIL (0.003s)
[160.138068] Starting dynamic subtest: vf-6
[160.199337] Dynamic subtest vf-6: FAIL (0.003s)
[160.207052] Starting dynamic subtest: vf-7
[160.272085] Dynamic subtest vf-7: FAIL (0.003s)
[160.278558] Starting dynamic subtest: vf-random
[160.339074] Dynamic subtest vf-random: FAIL (0.003s)
[160.346384] Starting dynamic subtest: vf-last
[160.407242] Dynamic subtest vf-last: FAIL (0.486s)
[160.409022] Subtest bind-unbind-vf: FAIL (0.525s)
[160.437429] [027/129] (858s left) gem_exec_whisper (basic-queues-priority)
[160.501240] Starting subtest: basic-queues-priority
[184.813483] Subtest basic-queues-priority: SUCCESS (24.307s)
[184.992489] [028/129] (834s left) kms_atomic_transition (modeset-transition-nonblocking)
[185.096273] Starting subtest: modeset-transition-nonblocking
[185.098482] Starting dynamic subtest: 1x-outputs
[195.656847] Dynamic subtest 1x-outputs: SUCCESS (10.558s)
[195.921347] Subtest modeset-transition-nonblocking: SUCCESS (10.822s)
[196.779818] [029/129] (822s left) gem_exec_fence (nb-await)
[196.966607] Starting subtest: nb-await
[196.968775] Starting dynamic subtest: rcs0
[197.035089] Dynamic subtest rcs0: SUCCESS (0.068s)
[197.043769] Starting dynamic subtest: bcs0
[197.091695] Dynamic subtest bcs0: SUCCESS (0.056s)
[197.101232] Starting dynamic subtest: vcs0
[197.150419] Dynamic subtest vcs0: SUCCESS (0.057s)
[197.160239] Starting dynamic subtest: vcs1
[197.207723] Dynamic subtest vcs1: SUCCESS (0.057s)
[197.217388] Starting dynamic subtest: vecs0
[197.265357] Dynamic subtest vecs0: SUCCESS (0.057s)
[197.275467] Starting dynamic subtest: ccs0
[197.322534] Dynamic subtest ccs0: SUCCESS (0.056s)
[197.325027] Subtest nb-await: SUCCESS (0.356s)
[199.070441] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[199.073809] [030/129] (820s left) kms_atomic (plane-invalid-params-fence)
[199.164072] Starting subtest: plane-invalid-params-fence
[199.166294] Starting dynamic subtest: pipe-A-eDP-1
[199.526090] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.361s)
[199.528371] Subtest plane-invalid-params-fence: SUCCESS (0.362s)
[200.394039] [031/129] (818s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[200.494472] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[200.498728] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[200.585792] [032/129] (818s left) kms_pm_dc (dc5-retention-flops)
[201.690837] Starting subtest: dc5-retention-flops
[201.695337] Subtest dc5-retention-flops: SKIP (0.000s)
[201.760596] [033/129] (817s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[201.856709] Starting subtest: flip-primary-invalidate-overlay
[214.373599] Subtest flip-primary-invalidate-overlay: SUCCESS (12.519s)
[214.705431] [034/129] (804s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[214.960558] Starting subtest: cursor-rapid-movement-512x170
[214.964959] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[215.116261] [035/129] (804s left) gem_fenced_exec_thrash (no-spare-fences)
[215.182723] Subtest no-spare-fences: SKIP (0.000s)
[215.253636] [036/129] (804s left) kms_plane_lowres (tiling-none)
[215.355112] Starting subtest: tiling-none
[215.357462] Starting dynamic subtest: pipe-A-eDP-1
[215.362177] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[215.648997] Starting dynamic subtest: pipe-B-eDP-1
[215.653794] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[215.661137] Starting dynamic subtest: pipe-C-eDP-1
[215.665727] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[215.673121] Starting dynamic subtest: pipe-D-eDP-1
[215.677076] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[215.681032] Subtest tiling-none: SKIP (0.292s)
[216.428077] [037/129] (802s left) kms_writeback (writeback-check-output)
[216.529281] Subtest writeback-check-output: SKIP (0.000s)
[216.568466] [038/129] (802s left) syncobj_basic (bad-flags-fd-to-handle)
[216.626277] Starting subtest: bad-flags-fd-to-handle
[216.628477] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[216.738691] [039/129] (802s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[216.790915] Starting subtest: wait-all-for-submit-delayed-submit
[216.894562] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[216.966593] [040/129] (802s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[217.064993] Starting subtest: fbc-psr-sprite-mmap-cpu
[217.067824] Starting dynamic subtest: eDP-1
[217.072998] Dynamic subtest eDP-1: SKIP (0.000s)
[217.077883] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[217.140327] [041/129] (802s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[217.241367] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[217.245354] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[217.354687] [042/129] (802s left) kms_display_modes (mst-extended-mode-negative)
[217.444249] Starting subtest: mst-extended-mode-negative
[217.448627] Subtest mst-extended-mode-negative: SKIP (0.000s)
[217.485751] [043/129] (802s left) kms_getfb (getfb-handle-valid)
[217.537730] Starting subtest: getfb-handle-valid
[217.540215] Subtest getfb-handle-valid: SUCCESS (0.000s)
[217.633100] [044/129] (802s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[217.741758] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[217.746159] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[217.849440] [045/129] (801s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[217.944760] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[217.946818] Starting dynamic subtest: pipe-A
[218.029533] Dynamic subtest pipe-A: SUCCESS (0.085s)
[218.038718] Starting dynamic subtest: pipe-B
[219.156120] Dynamic subtest pipe-B: SUCCESS (1.126s)
[219.166212] Starting dynamic subtest: pipe-C
[220.261884] Dynamic subtest pipe-C: SUCCESS (1.105s)
[220.270684] Starting dynamic subtest: pipe-D
[221.390352] Dynamic subtest pipe-D: SUCCESS (1.128s)
[221.392640] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.446s)
[222.532159] [046/129] (797s left) gem_exec_schedule (submit-early-slice)
[222.604710] Starting subtest: submit-early-slice
[222.606668] Starting dynamic subtest: rcs0
[222.634296] Dynamic subtest rcs0: SUCCESS (0.039s)
[222.642781] Starting dynamic subtest: bcs0
[222.668972] Dynamic subtest bcs0: SUCCESS (0.034s)
[222.676543] Starting dynamic subtest: vcs0
[222.703711] Dynamic subtest vcs0: SUCCESS (0.034s)
[222.711418] Starting dynamic subtest: vcs1
[222.738241] Dynamic subtest vcs1: SUCCESS (0.034s)
[222.745805] Starting dynamic subtest: vecs0
[222.771773] Dynamic subtest vecs0: SUCCESS (0.033s)
[222.782322] Starting dynamic subtest: ccs0
[222.808639] Dynamic subtest ccs0: SUCCESS (0.036s)
[222.811158] Subtest submit-early-slice: SUCCESS (0.214s)
[224.016132] [047/129] (795s left) gem_ctx_shared (q-in-order)
[224.084630] Starting subtest: Q-in-order
[224.087103] Starting dynamic subtest: rcs0
[224.191181] Dynamic subtest rcs0: SUCCESS (0.106s)
[224.209365] Starting dynamic subtest: vcs0
[224.276354] Dynamic subtest vcs0: SUCCESS (0.084s)
[224.291837] Starting dynamic subtest: vcs1
[224.359636] Dynamic subtest vcs1: SUCCESS (0.083s)
[224.374429] Starting dynamic subtest: vecs0
[224.435997] Dynamic subtest vecs0: SUCCESS (0.075s)
[224.449200] Starting dynamic subtest: ccs0
[224.501857] Dynamic subtest ccs0: SUCCESS (0.066s)
[224.504515] Subtest Q-in-order: SUCCESS (0.418s)
[225.983346] [048/129] (793s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[226.099330] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[231.221963] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (5.125s)
[231.390862] [049/129] (788s left) syncobj_wait (wait-any-interrupted)
[231.451956] Starting subtest: wait-any-interrupted
[231.552252] Subtest wait-any-interrupted: SUCCESS (0.101s)
[231.621704] [050/129] (788s left) syncobj_timeline (invalid-signal-illegal-point)
[231.682472] Starting subtest: invalid-signal-illegal-point
[231.684426] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[231.773735] [051/129] (788s left) gen9_exec_parse (batch-zero-length)
[231.836457] Subtest batch-zero-length: SKIP (0.000s)
[231.907600] [052/129] (788s left) sysfs_preempt_timeout (timeout)
[231.965093] Starting subtest: timeout
[231.967311] Starting dynamic subtest: vecs0
[241.963208] Dynamic subtest vecs0: SUCCESS (9.996s)
[241.971614] Starting dynamic subtest: ccs0
[243.330754] Dynamic subtest ccs0: SUCCESS (1.366s)
[243.338620] Starting dynamic subtest: vcs0
[252.909709] Dynamic subtest vcs0: SUCCESS (9.573s)
[252.920056] Starting dynamic subtest: bcs0
[254.218750] Dynamic subtest bcs0: SUCCESS (1.309s)
[254.228411] Starting dynamic subtest: rcs0
[255.462682] Dynamic subtest rcs0: SUCCESS (1.243s)
[255.471913] Starting dynamic subtest: vcs1
[264.955440] Dynamic subtest vcs1: SUCCESS (9.489s)
[264.958125] Subtest timeout: SUCCESS (32.985s)
[265.032056] [053/129] (754s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[265.146348] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[265.150407] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[265.249222] [054/129] (754s left) kms_psr2_su (page_flip-p010)
[265.300210] Subtest page_flip-P010: SKIP (0.000s)
[265.369796] [055/129] (754s left) kms_hdr (bpc-switch)
[265.468249] Starting subtest: bpc-switch
[266.558178] Starting dynamic subtest: pipe-A-eDP-1
[269.933059] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.375s)
[269.935490] Subtest bpc-switch: SUCCESS (4.464s)
[270.051539] [056/129] (750s left) gem_exec_balancer (parallel-bb-first)
[270.304950] Starting subtest: parallel-bb-first
[271.085945] Subtest parallel-bb-first: SUCCESS (0.781s)
[271.950982] [057/129] (748s left) gem_exec_reloc (basic-wc-read)
[272.016422] Subtest basic-wc-read: SKIP (0.000s)
[272.075565] [058/129] (748s left) syncobj_timeline (wait-for-submit-complex)
[272.121242] Starting subtest: wait-for-submit-complex
[272.181025] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[272.250670] [059/129] (747s left) kms_color (ctm-0-50)
[272.347075] Starting subtest: ctm-0-50
[272.349232] Starting dynamic subtest: pipe-A-eDP-1
[275.685716] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.338s)
[275.694808] Starting dynamic subtest: pipe-B-eDP-1
[279.748909] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.062s)
[279.757771] Starting dynamic subtest: pipe-C-eDP-1
[283.682597] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.932s)
[283.690672] Starting dynamic subtest: pipe-D-eDP-1
[287.658667] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.977s)
[287.661279] Subtest ctm-0-50: SUCCESS (15.311s)
[288.508468] [060/129] (731s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[288.617901] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[291.923910] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (3.310s)
[292.078446] [061/129] (728s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[292.182881] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[292.184928] Starting dynamic subtest: pipe-A-eDP-1
[292.203889] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[292.211961] Starting dynamic subtest: pipe-B-eDP-1
[292.229309] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[292.236719] Starting dynamic subtest: pipe-C-eDP-1
[292.255482] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[292.264974] Starting dynamic subtest: pipe-D-eDP-1
[292.283772] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[292.287225] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[294.399156] [062/129] (725s left) kms_lease (lease-unleased-crtc)
[294.500931] Starting subtest: lease-unleased-crtc
[294.503354] Starting dynamic subtest: pipe-A-eDP-1
[294.791910] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[294.801260] Starting dynamic subtest: pipe-B-eDP-1
[295.549972] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.757s)
[295.560361] Starting dynamic subtest: pipe-C-eDP-1
[295.562693] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[295.571358] Starting dynamic subtest: pipe-D-eDP-1
[295.573228] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[295.575084] Subtest lease-unleased-crtc: SUCCESS (1.064s)
[295.910206] [063/129] (724s left) gem_huc_copy (huc-copy)
[295.982698] Starting subtest: huc-copy
[295.987723] Subtest huc-copy: SUCCESS (0.003s)
[296.117156] [064/129] (724s left) kms_invalid_mode (clock-too-high)
[296.216258] Starting subtest: clock-too-high
[296.218536] Starting dynamic subtest: pipe-A-eDP-1
[296.223029] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[296.230345] Starting dynamic subtest: pipe-B-eDP-1
[296.234855] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[296.242381] Starting dynamic subtest: pipe-C-eDP-1
[296.246812] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[296.255944] Starting dynamic subtest: pipe-D-eDP-1
[296.259867] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[296.263789] Subtest clock-too-high: SKIP (0.004s)
[296.294240] [065/129] (724s left) kms_setmode (clone-exclusive-crtc)
[296.342498] Starting subtest: clone-exclusive-crtc
[296.349179] Subtest clone-exclusive-crtc: SKIP (0.000s)
[296.419921] [066/129] (724s left) kms_psr (psr-sprite-plane-onoff)
[296.525234] Starting subtest: psr-sprite-plane-onoff
[296.527661] Starting dynamic subtest: eDP-1
[298.336560] Dynamic subtest eDP-1: SUCCESS (1.812s)
[298.338976] Subtest psr-sprite-plane-onoff: SUCCESS (1.813s)
[299.166358] [067/129] (721s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[299.259949] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[299.262269] Starting dynamic subtest: pipe-A-default-mode
[301.973754] Dynamic subtest pipe-A-default-mode: SUCCESS (2.710s)
[301.976164] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.712s)
[302.834206] [068/129] (717s left) prime_vgem (fence-read-hang)
[302.929184] Subtest fence-read-hang: SKIP (0.000s)
[303.041312] [069/129] (717s left) kms_chamelium_edid (dp-edid-resolution-list)
[303.429588] Subtest dp-edid-resolution-list: SKIP (0.000s)
[304.233859] [070/129] (716s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[304.334337] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[304.336701] Starting dynamic subtest: pipe-A-eDP-1
[304.360524] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[304.370082] Starting dynamic subtest: pipe-B-eDP-1
[304.392478] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[304.400381] Starting dynamic subtest: pipe-C-eDP-1
[304.423521] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[304.432480] Starting dynamic subtest: pipe-D-eDP-1
[304.454507] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[304.459052] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[306.509688] [071/129] (714s left) kms_plane (plane-position-covered)
[306.606106] Starting subtest: plane-position-covered
[307.124466] Starting dynamic subtest: pipe-A-plane-1
[308.407650] Dynamic subtest pipe-A-plane-1: SUCCESS (1.283s)
[308.416069] Starting dynamic subtest: pipe-A-plane-2
[309.690065] Dynamic subtest pipe-A-plane-2: SUCCESS (1.282s)
[309.699743] Starting dynamic subtest: pipe-A-plane-3
[310.914697] Dynamic subtest pipe-A-plane-3: SUCCESS (1.223s)
[310.922813] Starting dynamic subtest: pipe-A-plane-4
[312.153748] Dynamic subtest pipe-A-plane-4: SUCCESS (1.238s)
[312.162667] Starting dynamic subtest: pipe-A-plane-5
[312.191383] Dynamic subtest pipe-A-plane-5: SUCCESS (0.037s)
[313.303968] Starting dynamic subtest: pipe-B-plane-1
[314.525611] Dynamic subtest pipe-B-plane-1: SUCCESS (1.226s)
[314.533946] Starting dynamic subtest: pipe-B-plane-2
[315.827721] Dynamic subtest pipe-B-plane-2: SUCCESS (1.303s)
[315.836056] Starting dynamic subtest: pipe-B-plane-3
[317.038186] Dynamic subtest pipe-B-plane-3: SUCCESS (1.211s)
[317.046734] Starting dynamic subtest: pipe-B-plane-4
[318.272507] Dynamic subtest pipe-B-plane-4: SUCCESS (1.232s)
[318.281311] Starting dynamic subtest: pipe-B-plane-5
[318.309898] Dynamic subtest pipe-B-plane-5: SUCCESS (0.037s)
[318.312246] Subtest plane-position-covered: SUCCESS (11.701s)
[319.063459] [072/129] (701s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[319.165871] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[319.168208] Starting dynamic subtest: pipe-A-eDP-1
[319.191259] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[319.201700] Starting dynamic subtest: pipe-B-eDP-1
[319.223120] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[319.230778] Starting dynamic subtest: pipe-C-eDP-1
[319.251526] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[319.259462] Starting dynamic subtest: pipe-D-eDP-1
[319.281057] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[319.285242] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[321.322041] [073/129] (699s left) gem_exec_schedule (semaphore-codependency)
[321.397849] Starting subtest: semaphore-codependency
[321.406778] Subtest semaphore-codependency: SUCCESS (0.013s)
[321.752274] [074/129] (698s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[321.853928] Starting subtest: fbc-psr2-sprite-plane-onoff
[321.856275] Starting dynamic subtest: eDP-1
[321.860681] Dynamic subtest eDP-1: SKIP (0.000s)
[321.865079] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[321.921435] [075/129] (698s left) drm_fdinfo (idle)
[321.964131] Starting subtest: idle
[321.966468] Starting dynamic subtest: rcs0
[322.513990] Dynamic subtest rcs0: SUCCESS (0.551s)
[322.524056] Starting dynamic subtest: bcs0
[323.056080] Dynamic subtest bcs0: SUCCESS (0.538s)
[323.066224] Starting dynamic subtest: vcs0
[323.565801] Dynamic subtest vcs0: SUCCESS (0.503s)
[323.574996] Starting dynamic subtest: vcs1
[324.067204] Dynamic subtest vcs1: SUCCESS (0.503s)
[324.075892] Starting dynamic subtest: vecs0
[324.572461] Dynamic subtest vecs0: SUCCESS (0.503s)
[324.583240] Starting dynamic subtest: ccs0
[325.078334] Dynamic subtest ccs0: SUCCESS (0.503s)
[325.081112] Subtest idle: SUCCESS (3.115s)
[325.149298] [076/129] (695s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[325.262834] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[325.267218] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[325.370869] [077/129] (695s left) gem_busy (busy)
[325.441886] Starting subtest: busy
[325.444404] Starting dynamic subtest: all-engines
[325.521200] Dynamic subtest all-engines: SUCCESS (0.079s)
[325.529501] Starting dynamic subtest: rcs0
[326.897839] Dynamic subtest rcs0: SUCCESS (1.375s)
[326.907627] Starting dynamic subtest: bcs0
[326.956665] Dynamic subtest bcs0: SUCCESS (0.055s)
[326.966128] Starting dynamic subtest: vcs0
[326.995449] Dynamic subtest vcs0: SUCCESS (0.039s)
[327.003574] Starting dynamic subtest: vcs1
[328.944194] Dynamic subtest vcs1: SUCCESS (1.946s)
[328.953528] Starting dynamic subtest: vecs0
[330.928246] Dynamic subtest vecs0: SUCCESS (1.982s)
[330.937557] Starting dynamic subtest: ccs0
[332.912418] Dynamic subtest ccs0: SUCCESS (1.984s)
[332.914584] Subtest busy: SUCCESS (7.468s)
[333.300189] [078/129] (687s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[333.408599] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[336.808895] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (3.405s)
[336.963274] [079/129] (683s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[337.063066] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[337.073593] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s)
[337.148739] [080/129] (683s left) i915_query (query-regions-sanity-check)
[337.196507] Starting subtest: query-regions-sanity-check
[337.210798] Subtest query-regions-sanity-check: SUCCESS (0.016s)
[337.328614] [081/129] (683s left) kms_flip (flip-vs-rmfb)
[337.424552] Starting subtest: flip-vs-rmfb
[337.426500] Starting dynamic subtest: A-eDP1
[346.143313] Dynamic subtest A-eDP1: SUCCESS (8.717s)
[346.153435] Starting dynamic subtest: B-eDP1
[354.869253] Dynamic subtest B-eDP1: SUCCESS (8.724s)
[354.877170] Starting dynamic subtest: C-eDP1
[363.581075] Dynamic subtest C-eDP1: SUCCESS (8.710s)
[363.591680] Starting dynamic subtest: D-eDP1
[372.200863] Dynamic subtest D-eDP1: SUCCESS (8.618s)
[372.206147] Subtest flip-vs-rmfb: SUCCESS (34.778s)
[373.370781] [082/129] (647s left) sw_sync (sync_random_merge)
[373.410274] Starting subtest: sync_random_merge
[373.448178] Subtest sync_random_merge: SUCCESS (0.039s)
[373.505017] [083/129] (647s left) i915_pm_freq_api (freq-suspend)
[373.565663] Starting subtest: freq-suspend
[373.568345] Starting dynamic subtest: gt0
[389.911063] Dynamic subtest gt0: SUCCESS (1.239s)
[389.928251] Starting dynamic subtest: gt1
[405.838343] Dynamic subtest gt1: SUCCESS (1.152s)
[405.840436] Subtest freq-suspend: SUCCESS (2.393s)
[406.921317] [084/129] (645s left) kms_flip (2x-flip-vs-modeset)
[407.029976] Starting subtest: 2x-flip-vs-modeset
[407.041737] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[407.118700] [085/129] (644s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[407.227847] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[407.233695] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[407.343151] [086/129] (644s left) gem_watchdog (default-physical)
[407.418019] Starting subtest: default-physical
[409.433825] Subtest default-physical: SUCCESS (1.970s)
[409.533441] [087/129] (642s left) debugfs_test (basic-hwmon)
[409.596475] Starting subtest: basic-hwmon
[409.602253] Subtest basic-hwmon: SKIP (0.000s)
[409.709218] [088/129] (642s left) kms_flip (2x-nonexisting-fb)
[409.804419] Starting subtest: 2x-nonexisting-fb
[409.815627] Subtest 2x-nonexisting-fb: SKIP (0.010s)
[409.890237] [089/129] (642s left) gem_exec_reloc (basic-gtt-read)
[409.957711] Subtest basic-gtt-read: SKIP (0.000s)
[410.045036] [090/129] (642s left) gem_pxp (create-protected-buffer)
[410.171820] Starting subtest: create-protected-buffer
[410.174647] Subtest create-protected-buffer: SUCCESS (0.000s)
[410.286912] [091/129] (642s left) kms_cursor_crc (cursor-offscreen-32x32)
[410.419755] Starting subtest: cursor-offscreen-32x32
[410.459317] Subtest cursor-offscreen-32x32: SKIP (0.034s)
[410.706636] [092/129] (641s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[410.765146] Starting subtest: etime-multi-wait-available-unsubmitted
[410.866635] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.100s)
[410.950449] [093/129] (641s left) kms_flip (2x-flip-vs-panning)
[411.049246] Starting subtest: 2x-flip-vs-panning
[411.060553] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[411.138050] [094/129] (641s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[411.253414] Starting subtest: yf-tiled-8bpp-rotate-0
[411.257681] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[411.380365] [095/129] (641s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[411.484523] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[411.488872] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[411.561449] [096/129] (640s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[411.628816] Starting subtest: framebuffer-vs-set-tiling
[411.633580] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[411.750234] [097/129] (640s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc)
[411.860373] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc
[414.942222] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (3.033s)
[415.064157] [098/129] (637s left) gem_exec_reloc (basic-gtt-read-noreloc)
[415.129139] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[415.185062] [099/129] (637s left) dumb_buffer (map-uaf)
[415.244746] Starting subtest: map-uaf
[415.257247] Subtest map-uaf: SUCCESS (0.015s)
[415.370219] [100/129] (637s left) gem_softpin (evict-snoop)
[415.425157] Starting subtest: evict-snoop
[415.430145] Subtest evict-snoop: SKIP (0.000s)
[415.549630] [101/129] (637s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[420.597056] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[420.602261] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[421.451576] [102/129] (631s left) api_intel_bb (delta-check)
[421.508610] Starting subtest: delta-check
[421.514850] Subtest delta-check: SUCCESS (0.006s)
[421.627580] [103/129] (631s left) kms_flip (dpms-vs-vblank-race-interruptible)
[421.732722] Starting subtest: dpms-vs-vblank-race-interruptible
[421.735237] Starting dynamic subtest: A-eDP1
[426.728573] Dynamic subtest A-eDP1: SUCCESS (4.969s)
[426.738784] Starting dynamic subtest: B-eDP1
[431.349664] Dynamic subtest B-eDP1: SUCCESS (4.609s)
[431.359268] Starting dynamic subtest: C-eDP1
[435.929521] Dynamic subtest C-eDP1: SUCCESS (4.573s)
[435.938351] Starting dynamic subtest: D-eDP1
[440.431190] Dynamic subtest D-eDP1: SUCCESS (4.504s)
[440.433445] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.663s)
[441.304663] [104/129] (611s left) gem_exec_reloc (basic-cpu-wc)
[441.368980] Subtest basic-cpu-wc: SKIP (0.000s)
[441.439446] [105/129] (611s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[441.546817] Starting subtest: fbc-rgb565-draw-render
[444.727096] Subtest fbc-rgb565-draw-render: SUCCESS (3.187s)
[444.870966] [106/129] (608s left) kms_psr (pr-primary-render)
[444.966735] Starting subtest: pr-primary-render
[444.971485] Subtest pr-primary-render: SKIP (0.000s)
[445.032151] [107/129] (608s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[445.163663] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[445.168448] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[445.294138] [108/129] (607s left) gem_spin_batch (spin-all-new)
[445.359268] Starting subtest: spin-all-new
[445.373723] Subtest spin-all-new: SUCCESS (0.014s)
[446.849127] [109/129] (606s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[446.951495] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[446.955980] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[447.060906] [110/129] (606s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[447.121844] Starting subtest: y-tiled-to-vebox-x-tiled
[447.127873] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[447.300652] [111/129] (605s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[447.400665] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[447.406357] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[447.516589] [112/129] (605s left) gem_userptr_blits (sync-unmap)
[447.595286] Starting subtest: sync-unmap
[447.608920] Subtest sync-unmap: SUCCESS (0.014s)
[447.762829] [113/129] (605s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[448.313048] Starting subtest: syncobj-timeline-invalid-wait
[448.315544] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[449.925331] [114/129] (603s left) gem_exec_reloc (basic-gtt-cpu-active)
[449.994328] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[450.075190] [115/129] (603s left) gem_mmap_offset (bad-extensions)
[450.132674] Starting subtest: bad-extensions
[450.135012] Subtest bad-extensions: SUCCESS (0.000s)
[450.238138] [116/129] (603s left) perf_pmu (semaphore-busy)
[450.279878] Starting subtest: semaphore-busy
[450.282454] Starting dynamic subtest: rcs0
[451.951105] Dynamic subtest rcs0: SUCCESS (1.671s)
[451.962854] Starting dynamic subtest: bcs0
[453.588509] Dynamic subtest bcs0: SUCCESS (1.635s)
[453.598250] Starting dynamic subtest: vcs0
[457.307605] Dynamic subtest vcs0: SUCCESS (3.717s)
[457.317082] Starting dynamic subtest: vcs1
[463.322660] Dynamic subtest vcs1: SUCCESS (6.012s)
[463.334816] Starting dynamic subtest: vecs0
[469.339787] Dynamic subtest vecs0: SUCCESS (6.014s)
[469.351818] Starting dynamic subtest: ccs0
[472.413484] Dynamic subtest ccs0: SUCCESS (3.071s)
[472.416612] Subtest semaphore-busy: SUCCESS (22.134s)
[472.535291] [117/129] (580s left) gem_exec_suspend (basic-s3)
[472.604935] Starting subtest: basic-S3
[472.607811] Starting dynamic subtest: smem
[492.875463] Dynamic subtest smem: SUCCESS (6.157s)
[492.878493] Subtest basic-S3: SUCCESS (6.159s)
[493.052616] [118/129] (574s left) kms_vblank (query-busy)
[493.156954] Starting subtest: query-busy
[493.159590] Starting dynamic subtest: pipe-A-eDP-1
[495.097123] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s)
[495.119186] Starting dynamic subtest: pipe-D-eDP-1
[497.669472] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.520s)
[497.672337] Subtest query-busy: SUCCESS (4.408s)
[498.475216] [119/129] (569s left) kms_frontbuffer_tracking (psr-1p-rte)
[498.576897] Starting subtest: psr-1p-rte
[501.892062] Subtest psr-1p-rte: SUCCESS (3.280s)
[502.028075] [120/129] (565s left) prime_mmap (test_reprime)
[502.101049] Starting subtest: test_reprime
[502.103607] Starting dynamic subtest: test_reprime-smem
[502.134874] Dynamic subtest test_reprime-smem: SUCCESS (0.034s)
[502.137417] Subtest test_reprime: SUCCESS (0.035s)
[502.228427] [121/129] (565s left) kms_prop_blob (invalid-get-prop-any)
[502.288424] Starting subtest: invalid-get-prop-any
[502.290940] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[502.386339] [122/129] (565s left) gem_mmap_gtt (basic-read)
[502.446157] Subtest basic-read: SKIP (0.000s)
[502.506177] [123/129] (565s left) perf (global-sseu-config)
[502.616143] Starting subtest: global-sseu-config
[502.621543] Subtest global-sseu-config: SKIP (0.000s)
[502.654807] [124/129] (565s left) kms_psr (fbc-pr-no-drrs)
[502.763129] Starting subtest: fbc-pr-no-drrs
[502.768313] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[502.829814] [125/129] (565s left) kms_flip (blocking-wf_vblank)
[502.939117] Starting subtest: blocking-wf_vblank
[502.941544] Starting dynamic subtest: A-eDP1
[515.481566] Dynamic subtest A-eDP1: FAIL (11.972s)
[515.490895] Starting dynamic subtest: B-eDP1
[523.919454] Dynamic subtest B-eDP1: SUCCESS (8.937s)
[523.935559] Starting dynamic subtest: C-eDP1
[532.831991] Dynamic subtest C-eDP1: SUCCESS (8.907s)
[532.842133] Starting dynamic subtest: D-eDP1
[541.761555] Dynamic subtest D-eDP1: SUCCESS (8.925s)
[541.763887] Subtest blocking-wf_vblank: FAIL (38.752s)
[542.973646] [126/129] (525s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[543.074013] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[543.079097] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[543.160886] [127/129] (524s left) kms_rotation_crc (primary-rotation-270)
[543.261920] Starting subtest: primary-rotation-270
[543.267027] Subtest primary-rotation-270: SKIP (0.001s)
[543.334310] [128/129] (524s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[543.446509] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[548.955593] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (5.511s)
[549.077549] [129/129] (519s left) gem_exec_fence (basic-busy-all)
[549.154596] Starting subtest: basic-busy-all
[549.264691] Subtest basic-busy-all: SUCCESS (0.111s)
[550.956821] Closing watchdogs
Done.