[57.446315] Initializing watchdogs
[57.446399]   /dev/watchdog0
[57.466428] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[57.477482] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[57.481774] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.484286] [001/134] (960s left) kms_colorop (plane-xr24-xr24-srgb_eotf-srgb_inv_eotf-srgb_eotf)
[57.787811] Subtest plane-XR24-XR24-srgb_eotf-srgb_inv_eotf-srgb_eotf: SKIP (0.000s)
[57.913645] [002/134] (960s left) kms_chamelium_color (degamma)
[58.098727] Subtest degamma: SKIP (0.000s)
[58.160778] [003/134] (959s left) i915_pm_rps (engine-order)
[58.247890] Starting subtest: engine-order
[68.789216] Subtest engine-order: SUCCESS (10.557s)
[69.008562] [004/134] (949s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[69.084943] Starting subtest: multi-wait-all-for-submit-signaled
[69.085915] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[69.259028] [005/134] (948s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[69.451899] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[69.453686] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[69.642541] [006/134] (948s left) kms_cursor_crc (cursor-sliding-32x10)
[69.947461] Starting subtest: cursor-sliding-32x10
[70.001096] Subtest cursor-sliding-32x10: SKIP (0.052s)
[70.431084] [007/134] (947s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[70.617868] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[70.619488] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[70.809134] [008/134] (947s left) kms_flip (flip-vs-expired-vblank-interruptible)
[70.993378] Starting subtest: flip-vs-expired-vblank-interruptible
[70.998070] Starting dynamic subtest: A-DP3
[78.848551] Dynamic subtest A-DP3: SUCCESS (7.853s)
[78.859386] Starting dynamic subtest: B-DP3
[86.598500] Dynamic subtest B-DP3: SUCCESS (7.749s)
[86.609386] Starting dynamic subtest: C-DP3
[94.342927] Dynamic subtest C-DP3: SUCCESS (7.743s)
[94.370668] Starting dynamic subtest: D-DP3
[102.100837] Dynamic subtest D-DP3: SUCCESS (7.756s)
[102.107927] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (31.116s)
[102.403177] [009/134] (916s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[102.601675] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[102.603433] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[102.779270] [010/134] (915s left) gem_ctx_create (basic-files)
[102.861362] Starting subtest: basic-files
[104.873328] Subtest basic-files: SUCCESS (2.012s)
[105.570439] [011/134] (913s left) gem_mmap_gtt (ptrace)
[105.644177] Subtest ptrace: SKIP (0.000s)
[105.709865] [012/134] (912s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[105.896977] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[105.898837] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[106.093596] [013/134] (912s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[106.285156] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[107.617652] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.332s)
[107.896318] [014/134] (910s left) gem_readwrite (write-bad-handle)
[107.966960] Subtest write-bad-handle: SKIP (0.000s)
[108.039859] [015/134] (910s left) sw_sync (sync_expired_merge)
[108.083910] Starting subtest: sync_expired_merge
[109.157681] Subtest sync_expired_merge: SUCCESS (1.074s)
[109.245220] [016/134] (909s left) api_intel_bb (simple-bb-ctx)
[109.315967] Starting subtest: simple-bb-ctx
[109.348738] Subtest simple-bb-ctx: SUCCESS (0.034s)
[109.560554] [017/134] (909s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[109.746627] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[112.035617] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (2.289s)
[112.227706] [018/134] (906s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[112.409428] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[112.410279] Starting dynamic subtest: pipe-A
[112.499183] Dynamic subtest pipe-A: SUCCESS (0.090s)
[112.509231] Starting dynamic subtest: pipe-B
[112.695945] Dynamic subtest pipe-B: SUCCESS (0.196s)
[112.711162] Starting dynamic subtest: pipe-C
[112.927374] Dynamic subtest pipe-C: SUCCESS (0.231s)
[112.937555] Starting dynamic subtest: pipe-D
[113.123858] Dynamic subtest pipe-D: SUCCESS (0.196s)
[113.124728] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (0.715s)
[113.450474] [019/134] (905s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[113.640014] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[113.641848] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[113.815544] [020/134] (905s left) kms_pm_backlight (basic-brightness)
[113.995401] Subtest basic-brightness: SKIP (0.000s)
[114.059995] [021/134] (905s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[114.254445] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[114.256177] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[114.468808] [022/134] (904s left) gem_exec_parallel (fds)
[114.550192] Starting subtest: fds
[114.551154] Starting dynamic subtest: rcs0
[118.840831] Dynamic subtest rcs0: SUCCESS (4.290s)
[118.850507] Starting dynamic subtest: bcs0
[123.824266] Dynamic subtest bcs0: SUCCESS (4.983s)
[123.833885] Starting dynamic subtest: vcs0
[126.975171] Dynamic subtest vcs0: SUCCESS (3.151s)
[126.985108] Starting dynamic subtest: vcs1
[131.871669] Dynamic subtest vcs1: SUCCESS (4.896s)
[131.881420] Starting dynamic subtest: vecs0
[134.999862] Dynamic subtest vecs0: SUCCESS (3.128s)
[135.010163] Starting dynamic subtest: vecs1
[139.362924] Dynamic subtest vecs1: SUCCESS (4.363s)
[139.372214] Starting dynamic subtest: ccs0
[143.957756] Dynamic subtest ccs0: SUCCESS (4.594s)
[143.958860] Subtest fds: SUCCESS (29.407s)
[144.286319] [023/134] (875s left) kms_psr2_su (page_flip-nv12)
[144.360059] Subtest page_flip-NV12: SKIP (0.000s)
[144.475572] [024/134] (875s left) kms_flip (wf_vblank-ts-check)
[144.655880] Starting subtest: wf_vblank-ts-check
[144.660210] Starting dynamic subtest: A-DP3
[152.783010] Dynamic subtest A-DP3: SUCCESS (8.122s)
[152.793954] Starting dynamic subtest: B-DP3
[160.838191] Dynamic subtest B-DP3: SUCCESS (8.054s)
[160.848206] Starting dynamic subtest: C-DP3
[168.895228] Dynamic subtest C-DP3: SUCCESS (8.056s)
[168.905403] Starting dynamic subtest: D-DP3
[176.945859] Dynamic subtest D-DP3: SUCCESS (8.050s)
[176.947860] Subtest wf_vblank-ts-check: SUCCESS (32.291s)
[177.274893] [025/134] (842s left) kms_flip (dpms-vs-vblank-race)
[177.453398] Starting subtest: dpms-vs-vblank-race
[177.457579] Starting dynamic subtest: A-DP3
[180.767096] Dynamic subtest A-DP3: SUCCESS (3.309s)
[180.784244] Starting dynamic subtest: B-DP3
[183.831764] Dynamic subtest B-DP3: SUCCESS (3.063s)
[183.841203] Starting dynamic subtest: C-DP3
[186.863496] Dynamic subtest C-DP3: SUCCESS (3.031s)
[186.874424] Starting dynamic subtest: D-DP3
[189.912395] Dynamic subtest D-DP3: SUCCESS (3.047s)
[189.915355] Subtest dpms-vs-vblank-race: SUCCESS (12.462s)
[190.273125] [026/134] (829s left) perf_pmu (interrupts-sync)
[190.345279] Starting subtest: interrupts-sync
[191.568903] Subtest interrupts-sync: SUCCESS (1.222s)
[191.754595] [FACT perf_pmu (interrupts-sync)] new: kernel.kmod_is_loaded.vgem: true
[191.756849] [027/134] (828s left) vgem_basic (dmabuf-fence-before)
[191.811229] Starting subtest: dmabuf-fence-before
[191.812170] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[191.913321] [028/134] (827s left) i915_pm_freq_api (freq-reset-multiple)
[192.010440] Starting subtest: freq-reset-multiple
[192.011360] Starting dynamic subtest: gt0
[212.611474] Dynamic subtest gt0: SUCCESS (20.599s)
[212.612512] Subtest freq-reset-multiple: SUCCESS (20.600s)
[212.733371] [029/134] (807s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[212.927288] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[212.929121] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[213.131221] [030/134] (806s left) gem_flink_basic (bad-flink)
[213.214404] Starting subtest: bad-flink
[213.215329] Subtest bad-flink: SUCCESS (0.000s)
[213.414332] [031/134] (806s left) kms_prime (d3hot)
[213.604467] Subtest D3hot: SKIP (0.000s)
[213.797706] [032/134] (806s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[213.991565] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[213.993251] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[214.197230] [033/134] (806s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[214.278526] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[214.385984] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[214.537149] [034/134] (805s left) dumb_buffer (create-clear)
[214.617597] Starting subtest: create-clear
[250.883830] Subtest create-clear: SUCCESS (36.265s)
[251.380443] [035/134] (769s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[251.578191] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[251.579922] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[251.758042] [036/134] (768s left) kms_async_flips (invalid-async-flip)
[251.949717] Starting subtest: invalid-async-flip
[252.179060] Starting dynamic subtest: pipe-A-DP-3
[252.602201] Dynamic subtest pipe-A-DP-3: SUCCESS (0.423s)
[252.805246] Starting dynamic subtest: pipe-B-DP-3
[252.954385] Dynamic subtest pipe-B-DP-3: SUCCESS (0.159s)
[253.154209] Starting dynamic subtest: pipe-C-DP-3
[253.296852] Dynamic subtest pipe-C-DP-3: SUCCESS (0.151s)
[253.490970] Starting dynamic subtest: pipe-D-DP-3
[253.640400] Dynamic subtest pipe-D-DP-3: SUCCESS (0.159s)
[253.641510] Subtest invalid-async-flip: SUCCESS (1.692s)
[254.161049] [037/134] (766s left) gem_exec_suspend (basic)
[254.254929] Starting subtest: basic
[254.255915] Starting dynamic subtest: smem
[255.466509] Dynamic subtest smem: SUCCESS (1.211s)
[255.478097] Starting dynamic subtest: lmem0
[256.578300] Dynamic subtest lmem0: SUCCESS (1.111s)
[256.579221] Subtest basic: SUCCESS (2.324s)
[256.875789] [038/134] (763s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[257.073198] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[257.074970] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[257.266727] [039/134] (763s left) kms_getfb (getfb-handle-protection)
[257.472645] Starting subtest: getfb-handle-protection
[257.486295] Subtest getfb-handle-protection: SUCCESS (0.014s)
[257.698124] [040/134] (763s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[257.784978] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[257.787250] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[258.078693] [041/134] (762s left) i915_drm_fdinfo (memory-info-active)
[258.151240] Starting subtest: memory-info-active
[258.152213] Starting dynamic subtest: lmem0
[262.067055] Dynamic subtest lmem0: SUCCESS (3.914s)
[262.096179] Starting dynamic subtest: smem0
[265.585243] Dynamic subtest smem0: SUCCESS (3.506s)
[265.586190] Subtest memory-info-active: SUCCESS (7.427s)
[265.708669] [042/134] (755s left) prime_busy (before-wait)
[265.802469] Starting subtest: before-wait
[265.807782] Starting dynamic subtest: rcs0
[265.866757] Dynamic subtest rcs0: SUCCESS (0.059s)
[265.878874] Starting dynamic subtest: bcs0
[265.925017] Dynamic subtest bcs0: SUCCESS (0.057s)
[265.945069] Starting dynamic subtest: vcs0
[265.966071] Dynamic subtest vcs0: SUCCESS (0.039s)
[265.986694] Starting dynamic subtest: vcs1
[266.008036] Dynamic subtest vcs1: SUCCESS (0.040s)
[266.028601] Starting dynamic subtest: vecs0
[266.050920] Dynamic subtest vecs0: SUCCESS (0.041s)
[266.071750] Starting dynamic subtest: vecs1
[266.090943] Dynamic subtest vecs1: SUCCESS (0.038s)
[266.108807] Starting dynamic subtest: ccs0
[266.131485] Dynamic subtest ccs0: SUCCESS (0.039s)
[266.255542] Subtest before-wait: SUCCESS (0.445s)
[266.496225] [043/134] (754s left) syncobj_timeline (reset-multiple-signaled)
[266.586513] Starting subtest: reset-multiple-signaled
[266.587636] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[266.744431] [044/134] (754s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[266.946022] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[267.728061] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.782s)
[267.999009] [045/134] (753s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[268.197080] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[268.198864] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[268.398573] [046/134] (752s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[268.592597] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[268.593484] Starting dynamic subtest: pipe-A
[269.144936] Dynamic subtest pipe-A: SUCCESS (0.551s)
[269.170617] Starting dynamic subtest: pipe-B
[269.791427] Dynamic subtest pipe-B: SUCCESS (0.644s)
[269.814515] Starting dynamic subtest: pipe-C
[270.437406] Dynamic subtest pipe-C: SUCCESS (0.644s)
[270.459423] Starting dynamic subtest: pipe-D
[271.083567] Dynamic subtest pipe-D: SUCCESS (0.644s)
[271.084595] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (2.492s)
[271.445164] [047/134] (749s left) gem_exec_basic (basic)
[271.539409] Starting subtest: basic
[271.540403] Starting dynamic subtest: rcs0-smem
[271.543257] Dynamic subtest rcs0-smem: SUCCESS (0.005s)
[271.555404] Starting dynamic subtest: bcs0-smem
[271.556288] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[271.566670] Starting dynamic subtest: vcs0-smem
[271.567890] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[271.578223] Starting dynamic subtest: vcs1-smem
[271.579453] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[271.589482] Starting dynamic subtest: vecs0-smem
[271.590606] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[271.600459] Starting dynamic subtest: vecs1-smem
[271.601522] Dynamic subtest vecs1-smem: SUCCESS (0.001s)
[271.611333] Starting dynamic subtest: ccs0-smem
[271.612489] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[271.622427] Starting dynamic subtest: rcs0-lmem0
[271.623611] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[271.633549] Starting dynamic subtest: bcs0-lmem0
[271.634765] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[271.644629] Starting dynamic subtest: vcs0-lmem0
[271.645839] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[271.655638] Starting dynamic subtest: vcs1-lmem0
[271.656727] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[271.666348] Starting dynamic subtest: vecs0-lmem0
[271.667277] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[271.677661] Starting dynamic subtest: vecs1-lmem0
[271.678529] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[271.688812] Starting dynamic subtest: ccs0-lmem0
[271.690058] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[271.691176] Subtest basic: SUCCESS (0.025s)
[271.801243] [048/134] (749s left) gem_eio (wait-immediate)
[272.127202] Starting subtest: wait-immediate
[272.776888] Subtest wait-immediate: SUCCESS (0.650s)
[273.016566] [049/134] (748s left) gem_exec_schedule (reorder-wide)
[273.226187] Subtest reorder-wide: SKIP (0.000s)
[273.453389] [050/134] (748s left) gem_userptr_blits (readonly-pwrite-unsync)
[273.543167] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[273.707519] [051/134] (747s left) kms_psr (fbc-psr2-basic)
[273.896597] Subtest fbc-psr2-basic: SKIP (0.000s)
[273.960556] [052/134] (747s left) i915_query (query-topology-coherent-slice-mask)
[274.039540] Starting subtest: query-topology-coherent-slice-mask
[274.041432] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[274.187602] [053/134] (747s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[274.378400] Starting subtest: basic-busy-flip-before-cursor-varying-size
[274.380258] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[274.530499] [054/134] (747s left) kms_frontbuffer_tracking (psr-slowdraw)
[274.727281] Starting subtest: psr-slowdraw
[274.728976] Subtest psr-slowdraw: SKIP (0.000s)
[274.881618] [055/134] (746s left) gem_exec_fence (syncobj-repeat)
[275.467369] Starting subtest: syncobj-repeat
[275.786266] Subtest syncobj-repeat: SUCCESS (0.319s)
[276.194901] [056/134] (745s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[276.388050] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[276.389844] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[276.584131] [057/134] (745s left) gem_vm_create (create-ext)
[276.669600] Starting subtest: create-ext
[276.673959] Subtest create-ext: SUCCESS (0.004s)
[276.834907] [058/134] (745s left) gem_lmem_swapping (verify-random-ccs)
[279.680919] Starting subtest: verify-random-ccs
[279.682046] Starting dynamic subtest: lmem0
[286.938215] Dynamic subtest lmem0: SUCCESS (7.257s)
[286.939212] Subtest verify-random-ccs: SUCCESS (7.258s)
[288.076323] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[288.077367] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[288.079424] [059/134] (734s left) kms_properties (connector-properties-atomic)
[289.800333] Starting subtest: connector-properties-atomic
[289.801241] Starting dynamic subtest: pipe-A-DP-3
[291.339213] Dynamic subtest pipe-A-DP-3: SUCCESS (1.538s)
[291.353392] Starting dynamic subtest: pipe-None-DP-1
[291.355339] Dynamic subtest pipe-None-DP-1: SUCCESS (0.002s)
[291.366481] Starting dynamic subtest: pipe-None-DP-2
[291.368354] Dynamic subtest pipe-None-DP-2: SUCCESS (0.002s)
[291.377897] Starting dynamic subtest: pipe-None-HDMI-A-1
[291.379689] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.002s)
[291.389793] Starting dynamic subtest: pipe-None-HDMI-A-2
[291.391546] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.002s)
[291.401861] Starting dynamic subtest: pipe-None-DP-4
[291.403584] Dynamic subtest pipe-None-DP-4: SUCCESS (0.002s)
[291.412920] Starting dynamic subtest: pipe-None-HDMI-A-3
[291.414589] Dynamic subtest pipe-None-HDMI-A-3: SUCCESS (0.002s)
[291.415494] Subtest connector-properties-atomic: SUCCESS (1.562s)
[291.659319] [FACT kms_properties (connector-properties-atomic)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[291.661721] [FACT kms_properties (connector-properties-atomic)] new: kernel.kmod_is_loaded.i915: true
[291.664775] [060/134] (730s left) kms_cursor_crc (cursor-onscreen-64x64)
[292.008611] Starting subtest: cursor-onscreen-64x64
[292.014081] Starting dynamic subtest: pipe-A-DP-3
[294.712443] Dynamic subtest pipe-A-DP-3: SUCCESS (2.698s)
[294.763476] Starting dynamic subtest: pipe-D-DP-3
[297.348285] Dynamic subtest pipe-D-DP-3: SUCCESS (2.592s)
[297.349373] Subtest cursor-onscreen-64x64: SUCCESS (5.339s)
[297.899803] [061/134] (724s left) kms_universal_plane (universal-plane-functional)
[298.093371] Starting subtest: universal-plane-functional
[298.094293] Starting dynamic subtest: pipe-A-DP-3
[300.472294] Dynamic subtest pipe-A-DP-3: SUCCESS (2.377s)
[300.482523] Starting dynamic subtest: pipe-B-DP-3
[302.650170] Dynamic subtest pipe-B-DP-3: SUCCESS (2.175s)
[302.660263] Starting dynamic subtest: pipe-C-DP-3
[304.863167] Dynamic subtest pipe-C-DP-3: SUCCESS (2.211s)
[304.873208] Starting dynamic subtest: pipe-D-DP-3
[307.045344] Dynamic subtest pipe-D-DP-3: SUCCESS (2.181s)
[307.046279] Subtest universal-plane-functional: SUCCESS (8.953s)
[307.366888] [062/134] (715s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[307.576921] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[307.578689] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[307.783907] [063/134] (714s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[307.971973] Starting subtest: compare-crc-sanitycheck-nv12
[307.974411] Starting dynamic subtest: pipe-A-DP-3
[308.720255] Dynamic subtest pipe-A-DP-3: SUCCESS (0.746s)
[308.731825] Starting dynamic subtest: pipe-B-DP-3
[309.368318] Dynamic subtest pipe-B-DP-3: SUCCESS (0.646s)
[309.379917] Starting dynamic subtest: pipe-C-DP-3
[309.987180] Dynamic subtest pipe-C-DP-3: SUCCESS (0.617s)
[309.998626] Starting dynamic subtest: pipe-D-DP-3
[310.597386] Dynamic subtest pipe-D-DP-3: SUCCESS (0.608s)
[310.598303] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.625s)
[310.922180] [064/134] (711s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[311.118343] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[311.120130] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[311.317697] [065/134] (711s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[311.511608] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[311.514024] Starting dynamic subtest: pipe-A-DP-3
[311.522422] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[311.532194] Starting dynamic subtest: pipe-B-DP-3
[311.540716] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[311.550306] Starting dynamic subtest: pipe-C-DP-3
[311.558803] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[311.568286] Starting dynamic subtest: pipe-D-DP-3
[311.577638] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[311.579660] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[312.016790] [066/134] (710s left) gem_ctx_persistence (many-contexts)
[312.112203] Starting subtest: many-contexts
[349.874189] Subtest many-contexts: SUCCESS (37.760s)
[350.067040] [067/134] (672s left) kms_chamelium_frames (dp-frame-dump)
[350.341877] Subtest dp-frame-dump: SKIP (0.000s)
[350.497557] [068/134] (672s left) kms_psr (pr-cursor-render)
[350.689267] Subtest pr-cursor-render: SKIP (0.000s)
[350.749964] [069/134] (672s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[350.953519] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[352.238743] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.284s)
[352.486530] [070/134] (670s left) kms_colorop (plane-xr30-xr30-gamma_2_2_inv_oetf)
[352.787932] Subtest plane-XR30-XR30-gamma_2_2_inv_oetf: SKIP (0.000s)
[352.942384] [071/134] (670s left) kms_big_fb (linear-8bpp-rotate-180)
[353.143926] Starting subtest: linear-8bpp-rotate-180
[354.822363] Subtest linear-8bpp-rotate-180: SUCCESS (1.677s)
[355.060749] [072/134] (668s left) kms_colorop (plane-xr24-xr24-ctm_3x4_50_desat)
[355.358591] Subtest plane-XR24-XR24-ctm_3x4_50_desat: SKIP (0.000s)
[355.524126] [073/134] (667s left) gem_tiled_fence_blits (basic)
[355.613451] Subtest basic: SKIP (0.000s)
[355.683081] [074/134] (667s left) kms_dp_link_training (uhbr-sst)
[355.871947] Starting subtest: uhbr-sst
[355.873819] Subtest uhbr-sst: SKIP (0.000s)
[356.010379] [075/134] (667s left) syncobj_wait (single-wait-for-submit-submitted)
[356.102587] Starting subtest: single-wait-for-submit-submitted
[356.208804] Subtest single-wait-for-submit-submitted: SUCCESS (0.105s)
[356.386230] [076/134] (667s left) kms_plane_multiple (2x-tiling-4)
[356.579429] Starting subtest: 2x-tiling-4
[356.581249] Subtest 2x-tiling-4: SKIP (0.000s)
[356.736333] [077/134] (666s left) kms_psr (psr2-no-drrs)
[356.930233] Subtest psr2-no-drrs: SKIP (0.000s)
[356.999421] [078/134] (666s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[357.192489] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[357.194209] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[357.389607] [079/134] (666s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[357.585432] Starting subtest: plane-all-modeset-transition-fencing
[357.586338] Starting dynamic subtest: pipe-A-DP-3
[384.531416] Dynamic subtest pipe-A-DP-3: SUCCESS (26.944s)
[384.621555] Starting dynamic subtest: pipe-B-DP-3
[407.989421] Dynamic subtest pipe-B-DP-3: SUCCESS (23.380s)
[408.042197] Subtest plane-all-modeset-transition-fencing: SUCCESS (50.456s)
[408.334888] [080/134] (615s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[408.529343] Starting subtest: fbc-2p-pri-indfb-multidraw
[408.531133] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[408.735754] [081/134] (615s left) gem_softpin (evict-prime)
[408.823367] Starting subtest: evict-prime
[408.824307] Starting dynamic subtest: rcs0
[410.034397] Dynamic subtest rcs0: SUCCESS (1.210s)
[410.050630] Starting dynamic subtest: bcs0
[411.207573] Dynamic subtest bcs0: SUCCESS (1.172s)
[411.221432] Starting dynamic subtest: vcs0
[412.368596] Dynamic subtest vcs0: SUCCESS (1.160s)
[412.381504] Starting dynamic subtest: vcs1
[413.543270] Dynamic subtest vcs1: SUCCESS (1.173s)
[413.556454] Starting dynamic subtest: vecs0
[414.690352] Dynamic subtest vecs0: SUCCESS (1.146s)
[414.702905] Starting dynamic subtest: vecs1
[415.835388] Dynamic subtest vecs1: SUCCESS (1.144s)
[415.848224] Starting dynamic subtest: ccs0
[417.010502] Dynamic subtest ccs0: SUCCESS (1.174s)
[417.022334] Starting dynamic subtest: all
[418.147295] Dynamic subtest all: SUCCESS (1.136s)
[418.148303] Subtest evict-prime: SUCCESS (9.324s)
[418.319817] [082/134] (605s left) kms_content_protection (dp-mst-suspend-resume)
[418.579442] Starting subtest: dp-mst-suspend-resume
[418.581222] Subtest dp-mst-suspend-resume: SKIP (0.000s)
[418.781071] [083/134] (605s left) fbdev (eof)
[418.847768] Starting subtest: eof
[418.848630] Subtest eof: SUCCESS (0.000s)
[419.004096] [084/134] (605s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[419.090090] Starting subtest: yf-tiled-ccs-to-yf-tiled
[419.092650] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[419.378625] [085/134] (604s left) i915_selftest (perf)
[420.482470] Starting subtest: perf
[420.483458] Starting dynamic subtest: engine_cs
[422.199160] Dynamic subtest engine_cs: SUCCESS (1.716s)
[422.208279] Starting dynamic subtest: request
[427.055443] Dynamic subtest request: SUCCESS (4.854s)
[427.067144] Starting dynamic subtest: migrate
[428.978983] Dynamic subtest migrate: SUCCESS (1.920s)
[428.988180] Starting dynamic subtest: region
[457.677048] Dynamic subtest region: SUCCESS (28.696s)
[457.678113] Subtest perf: SUCCESS (37.195s)
[457.708099] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[457.709093] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[457.711220] [086/134] (566s left) gem_eio (in-flight-external)
[459.463437] Starting subtest: in-flight-external
[460.879115] Subtest in-flight-external: SUCCESS (1.416s)
[461.049552] [FACT gem_eio (in-flight-external)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[461.052062] [FACT gem_eio (in-flight-external)] new: kernel.kmod_is_loaded.i915: true
[461.054810] [087/134] (563s left) perf_pmu (busy-hang)
[461.130475] Starting subtest: busy-hang
[461.131424] Starting dynamic subtest: rcs0
[462.454369] Dynamic subtest rcs0: SUCCESS (1.320s)
[462.464828] Starting dynamic subtest: bcs0
[463.649670] Dynamic subtest bcs0: SUCCESS (1.195s)
[463.662857] Starting dynamic subtest: vcs0
[464.849782] Dynamic subtest vcs0: SUCCESS (1.196s)
[464.862660] Starting dynamic subtest: vcs1
[466.055782] Dynamic subtest vcs1: SUCCESS (1.202s)
[466.068261] Starting dynamic subtest: vecs0
[467.256884] Dynamic subtest vecs0: SUCCESS (1.198s)
[467.270190] Starting dynamic subtest: vecs1
[468.476671] Dynamic subtest vecs1: SUCCESS (1.216s)
[468.488893] Starting dynamic subtest: ccs0
[469.689940] Dynamic subtest ccs0: SUCCESS (1.210s)
[469.692791] Subtest busy-hang: SUCCESS (8.561s)
[469.848958] [088/134] (554s left) kms_addfb_basic (no-handle)
[469.929610] Starting subtest: no-handle
[469.930505] Subtest no-handle: SUCCESS (0.000s)
[470.242520] [089/134] (554s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[470.434476] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[470.436206] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[470.621349] [090/134] (553s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[470.812432] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[470.813402] Starting dynamic subtest: pipe-A-DP-3
[470.822885] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[470.833099] Starting dynamic subtest: pipe-B-DP-3
[470.842388] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[470.853243] Starting dynamic subtest: pipe-C-DP-3
[470.862432] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[470.872590] Starting dynamic subtest: pipe-D-DP-3
[470.884535] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[470.886528] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SKIP (0.007s)
[471.285526] [091/134] (553s left) syncobj_timeline (host-signal-ordered)
[471.364971] Starting subtest: host-signal-ordered
[471.365991] Subtest host-signal-ordered: SUCCESS (0.000s)
[471.521063] [092/134] (553s left) api_intel_bb (blit-reloc-keep-cache)
[471.602536] Starting subtest: blit-reloc-keep-cache
[471.604325] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[471.756088] [093/134] (553s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[471.838656] Starting subtest: multi-wait-all-for-submit-submitted
[471.944620] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.105s)
[472.072634] [094/134] (552s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[472.259993] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[472.261877] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[472.598393] [095/134] (552s left) gen9_exec_parse (secure-batches)
[472.685191] Subtest secure-batches: SKIP (0.000s)
[472.777789] [096/134] (552s left) kms_psr (fbc-psr-cursor-plane-onoff)
[472.972609] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[473.041584] [097/134] (551s left) kms_addfb_basic (bad-pitch-128)
[473.123738] Starting subtest: bad-pitch-128
[473.124615] Subtest bad-pitch-128: SUCCESS (0.000s)
[473.393062] [098/134] (551s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[473.582962] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[473.585449] Starting dynamic subtest: pipe-A-valid-mode
[475.971590] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.384s)
[475.973082] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (2.388s)
[476.279974] [099/134] (548s left) sysfs_timeslice_duration (invalid)
[476.366506] Starting subtest: invalid
[476.368795] Starting dynamic subtest: vecs0
[476.369657] Dynamic subtest vecs0: SUCCESS (0.000s)
[476.381088] Starting dynamic subtest: ccs0
[476.382381] Dynamic subtest ccs0: SUCCESS (0.000s)
[476.392590] Starting dynamic subtest: vcs0
[476.393669] Dynamic subtest vcs0: SUCCESS (0.000s)
[476.404093] Starting dynamic subtest: bcs0
[476.405345] Dynamic subtest bcs0: SUCCESS (0.000s)
[476.415599] Starting dynamic subtest: vecs1
[476.416789] Dynamic subtest vecs1: SUCCESS (0.000s)
[476.427452] Starting dynamic subtest: rcs0
[476.428644] Dynamic subtest rcs0: SUCCESS (0.000s)
[476.438777] Starting dynamic subtest: vcs1
[476.439939] Dynamic subtest vcs1: SUCCESS (0.000s)
[476.441061] Subtest invalid: SUCCESS (0.011s)
[476.508656] [100/134] (548s left) kms_psr (psr-sprite-mmap-gtt)
[476.722621] Subtest psr-sprite-mmap-gtt: SKIP (0.000s)
[476.788365] [101/134] (548s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[476.978478] Starting subtest: basic-flip-after-cursor-atomic
[478.017747] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.039s)
[478.353293] [102/134] (547s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[478.441297] Starting subtest: invalid-bsd1-flag-on-vebox
[478.442236] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[478.617401] [103/134] (546s left) syncobj_eventfd (invalid-bad-pad)
[478.701532] Starting subtest: invalid-bad-pad
[478.702459] Subtest invalid-bad-pad: SUCCESS (0.000s)
[478.838528] [104/134] (546s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[479.035614] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[479.093399] [105/134] (546s left) gem_exec_fence (syncobj-timeline-signal)
[479.783062] Starting subtest: syncobj-timeline-signal
[479.818423] Subtest syncobj-timeline-signal: SUCCESS (0.036s)
[480.148873] [106/134] (545s left) gem_exec_whisper (basic-contexts-forked)
[480.240483] Starting subtest: basic-contexts-forked
[503.303786] Subtest basic-contexts-forked: SUCCESS (23.062s)
[503.596572] [107/134] (522s left) gem_mmap_gtt (big-bo-tiledx)
[503.682196] Subtest big-bo-tiledX: SKIP (0.000s)
[503.766846] [108/134] (521s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[503.847514] Starting subtest: multi-wait-all-for-submit-signaled
[503.848442] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[504.025619] [109/134] (521s left) gem_fence_thrash (bo-write-verify-x)
[504.075301] Starting subtest: bo-write-verify-x
[504.110305] Subtest bo-write-verify-x: SKIP (0.034s)
[504.178969] [110/134] (521s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[504.374570] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[504.376268] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[504.504247] [111/134] (521s left) gem_create (create-ext-set-pat)
[504.698745] Starting subtest: create-ext-set-pat
[504.700755] Subtest create-ext-set-pat: SKIP (0.000s)
[504.882320] [112/134] (521s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[505.068435] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[505.069338] Starting dynamic subtest: pipe-A-DP-3
[505.072971] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[505.083833] Starting dynamic subtest: pipe-B-DP-3
[505.087335] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[505.097955] Starting dynamic subtest: pipe-C-DP-3
[505.101501] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[505.112057] Starting dynamic subtest: pipe-D-DP-3
[505.115495] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[505.117241] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SKIP (0.008s)
[505.542540] [113/134] (520s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[505.737136] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[505.738946] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[505.939721] [114/134] (520s left) gem_lmem_swapping (heavy-verify-multi)
[508.704641] Starting subtest: heavy-verify-multi
[508.706748] Starting dynamic subtest: lmem0
[524.198782] Dynamic subtest lmem0: SUCCESS (15.497s)
[524.199799] Subtest heavy-verify-multi: SUCCESS (15.498s)
[525.547626] [FACT gem_lmem_swapping (heavy-verify-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[525.548611] [FACT gem_lmem_swapping (heavy-verify-multi)] deleted: kernel.kmod_is_loaded.i915: true
[525.550547] [115/134] (500s left) gem_ctx_persistence (engines-hang)
[527.187976] Starting subtest: engines-hang
[527.189216] Starting dynamic subtest: rcs0
[527.355333] Dynamic subtest rcs0: SUCCESS (0.166s)
[527.398155] Starting dynamic subtest: bcs0
[527.422388] Dynamic subtest bcs0: SUCCESS (0.063s)
[527.440809] Starting dynamic subtest: vcs0
[527.527340] Dynamic subtest vcs0: SUCCESS (0.102s)
[527.568212] Starting dynamic subtest: vcs1
[527.589487] Dynamic subtest vcs1: SUCCESS (0.058s)
[527.607466] Starting dynamic subtest: vecs0
[527.691414] Dynamic subtest vecs0: SUCCESS (0.099s)
[527.732756] Starting dynamic subtest: vecs1
[527.733924] Dynamic subtest vecs1: SUCCESS (0.035s)
[527.748974] Starting dynamic subtest: ccs0
[527.869307] Dynamic subtest ccs0: SUCCESS (0.135s)
[527.874169] Subtest engines-hang: SUCCESS (0.683s)
[528.021989] [FACT gem_ctx_persistence (engines-hang)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[528.024387] [FACT gem_ctx_persistence (engines-hang)] new: kernel.kmod_is_loaded.i915: true
[528.027769] [116/134] (498s left) kms_pm_rpm (modeset-non-lpsp-stress)
[529.982691] Starting subtest: modeset-non-lpsp-stress
[535.461738] Subtest modeset-non-lpsp-stress: SUCCESS (5.484s)
[535.763241] [117/134] (490s left) kms_color (ctm-blue-to-red)
[535.953395] Starting subtest: ctm-blue-to-red
[535.954290] Starting dynamic subtest: pipe-A-DP-3
[536.608260] Dynamic subtest pipe-A-DP-3: SUCCESS (0.653s)
[536.628323] Starting dynamic subtest: pipe-B-DP-3
[537.243601] Dynamic subtest pipe-B-DP-3: SUCCESS (0.634s)
[537.259740] Starting dynamic subtest: pipe-C-DP-3
[537.838311] Dynamic subtest pipe-C-DP-3: SUCCESS (0.594s)
[537.851142] Starting dynamic subtest: pipe-D-DP-3
[538.450642] Dynamic subtest pipe-D-DP-3: SUCCESS (0.611s)
[538.451647] Subtest ctm-blue-to-red: SUCCESS (2.499s)
[538.768097] [118/134] (487s left) kms_vblank (wait-idle-hang)
[538.959604] Starting subtest: wait-idle-hang
[538.961968] Starting dynamic subtest: pipe-A-DP-3
[565.576183] Dynamic subtest pipe-A-DP-3: SUCCESS (26.614s)
[565.589376] Starting dynamic subtest: pipe-D-DP-3
[590.590047] Dynamic subtest pipe-D-DP-3: SUCCESS (25.009s)
[590.591076] Subtest wait-idle-hang: SUCCESS (51.629s)
[590.923731] [119/134] (435s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[591.119324] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[591.120247] Starting dynamic subtest: pipe-A-valid-mode
[595.652433] Dynamic subtest pipe-A-valid-mode: SUCCESS (4.530s)
[595.653720] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SUCCESS (4.533s)
[595.946400] [120/134] (430s left) gem_exec_nop (basic-sequential)
[596.041584] Starting subtest: basic-sequential
[600.506653] Subtest basic-sequential: SUCCESS (4.464s)
[600.831248] [121/134] (425s left) gem_exec_flush (basic-wb-rw-default)
[600.918676] Subtest basic-wb-rw-default: SKIP (0.000s)
[601.008099] [122/134] (425s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[601.200436] Starting subtest: bo-too-small-due-to-tiling
[601.202210] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[601.392738] [123/134] (425s left) kms_vblank (query-forked)
[601.583592] Starting subtest: query-forked
[601.586041] Starting dynamic subtest: pipe-A-DP-3
[603.969912] Dynamic subtest pipe-A-DP-3: SUCCESS (2.384s)
[603.999753] Starting dynamic subtest: pipe-D-DP-3
[606.332457] Dynamic subtest pipe-D-DP-3: SUCCESS (2.356s)
[606.333415] Subtest query-forked: SUCCESS (4.748s)
[606.665330] [124/134] (420s left) gem_ctx_shared (q-smoketest-all)
[606.765827] Starting subtest: Q-smoketest-all
[639.065438] Subtest Q-smoketest-all: SUCCESS (32.293s)
[639.400140] [125/134] (387s left) gem_exec_balancer (indices)
[639.496848] Starting subtest: indices
[641.133274] Subtest indices: SUCCESS (1.636s)
[641.542986] [126/134] (385s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[641.742939] Starting subtest: y-tiled-16bpp-rotate-270
[641.744745] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[641.933676] [127/134] (385s left) gem_exec_reloc (basic-cpu-wc)
[642.038116] Subtest basic-cpu-wc: SKIP (0.000s)
[642.175287] [128/134] (385s left) kms_addfb_basic (invalid-get-prop)
[642.261952] Starting subtest: invalid-get-prop
[642.262951] Subtest invalid-get-prop: SUCCESS (0.000s)
[642.569504] [129/134] (384s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[642.765971] Starting subtest: addfb25-y-tiled-legacy
[642.766864] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[642.942628] [130/134] (384s left) sysfs_heartbeat_interval (nopreempt)
[643.034390] Starting subtest: nopreempt
[643.036904] Starting dynamic subtest: vecs0
[647.382490] Dynamic subtest vecs0: SUCCESS (4.347s)
[647.395395] Starting dynamic subtest: ccs0
[651.705383] Dynamic subtest ccs0: SUCCESS (4.321s)
[651.719193] Starting dynamic subtest: vcs0
[655.983228] Dynamic subtest vcs0: SUCCESS (4.276s)
[655.994489] Starting dynamic subtest: bcs0
[660.192340] Dynamic subtest bcs0: SUCCESS (4.208s)
[660.203372] Starting dynamic subtest: vecs1
[664.427819] Dynamic subtest vecs1: SUCCESS (4.234s)
[664.440580] Starting dynamic subtest: rcs0
[668.775396] Dynamic subtest rcs0: SUCCESS (4.346s)
[668.787920] Starting dynamic subtest: vcs1
[673.063370] Dynamic subtest vcs1: SUCCESS (4.286s)
[673.064368] Subtest nopreempt: SUCCESS (30.029s)
[673.268449] [131/134] (354s left) gem_mmap_offset (perf)
[673.350825] Starting subtest: perf
[673.351887] Starting dynamic subtest: lmem0
[673.672125] Dynamic subtest lmem0: SUCCESS (0.321s)
[673.683632] Starting dynamic subtest: smem0
[673.689170] Dynamic subtest smem0: SUCCESS (0.003s)
[673.690391] Subtest perf: SUCCESS (0.326s)
[673.883227] [132/134] (353s left) gem_exec_schedule (lateslice)
[673.975265] Starting subtest: lateslice
[673.976186] Starting dynamic subtest: rcs0
[674.027030] Dynamic subtest rcs0: SUCCESS (0.051s)
[674.039829] Starting dynamic subtest: bcs0
[674.050589] Dynamic subtest bcs0: SUCCESS (0.023s)
[674.063325] Starting dynamic subtest: vcs0
[674.072367] Dynamic subtest vcs0: SUCCESS (0.021s)
[674.085189] Starting dynamic subtest: vcs1
[674.095022] Dynamic subtest vcs1: SUCCESS (0.022s)
[674.107870] Starting dynamic subtest: vecs0
[674.117996] Dynamic subtest vecs0: SUCCESS (0.022s)
[674.130569] Starting dynamic subtest: vecs1
[674.139372] Dynamic subtest vecs1: SUCCESS (0.020s)
[674.152070] Starting dynamic subtest: ccs0
[674.164189] Dynamic subtest ccs0: SUCCESS (0.024s)
[674.165182] Subtest lateslice: SUCCESS (0.189s)
[674.622928] [133/134] (353s left) kms_dsc (dsc-with-output-formats-with-bpc)
[674.817755] Starting subtest: dsc-with-output-formats-with-bpc
[674.849334] Subtest dsc-with-output-formats-with-bpc: SKIP (0.002s)
[674.992919] [134/134] (352s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[675.187507] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[675.189200] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[675.375765] Closing watchdogs
results: parsing output: 0/ for test: kms_colorop
results: parsing output: 1/ for test: kms_chamelium_color
results: parsing output: 2/ for test: i915_pm_rps
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_cursor_crc
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_ctx_create
results: parsing output: 10/ for test: gem_mmap_gtt
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: gem_readwrite
results: parsing output: 14/ for test: sw_sync
results: parsing output: 15/ for test: api_intel_bb
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_plane_scaling
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_pm_backlight
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_exec_parallel
results: parsing output: 22/ for test: kms_psr2_su
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: perf_pmu
results: parsing output: 26/ for test: vgem_basic
results: parsing output: 27/ for test: i915_pm_freq_api
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_flink_basic
results: parsing output: 30/ for test: kms_prime
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: dumb_buffer
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_async_flips
results: parsing output: 36/ for test: gem_exec_suspend
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_getfb
results: parsing output: 39/ for test: gem_render_copy
results: parsing output: 40/ for test: i915_drm_fdinfo
results: parsing output: 41/ for test: prime_busy
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_plane_scaling
results: parsing output: 46/ for test: gem_exec_basic
results: parsing output: 47/ for test: gem_eio
results: parsing output: 48/ for test: gem_exec_schedule
results: parsing output: 49/ for test: gem_userptr_blits
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: i915_query
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_exec_fence
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_vm_create
results: parsing output: 57/ for test: gem_lmem_swapping
results: parsing output: 58/ for test: kms_properties
results: parsing output: 59/ for test: kms_cursor_crc
results: parsing output: 60/ for test: kms_universal_plane
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_pipe_crc_basic
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: gem_ctx_persistence
results: parsing output: 66/ for test: kms_chamelium_frames
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_colorop
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_colorop
results: parsing output: 72/ for test: gem_tiled_fence_blits
results: parsing output: 73/ for test: kms_dp_link_training
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: kms_plane_multiple
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_atomic_transition
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_softpin
results: parsing output: 81/ for test: kms_content_protection
results: parsing output: 82/ for test: fbdev
results: parsing output: 83/ for test: gem_render_copy
results: parsing output: 84/ for test: i915_selftest
results: parsing output: 85/ for test: gem_eio
results: parsing output: 86/ for test: perf_pmu
results: parsing output: 87/ for test: kms_addfb_basic
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: api_intel_bb
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: gen9_exec_parse
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_addfb_basic
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: sysfs_timeslice_duration
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: gem_exec_params
results: parsing output: 102/ for test: syncobj_eventfd
results: parsing output: 103/ for test: kms_psr2_sf
results: parsing output: 104/ for test: gem_exec_fence
results: parsing output: 105/ for test: gem_exec_whisper
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: gem_fence_thrash
results: parsing output: 109/ for test: kms_joiner
results: parsing output: 110/ for test: gem_create
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_lmem_swapping
results: parsing output: 114/ for test: gem_ctx_persistence
results: parsing output: 115/ for test: kms_pm_rpm
results: parsing output: 116/ for test: kms_color
results: parsing output: 117/ for test: kms_vblank
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: gem_exec_nop
results: parsing output: 120/ for test: gem_exec_flush
results: parsing output: 121/ for test: kms_addfb_basic
results: parsing output: 122/ for test: kms_vblank
results: parsing output: 123/ for test: gem_ctx_shared
results: parsing output: 124/ for test: gem_exec_balancer
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: gem_exec_reloc
results: parsing output: 127/ for test: kms_addfb_basic
results: parsing output: 128/ for test: kms_addfb_basic
results: parsing output: 129/ for test: sysfs_heartbeat_interval
results: parsing output: 130/ for test: gem_mmap_offset
results: parsing output: 131/ for test: gem_exec_schedule
results: parsing output: 132/ for test: kms_dsc
results: parsing output: 133/ for test: kms_frontbuffer_tracking
Done.