[37.929728] Initializing watchdogs
[37.929992]   /dev/watchdog0
[37.965830] [001/142] (960s left) gem_userptr_blits (create-destroy-sync)
[38.316126] Starting subtest: create-destroy-sync
[43.337563] Subtest create-destroy-sync: SUCCESS (5.069s)
[43.499921] [002/142] (955s left) kms_big_fb (linear-64bpp-rotate-0)
[43.880778] Starting subtest: linear-64bpp-rotate-0
[52.626217] Subtest linear-64bpp-rotate-0: SUCCESS (8.786s)
[53.588344] [003/142] (945s left) i915_pm_rps (basic-api)
[53.818934] Starting subtest: basic-api
[53.837892] Subtest basic-api: SUCCESS (0.007s)
[53.966231] [004/142] (944s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[54.339122] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[54.438680] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.027s)
[54.542832] [005/142] (944s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[54.793638] Starting subtest: addfb25-x-tiled-mismatch-legacy
[54.820749] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[54.991648] [006/142] (943s left) kms_vblank (pipe-d-ts-continuation-suspend)
[55.371579] Subtest pipe-D-ts-continuation-suspend: SKIP (0.000s)
[55.571697] [007/142] (943s left) api_intel_bb (intel-bb-blit-x)
[55.817067] Starting subtest: intel-bb-blit-x
[59.167199] Subtest intel-bb-blit-x: SUCCESS (3.208s)
[59.252169] [008/142] (939s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[59.630111] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[59.671868] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[59.752744] [009/142] (939s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_ccs)
[60.239387] Starting subtest: pipe-C-bad-pixel-format-y_tiled_ccs
[60.276681] Subtest pipe-C-bad-pixel-format-y_tiled_ccs: SKIP (0.000s)
[60.634547] [010/142] (938s left) kms_psr (psr2_cursor_plane_onoff)
[60.890701] Subtest psr2_cursor_plane_onoff: SKIP (0.000s)
[60.988970] [011/142] (938s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[61.371686] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[61.409055] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[61.493370] [012/142] (937s left) gem_exec_params (invalid-fence-in)
[61.728227] Starting subtest: invalid-fence-in
[61.749684] Subtest invalid-fence-in: SUCCESS (0.001s)
[61.835504] [013/142] (937s left) kms_chamelium_frames (dp-crc-single)
[62.257393] Subtest dp-crc-single: SKIP (0.000s)
[62.554473] [014/142] (937s left) gem_exec_whisper (basic-queues-forked-all)
[62.829580] Starting subtest: basic-queues-forked-all
[85.896384] Subtest basic-queues-forked-all: SUCCESS (23.089s)
[86.097237] [015/142] (913s left) kms_plane_cursor (primary)
[86.392119] Starting subtest: primary
[86.434492] Starting dynamic subtest: pipe-A-DP-1-size-64
[88.804065] Dynamic subtest pipe-A-DP-1-size-64: SUCCESS (2.410s)
[88.863221] Starting dynamic subtest: pipe-A-DP-1-size-128
[91.253592] Dynamic subtest pipe-A-DP-1-size-128: SUCCESS (2.416s)
[91.307497] Starting dynamic subtest: pipe-A-DP-1-size-256
[93.700964] Dynamic subtest pipe-A-DP-1-size-256: SUCCESS (2.416s)
[93.883847] Starting dynamic subtest: pipe-B-DP-1-size-64
[96.492271] Dynamic subtest pipe-B-DP-1-size-64: SUCCESS (2.648s)
[96.563731] Starting dynamic subtest: pipe-B-DP-1-size-128
[98.945324] Dynamic subtest pipe-B-DP-1-size-128: SUCCESS (2.416s)
[99.009861] Starting dynamic subtest: pipe-B-DP-1-size-256
[101.382484] Dynamic subtest pipe-B-DP-1-size-256: SUCCESS (2.415s)
[101.553389] Starting dynamic subtest: pipe-C-DP-1-size-64
[104.166945] Dynamic subtest pipe-C-DP-1-size-64: SUCCESS (2.652s)
[104.226249] Starting dynamic subtest: pipe-C-DP-1-size-128
[106.619800] Dynamic subtest pipe-C-DP-1-size-128: SUCCESS (2.416s)
[106.680684] Starting dynamic subtest: pipe-C-DP-1-size-256
[109.066985] Dynamic subtest pipe-C-DP-1-size-256: SUCCESS (2.416s)
[109.201043] Subtest primary: SUCCESS (22.788s)
[109.516924] [016/142] (890s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[109.761397] Starting subtest: writes-after-reads-uncached
[129.833686] Subtest writes-after-reads-uncached: SUCCESS (20.091s)
[129.970266] [017/142] (869s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_mc_ccs)
[130.517336] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[130.833329] [018/142] (869s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[131.139429] Starting subtest: cursorB-vs-flipA-atomic-transitions
[131.177721] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.004s)
[131.269859] [019/142] (868s left) v3d/v3d_submit_cl (job-perfmon)
[131.552642] Subtest job-perfmon: SKIP (0.000s)
[131.638106] [020/142] (868s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[131.941200] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[131.961034] Starting dynamic subtest: pipe-A-DP-1
[132.036967] Dynamic subtest pipe-A-DP-1: SUCCESS (0.084s)
[132.080220] Starting dynamic subtest: pipe-B-DP-1
[132.420803] Dynamic subtest pipe-B-DP-1: SUCCESS (0.386s)
[132.465520] Starting dynamic subtest: pipe-C-DP-1
[132.532728] Dynamic subtest pipe-C-DP-1: SKIP (0.096s)
[132.556928] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.574s)
[132.940065] [021/142] (867s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[133.321624] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[133.360793] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[133.450832] [022/142] (866s left) gem_eio (in-flight-suspend)
[139.876847] Starting subtest: in-flight-suspend
[171.217166] Subtest in-flight-suspend: SUCCESS (8.782s)
[176.648768] [023/142] (857s left) gem_exec_schedule (semaphore-resolve)
[177.030917] Starting subtest: semaphore-resolve
[177.049766] Subtest semaphore-resolve: SUCCESS (0.048s)
[177.309060] [024/142] (857s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_dg2_rc_ccs_cc)
[177.736207] Starting subtest: pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs_cc
[177.774195] Subtest pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[178.182450] [025/142] (856s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[178.556510] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[178.597853] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[178.685152] [026/142] (855s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[178.981034] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[179.002539] Starting dynamic subtest: pipe-A-valid-mode
[179.669796] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.663s)
[179.688873] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SUCCESS (0.666s)
[180.037950] [027/142] (854s left) kms_concurrent (pipe-b)
[180.372405] Starting subtest: pipe-B
[180.398775] Starting dynamic subtest: DP-1
[181.205757] Dynamic subtest DP-1: SUCCESS (0.844s)
[181.226935] Subtest pipe-B: SUCCESS (0.848s)
[181.552902] [028/142] (853s left) gem_exec_flush (basic-batch-kernel-default-uc)
[181.828744] Starting subtest: basic-batch-kernel-default-uc
[187.451489] Subtest basic-batch-kernel-default-uc: SUCCESS (5.656s)
[187.664533] [029/142] (847s left) kms_atomic (plane-overlay-legacy)
[188.090515] Starting subtest: plane-overlay-legacy
[188.221117] Subtest plane-overlay-legacy: SUCCESS (0.129s)
[188.667007] [030/142] (846s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[189.003237] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[190.399000] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.418s)
[190.563272] [031/142] (844s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[190.938896] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[190.977214] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[191.067872] [032/142] (843s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_gen12_mc_ccs)
[191.489019] Starting subtest: pipe-B-bad-pixel-format-y_tiled_gen12_mc_ccs
[191.529389] Subtest pipe-B-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[191.943972] [033/142] (843s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_mtl_mc_ccs)
[192.507249] Subtest pipe-D-crc-primary-rotation-180-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[192.832219] [034/142] (842s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[193.208472] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[193.247916] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[193.335814] [035/142] (841s left) gem_exec_fence (basic-await)
[193.706981] Starting subtest: basic-await
[193.727988] Starting dynamic subtest: rcs0
[193.836225] Dynamic subtest rcs0: SUCCESS (0.132s)
[193.880905] Starting dynamic subtest: bcs0
[193.970747] Dynamic subtest bcs0: SUCCESS (0.133s)
[194.023133] Starting dynamic subtest: vcs0
[194.109897] Dynamic subtest vcs0: SUCCESS (0.135s)
[194.157988] Starting dynamic subtest: vecs0
[194.243388] Dynamic subtest vecs0: SUCCESS (0.133s)
[194.262144] Subtest basic-await: SUCCESS (0.540s)
[194.953297] [036/142] (840s left) syncobj_wait (wait-for-submit-snapshot)
[195.189813] Starting subtest: wait-for-submit-snapshot
[195.251932] Subtest wait-for-submit-snapshot: SUCCESS (0.084s)
[195.368143] [037/142] (840s left) gem_exec_parallel (basic)
[195.603839] Starting subtest: basic
[195.622604] Starting dynamic subtest: rcs0
[198.978369] Dynamic subtest rcs0: SUCCESS (3.189s)
[199.019497] Starting dynamic subtest: bcs0
[202.312427] Dynamic subtest bcs0: SUCCESS (3.341s)
[202.353581] Starting dynamic subtest: vcs0
[205.583894] Dynamic subtest vcs0: SUCCESS (3.448s)
[205.625433] Starting dynamic subtest: vecs0
[208.988598] Dynamic subtest vecs0: SUCCESS (3.220s)
[209.009367] Subtest basic: SUCCESS (13.202s)
[209.098740] [038/142] (826s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[209.390775] Starting subtest: short-busy-flip-before-cursor-toggle
[209.430835] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[209.527058] [039/142] (826s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[209.903261] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[209.945364] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[210.035745] [040/142] (825s left) kms_cursor_crc (cursor-onscreen-64x64)
[210.355417] Starting subtest: cursor-onscreen-64x64
[210.376769] Starting dynamic subtest: pipe-A-DP-1
[212.723910] Dynamic subtest pipe-A-DP-1: SUCCESS (2.348s)
[212.792506] Starting dynamic subtest: pipe-C-DP-1
[215.214041] Dynamic subtest pipe-C-DP-1: SUCCESS (2.436s)
[215.235558] Subtest cursor-onscreen-64x64: SUCCESS (4.863s)
[215.600768] [041/142] (820s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[215.982951] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[216.021209] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[216.112803] [042/142] (819s left) fbdev (info)
[216.327975] Starting subtest: info
[216.346855] Subtest info: SUCCESS (0.000s)
[216.453861] [043/142] (819s left) gem_exec_balancer (bonded-sync)
[216.706315] Starting subtest: bonded-sync
[220.635348] Subtest bonded-sync: SUCCESS (3.757s)
[224.604887] [044/142] (811s left) kms_vblank (pipe-b-ts-continuation-dpms-rpm)
[224.905285] Starting subtest: pipe-B-ts-continuation-dpms-rpm
[227.045093] Subtest pipe-B-ts-continuation-dpms-rpm: SUCCESS (2.127s)
[227.501536] [045/142] (808s left) kms_cursor_crc (cursor-sliding-512x170)
[227.817561] Starting subtest: cursor-sliding-512x170
[227.859543] Subtest cursor-sliding-512x170: SKIP (0.003s)
[227.951720] [046/142] (808s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[228.330972] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[228.370631] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[228.459051] [047/142] (807s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_gen12_rc_ccs_cc)
[228.905978] Starting subtest: pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs_cc
[228.946300] Subtest pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.001s)
[229.354161] [048/142] (807s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[229.732168] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[229.769841] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[229.866502] [049/142] (806s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[230.103095] Starting subtest: x-tiled-to-vebox-yf-tiled
[230.145201] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[230.322997] [050/142] (806s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[230.543943] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[230.563003] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s)
[230.657287] [051/142] (806s left) kms_flip (flip-vs-panning)
[230.983720] Starting subtest: flip-vs-panning
[231.002901] Starting dynamic subtest: A-DP1
[241.526445] Dynamic subtest A-DP1: SUCCESS (10.566s)
[241.573358] Starting dynamic subtest: B-DP1
[252.042248] Dynamic subtest B-DP1: SUCCESS (10.521s)
[252.086181] Starting dynamic subtest: C-DP1
[262.585758] Dynamic subtest C-DP1: SUCCESS (10.532s)
[262.613788] Subtest flip-vs-panning: SUCCESS (31.630s)
[263.111135] [052/142] (773s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[263.502869] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[263.556256] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[263.675536] [053/142] (773s left) gem_mmap_gtt (cpuset-basic-small-copy)
[263.941445] Starting subtest: cpuset-basic-small-copy
[270.648179] Subtest cpuset-basic-small-copy: SUCCESS (6.754s)
[270.790111] [054/142] (766s left) kms_psr (dpms)
[271.207423] Subtest dpms: SKIP (0.000s)
[271.306534] [055/142] (765s left) sysfs_timeslice_duration (duration)
[271.539073] Starting subtest: duration
[271.560723] Starting dynamic subtest: vecs0
[271.679528] Dynamic subtest vecs0: SUCCESS (0.090s)
[271.723058] Starting dynamic subtest: vcs0
[271.842267] Dynamic subtest vcs0: SUCCESS (0.082s)
[271.884098] Starting dynamic subtest: bcs0
[272.004335] Dynamic subtest bcs0: SUCCESS (0.095s)
[272.044551] Starting dynamic subtest: rcs0
[272.166447] Dynamic subtest rcs0: SUCCESS (0.098s)
[272.185109] Subtest duration: SUCCESS (0.374s)
[272.280045] [056/142] (765s left) kms_flip (2x-dpms-vs-vblank-race)
[272.602399] Starting subtest: 2x-dpms-vs-vblank-race
[272.641477] Subtest 2x-dpms-vs-vblank-race: SKIP (0.003s)
[272.734574] [057/142] (764s left) gem_exec_balancer (smoke)
[272.972760] Starting subtest: smoke
[276.696239] Subtest smoke: SUCCESS (3.729s)
[280.788632] [058/142] (756s left) kms_properties (connector-properties-legacy)
[281.128010] Starting subtest: connector-properties-legacy
[283.700579] Subtest connector-properties-legacy: SUCCESS (2.539s)
[284.022652] [059/142] (753s left) kms_ccs (pipe-a-bad-rotation-90-yf_tiled_ccs)
[284.436686] Starting subtest: pipe-A-bad-rotation-90-yf_tiled_ccs
[284.875861] Subtest pipe-A-bad-rotation-90-yf_tiled_ccs: SUCCESS (0.450s)
[285.471263] [060/142] (752s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[285.834923] Starting subtest: fbcpsr-tiling-y
[285.875868] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[285.968910] [061/142] (751s left) kms_rotation_crc (bad-tiling)
[286.273644] Starting subtest: bad-tiling
[288.754076] Subtest bad-tiling: SUCCESS (2.463s)
[289.185500] [062/142] (748s left) kms_atomic_transition (plane-all-transition)
[289.495500] Starting subtest: plane-all-transition
[289.517419] Starting dynamic subtest: pipe-A-DP-1
[293.497920] Dynamic subtest pipe-A-DP-1: SUCCESS (3.996s)
[293.640240] Starting dynamic subtest: pipe-B-DP-1
[297.971055] Dynamic subtest pipe-B-DP-1: SUCCESS (4.376s)
[298.112569] Subtest plane-all-transition: SUCCESS (8.605s)
[298.478988] [063/142] (739s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[298.866914] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[298.905113] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[298.999778] [064/142] (739s left) syncobj_timeline (device-submit-unordered)
[299.238891] Starting subtest: device-submit-unordered
[299.257765] Subtest device-submit-unordered: SUCCESS (0.001s)
[299.356200] [065/142] (738s left) kms_universal_plane (universal-plane-pipe-c-sanity)
[299.656611] Starting subtest: universal-plane-pipe-C-sanity
[300.422677] Subtest universal-plane-pipe-C-sanity: SUCCESS (0.744s)
[300.758426] [066/142] (737s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[303.778020] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s)
[303.916745] [067/142] (734s left) gem_softpin (evict-prime)
[304.167394] Starting subtest: evict-prime
[304.192828] Starting dynamic subtest: rcs0
[305.257492] Dynamic subtest rcs0: SUCCESS (1.112s)
[305.320579] Starting dynamic subtest: bcs0
[306.370321] Dynamic subtest bcs0: SUCCESS (1.111s)
[306.425610] Starting dynamic subtest: vcs0
[307.485253] Dynamic subtest vcs0: SUCCESS (1.111s)
[307.544777] Starting dynamic subtest: vecs0
[308.603047] Dynamic subtest vecs0: SUCCESS (1.118s)
[308.664920] Starting dynamic subtest: all
[309.717413] Dynamic subtest all: SUCCESS (1.119s)
[309.738798] Subtest evict-prime: SUCCESS (5.587s)
[309.833626] [068/142] (728s left) kms_plane_alpha_blend (constant-alpha-max)
[310.136460] Starting subtest: constant-alpha-max
[310.455592] Starting dynamic subtest: pipe-A-DP-1
[316.015240] Dynamic subtest pipe-A-DP-1: FAIL (0.541s)
[316.057247] Starting dynamic subtest: pipe-C-DP-1
[321.903583] Dynamic subtest pipe-C-DP-1: FAIL (8.424s)
[321.933893] Subtest constant-alpha-max: FAIL (9.289s)
[322.061765] [069/142] (716s left) v3d/v3d_perfmon (create-perfmon-0)
[322.376869] Subtest create-perfmon-0: SKIP (0.000s)
[322.469252] [070/142] (716s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[322.835976] Starting subtest: 4-tiled-8bpp-rotate-90
[322.874291] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.000s)
[322.967644] [071/142] (715s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[323.209115] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[323.227871] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[323.328035] [072/142] (715s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[323.700209] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[323.741811] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[323.840220] [073/142] (715s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_mtl_mc_ccs)
[324.336722] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_mtl_mc_ccs
[324.380772] Subtest pipe-C-crc-primary-rotation-180-4_tiled_mtl_mc_ccs: SKIP (0.001s)
[324.727814] [074/142] (714s left) gem_lmem_swapping (parallel-random-verify-ccs)
[324.983107] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[325.081460] [075/142] (714s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[325.383765] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[325.404151] Starting dynamic subtest: pipe-A-DP-1
[328.048703] Dynamic subtest pipe-A-DP-1: SUCCESS (2.652s)
[328.090869] Starting dynamic subtest: pipe-B-DP-1
[330.711349] Dynamic subtest pipe-B-DP-1: SUCCESS (2.655s)
[330.795099] Starting dynamic subtest: pipe-C-DP-1
[331.073290] Dynamic subtest pipe-C-DP-1: SUCCESS (0.365s)
[331.093734] Subtest plane-downscale-factor-0-5-with-pixel-format: SUCCESS (5.688s)
[331.496838] [076/142] (707s left) gem_ctx_engines (execute-allforone)
[331.731534] Starting subtest: execute-allforone
[331.752447] Subtest execute-allforone: SUCCESS (0.015s)
[331.994372] [077/142] (707s left) gem_ctx_isolation (preservation)
[332.231331] Starting subtest: preservation
[332.250233] Starting dynamic subtest: rcs0
[333.506113] Dynamic subtest rcs0: SUCCESS (1.277s)
[333.550173] Starting dynamic subtest: bcs0
[335.024855] Dynamic subtest bcs0: SUCCESS (1.518s)
[335.066848] Starting dynamic subtest: vcs0
[336.161061] Dynamic subtest vcs0: SUCCESS (1.133s)
[336.206275] Starting dynamic subtest: vecs0
[337.284364] Dynamic subtest vecs0: SUCCESS (1.123s)
[337.304288] Subtest preservation: SUCCESS (5.062s)
[337.563104] [078/142] (701s left) syncobj_basic (bad-create-flags)
[337.787021] Starting subtest: bad-create-flags
[337.808600] Subtest bad-create-flags: SUCCESS (0.000s)
[337.904749] [079/142] (701s left) i915_hangman (engine-engine-error)
[338.146939] Starting subtest: engine-engine-error
[338.168908] Starting dynamic subtest: rcs0
[338.229331] Dynamic subtest rcs0: SUCCESS (0.094s)
[338.272791] Starting dynamic subtest: bcs0
[338.316189] Dynamic subtest bcs0: SKIP (0.002s)
[338.366316] Starting dynamic subtest: vcs0
[338.387463] Dynamic subtest vcs0: SUCCESS (0.082s)
[338.432003] Starting dynamic subtest: vecs0
[338.450901] Dynamic subtest vecs0: SUCCESS (0.084s)
[338.469844] Subtest engine-engine-error: SUCCESS (0.274s)
[338.579417] [080/142] (701s left) drm_fdinfo (most-busy-check-all)
[338.811982] Starting subtest: most-busy-check-all
[338.833754] Starting dynamic subtest: rcs0
[339.327876] Dynamic subtest rcs0: SUCCESS (0.531s)
[339.373766] Starting dynamic subtest: bcs0
[339.853909] Dynamic subtest bcs0: SUCCESS (0.527s)
[339.904241] Starting dynamic subtest: vcs0
[340.387918] Dynamic subtest vcs0: SUCCESS (0.522s)
[340.435364] Starting dynamic subtest: vecs0
[340.911988] Dynamic subtest vecs0: SUCCESS (0.524s)
[340.933611] Subtest most-busy-check-all: SUCCESS (2.115s)
[341.031032] [081/142] (698s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc)
[341.496826] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc
[341.536413] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.005s)
[341.917803] [082/142] (697s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[342.267717] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[342.310971] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[342.411636] [083/142] (697s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[342.786940] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[342.827206] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[342.959735] [084/142] (697s left) i915_pm_rpm (legacy-planes-dpms)
[344.865838] Starting subtest: legacy-planes-dpms
[344.891178] Starting dynamic subtest: plane-39
[347.168484] Dynamic subtest plane-39: SUCCESS (2.302s)
[347.217937] Starting dynamic subtest: plane-47
[349.205971] Dynamic subtest plane-47: SUCCESS (2.039s)
[349.225874] Subtest legacy-planes-dpms: SUCCESS (4.346s)
[349.734973] [085/142] (690s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_dg2_rc_ccs_cc)
[350.241180] Starting subtest: pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs_cc
[350.311692] Subtest pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[350.621155] [086/142] (689s left) kms_getfb (getfb-handle-zero)
[350.858804] Starting subtest: getfb-handle-zero
[350.877860] Subtest getfb-handle-zero: SUCCESS (0.000s)
[350.978543] [087/142] (689s left) syncobj_wait (reset-signaled)
[351.180850] Starting subtest: reset-signaled
[351.202442] Subtest reset-signaled: SUCCESS (0.000s)
[351.301881] [088/142] (689s left) vgem_basic (dmabuf-fence)
[351.540371] Starting subtest: dmabuf-fence
[351.561122] Subtest dmabuf-fence: SUCCESS (0.002s)
[351.657120] [089/142] (688s left) kms_flip (2x-flip-vs-suspend-interruptible)
[351.941864] Starting subtest: 2x-flip-vs-suspend-interruptible
[351.979311] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.003s)
[352.080596] [090/142] (688s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[352.382572] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[363.477063] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.084s)
[363.859915] [091/142] (676s left) gem_exec_reloc (basic-write-read-active)
[364.132018] Starting subtest: basic-write-read-active
[364.244532] Subtest basic-write-read-active: SUCCESS (0.136s)
[364.485725] [092/142] (676s left) i915_pm_freq_api (freq-suspend)
[364.737418] Subtest freq-suspend: SKIP (0.000s)
[364.857180] [093/142] (676s left) gem_wait (busy)
[365.112017] Starting subtest: busy
[365.132718] Starting dynamic subtest: all-engines
[365.631138] Dynamic subtest all-engines: SUCCESS (0.534s)
[365.679728] Starting dynamic subtest: rcs0
[366.163843] Dynamic subtest rcs0: SUCCESS (0.515s)
[366.207070] Starting dynamic subtest: bcs0
[366.678708] Dynamic subtest bcs0: SUCCESS (0.519s)
[366.720566] Starting dynamic subtest: vcs0
[367.204691] Dynamic subtest vcs0: SUCCESS (0.517s)
[367.248679] Starting dynamic subtest: vecs0
[367.719300] Dynamic subtest vecs0: SUCCESS (0.515s)
[367.737957] Subtest busy: SUCCESS (2.615s)
[368.003297] [094/142] (673s left) gen9_exec_parse (bb-oversize)
[368.239893] Starting subtest: bb-oversize
[368.816394] Subtest bb-oversize: SKIP (0.404s)
[368.972388] [095/142] (672s left) kms_chamelium_hpd (hdmi-hpd-fast)
[369.601584] Subtest hdmi-hpd-fast: SKIP (0.000s)
[369.919454] [096/142] (671s left) prime_vgem (fence-flip-hang)
[370.190171] Subtest fence-flip-hang: SKIP (0.000s)
[370.307266] [097/142] (671s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_mc_ccs)
[370.800707] Starting subtest: pipe-C-bad-rotation-90-y_tiled_gen12_mc_ccs
[370.839387] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[371.201708] [098/142] (670s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[371.465110] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[371.574748] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.108s)
[371.694788] [099/142] (669s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[372.512700] Starting subtest: syncobj-timeline-multiple-ext-nodes
[372.532796] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[372.780370] [100/142] (668s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[373.026928] Starting subtest: multi-wait-for-submit-submitted-signaled
[373.047224] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[373.142111] [101/142] (668s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs)
[373.689032] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[374.027359] [102/142] (667s left) gem_eio (suspend)
[374.331370] Starting subtest: suspend
[386.498232] Subtest suspend: SUCCESS (11.820s)
[392.782586] [103/142] (655s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[393.146592] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[393.188910] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[393.285816] [104/142] (655s left) vc4/vc4_mmap (mmap-bad-handle)
[393.567255] Subtest mmap-bad-handle: SKIP (0.000s)
[393.666579] [105/142] (654s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_mtl_mc_ccs)
[394.031608] Starting subtest: pipe-A-crc-primary-basic-4_tiled_mtl_mc_ccs
[394.068650] Subtest pipe-A-crc-primary-basic-4_tiled_mtl_mc_ccs: SKIP (0.001s)
[394.519540] [106/142] (653s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[394.836136] Starting subtest: primary-4-tiled-reflect-x-0
[394.882723] Subtest primary-4-tiled-reflect-x-0: SKIP (0.003s)
[394.999348] [107/142] (653s left) syncobj_timeline (invalid-single-wait-all-available-unsubmitted)
[395.298035] Starting subtest: invalid-single-wait-all-available-unsubmitted
[395.322704] Subtest invalid-single-wait-all-available-unsubmitted: SUCCESS (0.000s)
[395.440633] [108/142] (653s left) vc4/vc4_wait_bo (used-bo)
[395.738103] Subtest used-bo: SKIP (0.000s)
[395.851302] [109/142] (652s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[396.242269] Starting subtest: yf-tiled-8bpp-rotate-270
[396.288692] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[396.409480] [110/142] (652s left) v3d/v3d_submit_csd (single-in-sync)
[396.717240] Subtest single-in-sync: SKIP (0.000s)
[396.812170] [111/142] (652s left) vgem_basic (setversion)
[397.050776] Starting subtest: setversion
[397.088997] Subtest setversion: SUCCESS (0.000s)
[397.184797] [112/142] (651s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[397.419799] Starting subtest: tiled-to-tiled
[397.543288] Subtest tiled-to-tiled: SUCCESS (0.115s)
[397.659442] [113/142] (651s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[397.974737] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[399.300050] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.345s)
[399.660207] [114/142] (649s left) core_hotunplug (unbind-rebind)
[399.982729] Starting subtest: unbind-rebind
[403.696731] Subtest unbind-rebind: SUCCESS (3.714s)
[403.790915] [115/142] (645s left) kms_invalid_mode (zero-clock)
[404.148970] Starting subtest: zero-clock
[404.168798] Starting dynamic subtest: DP-1-pipe-A
[404.210581] Dynamic subtest DP-1-pipe-A: SUCCESS (0.082s)
[404.262739] Starting dynamic subtest: DP-1-pipe-B
[404.284215] Dynamic subtest DP-1-pipe-B: SUCCESS (0.002s)
[404.336505] Starting dynamic subtest: DP-1-pipe-C
[404.357728] Dynamic subtest DP-1-pipe-C: SUCCESS (0.002s)
[404.378364] Subtest zero-clock: SUCCESS (0.099s)
[404.575200] [116/142] (644s left) gem_exec_flush (basic-uc-ro-default)
[404.860156] Starting subtest: basic-uc-ro-default
[410.457407] Subtest basic-uc-ro-default: SUCCESS (5.479s)
[410.576352] [117/142] (639s left) gem_exec_parallel (contexts)
[410.790688] Starting subtest: contexts
[410.811844] Starting dynamic subtest: rcs0
[416.305020] Dynamic subtest rcs0: SUCCESS (5.521s)
[416.351122] Starting dynamic subtest: bcs0
[424.461215] Dynamic subtest bcs0: SUCCESS (8.121s)
[424.508495] Starting dynamic subtest: vcs0
[430.778157] Dynamic subtest vcs0: SUCCESS (6.194s)
[430.827252] Starting dynamic subtest: vecs0
[437.880138] Dynamic subtest vecs0: SUCCESS (7.249s)
[437.901801] Subtest contexts: SUCCESS (27.099s)
[438.122054] [118/142] (611s left) gem_ctx_persistence (heartbeat-hostile)
[438.358823] Starting subtest: heartbeat-hostile
[439.549653] Subtest heartbeat-hostile: SUCCESS (1.202s)
[439.668544] [119/142] (610s left) perf_pmu (multi-client)
[439.906607] Starting subtest: multi-client
[439.925806] Starting dynamic subtest: rcs0
[440.916182] Dynamic subtest rcs0: SUCCESS (1.036s)
[440.960236] Starting dynamic subtest: bcs0
[441.953062] Dynamic subtest bcs0: SUCCESS (1.030s)
[441.998597] Starting dynamic subtest: vcs0
[442.984215] Dynamic subtest vcs0: SUCCESS (1.029s)
[443.029455] Starting dynamic subtest: vecs0
[444.016981] Dynamic subtest vecs0: SUCCESS (1.030s)
[444.038488] Subtest multi-client: SUCCESS (4.142s)
[444.171588] [120/142] (605s left) kms_busy (basic)
[444.494471] Starting subtest: basic
[444.513140] Starting dynamic subtest: flip
[445.176837] Dynamic subtest flip: SUCCESS (0.697s)
[445.220270] Starting dynamic subtest: modeset
[446.574611] Dynamic subtest modeset: SUCCESS (1.391s)
[446.594004] Subtest basic: SUCCESS (2.097s)
[446.972183] [121/142] (603s left) kms_frontbuffer_tracking (fbc-suspend)
[447.326334] Starting subtest: fbc-suspend
[485.032871] Subtest fbc-suspend: SUCCESS (5.849s)
[490.141960] [122/142] (596s left) kms_cursor_crc (cursor-dpms)
[490.476443] Starting subtest: cursor-dpms
[490.505934] Starting dynamic subtest: pipe-A-DP-1
[491.918213] Dynamic subtest pipe-A-DP-1: SUCCESS (1.413s)
[491.967626] Starting dynamic subtest: pipe-C-DP-1
[493.459069] Dynamic subtest pipe-C-DP-1: SUCCESS (1.550s)
[493.480913] Subtest cursor-dpms: SUCCESS (2.973s)
[493.843957] [123/142] (593s left) gem_exec_reloc (basic-scanout)
[494.167371] Starting subtest: basic-scanout
[494.188861] Starting dynamic subtest: rcs0
[494.461501] Dynamic subtest rcs0: SUCCESS (0.258s)
[494.509481] Starting dynamic subtest: bcs0
[494.634503] Dynamic subtest bcs0: SUCCESS (0.164s)
[494.682053] Starting dynamic subtest: vcs0
[494.795706] Dynamic subtest vcs0: SUCCESS (0.164s)
[494.841497] Starting dynamic subtest: vecs0
[494.966798] Dynamic subtest vecs0: SUCCESS (0.164s)
[494.985890] Subtest basic-scanout: SUCCESS (0.760s)
[495.081864] [124/142] (591s left) kms_content_protection (legacy)
[495.433560] Starting subtest: legacy
[495.623248] Starting dynamic subtest: pipe-A-DP-1
[616.626154] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[623.639791] Closing watchdogs
[623.645842] Initializing watchdogs
[623.646041]   /dev/watchdog0
[623.698676] [125/142] (463s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[623.957171] Starting subtest: single-wait-all-for-submit-signaled
[623.981909] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[624.110539] [126/142] (463s left) syncobj_wait (wait-delayed-signal)
[624.368697] Starting subtest: wait-delayed-signal
[624.431353] Subtest wait-delayed-signal: SUCCESS (0.102s)
[624.554940] [127/142] (462s left) gem_exec_schedule (u-submit-golden-slice)
[625.030502] Starting subtest: u-submit-golden-slice
[625.053802] Starting dynamic subtest: rcs0
[625.086015] Dynamic subtest rcs0: SUCCESS (0.063s)
[625.137686] Starting dynamic subtest: bcs0
[625.162760] Dynamic subtest bcs0: SUCCESS (0.046s)
[625.215760] Starting dynamic subtest: vcs0
[625.241897] Dynamic subtest vcs0: SUCCESS (0.042s)
[625.294232] Starting dynamic subtest: vecs0
[625.320185] Dynamic subtest vecs0: SUCCESS (0.044s)
[625.346323] Subtest u-submit-golden-slice: SUCCESS (0.207s)
[625.465571] [128/142] (462s left) gem_eio (wait-1us)
[625.771893] Starting subtest: wait-1us
[625.797513] Subtest wait-1us: SUCCESS (0.073s)
[626.005767] [129/142] (461s left) kms_getfb (getfb-addfb-different-handles)
[626.384412] Starting subtest: getfb-addfb-different-handles
[626.405003] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[626.514561] [130/142] (461s left) kms_chamelium_color (ctm-max)
[626.854480] Subtest ctm-max: SKIP (0.000s)
[626.957008] [131/142] (460s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs)
[627.388458] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs
[627.429698] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs: SKIP (0.005s)
[627.853912] [132/142] (460s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[628.240401] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[628.278331] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[628.376940] [133/142] (459s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[628.754097] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[628.791630] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[628.894342] [134/142] (459s left) kms_selftest (framebuffer)
[629.098121] Starting subtest: framebuffer
[629.222767] Starting dynamic subtest: drm_framebuffer-drm_test_framebuffer_create
[629.241623] Dynamic subtest drm_framebuffer-drm_test_framebuffer_create: SUCCESS (0.000s)
[629.260449] Subtest framebuffer: SUCCESS (0.109s)
[629.376084] [135/142] (458s left) perf (gen12-group-exclusive-stream-ctx-handle)
[629.732167] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[629.770872] Subtest gen12-group-exclusive-stream-ctx-handle: SKIP (0.000s)
[629.877077] [136/142] (458s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[630.183753] Starting subtest: 2x-flip-vs-cursor-atomic
[630.225667] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.004s)
[630.322802] [137/142] (458s left) gem_tiling_max_stride
[630.723190] [138/142] (457s left) gem_flink_basic (double-flink)
[630.947378] Starting subtest: double-flink
[630.967705] Subtest double-flink: SUCCESS (0.000s)
[631.069986] [139/142] (457s left) gem_mmap_wc (pf-nonblock)
[631.303100] Starting subtest: pf-nonblock
[631.324293] Subtest pf-nonblock: SUCCESS (0.006s)
[631.423002] [140/142] (457s left) kms_concurrent (pipe-d)
[631.739443] Subtest pipe-D: SKIP (0.000s)
[631.921599] [141/142] (456s left) kms_prop_blob (invalid-get-prop)
[632.157782] Starting subtest: invalid-get-prop
[632.176680] Subtest invalid-get-prop: SUCCESS (0.000s)
[632.273093] [142/142] (456s left) gem_ctx_persistence (userptr)
[632.499197] Starting subtest: userptr
[632.620080] Subtest userptr: SUCCESS (0.127s)
[632.698899] Closing watchdogs
Done.