[58.778563] Initializing watchdogs
[58.778977]   /dev/watchdog0
[58.812301] [001/141] (960s left) gen7_exec_parse (basic-offset)
[59.272161] Subtest basic-offset: SKIP (0.000s)
[59.395222] [002/141] (959s left) kms_plane_multiple (tiling-x)
[59.910799] Starting subtest: tiling-x
[59.913438] Starting dynamic subtest: pipe-A-eDP-1
[64.476401] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.561s)
[64.511782] Starting dynamic subtest: pipe-B-eDP-1
[69.862655] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.386s)
[69.893177] Starting dynamic subtest: pipe-C-eDP-1
[75.920182] Dynamic subtest pipe-C-eDP-1: SUCCESS (6.052s)
[75.959895] Starting dynamic subtest: pipe-D-eDP-1
[81.366365] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.440s)
[81.368521] Subtest tiling-x: SUCCESS (21.460s)
[82.304768] [003/141] (937s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_mtl_rc_ccs)
[83.252932] Starting subtest: pipe-A-crc-primary-basic-4_tiled_mtl_rc_ccs
[84.940154] Subtest pipe-A-crc-primary-basic-4_tiled_mtl_rc_ccs: SUCCESS (1.687s)
[86.808435] [004/141] (932s left) kms_addfb_basic (bo-too-small)
[87.299707] Starting subtest: bo-too-small
[87.302259] Subtest bo-too-small: SUCCESS (0.001s)
[87.442612] [005/141] (932s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_gen12_mc_ccs)
[88.827362] Starting subtest: pipe-C-crc-primary-basic-y_tiled_gen12_mc_ccs
[88.832108] Subtest pipe-C-crc-primary-basic-y_tiled_gen12_mc_ccs: SKIP (0.002s)
[89.800462] [006/141] (929s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt)
[90.300216] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt
[90.304881] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[90.445901] [007/141] (929s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[90.946312] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[90.950801] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[91.096375] [008/141] (928s left) gem_exec_reloc (basic-gtt-read-active)
[91.488910] Subtest basic-gtt-read-active: SKIP (0.000s)
[91.603529] [009/141] (928s left) gem_exec_reloc (basic-gtt-read-noreloc)
[91.997705] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[92.120161] [010/141] (927s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_dg2_rc_ccs)
[93.312367] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs
[93.316653] Subtest pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.002s)
[94.524230] [011/141] (925s left) kms_rotation_crc (bad-tiling)
[94.990187] Starting subtest: bad-tiling
[94.998322] Subtest bad-tiling: SKIP (0.006s)
[95.127070] [012/141] (924s left) kms_lease (lease_get)
[95.600151] Starting subtest: lease_get
[95.605136] Starting dynamic subtest: pipe-A-eDP-1
[95.610149] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[95.638361] Starting dynamic subtest: pipe-B-eDP-1
[95.641138] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[95.672416] Starting dynamic subtest: pipe-C-eDP-1
[95.675313] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s)
[95.707812] Starting dynamic subtest: pipe-D-eDP-1
[95.710242] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[95.712928] Subtest lease_get: SUCCESS (0.038s)
[95.799113] [013/141] (924s left) gem_ctx_isolation (preservation)
[96.221893] Starting subtest: preservation
[96.224819] Starting dynamic subtest: rcs0
[96.772285] Dynamic subtest rcs0: SUCCESS (0.548s)
[96.806203] Starting dynamic subtest: bcs0
[97.313248] Dynamic subtest bcs0: SUCCESS (0.539s)
[97.346746] Starting dynamic subtest: vcs0
[97.936459] Dynamic subtest vcs0: SUCCESS (0.622s)
[97.968641] Starting dynamic subtest: vcs1
[99.094183] Dynamic subtest vcs1: SUCCESS (1.156s)
[99.124159] Starting dynamic subtest: vecs0
[101.084786] Dynamic subtest vecs0: SUCCESS (1.989s)
[101.114183] Starting dynamic subtest: ccs0
[103.106121] Dynamic subtest ccs0: SUCCESS (2.021s)
[103.108431] Subtest preservation: SUCCESS (6.884s)
[103.444802] [014/141] (916s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[103.962288] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[115.649218] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (11.686s)
[115.837710] [015/141] (904s left) kms_vblank (pipe-b-ts-continuation-dpms-rpm)
[116.332960] Starting subtest: pipe-B-ts-continuation-dpms-rpm
[120.189309] Subtest pipe-B-ts-continuation-dpms-rpm: SUCCESS (3.859s)
[121.159533] [016/141] (899s left) gem_userptr_blits (unsync-unmap-after-close)
[121.560430] Subtest unsync-unmap-after-close: SKIP (0.000s)
[121.833328] [017/141] (898s left) gen3_render_mixed_blits
[122.307287] [018/141] (898s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[122.855840] Starting subtest: yf-tiled-32bpp-rotate-90
[122.860341] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[123.007449] [019/141] (897s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[123.550284] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[128.061901] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (4.509s)
[128.657292] [020/141] (891s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[130.834572] Starting subtest: syncobj-backward-timeline-chain-engines
[131.203901] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.368s)
[131.621964] [021/141] (889s left) gem_mmap_gtt (coherency)
[132.018042] Subtest coherency: SKIP (0.000s)
[132.128607] [022/141] (888s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[132.637061] Starting subtest: fbc-rgb565-draw-pwrite
[145.361328] Subtest fbc-rgb565-draw-pwrite: SUCCESS (12.726s)
[145.569449] [023/141] (875s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[145.839922] Starting subtest: yf-tiled-to-vebox-yf-tiled
[145.843326] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[146.102687] [024/141] (874s left) kms_flip (bo-too-big-interruptible)
[146.535899] Starting subtest: bo-too-big-interruptible
[146.568215] Starting dynamic subtest: A-eDP1
[149.157660] Dynamic subtest A-eDP1: SUCCESS (2.589s)
[149.189679] Starting dynamic subtest: B-eDP1
[151.459782] Dynamic subtest B-eDP1: SUCCESS (2.298s)
[151.488816] Starting dynamic subtest: C-eDP1
[153.737753] Dynamic subtest C-eDP1: SUCCESS (2.273s)
[153.768853] Starting dynamic subtest: D-eDP1
[156.008408] Dynamic subtest D-eDP1: SUCCESS (2.267s)
[156.035697] Subtest bo-too-big-interruptible: SUCCESS (9.499s)
[157.582060] [025/141] (863s left) perf_pmu (semaphore-busy)
[157.986669] Starting subtest: semaphore-busy
[157.989251] Starting dynamic subtest: rcs0
[159.660179] Dynamic subtest rcs0: SUCCESS (1.668s)
[159.696343] Starting dynamic subtest: bcs0
[161.312683] Dynamic subtest bcs0: SUCCESS (1.648s)
[161.350191] Starting dynamic subtest: vcs0
[165.072569] Dynamic subtest vcs0: SUCCESS (3.755s)
[165.109997] Starting dynamic subtest: vcs1
[171.086688] Dynamic subtest vcs1: SUCCESS (6.012s)
[171.124172] Starting dynamic subtest: vecs0
[177.038189] Dynamic subtest vecs0: SUCCESS (5.948s)
[177.072860] Starting dynamic subtest: ccs0
[180.188461] Dynamic subtest ccs0: SUCCESS (3.147s)
[180.190787] Subtest semaphore-busy: SUCCESS (22.198s)
[180.398412] [026/141] (840s left) perf (blocking-parameterized)
[181.374130] Starting subtest: blocking-parameterized
[201.481453] Subtest blocking-parameterized: SUCCESS (20.107s)
[201.580543] [027/141] (819s left) gem_mmap_wc (pf-nonblock)
[201.966633] Subtest pf-nonblock: SKIP (0.000s)
[202.088449] [028/141] (819s left) gem_exec_create (basic)
[202.510769] Starting subtest: basic
[202.512422] Starting dynamic subtest: smem
[206.546796] Dynamic subtest smem: SUCCESS (4.032s)
[206.549653] Subtest basic: SUCCESS (4.036s)
[206.838875] [029/141] (814s left) syncobj_timeline (invalid-query-one-illegal-handle)
[207.221406] Starting subtest: invalid-query-one-illegal-handle
[207.223646] Subtest invalid-query-one-illegal-handle: SUCCESS (0.002s)
[207.396430] [030/141] (813s left) feature_discovery (display)
[207.909363] Starting subtest: display
[207.911582] Subtest display: SUCCESS (0.000s)
[208.066310] [031/141] (813s left) gem_create (create-invalid-size)
[208.438087] Starting subtest: create-invalid-size
[208.440337] Subtest create-invalid-size: SUCCESS (0.000s)
[208.729832] [032/141] (812s left) gem_lmem_swapping (basic)
[209.123302] Subtest basic: SKIP (0.000s)
[209.229841] [033/141] (812s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[209.747692] Starting subtest: psr-rgb565-draw-pwrite
[226.280737] Subtest psr-rgb565-draw-pwrite: SUCCESS (16.532s)
[226.528462] [034/141] (795s left) syncobj_wait (single-wait-submitted)
[226.906563] Starting subtest: single-wait-submitted
[227.012242] Subtest single-wait-submitted: SUCCESS (0.105s)
[227.155105] [035/141] (794s left) kms_psr (psr2_suspend)
[227.645284] Starting subtest: psr2_suspend
[249.362187] Subtest psr2_suspend: SUCCESS (21.711s)
[254.298445] [036/141] (771s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[254.801160] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[254.805602] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[254.969657] [037/141] (770s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[255.452389] Starting subtest: compare-crc-sanitycheck-xr24
[255.463469] Starting dynamic subtest: pipe-A-eDP-1
[256.620326] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.158s)
[256.658506] Starting dynamic subtest: pipe-B-eDP-1
[258.486657] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.858s)
[258.530146] Starting dynamic subtest: pipe-C-eDP-1
[260.609971] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.114s)
[260.655722] Starting dynamic subtest: pipe-D-eDP-1
[263.094098] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.474s)
[263.096414] Subtest compare-crc-sanitycheck-xr24: SUCCESS (7.644s)
[264.044491] [038/141] (761s left) kms_cursor_edge_walk (64x64-right-edge)
[264.536539] Starting subtest: 64x64-right-edge
[264.542961] Starting dynamic subtest: pipe-A-eDP-1
[268.522194] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.977s)
[268.571981] Starting dynamic subtest: pipe-D-eDP-1
[272.004328] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.473s)
[272.006634] Subtest 64x64-right-edge: SUCCESS (7.472s)
[272.959851] [039/141] (753s left) prime_vgem (sync)
[273.385962] Starting subtest: sync
[273.388918] Starting dynamic subtest: rcs0
[273.468508] Dynamic subtest rcs0: SUCCESS (0.080s)
[273.533461] Starting dynamic subtest: bcs0
[273.540774] Dynamic subtest bcs0: SUCCESS (0.065s)
[273.602792] Starting dynamic subtest: vcs0
[273.605407] Dynamic subtest vcs0: SUCCESS (0.062s)
[273.667453] Starting dynamic subtest: vcs1
[273.670193] Dynamic subtest vcs1: SUCCESS (0.048s)
[273.742846] Starting dynamic subtest: vecs0
[273.745698] Dynamic subtest vecs0: SUCCESS (0.043s)
[273.791730] Starting dynamic subtest: ccs0
[273.794259] Dynamic subtest ccs0: SUCCESS (0.043s)
[273.796630] Subtest sync: SUCCESS (0.364s)
[273.949317] [040/141] (752s left) syncobj_timeline (transfer-timeline-point)
[274.330475] Starting subtest: transfer-timeline-point
[274.333088] Subtest transfer-timeline-point: SUCCESS (0.003s)
[274.477565] [041/141] (751s left) gem_userptr_blits (relocations)
[274.874166] Starting subtest: relocations
[274.878843] Subtest relocations: SKIP (0.003s)
[275.165111] [042/141] (751s left) gem_reg_read (timestamp-moving)
[275.544957] Starting subtest: timestamp-moving
[276.546639] Subtest timestamp-moving: SUCCESS (1.001s)
[276.724434] [043/141] (749s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_rc_ccs)
[278.411324] Starting subtest: pipe-D-crc-primary-rotation-180-y_tiled_gen12_rc_ccs
[278.416292] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SKIP (0.002s)
[279.129980] [044/141] (747s left) kms_ccs (pipe-a-bad-aux-stride-y_tiled_ccs)
[280.196150] Starting subtest: pipe-A-bad-aux-stride-y_tiled_ccs
[280.200553] Subtest pipe-A-bad-aux-stride-y_tiled_ccs: SKIP (0.000s)
[281.561589] [045/141] (744s left) i915_hwmon (hwmon-read)
[281.934839] Subtest hwmon-read: SKIP (0.000s)
[282.061708] [046/141] (744s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[282.568583] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[288.259135] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (5.694s)
[288.530904] [047/141] (738s left) gen9_exec_parse (bb-start-far)
[288.931120] Subtest bb-start-far: SKIP (0.000s)
[289.057386] [048/141] (737s left) gem_ctx_persistence (engines-cleanup)
[289.463234] Starting subtest: engines-cleanup
[289.465327] Starting dynamic subtest: rcs0
[289.548113] Dynamic subtest rcs0: SUCCESS (0.082s)
[289.596564] Starting dynamic subtest: bcs0
[289.598658] Dynamic subtest bcs0: SUCCESS (0.042s)
[289.645966] Starting dynamic subtest: vcs0
[289.648307] Dynamic subtest vcs0: SUCCESS (0.029s)
[289.693534] Starting dynamic subtest: vcs1
[289.695775] Dynamic subtest vcs1: SUCCESS (0.062s)
[289.743840] Starting dynamic subtest: vecs0
[289.745920] Dynamic subtest vecs0: SUCCESS (0.032s)
[289.788771] Starting dynamic subtest: ccs0
[289.790920] Dynamic subtest ccs0: SUCCESS (0.048s)
[289.793310] Subtest engines-cleanup: SUCCESS (0.322s)
[289.961540] [049/141] (736s left) kms_plane_scaling (intel-max-src-size)
[290.438456] Starting subtest: intel-max-src-size
[290.442278] Subtest intel-max-src-size: SKIP (0.000s)
[290.615214] [050/141] (736s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[293.531818] Subtest verify-pxp-execution-after-suspend-resume: SKIP (0.000s)
[293.701704] [051/141] (733s left) gem_exec_schedule (implicit-boths)
[294.154652] Starting subtest: implicit-boths
[294.156700] Starting dynamic subtest: rcs0
[294.666154] Dynamic subtest rcs0: SUCCESS (0.507s)
[294.716191] Starting dynamic subtest: bcs0
[295.078738] Dynamic subtest bcs0: SUCCESS (0.408s)
[295.121302] Starting dynamic subtest: vcs0
[295.405432] Dynamic subtest vcs0: SUCCESS (0.323s)
[295.448245] Starting dynamic subtest: vcs1
[295.747248] Dynamic subtest vcs1: SUCCESS (0.337s)
[295.791916] Starting dynamic subtest: vecs0
[296.034213] Dynamic subtest vecs0: SUCCESS (0.283s)
[296.077859] Starting dynamic subtest: ccs0
[296.442910] Dynamic subtest ccs0: SUCCESS (0.404s)
[296.446056] Subtest implicit-boths: SUCCESS (2.287s)
[297.799613] [052/141] (729s left) kms_vblank (pipe-a-query-busy)
[298.310743] Starting subtest: pipe-A-query-busy
[300.370626] Subtest pipe-A-query-busy: SUCCESS (2.059s)
[301.316776] [053/141] (725s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[301.705888] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[301.708653] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[301.858819] [054/141] (725s left) gem_eio (context-create)
[303.785151] Starting subtest: context-create
[306.775359] Subtest context-create: SUCCESS (2.987s)
[308.605546] [055/141] (718s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[309.124134] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[319.538146] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (10.412s)
[319.821571] [056/141] (707s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_gen12_rc_ccs_cc)
[321.205062] Starting subtest: pipe-C-bad-pixel-format-y_tiled_gen12_rc_ccs_cc
[321.209403] Subtest pipe-C-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[322.269344] [057/141] (705s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[322.857225] Starting subtest: cursorA-vs-flipA-atomic-transitions
[334.816711] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.961s)
[335.778625] [058/141] (691s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_mc_ccs)
[337.403137] Starting subtest: pipe-D-bad-pixel-format-y_tiled_gen12_mc_ccs
[337.407291] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[338.223626] [059/141] (689s left) kms_chamelium_hpd (vga-hpd-fast)
[339.124588] Subtest vga-hpd-fast: SKIP (0.000s)
[339.997488] [060/141] (687s left) kms_prop_blob (basic)
[340.340393] Starting subtest: basic
[340.342770] Subtest basic: SUCCESS (0.000s)
[340.495660] [061/141] (687s left) kms_ccs (pipe-d-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc)
[342.215443] Starting subtest: pipe-D-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc
[342.217264] Subtest pipe-D-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.002s)
[342.884456] [062/141] (685s left) vc4/vc4_tiling (get-bad-handle)
[343.374845] Subtest get-bad-handle: SKIP (0.000s)
[343.512338] [063/141] (684s left) kms_chamelium_color (ctm-0-25)
[343.988819] Subtest ctm-0-25: SKIP (0.000s)
[344.110320] [064/141] (684s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[344.606615] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[344.610819] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[344.782845] [065/141] (683s left) gem_exec_schedule (u-fairslice-all)
[345.219355] Starting subtest: u-fairslice-all
[347.466834] Subtest u-fairslice-all: SUCCESS (2.248s)
[348.728684] [066/141] (679s left) perf_pmu (all-busy-idle-check-all)
[349.121242] Starting subtest: all-busy-idle-check-all
[350.534077] Subtest all-busy-idle-check-all: SUCCESS (1.415s)
[350.722608] [067/141] (677s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[351.233874] Starting subtest: addfb25-y-tiled-small-legacy
[351.237714] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[351.412257] [068/141] (677s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[351.919940] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[351.923718] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[352.098600] [069/141] (676s left) dmabuf_sync_file (export-multiwait)
[352.476048] Starting subtest: export-multiwait
[352.478118] Subtest export-multiwait: SUCCESS (0.002s)
[352.607569] [070/141] (676s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[353.082462] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[353.091907] Starting dynamic subtest: pipe-A-default-mode
[353.507294] Dynamic subtest pipe-A-default-mode: SKIP (0.410s)
[353.510865] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.424s)
[354.449845] [071/141] (674s left) gem_userptr_blits (process-exit)
[354.913527] Starting subtest: process-exit
[354.986093] Subtest process-exit: SUCCESS (0.072s)
[355.232436] [072/141] (673s left) kms_vblank (pipe-c-query-forked-hang)
[355.720163] Starting subtest: pipe-C-query-forked-hang
[371.849725] Subtest pipe-C-query-forked-hang: SUCCESS (16.130s)
[372.804922] [073/141] (656s left) vc4/vc4_dmabuf_poll (poll-read-waits-until-write-done)
[373.277116] Subtest poll-read-waits-until-write-done: SKIP (0.000s)
[373.417681] [074/141] (655s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[373.917128] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[373.921684] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[374.102768] [075/141] (655s left) gem_mmap_wc (read)
[374.469246] Subtest read: SKIP (0.000s)
[374.594700] [076/141] (654s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[375.680121] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[375.695115] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.013s)
[376.998462] [077/141] (652s left) kms_atomic (crtc-invalid-params-fence)
[377.800651] Starting subtest: crtc-invalid-params-fence
[378.274610] Subtest crtc-invalid-params-fence: SUCCESS (0.474s)
[379.632809] [078/141] (649s left) gem_render_copy_redux (flink-interruptible)
[380.089303] Starting subtest: flink-interruptible
[386.914153] Subtest flink-interruptible: SUCCESS (6.824s)
[387.113063] [079/141] (642s left) gem_tiled_wb
[387.622632] [080/141] (641s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[388.145129] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[388.149675] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[388.337652] [081/141] (641s left) i915_pm_rc6_residency (rc6-fence)
[388.714670] Starting subtest: rc6-fence
[412.599142] Subtest rc6-fence: SUCCESS (23.888s)
[414.032508] [082/141] (615s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[414.543645] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[414.548349] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[414.733117] [083/141] (615s left) kms_draw_crc (draw-method-render)
[415.223253] Starting subtest: draw-method-render
[415.225612] Starting dynamic subtest: xrgb8888-untiled
[416.007675] Dynamic subtest xrgb8888-untiled: SUCCESS (0.782s)
[416.060205] Starting dynamic subtest: rgb565-untiled
[416.664562] Dynamic subtest rgb565-untiled: SUCCESS (0.651s)
[416.717230] Starting dynamic subtest: xrgb2101010-untiled
[417.441320] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.774s)
[417.493128] Starting dynamic subtest: xrgb8888-xtiled
[417.840494] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.395s)
[417.893620] Starting dynamic subtest: rgb565-xtiled
[418.196807] Dynamic subtest rgb565-xtiled: SUCCESS (0.352s)
[418.250137] Starting dynamic subtest: xrgb2101010-xtiled
[418.598118] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.397s)
[418.655872] Starting dynamic subtest: xrgb8888-4tiled
[419.030991] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.423s)
[419.077722] Starting dynamic subtest: rgb565-4tiled
[419.430858] Dynamic subtest rgb565-4tiled: SUCCESS (0.395s)
[419.485871] Starting dynamic subtest: xrgb2101010-4tiled
[419.831520] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.396s)
[419.834459] Subtest draw-method-render: SUCCESS (4.610s)
[420.028851] [084/141] (609s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc)
[421.585373] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc
[424.710503] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc: SUCCESS (3.123s)
[426.051318] [085/141] (603s left) v3d/v3d_submit_cl (bad-perfmon)
[426.535892] Subtest bad-perfmon: SKIP (0.000s)
[426.670198] [086/141] (603s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[427.495790] Starting subtest: cursor-rapid-movement-64x21
[427.526637] Starting dynamic subtest: pipe-A-eDP-1
[428.834328] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.307s)
[429.016225] Starting dynamic subtest: pipe-D-eDP-1
[431.697976] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.701s)
[431.700770] Subtest cursor-rapid-movement-64x21: SUCCESS (4.207s)
[432.910678] [087/141] (597s left) kms_cursor_crc (cursor-onscreen-512x170)
[434.194291] Starting subtest: cursor-onscreen-512x170
[434.203356] Subtest cursor-onscreen-512x170: SKIP (0.007s)
[434.551740] [088/141] (595s left) i915_query (query-regions-sanity-check)
[434.933727] Starting subtest: query-regions-sanity-check
[435.006100] Subtest query-regions-sanity-check: SUCCESS (0.075s)
[435.174315] [089/141] (595s left) i915_pm_rpm (reg-read-ioctl)
[437.712348] Starting subtest: reg-read-ioctl
[445.132586] Subtest reg-read-ioctl: SUCCESS (7.420s)
[446.079323] [090/141] (584s left) gem_mmap_gtt (flink-race)
[446.448370] Subtest flink-race: SKIP (0.000s)
[446.584741] [091/141] (583s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-submitted-sign
[446.964060] Starting subtest: invalid-multi-wait-all-available-unsubmitted-submitted-signaled
[446.973706] Subtest invalid-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.005s)
[447.127368] [092/141] (583s left) kms_vblank (pipe-b-query-busy-hang)
[447.604726] Starting subtest: pipe-B-query-busy-hang
[462.865742] Subtest pipe-B-query-busy-hang: SUCCESS (15.261s)
[463.830321] [093/141] (566s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[464.374637] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[464.379126] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[464.557393] [094/141] (566s left) kms_psr (psr2_cursor_plane_onoff)
[465.041428] Starting subtest: psr2_cursor_plane_onoff
[468.245238] Subtest psr2_cursor_plane_onoff: SUCCESS (3.199s)
[469.179153] [095/141] (561s left) kms_vblank (pipe-d-query-forked-hang)
[469.679080] Starting subtest: pipe-D-query-forked-hang
[485.805455] Subtest pipe-D-query-forked-hang: SUCCESS (16.126s)
[486.763901] [096/141] (544s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[487.144730] Starting subtest: invalid-single-wait-all-unsubmitted
[487.147794] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.001s)
[487.308571] [097/141] (543s left) gem_exec_schedule (lateslice)
[487.743503] Starting subtest: lateslice
[487.745804] Starting dynamic subtest: rcs0
[487.794473] Dynamic subtest rcs0: SUCCESS (0.049s)
[487.850743] Starting dynamic subtest: bcs0
[487.853625] Dynamic subtest bcs0: SUCCESS (0.043s)
[487.879426] Starting dynamic subtest: vcs0
[487.893502] Dynamic subtest vcs0: SUCCESS (0.047s)
[487.949564] Starting dynamic subtest: vcs1
[487.951731] Dynamic subtest vcs1: SUCCESS (0.041s)
[488.007245] Starting dynamic subtest: vecs0
[488.009421] Dynamic subtest vecs0: SUCCESS (0.045s)
[488.060492] Starting dynamic subtest: ccs0
[488.062727] Dynamic subtest ccs0: SUCCESS (0.045s)
[488.064949] Subtest lateslice: SUCCESS (0.295s)
[489.725975] [098/141] (541s left) sw_sync (sync_merge_same)
[490.104685] Starting subtest: sync_merge_same
[490.107567] Subtest sync_merge_same: SUCCESS (0.001s)
[490.270575] [099/141] (541s left) gem_exec_suspend (basic-s3-devices)
[490.704758] Starting subtest: basic-S3-devices
[490.706452] Starting dynamic subtest: smem
[508.550885] Dynamic subtest smem: SUCCESS (17.842s)
[508.553688] Subtest basic-S3-devices: SUCCESS (17.845s)
[508.867360] [100/141] (522s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[509.466685] Starting subtest: y-tiled-64bpp-rotate-270
[509.472079] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[509.656774] [101/141] (521s left) kms_flip (absolute-wf_vblank)
[510.061142] Starting subtest: absolute-wf_vblank
[510.092472] Starting dynamic subtest: A-eDP1
[519.414293] Dynamic subtest A-eDP1: SUCCESS (9.325s)
[519.466485] Starting dynamic subtest: B-eDP1
[528.558764] Dynamic subtest B-eDP1: SUCCESS (9.139s)
[528.605586] Starting dynamic subtest: C-eDP1
[537.715112] Dynamic subtest C-eDP1: SUCCESS (9.151s)
[537.760208] Starting dynamic subtest: D-eDP1
[546.867390] Dynamic subtest D-eDP1: SUCCESS (9.148s)
[546.892283] Subtest absolute-wf_vblank: SUCCESS (36.835s)
[548.512875] [102/141] (483s left) kms_vblank (pipe-b-ts-continuation-modeset-rpm)
[549.002671] Starting subtest: pipe-B-ts-continuation-modeset-rpm
[553.119205] Subtest pipe-B-ts-continuation-modeset-rpm: SUCCESS (4.113s)
[554.087778] [103/141] (477s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[554.589315] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[554.593588] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[554.770100] [104/141] (476s left) kms_ccs (pipe-b-bad-aux-stride-4_tiled_mtl_mc_ccs)
[556.038639] Starting subtest: pipe-B-bad-aux-stride-4_tiled_mtl_mc_ccs
[556.552688] Subtest pipe-B-bad-aux-stride-4_tiled_mtl_mc_ccs: SUCCESS (0.518s)
[557.645155] [105/141] (474s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc)
[558.925173] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc
[558.929910] Subtest pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[560.086909] [106/141] (471s left) kms_plane_scaling (planes-upscale-20x20)
[560.573344] Starting subtest: planes-upscale-20x20
[560.582712] Starting dynamic subtest: pipe-A-eDP-1
[560.762622] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.184s)
[560.822650] Starting dynamic subtest: pipe-B-eDP-1
[562.208389] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.435s)
[562.268166] Starting dynamic subtest: pipe-C-eDP-1
[563.667534] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.448s)
[563.732637] Starting dynamic subtest: pipe-D-eDP-1
[565.150299] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.471s)
[565.152302] Subtest planes-upscale-20x20: SUCCESS (4.583s)
[566.679600] [107/141] (465s left) gem_softpin (full)
[567.086531] Starting subtest: full
[567.137431] Subtest full: SUCCESS (0.050s)
[567.339556] [108/141] (464s left) kms_getfb (getfb2-handle-not-fb)
[567.729858] Starting subtest: getfb2-handle-not-fb
[567.842079] Subtest getfb2-handle-not-fb: SUCCESS (0.111s)
[568.029462] [109/141] (464s left) perf_pmu (busy-start)
[568.426127] Starting subtest: busy-start
[568.432660] Starting dynamic subtest: rcs0
[570.990752] Dynamic subtest rcs0: SUCCESS (2.561s)
[571.044301] Starting dynamic subtest: bcs0
[573.546614] Dynamic subtest bcs0: SUCCESS (2.552s)
[573.600479] Starting dynamic subtest: vcs0
[577.552684] Dynamic subtest vcs0: SUCCESS (4.000s)
[577.601626] Starting dynamic subtest: vcs1
[581.519569] Dynamic subtest vcs1: SUCCESS (3.963s)
[581.569050] Starting dynamic subtest: vecs0
[585.552546] Dynamic subtest vecs0: SUCCESS (4.027s)
[585.602388] Starting dynamic subtest: ccs0
[588.109085] Dynamic subtest ccs0: SUCCESS (2.554s)
[588.112474] Subtest busy-start: SUCCESS (19.685s)
[588.325093] [110/141] (443s left) syncobj_basic (test-valid-cycle)
[588.704993] Starting subtest: test-valid-cycle
[588.707062] Subtest test-valid-cycle: SUCCESS (0.000s)
[588.889493] [111/141] (443s left) gem_workarounds (suspend-resume)
[589.359751] Starting subtest: suspend-resume
[606.502840] Subtest suspend-resume: SUCCESS (17.144s)
[606.702540] [112/141] (425s left) api_intel_bb (object-noreloc-purge-cache-simple)
[607.076338] Starting subtest: object-noreloc-purge-cache-simple
[607.096222] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.020s)
[607.285178] [113/141] (425s left) kms_psr (sprite_blt)
[607.766187] Starting subtest: sprite_blt
[610.912377] Subtest sprite_blt: SUCCESS (3.146s)
[611.866297] [114/141] (420s left) syncobj_timeline (multi-wait-signaled)
[612.245953] Starting subtest: multi-wait-signaled
[612.252242] Subtest multi-wait-signaled: SUCCESS (0.003s)
[612.401844] [115/141] (420s left) gem_exec_capture (capture-invisible)
[612.816424] Starting subtest: capture-invisible
[612.818420] Starting dynamic subtest: smem0
[612.821890] Dynamic subtest smem0: SKIP (0.000s)
[612.825498] Subtest capture-invisible: SKIP (0.005s)
[612.998878] [116/141] (419s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[613.369885] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[613.371881] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[613.514569] [117/141] (419s left) v3d/v3d_perfmon (get-values-invalid-pad)
[613.995165] Subtest get-values-invalid-pad: SKIP (0.000s)
[614.136540] [118/141] (418s left) kms_flip (2x-flip-vs-panning-vs-hang)
[614.526691] Starting subtest: 2x-flip-vs-panning-vs-hang
[614.694078] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.165s)
[614.903893] [119/141] (418s left) dmabuf_sync_file (import-basic)
[615.272969] Starting subtest: import-basic
[615.284357] Subtest import-basic: SUCCESS (0.011s)
[615.426082] [120/141] (417s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[615.939671] Starting subtest: psr-1p-primscrn-spr-indfb-move
[627.208184] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (11.269s)
[627.483176] [121/141] (405s left) gem_exec_fair (basic-none-vip)
[627.888675] Subtest basic-none-vip: SKIP (0.000s)
[628.040496] [122/141] (405s left) sysfs_preempt_timeout (invalid)
[628.446339] Starting subtest: invalid
[628.452580] Starting dynamic subtest: vecs0
[628.454797] Dynamic subtest vecs0: SUCCESS (0.002s)
[628.512924] Starting dynamic subtest: ccs0
[628.515358] Dynamic subtest ccs0: SUCCESS (0.003s)
[628.566877] Starting dynamic subtest: vcs0
[628.569580] Dynamic subtest vcs0: SUCCESS (0.002s)
[628.618139] Starting dynamic subtest: bcs0
[628.620584] Dynamic subtest bcs0: SUCCESS (0.002s)
[628.669436] Starting dynamic subtest: rcs0
[628.671877] Dynamic subtest rcs0: SUCCESS (0.002s)
[628.720281] Starting dynamic subtest: vcs1
[628.722648] Dynamic subtest vcs1: SUCCESS (0.002s)
[628.725192] Subtest invalid: SUCCESS (0.044s)
[628.791569] [123/141] (404s left) gem_ctx_param (invalid-param-set)
[629.166404] Starting subtest: invalid-param-set
[629.168296] Subtest invalid-param-set: SUCCESS (0.000s)
[629.318058] [124/141] (404s left) kms_content_protection (uevent)
[630.019736] Starting subtest: uevent
[634.130963] Subtest uevent: SKIP (4.110s)
[635.561557] [125/141] (398s left) kms_ccs (pipe-c-bad-aux-stride-4_tiled_mtl_rc_ccs_cc)
[637.094895] Starting subtest: pipe-C-bad-aux-stride-4_tiled_mtl_rc_ccs_cc
[637.102434] Subtest pipe-C-bad-aux-stride-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.005s)
[637.962104] [126/141] (395s left) gem_exec_whisper (basic-contexts-all)
[638.406131] Starting subtest: basic-contexts-all
[660.108527] Subtest basic-contexts-all: FAIL (21.693s)
[661.609674] [127/141] (372s left) gem_close_race (multigpu-basic-threads)
[662.059542] Starting subtest: multigpu-basic-threads
[662.063559] Subtest multigpu-basic-threads: SKIP (0.000s)
[662.400418] [128/141] (371s left) perf (short-reads)
[663.083714] Starting subtest: short-reads
[663.116380] Subtest short-reads: SUCCESS (0.034s)
[663.245183] [129/141] (370s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[664.110520] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[664.989556] [130/141] (369s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_gen12_mc_ccs)
[665.883377] Starting subtest: pipe-A-bad-rotation-90-y_tiled_gen12_mc_ccs
[665.887947] Subtest pipe-A-bad-rotation-90-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[667.424909] [131/141] (366s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[667.906127] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[667.914453] Starting dynamic subtest: pipe-A-default-mode
[670.285341] Dynamic subtest pipe-A-default-mode: SKIP (2.366s)
[670.289855] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (2.380s)
[670.580322] [132/141] (363s left) prime_vgem (fence-read-hang)
[671.021579] Subtest fence-read-hang: SKIP (0.000s)
[671.176361] [133/141] (363s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[671.694151] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[677.369169] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (5.677s)
[677.647644] [134/141] (356s left) gem_exec_balancer (fairslice)
[678.084102] Starting subtest: fairslice
[686.855943] Subtest fairslice: SUCCESS (8.773s)
[687.901729] [135/141] (346s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_mtl_rc_ccs)
[689.397781] Starting subtest: pipe-C-random-ccs-data-4_tiled_mtl_rc_ccs
[690.586767] Subtest pipe-C-random-ccs-data-4_tiled_mtl_rc_ccs: SUCCESS (1.189s)
[691.923345] [136/141] (342s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[692.435164] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[692.439553] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[692.612757] [137/141] (342s left) gem_userptr_blits (vma-merge)
[693.126191] Starting subtest: vma-merge
[713.634684] Subtest vma-merge: FAIL (20.480s)
[713.795504] [138/141] (320s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[714.360505] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[717.125803] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (2.761s)
[717.462348] [139/141] (317s left) gem_mmap_gtt (fault-concurrent)
[717.832664] Subtest fault-concurrent: SKIP (0.000s)
[717.959678] [140/141] (316s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[718.480249] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[721.446234] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (2.963s)
[721.772245] [141/141] (313s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[722.212251] Starting subtest: stress-mm-invalidate-close-overlap
[724.364784] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.150s)
[724.598875] Closing watchdogs
Done.