[41.133148] Initializing watchdogs
[41.133419]   /dev/watchdog0
[41.149653] [001/141] (960s left) i915_pm_rps (waitboost)
[41.407494] Starting subtest: waitboost
[43.997591] Subtest waitboost: SUCCESS (2.590s)
[44.083703] [002/141] (957s left) kms_cursor_crc (cursor-offscreen-128x128)
[44.406645] Starting subtest: cursor-offscreen-128x128
[44.443153] Starting dynamic subtest: pipe-A-DP-1
[47.244975] Dynamic subtest pipe-A-DP-1: SUCCESS (2.801s)
[47.327695] Starting dynamic subtest: pipe-C-DP-1
[50.193133] Dynamic subtest pipe-C-DP-1: SUCCESS (2.877s)
[50.194387] Subtest cursor-offscreen-128x128: SUCCESS (5.785s)
[50.548407] [003/141] (951s left) syncobj_timeline (device-submit-unordered)
[50.764277] Starting subtest: device-submit-unordered
[50.767773] Subtest device-submit-unordered: SUCCESS (0.002s)
[50.844722] [004/141] (950s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_dg2_rc_ccs)
[51.242939] Starting subtest: pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs
[51.245614] Subtest pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[51.824896] [005/141] (949s left) syncobj_timeline (single-wait-all-available-submitted)
[52.030474] Starting subtest: single-wait-all-available-submitted
[52.032097] Subtest single-wait-all-available-submitted: SUCCESS (0.001s)
[52.108722] [006/141] (949s left) kms_ccs (pipe-a-bad-aux-stride-y_tiled_ccs)
[52.561582] Starting subtest: pipe-A-bad-aux-stride-y_tiled_ccs
[52.564942] Subtest pipe-A-bad-aux-stride-y_tiled_ccs: SUCCESS (0.002s)
[53.090282] [007/141] (948s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[53.431098] Starting subtest: 2x-flip-vs-cursor-legacy
[53.435761] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.004s)
[53.515418] [008/141] (948s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[53.912342] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[53.915272] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[54.018375] [009/141] (947s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[54.522427] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[54.525120] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[54.638328] [010/141] (947s left) kms_chamelium_hpd (vga-hpd-fast)
[55.210240] Subtest vga-hpd-fast: SKIP (0.000s)
[55.622554] [011/141] (946s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[55.927882] Starting subtest: fbc-rgb565-draw-pwrite
[58.263501] Subtest fbc-rgb565-draw-pwrite: SUCCESS (2.337s)
[58.382942] [012/141] (943s left) kms_concurrent (pipe-a)
[58.690230] Starting subtest: pipe-A
[58.692893] Starting dynamic subtest: DP-1
[59.521477] Dynamic subtest DP-1: SUCCESS (0.827s)
[59.522760] Subtest pipe-A: SUCCESS (0.830s)
[59.835921] [013/141] (942s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[60.140248] Starting subtest: cursorA-vs-flipB-atomic
[60.143035] Subtest cursorA-vs-flipB-atomic: SKIP (0.002s)
[60.219257] [014/141] (941s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[60.521200] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[60.523681] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[60.618949] [015/141] (941s left) kms_vblank (pipe-a-ts-continuation-idle-hang)
[60.928379] Starting subtest: pipe-A-ts-continuation-idle-hang
[68.016703] Subtest pipe-A-ts-continuation-idle-hang: SUCCESS (7.092s)
[68.345557] [016/141] (933s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_dg2_rc_ccs)
[68.952385] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs
[68.956536] Subtest pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.002s)
[69.364203] [017/141] (932s left) kms_plane (plane-position-covered)
[69.664202] Starting subtest: plane-position-covered
[69.665446] Starting dynamic subtest: pipe-A-planes
[71.147970] Dynamic subtest pipe-A-planes: SUCCESS (1.484s)
[71.164095] Starting dynamic subtest: pipe-B-planes
[72.962202] Dynamic subtest pipe-B-planes: SUCCESS (1.811s)
[72.963641] Subtest plane-position-covered: SUCCESS (3.301s)
[73.294642] [018/141] (929s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[73.618755] Starting subtest: yf-tiled-64bpp-rotate-180
[73.621829] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[73.711431] [019/141] (928s left) prime_busy (after-wait)
[73.926449] Starting subtest: after-wait
[73.944259] Starting dynamic subtest: rcs0
[73.967927] Dynamic subtest rcs0: SUCCESS (0.024s)
[73.983519] Starting dynamic subtest: bcs0
[73.987496] Dynamic subtest bcs0: SUCCESS (0.016s)
[74.003383] Starting dynamic subtest: vcs0
[74.007694] Dynamic subtest vcs0: SUCCESS (0.019s)
[74.023231] Starting dynamic subtest: vecs0
[74.024648] Dynamic subtest vecs0: SUCCESS (0.016s)
[74.136346] Subtest after-wait: SUCCESS (0.209s)
[74.211917] [020/141] (928s left) api_intel_bb (blit-reloc-keep-cache)
[74.413935] Starting subtest: blit-reloc-keep-cache
[74.437209] Subtest blit-reloc-keep-cache: SUCCESS (0.022s)
[74.544333] [021/141] (927s left) kms_plane_scaling (planes-downscale-factor-0-5)
[74.846866] Starting subtest: planes-downscale-factor-0-5
[74.848369] Starting dynamic subtest: pipe-A-DP-1
[75.192441] Dynamic subtest pipe-A-DP-1: SUCCESS (0.345s)
[75.209086] Starting dynamic subtest: pipe-B-DP-1
[75.612143] Dynamic subtest pipe-B-DP-1: SUCCESS (0.414s)
[75.626524] Starting dynamic subtest: pipe-C-DP-1
[75.706922] Dynamic subtest pipe-C-DP-1: SKIP (0.091s)
[75.708218] Subtest planes-downscale-factor-0-5: SUCCESS (0.861s)
[76.097096] [022/141] (926s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[76.409651] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[76.412407] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[76.497507] [023/141] (925s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[76.807333] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[76.811253] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[76.898159] [024/141] (925s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[77.226817] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[77.229425] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[77.329213] [025/141] (925s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[77.635962] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[80.576628] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SUCCESS (2.944s)
[80.713036] [026/141] (921s left) vc4/vc4_tiling (set-bad-flags)
[80.978191] Subtest set-bad-flags: SKIP (0.000s)
[81.045651] [027/141] (921s left) kms_invalid_mode (bad-hsync-end)
[81.348093] Starting subtest: bad-hsync-end
[81.349470] Starting dynamic subtest: DP-1-pipe-A
[81.453971] Dynamic subtest DP-1-pipe-A: SUCCESS (0.105s)
[81.485907] Starting dynamic subtest: DP-1-pipe-B
[81.487485] Dynamic subtest DP-1-pipe-B: SUCCESS (0.015s)
[81.502598] Starting dynamic subtest: DP-1-pipe-C
[81.503855] Dynamic subtest DP-1-pipe-C: SUCCESS (0.015s)
[81.505174] Subtest bad-hsync-end: SUCCESS (0.143s)
[81.835070] [028/141] (920s left) kms_flip (absolute-wf_vblank)
[82.124468] Starting subtest: absolute-wf_vblank
[82.125878] Starting dynamic subtest: A-DP1
[92.669966] Dynamic subtest A-DP1: SUCCESS (10.545s)
[92.685793] Starting dynamic subtest: B-DP1
[103.130060] Dynamic subtest B-DP1: SUCCESS (10.459s)
[103.145738] Starting dynamic subtest: C-DP1
[113.595053] Dynamic subtest C-DP1: SUCCESS (10.463s)
[113.598703] Subtest absolute-wf_vblank: SUCCESS (31.477s)
[114.017655] [029/141] (888s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_mtl_rc_ccs)
[114.680644] Subtest pipe-D-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[114.976790] [030/141] (887s left) kms_universal_plane (universal-plane-pipe-d-sanity)
[115.286129] Subtest universal-plane-pipe-D-sanity: SKIP (0.000s)
[115.359766] [031/141] (887s left) kms_ccs (pipe-a-crc-primary-basic-yf_tiled_ccs)
[115.766464] Starting subtest: pipe-A-crc-primary-basic-yf_tiled_ccs
[116.411570] Subtest pipe-A-crc-primary-basic-yf_tiled_ccs: SUCCESS (0.645s)
[117.131556] [032/141] (885s left) gem_exec_reloc (basic-write-cpu-active)
[117.348634] Starting subtest: basic-write-cpu-active
[117.488676] Subtest basic-write-cpu-active: SUCCESS (0.142s)
[117.663675] [033/141] (885s left) gem_exec_reloc (basic-wc-active)
[117.876193] Starting subtest: basic-wc-active
[118.017909] Subtest basic-wc-active: SUCCESS (0.140s)
[118.196658] [034/141] (884s left) gem_create (create-massive)
[118.401734] Starting subtest: create-massive
[118.403117] Subtest create-massive: SUCCESS (0.000s)
[118.613717] [035/141] (884s left) gem_ctx_shared (exec-shared-gtt)
[118.842982] Starting subtest: exec-shared-gtt
[118.844521] Starting dynamic subtest: rcs0
[118.859373] Dynamic subtest rcs0: SUCCESS (0.015s)
[118.882047] Starting dynamic subtest: bcs0
[118.883489] Dynamic subtest bcs0: SUCCESS (0.013s)
[118.900229] Starting dynamic subtest: vcs0
[118.901527] Dynamic subtest vcs0: SUCCESS (0.010s)
[118.917108] Starting dynamic subtest: vecs0
[118.918439] Dynamic subtest vecs0: SUCCESS (0.008s)
[118.919682] Subtest exec-shared-gtt: SUCCESS (0.051s)
[119.114202] [036/141] (883s left) sw_sync (sync_expired_merge)
[119.314116] Starting subtest: sync_expired_merge
[120.389327] Subtest sync_expired_merge: SUCCESS (1.074s)
[120.463663] [037/141] (882s left) i915_getparams_basic (basic-subslice-total)
[120.665418] Starting subtest: basic-subslice-total
[120.668395] Subtest basic-subslice-total: SUCCESS (0.000s)
[120.746900] [038/141] (882s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[121.061495] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[121.063996] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[121.163934] [039/141] (881s left) gem_exec_balancer (smoke)
[121.391836] Starting subtest: smoke
[125.075989] Subtest smoke: SUCCESS (3.683s)
[128.996453] [040/141] (874s left) gem_mmap_offset (bad-extensions)
[129.201084] Starting subtest: bad-extensions
[129.202712] Subtest bad-extensions: SUCCESS (0.000s)
[129.295499] [041/141] (873s left) fbdev (write)
[129.512990] Starting subtest: write
[130.246262] Subtest write: SUCCESS (0.733s)
[130.312286] [042/141] (872s left) kms_flip (dpms-vs-vblank-race)
[130.596335] Starting subtest: dpms-vs-vblank-race
[130.600197] Starting dynamic subtest: A-DP1
[134.914132] Dynamic subtest A-DP1: SUCCESS (4.314s)
[134.929174] Starting dynamic subtest: B-DP1
[139.171535] Dynamic subtest B-DP1: SUCCESS (4.257s)
[139.186759] Starting dynamic subtest: C-DP1
[143.473924] Dynamic subtest C-DP1: SUCCESS (4.299s)
[143.475556] Subtest dpms-vs-vblank-race: SUCCESS (12.880s)
[143.848819] [043/141] (859s left) gem_fence_thrash (bo-write-verify-y)
[144.054261] Starting subtest: bo-write-verify-y
[145.300410] Subtest bo-write-verify-y: SUCCESS (1.246s)
[145.395858] [044/141] (857s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[145.703775] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[145.706508] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[145.796547] [045/141] (857s left) kms_cursor_crc (cursor-sliding-128x128)
[146.101699] Starting subtest: cursor-sliding-128x128
[146.114826] Starting dynamic subtest: pipe-A-DP-1
[149.793526] Dynamic subtest pipe-A-DP-1: SUCCESS (3.676s)
[149.868618] Starting dynamic subtest: pipe-C-DP-1
[153.844873] Dynamic subtest pipe-C-DP-1: SUCCESS (3.991s)
[153.846378] Subtest cursor-sliding-128x128: SUCCESS (7.744s)
[154.187131] [046/141] (849s left) kms_vblank (pipe-b-wait-forked-hang)
[154.494343] Starting subtest: pipe-B-wait-forked-hang
[161.971246] Subtest pipe-B-wait-forked-hang: SUCCESS (7.478s)
[162.307396] [047/141] (841s left) syncobj_wait (reset-signaled)
[162.514760] Starting subtest: reset-signaled
[162.516500] Subtest reset-signaled: SUCCESS (0.000s)
[162.606728] [048/141] (840s left) perf_pmu (cpu-hotplug)
[162.814541] Starting subtest: cpu-hotplug
[162.820886] Subtest cpu-hotplug: SKIP (0.003s)
[162.923315] [049/141] (840s left) gem_exec_whisper (basic-queues-priority-all)
[163.151369] Starting subtest: basic-queues-priority-all
[185.946719] Subtest basic-queues-priority-all: SUCCESS (22.794s)
[186.141750] [050/141] (817s left) v3d/v3d_wait_bo (map-bo-0ns)
[186.386754] Subtest map-bo-0ns: SKIP (0.000s)
[186.460146] [051/141] (817s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[186.775287] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[186.777985] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[186.874752] [052/141] (816s left) kms_big_fb (linear-32bpp-rotate-90)
[187.205511] Starting subtest: linear-32bpp-rotate-90
[187.295577] Subtest linear-32bpp-rotate-90: SKIP (0.086s)
[187.408638] [053/141] (816s left) kms_psr2_su (page_flip-xrgb8888)
[187.614335] Subtest page_flip-XRGB8888: SKIP (0.000s)
[187.673677] [054/141] (815s left) kms_psr2_sf (plane-move-sf-dmg-area)
[187.880604] Subtest plane-move-sf-dmg-area: SKIP (0.000s)
[187.924946] [055/141] (815s left) gem_exec_reloc (basic-cpu)
[188.137931] Starting subtest: basic-cpu
[188.160494] Subtest basic-cpu: SUCCESS (0.021s)
[188.341845] [056/141] (815s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[188.648189] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[188.651054] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[188.741842] [057/141] (814s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[189.038562] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[189.039917] Starting dynamic subtest: pipe-A-valid-mode
[189.740404] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.701s)
[189.742709] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SUCCESS (0.704s)
[190.082244] [058/141] (813s left) i915_pm_rpm (gem-evict-pwrite)
[191.994344] Starting subtest: gem-evict-pwrite
[193.090856] Subtest gem-evict-pwrite: SUCCESS (1.091s)
[193.550043] [059/141] (810s left) gem_ctx_param (invalid-param-set)
[193.755434] Starting subtest: invalid-param-set
[193.757131] Subtest invalid-param-set: SUCCESS (0.000s)
[193.847688] [060/141] (809s left) kms_ccs (pipe-c-bad-rotation-90-yf_tiled_ccs)
[194.424420] Starting subtest: pipe-C-bad-rotation-90-yf_tiled_ccs
[194.427182] Subtest pipe-C-bad-rotation-90-yf_tiled_ccs: SKIP (0.000s)
[194.834402] [061/141] (809s left) perf_pmu (idle-no-semaphores)
[195.045428] Starting subtest: idle-no-semaphores
[195.046876] Starting dynamic subtest: rcs0
[195.566662] Dynamic subtest rcs0: SUCCESS (0.519s)
[195.585289] Starting dynamic subtest: bcs0
[196.081798] Dynamic subtest bcs0: SUCCESS (0.513s)
[196.100413] Starting dynamic subtest: vcs0
[196.597783] Dynamic subtest vcs0: SUCCESS (0.514s)
[196.616304] Starting dynamic subtest: vecs0
[197.113781] Dynamic subtest vecs0: SUCCESS (0.514s)
[197.115709] Subtest idle-no-semaphores: SUCCESS (2.069s)
[197.212985] [062/141] (806s left) gem_exec_reloc (basic-gtt-cpu)
[197.426980] Starting subtest: basic-gtt-cpu
[197.448827] Subtest basic-gtt-cpu: SUCCESS (0.022s)
[197.646540] [063/141] (806s left) gem_exec_balancer (hang)
[201.718391] Starting subtest: hang
[205.305838] Subtest hang: SUCCESS (3.587s)
[205.397775] [064/141] (798s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[205.724622] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[207.156373] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.430s)
[207.314732] [065/141] (796s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[207.628810] Starting subtest: basic-max-pipe-crc-check
[207.631602] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[207.678890] [066/141] (796s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[208.003953] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[209.288887] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (1.284s)
[209.631140] [067/141] (794s left) gem_exec_fence (invalid-timeline-fence-array)
[210.513935] Starting subtest: invalid-timeline-fence-array
[210.524413] Subtest invalid-timeline-fence-array: SUCCESS (0.010s)
[210.746732] [068/141] (793s left) kms_chamelium_frames (dp-crc-multiple)
[211.158142] Subtest dp-crc-multiple: SKIP (0.000s)
[211.449810] [069/141] (792s left) gem_fenced_exec_thrash (2-spare-fences)
[211.661481] Starting subtest: 2-spare-fences
[213.824605] Subtest 2-spare-fences: SUCCESS (2.162s)
[213.991589] [070/141] (790s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[214.319510] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[214.324844] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.003s)
[214.428537] [071/141] (789s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[214.745924] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[214.749085] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[214.845385] [072/141] (789s left) kms_psr (sprite_mmap_cpu)
[215.048655] Subtest sprite_mmap_cpu: SKIP (0.000s)
[215.110667] [073/141] (789s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[215.424232] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[215.426964] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[215.528904] [074/141] (788s left) kms_cursor_crc (cursor-sliding-max-size)
[215.860094] Starting subtest: cursor-sliding-max-size
[215.864760] Subtest cursor-sliding-max-size: SKIP (0.000s)
[215.962120] [075/141] (788s left) kms_addfb_basic (clobberred-modifier)
[216.168082] Starting subtest: clobberred-modifier
[216.169506] Subtest clobberred-modifier: SUCCESS (0.000s)
[216.361817] [076/141] (788s left) api_intel_bb (reset-bb)
[216.565426] Starting subtest: reset-bb
[216.570480] Subtest reset-bb: SUCCESS (0.005s)
[216.694884] [077/141] (787s left) kms_vblank (pipe-d-ts-continuation-modeset-rpm)
[216.995148] Subtest pipe-D-ts-continuation-modeset-rpm: SKIP (0.000s)
[217.078993] [078/141] (787s left) kms_plane_lowres (tiling-y)
[217.379884] Starting subtest: tiling-y
[217.381236] Starting dynamic subtest: pipe-A-DP-1
[223.653372] Dynamic subtest pipe-A-DP-1: SUCCESS (6.274s)
[223.786997] Starting dynamic subtest: pipe-B-DP-1
[229.869091] Dynamic subtest pipe-B-DP-1: SUCCESS (6.098s)
[229.991832] Starting dynamic subtest: pipe-C-DP-1
[234.100228] Dynamic subtest pipe-C-DP-1: SUCCESS (4.130s)
[234.213881] Subtest tiling-y: SUCCESS (16.838s)
[234.682376] [079/141] (769s left) kms_vblank (pipe-c-wait-forked-busy)
[234.984614] Starting subtest: pipe-C-wait-forked-busy
[237.943853] Subtest pipe-C-wait-forked-busy: SUCCESS (2.959s)
[238.266823] [080/141] (766s left) api_intel_allocator (open-vm)
[238.470462] Starting subtest: open-vm
[238.474954] Subtest open-vm: SUCCESS (0.004s)
[238.580995] [081/141] (766s left) sysfs_timeslice_duration (timeout)
[238.792534] Starting subtest: timeout
[238.797834] Starting dynamic subtest: vecs0
[239.688235] Dynamic subtest vecs0: SUCCESS (0.893s)
[239.710276] Starting dynamic subtest: vcs0
[240.578153] Dynamic subtest vcs0: SUCCESS (0.885s)
[240.598765] Starting dynamic subtest: bcs0
[241.469214] Dynamic subtest bcs0: SUCCESS (0.888s)
[241.489447] Starting dynamic subtest: rcs0
[242.379360] Dynamic subtest rcs0: SUCCESS (0.908s)
[242.381028] Subtest timeout: SUCCESS (3.588s)
[242.464871] [082/141] (762s left) kms_ccs (pipe-d-ccs-on-another-bo-y_tiled_gen12_mc_ccs)
[243.144413] Subtest pipe-D-ccs-on-another-bo-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[243.461898] [083/141] (761s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[243.768684] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[243.771389] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[243.886637] [084/141] (760s left) kms_vblank (pipe-b-wait-idle)
[244.197226] Starting subtest: pipe-B-wait-idle
[246.844202] Subtest pipe-B-wait-idle: SUCCESS (2.646s)
[247.181101] [085/141] (757s left) gem_madvise (dontneed-before-mmap)
[247.380648] Starting subtest: dontneed-before-mmap
[247.398511] Subtest dontneed-before-mmap: SUCCESS (0.016s)
[247.497103] [086/141] (757s left) prime_mmap (test_errors)
[247.702357] Starting subtest: test_errors
[247.703772] Starting dynamic subtest: test_errors-smem
[247.723575] Dynamic subtest test_errors-smem: SUCCESS (0.020s)
[247.725518] Subtest test_errors: SUCCESS (0.023s)
[247.830491] [087/141] (757s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_mtl_rc_ccs)
[248.493059] Subtest pipe-D-bad-pixel-format-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[248.811917] [088/141] (756s left) kms_addfb_basic (size-max)
[249.115926] Starting subtest: size-max
[249.117464] Subtest size-max: SUCCESS (0.000s)
[249.244636] [089/141] (755s left) kms_setmode (invalid-clone-exclusive-crtc)
[249.449347] Starting subtest: invalid-clone-exclusive-crtc
[249.453864] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[249.544551] [090/141] (755s left) syncobj_timeline (invalid-query-one-illegal-handle)
[249.748292] Starting subtest: invalid-query-one-illegal-handle
[249.750132] Subtest invalid-query-one-illegal-handle: SUCCESS (0.001s)
[249.844801] [091/141] (755s left) kms_atomic_transition (modeset-transition-nonblocking)
[250.145591] Starting subtest: modeset-transition-nonblocking
[250.146984] Starting dynamic subtest: 1x-outputs
[254.895184] Dynamic subtest 1x-outputs: SUCCESS (4.748s)
[255.010109] Subtest modeset-transition-nonblocking: SUCCESS (4.858s)
[255.344700] [092/141] (749s left) kms_draw_crc (draw-method-mmap-cpu)
[255.656454] Starting subtest: draw-method-mmap-cpu
[255.657916] Starting dynamic subtest: xrgb8888-untiled
[255.953166] Dynamic subtest xrgb8888-untiled: SUCCESS (0.295s)
[255.971582] Starting dynamic subtest: rgb565-untiled
[256.217422] Dynamic subtest rgb565-untiled: SUCCESS (0.263s)
[256.238598] Starting dynamic subtest: xrgb2101010-untiled
[256.502424] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.281s)
[256.521032] Starting dynamic subtest: xrgb8888-xtiled
[256.702438] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.197s)
[256.720931] Starting dynamic subtest: rgb565-xtiled
[256.884480] Dynamic subtest rgb565-xtiled: SUCCESS (0.181s)
[256.906803] Starting dynamic subtest: xrgb2101010-xtiled
[257.067610] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.180s)
[257.089207] Starting dynamic subtest: xrgb8888-ytiled
[257.267466] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.197s)
[257.288928] Starting dynamic subtest: rgb565-ytiled
[257.450373] Dynamic subtest rgb565-ytiled: SUCCESS (0.181s)
[257.472099] Starting dynamic subtest: xrgb2101010-ytiled
[257.634409] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.181s)
[257.635971] Subtest draw-method-mmap-cpu: SUCCESS (1.981s)
[257.743105] [093/141] (747s left) gem_exec_schedule (u-semaphore-user)
[257.980652] Starting subtest: u-semaphore-user
[258.003852] Subtest u-semaphore-user: SUCCESS (0.023s)
[258.360656] [094/141] (746s left) kms_selftest (drm_format_helper)
[258.557289] Starting subtest: drm_format_helper
[258.562889] Subtest drm_format_helper: SKIP (0.004s)
[258.626064] [095/141] (746s left) kms_addfb_basic (master-rmfb)
[258.831699] Starting subtest: master-rmfb
[258.833242] Subtest master-rmfb: SUCCESS (0.001s)
[259.044154] [096/141] (746s left) kms_panel_fitting (legacy)
[259.354680] Starting subtest: legacy
[259.357426] Subtest legacy: SKIP (0.000s)
[259.442998] [097/141] (745s left) gem_exec_params (invalid-bsd-ring)
[259.653115] Starting subtest: invalid-bsd-ring
[259.659245] Subtest invalid-bsd-ring: SUCCESS (0.002s)
[259.760291] [098/141] (745s left) i915_hangman (gt-error-state-capture)
[259.989327] Starting subtest: gt-error-state-capture
[259.991091] Starting dynamic subtest: rcs0
[269.271114] Dynamic subtest rcs0: SUCCESS (9.280s)
[269.296161] Starting dynamic subtest: bcs0
[279.240227] Dynamic subtest bcs0: SUCCESS (9.966s)
[279.265603] Starting dynamic subtest: vcs0
[289.254918] Dynamic subtest vcs0: SUCCESS (9.983s)
[289.274167] Starting dynamic subtest: vecs0
[299.275999] Dynamic subtest vecs0: SUCCESS (10.048s)
[299.277577] Subtest gt-error-state-capture: SUCCESS (39.288s)
[299.393508] [099/141] (706s left) gem_exec_schedule (promotion)
[299.636391] Starting subtest: promotion
[299.638098] Starting dynamic subtest: rcs0
[299.781847] Dynamic subtest rcs0: SUCCESS (0.144s)
[299.808798] Starting dynamic subtest: bcs0
[299.939375] Dynamic subtest bcs0: SUCCESS (0.155s)
[299.965996] Starting dynamic subtest: vcs0
[300.075454] Dynamic subtest vcs0: SUCCESS (0.133s)
[300.100021] Starting dynamic subtest: vecs0
[300.215207] Dynamic subtest vecs0: SUCCESS (0.136s)
[300.217858] Subtest promotion: SUCCESS (0.579s)
[300.577439] [100/141] (704s left) gem_pread (exhaustion)
[300.780930] Starting subtest: exhaustion
[323.068500] Subtest exhaustion: SUCCESS (22.287s)
[323.183960] [101/141] (682s left) gem_spin_batch (spin-all-new)
[323.415664] Starting subtest: spin-all-new
[323.445056] Subtest spin-all-new: SUCCESS (0.029s)
[323.677583] [102/141] (681s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[323.980860] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[323.983434] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[324.094860] [103/141] (681s left) gem_media_fill (media-fill)
[324.314863] Starting subtest: media-fill
[324.319295] Starting dynamic subtest: smem
[324.328540] Dynamic subtest smem: SUCCESS (0.011s)
[324.330496] Subtest media-fill: SUCCESS (0.014s)
[324.544943] [104/141] (681s left) gem_mmap_wc (read-write-distinct)
[324.748195] Starting subtest: read-write-distinct
[324.779769] Subtest read-write-distinct: SUCCESS (0.032s)
[324.893844] [105/141] (680s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc)
[325.520916] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc
[325.526204] Subtest pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc: SKIP (0.002s)
[325.920339] [106/141] (679s left) kms_flip (plain-flip-fb-recreate-interruptible)
[326.226936] Starting subtest: plain-flip-fb-recreate-interruptible
[326.232253] Starting dynamic subtest: A-DP1
[337.053984] Dynamic subtest A-DP1: SUCCESS (10.821s)
[337.079259] Starting dynamic subtest: B-DP1
[347.799608] Dynamic subtest B-DP1: SUCCESS (10.741s)
[347.822866] Starting dynamic subtest: C-DP1
[358.512371] Dynamic subtest C-DP1: SUCCESS (10.708s)
[358.516268] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (32.285s)
[358.924868] [107/141] (646s left) vgem_basic (dmabuf-mmap)
[359.131908] Starting subtest: dmabuf-mmap
[359.174359] Subtest dmabuf-mmap: SUCCESS (0.043s)
[359.255970] [108/141] (646s left) gem_exec_flush (basic-uc-set-default)
[359.481139] Starting subtest: basic-uc-set-default
[364.967948] Subtest basic-uc-set-default: SUCCESS (5.487s)
[365.172375] [109/141] (640s left) gem_exec_schedule (independent)
[365.401196] Starting subtest: independent
[365.402771] Starting dynamic subtest: rcs0
[365.590963] Dynamic subtest rcs0: SUCCESS (0.188s)
[365.619399] Starting dynamic subtest: bcs0
[365.799447] Dynamic subtest bcs0: SUCCESS (0.205s)
[365.826471] Starting dynamic subtest: vcs0
[365.990330] Dynamic subtest vcs0: SUCCESS (0.188s)
[366.017897] Starting dynamic subtest: vecs0
[366.178496] Dynamic subtest vecs0: SUCCESS (0.185s)
[366.180536] Subtest independent: SUCCESS (0.779s)
[366.522758] [110/141] (639s left) drm_fdinfo (virtual-busy)
[366.728695] Starting subtest: virtual-busy
[368.902126] Subtest virtual-busy: SUCCESS (2.174s)
[368.986782] [111/141] (636s left) v3d/v3d_submit_csd (bad-perfmon)
[369.248636] Subtest bad-perfmon: SKIP (0.000s)
[369.321994] [112/141] (636s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[369.640450] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[369.643173] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[369.756825] [113/141] (636s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-signaled)
[369.960224] Starting subtest: invalid-multi-wait-available-unsubmitted-signaled
[369.962036] Subtest invalid-multi-wait-available-unsubmitted-signaled: SUCCESS (0.002s)
[370.056049] [114/141] (635s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[370.360596] Starting subtest: basic-flip-before-cursor-varying-size
[371.462310] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.103s)
[371.798998] [115/141] (634s left) kms_cdclk (mode-transition)
[372.002878] Subtest mode-transition: SKIP (0.000s)
[372.061797] [116/141] (634s left) gem_ctx_persistence (legacy-engines-mixed-process)
[372.268374] Starting subtest: legacy-engines-mixed-process
[372.273300] Starting dynamic subtest: render
[372.646400] Dynamic subtest render: SUCCESS (0.375s)
[372.670918] Starting dynamic subtest: bsd
[372.998525] Dynamic subtest bsd: SUCCESS (0.348s)
[373.022230] Starting dynamic subtest: blt
[373.350139] Dynamic subtest blt: SUCCESS (0.348s)
[373.373901] Starting dynamic subtest: vebox
[373.703176] Dynamic subtest vebox: SUCCESS (0.349s)
[373.704709] Subtest legacy-engines-mixed-process: SUCCESS (1.435s)
[373.797580] [117/141] (632s left) gem_partial_pwrite_pread (write-uncached)
[374.013974] Starting subtest: write-uncached
[388.278198] Subtest write-uncached: SUCCESS (14.268s)
[388.396871] [118/141] (617s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_rc_ccs_cc)
[388.925363] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs_cc
[388.929287] Subtest pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[389.413351] [119/141] (616s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_gen12_mc_ccs)
[389.943329] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_gen12_mc_ccs
[389.946133] Subtest pipe-B-ccs-on-another-bo-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[390.398869] [120/141] (615s left) gem_softpin (allocator-nopin)
[390.606988] Starting subtest: allocator-nopin
[390.843489] Subtest allocator-nopin: SUCCESS (0.236s)
[390.980880] [121/141] (615s left) kms_ccs (pipe-a-crc-sprite-planes-basic-yf_tiled_ccs)
[391.439251] Starting subtest: pipe-A-crc-sprite-planes-basic-yf_tiled_ccs
[391.983338] Subtest pipe-A-crc-sprite-planes-basic-yf_tiled_ccs: SUCCESS (0.541s)
[392.576629] [122/141] (613s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[392.888658] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[392.891399] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[392.995458] [123/141] (613s left) i915_pm_rc6_residency (rc6-fence)
[393.193856] Starting subtest: rc6-fence
[408.442761] Subtest rc6-fence: SUCCESS (15.250s)
[408.708417] [124/141] (597s left) syncobj_wait (reset-multiple-signaled)
[408.909648] Starting subtest: reset-multiple-signaled
[408.911273] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[409.009548] [125/141] (597s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_mtl_rc_ccs_cc)
[409.478050] Starting subtest: pipe-B-bad-pixel-format-4_tiled_mtl_rc_ccs_cc
[409.480874] Subtest pipe-B-bad-pixel-format-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[409.994708] [126/141] (596s left) kms_vblank (pipe-b-ts-continuation-modeset-hang)
[410.288469] Starting subtest: pipe-B-ts-continuation-modeset-hang
[417.974895] Subtest pipe-B-ts-continuation-modeset-hang: SUCCESS (7.690s)
[418.314304] [127/141] (588s left) kms_universal_plane (disable-primary-vs-flip-pipe-c)
[418.620258] Starting subtest: disable-primary-vs-flip-pipe-C
[419.786917] Subtest disable-primary-vs-flip-pipe-C: SUCCESS (1.169s)
[420.125630] [128/141] (586s left) gem_exec_fence (syncobj-invalid-flags)
[420.786691] Starting subtest: syncobj-invalid-flags
[420.788415] Subtest syncobj-invalid-flags: SUCCESS (0.001s)
[421.142827] [129/141] (585s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[421.639067] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc
[421.641746] Subtest pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SKIP (0.001s)
[422.121209] [130/141] (584s left) gem_pipe_control_store_loop (reused-buffer)
[422.332083] Starting subtest: reused-buffer
[424.491431] Subtest reused-buffer: SUCCESS (2.158s)
[424.603970] [131/141] (582s left) v3d/v3d_submit_cl (bad-multisync-extension)
[424.861776] Subtest bad-multisync-extension: SKIP (0.000s)
[424.937192] [132/141] (581s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[425.146277] Starting subtest: basic-wc-cpu-noreloc
[425.156212] Subtest basic-wc-cpu-noreloc: SUCCESS (0.010s)
[425.353761] [133/141] (581s left) gem_userptr_blits (input-checking)
[425.574308] Starting subtest: input-checking
[425.575660] Subtest input-checking: SUCCESS (0.000s)
[425.754518] [134/141] (581s left) gem_exec_whisper (basic-contexts)
[425.982042] Starting subtest: basic-contexts
[435.520830] Subtest basic-contexts: SUCCESS (9.537s)
[435.736585] [135/141] (571s left) gem_ctx_engines (invalid-engines)
[435.962834] Starting subtest: invalid-engines
[435.977997] Subtest invalid-engines: SUCCESS (0.015s)
[436.187106] [136/141] (570s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[436.578182] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[436.884384] [137/141] (570s left) gem_vm_create (isolation)
[437.090704] Starting subtest: isolation
[437.103606] Subtest isolation: SUCCESS (0.012s)
[437.222577] [138/141] (569s left) kms_cursor_crc (cursor-offscreen-32x10)
[437.519804] Starting subtest: cursor-offscreen-32x10
[437.636617] Subtest cursor-offscreen-32x10: SKIP (0.114s)
[437.755439] [139/141] (569s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[437.975904] Starting subtest: yf-tiled-ccs-to-yf-tiled
[437.981432] Starting dynamic subtest: smem
[438.399049] Dynamic subtest smem: SUCCESS (0.419s)
[438.400376] Subtest yf-tiled-ccs-to-yf-tiled: SUCCESS (0.422s)
[438.606956] [140/141] (568s left) syncobj_timeline (signal-array)
[438.810389] Starting subtest: signal-array
[438.812132] Subtest signal-array: SUCCESS (0.000s)
[438.905146] [141/141] (568s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[439.114909] Starting subtest: basic-wc-gtt-noreloc
[439.127329] Subtest basic-wc-gtt-noreloc: SUCCESS (0.012s)
[439.317547] Closing watchdogs
Done.