[43.958409] Initializing watchdogs
[43.958646]   /dev/watchdog0
[43.993845] [001/141] (960s left) kms_setmode (invalid-clone-single-crtc)
[44.336068] Starting subtest: invalid-clone-single-crtc
[44.396419] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[44.474178] [002/141] (960s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[44.862090] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[64.333094] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (19.465s)
[64.693636] [003/141] (939s left) gem_exec_schedule (u-independent)
[65.182453] Starting subtest: u-independent
[65.202035] Starting dynamic subtest: rcs0
[65.267896] Dynamic subtest rcs0: SUCCESS (0.217s)
[65.306398] Starting dynamic subtest: bcs0
[65.448266] Dynamic subtest bcs0: SUCCESS (0.187s)
[65.490380] Starting dynamic subtest: vcs0
[65.631824] Dynamic subtest vcs0: SUCCESS (0.183s)
[65.669541] Starting dynamic subtest: vecs0
[65.801332] Dynamic subtest vecs0: SUCCESS (0.172s)
[65.820626] Subtest u-independent: SUCCESS (0.761s)
[66.172388] [004/141] (938s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[66.603184] Starting subtest: psr-rgb101010-draw-blt
[66.651141] Subtest psr-rgb101010-draw-blt: SKIP (0.000s)
[66.755523] [005/141] (938s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc)
[67.530884] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[67.838693] [006/141] (937s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[68.274941] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[68.315114] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[68.423255] [007/141] (936s left) kms_cursor_edge_walk (128x128-top-edge)
[68.799303] Starting subtest: 128x128-top-edge
[68.821798] Starting dynamic subtest: pipe-A-DP-1
[72.432617] Dynamic subtest pipe-A-DP-1: SUCCESS (3.639s)
[72.465936] Starting dynamic subtest: pipe-C-DP-1
[75.930198] Dynamic subtest pipe-C-DP-1: SUCCESS (3.475s)
[75.951164] Subtest 128x128-top-edge: SUCCESS (7.120s)
[76.268035] [008/141] (928s left) sysfs_heartbeat_interval (mixed)
[76.574373] Starting subtest: mixed
[76.594554] Starting dynamic subtest: vecs0
[81.785461] Dynamic subtest vecs0: SUCCESS (5.211s)
[81.817751] Starting dynamic subtest: vcs0
[87.007525] Dynamic subtest vcs0: SUCCESS (5.209s)
[87.043273] Starting dynamic subtest: bcs0
[92.228303] Dynamic subtest bcs0: SUCCESS (5.232s)
[92.263315] Starting dynamic subtest: rcs0
[97.545597] Dynamic subtest rcs0: SUCCESS (5.313s)
[97.567796] Subtest mixed: SUCCESS (20.969s)
[97.655777] [009/141] (907s left) gem_create (create-ext-cpu-access-big)
[98.054164] Starting subtest: create-ext-cpu-access-big
[98.094800] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[98.177796] [010/141] (907s left) gem_exec_whisper (basic-queues-forked)
[98.523557] Starting subtest: basic-queues-forked
[109.742418] Subtest basic-queues-forked: SUCCESS (11.250s)
[109.949618] [011/141] (895s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[110.362591] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[110.404822] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[110.511524] [012/141] (894s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[110.962031] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[111.016035] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[111.148802] [013/141] (894s left) kms_ccs (pipe-b-missing-ccs-buffer-y_tiled_gen12_rc_ccs)
[111.768533] Starting subtest: pipe-B-missing-ccs-buffer-y_tiled_gen12_rc_ccs
[111.824874] Subtest pipe-B-missing-ccs-buffer-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[112.267331] [014/141] (893s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_ccs)
[112.965975] Starting subtest: pipe-C-random-ccs-data-y_tiled_ccs
[113.043923] Subtest pipe-C-random-ccs-data-y_tiled_ccs: SKIP (0.000s)
[113.337792] [015/141] (892s left) i915_module_load (load)
[113.621741] Starting subtest: load
[113.659609] Subtest load: SKIP (0.003s)
[113.766481] [016/141] (892s left) kms_vblank (pipe-a-wait-forked)
[114.134787] Starting subtest: pipe-A-wait-forked
[116.478414] Subtest pipe-A-wait-forked: SUCCESS (2.346s)
[116.844942] [017/141] (889s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-25)
[117.212697] Starting subtest: planes-unity-scaling-downscale-factor-0-25
[117.234118] Starting dynamic subtest: pipe-A-DP-1
[117.272876] Dynamic subtest pipe-A-DP-1: SKIP (0.030s)
[117.312503] Starting dynamic subtest: pipe-B-DP-1
[117.354230] Dynamic subtest pipe-B-DP-1: SKIP (0.083s)
[117.399902] Starting dynamic subtest: pipe-C-DP-1
[117.441711] Dynamic subtest pipe-C-DP-1: SKIP (0.078s)
[117.479591] Subtest planes-unity-scaling-downscale-factor-0-25: SKIP (0.200s)
[117.604093] [018/141] (888s left) gem_ctx_param (invalid-ctx-set)
[117.902133] Starting subtest: invalid-ctx-set
[117.924037] Subtest invalid-ctx-set: SUCCESS (0.000s)
[118.031183] [019/141] (888s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[118.446211] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[118.488458] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[118.595849] [020/141] (887s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[119.007414] Starting subtest: extended-modeset-hang-oldfb-with-reset
[119.028246] Starting dynamic subtest: pipe-A
[121.044227] Dynamic subtest pipe-A: SUCCESS (2.036s)
[121.078315] Starting dynamic subtest: pipe-C
[123.268298] Dynamic subtest pipe-C: SUCCESS (2.229s)
[123.288409] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (4.275s)
[123.666731] [021/141] (882s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[124.087642] Starting subtest: fbcpsr-2p-rte
[124.129889] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[124.235237] [022/141] (882s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[124.680682] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[124.718562] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[124.825624] [023/141] (881s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[125.188826] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[125.209025] Starting dynamic subtest: pipe-A-valid-mode
[125.337722] Dynamic subtest pipe-A-valid-mode: SKIP (0.124s)
[125.378916] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.126s)
[125.687810] [024/141] (881s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[126.398245] Starting subtest: pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs_cc
[126.441270] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[126.771083] [025/141] (880s left) perf (whitelisted-registers-userspace-config)
[127.237122] Starting subtest: whitelisted-registers-userspace-config
[127.257684] Subtest whitelisted-registers-userspace-config: SUCCESS (0.003s)
[127.360920] [026/141] (879s left) gem_mmap_offset (clear)
[127.662068] Starting subtest: clear
[127.681216] Starting dynamic subtest: smem0
[151.706494] Dynamic subtest smem0: SUCCESS (24.034s)
[151.727103] Subtest clear: SUCCESS (24.035s)
[152.149265] [027/141] (854s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_gen12_mc_ccs)
[152.604920] Starting subtest: pipe-A-random-ccs-data-y_tiled_gen12_mc_ccs
[152.664545] Subtest pipe-A-random-ccs-data-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[153.178723] [028/141] (853s left) gem_mmap_gtt (basic-wc)
[153.466976] Starting subtest: basic-wc
[154.081946] Subtest basic-wc: SUCCESS (0.631s)
[154.232626] [029/141] (852s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[154.628114] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[156.023156] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.407s)
[156.220089] [030/141] (851s left) kms_invalid_mode (bad-hsync-end)
[156.639518] Starting subtest: bad-hsync-end
[156.658852] Starting dynamic subtest: DP-1-pipe-A
[156.708684] Dynamic subtest DP-1-pipe-A: SUCCESS (0.093s)
[156.747185] Starting dynamic subtest: DP-1-pipe-B
[156.767939] Dynamic subtest DP-1-pipe-B: SUCCESS (0.015s)
[156.805476] Starting dynamic subtest: DP-1-pipe-C
[156.824292] Dynamic subtest DP-1-pipe-C: SUCCESS (0.014s)
[156.843305] Subtest bad-hsync-end: SUCCESS (0.129s)
[157.108481] [031/141] (850s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[157.551565] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[157.589323] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[157.699608] [032/141] (849s left) kms_cursor_crc (cursor-size-change)
[158.063673] Starting subtest: cursor-size-change
[158.082619] Starting dynamic subtest: pipe-A-DP-1
[158.818382] Dynamic subtest pipe-A-DP-1: SUCCESS (0.741s)
[158.858274] Starting dynamic subtest: pipe-C-DP-1
[159.843433] Dynamic subtest pipe-C-DP-1: SUCCESS (1.031s)
[159.863343] Subtest cursor-size-change: SUCCESS (1.779s)
[160.249712] [033/141] (847s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[160.608857] Starting subtest: cursor-rapid-movement-32x32
[160.762706] Subtest cursor-rapid-movement-32x32: SKIP (0.112s)
[160.873810] [034/141] (846s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[161.317750] Starting subtest: fbcpsr-tiling-linear
[161.355573] Subtest fbcpsr-tiling-linear: SKIP (0.000s)
[161.465633] [035/141] (846s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[161.823211] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[161.842584] Starting dynamic subtest: pipe-A-DP-1
[164.232358] Dynamic subtest pipe-A-DP-1: SUCCESS (2.392s)
[164.273374] Starting dynamic subtest: pipe-B-DP-1
[166.856868] Dynamic subtest pipe-B-DP-1: SUCCESS (2.624s)
[166.892300] Starting dynamic subtest: pipe-C-DP-1
[167.232551] Dynamic subtest pipe-C-DP-1: SUCCESS (0.370s)
[167.254359] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (5.397s)
[167.653126] [036/141] (840s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[168.068163] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[168.111115] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[168.220874] [037/141] (839s left) kms_lease (lease_invalid_plane)
[168.609606] Starting subtest: lease_invalid_plane
[168.631402] Starting dynamic subtest: pipe-A-DP-1
[168.653185] Dynamic subtest pipe-A-DP-1: SUCCESS (0.000s)
[168.690126] Starting dynamic subtest: pipe-B-DP-1
[168.709987] Dynamic subtest pipe-B-DP-1: SUCCESS (0.000s)
[168.744954] Starting dynamic subtest: pipe-C-DP-1
[168.763770] Dynamic subtest pipe-C-DP-1: SUCCESS (0.000s)
[168.782477] Subtest lease_invalid_plane: SUCCESS (0.009s)
[168.893968] [038/141] (839s left) vc4/vc4_purgeable_bo (mark-unpurgeable-check-retained)
[169.238254] Subtest mark-unpurgeable-check-retained: SKIP (0.000s)
[169.345598] [039/141] (838s left) gem_exec_fence (syncobj-repeat)
[170.165146] Starting subtest: syncobj-repeat
[171.011391] Subtest syncobj-repeat: SUCCESS (0.847s)
[171.396188] [040/141] (836s left) kms_plane_cursor (overlay)
[171.789029] Starting subtest: overlay
[171.829845] Starting dynamic subtest: pipe-A-DP-1-size-64
[174.212458] Dynamic subtest pipe-A-DP-1-size-64: SUCCESS (2.448s)
[174.288648] Starting dynamic subtest: pipe-A-DP-1-size-128
[176.728407] Dynamic subtest pipe-A-DP-1-size-128: SUCCESS (2.449s)
[176.807619] Starting dynamic subtest: pipe-A-DP-1-size-256
[179.211660] Dynamic subtest pipe-A-DP-1-size-256: SUCCESS (2.432s)
[179.401136] Starting dynamic subtest: pipe-B-DP-1-size-64
[182.007303] Dynamic subtest pipe-B-DP-1-size-64: SUCCESS (2.660s)
[182.092153] Starting dynamic subtest: pipe-B-DP-1-size-128
[184.479034] Dynamic subtest pipe-B-DP-1-size-128: SUCCESS (2.416s)
[184.558262] Starting dynamic subtest: pipe-B-DP-1-size-256
[186.938290] Dynamic subtest pipe-B-DP-1-size-256: SUCCESS (2.416s)
[187.118134] Starting dynamic subtest: pipe-C-DP-1-size-64
[189.726819] Dynamic subtest pipe-C-DP-1-size-64: SUCCESS (2.654s)
[189.815658] Starting dynamic subtest: pipe-C-DP-1-size-128
[192.212392] Dynamic subtest pipe-C-DP-1-size-128: SUCCESS (2.432s)
[192.292569] Starting dynamic subtest: pipe-C-DP-1-size-256
[194.695863] Dynamic subtest pipe-C-DP-1-size-256: SUCCESS (2.416s)
[194.843811] Subtest overlay: SUCCESS (23.065s)
[195.209613] [041/141] (813s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[195.635671] Starting subtest: primary-y-tiled-reflect-x-270
[195.689247] Subtest primary-y-tiled-reflect-x-270: SKIP (0.003s)
[195.827567] [042/141] (812s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[196.215076] Starting subtest: cursorA-vs-flipA-atomic-transitions
[207.295730] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.087s)
[207.695397] [043/141] (801s left) kms_chamelium_color (ctm-negative)
[208.096179] Subtest ctm-negative: SKIP (0.000s)
[208.212880] [044/141] (800s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_dg2_rc_ccs)
[208.872465] Starting subtest: pipe-C-crc-primary-basic-4_tiled_dg2_rc_ccs
[208.916037] Subtest pipe-C-crc-primary-basic-4_tiled_dg2_rc_ccs: SKIP (0.001s)
[209.296747] [045/141] (799s left) gen3_mixed_blits
[209.723902] [046/141] (799s left) kms_vblank (pipe-a-query-idle-hang)
[210.087477] Starting subtest: pipe-A-query-idle-hang
[217.175162] Subtest pipe-A-query-idle-hang: SUCCESS (6.971s)
[217.429470] [047/141] (791s left) gem_wait (write-busy)
[217.749758] Starting subtest: write-busy
[217.770478] Starting dynamic subtest: all-engines
[218.276842] Dynamic subtest all-engines: SUCCESS (0.529s)
[218.315270] Starting dynamic subtest: rcs0
[218.802617] Dynamic subtest rcs0: SUCCESS (0.517s)
[218.839613] Starting dynamic subtest: bcs0
[219.318898] Dynamic subtest bcs0: SUCCESS (0.520s)
[219.353857] Starting dynamic subtest: vcs0
[219.844988] Dynamic subtest vcs0: SUCCESS (0.517s)
[219.883354] Starting dynamic subtest: vecs0
[220.360066] Dynamic subtest vecs0: SUCCESS (0.516s)
[220.378640] Subtest write-busy: SUCCESS (2.614s)
[220.641425] [048/141] (788s left) v3d/v3d_wait_bo (used-bo-1ns)
[220.982230] Subtest used-bo-1ns: SKIP (0.000s)
[221.092489] [049/141] (788s left) kms_frontbuffer_tracking (basic)
[221.513862] Starting subtest: basic
[224.312343] Subtest basic: SUCCESS (2.848s)
[224.476075] [050/141] (784s left) kms_psr (primary_render)
[224.796738] Subtest primary_render: SKIP (0.000s)
[224.915242] [051/141] (784s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[225.313600] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[225.396466] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.003s)
[225.506045] [052/141] (784s left) i915_pm_freq_api (freq-suspend)
[225.825688] Subtest freq-suspend: SKIP (0.000s)
[225.938495] [053/141] (783s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-submitted-signaled
[226.233597] Starting subtest: invalid-multi-wait-available-unsubmitted-submitted-signaled
[226.254812] Subtest invalid-multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[226.363249] [054/141] (783s left) gem_exec_reloc (basic-gtt-read-noreloc)
[226.666309] Starting subtest: basic-gtt-read-noreloc
[226.685545] Subtest basic-gtt-read-noreloc: SUCCESS (0.012s)
[226.890625] [055/141] (783s left) kms_chamelium_frames (hdmi-crc-fast)
[227.372684] Subtest hdmi-crc-fast: SKIP (0.000s)
[227.697619] [056/141] (782s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-signaled)
[227.990089] Starting subtest: invalid-multi-wait-all-available-unsubmitted-signaled
[228.008992] Subtest invalid-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.001s)
[228.121597] [057/141] (782s left) gem_partial_pwrite_pread (write)
[228.418388] Starting subtest: write
[243.017621] Subtest write: SUCCESS (14.601s)
[243.173310] [058/141] (767s left) syncobj_timeline (device-signal-unordered)
[243.467368] Starting subtest: device-signal-unordered
[243.488762] Subtest device-signal-unordered: SUCCESS (0.002s)
[243.599316] [059/141] (766s left) gem_ctx_persistence (engines-hostile-preempt)
[243.899201] Starting subtest: engines-hostile-preempt
[243.919289] Starting dynamic subtest: rcs0
[243.984283] Dynamic subtest rcs0: SUCCESS (0.112s)
[244.021598] Starting dynamic subtest: bcs0
[244.088181] Dynamic subtest bcs0: SUCCESS (0.089s)
[244.125476] Starting dynamic subtest: vcs0
[244.166134] Dynamic subtest vcs0: SUCCESS (0.087s)
[244.201859] Starting dynamic subtest: vecs0
[244.267357] Dynamic subtest vecs0: SUCCESS (0.090s)
[244.288206] Subtest engines-hostile-preempt: SUCCESS (0.389s)
[244.407134] [060/141] (766s left) gem_workarounds (basic-read-context)
[244.728384] Starting subtest: basic-read-context
[244.747231] Subtest basic-read-context: SUCCESS (0.024s)
[244.889655] [061/141] (765s left) kms_vblank (pipe-b-query-idle-hang)
[245.262134] Starting subtest: pipe-B-query-idle-hang
[253.098119] Subtest pipe-B-query-idle-hang: SUCCESS (7.770s)
[253.430502] [062/141] (757s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[253.834610] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[253.860056] Starting dynamic subtest: pipe-A-valid-mode
[254.545506] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.723s)
[254.574098] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SUCCESS (0.728s)
[254.941072] [063/141] (756s left) gem_exec_balancer (sequential)
[255.253395] Starting subtest: sequential
[259.167921] Subtest sequential: SUCCESS (3.739s)
[263.045603] [064/141] (748s left) kms_setmode (basic)
[263.343411] Starting subtest: basic
[263.524560] Starting dynamic subtest: pipe-A-DP-1
[265.839779] Dynamic subtest pipe-A-DP-1: SUCCESS (2.307s)
[265.983477] Starting dynamic subtest: pipe-B-DP-1
[268.289899] Dynamic subtest pipe-B-DP-1: SUCCESS (2.305s)
[268.400428] Subtest basic: SUCCESS (5.059s)
[268.764123] [065/141] (742s left) kms_atomic (plane-cursor-legacy)
[269.248187] Starting subtest: plane-cursor-legacy
[269.335650] Subtest plane-cursor-legacy: SUCCESS (0.066s)
[269.783558] [066/141] (741s left) gem_mmap_gtt (flink-race)
[270.076470] Starting subtest: flink-race
[290.336952] Subtest flink-race: SUCCESS (20.117s)
[290.426363] [067/141] (720s left) gem_flink_basic (bad-open)
[290.725470] Starting subtest: bad-open
[290.744229] Subtest bad-open: SUCCESS (0.000s)
[290.832731] [068/141] (720s left) v3d/v3d_submit_cl (valid-multisync-submission)
[291.162607] Subtest valid-multisync-submission: SKIP (0.000s)
[291.255851] [069/141] (720s left) prime_vgem (basic-read)
[291.554174] Starting subtest: basic-read
[291.575633] Subtest basic-read: SUCCESS (0.050s)
[291.708491] [070/141] (719s left) syncobj_timeline (reset-multiple-signaled)
[291.986585] Starting subtest: reset-multiple-signaled
[292.007036] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[292.094746] [071/141] (719s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-c)
[292.461351] Starting subtest: universal-plane-pageflip-windowed-pipe-C
[293.386027] Subtest universal-plane-pageflip-windowed-pipe-C: SUCCESS (0.906s)
[293.736911] [072/141] (718s left) kms_ccs (pipe-a-crc-primary-basic-y_tiled_gen12_rc_ccs)
[294.192441] Starting subtest: pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs
[294.239205] Subtest pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.001s)
[294.815186] [073/141] (717s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[295.251694] Starting subtest: fbc-rgb565-draw-blt
[297.422744] Subtest fbc-rgb565-draw-blt: SUCCESS (2.235s)
[297.591432] [074/141] (714s left) gem_exec_params (rs-invalid)
[297.895115] Starting subtest: rs-invalid
[297.913977] Subtest rs-invalid: SUCCESS (0.006s)
[298.028647] [075/141] (714s left) i915_suspend (debugfs-reader)
[298.325574] Starting subtest: debugfs-reader
[317.142287] Subtest debugfs-reader: SUCCESS (3.765s)
[322.246064] [076/141] (710s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs)
[322.883151] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs
[322.920891] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs: SKIP (0.005s)
[323.355469] [077/141] (709s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[323.846770] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[324.507719] [078/141] (708s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[324.965007] Starting subtest: fbcpsr-shrfb-scaledprimary
[325.024013] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s)
[325.163542] [079/141] (707s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[325.554376] Starting subtest: stress-mm-invalidate-close-overlap
[327.650055] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[327.817165] [080/141] (705s left) prime_self_import (basic-with_fd_dup)
[328.099055] Starting subtest: basic-with_fd_dup
[328.136581] Subtest basic-with_fd_dup: SUCCESS (0.008s)
[328.238805] [081/141] (704s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[328.517694] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[328.557915] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[328.733408] [082/141] (704s left) i915_query (test-query-geometry-subslices)
[329.035148] Starting subtest: test-query-geometry-subslices
[329.072786] Subtest test-query-geometry-subslices: SKIP (0.000s)
[329.166491] [083/141] (703s left) gen9_exec_parse (shadow-peek)
[329.472508] Starting subtest: shadow-peek
[329.491685] Subtest shadow-peek: SUCCESS (0.005s)
[329.700273] [084/141] (703s left) gem_exec_fence (expired-history)
[330.416254] Starting subtest: expired-history
[336.206637] Subtest expired-history: SUCCESS (5.814s)
[336.836316] [085/141] (696s left) v3d/v3d_perfmon (destroy-valid-perfmon)
[337.174881] Subtest destroy-valid-perfmon: SKIP (0.000s)
[337.287064] [086/141] (696s left) gem_userptr_blits (nohangcheck)
[337.641995] Starting subtest: nohangcheck
[337.934318] Subtest nohangcheck: SUCCESS (0.336s)
[338.089813] [087/141] (695s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[338.453418] Starting subtest: basic-flip-after-cursor-atomic
[339.530497] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.079s)
[339.916861] [088/141] (693s left) kms_big_fb (linear-8bpp-rotate-180)
[340.314950] Starting subtest: linear-8bpp-rotate-180
[344.206026] Subtest linear-8bpp-rotate-180: SUCCESS (3.911s)
[344.439552] [089/141] (689s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[344.959372] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[345.000301] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.005s)
[345.545221] [090/141] (688s left) perf_pmu (multi-client)
[345.847332] Starting subtest: multi-client
[345.866419] Starting dynamic subtest: rcs0
[346.847191] Dynamic subtest rcs0: SUCCESS (1.025s)
[346.891043] Starting dynamic subtest: bcs0
[347.884971] Dynamic subtest bcs0: SUCCESS (1.032s)
[347.927844] Starting dynamic subtest: vcs0
[348.916246] Dynamic subtest vcs0: SUCCESS (1.029s)
[348.956903] Starting dynamic subtest: vecs0
[349.952447] Dynamic subtest vecs0: SUCCESS (1.029s)
[349.973892] Subtest multi-client: SUCCESS (4.132s)
[350.088422] [091/141] (683s left) gem_eio (wait-1us)
[350.432146] Starting subtest: wait-1us
[350.496702] Subtest wait-1us: SUCCESS (0.087s)
[350.727419] [092/141] (683s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[351.132150] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[351.170094] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[351.288266] [093/141] (682s left) kms_psr (psr2_cursor_render)
[351.580391] Subtest psr2_cursor_render: SKIP (0.000s)
[351.679154] [094/141] (682s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[351.949894] Starting subtest: yf-tiled-to-vebox-x-tiled
[351.992986] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[352.172396] [095/141] (682s left) syncobj_wait (invalid-wait-illegal-handle)
[352.477650] Starting subtest: invalid-wait-illegal-handle
[352.501763] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[352.596304] [096/141] (681s left) kms_universal_plane (disable-primary-vs-flip-pipe-b)
[352.956828] Starting subtest: disable-primary-vs-flip-pipe-B
[353.983256] Subtest disable-primary-vs-flip-pipe-B: SUCCESS (1.017s)
[354.368798] [097/141] (680s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_rc_ccs_cc)
[355.119154] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[355.467553] [098/141] (679s left) kms_psr (psr2_sprite_plane_move)
[355.776007] Subtest psr2_sprite_plane_move: SKIP (0.000s)
[355.891477] [099/141] (678s left) gem_userptr_blits (dmabuf-sync)
[356.271823] Starting subtest: dmabuf-sync
[356.313101] Subtest dmabuf-sync: SKIP (0.007s)
[356.427670] [100/141] (678s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[356.857048] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[356.897059] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[357.010913] [101/141] (677s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_gen12_mc_ccs)
[357.377258] Starting subtest: pipe-A-bad-pixel-format-y_tiled_gen12_mc_ccs
[357.420314] Subtest pipe-A-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[358.096991] [102/141] (677s left) fbdev (read)
[358.413216] Starting subtest: read
[359.820846] Subtest read: SUCCESS (1.409s)
[359.984188] [103/141] (675s left) gem_exec_flush (basic-wb-rw-before-default)
[360.355802] Starting subtest: basic-wb-rw-before-default
[365.976465] Subtest basic-wb-rw-before-default: SUCCESS (5.498s)
[366.097113] [104/141] (669s left) api_intel_bb (simple-bb-ctx)
[366.427891] Starting subtest: simple-bb-ctx
[366.455210] Subtest simple-bb-ctx: SUCCESS (0.014s)
[366.566331] [105/141] (668s left) kms_dsc (dsc-with-bpc-formats)
[366.960141] Subtest dsc-with-bpc-formats: SKIP (0.000s)
[367.077836] [106/141] (668s left) gem_exercise_blt (fast-copy-emit)
[367.381722] Starting subtest: fast-copy-emit
[367.400829] Starting dynamic subtest: linear-smem-smem-emit
[367.419840] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.058s)
[367.462377] Starting dynamic subtest: ymajor-smem-smem-emit
[367.481233] Dynamic subtest ymajor-smem-smem-emit: SUCCESS (0.052s)
[367.525230] Starting dynamic subtest: yfmajor-smem-smem-emit
[367.547004] Dynamic subtest yfmajor-smem-smem-emit: SUCCESS (0.049s)
[367.592605] Starting dynamic subtest: tile64-smem-smem-emit
[367.613463] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.048s)
[367.632681] Subtest fast-copy-emit: SUCCESS (0.220s)
[367.725506] [107/141] (667s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[368.170602] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[368.207900] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[368.325443] [108/141] (667s left) kms_content_protection (uevent)
[368.741543] Starting subtest: uevent
[368.760578] Starting dynamic subtest: pipe-A-DP-1
[404.638754] Dynamic subtest pipe-A-DP-1: FAIL (34.778s)
[404.657367] Subtest uevent: FAIL (34.941s)
[404.784125] [109/141] (631s left) api_intel_bb (object-reloc-keep-cache)
[405.057959] Starting subtest: object-reloc-keep-cache
[405.076669] Subtest object-reloc-keep-cache: SUCCESS (0.014s)
[405.200306] [110/141] (630s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_mtl_mc_ccs)
[405.749572] Starting subtest: pipe-B-crc-primary-basic-4_tiled_mtl_mc_ccs
[405.786958] Subtest pipe-B-crc-primary-basic-4_tiled_mtl_mc_ccs: SKIP (0.001s)
[406.293411] [111/141] (629s left) gem_pxp (create-valid-protected-context)
[409.270799] Subtest create-valid-protected-context: SKIP (0.000s)
[409.428887] [112/141] (626s left) kms_cursor_crc (cursor-onscreen-512x170)
[409.798043] Starting subtest: cursor-onscreen-512x170
[409.835409] Subtest cursor-onscreen-512x170: SKIP (0.002s)
[409.953116] [113/141] (626s left) gem_exec_params (invalid-bsd2-flag-on-render)
[410.247229] Starting subtest: invalid-bsd2-flag-on-render
[410.269194] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.001s)
[410.369599] [114/141] (626s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[410.789822] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[410.831911] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[410.948717] [115/141] (625s left) kms_atomic_transition (plane-all-transition)
[411.317589] Starting subtest: plane-all-transition
[411.339920] Starting dynamic subtest: pipe-A-DP-1
[415.297301] Dynamic subtest pipe-A-DP-1: SUCCESS (3.982s)
[415.486321] Starting dynamic subtest: pipe-B-DP-1
[419.799621] Dynamic subtest pipe-B-DP-1: SUCCESS (4.399s)
[419.909091] Subtest plane-all-transition: SUCCESS (8.585s)
[420.283720] [116/141] (616s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_mtl_rc_ccs_cc)
[421.085337] Subtest pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[421.435275] [117/141] (615s left) syncobj_timeline (wait-all-complex)
[421.729211] Starting subtest: wait-all-complex
[421.916669] Subtest wait-all-complex: SUCCESS (0.216s)
[422.057582] [118/141] (614s left) prime_mmap (test_forked)
[422.355790] Starting subtest: test_forked
[422.376501] Starting dynamic subtest: test_forked-smem
[422.395799] Dynamic subtest test_forked-smem: SUCCESS (0.041s)
[422.414821] Subtest test_forked: SUCCESS (0.043s)
[422.531916] [119/141] (614s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[422.947299] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[422.984228] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[423.108361] [120/141] (613s left) syncobj_basic (bad-flags-fd-to-handle)
[423.401466] Starting subtest: bad-flags-fd-to-handle
[423.422973] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[423.535472] [121/141] (613s left) gem_exec_balancer (bonded-sync)
[423.835814] Starting subtest: bonded-sync
[427.589257] Subtest bonded-sync: SUCCESS (3.761s)
[431.674404] [122/141] (605s left) kms_psr2_sf (cursor-plane-move-continuous-sf)
[431.998257] Subtest cursor-plane-move-continuous-sf: SKIP (0.000s)
[432.114411] [123/141] (605s left) kms_writeback (writeback-fb-id)
[432.589028] Subtest writeback-fb-id: SKIP (0.000s)
[432.713092] [124/141] (604s left) syncobj_wait (signal)
[433.004579] Starting subtest: signal
[433.026067] Subtest signal: SUCCESS (0.000s)
[433.139039] [125/141] (604s left) drm_mm (drm_mm_test)
[433.419072] Starting subtest: drm_mm_test
[433.456925] Subtest drm_mm_test: SKIP (0.004s)
[433.572867] [126/141] (604s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs)
[434.305215] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs
[434.347493] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs: SKIP (0.004s)
[434.683436] [127/141] (603s left) syncobj_wait (wait-all-interrupted)
[434.973226] Starting subtest: wait-all-interrupted
[435.054957] Subtest wait-all-interrupted: SUCCESS (0.108s)
[435.191377] [128/141] (602s left) gem_mmap_gtt (medium-copy-odd)
[435.486079] Starting subtest: medium-copy-odd
[442.523947] Subtest medium-copy-odd: SUCCESS (7.070s)
[442.701714] [129/141] (595s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[443.320861] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[444.619797] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.339s)
[445.015954] [130/141] (593s left) perf_pmu (invalid-init)
[445.314925] Starting subtest: invalid-init
[445.335194] Subtest invalid-init: SUCCESS (0.001s)
[445.475484] [131/141] (592s left) kms_flip (wf_vblank-ts-check-interruptible)
[445.845400] Starting subtest: wf_vblank-ts-check-interruptible
[445.863924] Starting dynamic subtest: A-DP1
[456.848816] Dynamic subtest A-DP1: SUCCESS (10.806s)
[456.893214] Starting dynamic subtest: B-DP1
[467.542890] Dynamic subtest B-DP1: SUCCESS (10.706s)
[467.605254] Starting dynamic subtest: C-DP1
[478.105129] Dynamic subtest C-DP1: SUCCESS (10.731s)
[478.127579] Subtest wf_vblank-ts-check-interruptible: SUCCESS (32.257s)
[478.584682] [132/141] (559s left) gem_ctx_param (invalid-set-no-zeromap)
[478.884858] Starting subtest: invalid-set-no-zeromap
[478.906523] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[479.025605] [133/141] (559s left) perf_pmu (all-busy-idle-check-all)
[479.330418] Starting subtest: all-busy-idle-check-all
[479.933999] Subtest all-busy-idle-check-all: SUCCESS (0.626s)
[480.052544] [134/141] (558s left) kms_vblank (pipe-a-query-forked)
[480.401692] Starting subtest: pipe-A-query-forked
[482.784243] Subtest pipe-A-query-forked: SUCCESS (2.367s)
[483.143636] [135/141] (555s left) gem_ctx_shared (q-independent)
[483.445715] Starting subtest: Q-independent
[483.465202] Starting dynamic subtest: rcs0
[483.545487] Dynamic subtest rcs0: SUCCESS (0.102s)
[483.593473] Starting dynamic subtest: bcs0
[483.636765] Dynamic subtest bcs0: SUCCESS (0.077s)
[483.682871] Starting dynamic subtest: vcs0
[483.702062] Dynamic subtest vcs0: SUCCESS (0.059s)
[483.748252] Starting dynamic subtest: vecs0
[483.769436] Dynamic subtest vecs0: SUCCESS (0.062s)
[483.791454] Subtest Q-independent: SUCCESS (0.316s)
[484.039054] [136/141] (554s left) gem_softpin (overlap)
[484.343213] Starting subtest: overlap
[487.273071] Subtest overlap: SUCCESS (2.775s)
[487.374662] [137/141] (551s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[487.798476] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[490.526500] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.674s)
[490.624946] [138/141] (548s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[491.070639] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[493.101298] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.107s)
[493.271998] [139/141] (545s left) gem_exec_schedule (noreorder-priority)
[493.736151] Starting subtest: noreorder-priority
[493.755293] Starting dynamic subtest: rcs0
[494.837873] Dynamic subtest rcs0: SUCCESS (1.126s)
[494.893159] Starting dynamic subtest: bcs0
[495.966183] Dynamic subtest bcs0: SUCCESS (1.127s)
[496.015420] Starting dynamic subtest: vcs0
[497.103332] Dynamic subtest vcs0: SUCCESS (1.131s)
[497.156661] Starting dynamic subtest: vecs0
[498.229199] Dynamic subtest vecs0: SUCCESS (1.125s)
[498.248353] Subtest noreorder-priority: SUCCESS (4.523s)
[498.478264] [140/141] (540s left) i915_pm_rpm (gem-idle)
[500.334373] Starting subtest: gem-idle
[505.903481] Subtest gem-idle: SUCCESS (5.390s)
[506.208658] [141/141] (533s left) perf_pmu (busy-no-semaphores)
[506.511468] Starting subtest: busy-no-semaphores
[506.530634] Starting dynamic subtest: rcs0
[507.018584] Dynamic subtest rcs0: SUCCESS (0.535s)
[507.063914] Starting dynamic subtest: bcs0
[507.558899] Dynamic subtest bcs0: SUCCESS (0.534s)
[507.605941] Starting dynamic subtest: vcs0
[508.089423] Dynamic subtest vcs0: SUCCESS (0.528s)
[508.135213] Starting dynamic subtest: vecs0
[508.631045] Dynamic subtest vecs0: SUCCESS (0.539s)
[508.652817] Subtest busy-no-semaphores: SUCCESS (2.152s)
[508.761355] Closing watchdogs
Done.