[40.020968] Initializing watchdogs
[40.021248]   /dev/watchdog0
[40.067776] [001/142] (960s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[40.463808] Starting subtest: basic-max-pipe-crc-check
[40.503850] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[40.597095] [002/142] (960s left) i915_query (query-topology-kernel-writes)
[40.903982] Starting subtest: query-topology-kernel-writes
[40.924398] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[41.007692] [003/142] (959s left) kms_plane_multiple (tiling-none)
[41.359505] Starting subtest: tiling-none
[41.381224] Starting dynamic subtest: pipe-A-DP-1
[42.898177] Dynamic subtest pipe-A-DP-1: SUCCESS (1.533s)
[42.931913] Starting dynamic subtest: pipe-B-DP-1
[44.552616] Dynamic subtest pipe-B-DP-1: SUCCESS (1.639s)
[44.587716] Starting dynamic subtest: pipe-C-DP-1
[46.170803] Dynamic subtest pipe-C-DP-1: SUCCESS (1.621s)
[46.192145] Subtest tiling-none: SUCCESS (4.805s)
[46.532960] [004/142] (954s left) gem_exec_flush (basic-wb-ro-before-default)
[46.894794] Starting subtest: basic-wb-ro-before-default
[52.364869] Subtest basic-wb-ro-before-default: SUCCESS (5.478s)
[52.584535] [005/142] (948s left) kms_chamelium_hpd (vga-hpd-fast)
[53.098248] Subtest vga-hpd-fast: SKIP (0.000s)
[53.391623] [006/142] (947s left) gem_eio (suspend)
[59.860149] Starting subtest: suspend
[66.081540] Subtest suspend: SUCCESS (12.375s)
[70.621427] [007/142] (934s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[71.088045] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[71.124525] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[71.219259] [008/142] (934s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[71.632432] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[71.671537] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[71.765259] [009/142] (933s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_dg2_rc_ccs_cc)
[72.231794] Starting subtest: pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs_cc
[72.274545] Subtest pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[72.866651] [010/142] (932s left) gem_mmap_wc (set-cache-level)
[73.167312] Starting subtest: set-cache-level
[73.185881] Subtest set-cache-level: SUCCESS (0.004s)
[73.283792] [011/142] (932s left) kms_psr (psr2_cursor_render)
[73.592525] Subtest psr2_cursor_render: SKIP (0.000s)
[73.689634] [012/142] (932s left) kms_vblank (pipe-b-query-forked)
[74.044176] Starting subtest: pipe-B-query-forked
[76.786422] Subtest pipe-B-query-forked: SUCCESS (2.738s)
[77.137201] [013/142] (928s left) kms_addfb_basic (bo-too-small)
[77.519122] Starting subtest: bo-too-small
[77.537378] Subtest bo-too-small: SUCCESS (0.001s)
[77.634135] [014/142] (928s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[78.062391] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[78.098524] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[78.200263] [015/142] (927s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc)
[78.716800] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc
[78.753608] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.005s)
[79.267389] [016/142] (926s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[79.705256] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[82.601417] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SUCCESS (2.974s)
[82.760817] [017/142] (923s left) kms_invalid_mode (bad-vtotal)
[83.130958] Starting subtest: bad-vtotal
[83.149304] Starting dynamic subtest: DP-1-pipe-A
[83.220662] Dynamic subtest DP-1-pipe-A: SUCCESS (0.097s)
[83.257901] Starting dynamic subtest: DP-1-pipe-B
[83.279402] Dynamic subtest DP-1-pipe-B: SUCCESS (0.014s)
[83.317529] Starting dynamic subtest: DP-1-pipe-C
[83.336098] Dynamic subtest DP-1-pipe-C: SUCCESS (0.014s)
[83.354412] Subtest bad-vtotal: SUCCESS (0.135s)
[83.591383] [018/142] (922s left) gem_exec_schedule (pi-shared-iova)
[84.068626] Starting subtest: pi-shared-iova
[84.087570] Starting dynamic subtest: rcs0
[84.136590] Dynamic subtest rcs0: SUCCESS (0.087s)
[84.171825] Starting dynamic subtest: bcs0
[84.212328] Dynamic subtest bcs0: SUCCESS (0.081s)
[84.247256] Starting dynamic subtest: vcs0
[84.265676] Dynamic subtest vcs0: SUCCESS (0.054s)
[84.301656] Starting dynamic subtest: vecs0
[84.322820] Dynamic subtest vecs0: SUCCESS (0.056s)
[84.343829] Subtest pi-shared-iova: SUCCESS (0.280s)
[84.558902] [019/142] (921s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[84.984805] Starting subtest: psr-modesetfrombusy
[85.021138] Subtest psr-modesetfrombusy: SKIP (0.000s)
[85.116147] [020/142] (921s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_mtl_rc_ccs)
[85.905737] Subtest pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[86.201449] [021/142] (920s left) kms_chamelium_frames (hdmi-frame-dump)
[86.673717] Subtest hdmi-frame-dump: SKIP (0.000s)
[87.242783] [022/142] (919s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[87.699150] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[89.176624] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.533s)
[89.616112] [023/142] (917s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_dg2_rc_ccs)
[90.335378] Starting subtest: pipe-C-bad-pixel-format-4_tiled_dg2_rc_ccs
[90.373559] Subtest pipe-C-bad-pixel-format-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[90.774165] [024/142] (916s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[91.209526] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[91.247422] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[91.338879] [025/142] (915s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[91.632844] Starting subtest: rel-constants-invalid-rel-gen5
[91.651356] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[91.747242] [026/142] (915s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs)
[92.541221] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[92.840508] [027/142] (914s left) gem_ctx_shared (exec-shared-gtt)
[93.135588] Starting subtest: exec-shared-gtt
[93.154787] Starting dynamic subtest: rcs0
[93.173388] Dynamic subtest rcs0: SUCCESS (0.011s)
[93.205538] Starting dynamic subtest: bcs0
[93.223962] Dynamic subtest bcs0: SUCCESS (0.013s)
[93.259040] Starting dynamic subtest: vcs0
[93.280618] Dynamic subtest vcs0: SUCCESS (0.008s)
[93.315310] Starting dynamic subtest: vecs0
[93.335796] Dynamic subtest vecs0: SUCCESS (0.009s)
[93.354927] Subtest exec-shared-gtt: SUCCESS (0.043s)
[93.442872] [028/142] (913s left) kms_concurrent (pipe-d)
[93.845484] Subtest pipe-D: SKIP (0.000s)
[94.013098] [029/142] (913s left) gem_exec_reloc (basic-cpu-read)
[94.304086] Starting subtest: basic-cpu-read
[94.325450] Subtest basic-cpu-read: SUCCESS (0.021s)
[94.521492] [030/142] (912s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[94.882663] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[94.904653] Starting dynamic subtest: pipe-A-valid-mode
[94.989300] Dynamic subtest pipe-A-valid-mode: SKIP (0.086s)
[95.025617] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (0.089s)
[95.311391] [031/142] (912s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[95.726427] Starting subtest: y-tiled-32bpp-rotate-90
[100.889592] Subtest y-tiled-32bpp-rotate-90: SUCCESS (5.201s)
[102.391206] [032/142] (905s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[102.681291] Starting subtest: basic-gtt-cpu-noreloc
[102.699996] Subtest basic-gtt-cpu-noreloc: SUCCESS (0.011s)
[102.894576] [033/142] (904s left) gem_sync (basic-store-all)
[103.352442] Starting subtest: basic-store-all
[107.155060] Subtest basic-store-all: SUCCESS (3.801s)
[107.245319] [034/142] (900s left) kms_vblank (pipe-a-wait-forked-busy)
[107.621111] Starting subtest: pipe-A-wait-forked-busy
[110.077587] Subtest pipe-A-wait-forked-busy: SUCCESS (2.454s)
[110.409498] [035/142] (897s left) gem_tiled_pread_pwrite
[112.550764] [036/142] (895s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[113.059135] Starting subtest: blocking-absolute-wf_vblank-interruptible
[113.078848] Starting dynamic subtest: A-DP1
[124.193144] Dynamic subtest A-DP1: SUCCESS (10.963s)
[124.237183] Starting dynamic subtest: B-DP1
[134.442099] Dynamic subtest B-DP1: SUCCESS (10.419s)
[134.479245] Starting dynamic subtest: C-DP1
[145.225743] Dynamic subtest C-DP1: SUCCESS (10.608s)
[145.246955] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (31.998s)
[145.467459] [037/142] (862s left) prime_vgem (basic-blt)
[145.918228] Starting subtest: basic-blt
[145.938754] Subtest basic-blt: SUCCESS (0.057s)
[146.081277] [038/142] (862s left) gem_pxp (reject-modify-context-protection-off-1)
[149.065498] Subtest reject-modify-context-protection-off-1: SKIP (0.000s)
[149.213760] [039/142] (858s left) kms_plane_scaling (plane-downscale-with-pixel-format-factor-0-25)
[149.633414] Starting subtest: plane-downscale-with-pixel-format-factor-0-25
[149.656523] Starting dynamic subtest: pipe-A-DP-1
[149.694142] Dynamic subtest pipe-A-DP-1: SKIP (0.034s)
[149.736250] Starting dynamic subtest: pipe-B-DP-1
[149.776152] Dynamic subtest pipe-B-DP-1: SKIP (0.080s)
[149.814538] Starting dynamic subtest: pipe-C-DP-1
[149.891182] Dynamic subtest pipe-C-DP-1: SKIP (0.080s)
[149.927404] Subtest plane-downscale-with-pixel-format-factor-0-25: SKIP (0.206s)
[150.022705] [040/142] (858s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[150.375076] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[150.395805] Starting dynamic subtest: pipe-A-DP-1
[150.696692] Dynamic subtest pipe-A-DP-1: SUCCESS (0.302s)
[150.739848] Starting dynamic subtest: pipe-B-DP-1
[151.048151] Dynamic subtest pipe-B-DP-1: SUCCESS (0.359s)
[151.107539] Starting dynamic subtest: pipe-C-DP-1
[151.204781] Dynamic subtest pipe-C-DP-1: SKIP (0.086s)
[151.232863] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.758s)
[151.578487] [041/142] (856s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[152.013321] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[153.427536] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.446s)
[153.617994] [042/142] (854s left) vc4/vc4_purgeable_bo (access-purgeable-bo-mem)
[153.965923] Subtest access-purgeable-bo-mem: SKIP (0.000s)
[154.063183] [043/142] (854s left) kms_vblank (pipe-d-query-busy)
[154.439984] Subtest pipe-D-query-busy: SKIP (0.000s)
[154.616817] [044/142] (854s left) debugfs_test (basic-hwmon)
[154.914810] Starting subtest: basic-hwmon
[154.953724] Subtest basic-hwmon: SKIP (0.000s)
[155.115928] [045/142] (853s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[155.474146] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[156.028856] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.546s)
[156.376409] [046/142] (852s left) kms_properties (plane-properties-atomic)
[156.733360] Starting subtest: plane-properties-atomic
[157.795072] Subtest plane-properties-atomic: SUCCESS (1.040s)
[158.140085] [047/142] (850s left) kms_psr (cursor_plane_onoff)
[158.458201] Subtest cursor_plane_onoff: SKIP (0.000s)
[158.548173] [048/142] (850s left) vc4/vc4_purgeable_bo (mark-unpurgeable-check-retained)
[158.887940] Subtest mark-unpurgeable-check-retained: SKIP (0.000s)
[158.985527] [049/142] (850s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[159.429975] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[159.472323] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[159.566459] [050/142] (849s left) gem_eio (reset-stress)
[159.889513] Starting subtest: reset-stress
[192.841516] Subtest reset-stress: SUCCESS (32.993s)
[193.028395] [051/142] (816s left) gem_mmap_gtt (cpuset-big-copy-odd)
[193.320718] Starting subtest: cpuset-big-copy-odd
[216.289143] Subtest cpuset-big-copy-odd: SUCCESS (23.000s)
[216.755338] [052/142] (792s left) gen9_exec_parse (bb-start-param)
[217.189886] Starting subtest: bb-start-param
[217.208314] Subtest bb-start-param: SUCCESS (0.004s)
[217.444235] [053/142] (792s left) kms_cursor_edge_walk (256x256-top-bottom)
[217.858856] Starting subtest: 256x256-top-bottom
[217.877898] Starting dynamic subtest: pipe-A-DP-1
[221.749834] Dynamic subtest pipe-A-DP-1: SUCCESS (3.879s)
[221.788438] Starting dynamic subtest: pipe-C-DP-1
[225.199734] Dynamic subtest pipe-C-DP-1: SUCCESS (3.462s)
[225.219721] Subtest 256x256-top-bottom: SUCCESS (7.349s)
[225.549320] [054/142] (784s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[225.898833] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[225.981706] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.103s)
[226.092262] [055/142] (783s left) gem_exec_fair (basic-none-vip)
[226.564150] Starting subtest: basic-none-vip
[226.582590] Starting dynamic subtest: rcs0
[232.236702] Dynamic subtest rcs0: SUCCESS (5.850s)
[232.257609] Subtest basic-none-vip: SUCCESS (5.851s)
[232.476333] [056/142] (777s left) sysfs_timeslice_duration (timeout)
[232.771898] Starting subtest: timeout
[232.790442] Starting dynamic subtest: vecs0
[233.659904] Dynamic subtest vecs0: SUCCESS (0.885s)
[233.707798] Starting dynamic subtest: vcs0
[234.536569] Dynamic subtest vcs0: SUCCESS (0.869s)
[234.585276] Starting dynamic subtest: bcs0
[235.473610] Dynamic subtest bcs0: SUCCESS (0.915s)
[235.515808] Starting dynamic subtest: rcs0
[236.363245] Dynamic subtest rcs0: SUCCESS (0.898s)
[236.388247] Subtest timeout: SUCCESS (3.572s)
[236.502819] [057/142] (773s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[236.832914] Starting subtest: single-wait-for-submit-available-signaled
[236.859211] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.001s)
[236.970920] [058/142] (772s left) i915_pm_backlight (basic-brightness)
[237.386911] Subtest basic-brightness: SKIP (0.000s)
[237.512130] [059/142] (772s left) gem_exec_balancer (bonded-true-hang)
[241.876418] Starting subtest: bonded-true-hang
[245.448096] Subtest bonded-true-hang: SUCCESS (3.586s)
[245.546642] [060/142] (764s left) kms_ccs (pipe-a-bad-aux-stride-4_tiled_mtl_mc_ccs)
[246.066693] Starting subtest: pipe-A-bad-aux-stride-4_tiled_mtl_mc_ccs
[246.104169] Subtest pipe-A-bad-aux-stride-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[246.653646] [061/142] (763s left) gem_exec_params (batch-first)
[246.950966] Starting subtest: batch-first
[246.971446] Subtest batch-first: SUCCESS (0.012s)
[247.084775] [062/142] (763s left) v3d/v3d_submit_csd (single-out-sync)
[247.438418] Subtest single-out-sync: SKIP (0.000s)
[247.537316] [063/142] (762s left) gem_flink_race (flink_name)
[247.787280] Starting subtest: flink_name
[253.223677] Subtest flink_name: SUCCESS (5.374s)
[253.315394] [064/142] (757s left) gem_create (create-clear)
[253.615214] Starting subtest: create-clear
[253.633932] Starting dynamic subtest: smem0
[288.523323] Dynamic subtest smem0: SUCCESS (34.665s)
[288.543819] Subtest create-clear: SUCCESS (34.666s)
[288.936138] [065/142] (721s left) kms_addfb_basic (basic-y-tiled-legacy)
[289.232240] Starting subtest: basic-y-tiled-legacy
[289.252331] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[289.524746] [066/142] (721s left) gem_exec_parallel (basic)
[289.811510] Starting subtest: basic
[289.832510] Starting dynamic subtest: rcs0
[293.529998] Dynamic subtest rcs0: SUCCESS (3.545s)
[293.566942] Starting dynamic subtest: bcs0
[297.128391] Dynamic subtest bcs0: SUCCESS (3.599s)
[297.165974] Starting dynamic subtest: vcs0
[300.650853] Dynamic subtest vcs0: SUCCESS (3.521s)
[300.690861] Starting dynamic subtest: vecs0
[304.149048] Dynamic subtest vecs0: SUCCESS (3.489s)
[304.167586] Subtest basic: SUCCESS (14.159s)
[304.259219] [067/142] (706s left) i915_pm_rpm (basic-pci-d3-state)
[306.125762] Starting subtest: basic-pci-d3-state
[306.947376] Subtest basic-pci-d3-state: SUCCESS (0.819s)
[307.199531] [068/142] (703s left) kms_addfb_basic (bad-pitch-65536)
[307.482657] Starting subtest: bad-pitch-65536
[307.501242] Subtest bad-pitch-65536: SUCCESS (0.001s)
[307.678326] [069/142] (703s left) syncobj_timeline (single-wait-signaled)
[307.969311] Starting subtest: single-wait-signaled
[307.988093] Subtest single-wait-signaled: SUCCESS (0.001s)
[308.081090] [070/142] (703s left) syncobj_wait (invalid-reset-one-illegal-handle)
[308.377411] Starting subtest: invalid-reset-one-illegal-handle
[308.395971] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.001s)
[308.496442] [071/142] (702s left) gem_spin_batch (legacy)
[308.787727] Starting subtest: legacy
[308.808360] Starting dynamic subtest: default
[312.303599] Dynamic subtest default: SUCCESS (3.323s)
[312.344232] Starting dynamic subtest: render
[315.447972] Dynamic subtest render: SUCCESS (3.322s)
[315.483359] Starting dynamic subtest: bsd
[318.947328] Dynamic subtest bsd: SUCCESS (3.321s)
[318.984331] Starting dynamic subtest: bsd1
[322.263660] Dynamic subtest bsd1: SUCCESS (3.320s)
[322.299980] Starting dynamic subtest: blt
[325.418129] Dynamic subtest blt: SUCCESS (3.322s)
[325.453656] Starting dynamic subtest: vebox
[328.912612] Dynamic subtest vebox: SUCCESS (3.321s)
[328.932739] Subtest legacy: SUCCESS (19.937s)
[329.026636] [072/142] (682s left) kms_draw_crc (draw-method-mmap-wc)
[329.408218] Starting subtest: draw-method-mmap-wc
[329.429520] Starting dynamic subtest: xrgb8888-untiled
[329.709206] Dynamic subtest xrgb8888-untiled: SUCCESS (0.317s)
[329.748124] Starting dynamic subtest: rgb565-untiled
[329.993518] Dynamic subtest rgb565-untiled: SUCCESS (0.282s)
[330.033510] Starting dynamic subtest: xrgb2101010-untiled
[330.311881] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.316s)
[330.349770] Starting dynamic subtest: xrgb8888-xtiled
[330.525762] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.216s)
[330.562889] Starting dynamic subtest: rgb565-xtiled
[330.709036] Dynamic subtest rgb565-xtiled: SUCCESS (0.182s)
[330.744965] Starting dynamic subtest: xrgb2101010-xtiled
[330.932936] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.216s)
[330.969699] Starting dynamic subtest: xrgb8888-ytiled
[331.147659] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.216s)
[331.185807] Starting dynamic subtest: rgb565-ytiled
[331.342526] Dynamic subtest rgb565-ytiled: SUCCESS (0.199s)
[331.379587] Starting dynamic subtest: xrgb2101010-ytiled
[331.562381] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.216s)
[331.580947] Subtest draw-method-mmap-wc: SUCCESS (2.168s)
[331.700208] [073/142] (679s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[332.059542] Starting subtest: basic-flip-before-cursor-varying-size
[333.141911] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.081s)
[333.509799] [074/142] (678s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[333.948696] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[336.347847] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (2.465s)
[336.528540] [075/142] (675s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[336.973199] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[337.025210] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[337.148940] [076/142] (674s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_mtl_mc_ccs)
[337.960702] Subtest pipe-D-random-ccs-data-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[338.299185] [077/142] (673s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[338.731673] Starting subtest: fbcpsr-rgb565-draw-render
[338.770849] Subtest fbcpsr-rgb565-draw-render: SKIP (0.000s)
[338.871262] [078/142] (673s left) gem_ctx_isolation (clean)
[339.169903] Starting subtest: clean
[339.190457] Starting dynamic subtest: rcs0
[339.350871] Dynamic subtest rcs0: SUCCESS (0.217s)
[339.387285] Starting dynamic subtest: bcs0
[339.656740] Dynamic subtest bcs0: SUCCESS (0.304s)
[339.697495] Starting dynamic subtest: vcs0
[339.913109] Dynamic subtest vcs0: SUCCESS (0.255s)
[339.951751] Starting dynamic subtest: vecs0
[340.143060] Dynamic subtest vecs0: SUCCESS (0.231s)
[340.161346] Subtest clean: SUCCESS (1.011s)
[340.371544] [079/142] (671s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[340.802059] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[340.843921] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[340.940836] [080/142] (671s left) gem_exec_schedule (semaphore-codependency)
[341.381714] Starting subtest: semaphore-codependency
[341.402363] Subtest semaphore-codependency: SUCCESS (0.023s)
[341.656825] [081/142] (670s left) kms_flip (busy-flip)
[342.039695] Starting subtest: busy-flip
[342.059342] Starting dynamic subtest: A-DP1
[343.044187] Dynamic subtest A-DP1: SUCCESS (1.033s)
[343.081302] Starting dynamic subtest: B-DP1
[344.045125] Dynamic subtest B-DP1: SUCCESS (0.996s)
[344.083759] Starting dynamic subtest: C-DP1
[345.041716] Dynamic subtest C-DP1: SUCCESS (0.990s)
[345.060617] Subtest busy-flip: SUCCESS (3.028s)
[345.463619] [082/142] (666s left) api_intel_allocator (gem-pool)
[345.762738] Starting subtest: gem-pool
[345.781376] Subtest gem-pool: SUCCESS (0.019s)
[345.897110] [083/142] (666s left) kms_addfb_basic (bad-pitch-256)
[346.181631] Starting subtest: bad-pitch-256
[346.200888] Subtest bad-pitch-256: SUCCESS (0.000s)
[346.377922] [084/142] (666s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[346.689098] Starting subtest: x-tiled-to-vebox-y-tiled
[346.726057] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[346.881730] [085/142] (665s left) gem_exec_whisper (basic-queues-priority)
[347.213848] Starting subtest: basic-queues-priority
[359.634689] Subtest basic-queues-priority: SUCCESS (12.448s)
[359.847292] [086/142] (652s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[360.380323] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[360.417629] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.005s)
[360.958190] [087/142] (651s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[361.400323] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[361.437180] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[361.539987] [088/142] (651s left) kms_prop_blob (blob-multiple)
[361.830098] Starting subtest: blob-multiple
[361.852604] Subtest blob-multiple: SUCCESS (0.003s)
[361.954120] [089/142] (650s left) perf (short-reads)
[362.387506] Starting subtest: short-reads
[362.453659] Subtest short-reads: SUCCESS (0.061s)
[362.574108] [090/142] (650s left) drm_fdinfo (virtual-busy-idle)
[362.867557] Starting subtest: virtual-busy-idle
[365.429025] Subtest virtual-busy-idle: SUCCESS (2.587s)
[365.543272] [091/142] (647s left) gem_softpin (allocator-basic)
[365.830243] Starting subtest: allocator-basic
[366.041751] Subtest allocator-basic: SUCCESS (0.236s)
[366.211724] [092/142] (647s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_dg2_rc_ccs)
[367.015250] Subtest pipe-D-bad-rotation-90-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[367.328982] [093/142] (645s left) gem_mmap_gtt (medium-copy)
[367.631691] Starting subtest: medium-copy
[373.203565] Subtest medium-copy: SUCCESS (5.608s)
[373.327573] [094/142] (640s left) kms_ccs (pipe-b-bad-aux-stride-y_tiled_ccs)
[374.148442] Starting subtest: pipe-B-bad-aux-stride-y_tiled_ccs
[374.167065] Subtest pipe-B-bad-aux-stride-y_tiled_ccs: SUCCESS (0.002s)
[374.665819] [095/142] (638s left) gem_exec_params (invalid-batch-start-offset)
[374.993588] Starting subtest: invalid-batch-start-offset
[375.026726] Subtest invalid-batch-start-offset: SUCCESS (0.008s)
[375.154759] [096/142] (638s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[375.609650] Starting subtest: cursor-rapid-movement-512x512
[375.659844] Subtest cursor-rapid-movement-512x512: SKIP (0.003s)
[375.794490] [097/142] (637s left) kms_atomic_transition (modeset-transition-nonblocking)
[376.172587] Starting subtest: modeset-transition-nonblocking
[376.201318] Starting dynamic subtest: 1x-outputs
[381.340230] Dynamic subtest 1x-outputs: SUCCESS (5.177s)
[381.452323] Subtest modeset-transition-nonblocking: SUCCESS (5.268s)
[381.805090] [098/142] (632s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[382.221455] Starting subtest: cursor-vs-flip-varying-size
[424.040428] Subtest cursor-vs-flip-varying-size: SUCCESS (41.830s)
[424.389523] [099/142] (589s left) kms_big_fb (linear-64bpp-rotate-0)
[424.838616] Starting subtest: linear-64bpp-rotate-0
[433.163841] Subtest linear-64bpp-rotate-0: SUCCESS (8.364s)
[434.110998] [100/142] (579s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[434.397966] Starting subtest: basic-cpu-wc-noreloc
[434.419453] Subtest basic-cpu-wc-noreloc: SUCCESS (0.012s)
[436.403881] [101/142] (577s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[436.722824] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[436.744246] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.002s)
[436.856843] [102/142] (577s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[437.274226] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[437.317207] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[437.419817] [103/142] (576s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[437.831329] Starting subtest: fbcpsr-tiling-y
[437.872517] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[437.973796] [104/142] (576s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[438.435857] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[438.731476] [105/142] (575s left) kms_ccs (pipe-c-missing-ccs-buffer-4_tiled_mtl_mc_ccs)
[439.456597] Starting subtest: pipe-C-missing-ccs-buffer-4_tiled_mtl_mc_ccs
[439.498848] Subtest pipe-C-missing-ccs-buffer-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[439.845278] [106/142] (574s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_mtl_rc_ccs_cc)
[440.500888] Starting subtest: pipe-C-bad-pixel-format-4_tiled_mtl_rc_ccs_cc
[440.540889] Subtest pipe-C-bad-pixel-format-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[440.973635] [107/142] (573s left) i915_pm_sseu (full-enable)
[441.811817] Starting subtest: full-enable
[441.838228] Subtest full-enable: SUCCESS (0.020s)
[441.986223] [108/142] (572s left) kms_cursor_crc (cursor-onscreen-max-size)
[442.381523] Starting subtest: cursor-onscreen-max-size
[442.451622] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[442.571780] [109/142] (572s left) kms_color (legacy-gamma-reset)
[442.936224] Starting subtest: legacy-gamma-reset
[442.954483] Starting dynamic subtest: pipe-A
[443.420898] Dynamic subtest pipe-A: SUCCESS (0.483s)
[443.470434] Starting dynamic subtest: pipe-B
[443.832572] Dynamic subtest pipe-B: SUCCESS (0.386s)
[443.880596] Starting dynamic subtest: pipe-C
[444.204122] Dynamic subtest pipe-C: SUCCESS (0.380s)
[444.226417] Subtest legacy-gamma-reset: SUCCESS (1.253s)
[444.528776] [110/142] (570s left) kms_universal_plane (universal-plane-pipe-d-sanity)
[444.909067] Subtest universal-plane-pipe-D-sanity: SKIP (0.000s)
[445.091652] [111/142] (570s left) gem_basic (multigpu-create-close)
[445.381133] Starting subtest: multigpu-create-close
[445.418972] Subtest multigpu-create-close: SKIP (0.000s)
[445.517660] [112/142] (569s left) gem_userptr_blits (usage-restrictions)
[445.871920] Starting subtest: usage-restrictions
[445.892492] Subtest usage-restrictions: SUCCESS (0.000s)
[446.009434] [113/142] (569s left) i915_pm_rpm (modeset-non-lpsp-stress)
[447.849714] Starting subtest: modeset-non-lpsp-stress
[455.116603] Subtest modeset-non-lpsp-stress: SUCCESS (7.258s)
[455.317352] [114/142] (560s left) sw_sync (sync_random_merge)
[455.594720] Starting subtest: sync_random_merge
[455.731335] Subtest sync_random_merge: SUCCESS (0.151s)
[455.826824] [115/142] (559s left) gem_lmem_swapping (parallel-multi)
[456.148228] Subtest parallel-multi: SKIP (0.000s)
[456.245977] [116/142] (559s left) gem_ctx_persistence (legacy-engines-mixed)
[456.538159] Starting subtest: legacy-engines-mixed
[456.556609] Starting dynamic subtest: render
[456.577948] Dynamic subtest render: SUCCESS (0.050s)
[456.619119] Starting dynamic subtest: bsd
[456.640044] Dynamic subtest bsd: SUCCESS (0.046s)
[456.681932] Starting dynamic subtest: blt
[456.700517] Dynamic subtest blt: SUCCESS (0.051s)
[456.739681] Starting dynamic subtest: vebox
[456.758183] Dynamic subtest vebox: SUCCESS (0.049s)
[456.776718] Subtest legacy-engines-mixed: SUCCESS (0.204s)
[456.881168] [117/142] (558s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[457.233048] Starting subtest: 2x-flip-vs-cursor-legacy
[457.269631] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.005s)
[457.373663] [118/142] (558s left) gen7_exec_parse (basic-allowed)
[457.683629] Subtest basic-allowed: SKIP (0.000s)
[457.786917] [119/142] (558s left) perf_pmu (busy-accuracy-98)
[458.073173] Starting subtest: busy-accuracy-98
[458.091810] Starting dynamic subtest: rcs0
[461.140345] Dynamic subtest rcs0: SUCCESS (3.051s)
[461.185023] Starting dynamic subtest: bcs0
[464.193528] Dynamic subtest bcs0: SUCCESS (3.052s)
[464.237295] Starting dynamic subtest: vcs0
[467.241093] Dynamic subtest vcs0: SUCCESS (3.047s)
[467.288333] Starting dynamic subtest: vecs0
[470.286873] Dynamic subtest vecs0: SUCCESS (3.048s)
[470.314944] Subtest busy-accuracy-98: SUCCESS (12.203s)
[470.458518] [120/142] (545s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[470.916095] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[470.966302] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[471.085533] [121/142] (545s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[472.223331] Starting subtest: syncobj-timeline-multiple-ext-nodes
[472.252545] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[472.491989] [122/142] (543s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs)
[473.241178] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs
[473.287639] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs: SKIP (0.004s)
[473.616763] [123/142] (542s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[474.021174] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[475.235395] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (1.234s)
[475.703052] [124/142] (540s left) gem_mmap (pf-nonblock)
[476.024098] Starting subtest: pf-nonblock
[476.049924] Subtest pf-nonblock: SUCCESS (0.005s)
[476.173884] [125/142] (540s left) api_intel_allocator (simple-allocator)
[476.499576] Starting subtest: simple-allocator
[476.521421] Starting dynamic subtest: basic
[476.549244] Dynamic subtest basic: SUCCESS (0.007s)
[476.593616] Starting dynamic subtest: parallel-one
[476.652196] Dynamic subtest parallel-one: SUCCESS (0.165s)
[476.699237] Starting dynamic subtest: print
[476.725436] Dynamic subtest print: SUCCESS (0.000s)
[476.772125] Starting dynamic subtest: reuse
[476.796060] Dynamic subtest reuse: SUCCESS (0.000s)
[476.836800] Starting dynamic subtest: reserve
[476.863611] Dynamic subtest reserve: SUCCESS (0.000s)
[476.909324] Starting dynamic subtest: fork-reopen-allocator
[476.933587] Dynamic subtest fork-reopen-allocator: SUCCESS (0.039s)
[476.960622] Subtest simple-allocator: SUCCESS (0.219s)
[477.085312] [126/142] (539s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_dg2_rc_ccs)
[477.696259] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs
[477.752799] Subtest pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.001s)
[478.233747] [127/142] (538s left) kms_flip (2x-flip-vs-fences-interruptible)
[478.620337] Starting subtest: 2x-flip-vs-fences-interruptible
[478.659030] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.003s)
[478.760598] [128/142] (538s left) kms_ccs (pipe-b-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc)
[479.360718] Starting subtest: pipe-B-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc
[479.398626] Subtest pipe-B-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc: SKIP (0.001s)
[479.868282] [129/142] (537s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[480.244091] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[480.281703] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.003s)
[480.381585] [130/142] (536s left) kms_universal_plane (universal-plane-pipe-a-functional)
[480.759517] Starting subtest: universal-plane-pipe-A-functional
[483.200067] Subtest universal-plane-pipe-A-functional: SUCCESS (2.450s)
[483.532577] [131/142] (533s left) syncobj_timeline (invalid-signal-bad-pad)
[483.819339] Starting subtest: invalid-signal-bad-pad
[483.839386] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[483.943452] [132/142] (533s left) syncobj_basic (create-signaled)
[484.255982] Starting subtest: create-signaled
[484.276690] Subtest create-signaled: SUCCESS (0.000s)
[484.374732] [133/142] (533s left) v3d/v3d_submit_cl (bad-extension)
[484.714271] Subtest bad-extension: SKIP (0.000s)
[484.817415] [134/142] (532s left) perf_pmu (init-busy)
[485.098990] Starting subtest: init-busy
[485.120500] Starting dynamic subtest: rcs0
[485.141776] Dynamic subtest rcs0: SUCCESS (0.002s)
[485.183030] Starting dynamic subtest: bcs0
[485.203719] Dynamic subtest bcs0: SUCCESS (0.001s)
[485.241516] Starting dynamic subtest: vcs0
[485.260038] Dynamic subtest vcs0: SUCCESS (0.001s)
[485.297773] Starting dynamic subtest: vecs0
[485.316128] Dynamic subtest vecs0: SUCCESS (0.001s)
[485.337133] Subtest init-busy: SUCCESS (0.011s)
[485.458396] [135/142] (532s left) gem_exec_balancer (invalid-bonds)
[485.754329] Starting subtest: invalid-bonds
[485.774747] Subtest invalid-bonds: SUCCESS (0.014s)
[489.832105] [136/142] (527s left) vgem_basic (sysfs)
[490.122609] Starting subtest: sysfs
[490.143638] Subtest sysfs: SUCCESS (0.001s)
[490.246511] [137/142] (527s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[490.653630] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[490.696467] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[490.799424] [138/142] (527s left) vgem_basic (busy-fence)
[491.088765] Starting subtest: busy-fence
[491.109306] Subtest busy-fence: SUCCESS (0.000s)
[491.204595] [139/142] (526s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[491.643147] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[491.679655] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[491.780665] [140/142] (526s left) gem_render_copy (x-tiled)
[492.092587] Starting subtest: x-tiled
[492.113575] Starting dynamic subtest: smem
[492.326126] Dynamic subtest smem: SUCCESS (0.280s)
[492.346145] Subtest x-tiled: SUCCESS (0.281s)
[492.563890] [141/142] (525s left) gem_eio (in-flight-contexts-10ms)
[492.896488] Starting subtest: in-flight-contexts-10ms
[504.295735] Subtest in-flight-contexts-10ms: SUCCESS (11.424s)
[504.505724] [142/142] (513s left) gem_userptr_blits (unsync-unmap-cycles)
[504.902673] Subtest unsync-unmap-cycles: SKIP (0.000s)
[504.987728] Closing watchdogs
Done.