[47.435959] Initializing watchdogs
[47.436514]   /dev/watchdog0
[47.451715] [001/136] (960s left) kms_vblank (pipe-d-query-forked)
[47.762172] Subtest pipe-D-query-forked: SKIP (0.000s)
[47.845038] [002/136] (960s left) gem_exec_reloc (basic-cpu-gtt-active)
[48.062171] Starting subtest: basic-cpu-gtt-active
[48.220878] Subtest basic-cpu-gtt-active: SUCCESS (0.160s)
[48.405033] [003/136] (959s left) kms_psr (basic)
[48.591076] Subtest basic: SKIP (0.000s)
[48.640512] [004/136] (959s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[48.933724] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[48.936639] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[49.021414] [005/136] (959s left) kms_frontbuffer_tracking (fbc-suspend)
[49.314671] Starting subtest: fbc-suspend
[86.681361] Subtest fbc-suspend: SUCCESS (6.502s)
[91.549511] [006/136] (952s left) gem_mmap_gtt (fault-concurrent-y)
[91.736401] Starting subtest: fault-concurrent-Y
[95.034630] Subtest fault-concurrent-Y: SUCCESS (3.298s)
[95.285284] [007/136] (948s left) kms_addfb_basic (invalid-set-prop)
[95.470750] Starting subtest: invalid-set-prop
[95.472332] Subtest invalid-set-prop: SUCCESS (0.000s)
[95.665086] [008/136] (948s left) gem_ctx_exec (basic-norecovery)
[95.849550] Starting subtest: basic-norecovery
[95.886176] Subtest basic-norecovery: SUCCESS (0.035s)
[95.984532] [009/136] (947s left) api_intel_bb (object-reloc-keep-cache)
[96.166450] Starting subtest: object-reloc-keep-cache
[96.183363] Subtest object-reloc-keep-cache: SUCCESS (0.018s)
[96.280765] [010/136] (947s left) perf_pmu (idle)
[96.472863] Starting subtest: idle
[96.474378] Starting dynamic subtest: rcs0
[96.981166] Dynamic subtest rcs0: SUCCESS (0.507s)
[96.998180] Starting dynamic subtest: bcs0
[97.488056] Dynamic subtest bcs0: SUCCESS (0.505s)
[97.505204] Starting dynamic subtest: vcs0
[97.995663] Dynamic subtest vcs0: SUCCESS (0.507s)
[98.012624] Starting dynamic subtest: vecs0
[98.502244] Dynamic subtest vecs0: SUCCESS (0.507s)
[98.503975] Subtest idle: SUCCESS (2.028s)
[98.581721] [011/136] (945s left) gem_ctx_persistence (legacy-engines-mixed-process)
[98.773533] Starting subtest: legacy-engines-mixed-process
[98.776787] Starting dynamic subtest: render
[99.135032] Dynamic subtest render: SUCCESS (0.358s)
[99.155875] Starting dynamic subtest: bsd
[99.483377] Dynamic subtest bsd: SUCCESS (0.348s)
[99.502369] Starting dynamic subtest: blt
[100.632767] Dynamic subtest blt: SUCCESS (1.147s)
[100.652128] Starting dynamic subtest: vebox
[100.980944] Dynamic subtest vebox: SUCCESS (0.347s)
[100.982546] Subtest legacy-engines-mixed-process: SUCCESS (2.208s)
[101.067463] [012/136] (942s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_rc_ccs)
[101.685120] Starting subtest: pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs
[101.688603] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[102.020907] [013/136] (941s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[102.308845] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[103.049661] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.745s)
[103.382165] [014/136] (940s left) kms_big_fb (linear-64bpp-rotate-180)
[103.697213] Starting subtest: linear-64bpp-rotate-180
[111.979111] Subtest linear-64bpp-rotate-180: SUCCESS (8.280s)
[112.966513] [015/136] (930s left) kms_rotation_crc (bad-tiling)
[113.237080] Starting subtest: bad-tiling
[115.603771] Subtest bad-tiling: SUCCESS (2.368s)
[115.993635] [016/136] (927s left) gem_wait (busy)
[116.208644] Starting subtest: busy
[116.210678] Starting dynamic subtest: all-engines
[116.738821] Dynamic subtest all-engines: SUCCESS (0.529s)
[116.761745] Starting dynamic subtest: rcs0
[117.252958] Dynamic subtest rcs0: SUCCESS (0.514s)
[117.273307] Starting dynamic subtest: bcs0
[117.768786] Dynamic subtest bcs0: SUCCESS (0.516s)
[117.787952] Starting dynamic subtest: vcs0
[118.284767] Dynamic subtest vcs0: SUCCESS (0.516s)
[118.303896] Starting dynamic subtest: vecs0
[118.800836] Dynamic subtest vecs0: SUCCESS (0.516s)
[118.802149] Subtest busy: SUCCESS (2.592s)
[119.026465] [017/136] (924s left) gem_exec_params (dr1-dirt)
[119.215877] Starting subtest: DR1-dirt
[119.217385] Subtest DR1-dirt: SUCCESS (0.001s)
[119.308945] [018/136] (924s left) kms_big_joiner (invalid-modeset)
[119.593340] Subtest invalid-modeset: SKIP (0.000s)
[119.644788] [019/136] (924s left) kms_flip (flip-vs-suspend-interruptible)
[119.916982] Starting subtest: flip-vs-suspend-interruptible
[119.920400] Starting dynamic subtest: A-DP1
[172.435298] Dynamic subtest A-DP1: SUCCESS (4.719s)
[172.455415] Starting dynamic subtest: B-DP1
[224.495382] Dynamic subtest B-DP1: SUCCESS (4.438s)
[224.520906] Starting dynamic subtest: C-DP1
[276.447055] Dynamic subtest C-DP1: SUCCESS (4.406s)
[276.448511] Subtest flip-vs-suspend-interruptible: SUCCESS (13.570s)
[281.847538] [020/136] (910s left) kms_psr2_sf (overlay-plane-update-sf-dmg-area)
[282.033150] Subtest overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[282.074649] [021/136] (910s left) kms_universal_plane (disable-primary-vs-flip-pipe-d)
[282.348218] Subtest disable-primary-vs-flip-pipe-D: SKIP (0.000s)
[282.422093] [022/136] (909s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_gen12_mc_ccs)
[283.048851] Subtest pipe-D-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[283.345455] [023/136] (908s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[283.639642] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[283.642045] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[283.746047] [024/136] (908s left) gem_spin_batch (spin-all-new)
[283.942886] Starting subtest: spin-all-new
[283.970687] Subtest spin-all-new: SUCCESS (0.028s)
[284.195512] [025/136] (908s left) gen9_exec_parse (bb-large)
[284.392241] Starting subtest: bb-large
[366.510837] Subtest bb-large: SUCCESS (82.119s)
[366.842216] [026/136] (825s left) v3d/v3d_submit_csd (bad-flag)
[367.226451] Subtest bad-flag: SKIP (0.000s)
[367.296281] [027/136] (825s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[367.591685] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[367.594315] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[367.781030] [028/136] (824s left) perf (unprivileged-single-ctx-counters)
[368.093717] Starting subtest: unprivileged-single-ctx-counters
[368.096374] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[368.145654] [029/136] (824s left) perf_pmu (all-busy-check-all)
[368.332434] Starting subtest: all-busy-check-all
[368.863854] Subtest all-busy-check-all: SUCCESS (0.531s)
[368.947962] [030/136] (823s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[369.371627] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[369.378830] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.005s)
[369.865882] [031/136] (822s left) gem_eio (in-flight-internal-10ms)
[370.067782] Starting subtest: in-flight-internal-10ms
[370.221684] Subtest in-flight-internal-10ms: SUCCESS (0.156s)
[370.461060] [032/136] (822s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[370.825594] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[370.828678] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[370.919960] [033/136] (821s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-wc)
[371.248702] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-wc
[371.252575] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[371.352340] [034/136] (821s left) kms_getfb (getfb-handle-zero)
[371.548598] Starting subtest: getfb-handle-zero
[371.550471] Subtest getfb-handle-zero: SUCCESS (0.000s)
[371.659390] [035/136] (820s left) kms_cursor_crc (cursor-random-256x256)
[372.022286] Starting subtest: cursor-random-256x256
[372.030044] Starting dynamic subtest: pipe-A-DP-1
[376.024988] Dynamic subtest pipe-A-DP-1: SUCCESS (3.997s)
[376.099763] Starting dynamic subtest: pipe-C-DP-1
[380.189983] Dynamic subtest pipe-C-DP-1: SUCCESS (4.109s)
[380.191268] Subtest cursor-random-256x256: SUCCESS (8.174s)
[380.544847] [036/136] (812s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[380.842818] Starting subtest: basic-max-pipe-crc-check
[380.845391] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[380.894232] [037/136] (811s left) kms_plane (plane-position-covered)
[381.171558] Starting subtest: plane-position-covered
[381.172886] Starting dynamic subtest: pipe-A-planes
[382.647617] Dynamic subtest pipe-A-planes: SUCCESS (1.478s)
[382.674317] Starting dynamic subtest: pipe-B-planes
[384.422771] Dynamic subtest pipe-B-planes: SUCCESS (1.772s)
[384.424312] Subtest plane-position-covered: SUCCESS (3.256s)
[384.763978] [038/136] (807s left) gem_eio (wait-wedge-10ms)
[384.967677] Starting subtest: wait-wedge-10ms
[385.066172] Subtest wait-wedge-10ms: SUCCESS (0.099s)
[385.249116] [039/136] (807s left) gem_exec_fence (syncobj-timeline-unused-fence)
[386.053585] Starting subtest: syncobj-timeline-unused-fence
[386.059747] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s)
[386.281219] [040/136] (806s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[386.590947] Starting subtest: 4-tiled-addfb-size-offset-overflow
[386.593891] Subtest 4-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[386.698173] [041/136] (806s left) drm_read (short-buffer-nonblock)
[387.109786] Starting subtest: short-buffer-nonblock
[387.111570] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[387.232464] [042/136] (805s left) prime_self_import (export-vs-gem_close-race)
[387.408737] Starting subtest: export-vs-gem_close-race
[392.440148] Subtest export-vs-gem_close-race: SUCCESS (5.030s)
[392.540200] [043/136] (800s left) gem_ctx_param (invalid-param-get)
[392.724704] Starting subtest: invalid-param-get
[392.726231] Subtest invalid-param-get: SUCCESS (0.000s)
[392.812754] [044/136] (800s left) i915_pm_rc6_residency (media-rc6-accuracy)
[393.161588] Starting subtest: media-rc6-accuracy
[393.164439] Subtest media-rc6-accuracy: SKIP (0.000s)
[393.245918] [045/136] (799s left) kms_ccs (pipe-d-ccs-on-another-bo-y_tiled_gen12_rc_ccs)
[393.877182] Subtest pipe-D-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[394.195924] [046/136] (798s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_dg2_rc_ccs_cc)
[394.664601] Starting subtest: pipe-B-crc-primary-basic-4_tiled_dg2_rc_ccs_cc
[394.668767] Subtest pipe-B-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.002s)
[395.152118] [047/136] (797s left) v3d/v3d_perfmon (create-two-perfmon)
[395.396634] Subtest create-two-perfmon: SKIP (0.000s)
[395.468352] [048/136] (797s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[395.750615] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[395.757192] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.004s)
[395.835477] [049/136] (797s left) kms_chamelium_frames (dp-crc-multiple)
[396.195622] Subtest dp-crc-multiple: SKIP (0.000s)
[396.488475] [050/136] (796s left) i915_pm_rps (fence-order)
[396.679040] Starting subtest: fence-order
[399.823611] Subtest fence-order: SUCCESS (3.144s)
[400.028500] [051/136] (793s left) i915_pm_backlight (basic-brightness)
[400.321151] Subtest basic-brightness: SKIP (0.000s)
[400.365383] [052/136] (792s left) gem_mmap_gtt (medium-copy)
[400.550562] Starting subtest: medium-copy
[406.511810] Subtest medium-copy: SUCCESS (5.959s)
[406.630228] [053/136] (786s left) gem_exec_params (secure-non-master)
[406.939628] Starting subtest: secure-non-master
[406.942311] Subtest secure-non-master: SKIP (0.000s)
[407.045455] [054/136] (786s left) sysfs_heartbeat_interval (invalid)
[407.233047] Starting subtest: invalid
[407.237380] Starting dynamic subtest: vecs0
[407.239042] Dynamic subtest vecs0: SUCCESS (0.001s)
[407.261077] Starting dynamic subtest: vcs0
[407.262514] Dynamic subtest vcs0: SUCCESS (0.001s)
[407.284541] Starting dynamic subtest: bcs0
[407.286020] Dynamic subtest bcs0: SUCCESS (0.001s)
[407.307953] Starting dynamic subtest: rcs0
[407.309269] Dynamic subtest rcs0: SUCCESS (0.001s)
[407.310643] Subtest invalid: SUCCESS (0.010s)
[407.346000] [055/136] (786s left) kms_flip (dpms-vs-vblank-race)
[407.608829] Starting subtest: dpms-vs-vblank-race
[407.610327] Starting dynamic subtest: A-DP1
[412.000258] Dynamic subtest A-DP1: SUCCESS (4.386s)
[412.022628] Starting dynamic subtest: B-DP1
[416.196338] Dynamic subtest B-DP1: SUCCESS (4.199s)
[416.220147] Starting dynamic subtest: C-DP1
[420.318902] Dynamic subtest C-DP1: SUCCESS (4.120s)
[420.320148] Subtest dpms-vs-vblank-race: SUCCESS (12.714s)
[420.668571] [056/136] (772s left) prime_self_import (basic-llseek-size)
[420.855447] Starting subtest: basic-llseek-size
[420.862173] Subtest basic-llseek-size: SUCCESS (0.006s)
[420.967198] [057/136] (772s left) kms_color (legacy-gamma)
[421.254381] Starting subtest: legacy-gamma
[421.255829] Starting dynamic subtest: pipe-A-DP-1
[421.807200] Dynamic subtest pipe-A-DP-1: SUCCESS (0.551s)
[421.838784] Starting dynamic subtest: pipe-B-DP-1
[422.630086] Dynamic subtest pipe-B-DP-1: SUCCESS (0.820s)
[422.663012] Starting dynamic subtest: pipe-C-DP-1
[423.586171] Dynamic subtest pipe-C-DP-1: SUCCESS (0.953s)
[423.587475] Subtest legacy-gamma: SUCCESS (2.335s)
[423.914264] [058/136] (769s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[424.206033] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[424.208632] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[424.314095] [059/136] (769s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-pwrite)
[424.602331] Starting subtest: fbc-1p-offscren-pri-indfb-draw-pwrite
[426.490378] Subtest fbc-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (1.890s)
[426.615069] [060/136] (766s left) kms_chamelium_frames (hdmi-crc-single)
[426.990627] Subtest hdmi-crc-single: SKIP (0.000s)
[427.287965] [061/136] (766s left) gem_ctx_bad_destroy (double-destroy)
[427.467433] Starting subtest: double-destroy
[427.469117] Subtest double-destroy: SUCCESS (0.000s)
[427.562274] [062/136] (766s left) gem_exec_whisper (basic-contexts-forked-all)
[427.767844] Starting subtest: basic-contexts-forked-all
[451.483359] Subtest basic-contexts-forked-all: SUCCESS (23.714s)
[451.679382] [063/136] (742s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_mc_ccs)
[452.302524] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[452.604944] [064/136] (741s left) gem_mmap_offset (basic-uaf)
[452.801105] Starting subtest: basic-uaf
[452.802600] Subtest basic-uaf: SUCCESS (0.003s)
[452.905001] [065/136] (740s left) kms_cursor_edge_walk (64x64-right-edge)
[453.188776] Starting subtest: 64x64-right-edge
[453.191184] Starting dynamic subtest: pipe-A-DP-1
[456.810204] Dynamic subtest pipe-A-DP-1: SUCCESS (3.620s)
[456.835962] Starting dynamic subtest: pipe-C-DP-1
[460.300214] Dynamic subtest pipe-C-DP-1: SUCCESS (3.488s)
[460.301711] Subtest 64x64-right-edge: SUCCESS (7.115s)
[460.626926] [066/136] (733s left) gem_exec_endless (dispatch)
[460.850385] Starting subtest: dispatch
[460.853262] Starting dynamic subtest: rcs0
[460.866988] Dynamic subtest rcs0: SUCCESS (0.012s)
[460.896545] Starting dynamic subtest: bcs0
[460.899120] Dynamic subtest bcs0: SKIP (0.001s)
[460.921521] Starting dynamic subtest: vcs0
[460.924057] Dynamic subtest vcs0: SUCCESS (0.008s)
[460.946497] Starting dynamic subtest: vecs0
[460.949105] Dynamic subtest vecs0: SUCCESS (0.008s)
[460.950447] Subtest dispatch: SUCCESS (0.036s)
[460.992033] [067/136] (732s left) gem_exec_schedule (manyslice)
[461.211532] Starting subtest: manyslice
[461.216182] Starting dynamic subtest: rcs0
[462.970649] Dynamic subtest rcs0: SUCCESS (1.753s)
[463.046318] Starting dynamic subtest: bcs0
[463.680729] Dynamic subtest bcs0: SUCCESS (0.712s)
[463.705585] Starting dynamic subtest: vcs0
[464.425560] Dynamic subtest vcs0: SUCCESS (0.742s)
[464.513227] Starting dynamic subtest: vecs0
[465.416016] Dynamic subtest vecs0: SUCCESS (0.990s)
[465.417376] Subtest manyslice: SUCCESS (4.203s)
[465.742712] [068/136] (728s left) gem_fence_thrash (bo-write-verify-threaded-y)
[465.918720] Starting subtest: bo-write-verify-threaded-y
[468.869426] Subtest bo-write-verify-threaded-y: SUCCESS (2.950s)
[468.974949] [069/136] (724s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[469.268944] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[469.271752] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[469.375874] [070/136] (724s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[469.656764] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[469.658220] Starting dynamic subtest: pipe-A-valid-mode
[469.768237] Dynamic subtest pipe-A-valid-mode: SKIP (0.106s)
[469.772497] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SKIP (0.109s)
[470.074869] [071/136] (723s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[470.378656] Starting subtest: yf-tiled-addfb-size-offset-overflow
[470.381334] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[470.475283] [072/136] (723s left) kms_sysfs_edid_timing
[471.941760] [073/136] (722s left) kms_psr (sprite_mmap_gtt)
[472.124073] Subtest sprite_mmap_gtt: SKIP (0.000s)
[472.177664] [074/136] (721s left) vc4/vc4_purgeable_bo (mark-purgeable)
[472.418242] Subtest mark-purgeable: SKIP (0.000s)
[472.492248] [075/136] (721s left) kms_psr (psr2_sprite_mmap_gtt)
[472.670914] Subtest psr2_sprite_mmap_gtt: SKIP (0.000s)
[472.729894] [076/136] (721s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[473.027782] Starting subtest: x-tiled-64bpp-rotate-270
[473.098549] Subtest x-tiled-64bpp-rotate-270: SKIP (0.070s)
[473.208145] [077/136] (721s left) kms_plane_scaling (planes-downscale-factor-0-25)
[473.479148] Starting subtest: planes-downscale-factor-0-25
[473.485346] Starting dynamic subtest: pipe-A-DP-1
[473.509001] Dynamic subtest pipe-A-DP-1: SKIP (0.025s)
[473.535975] Starting dynamic subtest: pipe-B-DP-1
[473.583864] Dynamic subtest pipe-B-DP-1: SKIP (0.070s)
[473.607943] Starting dynamic subtest: pipe-C-DP-1
[473.659751] Dynamic subtest pipe-C-DP-1: SKIP (0.071s)
[473.662470] Subtest planes-downscale-factor-0-25: SKIP (0.177s)
[473.759292] [078/136] (720s left) prime_vgem (busy)
[473.973340] Starting subtest: busy
[473.974625] Starting dynamic subtest: rcs0
[474.007135] Dynamic subtest rcs0: SUCCESS (0.034s)
[474.034324] Starting dynamic subtest: vcs0
[474.035693] Dynamic subtest vcs0: SUCCESS (0.016s)
[474.063657] Starting dynamic subtest: vecs0
[474.064904] Dynamic subtest vecs0: SUCCESS (0.017s)
[474.066165] Subtest busy: SUCCESS (0.072s)
[474.158761] [079/136] (720s left) gem_exec_reloc (basic-wc-noreloc)
[474.353876] Starting subtest: basic-wc-noreloc
[474.365139] Subtest basic-wc-noreloc: SUCCESS (0.011s)
[474.558837] [080/136] (719s left) kms_atomic (plane-primary-legacy)
[474.964803] Starting subtest: plane-primary-legacy
[475.150613] Subtest plane-primary-legacy: SUCCESS (0.189s)
[475.565706] [081/136] (718s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[475.848715] Starting subtest: cursorB-vs-flipA-varying-size
[475.851948] Subtest cursorB-vs-flipA-varying-size: SKIP (0.004s)
[475.948131] [082/136] (718s left) gem_ctx_sseu (engines)
[476.137309] Subtest engines: SKIP (0.000s)
[476.200307] [083/136] (718s left) i915_pm_rpm (pm-caching)
[477.992473] Starting subtest: pm-caching
[479.610858] Subtest pm-caching: SUCCESS (1.620s)
[480.066860] [084/136] (714s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted)
[480.250261] Starting subtest: invalid-multi-wait-all-available-unsubmitted
[480.252030] Subtest invalid-multi-wait-all-available-unsubmitted: SUCCESS (0.000s)
[480.348217] [085/136] (714s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_ccs)
[480.767980] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_ccs
[480.769551] Subtest pipe-A-ccs-on-another-bo-y_tiled_ccs: SUCCESS (0.001s)
[481.296112] [086/136] (713s left) fbdev (info)
[481.475516] Starting subtest: info
[481.477562] Subtest info: SUCCESS (0.000s)
[481.562752] [087/136] (713s left) drm_fdinfo (busy-idle)
[481.748468] Starting subtest: busy-idle
[481.750124] Starting dynamic subtest: rcs0
[482.376176] Dynamic subtest rcs0: SUCCESS (0.627s)
[482.401641] Starting dynamic subtest: bcs0
[483.005271] Dynamic subtest bcs0: SUCCESS (0.628s)
[483.030468] Starting dynamic subtest: vcs0
[483.635212] Dynamic subtest vcs0: SUCCESS (0.629s)
[483.662361] Starting dynamic subtest: vecs0
[484.264078] Dynamic subtest vecs0: SUCCESS (0.628s)
[484.265609] Subtest busy-idle: SUCCESS (2.516s)
[484.346198] [088/136] (710s left) kms_universal_plane (universal-plane-pipe-c-functional)
[484.635609] Starting subtest: universal-plane-pipe-C-functional
[487.623815] Subtest universal-plane-pipe-C-functional: SUCCESS (2.989s)
[487.936354] [089/136] (706s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[488.237929] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[488.240749] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[488.335803] [090/136] (706s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[488.634671] Starting subtest: fbc-tiling-linear
[490.559907] Subtest fbc-tiling-linear: SUCCESS (1.925s)
[490.702800] [091/136] (704s left) kms_vblank (pipe-c-wait-forked-busy-hang)
[490.980139] Starting subtest: pipe-C-wait-forked-busy-hang
[498.371007] Subtest pipe-C-wait-forked-busy-hang: SUCCESS (7.393s)
[498.726054] [092/136] (696s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[499.012546] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[499.015199] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[499.123329] [093/136] (695s left) syncobj_timeline (multi-wait-available-submitted)
[499.304464] Starting subtest: multi-wait-available-submitted
[499.309159] Subtest multi-wait-available-submitted: SUCCESS (0.002s)
[499.390267] [094/136] (695s left) gem_close (many-handles-one-vma)
[499.579020] Starting subtest: many-handles-one-vma
[499.676732] Subtest many-handles-one-vma: SUCCESS (0.095s)
[499.790960] [095/136] (695s left) kms_ccs (pipe-b-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[500.304754] Starting subtest: pipe-B-bad-aux-stride-y_tiled_gen12_rc_ccs_cc
[500.307361] Subtest pipe-B-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[500.726369] [096/136] (694s left) gem_exec_schedule (timeslicing)
[500.928904] Starting subtest: timeslicing
[500.930447] Starting dynamic subtest: rcs0
[500.937298] Dynamic subtest rcs0: SUCCESS (0.007s)
[500.971761] Starting dynamic subtest: bcs0
[500.973143] Dynamic subtest bcs0: SUCCESS (0.010s)
[500.996904] Starting dynamic subtest: vcs0
[500.998320] Dynamic subtest vcs0: SUCCESS (0.009s)
[501.020975] Starting dynamic subtest: vecs0
[501.022452] Dynamic subtest vecs0: SUCCESS (0.008s)
[501.023790] Subtest timeslicing: SUCCESS (0.040s)
[501.310684] [097/136] (693s left) gem_lmem_swapping (parallel-random-verify-ccs)
[501.498434] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[501.561982] [098/136] (693s left) kms_flip (dpms-off-confusion)
[501.819859] Starting subtest: dpms-off-confusion
[501.821173] Starting dynamic subtest: A-DP1
[512.344687] Dynamic subtest A-DP1: SUCCESS (10.523s)
[512.373076] Starting dynamic subtest: B-DP1
[522.806447] Dynamic subtest B-DP1: SUCCESS (10.460s)
[522.831902] Starting dynamic subtest: C-DP1
[533.270875] Dynamic subtest C-DP1: SUCCESS (10.461s)
[533.272239] Subtest dpms-off-confusion: SUCCESS (31.454s)
[533.686611] [099/136] (661s left) perf (gen12-mi-rpc)
[533.984053] Subtest gen12-mi-rpc: SKIP (0.000s)
[534.033844] [100/136] (661s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[534.319286] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[534.322137] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[534.434814] [101/136] (660s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc)
[535.023327] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc
[535.025917] Subtest pipe-C-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[535.375061] [102/136] (659s left) kms_prop_blob (blob-multiple)
[535.557274] Starting subtest: blob-multiple
[535.558715] Subtest blob-multiple: SUCCESS (0.003s)
[535.641751] [103/136] (659s left) gem_exec_reloc (basic-write-gtt)
[535.832932] Starting subtest: basic-write-gtt
[535.852659] Subtest basic-write-gtt: SUCCESS (0.018s)
[536.041319] [104/136] (659s left) gem_pxp (verify-pxp-stale-buf-execution)
[538.746348] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s)
[538.823492] [105/136] (656s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[539.112117] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[539.114783] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[539.224699] [106/136] (656s left) gem_exec_alignment (single)
[539.416152] Starting subtest: single
[539.424466] Subtest single: SUCCESS (0.008s)
[539.524222] [107/136] (655s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_dg2_rc_ccs)
[540.095160] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs
[540.097861] Subtest pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.002s)
[540.473854] [108/136] (655s left) syncobj_timeline (wait-all-snapshot)
[540.654875] Starting subtest: wait-all-snapshot
[540.738266] Subtest wait-all-snapshot: SUCCESS (0.083s)
[540.823741] [109/136] (654s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[541.129699] Starting subtest: y-tiled-32bpp-rotate-0
[545.781034] Subtest y-tiled-32bpp-rotate-0: SUCCESS (4.654s)
[546.307151] [110/136] (649s left) syncobj_timeline (invalid-transfer-non-existent-point)
[546.487562] Starting subtest: invalid-transfer-non-existent-point
[546.489340] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[546.572561] [111/136] (649s left) kms_plane_lowres (tiling-none)
[546.849197] Starting subtest: tiling-none
[546.850705] Starting dynamic subtest: pipe-A-DP-1
[552.093605] Dynamic subtest pipe-A-DP-1: SUCCESS (5.243s)
[552.197511] Starting dynamic subtest: pipe-B-DP-1
[557.307571] Dynamic subtest pipe-B-DP-1: SUCCESS (5.132s)
[557.446132] Starting dynamic subtest: pipe-C-DP-1
[560.875932] Dynamic subtest pipe-C-DP-1: SUCCESS (3.450s)
[561.008420] Subtest tiling-none: SUCCESS (14.159s)
[561.451025] [112/136] (634s left) gem_exec_gttfill (basic)
[561.660830] Starting subtest: basic
[587.699597] Subtest basic: SUCCESS (26.041s)
[587.901053] [113/136] (607s left) kms_atomic (plane-cursor-legacy)
[588.548566] Starting subtest: plane-cursor-legacy
[588.599764] Subtest plane-cursor-legacy: SUCCESS (0.053s)
[589.134106] [114/136] (606s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[589.425889] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[591.489284] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (2.067s)
[591.632855] [115/136] (604s left) kms_cursor_crc (cursor-dpms)
[591.913099] Starting subtest: cursor-dpms
[591.917656] Starting dynamic subtest: pipe-A-DP-1
[593.313634] Dynamic subtest pipe-A-DP-1: SUCCESS (1.394s)
[593.343366] Starting dynamic subtest: pipe-C-DP-1
[595.007301] Dynamic subtest pipe-C-DP-1: SUCCESS (1.689s)
[595.008692] Subtest cursor-dpms: SUCCESS (3.093s)
[595.377225] [116/136] (600s left) kms_vblank (pipe-d-wait-idle-hang)
[595.667800] Subtest pipe-D-wait-idle-hang: SKIP (0.000s)
[595.757516] [117/136] (600s left) vc4/vc4_create_bo (create-bo-0)
[596.015812] Subtest create-bo-0: SKIP (0.000s)
[596.090715] [118/136] (599s left) gem_exec_reloc (basic-write-cpu)
[596.285236] Starting subtest: basic-write-cpu
[596.300053] Subtest basic-write-cpu: SUCCESS (0.018s)
[596.491321] [119/136] (599s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[596.774157] Starting subtest: basic-busy-flip-before-cursor-varying-size
[596.776943] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[596.857569] [120/136] (599s left) gem_pxp (hw-rejects-pxp-buffer)
[599.554181] Starting subtest: hw-rejects-pxp-buffer
[599.555939] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s)
[599.657313] [121/136] (596s left) api_intel_bb (intel-bb-blit-none)
[599.836496] Starting subtest: intel-bb-blit-none
[603.471681] Subtest intel-bb-blit-none: SUCCESS (3.634s)
[603.588968] [122/136] (592s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[603.780589] Starting subtest: writes-after-reads-uncached
[624.096303] Subtest writes-after-reads-uncached: SUCCESS (20.318s)
[624.223347] [123/136] (571s left) gem_exec_flush (basic-batch-kernel-default-wb)
[624.425231] Starting subtest: basic-batch-kernel-default-wb
[630.275348] Subtest basic-batch-kernel-default-wb: SUCCESS (5.850s)
[630.477083] [124/136] (565s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[630.768754] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[630.771605] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[630.874547] [125/136] (565s left) kms_invalid_mode (int-max-clock)
[631.155365] Starting subtest: int-max-clock
[631.156638] Starting dynamic subtest: DP-1-pipe-A
[631.257518] Dynamic subtest DP-1-pipe-A: SUCCESS (0.098s)
[631.283561] Starting dynamic subtest: DP-1-pipe-B
[631.285060] Dynamic subtest DP-1-pipe-B: SUCCESS (0.013s)
[631.310542] Starting dynamic subtest: DP-1-pipe-C
[631.313171] Dynamic subtest DP-1-pipe-C: SUCCESS (0.014s)
[631.316294] Subtest int-max-clock: SUCCESS (0.134s)
[631.615565] [126/136] (564s left) gem_busy (busy)
[631.816707] Starting subtest: busy
[631.818335] Starting dynamic subtest: all-engines
[631.883992] Dynamic subtest all-engines: SUCCESS (0.066s)
[631.909990] Starting dynamic subtest: rcs0
[631.912006] Dynamic subtest rcs0: SUCCESS (0.013s)
[631.941516] Starting dynamic subtest: bcs0
[631.943188] Dynamic subtest bcs0: SUCCESS (0.015s)
[631.966911] Starting dynamic subtest: vcs0
[631.968232] Dynamic subtest vcs0: SUCCESS (0.015s)
[631.992457] Starting dynamic subtest: vecs0
[631.993828] Dynamic subtest vecs0: SUCCESS (0.012s)
[631.995114] Subtest busy: SUCCESS (0.128s)
[632.331639] [127/136] (563s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[632.626446] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[634.887436] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (2.266s)
[635.030179] [128/136] (561s left) gem_softpin (allocator-basic)
[635.226249] Starting subtest: allocator-basic
[635.452923] Subtest allocator-basic: SUCCESS (0.226s)
[635.580009] [129/136] (560s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[635.864119] Starting subtest: 2x-long-flip-vs-cursor-legacy
[635.869456] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.004s)
[635.964759] [130/136] (560s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[636.257845] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[638.504053] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.251s)
[638.649499] [131/136] (557s left) gem_exec_schedule (independent)
[638.853058] Starting subtest: independent
[638.854633] Starting dynamic subtest: rcs0
[639.040716] Dynamic subtest rcs0: SUCCESS (0.186s)
[639.071173] Starting dynamic subtest: bcs0
[639.235569] Dynamic subtest bcs0: SUCCESS (0.191s)
[639.266099] Starting dynamic subtest: vcs0
[639.406754] Dynamic subtest vcs0: SUCCESS (0.170s)
[639.434508] Starting dynamic subtest: vecs0
[639.585454] Dynamic subtest vecs0: SUCCESS (0.176s)
[639.586896] Subtest independent: SUCCESS (0.732s)
[639.913825] [132/136] (556s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[640.184601] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[640.187323] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.003s)
[640.299283] [133/136] (556s left) gem_exec_balancer (full-pulse)
[640.502573] Starting subtest: full-pulse
[644.435222] Subtest full-pulse: SUCCESS (3.935s)
[648.298000] [134/136] (548s left) gem_exec_balancer (waits)
[648.498417] Starting subtest: waits
[652.135367] Subtest waits: SUCCESS (3.635s)
[655.980697] [135/136] (540s left) vgem_slow (nohang)
[656.172209] Starting subtest: nohang
[666.342772] Subtest nohang: SUCCESS (10.169s)
[666.413024] [136/136] (530s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_dg2_rc_ccs)
[666.773472] Starting subtest: pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs
[666.776205] Subtest pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[667.326611] Closing watchdogs
Done.