[40.729373] Initializing watchdogs
[40.729429]   /dev/watchdog0
[40.736360] [001/140] (960s left) gem_set_tiling_vs_pwrite
[40.821652] [002/140] (960s left) kms_big_fb (linear-16bpp-rotate-0)
[40.945172] Starting subtest: linear-16bpp-rotate-0
[42.464037] Subtest linear-16bpp-rotate-0: SUCCESS (1.519s)
[42.583310] [003/140] (958s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[42.667444] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[42.672069] Starting dynamic subtest: pipe-A-eDP-1
[42.708738] Dynamic subtest pipe-A-eDP-1: SKIP (0.033s)
[42.724435] Starting dynamic subtest: pipe-B-eDP-1
[42.769977] Dynamic subtest pipe-B-eDP-1: SKIP (0.059s)
[42.781124] Starting dynamic subtest: pipe-C-eDP-1
[42.800252] Dynamic subtest pipe-C-eDP-1: SKIP (0.032s)
[42.812050] Starting dynamic subtest: pipe-D-eDP-1
[42.852477] Dynamic subtest pipe-D-eDP-1: SKIP (0.049s)
[42.856666] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.181s)
[42.944667] [004/140] (958s left) gem_ctx_persistence (process)
[43.019128] Starting subtest: process
[43.146763] Subtest process: SUCCESS (0.128s)
[43.243511] [005/140] (958s left) v3d/v3d_submit_csd (bad-pad)
[43.355555] Subtest bad-pad: SKIP (0.000s)
[43.403105] [006/140] (957s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[43.469555] Starting subtest: multiplane-rotation-cropping-bottom
[51.416104] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.950s)
[51.524817] [007/140] (949s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[51.907331] Starting subtest: pipe-B-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[51.912066] Subtest pipe-B-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.001s)
[52.773277] [008/140] (948s left) gem_softpin (32b-excludes-last-page)
[52.842564] Starting subtest: 32b-excludes-last-page
[52.845081] Subtest 32b-excludes-last-page: SUCCESS (0.003s)
[52.931511] [009/140] (948s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[52.979276] Starting subtest: invalid-smem-bo-on-discrete
[52.984493] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[53.053870] [010/140] (948s left) gem_exec_whisper (basic-contexts-all)
[53.134880] Starting subtest: basic-contexts-all
[72.396071] Subtest basic-contexts-all: SUCCESS (19.257s)
[72.579628] [011/140] (928s left) kms_universal_plane (universal-plane-pageflip-windowed)
[72.669274] Starting subtest: universal-plane-pageflip-windowed
[72.671309] Starting dynamic subtest: pipe-A-eDP-1
[73.275949] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.606s)
[73.291269] Starting dynamic subtest: pipe-B-eDP-1
[74.636875] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.357s)
[74.656698] Starting dynamic subtest: pipe-C-eDP-1
[75.928761] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.290s)
[75.950789] Starting dynamic subtest: pipe-D-eDP-1
[77.207460] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.275s)
[77.210167] Subtest universal-plane-pageflip-windowed: SUCCESS (4.538s)
[78.119978] [012/140] (923s left) kms_lease (lease-revoke)
[78.182072] Starting subtest: lease-revoke
[78.184786] Starting dynamic subtest: pipe-A-eDP-1
[78.207883] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.029s)
[78.224296] Starting dynamic subtest: pipe-B-eDP-1
[78.250482] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.042s)
[78.259521] Starting dynamic subtest: pipe-C-eDP-1
[78.285996] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.034s)
[78.295801] Starting dynamic subtest: pipe-D-eDP-1
[78.319985] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.033s)
[78.322449] Subtest lease-revoke: SUCCESS (0.141s)
[78.419021] [013/140] (923s left) kms_ccs (pipe-d-crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[78.819086] Starting subtest: pipe-D-crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[78.825062] Subtest pipe-D-crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.001s)
[79.654353] [014/140] (921s left) kms_hdr (invalid-hdr)
[79.750373] Starting subtest: invalid-hdr
[80.883514] Starting dynamic subtest: pipe-A-eDP-1
[84.368957] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.486s)
[84.372067] Subtest invalid-hdr: SUCCESS (4.621s)
[84.463264] [015/140] (917s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[84.541454] Starting subtest: fbcpsr-indfb-scaledprimary
[90.387847] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.848s)
[90.505132] [016/140] (911s left) gem_mmap_offset (bad-flags)
[90.560649] Starting subtest: bad-flags
[90.563127] Subtest bad-flags: SUCCESS (0.000s)
[90.644357] [017/140] (911s left) gem_exec_params (invalid-fence-in-submit)
[90.722461] Starting subtest: invalid-fence-in-submit
[90.732028] Subtest invalid-fence-in-submit: SUCCESS (0.007s)
[90.829106] [018/140] (910s left) i915_pm_rpm (gem-idle)
[92.659064] Starting subtest: gem-idle
[101.240453] Subtest gem-idle: SUCCESS (8.582s)
[101.771481] [019/140] (899s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[102.448840] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu
[106.977663] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (4.534s)
[107.123071] [020/140] (894s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[107.195782] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[107.200323] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[107.276232] [021/140] (894s left) gem_ppgtt (shrink-vs-evict-pinned)
[107.333877] Starting subtest: shrink-vs-evict-pinned
[114.508791] Subtest shrink-vs-evict-pinned: SUCCESS (7.174s)
[114.593156] [022/140] (887s left) syncobj_wait (wait-for-submit-snapshot)
[114.653323] Starting subtest: wait-for-submit-snapshot
[114.733857] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[114.808899] [023/140] (887s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[114.888683] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[120.060308] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (5.178s)
[120.180590] [024/140] (881s left) kms_ccs (pipe-d-random-ccs-data-y-tiled-gen12-mc-ccs)
[120.603653] Starting subtest: pipe-D-random-ccs-data-y-tiled-gen12-mc-ccs
[120.611786] Subtest pipe-D-random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[121.448461] [025/140] (880s left) kms_ccs (pipe-b-bad-rotation-90-4-tiled-dg2-rc-ccs)
[121.842443] Starting subtest: pipe-B-bad-rotation-90-4-tiled-dg2-rc-ccs
[121.848458] Subtest pipe-B-bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[122.689085] [026/140] (879s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[122.804519] Starting subtest: short-flip-after-cursor-toggle
[123.769104] Subtest short-flip-after-cursor-toggle: SUCCESS (0.964s)
[124.648170] [027/140] (877s left) drm_fdinfo (memory-info-resident)
[124.710347] Starting subtest: memory-info-resident
[124.713443] Starting dynamic subtest: smem0
[124.743680] Dynamic subtest smem0: SKIP (0.033s)
[124.749669] Subtest memory-info-resident: SKIP (0.034s)
[124.806106] [028/140] (877s left) gem_render_tiled_blits (basic)
[124.865546] Subtest basic: SKIP (0.000s)
[124.898228] [029/140] (877s left) kms_ccs (pipe-d-bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[125.291257] Starting subtest: pipe-D-bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[125.294549] Subtest pipe-D-bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.000s)
[126.121512] [030/140] (875s left) kms_flip (2x-flip-vs-suspend)
[126.208335] Starting subtest: 2x-flip-vs-suspend
[126.220635] Subtest 2x-flip-vs-suspend: SKIP (0.014s)
[126.293569] [031/140] (875s left) vgem_basic (debugfs)
[126.383834] Starting subtest: debugfs
[126.385956] Subtest debugfs: SUCCESS (0.001s)
[126.431270] [032/140] (875s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-gtt)
[126.497545] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-gtt
[126.501536] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[126.593838] [033/140] (875s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[126.660558] Starting subtest: etime-single-wait-all-available-unsubmitted
[126.768270] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.108s)
[126.840442] [034/140] (875s left) kms_ccs (pipe-a-crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[127.222162] Starting subtest: pipe-A-crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[127.227624] Subtest pipe-A-crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[128.101504] [035/140] (874s left) kms_big_fb (linear-32bpp-rotate-180)
[128.178995] Starting subtest: linear-32bpp-rotate-180
[129.712895] Subtest linear-32bpp-rotate-180: SUCCESS (1.538s)
[129.883873] [036/140] (872s left) gem_exec_schedule (semaphore-user)
[129.953772] Starting subtest: semaphore-user
[129.980858] Subtest semaphore-user: SUCCESS (0.027s)
[131.471921] [037/140] (870s left) kms_addfb_basic (unused-pitches)
[131.536846] Starting subtest: unused-pitches
[131.539385] Subtest unused-pitches: SUCCESS (0.000s)
[131.625993] [038/140] (870s left) perf_pmu (faulting-read)
[131.706039] Starting subtest: faulting-read
[131.708991] Starting dynamic subtest: gtt
[131.714539] Dynamic subtest gtt: SKIP (0.000s)
[131.732531] Starting dynamic subtest: wb
[131.735400] Dynamic subtest wb: SUCCESS (0.002s)
[131.747360] Starting dynamic subtest: wc
[131.749932] Dynamic subtest wc: SUCCESS (0.001s)
[131.759284] Starting dynamic subtest: uc
[131.761326] Dynamic subtest uc: SUCCESS (0.001s)
[131.763408] Subtest faulting-read: SUCCESS (0.007s)
[131.809152] [039/140] (870s left) prime_mmap (test_invalid_sync_flags)
[131.865104] Starting subtest: test_invalid_sync_flags
[131.867711] Starting dynamic subtest: test_invalid_sync_flags-smem
[131.870287] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[131.872873] Subtest test_invalid_sync_flags: SUCCESS (0.000s)
[131.945991] [040/140] (870s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[132.040866] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[135.242264] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (3.206s)
[135.362786] [041/140] (867s left) kms_pwrite_crc
[137.075110] [042/140] (865s left) gem_ccs (ctrl-surf-copy-new-ctx)
[137.135171] Starting subtest: ctrl-surf-copy-new-ctx
[137.140597] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[137.201769] [043/140] (865s left) syncobj_wait (multi-wait-all-submitted)
[137.253320] Starting subtest: multi-wait-all-submitted
[137.359872] Subtest multi-wait-all-submitted: SUCCESS (0.107s)
[137.433553] [044/140] (865s left) i915_pm_rps (reset)
[137.502712] Starting subtest: reset
[137.568279] Subtest reset: FAIL (0.023s)
[137.616083] [045/140] (864s left) kms_flip (flip-vs-blocking-wf-vblank)
[137.683820] Starting subtest: flip-vs-blocking-wf-vblank
[137.686311] Starting dynamic subtest: A-eDP1
[146.703080] Dynamic subtest A-eDP1: SUCCESS (9.022s)
[146.720138] Starting dynamic subtest: B-eDP1
[155.727610] Dynamic subtest B-eDP1: SUCCESS (9.023s)
[155.747617] Starting dynamic subtest: C-eDP1
[164.752719] Dynamic subtest C-eDP1: SUCCESS (9.023s)
[164.770357] Starting dynamic subtest: D-eDP1
[173.831748] Dynamic subtest D-eDP1: SUCCESS (9.075s)
[173.837514] Subtest flip-vs-blocking-wf-vblank: SUCCESS (36.159s)
[175.138650] [046/140] (827s left) kms_concurrent (multi-plane-atomic-lowres)
[175.202679] Starting subtest: multi-plane-atomic-lowres
[175.205340] Starting dynamic subtest: pipe-A-eDP-1
[175.704523] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.499s)
[175.707255] Subtest multi-plane-atomic-lowres: SUCCESS (0.500s)
[176.618978] [047/140] (825s left) api_intel_allocator (fork-simple-stress)
[176.685424] Starting subtest: fork-simple-stress
[182.077555] Subtest fork-simple-stress: SUCCESS (5.395s)
[182.158370] [048/140] (820s left) gem_mmap_gtt (basic-small-bo)
[182.223774] Subtest basic-small-bo: SKIP (0.000s)
[182.261586] [049/140] (820s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[182.329770] Starting subtest: fbcpsr-tiling-y
[182.334938] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[182.425579] [050/140] (820s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[182.480244] Starting subtest: invalid-bsd2-flag-on-vebox
[182.482571] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[182.572196] [051/140] (820s left) kms_flip (basic-flip-vs-wf_vblank)
[182.645709] Starting subtest: basic-flip-vs-wf_vblank
[182.648646] Starting dynamic subtest: A-eDP1
[184.695360] Dynamic subtest A-eDP1: SUCCESS (2.052s)
[184.713268] Starting dynamic subtest: B-eDP1
[186.679027] Dynamic subtest B-eDP1: SUCCESS (1.982s)
[186.696793] Starting dynamic subtest: C-eDP1
[188.715958] Dynamic subtest C-eDP1: SUCCESS (2.036s)
[188.733557] Starting dynamic subtest: D-eDP1
[190.712828] Dynamic subtest D-eDP1: SUCCESS (1.995s)
[190.721383] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.081s)
[191.981292] [052/140] (810s left) kms_cursor_crc (cursor-onscreen-64x21)
[192.156789] Starting subtest: cursor-onscreen-64x21
[192.162050] Starting dynamic subtest: pipe-A-eDP-1
[194.587131] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.424s)
[194.623875] Starting dynamic subtest: pipe-D-eDP-1
[197.778024] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.162s)
[197.780181] Subtest cursor-onscreen-64x21: SUCCESS (5.618s)
[198.658766] [053/140] (804s left) prime_busy (before)
[198.714980] Starting subtest: before
[198.718235] Starting dynamic subtest: rcs0
[198.743770] Dynamic subtest rcs0: SUCCESS (0.027s)
[198.753951] Starting dynamic subtest: bcs0
[198.784797] Dynamic subtest bcs0: SUCCESS (0.041s)
[198.797977] Starting dynamic subtest: vcs0
[198.827347] Dynamic subtest vcs0: SUCCESS (0.041s)
[198.845064] Starting dynamic subtest: vcs1
[198.870219] Dynamic subtest vcs1: SUCCESS (0.042s)
[198.886508] Starting dynamic subtest: vecs0
[198.911751] Dynamic subtest vecs0: SUCCESS (0.041s)
[198.927996] Starting dynamic subtest: ccs0
[198.953953] Dynamic subtest ccs0: SUCCESS (0.041s)
[199.067525] Subtest before: SUCCESS (0.352s)
[199.133895] [054/140] (803s left) dmabuf_sync_file (export-basic)
[199.183315] Starting subtest: export-basic
[199.185585] Subtest export-basic: SUCCESS (0.001s)
[199.232225] [055/140] (803s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[199.298567] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[199.301102] Starting dynamic subtest: pipe-A-default-mode
[199.592433] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[199.598080] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.290s)
[200.489282] [056/140] (802s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[200.568919] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[200.571488] Starting dynamic subtest: pipe-A-eDP-1
[200.634776] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.067s)
[200.656148] Starting dynamic subtest: pipe-B-eDP-1
[201.895389] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.256s)
[201.915763] Starting dynamic subtest: pipe-C-eDP-1
[203.100705] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.200s)
[203.118250] Starting dynamic subtest: pipe-D-eDP-1
[204.313233] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.208s)
[204.315879] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.747s)
[205.546742] [057/140] (797s left) kms_psr (psr2_primary_render)
[205.623888] Starting subtest: psr2_primary_render
[205.626481] Starting dynamic subtest: eDP-1
[207.438803] Dynamic subtest eDP-1: SUCCESS (1.816s)
[207.441551] Subtest psr2_primary_render: SUCCESS (1.817s)
[208.362498] [058/140] (794s left) gem_lmem_evict (dontneed-evict-race)
[208.437933] Subtest dontneed-evict-race: SKIP (0.000s)
[208.479440] [059/140] (794s left) gem_exec_fence (basic-wait)
[208.688411] Starting subtest: basic-wait
[208.691161] Starting dynamic subtest: rcs0
[208.748349] Dynamic subtest rcs0: SUCCESS (0.060s)
[208.765685] Starting dynamic subtest: bcs0
[208.805969] Dynamic subtest bcs0: SUCCESS (0.057s)
[208.824271] Starting dynamic subtest: vcs0
[208.864330] Dynamic subtest vcs0: SUCCESS (0.057s)
[208.881606] Starting dynamic subtest: vcs1
[208.920731] Dynamic subtest vcs1: SUCCESS (0.056s)
[208.937732] Starting dynamic subtest: vecs0
[208.982253] Dynamic subtest vecs0: SUCCESS (0.060s)
[208.999371] Starting dynamic subtest: ccs0
[209.039218] Dynamic subtest ccs0: SUCCESS (0.056s)
[209.041798] Subtest basic-wait: SUCCESS (0.353s)
[210.470136] [060/140] (792s left) kms_ccs (pipe-c-random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[210.867086] Starting subtest: pipe-C-random-ccs-data-4-tiled-dg2-rc-ccs-cc
[210.875922] Subtest pipe-C-random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[211.755151] [061/140] (791s left) gem_ctx_persistence (engines-queued)
[211.806560] Starting subtest: engines-queued
[211.809094] Starting dynamic subtest: rcs0
[211.846599] Dynamic subtest rcs0: SUCCESS (0.042s)
[211.864757] Starting dynamic subtest: bcs0
[211.872697] Dynamic subtest bcs0: SUCCESS (0.025s)
[211.886381] Starting dynamic subtest: vcs0
[213.386979] Dynamic subtest vcs0: SUCCESS (1.512s)
[213.404945] Starting dynamic subtest: vcs1
[215.433495] Dynamic subtest vcs1: SUCCESS (2.045s)
[215.453027] Starting dynamic subtest: vecs0
[217.417552] Dynamic subtest vecs0: SUCCESS (1.982s)
[217.435776] Starting dynamic subtest: ccs0
[217.627501] Dynamic subtest ccs0: SUCCESS (0.210s)
[217.629996] Subtest engines-queued: SUCCESS (5.823s)
[217.730565] [062/140] (785s left) gem_exec_params (invalid-bsd2-flag-on-render)
[217.776554] Starting subtest: invalid-bsd2-flag-on-render
[217.780226] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[217.885788] [063/140] (785s left) gem_media_fill (media-fill)
[217.944403] Subtest media-fill: SKIP (0.000s)
[218.026274] [064/140] (785s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[218.118083] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[218.122586] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[218.195187] [065/140] (784s left) v3d/v3d_create_bo (create-bo-zeroed)
[218.272575] Subtest create-bo-zeroed: SKIP (0.000s)
[218.320706] [066/140] (784s left) syncobj_wait (multi-wait-all-submitted-signaled)
[218.375124] Starting subtest: multi-wait-all-submitted-signaled
[218.480114] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.104s)
[218.554807] [067/140] (784s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[218.612458] Starting subtest: fbcpsr-2p-rte
[218.616412] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[218.705175] [068/140] (784s left) gem_softpin (evict-active)
[218.761915] Starting subtest: evict-active
[218.768442] Subtest evict-active: SUCCESS (0.007s)
[218.875154] [069/140] (784s left) sw_sync (sync_multi_producer_single_consumer)
[218.927184] Starting subtest: sync_multi_producer_single_consumer
[220.001167] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[220.050276] [070/140] (783s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[220.110820] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[220.124691] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.014s)
[220.193351] [071/140] (783s left) gen9_exec_parse (bb-oversize)
[220.258671] Subtest bb-oversize: SKIP (0.000s)
[220.289417] [072/140] (782s left) gem_ctx_engines (execute-oneforall)
[220.352816] Starting subtest: execute-oneforall
[221.227622] Subtest execute-oneforall: SUCCESS (0.877s)
[222.563986] [073/140] (780s left) gem_exec_fair (basic-pace-share)
[222.644796] Subtest basic-pace-share: SKIP (0.000s)
[222.672731] [074/140] (780s left) sysfs_heartbeat_interval (idempotent)
[222.747501] Starting subtest: idempotent
[222.750020] Starting dynamic subtest: vecs0
[222.752760] Dynamic subtest vecs0: SUCCESS (0.003s)
[222.767904] Starting dynamic subtest: ccs0
[222.770529] Dynamic subtest ccs0: SUCCESS (0.002s)
[222.780268] Starting dynamic subtest: vcs0
[222.782210] Dynamic subtest vcs0: SUCCESS (0.001s)
[222.789883] Starting dynamic subtest: bcs0
[222.791940] Dynamic subtest bcs0: SUCCESS (0.001s)
[222.798792] Starting dynamic subtest: rcs0
[222.800858] Dynamic subtest rcs0: SUCCESS (0.001s)
[222.807267] Starting dynamic subtest: vcs1
[222.809211] Dynamic subtest vcs1: SUCCESS (0.001s)
[222.811556] Subtest idempotent: SUCCESS (0.019s)
[222.852278] [075/140] (780s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[222.932817] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[223.530874] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.603s)
[223.710946] [076/140] (779s left) gem_exec_balancer (bonded-pair)
[223.783068] Starting subtest: bonded-pair
[223.787920] Subtest bonded-pair: SKIP (0.000s)
[224.034699] [077/140] (779s left) prime_mmap (test_forked_cpu_write)
[224.081996] Starting subtest: test_forked_cpu_write
[224.084768] Starting dynamic subtest: test_forked_cpu_write-smem
[224.087256] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.007s)
[224.089875] Subtest test_forked_cpu_write: SUCCESS (0.007s)
[224.177378] [078/140] (779s left) kms_setmode (clone-exclusive-crtc)
[224.230363] Starting subtest: clone-exclusive-crtc
[224.237360] Subtest clone-exclusive-crtc: SKIP (0.000s)
[224.293867] [079/140] (779s left) syncobj_timeline (multi-wait-for-submit-signaled)
[224.335671] Starting subtest: multi-wait-for-submit-signaled
[224.338327] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[224.399331] [080/140] (779s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[224.469608] Starting subtest: etime-single-wait-for-submit-unsubmitted
[224.576113] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[224.651415] [081/140] (778s left) kms_psr (psr2_primary_blt)
[224.750973] Starting subtest: psr2_primary_blt
[224.753431] Starting dynamic subtest: eDP-1
[226.572733] Dynamic subtest eDP-1: SUCCESS (1.821s)
[226.575748] Subtest psr2_primary_blt: SUCCESS (1.822s)
[227.498413] [082/140] (776s left) perf (oa-exponents)
[227.649115] Starting subtest: oa-exponents
[227.653650] Starting dynamic subtest: 0-rcs0
[229.447608] Dynamic subtest 0-rcs0: SUCCESS (1.800s)
[229.458738] Starting dynamic subtest: 1-vcs0
[231.273942] Dynamic subtest 1-vcs0: SUCCESS (1.826s)
[231.276824] Subtest oa-exponents: SUCCESS (3.627s)
[231.309154] [083/140] (772s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-blt)
[231.399613] Starting subtest: psr-1p-offscren-pri-indfb-draw-blt
[236.165067] Subtest psr-1p-offscren-pri-indfb-draw-blt: SUCCESS (4.766s)
[236.289528] [084/140] (767s left) sw_sync (sync_merge_invalid)
[236.341292] Starting subtest: sync_merge_invalid
[236.346456] Subtest sync_merge_invalid: SUCCESS (0.001s)
[236.384202] [085/140] (767s left) kms_pipe_crc_basic (read-crc)
[236.446499] Starting subtest: read-crc
[236.449060] Starting dynamic subtest: pipe-A-eDP-1
[237.205547] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.756s)
[237.224330] Starting dynamic subtest: pipe-B-eDP-1
[238.697362] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.489s)
[238.716043] Starting dynamic subtest: pipe-C-eDP-1
[240.136134] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.434s)
[240.154609] Starting dynamic subtest: pipe-D-eDP-1
[241.595479] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.457s)
[241.598045] Subtest read-crc: SUCCESS (5.148s)
[242.481637] [086/140] (761s left) kms_display_modes (mst-extended-mode-negative)
[242.549919] Starting subtest: mst-extended-mode-negative
[242.555100] Subtest mst-extended-mode-negative: SKIP (0.000s)
[242.574622] [087/140] (761s left) kms_psr2_sf (overlay-primary-update-sf-dmg-area)
[247.801920] Starting subtest: overlay-primary-update-sf-dmg-area
[247.804845] Starting dynamic subtest: pipe-A-eDP-1
[254.625428] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.820s)
[254.643169] Starting dynamic subtest: pipe-B-eDP-1
[261.439183] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.812s)
[261.441893] Subtest overlay-primary-update-sf-dmg-area: SUCCESS (13.639s)
[262.381672] [088/140] (741s left) gem_exec_balancer (fairslice)
[262.437262] Starting subtest: fairslice
[265.076929] Subtest fairslice: SUCCESS (2.639s)
[266.475881] [089/140] (737s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[266.566863] Starting subtest: 4-tiled-64bpp-rotate-180
[268.090635] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.527s)
[268.280361] [090/140] (735s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[268.350237] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[268.354347] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[268.431307] [091/140] (735s left) kms_vblank (wait-forked-busy)
[268.530326] Starting subtest: wait-forked-busy
[268.532745] Starting dynamic subtest: pipe-A-eDP-1
[270.433455] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.905s)
[270.453620] Starting dynamic subtest: pipe-D-eDP-1
[273.080837] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.637s)
[273.084118] Subtest wait-forked-busy: SUCCESS (4.552s)
[273.962059] [092/140] (729s left) kms_ccs (pipe-a-bad-aux-stride-y-tiled-gen12-rc-ccs)
[274.352830] Starting subtest: pipe-A-bad-aux-stride-y-tiled-gen12-rc-ccs
[274.357976] Subtest pipe-A-bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[275.210796] [093/140] (728s left) kms_ccs (pipe-a-bad-rotation-90-y-tiled-gen12-mc-ccs)
[275.585982] Starting subtest: pipe-A-bad-rotation-90-y-tiled-gen12-mc-ccs
[275.590854] Subtest pipe-A-bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[276.456096] [094/140] (727s left) vc4/vc4_perfmon (create-two-perfmon)
[276.547734] Subtest create-two-perfmon: SKIP (0.000s)
[276.599871] [095/140] (727s left) gem_vm_create (create-ext)
[276.666308] Starting subtest: create-ext
[276.672512] Subtest create-ext: SUCCESS (0.006s)
[276.770822] [096/140] (727s left) kms_cursor_crc (cursor-sliding-32x10)
[276.907817] Starting subtest: cursor-sliding-32x10
[276.937483] Subtest cursor-sliding-32x10: SKIP (0.026s)
[277.144373] [097/140] (726s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[277.251176] Starting subtest: 2x-long-cursor-vs-flip-legacy
[277.260427] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.003s)
[277.396387] [098/140] (726s left) v3d/v3d_submit_cl (simple-flush-cache)
[277.472822] Subtest simple-flush-cache: SKIP (0.000s)
[277.511923] [099/140] (726s left) kms_ccs (pipe-c-bad-pixel-format-4-tiled-mtl-rc-ccs)
[277.904906] Starting subtest: pipe-C-bad-pixel-format-4-tiled-mtl-rc-ccs
[277.908180] Subtest pipe-C-bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.000s)
[278.766799] [100/140] (725s left) gen3_mixed_blits
[278.865634] [101/140] (725s left) gem_pxp (verify-pxp-stale-buf-execution)
[281.503577] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s)
[281.535511] [102/140] (722s left) prime_vgem (shrink)
[281.637584] Starting subtest: shrink
[281.657551] Subtest shrink: SUCCESS (0.020s)
[281.755299] [103/140] (722s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[281.867177] Starting subtest: psr-rgb101010-draw-pwrite
[286.949694] Subtest psr-rgb101010-draw-pwrite: SUCCESS (5.086s)
[287.072915] [104/140] (717s left) kms_flip (dpms-off-confusion-interruptible)
[287.146968] Starting subtest: dpms-off-confusion-interruptible
[287.154755] Starting dynamic subtest: A-eDP1
[295.946170] Dynamic subtest A-eDP1: SUCCESS (8.754s)
[295.965435] Starting dynamic subtest: B-eDP1
[304.665926] Dynamic subtest B-eDP1: SUCCESS (8.754s)
[304.683891] Starting dynamic subtest: C-eDP1
[313.374906] Dynamic subtest C-eDP1: SUCCESS (8.707s)
[313.393178] Starting dynamic subtest: D-eDP1
[322.175076] Dynamic subtest D-eDP1: SUCCESS (8.750s)
[322.177378] Subtest dpms-off-confusion-interruptible: SUCCESS (34.989s)
[323.429720] [105/140] (680s left) kms_getfb (getfb-repeated-different-handles)
[323.484503] Starting subtest: getfb-repeated-different-handles
[323.487048] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[323.573301] [106/140] (680s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[323.637091] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[323.641857] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[323.730023] [107/140] (680s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[323.819494] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[323.823726] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[323.897565] [108/140] (680s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[323.987048] Starting subtest: primary-y-tiled-reflect-x-270
[323.991886] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[324.060487] [109/140] (680s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[324.149762] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[324.154523] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[324.246168] [110/140] (680s left) kms_chamelium_hpd (vga-hpd)
[324.639830] Subtest vga-hpd: SKIP (0.000s)
[325.513415] [111/140] (678s left) kms_pm_dc (dc9-dpms)
[326.600210] Starting subtest: dc9-dpms
[327.737436] Subtest dc9-dpms: SUCCESS (1.135s)
[327.803622] [112/140] (676s left) gem_mmap_gtt (basic-short)
[327.880536] Subtest basic-short: SKIP (0.000s)
[327.908110] [113/140] (676s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[328.309988] Starting subtest: pipe-A-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[328.315840] Subtest pipe-A-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.001s)
[329.198206] [114/140] (675s left) kms_plane_scaling (invalid-num-scalers)
[329.299807] Starting subtest: invalid-num-scalers
[329.302317] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[329.313484] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.011s)
[329.330838] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[329.333421] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.020s)
[329.345664] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[329.352700] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.020s)
[329.362040] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[329.374590] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.020s)
[329.376577] Subtest invalid-num-scalers: SUCCESS (0.074s)
[329.457450] [115/140] (675s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[329.547892] Starting subtest: yf-tiled-8bpp-rotate-180
[329.551722] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[329.616477] [116/140] (674s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[329.679382] Starting subtest: multi-wait-available-unsubmitted-signaled
[329.682091] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[329.749915] [117/140] (674s left) api_intel_bb (intel-bb-blit-y)
[329.809397] Starting subtest: intel-bb-blit-y
[333.178147] Subtest intel-bb-blit-y: SUCCESS (3.368s)
[333.282049] [118/140] (671s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[333.355034] Subtest no-spare-fences-busy: SKIP (0.000s)
[333.394986] [119/140] (671s left) gem_softpin (softpin)
[333.465741] Starting subtest: softpin
[365.771106] Subtest softpin: SUCCESS (32.301s)
[365.872267] [120/140] (638s left) i915_pciid
[366.015128] [121/140] (638s left) gem_exec_reloc (basic-gtt-active)
[366.095534] Subtest basic-gtt-active: SKIP (0.000s)
[366.159251] [122/140] (638s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[366.242481] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[366.247073] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[366.332141] [123/140] (638s left) gem_exec_params (invalid-ring2)
[366.404726] Starting subtest: invalid-ring2
[366.407473] Subtest invalid-ring2: SUCCESS (0.000s)
[366.498093] [124/140] (638s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[366.571295] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[371.399106] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.831s)
[371.510532] [125/140] (633s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[371.568626] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[371.573346] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[371.649614] [126/140] (633s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[371.710943] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[375.335415] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (3.627s)
[375.435890] [127/140] (629s left) gem_caching (reads)
[375.506984] Subtest reads: SKIP (0.000s)
[375.551801] [128/140] (629s left) vc4/vc4_tiling (get-bad-handle)
[375.642052] Subtest get-bad-handle: SKIP (0.000s)
[375.698651] [129/140] (629s left) kms_cursor_edge_walk (256x256-top-edge)
[375.755055] Starting subtest: 256x256-top-edge
[375.757510] Starting dynamic subtest: pipe-A-eDP-1
[379.295853] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.538s)
[379.314950] Starting dynamic subtest: pipe-D-eDP-1
[382.548535] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.249s)
[382.551067] Subtest 256x256-top-edge: SUCCESS (6.792s)
[383.456810] [130/140] (621s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[383.563626] Starting subtest: 2x-cursor-vs-flip-atomic
[383.568423] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.002s)
[383.659088] [131/140] (621s left) gem_exec_schedule (noreorder-priority)
[383.851196] Starting subtest: noreorder-priority
[383.853770] Starting dynamic subtest: rcs0
[384.984166] Dynamic subtest rcs0: SUCCESS (1.133s)
[385.005748] Starting dynamic subtest: vcs0
[386.402621] Dynamic subtest vcs0: SUCCESS (1.416s)
[386.421519] Starting dynamic subtest: vcs1
[388.451506] Dynamic subtest vcs1: SUCCESS (2.047s)
[388.470670] Starting dynamic subtest: vecs0
[390.419455] Dynamic subtest vecs0: SUCCESS (1.964s)
[390.438606] Starting dynamic subtest: ccs0
[391.566734] Dynamic subtest ccs0: SUCCESS (1.149s)
[391.569446] Subtest noreorder-priority: SUCCESS (7.718s)
[391.760641] [132/140] (613s left) kms_ccs (pipe-c-crc-primary-basic-4-tiled-dg2-mc-ccs)
[392.161564] Starting subtest: pipe-C-crc-primary-basic-4-tiled-dg2-mc-ccs
[392.167342] Subtest pipe-C-crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[393.066993] [133/140] (612s left) kms_ccs (pipe-d-bad-rotation-90-y-tiled-ccs)
[393.464950] Starting subtest: pipe-D-bad-rotation-90-y-tiled-ccs
[393.471102] Subtest pipe-D-bad-rotation-90-y-tiled-ccs: SKIP (0.000s)
[394.346213] [134/140] (610s left) kms_pm_rpm (system-suspend-modeset)
[396.566983] Starting subtest: system-suspend-modeset
[421.682170] Subtest system-suspend-modeset: SUCCESS (9.117s)
[422.483750] [135/140] (598s left) kms_ccs (pipe-b-random-ccs-data-y-tiled-gen12-mc-ccs)
[422.874057] Starting subtest: pipe-B-random-ccs-data-y-tiled-gen12-mc-ccs
[422.883112] Subtest pipe-B-random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[423.787041] [136/140] (597s left) gem_softpin (zero)
[423.841393] Starting subtest: zero
[423.846019] Subtest zero: SUCCESS (0.005s)
[423.960023] [137/140] (597s left) syncobj_wait (single-wait-all-for-submit-submitted)
[424.014997] Starting subtest: single-wait-all-for-submit-submitted
[424.117107] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.104s)
[424.197365] [138/140] (597s left) kms_chamelium_edid (dp-mode-timings)
[424.577908] Subtest dp-mode-timings: SKIP (0.000s)
[425.483006] [139/140] (595s left) kms_ccs (pipe-b-bad-rotation-90-y-tiled-gen12-mc-ccs)
[425.870166] Starting subtest: pipe-B-bad-rotation-90-y-tiled-gen12-mc-ccs
[425.875722] Subtest pipe-B-bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[426.729802] [140/140] (594s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[427.074627] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[427.976116] Closing watchdogs
Done.