[58.307856] Initializing watchdogs
[58.307903]   /dev/watchdog0
[58.339832] [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.344177] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.346732] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.350042] [001/133] (960s left) kms_selftest (drm_format_helper)
[58.408461] Starting subtest: drm_format_helper
[58.418047] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[58.530993] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.112s)
[58.538968] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[58.641076] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.108s)
[58.649413] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[58.743848] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.104s)
[58.752448] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[58.843781] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.098s)
[58.851493] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[58.936999] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.091s)
[58.944852] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[59.052303] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.116s)
[59.061237] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[59.141058] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.086s)
[59.149042] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[59.249385] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.107s)
[59.257213] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[59.334176] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.084s)
[59.341055] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[59.430086] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.095s)
[59.437493] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[59.526456] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.098s)
[59.532855] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[59.620273] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.092s)
[59.626445] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[59.712184] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.090s)
[59.720207] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[59.813997] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.101s)
[59.821441] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[59.907359] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.093s)
[59.914675] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[59.994947] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.087s)
[60.002125] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[60.102160] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.108s)
[60.103704] Subtest drm_format_helper: SUCCESS (1.685s)
[60.261184] [002/133] (958s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[60.318925] Subtest tiled-to-tiled: SKIP (0.000s)
[60.389194] [003/133] (958s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[60.486124] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[60.488123] Starting dynamic subtest: pipe-A-default-mode
[63.176927] Dynamic subtest pipe-A-default-mode: SUCCESS (2.680s)
[63.179389] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.681s)
[64.033086] [004/133] (954s left) prime_mmap (test_correct_cpu_write)
[64.087375] Starting subtest: test_correct_cpu_write
[64.090038] Starting dynamic subtest: test_correct_cpu_write-smem
[64.092043] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[64.093994] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[64.185436] [005/133] (954s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[64.256844] Starting subtest: y-tiled-ccs-to-y-tiled
[64.261077] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[64.446539] [006/133] (954s left) sysfs_heartbeat_interval (nopreempt)
[64.503591] Starting subtest: nopreempt
[64.506047] Starting dynamic subtest: vecs0
[73.938536] Dynamic subtest vecs0: SUCCESS (9.418s)
[73.947439] Starting dynamic subtest: ccs0
[77.805655] Dynamic subtest ccs0: SUCCESS (3.867s)
[77.815758] Starting dynamic subtest: vcs0
[86.943322] Dynamic subtest vcs0: SUCCESS (9.134s)
[86.953581] Starting dynamic subtest: bcs0
[90.804850] Dynamic subtest bcs0: SUCCESS (3.860s)
[90.814948] Starting dynamic subtest: rcs0
[94.817261] Dynamic subtest rcs0: SUCCESS (4.011s)
[94.827342] Starting dynamic subtest: vcs1
[103.895279] Dynamic subtest vcs1: SUCCESS (9.076s)
[103.897799] Subtest nopreempt: SUCCESS (39.371s)
[103.981078] [007/133] (915s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[104.080103] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[104.082412] Starting dynamic subtest: pipe-A-eDP-1
[104.105776] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[104.120485] Starting dynamic subtest: pipe-B-eDP-1
[104.142242] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[104.150449] Starting dynamic subtest: pipe-C-eDP-1
[104.172069] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[104.179150] Starting dynamic subtest: pipe-D-eDP-1
[104.201063] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[104.205061] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[106.231829] [008/133] (912s left) gem_ctx_param (set-priority-not-supported)
[106.286365] Starting subtest: set-priority-not-supported
[106.290999] Subtest set-priority-not-supported: SKIP (0.000s)
[106.356917] [009/133] (912s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[106.447414] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[106.451574] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[106.535871] [010/133] (912s left) syncobj_timeline (reset-during-wait-for-submit)
[106.593670] Starting subtest: reset-during-wait-for-submit
[106.698096] Subtest reset-during-wait-for-submit: SUCCESS (0.104s)
[106.772198] [011/133] (912s left) kms_pm_dc (dc5-dpms-negative)
[107.874794] Starting subtest: dc5-dpms-negative
[107.879645] Subtest dc5-dpms-negative: SKIP (0.000s)
[107.947369] [012/133] (911s left) kms_psr (fbc-pr-suspend)
[108.048038] Starting subtest: fbc-pr-suspend
[108.052172] Subtest fbc-pr-suspend: SKIP (0.000s)
[108.116498] [013/133] (911s left) kms_content_protection (atomic)
[108.262973] Starting subtest: atomic
[108.267604] Subtest atomic: SKIP (0.000s)
[108.396115] [014/133] (910s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[108.494294] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[108.498499] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[108.596342] [015/133] (910s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[108.694210] Starting subtest: 4-tiled-32bpp-rotate-90
[108.712968] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[108.819978] [016/133] (910s left) fbdev (unaligned-write)
[108.866267] Starting subtest: unaligned-write
[108.966036] Subtest unaligned-write: SUCCESS (0.098s)
[109.021695] [017/133] (910s left) i915_query (query-regions-sanity-check)
[109.075032] Starting subtest: query-regions-sanity-check
[109.084558] Subtest query-regions-sanity-check: SUCCESS (0.010s)
[109.198229] [018/133] (910s left) gem_exec_schedule (preempt-queue-chain)
[109.270111] Subtest preempt-queue-chain: SKIP (0.000s)
[109.560401] [019/133] (909s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[109.679056] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[109.683320] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[109.786454] [020/133] (909s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[109.876058] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[109.878269] Starting dynamic subtest: pipe-A-eDP-1
[109.937243] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[109.947181] Starting dynamic subtest: pipe-B-eDP-1
[110.001782] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[110.009418] Starting dynamic subtest: pipe-C-eDP-1
[110.063413] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[110.070469] Starting dynamic subtest: pipe-D-eDP-1
[110.124913] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[110.129176] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.007s)
[112.182824] [021/133] (907s left) gem_userptr_blits (process-exit)
[112.262722] Starting subtest: process-exit
[112.270598] Subtest process-exit: SUCCESS (0.008s)
[112.404204] [022/133] (907s left) gem_tiled_partial_pwrite_pread (writes)
[112.474773] Subtest writes: SKIP (0.000s)
[112.551706] [023/133] (907s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[112.653864] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[112.656245] Starting dynamic subtest: pipe-A
[113.768841] Dynamic subtest pipe-A: SUCCESS (1.117s)
[113.777390] Starting dynamic subtest: pipe-B
[115.963873] Dynamic subtest pipe-B: SUCCESS (2.195s)
[115.971410] Starting dynamic subtest: pipe-C
[117.182739] Dynamic subtest pipe-C: SUCCESS (1.218s)
[117.191082] Starting dynamic subtest: pipe-D
[118.401901] Dynamic subtest pipe-D: SUCCESS (1.218s)
[118.404179] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.750s)
[119.598982] [024/133] (900s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[119.700342] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[126.698604] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.000s)
[126.832165] [025/133] (892s left) perf (global-sseu-config)
[126.965162] Starting subtest: global-sseu-config
[126.969768] Subtest global-sseu-config: SKIP (0.000s)
[127.009149] [026/133] (892s left) gen9_exec_parse (allowed-single)
[127.063364] Subtest allowed-single: SKIP (0.000s)
[127.143059] [027/133] (892s left) gem_ringfill (engines-basic)
[132.889691] Starting subtest: engines-basic
[132.892493] Starting dynamic subtest: rcs0
[132.942550] Dynamic subtest rcs0: SUCCESS (0.054s)
[132.953778] Starting dynamic subtest: bcs0
[132.987225] Dynamic subtest bcs0: SUCCESS (0.043s)
[132.997390] Starting dynamic subtest: vcs0
[133.033796] Dynamic subtest vcs0: SUCCESS (0.045s)
[133.048581] Starting dynamic subtest: vcs1
[133.075944] Dynamic subtest vcs1: SUCCESS (0.041s)
[133.084855] Starting dynamic subtest: vecs0
[133.119465] Dynamic subtest vecs0: SUCCESS (0.042s)
[133.129129] Starting dynamic subtest: ccs0
[133.164919] Dynamic subtest ccs0: SUCCESS (0.044s)
[133.167674] Subtest engines-basic: SUCCESS (0.277s)
[133.239696] [FACT gem_ringfill (engines-basic)] new: kernel.kmod_is_loaded.vgem: true
[133.243311] [028/133] (886s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[133.333622] Starting subtest: 2x-absolute-wf_vblank-interruptible
[133.344083] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.010s)
[133.416723] [029/133] (886s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[133.515675] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[140.280181] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.768s)
[140.407387] [030/133] (879s left) kms_big_fb (linear-8bpp-rotate-90)
[140.521347] Starting subtest: linear-8bpp-rotate-90
[140.542058] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[140.665608] [031/133] (879s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[140.783469] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[142.237324] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.450s)
[143.035097] [032/133] (876s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[143.122757] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[143.124961] Starting dynamic subtest: pipe-A-default-mode
[145.878612] Dynamic subtest pipe-A-default-mode: SUCCESS (2.756s)
[145.880890] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.758s)
[146.742313] [033/133] (873s left) gem_userptr_blits (sd-probe)
[146.808798] Starting subtest: sd-probe
[146.810993] Subtest sd-probe: SUCCESS (0.000s)
[146.932769] [034/133] (873s left) gem_mmap_gtt (cpuset-big-copy)
[146.981604] Subtest cpuset-big-copy: SKIP (0.000s)
[147.042885] [035/133] (873s left) kms_cursor_crc (cursor-size-hints)
[147.178843] Starting subtest: cursor-size-hints
[147.181189] Starting dynamic subtest: pipe-A-eDP-1
[147.800259] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.619s)
[147.808480] Starting dynamic subtest: pipe-D-eDP-1
[149.097107] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.297s)
[149.099406] Subtest cursor-size-hints: SUCCESS (1.918s)
[149.900765] [036/133] (870s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[149.957054] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[149.959283] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[150.044895] [037/133] (870s left) kms_lease (lessee-list)
[150.140960] Starting subtest: lessee-list
[150.143271] Starting dynamic subtest: pipe-A-eDP-1
[150.145586] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[150.154328] Starting dynamic subtest: pipe-B-eDP-1
[150.156186] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[150.163328] Starting dynamic subtest: pipe-C-eDP-1
[150.165184] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[150.172095] Starting dynamic subtest: pipe-D-eDP-1
[150.173970] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[150.175918] Subtest lessee-list: SUCCESS (0.008s)
[150.246095] [038/133] (870s left) core_auth (getclient-master-drop)
[150.278170] Starting subtest: getclient-master-drop
[150.306395] Subtest getclient-master-drop: SUCCESS (0.029s)
[150.434737] [039/133] (869s left) kms_getfb (getfb-handle-closed)
[150.530986] Starting subtest: getfb-handle-closed
[150.533299] Subtest getfb-handle-closed: SUCCESS (0.000s)
[150.638060] [040/133] (869s left) gem_userptr_blits (unsync-unmap-after-close)
[150.710905] Subtest unsync-unmap-after-close: SKIP (0.000s)
[150.857991] [041/133] (869s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[150.961194] Starting subtest: fbcpsr-indfb-scaledprimary
[156.779866] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.820s)
[156.927210] [042/133] (863s left) kms_pm_rpm (modeset-pc8-residency-stress)
[159.057125] Starting subtest: modeset-pc8-residency-stress
[159.062154] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[159.429146] [043/133] (861s left) i915_pm_freq_mult (media-freq)
[159.481896] Starting subtest: media-freq
[159.484182] Starting dynamic subtest: gt0
[159.488316] Dynamic subtest gt0: SKIP (0.000s)
[159.495848] Starting dynamic subtest: gt1
[159.499992] Dynamic subtest gt1: SKIP (0.000s)
[159.504072] Subtest media-freq: SKIP (0.001s)
[159.573193] [044/133] (860s left) gem_ctx_shared (q-promotion)
[159.629836] Starting subtest: Q-promotion
[159.632582] Starting dynamic subtest: rcs0
[159.732394] Dynamic subtest rcs0: SUCCESS (0.102s)
[159.749442] Starting dynamic subtest: vcs0
[159.819591] Dynamic subtest vcs0: SUCCESS (0.086s)
[159.833371] Starting dynamic subtest: vcs1
[159.903569] Dynamic subtest vcs1: SUCCESS (0.083s)
[159.918169] Starting dynamic subtest: vecs0
[159.992998] Dynamic subtest vecs0: SUCCESS (0.089s)
[160.008604] Starting dynamic subtest: ccs0
[160.088526] Dynamic subtest ccs0: SUCCESS (0.094s)
[160.091056] Subtest Q-promotion: SUCCESS (0.458s)
[161.010277] [045/133] (859s left) syncobj_timeline (signal-array)
[161.076117] Starting subtest: signal-array
[161.078447] Subtest signal-array: SUCCESS (0.000s)
[161.175434] [046/133] (859s left) gem_ctx_freq (sysfs)
[161.237265] Starting subtest: sysfs
[161.239499] Starting dynamic subtest: gt0
[166.723124] Dynamic subtest gt0: SUCCESS (5.488s)
[166.735201] Starting dynamic subtest: gt1
[207.894360] Dynamic subtest gt1: SUCCESS (41.167s)
[207.897193] Subtest sysfs: SUCCESS (46.657s)
[208.020479] [047/133] (812s left) gem_create (create-clear)
[208.074717] Starting subtest: create-clear
[208.076856] Starting dynamic subtest: smem0
[240.727357] Dynamic subtest smem0: SUCCESS (32.649s)
[240.729333] Subtest create-clear: SUCCESS (32.651s)
[240.931874] [048/133] (779s left) vgem_basic (sysfs)
[240.999574] Starting subtest: sysfs
[241.002067] Subtest sysfs: SUCCESS (0.001s)
[241.058751] [049/133] (779s left) kms_async_flips (crc-atomic)
[241.166265] Starting subtest: crc-atomic
[241.549556] Starting dynamic subtest: pipe-A-eDP-1
[244.460295] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.882s)
[244.813708] Starting dynamic subtest: pipe-B-eDP-1
[247.778911] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.957s)
[248.135389] Starting dynamic subtest: pipe-C-eDP-1
[251.091749] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.933s)
[251.436173] Starting dynamic subtest: pipe-D-eDP-1
[254.323535] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.866s)
[254.325647] Subtest crc-atomic: SUCCESS (13.129s)
[255.470123] [050/133] (765s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[255.589426] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[262.154966] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.568s)
[262.281367] [051/133] (758s left) kms_plane_alpha_blend (alpha-7efc)
[262.371665] Starting subtest: alpha-7efc
[262.644118] Starting dynamic subtest: pipe-A-eDP-1
[263.250784] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.605s)
[263.276497] Starting dynamic subtest: pipe-D-eDP-1
[264.543310] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.270s)
[264.545501] Subtest alpha-7efc: SUCCESS (2.170s)
[265.388426] [052/133] (755s left) kms_joiner (invalid-modeset-big-joiner)
[265.489523] Starting subtest: invalid-modeset-big-joiner
[265.493976] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[265.555773] [053/133] (755s left) kms_color (ctm-signed)
[265.640256] Starting subtest: ctm-signed
[265.642478] Starting dynamic subtest: pipe-A-eDP-1
[267.765420] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.124s)
[267.775585] Starting dynamic subtest: pipe-B-eDP-1
[270.563428] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.799s)
[270.572768] Starting dynamic subtest: pipe-C-eDP-1
[273.269582] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.703s)
[273.278756] Starting dynamic subtest: pipe-D-eDP-1
[275.929511] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.661s)
[275.931837] Subtest ctm-signed: SUCCESS (10.290s)
[276.747836] [054/133] (744s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[276.841408] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[276.845491] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[276.947165] [055/133] (743s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[277.046359] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[277.050733] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[277.150035] [056/133] (743s left) gem_userptr_blits (usage-restrictions)
[277.221341] Starting subtest: usage-restrictions
[277.223611] Subtest usage-restrictions: SUCCESS (0.000s)
[277.375130] [057/133] (743s left) gem_pxp (verify-pxp-stale-ctx-execution)
[277.502039] Starting subtest: verify-pxp-stale-ctx-execution
[278.557940] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.058s)
[278.678393] [058/133] (742s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[278.768447] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[278.772820] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[278.866950] [059/133] (742s left) gem_ctx_persistence (heartbeat-hang)
[278.920377] Starting subtest: heartbeat-hang
[278.924819] Subtest heartbeat-hang: SKIP (0.000s)
[279.026438] [060/133] (742s left) kms_chamelium_color (ctm-blue-to-red)
[279.115259] Subtest ctm-blue-to-red: SKIP (0.000s)
[279.163446] [061/133] (742s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[279.265304] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[285.366498] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.104s)
[286.554593] [062/133] (734s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[286.649234] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[286.651418] Starting dynamic subtest: pipe-A-eDP-1
[286.734447] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[286.743713] Starting dynamic subtest: pipe-B-eDP-1
[287.914928] Dynamic subtest pipe-B-eDP-1: SKIP (1.178s)
[287.919662] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.268s)
[289.113526] [063/133] (732s left) kms_cursor_legacy (torture-move)
[289.232213] Starting subtest: torture-move
[289.234470] Starting dynamic subtest: pipe-A
[295.175401] Dynamic subtest pipe-A: SUCCESS (5.939s)
[295.186259] Starting dynamic subtest: pipe-B
[302.105906] Dynamic subtest pipe-B: SUCCESS (6.929s)
[302.119138] Starting dynamic subtest: pipe-C
[308.465983] Dynamic subtest pipe-C: SUCCESS (6.356s)
[308.479791] Starting dynamic subtest: pipe-D
[315.166136] Dynamic subtest pipe-D: SUCCESS (6.699s)
[315.177873] Starting dynamic subtest: all-pipes
[322.273755] Dynamic subtest all-pipes: SUCCESS (7.090s)
[322.276054] Subtest torture-move: SUCCESS (33.022s)
[322.422632] [064/133] (698s left) api_intel_bb (blit-noreloc-keep-cache)
[322.507709] Starting subtest: blit-noreloc-keep-cache
[322.515720] Subtest blit-noreloc-keep-cache: SUCCESS (0.009s)
[322.655592] [065/133] (698s left) kms_vblank (wait-idle-hang)
[322.755046] Starting subtest: wait-idle-hang
[322.757322] Starting dynamic subtest: pipe-A-eDP-1
[349.662629] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.906s)
[349.676903] Starting dynamic subtest: pipe-D-eDP-1
[364.697237] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.032s)
[364.699524] Subtest wait-idle-hang: SUCCESS (41.943s)
[365.571900] [066/133] (655s left) gem_userptr_blits (process-exit-busy)
[365.631185] Starting subtest: process-exit-busy
[365.642990] Subtest process-exit-busy: SUCCESS (0.015s)
[365.759585] [067/133] (655s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[365.858218] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[365.862540] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[365.969914] [068/133] (655s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[366.067436] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[366.071588] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[366.173799] [069/133] (655s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[366.273104] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[366.302064] Starting dynamic subtest: pipe-A-plane-0
[366.609609] Dynamic subtest pipe-A-plane-0: SUCCESS (0.311s)
[366.619021] Starting dynamic subtest: pipe-A-plane-3
[366.842728] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[367.949425] Starting dynamic subtest: pipe-B-plane-0
[368.251719] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[368.260202] Starting dynamic subtest: pipe-B-plane-3
[368.485214] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[368.807558] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.533s)
[369.633620] [070/133] (651s left) core_setmaster (master-drop-set-user)
[369.715258] Starting subtest: master-drop-set-user
[369.726772] Subtest master-drop-set-user: SUCCESS (0.014s)
[369.765140] [071/133] (651s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[369.858518] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[369.860669] Starting dynamic subtest: pipe-A-eDP-1
[369.880811] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[369.890135] Starting dynamic subtest: pipe-B-eDP-1
[369.909796] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[369.918383] Starting dynamic subtest: pipe-C-eDP-1
[369.938439] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[369.947159] Starting dynamic subtest: pipe-D-eDP-1
[369.967248] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[369.969499] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.092s)
[372.120441] [072/133] (649s left) kms_flip (2x-flip-vs-wf_vblank)
[372.217808] Starting subtest: 2x-flip-vs-wf_vblank
[372.226048] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s)
[372.335151] [073/133] (649s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[372.436499] Starting subtest: y-tiled-32bpp-rotate-90
[372.440783] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[372.559441] [074/133] (649s left) kms_setmode (invalid-clone-exclusive-crtc)
[372.621244] Starting subtest: invalid-clone-exclusive-crtc
[372.627389] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[372.728921] [075/133] (649s left) kms_psr (pr-cursor-blt)
[372.813583] Starting subtest: pr-cursor-blt
[372.817753] Subtest pr-cursor-blt: SKIP (0.000s)
[372.892470] [076/133] (648s left) kms_getfb (getfb-repeated-different-handles)
[372.987117] Starting subtest: getfb-repeated-different-handles
[372.989375] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[373.087083] [077/133] (648s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[373.195374] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[374.197032] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.000s)
[374.318359] [078/133] (647s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[374.409417] Starting subtest: primary-4-tiled-reflect-x-180
[381.431055] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.022s)
[382.599122] [079/133] (639s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[382.693869] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[390.051402] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.359s)
[390.176185] [080/133] (631s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[390.271909] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[395.492768] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (5.223s)
[396.669280] [081/133] (625s left) gem_mmap_offset (bad-object)
[396.734549] Starting subtest: bad-object
[396.736653] Subtest bad-object: SUCCESS (0.001s)
[396.830972] [082/133] (625s left) syncobj_timeline (invalid-query-illegal-handle)
[396.893610] Starting subtest: invalid-query-illegal-handle
[396.895951] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[396.986834] [083/133] (625s left) prime_vgem (fence-wait)
[397.055482] Starting subtest: fence-wait
[397.057423] Starting dynamic subtest: rcs0
[398.113402] Dynamic subtest rcs0: SUCCESS (1.057s)
[398.123935] Starting dynamic subtest: bcs0
[399.163793] Dynamic subtest bcs0: SUCCESS (1.051s)
[399.174205] Starting dynamic subtest: vcs0
[400.208592] Dynamic subtest vcs0: SUCCESS (1.042s)
[400.219957] Starting dynamic subtest: vcs1
[401.257656] Dynamic subtest vcs1: SUCCESS (1.046s)
[401.269060] Starting dynamic subtest: vecs0
[402.302068] Dynamic subtest vecs0: SUCCESS (1.042s)
[402.313315] Starting dynamic subtest: ccs0
[403.349393] Dynamic subtest ccs0: SUCCESS (1.045s)
[403.352301] Subtest fence-wait: SUCCESS (6.296s)
[403.468476] [084/133] (618s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[403.581746] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[403.583991] Starting dynamic subtest: pipe-A-eDP-1
[409.458250] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.880s)
[409.467305] Starting dynamic subtest: pipe-B-eDP-1
[416.117710] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.659s)
[416.120116] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.542s)
[417.000017] [085/133] (605s left) i915_module_load (reload-no-display)
[417.044169] Starting subtest: reload-no-display
[422.817568] Subtest reload-no-display: SUCCESS (5.775s)
[422.845847] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[422.846745] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[422.850189] [086/133] (599s left) testdisplay
[424.701499] [FACT testdisplay] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[424.702791] [FACT testdisplay] new: kernel.kmod_is_loaded.i915: true
[424.706404] [087/133] (597s left) gem_mmap_offset (pf-nonblock)
[424.767817] Starting subtest: pf-nonblock
[424.773316] Subtest pf-nonblock: SUCCESS (0.006s)
[424.883870] [088/133] (597s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[424.974457] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[424.978415] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[425.070885] [089/133] (597s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[425.165406] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[429.229721] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.067s)
[430.379444] [090/133] (591s left) prime_mmap_coherency (ioctl-errors)
[430.438153] Starting subtest: ioctl-errors
[444.024203] Subtest ioctl-errors: SUCCESS (13.586s)
[444.185515] [091/133] (578s left) gem_userptr_blits (unsync-unmap-cycles)
[444.289681] Subtest unsync-unmap-cycles: SKIP (0.000s)
[444.416598] [092/133] (578s left) kms_chamelium_frames (hdmi-frame-dump)
[444.822071] Subtest hdmi-frame-dump: SKIP (0.000s)
[445.644217] [093/133] (576s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[445.732962] Starting subtest: plane-upscale-20x20-with-rotation
[445.735142] Starting dynamic subtest: pipe-A
[445.959310] Dynamic subtest pipe-A: SUCCESS (0.228s)
[445.968589] Starting dynamic subtest: pipe-B
[447.234550] Dynamic subtest pipe-B: SUCCESS (1.274s)
[447.244021] Starting dynamic subtest: pipe-C
[448.564802] Dynamic subtest pipe-C: SUCCESS (1.329s)
[448.573199] Starting dynamic subtest: pipe-D
[449.903581] Dynamic subtest pipe-D: SUCCESS (1.338s)
[449.905941] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.174s)
[451.094690] [094/133] (571s left) kms_psr (psr2-primary-page-flip)
[451.206609] Starting subtest: psr2-primary-page-flip
[451.208905] Starting dynamic subtest: eDP-1
[452.960845] Dynamic subtest eDP-1: SUCCESS (1.750s)
[452.963274] Subtest psr2-primary-page-flip: SUCCESS (1.752s)
[453.839350] [095/133] (568s left) gem_exec_whisper (basic-contexts-priority-all)
[453.910450] Starting subtest: basic-contexts-priority-all
[476.868981] Subtest basic-contexts-priority-all: SUCCESS (22.902s)
[477.011904] [096/133] (545s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[477.102635] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[477.486478] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[480.280486] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.740s)
[480.292502] Starting dynamic subtest: pipe-A-eDP-1-4
[482.465175] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s)
[482.476472] Starting dynamic subtest: pipe-A-eDP-1-4
[484.424031] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[484.437822] Starting dynamic subtest: pipe-A-eDP-1-x
[486.666331] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[486.982538] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[489.803578] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.775s)
[489.813184] Starting dynamic subtest: pipe-B-eDP-1-4
[492.022941] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.218s)
[492.035150] Starting dynamic subtest: pipe-B-eDP-1-4
[493.981809] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[493.993452] Starting dynamic subtest: pipe-B-eDP-1-x
[496.234074] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[496.548542] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[499.335296] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.741s)
[499.345772] Starting dynamic subtest: pipe-C-eDP-1-4
[501.510255] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.172s)
[501.522579] Starting dynamic subtest: pipe-C-eDP-1-4
[503.469432] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[503.481898] Starting dynamic subtest: pipe-C-eDP-1-x
[505.699521] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[506.024755] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[508.813692] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.797s)
[508.825939] Starting dynamic subtest: pipe-D-eDP-1-4
[511.041338] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[511.052946] Starting dynamic subtest: pipe-D-eDP-1-4
[512.999012] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[513.014179] Starting dynamic subtest: pipe-D-eDP-1-x
[515.229435] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[515.231902] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.074s)
[516.402551] [097/133] (506s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[516.509785] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[516.514100] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[516.579505] [098/133] (506s left) gem_exec_reloc (basic-write-wc-noreloc)
[516.637858] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[516.705369] [099/133] (506s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[516.812292] Starting subtest: fbcpsr-tiling-linear
[523.442922] Subtest fbcpsr-tiling-linear: SUCCESS (6.633s)
[523.582274] [100/133] (499s left) kms_flip (flip-vs-fences-interruptible)
[523.673493] Starting subtest: flip-vs-fences-interruptible
[523.677886] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[523.776870] [101/133] (499s left) gem_exec_schedule (smoketest)
[523.979745] Starting subtest: smoketest
[523.982694] Starting dynamic subtest: rcs0
[529.591771] Dynamic subtest rcs0: SUCCESS (5.504s)
[529.601955] Starting dynamic subtest: bcs0
[535.105056] Dynamic subtest bcs0: SUCCESS (5.520s)
[535.115497] Starting dynamic subtest: vcs0
[540.599854] Dynamic subtest vcs0: SUCCESS (5.495s)
[540.610812] Starting dynamic subtest: vcs1
[546.104047] Dynamic subtest vcs1: SUCCESS (5.499s)
[546.115512] Starting dynamic subtest: vecs0
[551.595976] Dynamic subtest vecs0: SUCCESS (5.494s)
[551.606894] Starting dynamic subtest: ccs0
[557.040181] Dynamic subtest ccs0: SUCCESS (5.495s)
[557.042404] Subtest smoketest: SUCCESS (33.014s)
[557.233609] [102/133] (465s left) kms_properties (get_properties-sanity-atomic)
[557.338354] Starting subtest: get_properties-sanity-atomic
[557.340665] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[557.413970] [103/133] (465s left) gem_exec_fence (nb-await)
[557.601911] Starting subtest: nb-await
[557.604172] Starting dynamic subtest: rcs0
[557.666084] Dynamic subtest rcs0: SUCCESS (0.067s)
[557.677973] Starting dynamic subtest: bcs0
[557.724515] Dynamic subtest bcs0: SUCCESS (0.056s)
[557.737056] Starting dynamic subtest: vcs0
[557.783419] Dynamic subtest vcs0: SUCCESS (0.057s)
[557.795043] Starting dynamic subtest: vcs1
[557.842111] Dynamic subtest vcs1: SUCCESS (0.057s)
[557.854354] Starting dynamic subtest: vecs0
[557.901075] Dynamic subtest vecs0: SUCCESS (0.057s)
[557.912627] Starting dynamic subtest: ccs0
[557.958294] Dynamic subtest ccs0: SUCCESS (0.055s)
[557.960885] Subtest nb-await: SUCCESS (0.361s)
[559.977312] [104/133] (462s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[560.092345] Starting subtest: yf-tiled-8bpp-rotate-180
[560.096398] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[560.176955] [105/133] (462s left) gem_exec_params (batch-first)
[560.242014] Starting subtest: batch-first
[560.247584] Subtest batch-first: SUCCESS (0.006s)
[560.369159] [106/133] (462s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[560.419934] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[560.474097] [107/133] (462s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[560.571848] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[560.575738] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[560.653944] [108/133] (462s left) gem_exec_reloc (basic-concurrent16)
[560.707752] Subtest basic-concurrent16: SKIP (0.000s)
[560.780088] [109/133] (462s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[560.875202] Starting subtest: x-tiled-16bpp-rotate-270
[560.894202] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[560.997451] [110/133] (462s left) gem_exec_create (legacy)
[561.069378] Starting subtest: legacy
[561.071316] Starting dynamic subtest: smem
[564.888090] Dynamic subtest smem: SUCCESS (3.816s)
[564.891062] Subtest legacy: SUCCESS (3.818s)
[565.074459] [111/133] (458s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[565.480352] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[566.251456] [112/133] (457s left) gem_spin_batch (spin-all-new)
[566.311823] Starting subtest: spin-all-new
[566.325624] Subtest spin-all-new: SUCCESS (0.013s)
[567.946752] [113/133] (455s left) gem_exec_whisper (basic-queues-forked)
[568.017861] Starting subtest: basic-queues-forked
[591.273910] Subtest basic-queues-forked: SUCCESS (23.251s)
[591.458289] [114/133] (431s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[591.521040] Starting subtest: single-wait-for-submit-unsubmitted
[591.627229] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[591.702333] [115/133] (431s left) perf_pmu (idle-no-semaphores)
[591.746220] Starting subtest: idle-no-semaphores
[591.748443] Starting dynamic subtest: rcs0
[592.307533] Dynamic subtest rcs0: SUCCESS (0.556s)
[592.316037] Starting dynamic subtest: bcs0
[592.824735] Dynamic subtest bcs0: SUCCESS (0.520s)
[592.835967] Starting dynamic subtest: vcs0
[593.344294] Dynamic subtest vcs0: SUCCESS (0.516s)
[593.355205] Starting dynamic subtest: vcs1
[593.868408] Dynamic subtest vcs1: SUCCESS (0.521s)
[593.879743] Starting dynamic subtest: vecs0
[594.385213] Dynamic subtest vecs0: SUCCESS (0.514s)
[594.395879] Starting dynamic subtest: ccs0
[594.916474] Dynamic subtest ccs0: SUCCESS (0.528s)
[594.919258] Subtest idle-no-semaphores: SUCCESS (3.172s)
[595.047825] [116/133] (428s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[595.166441] Starting subtest: cursorB-vs-flipA-atomic
[595.170847] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[595.322207] [117/133] (428s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[595.429579] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[595.434038] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[595.526178] [118/133] (428s left) kms_frontbuffer_tracking (basic)
[595.631406] Starting subtest: basic
[598.796896] Subtest basic: SUCCESS (3.170s)
[598.922638] [119/133] (424s left) kms_cursor_edge_walk (256x256-right-edge)
[599.010047] Starting subtest: 256x256-right-edge
[599.011931] Starting dynamic subtest: pipe-A-eDP-1
[602.444881] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.435s)
[602.456902] Starting dynamic subtest: pipe-D-eDP-1
[605.555734] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.107s)
[605.557847] Subtest 256x256-right-edge: SUCCESS (6.545s)
[606.375017] [120/133] (417s left) syncobj_eventfd (timeline-wait)
[606.433050] Starting subtest: timeline-wait
[606.441958] Subtest timeline-wait: SUCCESS (0.010s)
[606.522176] [121/133] (417s left) kms_cursor_crc (cursor-onscreen-32x32)
[606.659988] Starting subtest: cursor-onscreen-32x32
[606.705469] Subtest cursor-onscreen-32x32: SKIP (0.041s)
[606.999628] [122/133] (416s left) i915_drm_fdinfo (memory-info-resident)
[607.045958] Starting subtest: memory-info-resident
[607.048088] Starting dynamic subtest: smem0
[609.608473] Dynamic subtest smem0: SUCCESS (2.564s)
[609.610887] Subtest memory-info-resident: SUCCESS (2.565s)
[609.683890] [123/133] (414s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[609.790075] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[609.793579] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[609.931692] [124/133] (413s left) kms_plane_cursor (viewport)
[610.031365] Starting subtest: viewport
[610.034777] Starting dynamic subtest: pipe-A-eDP-1-size-64
[612.475541] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.444s)
[612.537161] Starting dynamic subtest: pipe-A-eDP-1-size-128
[614.976689] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.449s)
[615.039705] Starting dynamic subtest: pipe-A-eDP-1-size-256
[617.533653] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.504s)
[617.880764] Starting dynamic subtest: pipe-B-eDP-1-size-64
[621.136255] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.265s)
[621.195855] Starting dynamic subtest: pipe-B-eDP-1-size-128
[623.716238] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.526s)
[623.774223] Starting dynamic subtest: pipe-B-eDP-1-size-256
[626.249608] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.482s)
[626.609317] Starting dynamic subtest: pipe-C-eDP-1-size-64
[629.565844] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.966s)
[629.603818] Starting dynamic subtest: pipe-C-eDP-1-size-128
[631.709486] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.114s)
[631.747905] Starting dynamic subtest: pipe-C-eDP-1-size-256
[633.865314] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.125s)
[634.197155] Starting dynamic subtest: pipe-D-eDP-1-size-64
[637.017903] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.832s)
[637.057162] Starting dynamic subtest: pipe-D-eDP-1-size-128
[639.117710] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.069s)
[639.154892] Starting dynamic subtest: pipe-D-eDP-1-size-256
[641.239087] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.091s)
[641.558366] Subtest viewport: SUCCESS (31.528s)
[642.432372] [125/133] (381s left) kms_psr (fbc-psr-sprite-blt)
[642.530877] Starting subtest: fbc-psr-sprite-blt
[642.533209] Starting dynamic subtest: eDP-1
[642.537344] Dynamic subtest eDP-1: SKIP (0.000s)
[642.541467] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[642.605067] [126/133] (381s left) syncobj_wait (wait-for-submit-delayed-submit)
[642.667485] Starting subtest: wait-for-submit-delayed-submit
[642.770919] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[642.859063] [127/133] (381s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[642.958857] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[642.961134] Starting dynamic subtest: pipe-A-eDP-1
[642.984093] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[642.995833] Starting dynamic subtest: pipe-B-eDP-1
[643.017582] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[643.026783] Starting dynamic subtest: pipe-C-eDP-1
[643.048567] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[643.057571] Starting dynamic subtest: pipe-D-eDP-1
[643.079609] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[643.083692] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[645.096157] [128/133] (378s left) kms_draw_crc (draw-method-mmap-wc)
[645.197458] Starting subtest: draw-method-mmap-wc
[645.199555] Starting dynamic subtest: xrgb8888-untiled
[645.418702] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s)
[645.427919] Starting dynamic subtest: rgb565-untiled
[645.630131] Dynamic subtest rgb565-untiled: SUCCESS (0.211s)
[645.646897] Starting dynamic subtest: xrgb2101010-untiled
[645.829984] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.197s)
[645.842248] Starting dynamic subtest: xbgr16161616f-untiled
[646.040791] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[646.049613] Starting dynamic subtest: xrgb8888-xtiled
[646.173961] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[646.184839] Starting dynamic subtest: rgb565-xtiled
[646.296473] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[646.307930] Starting dynamic subtest: xrgb2101010-xtiled
[646.429769] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.131s)
[646.441123] Starting dynamic subtest: xbgr16161616f-xtiled
[646.562944] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.131s)
[646.573121] Starting dynamic subtest: xrgb8888-4tiled
[646.718699] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[646.730250] Starting dynamic subtest: rgb565-4tiled
[646.863021] Dynamic subtest rgb565-4tiled: SUCCESS (0.142s)
[646.875061] Starting dynamic subtest: xrgb2101010-4tiled
[646.996844] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.131s)
[647.009749] Starting dynamic subtest: xbgr16161616f-4tiled
[647.163247] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.164s)
[647.165089] Subtest draw-method-mmap-wc: SUCCESS (1.969s)
[647.259060] [129/133] (376s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[647.346639] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[647.350100] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[647.442529] [130/133] (376s left) prime_mmap_coherency (read)
[647.497841] Starting subtest: read
[652.927120] Subtest read: SUCCESS (5.375s)
[653.009353] [131/133] (371s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[653.071154] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[653.127496] [132/133] (371s left) gem_exec_balancer (bonded-dual)
[653.189767] Starting subtest: bonded-dual
[653.194113] Subtest bonded-dual: SKIP (0.000s)
[653.512373] [133/133] (370s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[653.614695] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[653.618782] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[653.720048] Closing watchdogs
results: parsing output: 0/ for test: kms_selftest
results: parsing output: 1/ for test: gem_set_tiling_vs_blt
results: parsing output: 2/ for test: kms_flip_scaled_crc
results: parsing output: 3/ for test: prime_mmap
results: parsing output: 4/ for test: gem_render_copy
results: parsing output: 5/ for test: sysfs_heartbeat_interval
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: gem_ctx_param
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_pm_dc
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: kms_content_protection
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: fbdev
results: parsing output: 16/ for test: i915_query
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: gem_userptr_blits
results: parsing output: 21/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 22/ for test: kms_plane_scaling
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: perf
results: parsing output: 25/ for test: gen9_exec_parse
results: parsing output: 26/ for test: gem_ringfill
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: gem_userptr_blits
results: parsing output: 33/ for test: gem_mmap_gtt
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: kms_lease
results: parsing output: 37/ for test: core_auth
results: parsing output: 38/ for test: kms_getfb
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_pm_rpm
results: parsing output: 42/ for test: i915_pm_freq_mult
results: parsing output: 43/ for test: gem_ctx_shared
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: gem_ctx_freq
results: parsing output: 46/ for test: gem_create
results: parsing output: 47/ for test: vgem_basic
results: parsing output: 48/ for test: kms_async_flips
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_plane_alpha_blend
results: parsing output: 51/ for test: kms_joiner
results: parsing output: 52/ for test: kms_color
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_userptr_blits
results: parsing output: 56/ for test: gem_pxp
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_ctx_persistence
results: parsing output: 59/ for test: kms_chamelium_color
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: api_intel_bb
results: parsing output: 64/ for test: kms_vblank
results: parsing output: 65/ for test: gem_userptr_blits
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_plane
results: parsing output: 69/ for test: core_setmaster
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_setmode
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_getfb
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_rotation_crc
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_mmap_offset
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: prime_vgem
results: parsing output: 83/ for test: kms_psr2_sf
results: parsing output: 84/ for test: i915_module_load
results: parsing output: 85/ for test: testdisplay
results: parsing output: 86/ for test: gem_mmap_offset
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: prime_mmap_coherency
results: parsing output: 90/ for test: gem_userptr_blits
results: parsing output: 91/ for test: kms_chamelium_frames
results: parsing output: 92/ for test: kms_plane_scaling
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: gem_exec_whisper
results: parsing output: 95/ for test: kms_async_flips
results: parsing output: 96/ for test: kms_psr2_sf
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_properties
results: parsing output: 102/ for test: gem_exec_fence
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: gem_exec_params
results: parsing output: 105/ for test: kms_pipe_b_c_ivb
results: parsing output: 106/ for test: kms_flip_scaled_crc
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: gem_exec_create
results: parsing output: 110/ for test: kms_chamelium_hpd
results: parsing output: 111/ for test: gem_spin_batch
results: parsing output: 112/ for test: gem_exec_whisper
results: parsing output: 113/ for test: syncobj_wait
results: parsing output: 114/ for test: perf_pmu
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_cursor_edge_walk
results: parsing output: 119/ for test: syncobj_eventfd
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: i915_drm_fdinfo
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_plane_cursor
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: syncobj_wait
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: kms_draw_crc
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: prime_mmap_coherency
results: parsing output: 130/ for test: gem_exec_reloc
results: parsing output: 131/ for test: gem_exec_balancer
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.