[61.790816] Initializing watchdogs [61.790881] /dev/watchdog0 [61.799143] [001/130] (960s left) gem_mmap_gtt (fault-concurrent-x) [61.871234] Subtest fault-concurrent-X: SKIP (0.000s) [61.908218] [002/130] (960s left) gem_softpin (evict-snoop) [62.004410] Starting subtest: evict-snoop [62.006273] Subtest evict-snoop: SKIP (0.000s) [62.119517] [003/130] (960s left) syncobj_wait (wait-all-for-submit-snapshot) [62.188943] Starting subtest: wait-all-for-submit-snapshot [62.272849] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [62.338979] [004/130] (960s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [64.360714] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [65.636844] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.274s) [65.817730] [005/130] (956s left) gem_pipe_control_store_loop (reused-buffer) [65.904304] Starting subtest: reused-buffer [68.081283] Subtest reused-buffer: SUCCESS (2.175s) [68.173255] [006/130] (954s left) syncobj_timeline (wait-any-complex) [68.261198] Starting subtest: wait-any-complex [68.323180] Subtest wait-any-complex: SUCCESS (0.062s) [68.384877] [007/130] (954s left) gen9_exec_parse (basic-rejected) [68.471838] Subtest basic-rejected: SKIP (0.000s) [68.514008] [008/130] (953s left) syncobj_timeline (etime-multi-wait-submitted) [68.585391] Starting subtest: etime-multi-wait-submitted [68.687930] Subtest etime-multi-wait-submitted: SUCCESS (0.102s) [68.790618] [009/130] (953s left) kms_mmap_write_crc (main) [70.828489] Starting subtest: main [70.830222] Starting dynamic subtest: pipe-A-HDMI-A-3 [74.515811] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.685s) [74.516770] Subtest main: SUCCESS (3.686s) [74.683906] [010/130] (947s left) kms_fbcon_fbt (fbc-suspend) [74.782188] Starting subtest: fbc-suspend [125.794662] Subtest fbc-suspend: SUCCESS (20.999s) [126.828899] [011/130] (926s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [128.897878] Starting subtest: crc-primary-basic-y-tiled-ccs [128.898793] Starting dynamic subtest: pipe-A-HDMI-A-3 [128.907318] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s) [128.915406] Starting dynamic subtest: pipe-B-HDMI-A-3 [128.923647] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s) [128.931287] Starting dynamic subtest: pipe-C-HDMI-A-3 [128.939427] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s) [128.947050] Starting dynamic subtest: pipe-D-HDMI-A-3 [128.957512] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s) [128.959401] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s) [129.093817] [012/130] (924s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling) [131.143474] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling [131.144386] Starting dynamic subtest: pipe-A-valid-mode [132.004598] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.860s) [132.005598] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (0.861s) [132.174425] [013/130] (921s left) gem_exec_whisper (basic-fds-all) [132.267859] Starting subtest: basic-fds-all [152.715758] Subtest basic-fds-all: SUCCESS (20.140s) [152.935475] [014/130] (901s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs) [154.959872] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs [154.960871] Starting dynamic subtest: pipe-A-HDMI-A-3 [154.969518] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [154.977841] Starting dynamic subtest: pipe-B-HDMI-A-3 [154.986761] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [154.994922] Starting dynamic subtest: pipe-C-HDMI-A-3 [155.003360] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [155.011646] Starting dynamic subtest: pipe-D-HDMI-A-3 [155.021507] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [155.023263] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.003s) [155.256770] [015/130] (898s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [157.276373] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [158.243476] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.961s) [158.408806] [016/130] (895s left) kms_pm_rpm (drm-resources-equal) [163.025760] Starting subtest: drm-resources-equal [169.506712] Subtest drm-resources-equal: SUCCESS (6.466s) [169.617819] [017/130] (884s left) kms_cursor_legacy (flip-vs-cursor-toggle) [171.733911] Starting subtest: flip-vs-cursor-toggle [182.021906] Subtest flip-vs-cursor-toggle: SUCCESS (10.282s) [182.163511] [018/130] (872s left) kms_big_fb (4-tiled-16bpp-rotate-180) [184.183382] Starting subtest: 4-tiled-16bpp-rotate-180 [185.864040] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.679s) [186.019673] [019/130] (868s left) gem_exec_reloc (basic-write-gtt-active) [186.090357] Subtest basic-write-gtt-active: SKIP (0.000s) [186.150182] [020/130] (868s left) kms_atomic_interruptible (universal-setplane-cursor) [188.192968] Starting subtest: universal-setplane-cursor [188.193852] Starting dynamic subtest: pipe-A-HDMI-A-3 [194.392003] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (6.195s) [194.393124] Subtest universal-setplane-cursor: SUCCESS (6.196s) [194.526798] [021/130] (859s left) kms_feature_discovery (psr2) [196.539040] Starting subtest: psr2 [196.540753] Subtest psr2: SKIP (0.000s) [196.593448] [022/130] (857s left) drm_fdinfo (virtual-busy-all) [196.692581] Starting subtest: virtual-busy-all [196.694748] Subtest virtual-busy-all: SKIP (0.000s) [196.796607] [023/130] (857s left) kms_cursor_legacy (torture-bo) [198.822927] Starting subtest: torture-bo [198.823870] Starting dynamic subtest: pipe-A [204.312399] Dynamic subtest pipe-A: SUCCESS (5.486s) [204.321656] Starting dynamic subtest: pipe-B [209.809863] Dynamic subtest pipe-B: SUCCESS (5.495s) [209.818658] Starting dynamic subtest: pipe-C [215.412012] Dynamic subtest pipe-C: SUCCESS (5.599s) [215.420811] Starting dynamic subtest: pipe-D [221.068066] Dynamic subtest pipe-D: SUCCESS (5.653s) [221.077571] Starting dynamic subtest: all-pipes [226.612203] Dynamic subtest all-pipes: SUCCESS (5.542s) [226.613103] Subtest torture-bo: SUCCESS (27.776s) [226.677167] [024/130] (827s left) kms_cursor_crc (cursor-random-128x42) [228.869070] Starting subtest: cursor-random-128x42 [228.873826] Starting dynamic subtest: pipe-A-HDMI-A-3 [233.234876] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.359s) [233.263521] Starting dynamic subtest: pipe-D-HDMI-A-3 [237.283818] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.027s) [237.284676] Subtest cursor-random-128x42: SUCCESS (8.411s) [237.531285] [025/130] (816s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff) [240.452393] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff [240.454153] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [240.532110] [026/130] (813s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs) [242.553668] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs [242.554616] Starting dynamic subtest: pipe-A-HDMI-A-3 [242.563390] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [242.572612] Starting dynamic subtest: pipe-B-HDMI-A-3 [242.581423] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [242.590250] Starting dynamic subtest: pipe-C-HDMI-A-3 [242.598687] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [242.607581] Starting dynamic subtest: pipe-D-HDMI-A-3 [242.617535] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [242.619097] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SKIP (0.004s) [242.811102] [027/130] (811s left) gem_exec_fence (basic-wait) [243.039784] Starting subtest: basic-wait [243.041244] Starting dynamic subtest: rcs0 [243.154213] Dynamic subtest rcs0: SUCCESS (0.114s) [243.165650] Starting dynamic subtest: bcs0 [243.205251] Dynamic subtest bcs0: SUCCESS (0.050s) [243.226291] Starting dynamic subtest: vcs0 [243.260310] Dynamic subtest vcs0: SUCCESS (0.054s) [243.296396] Starting dynamic subtest: vcs1 [243.320314] Dynamic subtest vcs1: SUCCESS (0.059s) [243.337762] Starting dynamic subtest: vecs0 [243.372628] Dynamic subtest vecs0: SUCCESS (0.051s) [243.402348] Starting dynamic subtest: vecs1 [243.427367] Dynamic subtest vecs1: SUCCESS (0.054s) [243.445818] Starting dynamic subtest: ccs0 [243.480931] Dynamic subtest ccs0: SUCCESS (0.053s) [243.482644] Subtest basic-wait: SUCCESS (0.442s) [244.189169] [028/130] (810s left) kms_busy (basic-hang) [247.121937] Starting subtest: basic-hang [247.124098] Starting dynamic subtest: flip-pipe-A [247.735079] Dynamic subtest flip-pipe-A: SUCCESS (0.612s) [247.745115] Starting dynamic subtest: modeset-pipe-A [248.417860] Dynamic subtest modeset-pipe-A: SUCCESS (0.682s) [248.427984] Starting dynamic subtest: flip-pipe-D [248.787500] Dynamic subtest flip-pipe-D: SUCCESS (0.367s) [248.798406] Starting dynamic subtest: modeset-pipe-D [249.408985] Dynamic subtest modeset-pipe-D: SUCCESS (0.622s) [249.409881] Subtest basic-hang: SUCCESS (2.288s) [249.536526] [029/130] (805s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [251.572483] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [251.574251] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [251.656732] [030/130] (802s left) gem_exec_flush (basic-wb-set-default) [251.833878] Subtest basic-wb-set-default: SKIP (0.000s) [251.878278] [031/130] (802s left) gem_ctx_engines (invalid-engines) [251.968407] Starting subtest: invalid-engines [251.999565] Subtest invalid-engines: SUCCESS (0.031s) [252.256067] [032/130] (802s left) kms_cursor_crc (cursor-random-64x21) [254.400343] Starting subtest: cursor-random-64x21 [254.404684] Starting dynamic subtest: pipe-A-HDMI-A-3 [258.903742] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.500s) [258.936627] Starting dynamic subtest: pipe-D-HDMI-A-3 [263.240736] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.313s) [263.241675] Subtest cursor-random-64x21: SUCCESS (8.841s) [263.541125] [033/130] (791s left) gem_exec_alignment (pi) [263.626047] Starting subtest: pi [295.217673] Subtest pi: SUCCESS (31.587s) [295.901558] [034/130] (758s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [297.993616] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [297.995428] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [298.076287] [035/130] (756s left) core_getclient [298.324920] [036/130] (756s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt) [300.363182] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt [300.364907] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [300.462816] [037/130] (754s left) kms_concurrent (multi-plane-atomic-lowres) [302.574596] Starting subtest: multi-plane-atomic-lowres [302.575484] Starting dynamic subtest: pipe-A-HDMI-A-3 [302.956076] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.381s) [302.956981] Subtest multi-plane-atomic-lowres: SUCCESS (0.382s) [303.114208] [038/130] (751s left) syncobj_timeline (invalid-query-one-illegal-handle) [303.203414] Starting subtest: invalid-query-one-illegal-handle [303.204362] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s) [303.273138] [039/130] (751s left) gem_mmap_gtt (basic-read) [303.351834] Subtest basic-read: SKIP (0.000s) [303.388342] [040/130] (751s left) perf_pmu (busy-idle-no-semaphores) [303.453581] Starting subtest: busy-idle-no-semaphores [303.454599] Starting dynamic subtest: rcs0 [304.147951] Dynamic subtest rcs0: SUCCESS (0.693s) [304.162209] Starting dynamic subtest: bcs0 [304.802818] Dynamic subtest bcs0: SUCCESS (0.652s) [304.817255] Starting dynamic subtest: vcs0 [305.454712] Dynamic subtest vcs0: SUCCESS (0.650s) [305.488055] Starting dynamic subtest: vcs1 [306.109637] Dynamic subtest vcs1: SUCCESS (0.652s) [306.123746] Starting dynamic subtest: vecs0 [306.762839] Dynamic subtest vecs0: SUCCESS (0.651s) [306.777713] Starting dynamic subtest: vecs1 [307.415867] Dynamic subtest vecs1: SUCCESS (0.651s) [307.430034] Starting dynamic subtest: ccs0 [308.069578] Dynamic subtest ccs0: SUCCESS (0.651s) [308.071575] Subtest busy-idle-no-semaphores: SUCCESS (4.614s) [308.202598] [041/130] (746s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt) [310.223131] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt [310.224764] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [310.325387] [042/130] (744s left) gem_render_copy (y-tiled) [310.494678] Starting subtest: y-tiled [310.496654] Subtest y-tiled: SKIP (0.000s) [310.704343] [043/130] (744s left) gem_exec_fence (syncobj-timeline-chain-engines) [311.389678] Starting subtest: syncobj-timeline-chain-engines [311.522818] Subtest syncobj-timeline-chain-engines: SUCCESS (0.137s) [311.781706] [044/130] (743s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [311.860103] Starting subtest: multi-wait-for-submit-available-submitted [311.860998] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s) [311.995825] [045/130] (743s left) gem_ctx_persistence (smoketest) [312.099911] Starting subtest: smoketest [350.909024] Subtest smoketest: SUCCESS (38.796s) [351.015276] [046/130] (704s left) gem_exec_params (invalid-ring2) [351.105660] Starting subtest: invalid-ring2 [351.106675] Subtest invalid-ring2: SUCCESS (0.000s) [351.217240] [047/130] (703s left) tools_test (sysfs_l3_parity) [351.282602] Starting subtest: sysfs_l3_parity [351.360666] Subtest sysfs_l3_parity: SKIP (0.083s) [351.416737] [048/130] (703s left) gem_pxp (display-protected-crc) [354.037802] Subtest display-protected-crc: SKIP (0.000s) [354.104329] [049/130] (701s left) perf (enable-disable) [354.477991] Starting subtest: enable-disable [354.478864] Starting dynamic subtest: 0-rcs0 [356.735662] Dynamic subtest 0-rcs0: SUCCESS (2.257s) [356.736636] Subtest enable-disable: SUCCESS (2.257s) [356.762136] [050/130] (698s left) gem_mmap_gtt (basic-write-read) [356.927578] Subtest basic-write-read: SKIP (0.000s) [356.975169] [051/130] (698s left) prime_vgem (sync) [357.115320] Starting subtest: sync [357.116503] Starting dynamic subtest: rcs0 [357.180954] Dynamic subtest rcs0: SUCCESS (0.065s) [357.192032] Starting dynamic subtest: bcs0 [357.234727] Dynamic subtest bcs0: SUCCESS (0.053s) [357.248962] Starting dynamic subtest: vcs0 [357.278886] Dynamic subtest vcs0: SUCCESS (0.043s) [357.298308] Starting dynamic subtest: vcs1 [357.319628] Dynamic subtest vcs1: SUCCESS (0.040s) [357.338939] Starting dynamic subtest: vecs0 [357.360841] Dynamic subtest vecs0: SUCCESS (0.040s) [357.380454] Starting dynamic subtest: vecs1 [357.402266] Dynamic subtest vecs1: SUCCESS (0.040s) [357.421952] Starting dynamic subtest: ccs0 [357.443515] Dynamic subtest ccs0: SUCCESS (0.040s) [357.444620] Subtest sync: SUCCESS (0.328s) [357.583946] [052/130] (697s left) kms_psr (fbc-psr-sprite-render) [359.652612] Subtest fbc-psr-sprite-render: SKIP (0.000s) [359.676293] [053/130] (695s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf) [361.739533] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s) [361.759996] [054/130] (693s left) gem_exec_reloc (basic-wc-read-active) [361.886069] Subtest basic-wc-read-active: SKIP (0.000s) [361.949791] [055/130] (693s left) kms_big_fb (linear-8bpp-rotate-0) [364.039612] Starting subtest: linear-8bpp-rotate-0 [365.631962] Subtest linear-8bpp-rotate-0: SUCCESS (1.591s) [365.811091] [056/130] (689s left) kms_flip (busy-flip) [367.888690] Starting subtest: busy-flip [367.893877] Starting dynamic subtest: A-HDMI-A3 [368.663790] Dynamic subtest A-HDMI-A3: SUCCESS (0.770s) [368.676228] Starting dynamic subtest: B-HDMI-A3 [369.360456] Dynamic subtest B-HDMI-A3: SUCCESS (0.696s) [369.371647] Starting dynamic subtest: C-HDMI-A3 [370.023898] Dynamic subtest C-HDMI-A3: SUCCESS (0.663s) [370.037396] Starting dynamic subtest: D-HDMI-A3 [370.703723] Dynamic subtest D-HDMI-A3: SUCCESS (0.679s) [370.704688] Subtest busy-flip: SUCCESS (2.817s) [370.955000] [057/130] (684s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [373.039588] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt [373.041337] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [373.143565] [058/130] (682s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [375.299403] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [375.301255] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s) [375.412206] [059/130] (680s left) gem_lmem_swapping (smem-oom) [381.793147] Starting subtest: smem-oom [381.794040] Starting dynamic subtest: lmem0 [396.139393] Dynamic subtest lmem0: CRASH (14.172s) [396.140528] Subtest smem-oom: SUCCESS (14.174s) [434.601961] Dynamic subtest lmem0: CRASH (52.666s) [434.603057] Subtest smem-oom: SUCCESS (52.669s) [451.462625] Dynamic subtest lmem0: CRASH (69.528s) [451.463653] Subtest smem-oom: SUCCESS (69.530s) [468.641609] Dynamic subtest lmem0: CRASH (86.706s) [468.642782] Subtest smem-oom: SUCCESS (86.708s) [485.397299] Dynamic subtest lmem0: CRASH (103.447s) [485.398352] Subtest smem-oom: SUCCESS (103.450s) [501.989918] Per-test timeout exceeded. Killing the current test with SIGQUIT. [502.142530] Dynamic subtest lmem0: CRASH (120.177s) [502.143353] Subtest smem-oom: SUCCESS (120.180s) [503.326386] Closing watchdogs [503.333918] Initializing watchdogs [503.333961] /dev/watchdog0 [503.349090] [060/130] (552s left) kms_pm_rpm (basic-rte) [503.492255] Starting subtest: basic-rte [509.441978] Subtest basic-rte: SUCCESS (5.948s) [511.864446] [061/130] (544s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [513.867574] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [513.869402] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [513.980742] [062/130] (541s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render) [516.110369] Starting subtest: fbcpsr-rgb101010-draw-render [516.112133] Subtest fbcpsr-rgb101010-draw-render: SKIP (0.000s) [516.204216] [063/130] (539s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite) [518.302899] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite [518.304721] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [518.407899] [064/130] (537s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25) [520.510005] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25 [520.510887] Starting dynamic subtest: pipe-A [520.606758] Dynamic subtest pipe-A: SUCCESS (0.098s) [520.619914] Starting dynamic subtest: pipe-B [520.731725] Dynamic subtest pipe-B: SUCCESS (0.124s) [520.747819] Starting dynamic subtest: pipe-C [520.858272] Dynamic subtest pipe-C: SUCCESS (0.126s) [520.882638] Starting dynamic subtest: pipe-D [520.998097] Dynamic subtest pipe-D: SUCCESS (0.139s) [520.999277] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.491s) [521.163050] [065/130] (534s left) dmabuf (all-tests) [521.238117] Starting subtest: all-tests [521.239031] Starting dynamic subtest: sanitycheck [521.347628] Dynamic subtest sanitycheck: SUCCESS (0.108s) [521.364396] Starting dynamic subtest: dma_fence [521.595991] Dynamic subtest dma_fence: SUCCESS (0.232s) [521.645640] Starting dynamic subtest: dma_fence_chain [530.891084] Dynamic subtest dma_fence_chain: SUCCESS (9.303s) [530.910712] Starting dynamic subtest: dma_fence_unwrap [531.002769] Dynamic subtest dma_fence_unwrap: SUCCESS (0.109s) [531.029032] Starting dynamic subtest: dma_resv [531.109065] Dynamic subtest dma_resv: SUCCESS (0.103s) [531.110974] Subtest all-tests: SUCCESS (9.870s) [531.208733] [066/130] (524s left) syncobj_timeline (single-wait-all-available-submitted) [531.285818] Starting subtest: single-wait-all-available-submitted [531.286812] Subtest single-wait-all-available-submitted: SUCCESS (0.000s) [531.425517] [067/130] (524s left) api_intel_bb (add-remove-objects) [531.503790] Starting subtest: add-remove-objects [531.536516] Subtest add-remove-objects: SUCCESS (0.033s) [531.714456] [068/130] (524s left) gem_exec_schedule (lateslice) [531.804873] Starting subtest: lateslice [531.805832] Starting dynamic subtest: rcs0 [531.850262] Dynamic subtest rcs0: SUCCESS (0.045s) [531.863372] Starting dynamic subtest: bcs0 [531.870179] Dynamic subtest bcs0: SUCCESS (0.019s) [531.883562] Starting dynamic subtest: vcs0 [531.892602] Dynamic subtest vcs0: SUCCESS (0.022s) [531.905592] Starting dynamic subtest: vcs1 [531.914027] Dynamic subtest vcs1: SUCCESS (0.021s) [531.926627] Starting dynamic subtest: vecs0 [531.933782] Dynamic subtest vecs0: SUCCESS (0.019s) [531.946606] Starting dynamic subtest: vecs1 [531.958154] Dynamic subtest vecs1: SUCCESS (0.024s) [531.970700] Starting dynamic subtest: ccs0 [531.978837] Dynamic subtest ccs0: SUCCESS (0.020s) [531.979715] Subtest lateslice: SUCCESS (0.174s) [532.376603] [069/130] (523s left) gem_basic (create-close) [532.453783] Starting subtest: create-close [532.455975] Subtest create-close: SUCCESS (0.000s) [532.599525] [070/130] (523s left) i915_power (sanity) [532.676866] Starting subtest: sanity [536.743880] Subtest sanity: SUCCESS (4.065s) [536.866032] [071/130] (519s left) kms_vblank (wait-busy-hang) [538.874819] Starting subtest: wait-busy-hang [538.875709] Starting dynamic subtest: pipe-A-HDMI-A-3 [565.575205] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (26.693s) [565.589585] Starting dynamic subtest: pipe-D-HDMI-A-3 [590.558765] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (24.974s) [590.559717] Subtest wait-busy-hang: SUCCESS (51.672s) [590.691168] [072/130] (465s left) drm_read (empty-nonblock) [592.769465] Starting subtest: empty-nonblock [592.770399] Subtest empty-nonblock: SUCCESS (0.000s) [592.986615] [073/130] (463s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant) [595.013647] Starting subtest: coverage-vs-premult-vs-constant [595.234261] Starting dynamic subtest: pipe-A-HDMI-A-3 [595.691699] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.457s) [595.705898] Starting dynamic subtest: pipe-D-HDMI-A-3 [596.141895] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.448s) [596.142867] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.129s) [596.295855] [074/130] (460s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt) [598.336389] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt [598.338083] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [598.436905] [075/130] (458s left) kms_addfb_basic (too-wide) [600.528619] Starting subtest: too-wide [600.529558] Subtest too-wide: SUCCESS (0.000s) [600.633909] [076/130] (455s left) kms_psr2_sf (pr-cursor-plane-update-sf) [602.726748] Subtest pr-cursor-plane-update-sf: SKIP (0.000s) [602.803389] [077/130] (453s left) kms_hdr (bpc-switch-dpms) [604.883756] Starting subtest: bpc-switch-dpms [604.886477] Subtest bpc-switch-dpms: SKIP (0.000s) [604.963253] [078/130] (451s left) gem_fenced_exec_thrash (no-spare-fences) [605.112586] Subtest no-spare-fences: SKIP (0.000s) [605.161184] [079/130] (451s left) gem_readwrite (write-bad-handle) [605.236889] Subtest write-bad-handle: SKIP (0.000s) [605.286060] [080/130] (451s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [607.313505] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [607.315481] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [607.430008] [081/130] (449s left) gem_wait (busy) [607.603568] Starting subtest: busy [607.604567] Starting dynamic subtest: all-engines [608.189264] Dynamic subtest all-engines: SUCCESS (0.586s) [608.202411] Starting dynamic subtest: rcs0 [608.728870] Dynamic subtest rcs0: SUCCESS (0.539s) [608.741975] Starting dynamic subtest: bcs0 [609.267716] Dynamic subtest bcs0: SUCCESS (0.538s) [609.280488] Starting dynamic subtest: vcs0 [609.806915] Dynamic subtest vcs0: SUCCESS (0.538s) [609.819580] Starting dynamic subtest: vcs1 [610.345723] Dynamic subtest vcs1: SUCCESS (0.538s) [610.358423] Starting dynamic subtest: vecs0 [610.884816] Dynamic subtest vecs0: SUCCESS (0.538s) [610.897679] Starting dynamic subtest: vecs1 [611.424154] Dynamic subtest vecs1: SUCCESS (0.538s) [611.437017] Starting dynamic subtest: ccs0 [611.963818] Dynamic subtest ccs0: SUCCESS (0.539s) [611.964750] Subtest busy: SUCCESS (4.361s) [612.193098] [082/130] (444s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [614.201551] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [614.203316] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [614.306587] [083/130] (442s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs) [616.404576] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs [616.406335] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s) [616.543041] [084/130] (440s left) kms_vrr (negative-basic) [618.618603] Starting subtest: negative-basic [618.621360] Subtest negative-basic: SKIP (0.000s) [618.697137] [085/130] (438s left) kms_joiner (basic-big-joiner) [620.775587] Starting subtest: basic-big-joiner [620.777341] Subtest basic-big-joiner: SKIP (0.000s) [620.844336] [086/130] (436s left) syncobj_wait (multi-wait-all-for-submit-signaled) [621.013018] Starting subtest: multi-wait-all-for-submit-signaled [621.013982] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [621.155833] [087/130] (435s left) gem_exec_balancer (parallel-dmabuf-import-out-fence) [621.474785] Starting subtest: parallel-dmabuf-import-out-fence [623.348105] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.874s) [626.449922] [088/130] (433s left) gem_spin_batch (resubmit-all) [626.532051] Starting subtest: resubmit-all [626.532987] Starting dynamic subtest: rcs0 [626.563821] Dynamic subtest rcs0: SUCCESS (0.031s) [626.577466] Starting dynamic subtest: bcs0 [626.578364] Dynamic subtest bcs0: SUCCESS (0.003s) [626.591417] Starting dynamic subtest: vcs0 [626.592671] Dynamic subtest vcs0: SUCCESS (0.002s) [626.605233] Starting dynamic subtest: vcs1 [626.606361] Dynamic subtest vcs1: SUCCESS (0.003s) [626.618831] Starting dynamic subtest: vecs0 [626.619921] Dynamic subtest vecs0: SUCCESS (0.003s) [626.632567] Starting dynamic subtest: vecs1 [626.633606] Dynamic subtest vecs1: SUCCESS (0.002s) [626.645944] Starting dynamic subtest: ccs0 [626.647200] Dynamic subtest ccs0: SUCCESS (0.002s) [626.648308] Subtest resubmit-all: SUCCESS (0.054s) [626.851284] [089/130] (433s left) kms_flip (2x-flip-vs-expired-vblank-interruptible) [628.877106] Starting subtest: 2x-flip-vs-expired-vblank-interruptible [628.890805] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.013s) [628.954665] [090/130] (431s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [631.070398] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [631.135147] [091/130] (429s left) perf_pmu (rc6-all-gts) [631.208459] Starting subtest: rc6-all-gts [631.210447] Subtest rc6-all-gts: SKIP (0.000s) [631.332477] [092/130] (428s left) gem_mmap_offset (clear-via-pagefault) [631.419797] Starting subtest: clear-via-pagefault [631.421049] Starting dynamic subtest: lmem0 [653.121553] Dynamic subtest lmem0: SUCCESS (21.713s) [653.135287] Starting dynamic subtest: smem0 [676.388594] Dynamic subtest smem0: SUCCESS (23.275s) [676.389575] Subtest clear-via-pagefault: SUCCESS (44.990s) [676.588818] [093/130] (383s left) kms_sequence (get-idle) [678.589621] Starting subtest: get-idle [678.590621] Starting dynamic subtest: pipe-A-HDMI-A-3 [680.963865] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.374s) [680.979189] Starting dynamic subtest: pipe-B-HDMI-A-3 [683.182918] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.218s) [683.198109] Starting dynamic subtest: pipe-C-HDMI-A-3 [685.393894] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.210s) [685.408993] Starting dynamic subtest: pipe-D-HDMI-A-3 [687.586396] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.190s) [687.587389] Subtest get-idle: SUCCESS (9.000s) [689.716799] [094/130] (372s left) i915_pm_freq_mult (media-freq) [689.786868] Starting subtest: media-freq [689.787852] Starting dynamic subtest: gt0 [690.295022] Dynamic subtest gt0: SUCCESS (0.508s) [690.296413] Subtest media-freq: SUCCESS (0.510s) [690.448441] [095/130] (371s left) kms_psr2_su (page_flip-nv12) [690.522877] Subtest page_flip-NV12: SKIP (0.000s) [690.566403] [096/130] (371s left) gem_exec_schedule (submit-early-slice) [690.649861] Starting subtest: submit-early-slice [690.650862] Starting dynamic subtest: rcs0 [690.720635] Dynamic subtest rcs0: SUCCESS (0.070s) [690.735198] Starting dynamic subtest: bcs0 [690.774420] Dynamic subtest bcs0: SUCCESS (0.052s) [690.787980] Starting dynamic subtest: vcs0 [690.820119] Dynamic subtest vcs0: SUCCESS (0.045s) [690.833599] Starting dynamic subtest: vcs1 [690.871788] Dynamic subtest vcs1: SUCCESS (0.051s) [690.885371] Starting dynamic subtest: vecs0 [690.919815] Dynamic subtest vecs0: SUCCESS (0.047s) [690.934406] Starting dynamic subtest: vecs1 [690.970370] Dynamic subtest vecs1: SUCCESS (0.049s) [690.983648] Starting dynamic subtest: ccs0 [691.017196] Dynamic subtest ccs0: SUCCESS (0.046s) [691.018115] Subtest submit-early-slice: SUCCESS (0.368s) [691.442187] [097/130] (370s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt) [693.457566] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt [693.459336] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [693.544791] [098/130] (368s left) kms_rotation_crc (multiplane-rotation) [695.650594] Starting subtest: multiplane-rotation [707.334181] Subtest multiplane-rotation: SUCCESS (11.684s) [707.502114] [099/130] (354s left) gem_eio (in-flight-immediate) [707.863690] Starting subtest: in-flight-immediate [713.268697] Subtest in-flight-immediate: SUCCESS (5.406s) [715.270979] [100/130] (347s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [717.344641] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [717.346514] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [717.450182] [101/130] (345s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [719.565574] Starting subtest: primary-yf-tiled-reflect-x-180 [719.662336] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.097s) [719.811610] [102/130] (342s left) gem_softpin (allocator-nopin-reserve) [719.933729] Starting subtest: allocator-nopin-reserve [720.124858] Subtest allocator-nopin-reserve: SUCCESS (0.191s) [720.273252] [103/130] (342s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt) [722.299665] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt [722.301876] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [722.406359] [104/130] (340s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic) [724.517870] Starting subtest: 2x-long-flip-vs-cursor-atomic [724.519870] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s) [724.583646] [105/130] (338s left) i915_pm_rpm (sysfs-read) [729.094735] Starting subtest: sysfs-read [730.281992] Subtest sysfs-read: SUCCESS (1.183s) [731.501096] [106/130] (331s left) kms_addfb_basic (master-rmfb) [731.584481] Starting subtest: master-rmfb [731.587502] Subtest master-rmfb: SUCCESS (0.003s) [733.635224] [107/130] (329s left) gem_pxp (verify-pxp-stale-buf-execution) [736.332968] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s) [736.414602] [108/130] (326s left) gem_ctx_param (invalid-param-get) [736.489201] Starting subtest: invalid-param-get [736.491594] Subtest invalid-param-get: SUCCESS (0.001s) [736.572795] [109/130] (326s left) kms_dsc (dsc-with-formats) [738.584697] Starting subtest: dsc-with-formats [738.601579] Subtest dsc-with-formats: SKIP (0.001s) [738.652928] [110/130] (324s left) kms_flip (2x-flip-vs-blocking-wf-vblank) [740.720659] Starting subtest: 2x-flip-vs-blocking-wf-vblank [740.732811] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.013s) [740.805361] [111/130] (322s left) kms_psr (fbc-pr-sprite-blt) [742.876889] Subtest fbc-pr-sprite-blt: SKIP (0.000s) [742.913636] [112/130] (320s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size) [744.915652] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size [745.934083] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.019s) [746.112611] [113/130] (316s left) gem_basic (multigpu-create-close) [746.187829] Starting subtest: multigpu-create-close [746.189647] Subtest multigpu-create-close: SKIP (0.000s) [746.278789] [114/130] (316s left) kms_chamelium_color (degamma) [748.315920] Subtest degamma: SKIP (0.000s) [748.354995] [115/130] (314s left) kms_psr (fbc-psr-sprite-mmap-cpu) [750.362098] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s) [750.389231] [116/130] (312s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [752.401778] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip [752.403627] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [752.508168] [117/130] (310s left) gem_ctx_persistence (heartbeat-close) [752.673412] Starting subtest: heartbeat-close [752.675486] Subtest heartbeat-close: SKIP (0.001s) [752.780622] [118/130] (310s left) gem_ctx_create (basic-files) [752.904706] Starting subtest: basic-files [754.921359] Subtest basic-files: SUCCESS (2.017s) [755.666383] [119/130] (307s left) gem_unref_active_buffers [755.961422] [120/130] (307s left) gem_busy (close-race) [756.050684] Starting subtest: close-race [778.058847] Subtest close-race: SUCCESS (22.007s) [778.585247] [121/130] (284s left) perf (i915-ref-count) [778.774623] Starting subtest: i915-ref-count [779.022788] Subtest i915-ref-count: SUCCESS (0.248s) [779.145042] [122/130] (284s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling) [781.218577] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling [781.219573] Starting dynamic subtest: pipe-A-valid-mode [781.263347] Dynamic subtest pipe-A-valid-mode: SKIP (0.043s) [781.265015] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.044s) [781.364667] [123/130] (281s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [783.468649] Starting subtest: plane-scaler-with-clipping-clamping-rotation [783.469635] Starting dynamic subtest: pipe-A [783.854350] Dynamic subtest pipe-A: SUCCESS (0.386s) [783.893008] Starting dynamic subtest: pipe-B [784.279231] Dynamic subtest pipe-B: SUCCESS (0.423s) [784.314938] Starting dynamic subtest: pipe-C [784.686405] Dynamic subtest pipe-C: SUCCESS (0.405s) [784.720130] Starting dynamic subtest: pipe-D [785.094206] Dynamic subtest pipe-D: SUCCESS (0.406s) [785.095509] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (1.628s) [785.306756] [124/130] (278s left) kms_psr (psr2-sprite-render) [787.372017] Subtest psr2-sprite-render: SKIP (0.000s) [787.402484] [125/130] (275s left) kms_big_fb (linear-16bpp-rotate-180) [789.486890] Starting subtest: linear-16bpp-rotate-180 [791.269212] Subtest linear-16bpp-rotate-180: SUCCESS (1.781s) [791.426728] [126/130] (271s left) gem_exec_schedule (preempt-hang) [791.670353] Starting subtest: preempt-hang [791.671344] Starting dynamic subtest: rcs0 [792.039953] Dynamic subtest rcs0: SUCCESS (0.368s) [792.054964] Starting dynamic subtest: bcs0 [792.395576] Dynamic subtest bcs0: SUCCESS (0.354s) [792.410313] Starting dynamic subtest: vcs0 [792.740615] Dynamic subtest vcs0: SUCCESS (0.344s) [792.755012] Starting dynamic subtest: vcs1 [793.098785] Dynamic subtest vcs1: SUCCESS (0.357s) [793.113661] Starting dynamic subtest: vecs0 [793.453902] Dynamic subtest vecs0: SUCCESS (0.354s) [793.468837] Starting dynamic subtest: vecs1 [793.793598] Dynamic subtest vecs1: SUCCESS (0.339s) [793.808406] Starting dynamic subtest: ccs0 [794.137841] Dynamic subtest ccs0: SUCCESS (0.343s) [794.138792] Subtest preempt-hang: SUCCESS (2.467s) [794.482402] [127/130] (268s left) syncobj_wait (invalid-reset-bad-pad) [794.606368] Starting subtest: invalid-reset-bad-pad [794.607636] Subtest invalid-reset-bad-pad: SUCCESS (0.000s) [794.758530] [128/130] (268s left) debugfs_test (read_all_entries_display_on) [796.832607] Starting subtest: read_all_entries_display_on [797.605982] Subtest read_all_entries_display_on: SUCCESS (0.773s) [797.793258] [129/130] (265s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [799.869690] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [799.870646] Starting dynamic subtest: pipe-A-HDMI-A-3 [803.658320] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.771s) [803.678154] Starting dynamic subtest: pipe-B-HDMI-A-3 [804.149867] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.483s) [804.183352] Starting dynamic subtest: pipe-C-HDMI-A-3 [804.657059] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.501s) [804.690247] Starting dynamic subtest: pipe-D-HDMI-A-3 [805.164479] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.499s) [805.166346] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SUCCESS (5.279s) [805.389270] [130/130] (258s left) kms_chamelium_hpd (vga-hpd) [807.488108] Subtest vga-hpd: SKIP (0.000s) [807.551659] Closing watchdogs Done.