[51.712432] Initializing watchdogs
[51.712911]   /dev/watchdog0
[51.745831] [001/141] (960s left) kms_flip (flip-vs-panning-vs-hang)
[52.186036] Starting subtest: flip-vs-panning-vs-hang
[52.199351] Starting dynamic subtest: A-eDP1
[93.423924] Dynamic subtest A-eDP1: SUCCESS (41.223s)
[93.462930] Starting dynamic subtest: D-eDP1
[134.438111] Dynamic subtest D-eDP1: SUCCESS (41.013s)
[134.449689] Subtest flip-vs-panning-vs-hang: SUCCESS (82.265s)
[136.039396] [002/141] (876s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[136.545804] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[136.552364] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[136.699759] [003/141] (875s left) kms_flip (dpms-off-confusion)
[137.098122] Starting subtest: dpms-off-confusion
[137.122591] Starting dynamic subtest: A-eDP1
[146.390882] Dynamic subtest A-eDP1: SUCCESS (9.269s)
[146.429187] Starting dynamic subtest: B-eDP1
[155.229707] Dynamic subtest B-eDP1: SUCCESS (8.838s)
[155.255655] Starting dynamic subtest: C-eDP1
[164.326649] Dynamic subtest C-eDP1: SUCCESS (9.095s)
[164.351479] Starting dynamic subtest: D-eDP1
[173.406066] Dynamic subtest D-eDP1: SUCCESS (9.073s)
[173.428253] Subtest dpms-off-confusion: SUCCESS (36.338s)
[175.003468] [004/141] (837s left) kms_flip (2x-flip-vs-suspend)
[175.395365] Starting subtest: 2x-flip-vs-suspend
[175.555615] Subtest 2x-flip-vs-suspend: SKIP (0.160s)
[175.739914] [005/141] (836s left) kms_chamelium_frames (dp-crc-multiple)
[176.627446] Subtest dp-crc-multiple: SKIP (0.000s)
[177.472509] [006/141] (835s left) prime_busy (after)
[177.879766] Starting subtest: after
[177.912676] Starting dynamic subtest: rcs0
[177.932959] Dynamic subtest rcs0: SUCCESS (0.024s)
[177.965985] Starting dynamic subtest: bcs0
[177.989349] Dynamic subtest bcs0: SUCCESS (0.055s)
[178.019082] Starting dynamic subtest: vcs0
[178.037478] Dynamic subtest vcs0: SUCCESS (0.048s)
[178.074231] Starting dynamic subtest: vcs1
[178.077775] Dynamic subtest vcs1: SUCCESS (0.029s)
[178.113815] Starting dynamic subtest: vecs0
[178.116967] Dynamic subtest vecs0: SUCCESS (0.031s)
[178.147485] Starting dynamic subtest: ccs0
[178.150894] Dynamic subtest ccs0: SUCCESS (0.031s)
[178.258153] Subtest after: SUCCESS (0.377s)
[178.386882] [007/141] (834s left) kms_addfb_basic (too-high)
[178.872605] Starting subtest: too-high
[178.876523] Subtest too-high: SUCCESS (0.004s)
[179.025324] [008/141] (833s left) gem_exec_flush (basic-wb-rw-default)
[179.427737] Starting subtest: basic-wb-rw-default
[185.304267] Subtest basic-wb-rw-default: SUCCESS (5.876s)
[185.597675] [009/141] (827s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[186.077885] Starting subtest: compare-crc-sanitycheck-xr24
[186.087803] Starting dynamic subtest: pipe-A-eDP-1
[187.206197] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.119s)
[187.239286] Starting dynamic subtest: pipe-B-eDP-1
[188.840530] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.629s)
[188.874176] Starting dynamic subtest: pipe-C-eDP-1
[190.235759] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.390s)
[190.268487] Starting dynamic subtest: pipe-D-eDP-1
[192.506367] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.263s)
[192.509354] Subtest compare-crc-sanitycheck-xr24: SUCCESS (6.427s)
[193.464638] [010/141] (819s left) gem_exec_params (invalid-batch-start-offset)
[193.852392] Starting subtest: invalid-batch-start-offset
[193.874500] Subtest invalid-batch-start-offset: SUCCESS (0.018s)
[194.040042] [011/141] (818s left) gem_exec_reloc (basic-wc)
[194.439699] Subtest basic-wc: SKIP (0.000s)
[194.563422] [012/141] (818s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-blt)
[195.061354] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-blt
[207.011770] Subtest fbc-1p-offscren-pri-shrfb-draw-blt: SUCCESS (11.954s)
[207.309464] [013/141] (805s left) vc4/vc4_label_bo (set-bad-handle)
[207.814683] Subtest set-bad-handle: SKIP (0.000s)
[207.925159] [014/141] (805s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-25)
[208.398462] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-25
[208.405973] Starting dynamic subtest: pipe-A-eDP-1
[208.501400] Dynamic subtest pipe-A-eDP-1: SKIP (0.092s)
[208.548840] Starting dynamic subtest: pipe-B-eDP-1
[208.714903] Dynamic subtest pipe-B-eDP-1: SKIP (0.201s)
[208.740955] Starting dynamic subtest: pipe-C-eDP-1
[208.894401] Dynamic subtest pipe-C-eDP-1: SKIP (0.173s)
[208.924081] Starting dynamic subtest: pipe-D-eDP-1
[209.081500] Dynamic subtest pipe-D-eDP-1: SKIP (0.175s)
[209.088618] Subtest planes-upscale-factor-0-25-downscale-factor-0-25: SKIP (0.676s)
[209.235573] [015/141] (803s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[209.757706] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[209.764689] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[209.908545] [016/141] (803s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[210.441164] Starting subtest: 4-tiled-64bpp-rotate-90
[210.503683] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.057s)
[210.673793] [017/141] (802s left) gem_lmem_swapping (smem-oom)
[210.938839] Subtest smem-oom: SKIP (0.000s)
[211.011270] [018/141] (802s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_mtl_rc_ccs)
[211.220086] Starting subtest: pipe-A-bad-pixel-format-4_tiled_mtl_rc_ccs
[211.222359] Subtest pipe-A-bad-pixel-format-4_tiled_mtl_rc_ccs: SUCCESS (0.001s)
[212.501476] [019/141] (800s left) kms_vblank (pipe-b-wait-forked-hang)
[212.966291] Starting subtest: pipe-B-wait-forked-hang
[228.830975] Subtest pipe-B-wait-forked-hang: SUCCESS (15.863s)
[229.764286] [020/141] (783s left) kms_frontbuffer_tracking (fbc-1p-rte)
[230.269654] Starting subtest: fbc-1p-rte
[238.612363] Subtest fbc-1p-rte: SUCCESS (8.350s)
[238.909870] [021/141] (774s left) gem_create (create-size-update)
[239.286332] Starting subtest: create-size-update
[239.290051] Subtest create-size-update: SUCCESS (0.000s)
[239.596286] [022/141] (774s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc)
[241.344162] Starting subtest: pipe-D-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc
[241.350341] Subtest pipe-D-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[242.003299] [023/141] (771s left) perf (whitelisted-registers-userspace-config)
[242.924748] Starting subtest: whitelisted-registers-userspace-config
[242.928346] Subtest whitelisted-registers-userspace-config: SUCCESS (0.006s)
[243.018802] [024/141] (770s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[243.534482] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[243.541995] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.001s)
[243.684644] [025/141] (770s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[244.092852] Starting subtest: yf-tiled-ccs-to-x-tiled
[244.099959] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[244.360789] [026/141] (769s left) syncobj_timeline (invalid-query-illegal-handle)
[244.742547] Starting subtest: invalid-query-illegal-handle
[244.746647] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[244.876513] [027/141] (769s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[245.712213] Starting subtest: cursor-rapid-movement-64x21
[245.747295] Starting dynamic subtest: pipe-A-eDP-1
[247.057617] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.311s)
[247.257653] Starting dynamic subtest: pipe-D-eDP-1
[249.941346] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.708s)
[249.945568] Subtest cursor-rapid-movement-64x21: SUCCESS (4.224s)
[251.110176] [028/141] (763s left) kms_big_joiner (basic)
[251.594449] Subtest basic: SKIP (0.000s)
[251.709797] [029/141] (762s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[252.198897] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[252.205237] Starting dynamic subtest: pipe-A-default-mode
[253.818282] Dynamic subtest pipe-A-default-mode: SKIP (1.604s)
[253.825087] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.618s)
[254.103495] [030/141] (760s left) gem_ctx_persistence (heartbeat-many)
[254.496256] Starting subtest: heartbeat-many
[254.503629] Subtest heartbeat-many: SKIP (0.001s)
[254.669605] [031/141] (759s left) kms_psr (psr2_cursor_mmap_cpu)
[255.159118] Starting subtest: psr2_cursor_mmap_cpu
[258.372518] Subtest psr2_cursor_mmap_cpu: SUCCESS (3.212s)
[259.245206] [032/141] (755s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y_tiled_ccs)
[260.842336] Starting subtest: pipe-C-crc-sprite-planes-basic-y_tiled_ccs
[260.858456] Subtest pipe-C-crc-sprite-planes-basic-y_tiled_ccs: SKIP (0.013s)
[261.678787] [033/141] (752s left) gem_close_race (basic-process)
[262.114654] Starting subtest: basic-process
[262.221107] Subtest basic-process: SUCCESS (0.106s)
[262.486724] [034/141] (752s left) kms_plane_lowres (tiling-4)
[262.966856] Starting subtest: tiling-4
[262.975895] Starting dynamic subtest: pipe-A-eDP-1
[262.982463] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[263.415054] Starting dynamic subtest: pipe-B-eDP-1
[263.421865] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[263.453320] Starting dynamic subtest: pipe-C-eDP-1
[263.459184] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[263.490540] Starting dynamic subtest: pipe-D-eDP-1
[263.497673] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[263.504812] Subtest tiling-4: SKIP (0.506s)
[264.306141] [035/141] (750s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[265.852255] Starting subtest: pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs_cc
[265.858975] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[266.680444] [036/141] (748s left) kms_cursor_crc (cursor-onscreen-64x21)
[267.485371] Starting subtest: cursor-onscreen-64x21
[267.522456] Starting dynamic subtest: pipe-A-eDP-1
[271.495488] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.977s)
[271.683145] Starting dynamic subtest: pipe-D-eDP-1
[276.789417] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.134s)
[276.792870] Subtest cursor-onscreen-64x21: SUCCESS (9.301s)
[277.946645] [037/141] (736s left) kms_flip (nonexisting-fb-interruptible)
[278.369321] Starting subtest: nonexisting-fb-interruptible
[278.406779] Starting dynamic subtest: A-eDP1
[280.159308] Dynamic subtest A-eDP1: SUCCESS (1.756s)
[280.192487] Starting dynamic subtest: B-eDP1
[281.731314] Dynamic subtest B-eDP1: SUCCESS (1.567s)
[281.764550] Starting dynamic subtest: C-eDP1
[283.335574] Dynamic subtest C-eDP1: SUCCESS (1.599s)
[283.369461] Starting dynamic subtest: D-eDP1
[284.893971] Dynamic subtest D-eDP1: SUCCESS (1.553s)
[284.920578] Subtest nonexisting-fb-interruptible: SUCCESS (6.551s)
[286.449223] [038/141] (728s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[286.955733] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[298.294895] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (11.345s)
[298.546778] [039/141] (716s left) prime_busy (hang)
[298.954298] Starting subtest: hang
[298.957438] Starting dynamic subtest: rcs0
[313.423306] Dynamic subtest rcs0: SUCCESS (14.466s)
[313.454999] Starting dynamic subtest: bcs0
[320.552361] Dynamic subtest bcs0: SUCCESS (7.126s)
[320.585657] Starting dynamic subtest: vcs0
[327.550656] Dynamic subtest vcs0: SUCCESS (6.991s)
[327.584639] Starting dynamic subtest: vcs1
[334.592782] Dynamic subtest vcs1: SUCCESS (7.041s)
[334.625165] Starting dynamic subtest: vecs0
[341.526610] Dynamic subtest vecs0: SUCCESS (6.931s)
[341.558957] Starting dynamic subtest: ccs0
[355.354740] Dynamic subtest ccs0: SUCCESS (13.823s)
[355.358485] Subtest hang: SUCCESS (56.402s)
[355.515566] [040/141] (659s left) gem_ctx_persistence (process)
[355.964678] Starting subtest: process
[356.166612] Subtest process: SUCCESS (0.202s)
[356.343372] [041/141] (658s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_mtl_rc_ccs_cc)
[357.782051] Starting subtest: pipe-C-crc-primary-basic-4_tiled_mtl_rc_ccs_cc
[358.801505] Subtest pipe-C-crc-primary-basic-4_tiled_mtl_rc_ccs_cc: SUCCESS (1.019s)
[360.136293] [042/141] (655s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[360.711348] Starting subtest: flip-vs-cursor-atomic
[369.631930] Subtest flip-vs-cursor-atomic: SUCCESS (8.921s)
[370.573239] [043/141] (644s left) gem_userptr_blits (coherency-unsync)
[370.986346] Subtest coherency-unsync: SKIP (0.000s)
[371.249688] [044/141] (644s left) gem_exec_fair (basic-flow)
[371.653187] Subtest basic-flow: SKIP (0.000s)
[371.784970] [045/141] (643s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[372.291999] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[372.299463] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[372.444615] [046/141] (643s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[373.009233] Starting subtest: cursor-vs-flip-legacy
[407.698293] Subtest cursor-vs-flip-legacy: SUCCESS (34.689s)
[408.257590] [047/141] (607s left) drm_buddy (drm_buddy_test)
[408.618252] Starting subtest: drm_buddy_test
[408.630647] Subtest drm_buddy_test: SKIP (0.007s)
[408.741965] [048/141] (606s left) gem_pxp (reject-modify-context-protection-on)
[411.628837] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[411.779876] [049/141] (603s left) kms_atomic (plane-primary-legacy)
[412.583452] Starting subtest: plane-primary-legacy
[412.874606] Subtest plane-primary-legacy: SUCCESS (0.292s)
[414.201866] [050/141] (601s left) gem_exec_reloc (basic-range-active)
[414.587190] Subtest basic-range-active: SKIP (0.000s)
[414.711112] [051/141] (601s left) v3d/v3d_submit_csd (bad-flag)
[415.147616] Subtest bad-flag: SKIP (0.000s)
[415.265944] [052/141] (600s left) kms_flip (plain-flip-ts-check-interruptible)
[415.674778] Starting subtest: plain-flip-ts-check-interruptible
[415.706341] Starting dynamic subtest: A-eDP1
[425.133571] Dynamic subtest A-eDP1: SUCCESS (9.428s)
[425.150598] Starting dynamic subtest: B-eDP1
[434.338764] Dynamic subtest B-eDP1: SUCCESS (9.203s)
[434.361928] Starting dynamic subtest: C-eDP1
[443.501946] Dynamic subtest C-eDP1: SUCCESS (9.159s)
[443.538478] Starting dynamic subtest: D-eDP1
[452.756058] Dynamic subtest D-eDP1: SUCCESS (9.248s)
[452.784780] Subtest plain-flip-ts-check-interruptible: SUCCESS (37.110s)
[454.319262] [053/141] (561s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_ccs)
[456.128887] Starting subtest: pipe-D-bad-aux-stride-y_tiled_ccs
[456.134923] Subtest pipe-D-bad-aux-stride-y_tiled_ccs: SKIP (0.000s)
[456.731834] [054/141] (559s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[457.302800] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[459.329235] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (2.024s)
[460.249917] [055/141] (555s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs)
[462.035138] Starting subtest: pipe-D-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs
[462.051307] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs: SKIP (0.013s)
[462.625344] [056/141] (553s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-c)
[463.104625] Starting subtest: universal-plane-pageflip-windowed-pipe-C
[465.412604] Subtest universal-plane-pageflip-windowed-pipe-C: SUCCESS (2.306s)
[466.348773] [057/141] (549s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[466.727354] Starting subtest: wait-all-for-submit-delayed-submit
[466.833916] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.107s)
[466.987865] [058/141] (549s left) i915_hangman (gt-engine-hang)
[467.416924] Starting subtest: gt-engine-hang
[467.420861] Starting dynamic subtest: rcs0
[470.504227] Dynamic subtest rcs0: SUCCESS (3.086s)
[470.537349] Starting dynamic subtest: bcs0
[473.511974] Dynamic subtest bcs0: SUCCESS (3.002s)
[473.548561] Starting dynamic subtest: vcs0
[475.494818] Dynamic subtest vcs0: SUCCESS (1.979s)
[475.528449] Starting dynamic subtest: vcs1
[477.478606] Dynamic subtest vcs1: SUCCESS (1.981s)
[477.512873] Starting dynamic subtest: vecs0
[479.525753] Dynamic subtest vecs0: SUCCESS (2.043s)
[479.556232] Starting dynamic subtest: ccs0
[481.510432] Dynamic subtest ccs0: SUCCESS (1.980s)
[481.514190] Subtest gt-engine-hang: SUCCESS (14.098s)
[481.724448] [059/141] (534s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[482.246548] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[482.253729] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[482.411256] [060/141] (534s left) syncobj_timeline (wait-all-complex)
[482.791042] Starting subtest: wait-all-complex
[483.008675] Subtest wait-all-complex: SUCCESS (0.218s)
[483.147154] [061/141] (533s left) gem_exec_fence (syncobj-signal)
[485.120502] Starting subtest: syncobj-signal
[485.137813] Subtest syncobj-signal: SUCCESS (0.017s)
[485.717912] [062/141] (530s left) kms_getfb (getfb-handle-valid)
[486.094476] Starting subtest: getfb-handle-valid
[486.098316] Subtest getfb-handle-valid: SUCCESS (0.000s)
[486.283429] [063/141] (530s left) kms_hdr (static-toggle-dpms)
[486.761460] Starting subtest: static-toggle-dpms
[486.769165] Subtest static-toggle-dpms: SKIP (0.001s)
[486.898538] [064/141] (529s left) perf_pmu (busy-check-all)
[487.287893] Starting subtest: busy-check-all
[487.291861] Starting dynamic subtest: rcs0
[487.877126] Dynamic subtest rcs0: SUCCESS (0.587s)
[487.913998] Starting dynamic subtest: bcs0
[488.457375] Dynamic subtest bcs0: SUCCESS (0.576s)
[488.493879] Starting dynamic subtest: vcs0
[490.533541] Dynamic subtest vcs0: SUCCESS (2.071s)
[490.577970] Starting dynamic subtest: vcs1
[492.517838] Dynamic subtest vcs1: SUCCESS (1.980s)
[492.555664] Starting dynamic subtest: vecs0
[494.500988] Dynamic subtest vecs0: SUCCESS (1.980s)
[494.545094] Starting dynamic subtest: ccs0
[495.094799] Dynamic subtest ccs0: SUCCESS (0.588s)
[495.098270] Subtest busy-check-all: SUCCESS (7.809s)
[495.252169] [065/141] (521s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_mtl_mc_ccs)
[496.375338] Starting subtest: pipe-B-bad-pixel-format-4_tiled_mtl_mc_ccs
[496.386114] Subtest pipe-B-bad-pixel-format-4_tiled_mtl_mc_ccs: SUCCESS (0.006s)
[497.642206] [066/141] (519s left) syncobj_timeline (invalid-wait-zero-handles)
[498.021380] Starting subtest: invalid-wait-zero-handles
[498.025126] Subtest invalid-wait-zero-handles: SUCCESS (0.000s)
[498.152924] [067/141] (518s left) fbdev (unaligned-write)
[498.525878] Starting subtest: unaligned-write
[499.451241] Subtest unaligned-write: SUCCESS (0.925s)
[499.606041] [068/141] (517s left) kms_frontbuffer_tracking (fbcpsr-badstride)
[500.104427] Starting subtest: fbcpsr-badstride
[515.220405] Subtest fbcpsr-badstride: SUCCESS (15.121s)
[515.464901] [069/141] (501s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[515.972124] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[515.979593] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[516.133438] [070/141] (501s left) gem_exec_schedule (u-submit-late-slice)
[516.573697] Starting subtest: u-submit-late-slice
[516.577428] Starting dynamic subtest: rcs0
[516.724590] Dynamic subtest rcs0: SUCCESS (0.148s)
[516.763084] Starting dynamic subtest: bcs0
[516.857189] Dynamic subtest bcs0: SUCCESS (0.129s)
[516.895166] Starting dynamic subtest: vcs0
[516.989557] Dynamic subtest vcs0: SUCCESS (0.129s)
[517.031742] Starting dynamic subtest: vcs1
[517.115112] Dynamic subtest vcs1: SUCCESS (0.121s)
[517.152732] Starting dynamic subtest: vecs0
[517.241310] Dynamic subtest vecs0: SUCCESS (0.122s)
[517.282164] Starting dynamic subtest: ccs0
[517.372186] Dynamic subtest ccs0: SUCCESS (0.127s)
[517.375726] Subtest u-submit-late-slice: SUCCESS (0.800s)
[518.685081] [071/141] (498s left) kms_cursor_crc (cursor-alpha-transparent)
[519.179517] Starting subtest: cursor-alpha-transparent
[519.188157] Starting dynamic subtest: pipe-A-eDP-1
[520.570092] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.382s)
[520.610197] Starting dynamic subtest: pipe-D-eDP-1
[522.276518] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.692s)
[522.280715] Subtest cursor-alpha-transparent: SUCCESS (3.095s)
[523.231521] [072/141] (494s left) kms_chamelium_edid (dp-mode-timings)
[524.124433] Subtest dp-mode-timings: SKIP (0.000s)
[524.980358] [073/141] (492s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[525.490762] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[525.497231] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[525.648957] [074/141] (492s left) kms_psr (cursor_plane_move)
[526.126427] Starting subtest: cursor_plane_move
[529.305361] Subtest cursor_plane_move: SUCCESS (3.175s)
[530.237251] [075/141] (487s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[530.740904] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[530.747910] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[530.925170] [076/141] (486s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[531.411615] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[531.420400] Starting dynamic subtest: pipe-A-default-mode
[531.863270] Dynamic subtest pipe-A-default-mode: SKIP (0.437s)
[531.871358] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.451s)
[532.797943] [077/141] (485s left) i915_pm_rc6_residency (rc6-fence)
[533.163807] Starting subtest: rc6-fence
[556.568832] Subtest rc6-fence: SUCCESS (23.405s)
[557.991894] [078/141] (459s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_mtl_rc_ccs)
[559.633235] Starting subtest: pipe-D-bad-rotation-90-4_tiled_mtl_rc_ccs
[560.349903] Subtest pipe-D-bad-rotation-90-4_tiled_mtl_rc_ccs: SUCCESS (0.713s)
[561.669746] [079/141] (456s left) kms_addfb_basic (addfb25-4-tiled)
[562.155879] Starting subtest: addfb25-4-tiled
[562.159752] Subtest addfb25-4-tiled: SUCCESS (0.002s)
[562.324988] [080/141] (455s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[562.841431] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[562.848531] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.001s)
[563.007725] [081/141] (455s left) prime_udl
[563.483419] [082/141] (454s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs)
[564.530304] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs
[568.019896] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs: SUCCESS (3.489s)
[569.808448] [083/141] (448s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[570.306505] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[570.313507] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[570.476296] [084/141] (448s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_dg2_rc_ccs_cc)
[571.668108] Starting subtest: pipe-B-crc-primary-basic-4_tiled_dg2_rc_ccs_cc
[571.674723] Subtest pipe-B-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.002s)
[572.905799] [085/141] (445s left) gem_wait (busy)
[573.350529] Starting subtest: busy
[573.354495] Starting dynamic subtest: all-engines
[574.502342] Dynamic subtest all-engines: SUCCESS (1.149s)
[574.540539] Starting dynamic subtest: rcs0
[575.058056] Dynamic subtest rcs0: SUCCESS (0.552s)
[575.103249] Starting dynamic subtest: bcs0
[575.607686] Dynamic subtest bcs0: SUCCESS (0.546s)
[575.652248] Starting dynamic subtest: vcs0
[577.509088] Dynamic subtest vcs0: SUCCESS (1.896s)
[577.546974] Starting dynamic subtest: vcs1
[579.494824] Dynamic subtest vcs1: SUCCESS (1.980s)
[579.533802] Starting dynamic subtest: vecs0
[581.477884] Dynamic subtest vecs0: SUCCESS (1.979s)
[581.517129] Starting dynamic subtest: ccs0
[582.031565] Dynamic subtest ccs0: SUCCESS (0.551s)
[582.035456] Subtest busy: SUCCESS (8.684s)
[582.413247] [086/141] (436s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[582.818799] Starting subtest: rel-constants-invalid-rel-gen5
[582.822835] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.001s)
[583.009926] [087/141] (435s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[583.532501] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[591.296789] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (7.769s)
[591.556251] [088/141] (427s left) gem_ctx_param (invalid-size-get)
[591.936428] Starting subtest: invalid-size-get
[591.940105] Subtest invalid-size-get: SUCCESS (0.001s)
[592.075355] [089/141] (426s left) syncobj_wait (wait-for-submit-complex)
[592.452084] Starting subtest: wait-for-submit-complex
[592.512217] Subtest wait-for-submit-complex: SUCCESS (0.065s)
[592.657236] [090/141] (426s left) kms_addfb_basic (addfb25-bad-modifier)
[593.028968] Starting subtest: addfb25-bad-modifier
[593.032491] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[593.311176] [091/141] (425s left) syncobj_timeline (wait-any-interrupted)
[593.685473] Starting subtest: wait-any-interrupted
[593.787403] Subtest wait-any-interrupted: SUCCESS (0.103s)
[593.936419] [092/141] (425s left) gem_exec_parallel (contexts)
[594.363484] Starting subtest: contexts
[594.367331] Starting dynamic subtest: rcs0
[600.735559] Dynamic subtest rcs0: SUCCESS (6.372s)
[600.776172] Starting dynamic subtest: bcs0
[606.931798] Dynamic subtest bcs0: SUCCESS (6.191s)
[606.966499] Starting dynamic subtest: vcs0
[612.089387] Dynamic subtest vcs0: SUCCESS (5.153s)
[612.106964] Starting dynamic subtest: vcs1
[617.812614] Dynamic subtest vcs1: SUCCESS (5.719s)
[617.854523] Starting dynamic subtest: vecs0
[623.073151] Dynamic subtest vecs0: SUCCESS (5.255s)
[623.111477] Starting dynamic subtest: ccs0
[629.894426] Dynamic subtest ccs0: SUCCESS (6.816s)
[629.898867] Subtest contexts: SUCCESS (35.537s)
[630.221179] [093/141] (388s left) kms_properties (crtc-properties-atomic)
[630.706124] Starting subtest: crtc-properties-atomic
[635.073613] Subtest crtc-properties-atomic: SUCCESS (4.371s)
[636.032715] [094/141] (383s left) gem_close_race (basic-threads)
[636.461192] Starting subtest: basic-threads
[637.950257] Subtest basic-threads: SUCCESS (1.483s)
[638.192375] [095/141] (381s left) api_intel_bb (intel-bb-blit-none)
[638.571811] Starting subtest: intel-bb-blit-none
[651.319344] Subtest intel-bb-blit-none: SUCCESS (12.746s)
[651.528766] [096/141] (367s left) vgem_basic (mmap)
[651.931501] Starting subtest: mmap
[651.967170] Subtest mmap: SUCCESS (0.039s)
[652.112804] [097/141] (367s left) prime_vgem (coherency-gtt)
[652.526889] Starting subtest: coherency-gtt
[652.533827] Subtest coherency-gtt: SKIP (0.000s)
[652.733259] [098/141] (366s left) gem_exec_suspend (basic)
[653.158450] Starting subtest: basic
[653.161862] Starting dynamic subtest: smem
[658.471560] Dynamic subtest smem: SUCCESS (5.309s)
[658.475345] Subtest basic: SUCCESS (5.313s)
[658.774787] [099/141] (360s left) gem_partial_pwrite_pread (writes-after-reads)
[659.175389] Subtest writes-after-reads: SKIP (0.000s)
[659.318815] [100/141] (360s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-gtt)
[659.832755] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-gtt
[659.839200] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[660.007210] [101/141] (359s left) gem_exec_schedule (preempt-other-chain)
[660.456498] Starting subtest: preempt-other-chain
[660.460309] Starting dynamic subtest: rcs0
[660.940706] Dynamic subtest rcs0: SUCCESS (0.481s)
[660.978947] Starting dynamic subtest: bcs0
[661.397671] Dynamic subtest bcs0: SUCCESS (0.453s)
[661.434959] Starting dynamic subtest: vcs0
[661.765991] Dynamic subtest vcs0: SUCCESS (0.363s)
[661.808482] Starting dynamic subtest: vcs1
[662.159492] Dynamic subtest vcs1: SUCCESS (0.390s)
[662.202836] Starting dynamic subtest: vecs0
[662.617638] Dynamic subtest vecs0: SUCCESS (0.453s)
[662.660732] Starting dynamic subtest: ccs0
[663.135982] Dynamic subtest ccs0: SUCCESS (0.514s)
[663.140148] Subtest preempt-other-chain: SUCCESS (2.682s)
[664.647555] [102/141] (355s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[665.625850] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc
[666.984613] Subtest pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SUCCESS (1.358s)
[668.767601] [103/141] (351s left) gem_userptr_blits (stress-purge)
[669.222983] Starting subtest: stress-purge
[674.727851] Subtest stress-purge: SUCCESS (5.507s)
[675.018761] [104/141] (345s left) gem_softpin (noreloc-interruptible)
[675.578305] Starting subtest: noreloc-interruptible
[681.155862] Subtest noreloc-interruptible: SUCCESS (5.576s)
[681.377373] [105/141] (338s left) gem_exec_balancer (nop)
[681.811069] Starting subtest: nop
[740.495272] Subtest nop: SUCCESS (58.684s)
[741.529174] [106/141] (278s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[742.068709] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[742.075708] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[742.228348] [107/141] (278s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[742.734117] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[756.247208] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (13.517s)
[756.530104] [108/141] (263s left) vc4/vc4_purgeable_bo (access-purgeable-bo-mem)
[757.022528] Subtest access-purgeable-bo-mem: SKIP (0.000s)
[757.158097] [109/141] (263s left) kms_cursor_crc (cursor-suspend)
[757.706332] Starting subtest: cursor-suspend
[757.716261] Starting dynamic subtest: pipe-A-eDP-1
[793.483955] Dynamic subtest pipe-A-eDP-1: SUCCESS (35.762s)
[793.535073] Starting dynamic subtest: pipe-D-eDP-1
[829.379229] Dynamic subtest pipe-D-eDP-1: SUCCESS (35.890s)
[829.383682] Subtest cursor-suspend: SUCCESS (71.674s)
[830.820957] [110/141] (189s left) i915_query (query-regions-garbage-items)
[831.197151] Starting subtest: query-regions-garbage-items
[831.201134] Subtest query-regions-garbage-items: SUCCESS (0.003s)
[831.351588] [111/141] (189s left) syncobj_timeline (etime-multi-wait-submitted)
[831.729388] Starting subtest: etime-multi-wait-submitted
[831.827951] Subtest etime-multi-wait-submitted: SUCCESS (0.104s)
[831.992132] [112/141] (188s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_gen12_mc_ccs)
[833.129193] Starting subtest: pipe-B-crc-primary-basic-y_tiled_gen12_mc_ccs
[833.136362] Subtest pipe-B-crc-primary-basic-y_tiled_gen12_mc_ccs: SKIP (0.002s)
[834.398635] [113/141] (186s left) gem_ctx_isolation (clean)
[834.825824] Starting subtest: clean
[834.829595] Starting dynamic subtest: rcs0
[834.935238] Dynamic subtest rcs0: SUCCESS (0.113s)
[834.994476] Starting dynamic subtest: bcs0
[835.076273] Dynamic subtest bcs0: SUCCESS (0.137s)
[835.134285] Starting dynamic subtest: vcs0
[835.245087] Dynamic subtest vcs0: SUCCESS (0.165s)
[835.301637] Starting dynamic subtest: vcs1
[836.620468] Dynamic subtest vcs1: SUCCESS (1.370s)
[836.671188] Starting dynamic subtest: vecs0
[838.606958] Dynamic subtest vecs0: SUCCESS (1.984s)
[838.661434] Starting dynamic subtest: ccs0
[840.618344] Dynamic subtest ccs0: SUCCESS (2.007s)
[840.622137] Subtest clean: SUCCESS (5.803s)
[840.974777] [114/141] (180s left) i915_pm_rpm (reg-read-ioctl)
[843.730831] Starting subtest: reg-read-ioctl
[851.170766] Subtest reg-read-ioctl: SUCCESS (7.440s)
[852.099931] [115/141] (169s left) v3d/v3d_job_submission (multiple-singlesync-to-multisync)
[852.575449] Subtest multiple-singlesync-to-multisync: SKIP (0.000s)
[852.713294] [116/141] (168s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[853.266400] Starting subtest: y-tiled-32bpp-rotate-180
[853.273560] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[853.440926] [117/141] (167s left) kms_psr2_sf (cursor-plane-move-continuous-exceed-fully-sf)
[860.745133] Starting subtest: cursor-plane-move-continuous-exceed-fully-sf
[860.754356] Starting dynamic subtest: pipe-A-eDP-1
[872.708785] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.950s)
[872.742436] Starting dynamic subtest: pipe-B-eDP-1
[884.638475] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.918s)
[884.641830] Subtest cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (23.893s)
[885.570494] [118/141] (135s left) kms_ccs (pipe-b-missing-ccs-buffer-4_tiled_mtl_rc_ccs)
[886.822490] Starting subtest: pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs
[886.826516] Subtest pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs: SUCCESS (0.002s)
[887.994622] [119/141] (133s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[888.392980] Starting subtest: invalid-bsd2-flag-on-blt
[888.397057] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.001s)
[888.568040] [120/141] (132s left) gem_exec_whisper (basic-queues-priority)
[888.986533] Starting subtest: basic-queues-priority
[921.532392] Subtest basic-queues-priority: SUCCESS (32.537s)
[921.839080] [121/141] ( 99s left) kms_psr (psr2_primary_render)
[922.330944] Starting subtest: psr2_primary_render
[925.739968] Subtest psr2_primary_render: SUCCESS (3.408s)
[926.695869] [122/141] ( 95s left) gem_exec_balancer (hog)
[927.126938] Starting subtest: hog
[927.134160] Subtest hog: SKIP (0.000s)
[928.114597] [123/141] ( 93s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[928.659168] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[932.588293] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (3.928s)
[933.109948] [124/141] ( 88s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[933.493401] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[933.615308] [125/141] ( 88s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[934.102763] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[943.113551] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (9.017s)
[943.305867] [126/141] ( 78s left) gem_bad_reloc (negative-reloc-bltcopy)
[943.705477] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[943.846334] [127/141] ( 78s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[944.389466] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[947.210133] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (2.821s)
[947.528306] [128/141] ( 74s left) gem_softpin (evict-single-offset)
[947.928233] Starting subtest: evict-single-offset
[985.447569] Subtest evict-single-offset: SUCCESS (37.516s)
[985.633451] [129/141] ( 36s left) kms_plane_scaling (intel-max-src-size)
[986.295339] Starting subtest: intel-max-src-size
[986.302550] Subtest intel-max-src-size: SKIP (0.000s)
[986.472817] [130/141] ( 35s left) kms_vblank (pipe-d-wait-forked)
[986.965645] Starting subtest: pipe-D-wait-forked
[991.549405] Subtest pipe-D-wait-forked: SUCCESS (4.587s)
[992.509226] [131/141] ( 30s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[993.028526] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[993.036694] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[993.207259] [132/141] ( 29s left) api_intel_bb (reset-flags)
[993.590707] Starting subtest: reset-flags
[993.631832] Subtest reset-flags: SUCCESS (0.041s)
[993.820230] [133/141] ( 28s left) gem_softpin (evict-snoop-interruptible)
[994.238137] Starting subtest: evict-snoop-interruptible
[994.245673] Subtest evict-snoop-interruptible: SKIP (0.000s)
[994.418237] [134/141] ( 28s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[994.920217] Starting subtest: psr-rgb101010-draw-mmap-wc
[1006.916419] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (11.994s)
[1007.188124] [135/141] ( 15s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[1008.091388] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[1008.966492] [136/141] ( 14s left) gen9_exec_parse (valid-registers)
[1009.356851] Subtest valid-registers: SKIP (0.000s)
[1009.480680] [137/141] ( 13s left) gem_mmap_gtt (big-copy)
[1009.854482] Subtest big-copy: SKIP (0.000s)
[1009.978710] [138/141] ( 13s left) kms_frontbuffer_tracking (fbc-tiling-y)
[1010.477766] Starting subtest: fbc-tiling-y
[1010.484301] Subtest fbc-tiling-y: SKIP (0.000s)
[1010.656869] [139/141] ( 12s left) kms_big_fb (linear-16bpp-rotate-90)
[1011.204095] Starting subtest: linear-16bpp-rotate-90
[1011.263705] Subtest linear-16bpp-rotate-90: SKIP (0.057s)
[1011.453518] [140/141] ( 11s left) gem_mmap_gtt (pf-nonblock)
[1011.830136] Subtest pf-nonblock: SKIP (0.000s)
[1011.957199] [141/141] ( 11s left) drm_read (fault-buffer)
[1013.028454] Starting subtest: fault-buffer
[1013.031792] Subtest fault-buffer: SUCCESS (0.003s)
[1013.260781] Closing watchdogs
Done.