[58.013337] Initializing watchdogs [58.013382] /dev/watchdog0 [58.027784] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [58.032268] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.034295] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.036211] [001/132] (960s left) api_intel_bb (object-reloc-keep-cache) [58.100206] Starting subtest: object-reloc-keep-cache [58.102920] Subtest object-reloc-keep-cache: SKIP (0.003s) [58.199341] [002/132] (960s left) gem_gpgpu_fill (basic) [58.260533] Starting subtest: basic [58.261746] Starting dynamic subtest: smem [58.272163] Dynamic subtest smem: SUCCESS (0.012s) [58.273136] Subtest basic: SUCCESS (0.012s) [58.435268] [003/132] (960s left) gem_pread (bench) [58.490022] Subtest bench: SKIP (0.000s) [58.543913] [004/132] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [58.644056] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [58.645921] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [58.757154] [005/132] (959s left) kms_chamelium_audio (dp-audio-edid) [59.151390] Subtest dp-audio-edid: SKIP (0.000s) [59.968857] [006/132] (958s left) kms_vblank (wait-busy-hang) [60.061247] Starting subtest: wait-busy-hang [60.062182] Starting dynamic subtest: pipe-A-eDP-1 [86.742085] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.710s) [86.749766] Starting dynamic subtest: pipe-D-eDP-1 [111.630188] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.889s) [111.631085] Subtest wait-busy-hang: SUCCESS (51.602s) [112.434319] [007/132] (906s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [112.522255] Starting subtest: planes-downscale-factor-0-75-unity-scaling [112.523197] Starting dynamic subtest: pipe-A [112.586252] Dynamic subtest pipe-A: SUCCESS (0.065s) [112.593958] Starting dynamic subtest: pipe-B [113.748548] Dynamic subtest pipe-B: SUCCESS (1.162s) [113.757218] Starting dynamic subtest: pipe-C [114.865096] Dynamic subtest pipe-C: SUCCESS (1.115s) [114.871874] Starting dynamic subtest: pipe-D [115.997364] Dynamic subtest pipe-D: SUCCESS (1.132s) [115.998363] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.477s) [117.181958] [008/132] (901s left) gem_mmap_gtt (isolation) [117.235931] Subtest isolation: SKIP (0.000s) [117.301365] [009/132] (901s left) kms_flip (basic-flip-vs-wf_vblank) [117.388681] Starting subtest: basic-flip-vs-wf_vblank [117.390672] Starting dynamic subtest: A-eDP1 [119.308426] Dynamic subtest A-eDP1: SUCCESS (1.918s) [119.315046] Starting dynamic subtest: B-eDP1 [121.249429] Dynamic subtest B-eDP1: SUCCESS (1.940s) [121.260100] Starting dynamic subtest: C-eDP1 [123.173028] Dynamic subtest C-eDP1: SUCCESS (1.923s) [123.182957] Starting dynamic subtest: D-eDP1 [125.107381] Dynamic subtest D-eDP1: SUCCESS (1.934s) [125.109490] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.722s) [126.347894] [010/132] (892s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0) [126.464370] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0 [127.464656] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.001s) [127.601516] [011/132] (891s left) kms_psr (psr2-basic) [127.690508] Starting subtest: psr2-basic [127.691542] Starting dynamic subtest: eDP-1 [129.291557] Dynamic subtest eDP-1: SUCCESS (1.601s) [129.292567] Subtest psr2-basic: SUCCESS (1.602s) [130.108717] [012/132] (888s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt) [130.217958] Starting subtest: fbc-farfromfence-mmap-gtt [130.219841] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s) [130.348850] [013/132] (888s left) gen9_exec_parse (batch-zero-length) [130.411845] Subtest batch-zero-length: SKIP (0.000s) [130.480808] [014/132] (888s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs) [130.570076] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs [130.570919] Starting dynamic subtest: pipe-A-eDP-1 [130.594115] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.024s) [130.601712] Starting dynamic subtest: pipe-B-eDP-1 [130.624120] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.029s) [130.629847] Starting dynamic subtest: pipe-C-eDP-1 [130.646982] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s) [130.652635] Starting dynamic subtest: pipe-D-eDP-1 [130.670589] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.023s) [130.671530] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.102s) [132.892071] [015/132] (886s left) i915_pm_rpm (reg-read-ioctl) [135.109177] Starting subtest: reg-read-ioctl [137.398240] Subtest reg-read-ioctl: SUCCESS (2.291s) [137.790428] [016/132] (881s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted) [137.842188] Starting subtest: multi-wait-all-for-submit-unsubmitted [137.947404] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.103s) [138.037503] [017/132] (880s left) kms_scaling_modes (scaling-mode-full) [138.130036] Starting subtest: scaling-mode-full [138.131048] Starting dynamic subtest: pipe-A-eDP-1 [138.223901] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s) [138.233847] Starting dynamic subtest: pipe-B-eDP-1 [139.384370] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.159s) [139.392939] Starting dynamic subtest: pipe-C-eDP-1 [140.491597] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.106s) [140.499711] Starting dynamic subtest: pipe-D-eDP-1 [141.617606] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s) [141.618516] Subtest scaling-mode-full: SUCCESS (3.488s) [142.784860] [018/132] (876s left) gem_flink_basic (bad-open) [142.848406] Starting subtest: bad-open [142.849518] Subtest bad-open: SUCCESS (0.000s) [142.975269] [019/132] (876s left) gem_mmap_gtt (big-copy) [143.033167] Subtest big-copy: SKIP (0.000s) [143.100305] [020/132] (875s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc) [143.204473] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc [150.085757] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.880s) [150.227662] [021/132] (868s left) gem_exec_fence (syncobj-signal) [150.663789] Starting subtest: syncobj-signal [150.669909] Subtest syncobj-signal: SUCCESS (0.005s) [152.018715] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true [152.020703] [022/132] (867s left) gem_tiled_blits (normal) [152.065755] Subtest normal: SKIP (0.000s) [152.137990] [023/132] (867s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area) [157.096275] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area [157.098241] Starting dynamic subtest: pipe-A-eDP-1 [157.901165] Dynamic subtest pipe-A-eDP-1: SKIP (0.802s) [157.907900] Starting dynamic subtest: pipe-B-eDP-1 [159.136927] Dynamic subtest pipe-B-eDP-1: SKIP (1.234s) [159.139068] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (2.040s) [160.334034] [024/132] (858s left) kms_color (ctm-0-50) [160.428418] Starting subtest: ctm-0-50 [160.429307] Starting dynamic subtest: pipe-A-eDP-1 [163.872638] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.444s) [163.882607] Starting dynamic subtest: pipe-B-eDP-1 [168.126851] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.252s) [168.133492] Starting dynamic subtest: pipe-C-eDP-1 [172.084991] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.957s) [172.091652] Starting dynamic subtest: pipe-D-eDP-1 [176.088546] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.003s) [176.089391] Subtest ctm-0-50: SUCCESS (15.658s) [176.950295] [025/132] (842s left) gem_exec_params (no-bsd) [177.007215] Starting subtest: no-bsd [177.009679] Subtest no-bsd: SUCCESS (0.002s) [178.975845] [026/132] (840s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [179.060040] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [186.358525] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.298s) [186.512598] [027/132] (832s left) gem_exec_flush (basic-uc-rw-default) [186.576485] Starting subtest: basic-uc-rw-default [192.027631] Subtest basic-uc-rw-default: SUCCESS (5.451s) [192.232155] [028/132] (827s left) perf (create-destroy-userspace-config) [192.362472] Starting subtest: create-destroy-userspace-config [192.381395] Subtest create-destroy-userspace-config: SUCCESS (0.019s) [192.413885] [029/132] (826s left) kms_atomic (test-only) [192.509902] Starting subtest: test-only [192.559981] Starting dynamic subtest: pipe-A-eDP-1 [195.053599] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.492s) [195.054526] Subtest test-only: SUCCESS (2.543s) [195.887036] [030/132] (823s left) perf_pmu (most-busy-check-all) [195.924739] Starting subtest: most-busy-check-all [195.925674] Starting dynamic subtest: rcs0 [197.910496] Dynamic subtest rcs0: SUCCESS (1.984s) [197.920752] Starting dynamic subtest: bcs0 [199.895942] Dynamic subtest bcs0: SUCCESS (1.981s) [199.906323] Starting dynamic subtest: vcs0 [201.881804] Dynamic subtest vcs0: SUCCESS (1.983s) [201.891800] Starting dynamic subtest: vcs1 [203.927723] Dynamic subtest vcs1: SUCCESS (2.043s) [203.937703] Starting dynamic subtest: vecs0 [205.910768] Dynamic subtest vecs0: SUCCESS (1.982s) [205.920677] Starting dynamic subtest: ccs0 [207.895087] Dynamic subtest ccs0: SUCCESS (1.982s) [207.896787] Subtest most-busy-check-all: SUCCESS (11.970s) [208.036441] [031/132] (811s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt) [208.137695] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt [208.139457] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [208.266407] [032/132] (811s left) sysfs_preempt_timeout (invalid) [208.332852] Starting subtest: invalid [208.333917] Starting dynamic subtest: vecs0 [208.334937] Dynamic subtest vecs0: SUCCESS (0.000s) [208.343377] Starting dynamic subtest: ccs0 [208.344276] Dynamic subtest ccs0: SUCCESS (0.000s) [208.351069] Starting dynamic subtest: vcs0 [208.351949] Dynamic subtest vcs0: SUCCESS (0.000s) [208.358795] Starting dynamic subtest: bcs0 [208.359695] Dynamic subtest bcs0: SUCCESS (0.000s) [208.366316] Starting dynamic subtest: rcs0 [208.367209] Dynamic subtest rcs0: SUCCESS (0.000s) [208.373633] Starting dynamic subtest: vcs1 [208.374531] Dynamic subtest vcs1: SUCCESS (0.000s) [208.375422] Subtest invalid: SUCCESS (0.005s) [208.474079] [033/132] (811s left) gem_ctx_persistence (heartbeat-many) [208.525042] Starting subtest: heartbeat-many [208.526934] Subtest heartbeat-many: SKIP (0.000s) [208.685257] [034/132] (810s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs) [208.744463] Starting subtest: mixed-tiled-to-yf-tiled-ccs [208.746487] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s) [208.944533] [035/132] (810s left) gem_exec_capture (capture) [208.996400] Starting subtest: capture [208.997394] Starting dynamic subtest: rcs0-smem [209.830270] Dynamic subtest rcs0-smem: SUCCESS (0.834s) [209.837226] Starting dynamic subtest: bcs0-smem [210.652159] Dynamic subtest bcs0-smem: SUCCESS (0.822s) [210.659576] Starting dynamic subtest: vcs0-smem [211.463832] Dynamic subtest vcs0-smem: SUCCESS (0.811s) [211.470279] Starting dynamic subtest: vcs1-smem [212.778652] Dynamic subtest vcs1-smem: SUCCESS (1.314s) [212.785150] Starting dynamic subtest: vecs0-smem [213.648610] Dynamic subtest vecs0-smem: FAIL (0.851s) [213.655448] Starting dynamic subtest: ccs0-smem [214.954083] Dynamic subtest ccs0-smem: SUCCESS (1.323s) [214.954968] Subtest capture: FAIL (5.958s) [215.112302] [036/132] (804s left) kms_plane_lowres (tiling-4) [215.205948] Starting subtest: tiling-4 [215.206877] Starting dynamic subtest: pipe-A-eDP-1 [215.208521] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [215.497141] Starting dynamic subtest: pipe-B-eDP-1 [215.498964] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [215.505558] Starting dynamic subtest: pipe-C-eDP-1 [215.507244] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [215.513665] Starting dynamic subtest: pipe-D-eDP-1 [215.515360] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [215.517097] Subtest tiling-4: SKIP (0.291s) [216.305538] [037/132] (803s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling) [216.393267] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling [216.394091] Starting dynamic subtest: pipe-A-default-mode [216.688923] Dynamic subtest pipe-A-default-mode: SKIP (0.294s) [216.690802] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.295s) [217.535480] [038/132] (802s left) kms_big_fb (y-tiled-8bpp-rotate-270) [217.645166] Starting subtest: y-tiled-8bpp-rotate-270 [217.646880] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s) [217.774560] [039/132] (801s left) kms_addfb_basic (basic) [217.835199] Starting subtest: basic [217.836222] Subtest basic: SUCCESS (0.000s) [218.004374] [040/132] (801s left) kms_psr (psr2-sprite-mmap-gtt) [218.099744] Starting subtest: psr2-sprite-mmap-gtt [218.100969] Starting dynamic subtest: eDP-1 [219.511851] Dynamic subtest eDP-1: SKIP (1.408s) [219.513743] Subtest psr2-sprite-mmap-gtt: SKIP (1.410s) [219.683769] [041/132] (800s left) gem_exec_reloc (basic-gtt-noreloc) [219.740960] Subtest basic-gtt-noreloc: SKIP (0.000s) [219.817390] [042/132] (800s left) gem_mmap_gtt (basic-read-write) [219.874276] Subtest basic-read-write: SKIP (0.000s) [219.939893] [043/132] (799s left) gem_exec_reloc (basic-wc-read-noreloc) [220.005389] Subtest basic-wc-read-noreloc: SKIP (0.000s) [220.080949] [044/132] (799s left) gem_exec_parallel (userptr) [220.139924] Starting subtest: userptr [220.140967] Starting dynamic subtest: rcs0 [221.591758] Dynamic subtest rcs0: SUCCESS (1.451s) [221.600451] Starting dynamic subtest: bcs0 [223.068332] Dynamic subtest bcs0: SUCCESS (1.475s) [223.078597] Starting dynamic subtest: vcs0 [224.856500] Dynamic subtest vcs0: SUCCESS (1.785s) [224.865774] Starting dynamic subtest: vcs1 [226.901216] Dynamic subtest vcs1: SUCCESS (2.044s) [226.911612] Starting dynamic subtest: vecs0 [228.887076] Dynamic subtest vecs0: SUCCESS (1.981s) [228.896498] Starting dynamic subtest: ccs0 [230.385435] Dynamic subtest ccs0: SUCCESS (1.498s) [230.387756] Subtest userptr: SUCCESS (10.247s) [230.591582] [045/132] (789s left) kms_properties (plane-properties-atomic) [230.691945] Starting subtest: plane-properties-atomic [230.693918] Starting dynamic subtest: pipe-A-eDP-1 [231.243744] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.549s) [231.251327] Starting dynamic subtest: pipe-B-eDP-1 [232.526098] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.282s) [232.533283] Starting dynamic subtest: pipe-C-eDP-1 [233.839377] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.313s) [233.846609] Starting dynamic subtest: pipe-D-eDP-1 [235.075212] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s) [235.076165] Subtest plane-properties-atomic: SUCCESS (4.383s) [235.904211] [046/132] (784s left) prime_mmap (test_map_unmap) [235.969077] Starting subtest: test_map_unmap [235.970030] Starting dynamic subtest: test_map_unmap-smem [236.001979] Dynamic subtest test_map_unmap-smem: SUCCESS (0.033s) [236.003281] Subtest test_map_unmap: SUCCESS (0.033s) [236.129425] [047/132] (783s left) kms_cursor_crc (cursor-tearing-framebuffer-change) [236.234983] Starting subtest: cursor-tearing-framebuffer-change [236.235869] Starting dynamic subtest: pipe-A-eDP-1 [236.789456] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s) [236.796593] Starting dynamic subtest: pipe-D-eDP-1 [238.001904] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.211s) [238.002833] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.767s) [238.860641] [048/132] (781s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [238.951335] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [238.952213] Starting dynamic subtest: pipe-A-default-mode [240.099187] Dynamic subtest pipe-A-default-mode: SKIP (1.146s) [240.100887] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.147s) [240.246995] [049/132] (779s left) i915_query (test-query-geometry-subslices) [240.313206] Starting subtest: test-query-geometry-subslices [240.314110] Subtest test-query-geometry-subslices: SUCCESS (0.000s) [240.448021] [050/132] (779s left) syncobj_timeline (invalid-query-illegal-handle) [240.496461] Starting subtest: invalid-query-illegal-handle [240.497956] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [240.602403] [051/132] (779s left) kms_hdr (static-toggle) [240.700828] Starting subtest: static-toggle [240.703725] Subtest static-toggle: SKIP (0.000s) [240.789200] [052/132] (779s left) sw_sync (sync_multi_consumer) [240.819015] Starting subtest: sync_multi_consumer [241.206976] Subtest sync_multi_consumer: SUCCESS (0.387s) [241.286864] [053/132] (778s left) kms_psr (fbc-psr-sprite-plane-onoff) [241.368734] Starting subtest: fbc-psr-sprite-plane-onoff [241.369716] Starting dynamic subtest: eDP-1 [241.371595] Dynamic subtest eDP-1: SKIP (0.000s) [241.373363] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s) [241.464972] [054/132] (778s left) gem_userptr_blits (sd-probe) [241.536876] Starting subtest: sd-probe [241.537796] Subtest sd-probe: SUCCESS (0.000s) [241.699639] [055/132] (778s left) gem_eio (wait-immediate) [241.930083] Starting subtest: wait-immediate [242.317779] Subtest wait-immediate: SUCCESS (0.388s) [242.493941] [056/132] (777s left) kms_frontbuffer_tracking (psr-rgb565-draw-render) [242.586859] Starting subtest: psr-rgb565-draw-render [249.592308] Subtest psr-rgb565-draw-render: SUCCESS (7.006s) [249.757783] [057/132] (770s left) perf_pmu (event-wait) [249.789434] Starting subtest: event-wait [249.790403] Starting dynamic subtest: rcs0 [249.792130] Dynamic subtest rcs0: SKIP (0.000s) [249.793787] Subtest event-wait: SKIP (0.001s) [249.921308] [058/132] (770s left) gem_exec_schedule (smoketest) [250.107513] Starting subtest: smoketest [250.108807] Starting dynamic subtest: rcs0 [255.637996] Dynamic subtest rcs0: SUCCESS (5.507s) [255.646923] Starting dynamic subtest: bcs0 [261.164434] Dynamic subtest bcs0: SUCCESS (5.526s) [261.174109] Starting dynamic subtest: vcs0 [266.655786] Dynamic subtest vcs0: SUCCESS (5.493s) [266.669125] Starting dynamic subtest: vcs1 [272.161115] Dynamic subtest vcs1: SUCCESS (5.503s) [272.174100] Starting dynamic subtest: vecs0 [277.666176] Dynamic subtest vecs0: SUCCESS (5.502s) [277.675084] Starting dynamic subtest: ccs0 [283.187435] Dynamic subtest ccs0: SUCCESS (5.521s) [283.188252] Subtest smoketest: SUCCESS (33.059s) [283.377638] [059/132] (737s left) gem_userptr_blits (map-fixed-invalidate-busy) [283.448471] Starting subtest: map-fixed-invalidate-busy [283.450351] Subtest map-fixed-invalidate-busy: SKIP (0.000s) [283.613413] [060/132] (736s left) kms_busy (basic) [283.714903] Starting subtest: basic [283.715938] Starting dynamic subtest: flip [284.291468] Dynamic subtest flip: SUCCESS (0.576s) [284.302843] Starting dynamic subtest: modeset [287.748202] Dynamic subtest modeset: SUCCESS (3.455s) [287.749049] Subtest basic: SUCCESS (4.034s) [288.580417] [061/132] (731s left) kms_universal_plane (universal-plane-sanity) [288.665318] Starting subtest: universal-plane-sanity [288.666230] Starting dynamic subtest: pipe-A-eDP-1 [289.276831] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.610s) [289.286952] Starting dynamic subtest: pipe-B-eDP-1 [290.466768] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.189s) [290.475453] Starting dynamic subtest: pipe-C-eDP-1 [291.670564] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.202s) [291.678177] Starting dynamic subtest: pipe-D-eDP-1 [292.909221] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s) [292.910141] Subtest universal-plane-sanity: SUCCESS (4.244s) [293.783904] [062/132] (726s left) kms_flip (flip-vs-panning-interruptible) [293.880423] Starting subtest: flip-vs-panning-interruptible [293.882881] Starting dynamic subtest: A-eDP1 [302.575248] Dynamic subtest A-eDP1: SUCCESS (8.691s) [302.586888] Starting dynamic subtest: B-eDP1 [311.306554] Dynamic subtest B-eDP1: SUCCESS (8.729s) [311.317782] Starting dynamic subtest: C-eDP1 [320.034727] Dynamic subtest C-eDP1: SUCCESS (8.725s) [320.044583] Starting dynamic subtest: D-eDP1 [328.670078] Dynamic subtest D-eDP1: SUCCESS (8.632s) [328.672252] Subtest flip-vs-panning-interruptible: SUCCESS (34.790s) [329.851935] [063/132] (690s left) kms_addfb_basic (legacy-format) [329.912579] Starting subtest: legacy-format [329.943488] Subtest legacy-format: SUCCESS (0.029s) [330.116446] [064/132] (690s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [330.207728] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [330.209517] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [330.347799] [065/132] (690s left) gem_exec_flush (basic-uc-set-default) [330.404875] Starting subtest: basic-uc-set-default [335.861577] Subtest basic-uc-set-default: SUCCESS (5.457s) [336.072964] [066/132] (684s left) gem_ctx_exec (basic-invalid-context) [336.128301] Starting subtest: basic-invalid-context [336.139411] Subtest basic-invalid-context: SUCCESS (0.011s) [336.305953] [067/132] (684s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt) [336.405359] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt [340.870580] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.465s) [342.054391] [068/132] (678s left) gem_close (many-handles-one-vma) [342.112614] Starting subtest: many-handles-one-vma [342.136914] Subtest many-handles-one-vma: SUCCESS (0.026s) [342.279646] [069/132] (678s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [342.377396] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [342.378439] Starting dynamic subtest: pipe-A-eDP-1 [342.386599] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [342.394459] Starting dynamic subtest: pipe-B-eDP-1 [342.402501] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [342.410106] Starting dynamic subtest: pipe-C-eDP-1 [342.418237] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [342.425591] Starting dynamic subtest: pipe-D-eDP-1 [342.433803] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [342.435481] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [344.613836] [070/132] (676s left) gem_exec_suspend (basic-s0) [344.678112] Starting subtest: basic-S0 [344.678993] Starting dynamic subtest: smem [364.724027] Dynamic subtest smem: SUCCESS (9.264s) [364.725502] Subtest basic-S0: SUCCESS (9.265s) [369.937844] [071/132] (655s left) syncobj_eventfd (invalid-illegal-handle) [369.995532] Starting subtest: invalid-illegal-handle [369.996415] Subtest invalid-illegal-handle: SUCCESS (0.000s) [370.122586] [072/132] (655s left) gem_exec_reloc (basic-write-read-active) [370.186210] Subtest basic-write-read-active: SKIP (0.000s) [370.248733] [073/132] (655s left) sw_sync (sync_merge_same) [370.282820] Starting subtest: sync_merge_same [370.283690] Subtest sync_merge_same: SUCCESS (0.000s) [370.375458] [074/132] (655s left) kms_prime (basic-crc-vgem) [370.448894] Starting subtest: basic-crc-vgem [370.449739] Starting dynamic subtest: second-to-first [371.370072] Dynamic subtest second-to-first: SUCCESS (0.943s) [371.370938] Subtest basic-crc-vgem: SUCCESS (0.943s) [371.478000] [075/132] (654s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen) [371.589493] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen [378.026505] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.526s) [378.181725] [076/132] (647s left) prime_self_import (basic-llseek-size) [378.212662] Starting subtest: basic-llseek-size [378.228306] Subtest basic-llseek-size: SUCCESS (0.016s) [378.345593] [077/132] (647s left) gem_ctx_sseu (engines) [378.406391] Subtest engines: SKIP (0.000s) [378.466431] [078/132] (647s left) kms_cursor_crc (cursor-onscreen-max-size) [378.759843] Starting subtest: cursor-onscreen-max-size [378.762312] Subtest cursor-onscreen-max-size: SKIP (0.000s) [378.918310] [079/132] (647s left) syncobj_timeline (transfer-timeline-point) [378.977871] Starting subtest: transfer-timeline-point [378.978920] Subtest transfer-timeline-point: SUCCESS (0.001s) [379.114543] [080/132] (647s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted) [379.174875] Starting subtest: etime-single-wait-all-for-submit-submitted [379.279057] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.102s) [379.372858] [081/132] (646s left) gem_bad_reloc (negative-reloc) [379.424729] Subtest negative-reloc: SKIP (0.000s) [379.499127] [082/132] (646s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled) [379.545658] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [379.546643] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [379.678339] [083/132] (646s left) i915_drm_fdinfo (idle) [379.717542] Starting subtest: idle [379.718508] Starting dynamic subtest: rcs0 [380.313996] Dynamic subtest rcs0: SUCCESS (0.599s) [380.327390] Starting dynamic subtest: bcs0 [380.822021] Dynamic subtest bcs0: SUCCESS (0.506s) [380.834019] Starting dynamic subtest: vcs0 [381.327250] Dynamic subtest vcs0: SUCCESS (0.506s) [381.338423] Starting dynamic subtest: vcs1 [381.832942] Dynamic subtest vcs1: SUCCESS (0.506s) [381.844375] Starting dynamic subtest: vecs0 [382.337906] Dynamic subtest vecs0: SUCCESS (0.505s) [382.349549] Starting dynamic subtest: ccs0 [382.845265] Dynamic subtest ccs0: SUCCESS (0.505s) [382.846562] Subtest idle: SUCCESS (3.143s) [382.936189] [084/132] (643s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite) [383.040304] Starting subtest: fbc-rgb101010-draw-pwrite [388.387196] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.366s) [389.570414] [085/132] (636s left) kms_draw_crc (draw-method-render) [389.665303] Starting subtest: draw-method-render [389.666332] Starting dynamic subtest: xrgb8888-untiled [389.888887] Dynamic subtest xrgb8888-untiled: SUCCESS (0.223s) [389.897691] Starting dynamic subtest: rgb565-untiled [390.109849] Dynamic subtest rgb565-untiled: SUCCESS (0.221s) [390.119258] Starting dynamic subtest: xrgb2101010-untiled [390.320701] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s) [390.331139] Starting dynamic subtest: xbgr16161616f-untiled [390.542256] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.220s) [390.552856] Starting dynamic subtest: xrgb8888-xtiled [390.675276] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.131s) [390.684832] Starting dynamic subtest: rgb565-xtiled [390.786115] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s) [390.795216] Starting dynamic subtest: xrgb2101010-xtiled [390.897108] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s) [390.907625] Starting dynamic subtest: xbgr16161616f-xtiled [391.019065] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s) [391.033644] Starting dynamic subtest: xrgb8888-4tiled [391.140985] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s) [391.152229] Starting dynamic subtest: rgb565-4tiled [391.263712] Dynamic subtest rgb565-4tiled: SUCCESS (0.120s) [391.280363] Starting dynamic subtest: xrgb2101010-4tiled [391.373856] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.108s) [391.382337] Starting dynamic subtest: xbgr16161616f-4tiled [391.507056] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s) [391.509027] Subtest draw-method-render: SUCCESS (1.848s) [391.668734] [086/132] (634s left) gem_exec_balancer (bonded-sync) [391.728687] Starting subtest: bonded-sync [391.731143] Subtest bonded-sync: SKIP (0.000s) [392.064769] [087/132] (634s left) kms_color (ctm-negative) [392.153547] Starting subtest: ctm-negative [392.154488] Starting dynamic subtest: pipe-A-eDP-1 [392.841245] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.687s) [392.850217] Starting dynamic subtest: pipe-B-eDP-1 [394.227441] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.389s) [394.236862] Starting dynamic subtest: pipe-C-eDP-1 [395.622942] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.396s) [395.632015] Starting dynamic subtest: pipe-D-eDP-1 [396.959487] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s) [396.960351] Subtest ctm-negative: SUCCESS (4.813s) [397.776369] [088/132] (628s left) gem_ctx_engines (execute-oneforall) [397.827399] Starting subtest: execute-oneforall [398.343655] Subtest execute-oneforall: SUCCESS (0.516s) [399.821898] [089/132] (626s left) kms_psr (fbc-pr-sprite-blt) [399.907427] Starting subtest: fbc-pr-sprite-blt [399.909225] Subtest fbc-pr-sprite-blt: SKIP (0.000s) [400.003193] [090/132] (626s left) kms_lease (lease-revoke) [400.100557] Starting subtest: lease-revoke [400.101677] Starting dynamic subtest: pipe-A-eDP-1 [400.130575] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.031s) [400.139325] Starting dynamic subtest: pipe-B-eDP-1 [400.158880] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.027s) [400.172081] Starting dynamic subtest: pipe-C-eDP-1 [400.187383] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s) [400.200535] Starting dynamic subtest: pipe-D-eDP-1 [400.221632] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.033s) [400.222539] Subtest lease-revoke: SUCCESS (0.124s) [400.359515] [091/132] (626s left) kms_plane (plane-position-hole) [400.440895] Starting subtest: plane-position-hole [400.951931] Starting dynamic subtest: pipe-A-plane-1 [402.226485] Dynamic subtest pipe-A-plane-1: SUCCESS (1.274s) [402.235050] Starting dynamic subtest: pipe-A-plane-2 [403.447922] Dynamic subtest pipe-A-plane-2: SUCCESS (1.220s) [403.457239] Starting dynamic subtest: pipe-A-plane-3 [404.670199] Dynamic subtest pipe-A-plane-3: SUCCESS (1.220s) [404.680171] Starting dynamic subtest: pipe-A-plane-4 [405.900610] Dynamic subtest pipe-A-plane-4: SUCCESS (1.230s) [405.909389] Starting dynamic subtest: pipe-A-plane-5 [405.926710] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s) [407.062875] Starting dynamic subtest: pipe-B-plane-1 [408.288524] Dynamic subtest pipe-B-plane-1: SUCCESS (1.233s) [408.297399] Starting dynamic subtest: pipe-B-plane-2 [409.546367] Dynamic subtest pipe-B-plane-2: SUCCESS (1.256s) [409.558898] Starting dynamic subtest: pipe-B-plane-3 [410.857820] Dynamic subtest pipe-B-plane-3: SUCCESS (1.312s) [410.876396] Starting dynamic subtest: pipe-B-plane-4 [412.089370] Dynamic subtest pipe-B-plane-4: SUCCESS (1.230s) [412.098194] Starting dynamic subtest: pipe-B-plane-5 [412.112826] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s) [412.113740] Subtest plane-position-hole: SUCCESS (11.671s) [412.915003] [092/132] (613s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [413.023242] Starting subtest: switch-modeset-ultra-joiner-big-joiner [413.025006] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [413.111432] [093/132] (613s left) syncobj_wait (invalid-wait-illegal-handle) [413.167741] Starting subtest: invalid-wait-illegal-handle [413.168800] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [413.301229] [094/132] (613s left) kms_flip (2x-flip-vs-rmfb-interruptible) [413.399093] Starting subtest: 2x-flip-vs-rmfb-interruptible [413.410911] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.011s) [413.553456] [095/132] (613s left) kms_cursor_crc (cursor-sliding-128x42) [413.782356] Starting subtest: cursor-sliding-128x42 [413.822733] Subtest cursor-sliding-128x42: SKIP (0.038s) [414.073245] [096/132] (612s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [414.180274] Starting subtest: fbc-1p-primscrn-cur-indfb-move [418.309813] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.130s) [419.516271] [097/132] (607s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt) [419.602533] Starting subtest: psr-2p-primscrn-indfb-msflip-blt [419.604289] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [419.723127] [098/132] (607s left) i915_drm_fdinfo (virtual-busy-hang-all) [419.757018] Starting subtest: virtual-busy-hang-all [419.758779] Subtest virtual-busy-hang-all: SKIP (0.000s) [419.839888] [099/132] (606s left) kms_chamelium_hpd (common-hpd-after-suspend) [420.213357] Subtest common-hpd-after-suspend: SKIP (0.000s) [420.992260] [100/132] (605s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [421.076210] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs [421.077037] Starting dynamic subtest: pipe-A-eDP-1 [421.899357] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.820s) [421.908269] Starting dynamic subtest: pipe-B-eDP-1 [423.456114] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.556s) [423.464716] Starting dynamic subtest: pipe-C-eDP-1 [424.950196] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.493s) [424.958805] Starting dynamic subtest: pipe-D-eDP-1 [426.488836] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.538s) [426.489726] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.412s) [427.691249] [101/132] (599s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [427.784487] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [427.785326] Starting dynamic subtest: pipe-A-eDP-1 [427.803480] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s) [427.813841] Starting dynamic subtest: pipe-B-eDP-1 [427.825465] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s) [427.836787] Starting dynamic subtest: pipe-C-eDP-1 [427.846251] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s) [427.855854] Starting dynamic subtest: pipe-D-eDP-1 [427.868053] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s) [427.868865] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.086s) [430.066205] [102/132] (596s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [430.179146] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip [430.180862] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [430.316350] [103/132] (596s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [430.434079] Starting subtest: short-flip-before-cursor-atomic-transitions [431.384268] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.949s) [432.277502] [104/132] (594s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [432.386025] Starting subtest: psr-rgb565-draw-blt [439.313818] Subtest psr-rgb565-draw-blt: SUCCESS (6.931s) [439.457888] [105/132] (587s left) kms_content_protection (atomic-dpms-hdcp14) [439.600636] Starting subtest: atomic-dpms-hdcp14 [439.602690] Subtest atomic-dpms-hdcp14: SKIP (0.000s) [439.755774] [106/132] (587s left) kms_pm_backlight (bad-brightness) [439.854283] Starting subtest: bad-brightness [439.905938] Starting dynamic subtest: eDP-1 [440.221150] Dynamic subtest eDP-1: SUCCESS (0.315s) [440.222136] Subtest bad-brightness: SUCCESS (0.368s) [441.128023] [107/132] (585s left) kms_hdmi_inject (inject-audio) [441.462167] Starting subtest: inject-audio [441.733305] Subtest inject-audio: SUCCESS (0.271s) [442.389375] [108/132] (584s left) kms_psr (fbc-psr-basic) [442.491464] Starting subtest: fbc-psr-basic [442.492414] Starting dynamic subtest: eDP-1 [442.494243] Dynamic subtest eDP-1: SKIP (0.000s) [442.495893] Subtest fbc-psr-basic: SKIP (0.001s) [442.589529] [109/132] (584s left) kms_flip (wf_vblank-ts-check) [442.684351] Starting subtest: wf_vblank-ts-check [442.685301] Starting dynamic subtest: A-eDP1 [451.647705] Dynamic subtest A-eDP1: SUCCESS (8.966s) [451.658391] Starting dynamic subtest: B-eDP1 [460.539480] Dynamic subtest B-eDP1: SUCCESS (8.893s) [460.551302] Starting dynamic subtest: C-eDP1 [469.436367] Dynamic subtest C-eDP1: SUCCESS (8.892s) [469.447227] Starting dynamic subtest: D-eDP1 [478.324093] Dynamic subtest D-eDP1: SUCCESS (8.883s) [478.326872] Subtest wf_vblank-ts-check: SUCCESS (35.645s) [479.547966] [110/132] (547s left) syncobj_timeline (multi-wait-all-available-signaled) [479.613874] Starting subtest: multi-wait-all-available-signaled [479.615018] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s) [479.737263] [111/132] (547s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [479.836007] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [480.472584] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.637s) [480.655552] [112/132] (546s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt) [480.758551] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt [487.446765] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.687s) [487.589610] [113/132] (539s left) kms_psr2_su (page_flip-p010) [487.647895] Subtest page_flip-P010: SKIP (0.000s) [487.714932] [114/132] (539s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [487.823255] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [487.824982] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [487.937407] [115/132] (539s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [488.038525] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [489.028512] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.990s) [489.191927] [116/132] (538s left) api_intel_allocator (standalone) [489.249743] Starting subtest: standalone [489.266630] Subtest standalone: SUCCESS (0.018s) [489.416918] [117/132] (538s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [489.512414] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [489.514312] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [489.649451] [118/132] (537s left) kms_dirtyfb (drrs-dirtyfb-ioctl) [489.740062] Starting subtest: drrs-dirtyfb-ioctl [489.745177] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s) [489.852529] [119/132] (537s left) gem_exec_reloc (basic-cpu-wc-noreloc) [489.908970] Subtest basic-cpu-wc-noreloc: SKIP (0.000s) [489.995766] [120/132] (537s left) kms_cursor_legacy (cursor-vs-flip-toggle) [490.108237] Starting subtest: cursor-vs-flip-toggle [520.844751] Subtest cursor-vs-flip-toggle: SUCCESS (30.736s) [521.744935] [121/132] (505s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [521.858543] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [522.814712] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.957s) [522.989734] [122/132] (504s left) gem_mmap_gtt (medium-copy-odd) [523.062227] Subtest medium-copy-odd: SKIP (0.000s) [523.125550] [123/132] (504s left) core_getstats (basic) [523.185063] Starting subtest: basic [523.186176] Subtest basic: SUCCESS (0.000s) [523.319904] [124/132] (504s left) gem_ringfill (basic-all) [528.693641] Starting subtest: basic-all [529.863389] Subtest basic-all: SUCCESS (1.168s) [530.027348] [125/132] (497s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled) [530.088314] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [530.089282] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [530.219547] [126/132] (497s left) kms_pm_rpm (modeset-non-lpsp) [531.835664] Starting subtest: modeset-non-lpsp [532.985496] Subtest modeset-non-lpsp: SKIP (1.151s) [533.367776] [127/132] (494s left) gem_exec_schedule (preempt-engines) [533.439630] Starting subtest: preempt-engines [533.440784] Starting dynamic subtest: rcs0 [535.750252] Dynamic subtest rcs0: SUCCESS (2.308s) [535.761753] Starting dynamic subtest: bcs0 [538.052899] Dynamic subtest bcs0: SUCCESS (2.301s) [538.068606] Starting dynamic subtest: vcs0 [540.369866] Dynamic subtest vcs0: SUCCESS (2.316s) [540.381626] Starting dynamic subtest: vcs1 [542.636934] Dynamic subtest vcs1: SUCCESS (2.267s) [542.650176] Starting dynamic subtest: vecs0 [545.013623] Dynamic subtest vecs0: SUCCESS (2.373s) [545.022810] Starting dynamic subtest: ccs0 [547.348844] Dynamic subtest ccs0: SUCCESS (2.333s) [547.350239] Subtest preempt-engines: SUCCESS (13.911s) [547.672322] [128/132] (480s left) syncobj_timeline (multi-wait-submitted-signaled) [547.728337] Starting subtest: multi-wait-submitted-signaled [547.729408] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [547.865272] [129/132] (479s left) gem_lmem_swapping (verify-random) [547.901322] Subtest verify-random: SKIP (0.000s) [547.940103] [130/132] (479s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [548.025718] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [548.027437] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [548.158874] [131/132] (479s left) gem_softpin (allocator-nopin-reserve) [548.226625] Starting subtest: allocator-nopin-reserve [548.317244] Subtest allocator-nopin-reserve: SUCCESS (0.090s) [548.469866] [132/132] (479s left) kms_frontbuffer_tracking (fbc-modesetfrombusy) [548.561786] Starting subtest: fbc-modesetfrombusy [552.376409] Subtest fbc-modesetfrombusy: SUCCESS (3.817s) [553.537830] Closing watchdogs results: parsing output: 0/ for test: api_intel_bb results: parsing output: 1/ for test: gem_gpgpu_fill results: parsing output: 2/ for test: gem_pread results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_chamelium_audio results: parsing output: 5/ for test: kms_vblank results: parsing output: 6/ for test: kms_plane_scaling results: parsing output: 7/ for test: gem_mmap_gtt results: parsing output: 8/ for test: kms_flip results: parsing output: 9/ for test: kms_big_fb results: parsing output: 10/ for test: kms_psr results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: gen9_exec_parse results: parsing output: 13/ for test: kms_ccs results: parsing output: 14/ for test: i915_pm_rpm results: parsing output: 15/ for test: syncobj_wait results: parsing output: 16/ for test: kms_scaling_modes results: parsing output: 17/ for test: gem_flink_basic results: parsing output: 18/ for test: gem_mmap_gtt results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: gem_exec_fence results: parsing output: 21/ for test: gem_tiled_blits results: parsing output: 22/ for test: kms_psr2_sf results: parsing output: 23/ for test: kms_color results: parsing output: 24/ for test: gem_exec_params results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: gem_exec_flush results: parsing output: 27/ for test: perf results: parsing output: 28/ for test: kms_atomic results: parsing output: 29/ for test: perf_pmu results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: sysfs_preempt_timeout results: parsing output: 32/ for test: gem_ctx_persistence results: parsing output: 33/ for test: gem_render_copy results: parsing output: 34/ for test: gem_exec_capture results: parsing output: 35/ for test: kms_plane_lowres results: parsing output: 36/ for test: kms_flip_scaled_crc results: parsing output: 37/ for test: kms_big_fb results: parsing output: 38/ for test: kms_addfb_basic results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: gem_exec_reloc results: parsing output: 41/ for test: gem_mmap_gtt results: parsing output: 42/ for test: gem_exec_reloc results: parsing output: 43/ for test: gem_exec_parallel results: parsing output: 44/ for test: kms_properties results: parsing output: 45/ for test: prime_mmap results: parsing output: 46/ for test: kms_cursor_crc results: parsing output: 47/ for test: kms_flip_scaled_crc results: parsing output: 48/ for test: i915_query results: parsing output: 49/ for test: syncobj_timeline results: parsing output: 50/ for test: kms_hdr results: parsing output: 51/ for test: sw_sync results: parsing output: 52/ for test: kms_psr results: parsing output: 53/ for test: gem_userptr_blits results: parsing output: 54/ for test: gem_eio results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: perf_pmu results: parsing output: 57/ for test: gem_exec_schedule results: parsing output: 58/ for test: gem_userptr_blits results: parsing output: 59/ for test: kms_busy results: parsing output: 60/ for test: kms_universal_plane results: parsing output: 61/ for test: kms_flip results: parsing output: 62/ for test: kms_addfb_basic results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: gem_exec_flush results: parsing output: 65/ for test: gem_ctx_exec results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: gem_close results: parsing output: 68/ for test: kms_ccs results: parsing output: 69/ for test: gem_exec_suspend results: parsing output: 70/ for test: syncobj_eventfd results: parsing output: 71/ for test: gem_exec_reloc results: parsing output: 72/ for test: sw_sync results: parsing output: 73/ for test: kms_prime results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: prime_self_import results: parsing output: 76/ for test: gem_ctx_sseu results: parsing output: 77/ for test: kms_cursor_crc results: parsing output: 78/ for test: syncobj_timeline results: parsing output: 79/ for test: syncobj_timeline results: parsing output: 80/ for test: gem_bad_reloc results: parsing output: 81/ for test: syncobj_wait results: parsing output: 82/ for test: i915_drm_fdinfo results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_draw_crc results: parsing output: 85/ for test: gem_exec_balancer results: parsing output: 86/ for test: kms_color results: parsing output: 87/ for test: gem_ctx_engines results: parsing output: 88/ for test: kms_psr results: parsing output: 89/ for test: kms_lease results: parsing output: 90/ for test: kms_plane results: parsing output: 91/ for test: kms_joiner results: parsing output: 92/ for test: syncobj_wait results: parsing output: 93/ for test: kms_flip results: parsing output: 94/ for test: kms_cursor_crc results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: i915_drm_fdinfo results: parsing output: 98/ for test: kms_chamelium_hpd results: parsing output: 99/ for test: kms_ccs results: parsing output: 100/ for test: kms_ccs results: parsing output: 101/ for test: kms_big_fb results: parsing output: 102/ for test: kms_cursor_legacy results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_content_protection results: parsing output: 105/ for test: kms_pm_backlight results: parsing output: 106/ for test: kms_hdmi_inject results: parsing output: 107/ for test: kms_psr results: parsing output: 108/ for test: kms_flip results: parsing output: 109/ for test: syncobj_timeline results: parsing output: 110/ for test: kms_big_fb results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_psr2_su results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_big_fb results: parsing output: 115/ for test: api_intel_allocator results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_dirtyfb results: parsing output: 118/ for test: gem_exec_reloc results: parsing output: 119/ for test: kms_cursor_legacy results: parsing output: 120/ for test: kms_big_fb results: parsing output: 121/ for test: gem_mmap_gtt results: parsing output: 122/ for test: core_getstats results: parsing output: 123/ for test: gem_ringfill results: parsing output: 124/ for test: syncobj_wait results: parsing output: 125/ for test: kms_pm_rpm results: parsing output: 126/ for test: gem_exec_schedule results: parsing output: 127/ for test: syncobj_timeline results: parsing output: 128/ for test: gem_lmem_swapping results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: gem_softpin results: parsing output: 131/ for test: kms_frontbuffer_tracking Done.