[37.216386] Initializing watchdogs
[37.216685]   /dev/watchdog0
[37.233451] [001/141] (960s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[37.461968] Starting subtest: multi-wait-all-available-submitted-signaled
[37.465799] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.003s)
[37.554727] [002/141] (960s left) gem_exec_schedule (thriceslice)
[37.801724] Starting subtest: thriceslice
[37.803477] Starting dynamic subtest: rcs0
[37.833324] Dynamic subtest rcs0: SUCCESS (0.025s)
[37.851778] Starting dynamic subtest: bcs0
[37.853186] Dynamic subtest bcs0: SUCCESS (0.021s)
[37.882170] Starting dynamic subtest: vcs0
[37.883414] Dynamic subtest vcs0: SUCCESS (0.014s)
[37.896587] Starting dynamic subtest: vecs0
[37.897993] Dynamic subtest vecs0: SUCCESS (0.010s)
[37.899588] Subtest thriceslice: SUCCESS (0.073s)
[38.218970] [003/141] (959s left) gem_media_fill (media-fill)
[38.443557] Starting subtest: media-fill
[38.445207] Starting dynamic subtest: smem
[38.457888] Dynamic subtest smem: SUCCESS (0.014s)
[38.459647] Subtest media-fill: SUCCESS (0.015s)
[38.684259] [004/141] (959s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[38.997477] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[38.998806] Starting dynamic subtest: pipe-A-DP-1
[39.348220] Dynamic subtest pipe-A-DP-1: SUCCESS (0.349s)
[39.364322] Starting dynamic subtest: pipe-B-DP-1
[39.739949] Dynamic subtest pipe-B-DP-1: SUCCESS (0.389s)
[39.757825] Starting dynamic subtest: pipe-C-DP-1
[39.846292] Dynamic subtest pipe-C-DP-1: SKIP (0.101s)
[39.847596] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.850s)
[40.247840] [005/141] (957s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_gen12_rc_ccs_cc)
[40.720404] Starting subtest: pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs_cc
[40.722945] Subtest pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[41.222447] [006/141] (956s left) kms_addfb_basic (bad-pitch-65536)
[41.423704] Starting subtest: bad-pitch-65536
[41.425106] Subtest bad-pitch-65536: SUCCESS (0.001s)
[41.622683] [007/141] (956s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[41.924537] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[41.926632] Starting dynamic subtest: pipe-A-valid-mode
[42.718894] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.793s)
[42.720342] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (0.795s)
[43.039186] [008/141] (954s left) kms_invalid_mode (uint-max-clock)
[43.345689] Starting subtest: uint-max-clock
[43.347507] Starting dynamic subtest: DP-1-pipe-A
[43.443649] Dynamic subtest DP-1-pipe-A: SUCCESS (0.102s)
[43.459070] Starting dynamic subtest: DP-1-pipe-B
[43.460337] Dynamic subtest DP-1-pipe-B: SUCCESS (0.014s)
[43.473876] Starting dynamic subtest: DP-1-pipe-C
[43.475193] Dynamic subtest DP-1-pipe-C: SUCCESS (0.014s)
[43.476432] Subtest uint-max-clock: SUCCESS (0.137s)
[43.803035] [009/141] (954s left) kms_fb_coherency (memset-crc)
[44.101645] Starting subtest: memset-crc
[44.103150] Starting dynamic subtest: mmap-gtt
[44.817881] Dynamic subtest mmap-gtt: SUCCESS (0.717s)
[44.939875] Starting dynamic subtest: mmap-offset-wc
[45.528179] Dynamic subtest mmap-offset-wc: SUCCESS (0.601s)
[45.638802] Starting dynamic subtest: mmap-offset-uc
[46.898918] Dynamic subtest mmap-offset-uc: SUCCESS (1.272s)
[47.021103] Starting dynamic subtest: mmap-legacy-wc
[47.598640] Dynamic subtest mmap-legacy-wc: SUCCESS (0.590s)
[47.696868] Subtest memset-crc: SUCCESS (3.596s)
[48.030282] [010/141] (950s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[48.324981] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[48.326306] Starting dynamic subtest: pipe-A-valid-mode
[48.446643] Dynamic subtest pipe-A-valid-mode: SKIP (0.119s)
[48.449177] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.121s)
[48.766093] [011/141] (949s left) kms_vblank (pipe-c-wait-idle-hang)
[49.061561] Starting subtest: pipe-C-wait-idle-hang
[57.008837] Subtest pipe-C-wait-idle-hang: SUCCESS (7.947s)
[57.338072] [012/141] (940s left) gem_exec_schedule (preempt-queue)
[57.572459] Starting subtest: preempt-queue
[57.574210] Starting dynamic subtest: rcs0
[58.001480] Dynamic subtest rcs0: SUCCESS (0.428s)
[58.017982] Starting dynamic subtest: bcs0
[58.399375] Dynamic subtest bcs0: SUCCESS (0.396s)
[58.415530] Starting dynamic subtest: vcs0
[58.794299] Dynamic subtest vcs0: SUCCESS (0.395s)
[58.813268] Starting dynamic subtest: vecs0
[59.178234] Dynamic subtest vecs0: SUCCESS (0.383s)
[59.179653] Subtest preempt-queue: SUCCESS (1.605s)
[59.522365] [013/141] (938s left) gem_set_tiling_vs_gtt
[60.104718] [014/141] (938s left) gem_pxp (fail-invalid-protected-context)
[62.825837] Subtest fail-invalid-protected-context: SKIP (0.000s)
[62.903407] [015/141] (935s left) drm_fdinfo (all-busy-idle-check-all)
[63.108851] Starting subtest: all-busy-idle-check-all
[63.735284] Subtest all-busy-idle-check-all: SUCCESS (0.626s)
[63.819957] [016/141] (934s left) gem_exec_params (secure-non-master)
[64.030974] Starting subtest: secure-non-master
[64.033576] Subtest secure-non-master: SKIP (0.000s)
[64.119928] [017/141] (934s left) kms_addfb_basic (bad-pitch-63)
[64.321463] Starting subtest: bad-pitch-63
[64.322776] Subtest bad-pitch-63: SUCCESS (0.000s)
[64.521832] [018/141] (933s left) kms_flip (blocking-wf_vblank)
[64.814870] Starting subtest: blocking-wf_vblank
[64.816397] Starting dynamic subtest: A-DP1
[75.640484] Dynamic subtest A-DP1: SUCCESS (10.826s)
[75.655644] Starting dynamic subtest: B-DP1
[86.392377] Dynamic subtest B-DP1: SUCCESS (10.751s)
[86.406381] Starting dynamic subtest: C-DP1
[97.306983] Dynamic subtest C-DP1: SUCCESS (10.914s)
[97.308521] Subtest blocking-wf_vblank: SUCCESS (32.498s)
[97.716713] [019/141] (900s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[98.034258] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[98.036820] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[98.129614] [020/141] (900s left) drm_read (short-buffer-nonblock)
[98.547406] Starting subtest: short-buffer-nonblock
[98.549074] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[98.665548] [021/141] (899s left) kms_vblank (pipe-c-query-forked-hang)
[98.966576] Starting subtest: pipe-C-query-forked-hang
[105.963447] Subtest pipe-C-query-forked-hang: SUCCESS (6.998s)
[106.305551] [022/141] (892s left) kms_cursor_crc (cursor-offscreen-64x64)
[106.617882] Starting subtest: cursor-offscreen-64x64
[106.628636] Starting dynamic subtest: pipe-A-DP-1
[109.119297] Dynamic subtest pipe-A-DP-1: SUCCESS (2.491s)
[109.196636] Starting dynamic subtest: pipe-C-DP-1
[112.005722] Dynamic subtest pipe-C-DP-1: SUCCESS (2.822s)
[112.006986] Subtest cursor-offscreen-64x64: SUCCESS (5.388s)
[112.359711] [023/141] (886s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[112.680441] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[112.683101] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[112.772631] [024/141] (885s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[113.078463] Starting subtest: fbcpsr-slowdraw
[113.081128] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[113.172560] [025/141] (885s left) kms_content_protection (type1)
[113.509804] Starting subtest: type1
[114.221242] Subtest type1: SKIP (0.708s)
[114.637293] [026/141] (883s left) kms_hdr (bpc-switch-suspend)
[114.941818] Starting subtest: bpc-switch-suspend
[117.259654] Starting dynamic subtest: pipe-A-DP-1
[134.377860] Dynamic subtest pipe-A-DP-1: SUCCESS (2.624s)
[134.379315] Subtest bpc-switch-suspend: SUCCESS (4.946s)
[140.738011] [027/141] (878s left) gem_cs_tlb (engines)
[140.948694] Starting subtest: engines
[140.950177] Starting dynamic subtest: rcs0
[143.115331] Dynamic subtest rcs0: SUCCESS (2.162s)
[143.135052] Starting dynamic subtest: bcs0
[145.281127] Dynamic subtest bcs0: SUCCESS (2.166s)
[145.299191] Starting dynamic subtest: vcs0
[147.446678] Dynamic subtest vcs0: SUCCESS (2.161s)
[147.464907] Starting dynamic subtest: vecs0
[149.606685] Dynamic subtest vecs0: SUCCESS (2.161s)
[149.608023] Subtest engines: SUCCESS (8.657s)
[149.695438] [028/141] (869s left) gem_exec_balancer (nop)
[149.924173] Starting subtest: nop
[190.062358] Subtest nop: SUCCESS (40.138s)
[193.964973] [029/141] (825s left) feature_discovery (chamelium)
[194.264453] Starting subtest: chamelium
[194.266963] Subtest chamelium: SKIP (0.001s)
[194.346010] [030/141] (824s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[194.658029] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[194.660681] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[194.763667] [031/141] (824s left) gen7_exec_parse (batch-without-end)
[194.973524] Subtest batch-without-end: SKIP (0.000s)
[195.029139] [032/141] (824s left) gem_exec_whisper (basic-contexts-priority)
[195.252096] Starting subtest: basic-contexts-priority
[210.846389] Subtest basic-contexts-priority: SUCCESS (15.593s)
[211.047200] [033/141] (808s left) i915_pm_lpsp (screens-disabled)
[212.365112] Starting subtest: screens-disabled
[212.367809] Subtest screens-disabled: SKIP (0.000s)
[212.531170] [034/141] (806s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[212.837261] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[212.839847] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[212.931501] [035/141] (806s left) prime_vgem (basic-read)
[213.237432] Starting subtest: basic-read
[213.290873] Subtest basic-read: SUCCESS (0.052s)
[213.397362] [036/141] (806s left) gem_render_linear_blits (basic)
[213.607294] Starting subtest: basic
[213.684977] Subtest basic: SUCCESS (0.078s)
[213.747862] [037/141] (805s left) gem_exec_schedule (fairslice-all)
[213.983080] Starting subtest: fairslice-all
[216.098561] Subtest fairslice-all: SUCCESS (2.115s)
[216.466982] [038/141] (803s left) sw_sync (sync_busy_fork_unixsocket)
[216.670674] Starting subtest: sync_busy_fork_unixsocket
[216.706208] Subtest sync_busy_fork_unixsocket: SUCCESS (0.035s)
[216.782154] [039/141] (802s left) kms_chamelium_edid (hdmi-mode-timings)
[217.173897] Subtest hdmi-mode-timings: SKIP (0.000s)
[217.451911] [040/141] (802s left) v3d/v3d_submit_csd (bad-multisync-pad)
[217.707010] Subtest bad-multisync-pad: SKIP (0.000s)
[217.782431] [041/141] (801s left) kms_vrr (flip-basic)
[218.080725] Starting subtest: flip-basic
[218.084122] Subtest flip-basic: SKIP (0.000s)
[218.164748] [042/141] (801s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[218.453768] Starting subtest: flip-vs-dpms-off-vs-modeset
[218.455322] Starting dynamic subtest: A-DP1
[219.757977] Dynamic subtest A-DP1: SUCCESS (1.300s)
[219.779030] Starting dynamic subtest: B-DP1
[220.907782] Dynamic subtest B-DP1: SUCCESS (1.147s)
[220.930051] Starting dynamic subtest: C-DP1
[222.025267] Dynamic subtest C-DP1: SUCCESS (1.115s)
[222.026602] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (3.573s)
[222.367541] [043/141] (797s left) kms_chamelium_audio (dp-audio-edid)
[222.758491] Subtest dp-audio-edid: SKIP (0.000s)
[223.038292] [044/141] (796s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[223.262514] Starting subtest: mixed-tiled-to-y-tiled-ccs
[223.266269] Starting dynamic subtest: smem
[223.567542] Dynamic subtest smem: SUCCESS (0.301s)
[223.568918] Subtest mixed-tiled-to-y-tiled-ccs: SUCCESS (0.304s)
[223.768475] [045/141] (796s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[224.068668] Starting subtest: 2x-flip-vs-cursor-legacy
[224.071263] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.004s)
[224.166857] [046/141] (795s left) gem_exec_reloc (basic-gtt-read-active)
[224.380911] Starting subtest: basic-gtt-read-active
[224.523889] Subtest basic-gtt-read-active: SUCCESS (0.142s)
[224.722713] [047/141] (795s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc)
[225.053483] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc
[225.056023] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc: SKIP (0.001s)
[225.151407] [048/141] (794s left) gem_wait (invalid-flags)
[225.362848] Starting subtest: invalid-flags
[225.364449] Subtest invalid-flags: SUCCESS (0.000s)
[225.636704] [049/141] (794s left) kms_vblank (pipe-c-wait-idle)
[225.952027] Starting subtest: pipe-C-wait-idle
[228.739434] Subtest pipe-C-wait-idle: SUCCESS (2.788s)
[229.071748] [050/141] (790s left) kms_color (ctm-signed)
[229.374977] Starting subtest: ctm-signed
[229.376499] Starting dynamic subtest: pipe-A
[230.548773] Dynamic subtest pipe-A: SUCCESS (1.175s)
[230.569158] Starting dynamic subtest: pipe-B
[232.033000] Dynamic subtest pipe-B: SUCCESS (1.480s)
[232.075116] Starting dynamic subtest: pipe-C
[233.600203] Dynamic subtest pipe-C: SUCCESS (1.568s)
[233.601564] Subtest ctm-signed: SUCCESS (4.228s)
[233.927721] [051/141] (786s left) gem_caching (reads)
[234.149031] Starting subtest: reads
[241.121947] Subtest reads: SUCCESS (6.973s)
[241.244534] [052/141] (778s left) vc4/vc4_label_bo (set-bad-handle)
[241.502600] Subtest set-bad-handle: SKIP (0.000s)
[241.577300] [053/141] (778s left) kms_big_fb (linear-16bpp-rotate-0)
[241.911275] Starting subtest: linear-16bpp-rotate-0
[246.416666] Subtest linear-16bpp-rotate-0: SUCCESS (4.508s)
[246.746749] [054/141] (773s left) gem_create (create-ext-set-pat)
[247.092333] Starting subtest: create-ext-set-pat
[247.315796] Subtest create-ext-set-pat: FAIL (0.211s)
[247.396474] [055/141] (772s left) kms_big_fb (linear-8bpp-rotate-90)
[247.723916] Starting subtest: linear-8bpp-rotate-90
[247.813435] Subtest linear-8bpp-rotate-90: SKIP (0.089s)
[247.927599] [056/141] (772s left) kms_universal_plane (disable-primary-vs-flip-pipe-c)
[248.231908] Starting subtest: disable-primary-vs-flip-pipe-C
[249.404506] Subtest disable-primary-vs-flip-pipe-C: SUCCESS (1.175s)
[249.767944] [057/141] (770s left) kms_atomic (atomic_plane_damage)
[250.207200] Starting subtest: atomic_plane_damage
[250.209856] Subtest atomic_plane_damage: SKIP (0.000s)
[250.654764] [058/141] (769s left) gem_flink_race (flink_close)
[250.853825] Starting subtest: flink_close
[255.878585] Subtest flink_close: SUCCESS (5.025s)
[255.969370] [059/141] (764s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[256.274792] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[256.277621] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[256.386429] [060/141] (764s left) kms_atomic_transition (plane-all-transition-nonblocking)
[256.697526] Starting subtest: plane-all-transition-nonblocking
[256.698964] Starting dynamic subtest: pipe-A-DP-1
[260.725216] Dynamic subtest pipe-A-DP-1: SUCCESS (4.028s)
[260.846486] Starting dynamic subtest: pipe-B-DP-1
[265.245560] Dynamic subtest pipe-B-DP-1: SUCCESS (4.419s)
[265.347405] Subtest plane-all-transition-nonblocking: SUCCESS (8.652s)
[265.685125] [061/141] (754s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[266.012606] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[266.015646] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[266.118206] [062/141] (754s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[266.919312] Starting subtest: syncobj-backward-timeline-chain-engines
[267.059608] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.138s)
[267.285615] [063/141] (753s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[267.493525] Starting subtest: multi-wait-all-for-submit-signaled
[267.495034] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[267.584813] [064/141] (753s left) gem_lmem_swapping (parallel-random)
[267.793877] Subtest parallel-random: SKIP (0.000s)
[267.851271] [065/141] (752s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_gen12_rc_ccs_cc)
[268.432062] Starting subtest: pipe-C-crc-primary-basic-y_tiled_gen12_rc_ccs_cc
[268.434712] Subtest pipe-C-crc-primary-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.001s)
[268.832799] [066/141] (751s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[269.154799] Starting subtest: y-tiled-16bpp-rotate-0
[272.771001] Subtest y-tiled-16bpp-rotate-0: SUCCESS (3.616s)
[273.101945] [067/141] (747s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[273.430704] Starting subtest: 4-tiled-64bpp-rotate-180
[273.433414] Subtest 4-tiled-64bpp-rotate-180: SKIP (0.000s)
[273.534024] [068/141] (747s left) kms_psr2_su (page_flip-nv12)
[273.742551] Subtest page_flip-NV12: SKIP (0.000s)
[273.798298] [069/141] (747s left) sysfs_heartbeat_interval (nopreempt)
[274.006650] Starting subtest: nopreempt
[274.012548] Starting dynamic subtest: vecs0
[277.501016] Dynamic subtest vecs0: SUCCESS (3.488s)
[277.526820] Starting dynamic subtest: vcs0
[281.010186] Dynamic subtest vcs0: SUCCESS (3.506s)
[281.034116] Starting dynamic subtest: bcs0
[284.494470] Dynamic subtest bcs0: SUCCESS (3.483s)
[284.520826] Starting dynamic subtest: rcs0
[287.994621] Dynamic subtest rcs0: SUCCESS (3.494s)
[287.996825] Subtest nopreempt: SUCCESS (13.987s)
[288.082615] [070/141] (732s left) gem_mmap_wc (set-cache-level)
[288.292030] Starting subtest: set-cache-level
[288.293679] Subtest set-cache-level: SUCCESS (0.004s)
[288.382676] [071/141] (732s left) kms_rotation_crc (primary-rotation-270)
[288.689887] Starting subtest: primary-rotation-270
[294.794711] Subtest primary-rotation-270: SUCCESS (6.110s)
[295.223792] [072/141] (725s left) kms_getfb (getfb-reject-ccs)
[295.427540] Starting subtest: getfb-reject-ccs
[295.429028] Subtest getfb-reject-ccs: SUCCESS (0.000s)
[295.523195] [073/141] (725s left) kms_ccs (pipe-b-bad-rotation-90-yf_tiled_ccs)
[296.018316] Starting subtest: pipe-B-bad-rotation-90-yf_tiled_ccs
[296.486616] Subtest pipe-B-bad-rotation-90-yf_tiled_ccs: SUCCESS (0.466s)
[297.154206] [074/141] (723s left) kms_psr2_sf (overlay-primary-update-sf-dmg-area)
[297.360190] Subtest overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[297.416022] [075/141] (723s left) syncobj_timeline (single-wait-all-available-submitted)
[297.620743] Starting subtest: single-wait-all-available-submitted
[297.622657] Subtest single-wait-all-available-submitted: SUCCESS (0.001s)
[297.717585] [076/141] (723s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_dg2_mc_ccs)
[298.382398] Subtest pipe-D-random-ccs-data-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[298.704767] [077/141] (722s left) perf_pmu (most-busy-idle-check-all)
[298.918731] Starting subtest: most-busy-idle-check-all
[298.920440] Starting dynamic subtest: rcs0
[299.546077] Dynamic subtest rcs0: SUCCESS (0.626s)
[299.574861] Starting dynamic subtest: bcs0
[300.171828] Dynamic subtest bcs0: SUCCESS (0.621s)
[300.197292] Starting dynamic subtest: vcs0
[300.794872] Dynamic subtest vcs0: SUCCESS (0.620s)
[300.820199] Starting dynamic subtest: vecs0
[301.416836] Dynamic subtest vecs0: SUCCESS (0.621s)
[301.418298] Subtest most-busy-idle-check-all: SUCCESS (2.500s)
[301.521125] [078/141] (719s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[301.838065] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[302.976118] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.138s)
[303.323414] [079/141] (717s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_ccs)
[303.789800] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_ccs
[303.791583] Subtest pipe-A-ccs-on-another-bo-y_tiled_ccs: SUCCESS (0.002s)
[304.362204] [080/141] (716s left) kms_concurrent (pipe-b)
[304.673910] Starting subtest: pipe-B
[304.679293] Starting dynamic subtest: DP-1
[305.505254] Dynamic subtest DP-1: SUCCESS (0.826s)
[305.506531] Subtest pipe-B: SUCCESS (0.833s)
[305.824926] [081/141] (715s left) prime_vgem (basic-gtt)
[306.050797] Starting subtest: basic-gtt
[306.082688] Subtest basic-gtt: SUCCESS (0.032s)
[306.190442] [082/141] (715s left) kms_lease (page_flip_implicit_plane)
[306.495064] Starting subtest: page_flip_implicit_plane
[306.496475] Starting dynamic subtest: pipe-A-DP-1
[306.810837] Dynamic subtest pipe-A-DP-1: SUCCESS (0.316s)
[306.837921] Starting dynamic subtest: pipe-B-DP-1
[307.426423] Dynamic subtest pipe-B-DP-1: SUCCESS (0.610s)
[307.451117] Starting dynamic subtest: pipe-C-DP-1
[308.162155] Dynamic subtest pipe-C-DP-1: SUCCESS (0.731s)
[308.163744] Subtest page_flip_implicit_plane: SUCCESS (1.671s)
[308.490948] [083/141] (712s left) v3d/v3d_perfmon (create-perfmon-0)
[308.763865] Subtest create-perfmon-0: SKIP (0.000s)
[308.839607] [084/141] (712s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[309.148116] Starting subtest: basic-busy-flip-before-cursor-varying-size
[309.150869] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[309.240813] [085/141] (712s left) core_auth (many-magics)
[309.442157] Starting subtest: many-magics
[310.642727] Subtest many-magics: SUCCESS (1.199s)
[310.757430] [086/141] (710s left) gem_ctx_persistence (engines-queued)
[310.972100] Starting subtest: engines-queued
[310.974138] Starting dynamic subtest: rcs0
[311.022937] Dynamic subtest rcs0: SUCCESS (0.049s)
[311.054537] Starting dynamic subtest: bcs0
[311.168304] Dynamic subtest bcs0: SUCCESS (0.143s)
[311.195550] Starting dynamic subtest: vcs0
[311.226064] Dynamic subtest vcs0: SUCCESS (0.055s)
[311.252542] Starting dynamic subtest: vecs0
[311.291053] Dynamic subtest vecs0: SUCCESS (0.063s)
[311.292748] Subtest engines-queued: SUCCESS (0.320s)
[311.392354] [087/141] (710s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_mtl_rc_ccs)
[311.891932] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs
[311.894622] Subtest pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SKIP (0.001s)
[312.382953] [088/141] (709s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[312.688798] Starting subtest: psr-modesetfrombusy
[312.691358] Subtest psr-modesetfrombusy: SKIP (0.000s)
[312.799557] [089/141] (708s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[313.114595] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[313.117373] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[313.216060] [090/141] (708s left) gem_mmap_offset (basic-uaf)
[313.416707] Starting subtest: basic-uaf
[313.421838] Subtest basic-uaf: SUCCESS (0.005s)
[313.532424] [091/141] (708s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[313.850030] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[313.852741] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[313.949172] [092/141] (707s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_gen12_rc_ccs)
[314.573470] Starting subtest: pipe-C-random-ccs-data-y_tiled_gen12_rc_ccs
[314.577620] Subtest pipe-C-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[314.953129] [093/141] (706s left) kms_sequence (get-forked)
[315.256532] Starting subtest: get-forked
[315.257777] Starting dynamic subtest: DP-1-pipe-A
[317.642019] Dynamic subtest DP-1-pipe-A: SUCCESS (2.383s)
[317.670143] Starting dynamic subtest: DP-1-pipe-B
[320.314045] Dynamic subtest DP-1-pipe-B: SUCCESS (2.669s)
[320.338148] Starting dynamic subtest: DP-1-pipe-C
[323.115797] Dynamic subtest DP-1-pipe-C: SUCCESS (2.799s)
[323.117029] Subtest get-forked: SUCCESS (7.864s)
[323.427850] [094/141] (698s left) i915_pm_rpm (modeset-non-lpsp-stress)
[325.256042] Starting subtest: modeset-non-lpsp-stress
[332.357842] Subtest modeset-non-lpsp-stress: SUCCESS (7.102s)
[332.549039] [095/141] (689s left) gem_close (many-handles-one-vma)
[332.761588] Starting subtest: many-handles-one-vma
[332.846700] Subtest many-handles-one-vma: SUCCESS (0.084s)
[332.964153] [096/141] (689s left) gem_exec_reloc (basic-write-wc-noreloc)
[333.176521] Starting subtest: basic-write-wc-noreloc
[333.188388] Subtest basic-write-wc-noreloc: SUCCESS (0.012s)
[333.398109] [097/141] (688s left) kms_vblank (pipe-d-query-busy)
[333.696685] Subtest pipe-D-query-busy: SKIP (0.000s)
[333.780848] [098/141] (688s left) vc4/vc4_perfmon (destroy-valid-perfmon)
[334.037752] Subtest destroy-valid-perfmon: SKIP (0.000s)
[334.113466] [099/141] (688s left) vgem_slow (nohang)
[334.321804] Starting subtest: nohang
[344.623187] Subtest nohang: SUCCESS (10.302s)
[344.702134] [100/141] (677s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc)
[345.360906] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[345.684164] [101/141] (676s left) kms_psr (cursor_render)
[345.887147] Subtest cursor_render: SKIP (0.000s)
[345.950603] [102/141] (676s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[346.261003] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[346.264215] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[346.367650] [103/141] (675s left) kms_plane_scaling (planes-downscale-factor-0-25-unity-scaling)
[346.671255] Starting subtest: planes-downscale-factor-0-25-unity-scaling
[346.672791] Starting dynamic subtest: pipe-A-DP-1
[346.704661] Dynamic subtest pipe-A-DP-1: SKIP (0.029s)
[346.737218] Starting dynamic subtest: pipe-B-DP-1
[346.788487] Dynamic subtest pipe-B-DP-1: SKIP (0.079s)
[346.825593] Starting dynamic subtest: pipe-C-DP-1
[346.875324] Dynamic subtest pipe-C-DP-1: SKIP (0.082s)
[346.877918] Subtest planes-downscale-factor-0-25-unity-scaling: SKIP (0.206s)
[346.985805] [104/141] (675s left) i915_query (query-topology-known-pci-ids)
[347.186862] Starting subtest: query-topology-known-pci-ids
[347.190101] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[347.284140] [105/141] (675s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[347.611667] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[347.641593] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.028s)
[347.767686] [106/141] (674s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[348.084080] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[348.087020] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[348.184133] [107/141] (674s left) syncobj_timeline (etime-single-wait-all-submitted)
[348.386572] Starting subtest: etime-single-wait-all-submitted
[348.492586] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s)
[348.584467] [108/141] (673s left) gem_exec_fence (concurrent)
[348.942541] Starting subtest: concurrent
[348.944022] Starting dynamic subtest: rcs0
[348.984048] Dynamic subtest rcs0: SUCCESS (0.040s)
[349.012909] Starting dynamic subtest: bcs0
[349.024753] Dynamic subtest bcs0: SUCCESS (0.037s)
[349.051999] Starting dynamic subtest: vcs0
[349.061519] Dynamic subtest vcs0: SUCCESS (0.034s)
[349.089874] Starting dynamic subtest: vecs0
[349.098964] Dynamic subtest vecs0: SUCCESS (0.034s)
[349.100588] Subtest concurrent: SUCCESS (0.158s)
[349.768369] [109/141] (672s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_rc_ccs_cc)
[350.451735] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[350.774137] [110/141] (671s left) gem_exec_balancer (bonded-chain)
[350.999958] Starting subtest: bonded-chain
[354.702864] Subtest bonded-chain: SUCCESS (3.702s)
[358.575308] [111/141] (664s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[359.214811] Starting subtest: pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs_cc
[359.217541] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[359.563917] [112/141] (663s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[359.882106] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[359.885269] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[359.997974] [113/141] (662s left) kms_flip (2x-plain-flip-ts-check)
[360.285002] Starting subtest: 2x-plain-flip-ts-check
[360.287509] Subtest 2x-plain-flip-ts-check: SKIP (0.003s)
[360.397519] [114/141] (662s left) gem_userptr_blits (stress-purge)
[360.640864] Starting subtest: stress-purge
[366.066318] Subtest stress-purge: SUCCESS (5.425s)
[366.243841] [115/141] (656s left) perf_pmu (busy-hang)
[366.580354] Starting subtest: busy-hang
[366.581935] Starting dynamic subtest: rcs0
[367.631565] Dynamic subtest rcs0: SUCCESS (1.050s)
[367.660164] Starting dynamic subtest: bcs0
[368.689494] Dynamic subtest bcs0: SUCCESS (1.055s)
[368.718535] Starting dynamic subtest: vcs0
[369.734256] Dynamic subtest vcs0: SUCCESS (1.042s)
[369.760674] Starting dynamic subtest: vecs0
[370.782200] Dynamic subtest vecs0: SUCCESS (1.045s)
[370.783615] Subtest busy-hang: SUCCESS (4.203s)
[370.883924] [116/141] (652s left) kms_vblank (pipe-b-ts-continuation-modeset-hang)
[371.202157] Starting subtest: pipe-B-ts-continuation-modeset-hang
[378.506453] Subtest pipe-B-ts-continuation-modeset-hang: SUCCESS (7.307s)
[378.854575] [117/141] (644s left) i915_pm_dc (dc5-dpms-negative)
[380.188172] Starting subtest: dc5-dpms-negative
[384.495153] Subtest dc5-dpms-negative: SUCCESS (4.306s)
[384.705845] [118/141] (638s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[384.912384] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[384.917331] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.002s)
[385.004044] [119/141] (638s left) kms_ccs (pipe-a-crc-primary-rotation-180-y_tiled_gen12_mc_ccs)
[385.412546] Starting subtest: pipe-A-crc-primary-rotation-180-y_tiled_gen12_mc_ccs
[385.415107] Subtest pipe-A-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.001s)
[385.991284] [120/141] (637s left) gem_exec_flush (basic-uc-set-default)
[386.218674] Starting subtest: basic-uc-set-default
[391.691522] Subtest basic-uc-set-default: SUCCESS (5.473s)
[391.908149] [121/141] (631s left) api_intel_bb (destroy-bb)
[392.112572] Starting subtest: destroy-bb
[392.136476] Subtest destroy-bb: SUCCESS (0.026s)
[392.257218] [122/141] (630s left) gem_ctx_persistence (legacy-engines-queued)
[392.467615] Starting subtest: legacy-engines-queued
[392.472064] Starting dynamic subtest: render
[392.520601] Dynamic subtest render: SUCCESS (0.050s)
[392.550866] Starting dynamic subtest: bsd
[392.587727] Dynamic subtest bsd: SUCCESS (0.064s)
[392.621899] Starting dynamic subtest: blt
[392.740749] Dynamic subtest blt: SUCCESS (0.149s)
[392.770153] Starting dynamic subtest: vebox
[392.801699] Dynamic subtest vebox: SUCCESS (0.057s)
[392.803664] Subtest legacy-engines-queued: SUCCESS (0.335s)
[392.907995] [123/141] (630s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[393.115147] Starting subtest: invalid-multi-wait-all-unsubmitted
[393.116769] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[393.206587] [124/141] (630s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[393.517347] Starting subtest: fbc-rgb565-draw-mmap-wc
[395.695533] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (2.179s)
[395.823813] [125/141] (627s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[396.128178] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[396.130870] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.003s)
[396.241942] [126/141] (627s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_dg2_rc_ccs_cc)
[396.829669] Starting subtest: pipe-C-bad-rotation-90-4_tiled_dg2_rc_ccs_cc
[396.832206] Subtest pipe-C-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[397.237538] [127/141] (626s left) gem_mmap_gtt (big-copy-xy)
[397.441918] Starting subtest: big-copy-XY
[409.625171] Subtest big-copy-XY: SUCCESS (12.185s)
[409.772117] [128/141] (613s left) i915_hangman (engine-error-state-capture)
[410.123986] Starting subtest: engine-error-state-capture
[410.125843] Starting dynamic subtest: rcs0
[414.232987] Dynamic subtest rcs0: SUCCESS (4.107s)
[414.259419] Starting dynamic subtest: bcs0
[418.263216] Dynamic subtest bcs0: SUCCESS (4.027s)
[418.291216] Starting dynamic subtest: vcs0
[422.232420] Dynamic subtest vcs0: SUCCESS (3.966s)
[422.260245] Starting dynamic subtest: vecs0
[426.261216] Dynamic subtest vecs0: SUCCESS (4.026s)
[426.263127] Subtest engine-error-state-capture: SUCCESS (16.139s)
[426.387020] [129/141] (597s left) device_reset (unbind-reset-rebind)
[426.635361] Starting subtest: unbind-reset-rebind
[427.553844] Subtest unbind-reset-rebind: SUCCESS (0.916s)
[428.105491] [130/141] (595s left) kms_plane_alpha_blend (constant-alpha-min)
[428.429835] Starting subtest: constant-alpha-min
[428.741355] Starting dynamic subtest: pipe-A-DP-1
[429.478927] Dynamic subtest pipe-A-DP-1: SUCCESS (0.735s)
[429.525206] Starting dynamic subtest: pipe-C-DP-1
[430.429461] Dynamic subtest pipe-C-DP-1: SUCCESS (0.947s)
[430.430924] Subtest constant-alpha-min: SUCCESS (2.002s)
[430.795770] [131/141] (592s left) i915_pm_rps (min-max-config-loaded)
[431.014547] Starting subtest: min-max-config-loaded
[431.390547] Subtest min-max-config-loaded: SUCCESS (0.378s)
[431.495199] [132/141] (592s left) api_intel_allocator (alloc-simple)
[431.696995] Starting subtest: alloc-simple
[431.701330] Subtest alloc-simple: SUCCESS (0.004s)
[431.826715] [133/141] (591s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[432.151128] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[432.154211] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[432.261692] [134/141] (591s left) kms_cursor_crc (cursor-random-64x21)
[432.577607] Starting subtest: cursor-random-64x21
[432.588506] Starting dynamic subtest: pipe-A-DP-1
[436.613732] Dynamic subtest pipe-A-DP-1: SUCCESS (4.023s)
[436.706727] Starting dynamic subtest: pipe-C-DP-1
[440.836198] Dynamic subtest pipe-C-DP-1: SUCCESS (4.153s)
[440.837787] Subtest cursor-random-64x21: SUCCESS (8.258s)
[441.215894] [135/141] (582s left) gem_softpin (allocator-fork)
[441.426940] Starting subtest: allocator-fork
[443.808835] Subtest allocator-fork: SUCCESS (2.381s)
[443.913332] [136/141] (579s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[444.235570] Starting subtest: extended-modeset-hang-oldfb-with-reset
[444.239533] Starting dynamic subtest: pipe-A
[446.270253] Dynamic subtest pipe-A: SUCCESS (2.030s)
[446.306190] Starting dynamic subtest: pipe-C
[448.481319] Dynamic subtest pipe-C: SUCCESS (2.203s)
[448.482563] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (4.247s)
[448.856620] [137/141] (575s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_gen12_mc_ccs)
[449.485642] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_gen12_mc_ccs
[449.488616] Subtest pipe-C-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[449.859512] [138/141] (574s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[450.072256] Starting subtest: etime-multi-wait-for-submit-submitted
[450.180715] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.108s)
[450.275691] [139/141] (573s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[450.728074] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[450.734651] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.005s)
[451.272286] [140/141] (572s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[451.605655] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[452.754910] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.149s)
[453.106382] [141/141] (570s left) kms_pipe_crc_basic (bad-source)
[453.409249] Starting subtest: bad-source
[453.410892] Subtest bad-source: SUCCESS (0.001s)
[453.499686] Closing watchdogs
Done.