[58.896626] Initializing watchdogs
[58.896672]   /dev/watchdog0
[58.911276] [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.915686] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.918072] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.921549] [001/131] (960s left) gem_exec_fence (syncobj-timeline-unused-fence)
[59.515073] Starting subtest: syncobj-timeline-unused-fence
[59.523769] Subtest syncobj-timeline-unused-fence: SUCCESS (0.010s)
[60.967396] [FACT gem_exec_fence (syncobj-timeline-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[60.970507] [002/131] (958s left) gem_mmap_gtt (hang)
[61.030112] Subtest hang: SKIP (0.000s)
[61.087856] [003/131] (958s left) gem_exec_alignment (single)
[61.145780] Starting subtest: single
[61.153605] Subtest single: SUCCESS (0.008s)
[61.299965] [004/131] (958s left) kms_invalid_mode (bad-vsync-start)
[61.404795] Starting subtest: bad-vsync-start
[61.407089] Starting dynamic subtest: pipe-A-eDP-1
[61.688154] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[61.696516] Starting dynamic subtest: pipe-B-eDP-1
[61.698782] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[61.705627] Starting dynamic subtest: pipe-C-eDP-1
[61.707918] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[61.714800] Starting dynamic subtest: pipe-D-eDP-1
[61.716772] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[61.718718] Subtest bad-vsync-start: SUCCESS (0.290s)
[62.597052] [005/131] (956s left) gem_ctx_isolation (clean)
[62.658983] Starting subtest: clean
[62.661117] Starting dynamic subtest: rcs0
[62.725594] Dynamic subtest rcs0: SUCCESS (0.069s)
[62.735133] Starting dynamic subtest: bcs0
[62.816565] Dynamic subtest bcs0: SUCCESS (0.091s)
[62.824556] Starting dynamic subtest: vcs0
[62.911421] Dynamic subtest vcs0: SUCCESS (0.094s)
[62.920263] Starting dynamic subtest: vcs1
[64.946834] Dynamic subtest vcs1: SUCCESS (2.034s)
[64.955300] Starting dynamic subtest: vecs0
[66.918955] Dynamic subtest vecs0: SUCCESS (1.970s)
[66.928047] Starting dynamic subtest: ccs0
[68.938920] Dynamic subtest ccs0: SUCCESS (2.018s)
[68.941397] Subtest clean: SUCCESS (6.278s)
[69.217308] [006/131] (950s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[69.341954] Starting subtest: 2x-flip-vs-cursor-atomic
[69.346228] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[69.508019] [007/131] (950s left) gem_exec_schedule (u-submit-late-slice)
[69.581826] Starting subtest: u-submit-late-slice
[69.584080] Starting dynamic subtest: rcs0
[69.608115] Dynamic subtest rcs0: SUCCESS (0.034s)
[69.615824] Starting dynamic subtest: bcs0
[69.634986] Dynamic subtest bcs0: SUCCESS (0.027s)
[69.641971] Starting dynamic subtest: vcs0
[69.664284] Dynamic subtest vcs0: SUCCESS (0.029s)
[69.671469] Starting dynamic subtest: vcs1
[69.691721] Dynamic subtest vcs1: SUCCESS (0.027s)
[69.698621] Starting dynamic subtest: vecs0
[69.718973] Dynamic subtest vecs0: SUCCESS (0.027s)
[69.725935] Starting dynamic subtest: ccs0
[69.746455] Dynamic subtest ccs0: SUCCESS (0.027s)
[69.748677] Subtest u-submit-late-slice: SUCCESS (0.173s)
[71.074031] [008/131] (948s left) kms_getfb (getfb-handle-closed)
[71.180867] Starting subtest: getfb-handle-closed
[71.183232] Subtest getfb-handle-closed: SUCCESS (0.000s)
[71.315699] [009/131] (948s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[71.414929] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[71.417275] Starting dynamic subtest: pipe-A-eDP-1
[71.426723] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[71.435951] Starting dynamic subtest: pipe-B-eDP-1
[71.445186] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[71.452554] Starting dynamic subtest: pipe-C-eDP-1
[71.460728] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[71.467191] Starting dynamic subtest: pipe-D-eDP-1
[71.475585] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[71.479702] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[73.753852] [010/131] (946s left) gem_exec_capture (capture-recoverable)
[73.810389] Starting subtest: capture-recoverable
[73.812813] Subtest capture-recoverable: SUCCESS (0.003s)
[73.972818] [011/131] (945s left) kms_psr (fbc-pr-suspend)
[74.066144] Starting subtest: fbc-pr-suspend
[74.070271] Subtest fbc-pr-suspend: SKIP (0.000s)
[74.160955] [012/131] (945s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[74.248678] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[74.251020] Starting dynamic subtest: pipe-A-eDP-1
[75.137990] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.882s)
[75.146442] Starting dynamic subtest: pipe-B-eDP-1
[76.686834] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.545s)
[76.695895] Starting dynamic subtest: pipe-C-eDP-1
[78.156581] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.468s)
[78.165290] Starting dynamic subtest: pipe-D-eDP-1
[79.729481] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.574s)
[79.731458] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.472s)
[80.982232] [013/131] (938s left) perf (non-zero-reason)
[81.128060] Starting subtest: non-zero-reason
[81.130220] Starting dynamic subtest: 0-rcs0
[86.492687] Dynamic subtest 0-rcs0: SUCCESS (5.363s)
[86.503331] Starting dynamic subtest: 1-vecs0
[90.392110] Dynamic subtest 1-vecs0: SUCCESS (3.898s)
[90.395190] Subtest non-zero-reason: SUCCESS (9.262s)
[90.433672] [014/131] (929s left) sw_sync (alloc_timeline)
[90.472248] Starting subtest: alloc_timeline
[90.474594] Subtest alloc_timeline: SUCCESS (0.000s)
[90.556342] [015/131] (929s left) dmabuf_sync_file (export-wait-after-attach)
[90.597958] Starting subtest: export-wait-after-attach
[90.600337] Subtest export-wait-after-attach: SUCCESS (0.001s)
[90.678553] [016/131] (929s left) gem_exec_whisper (basic-sync-all)
[90.728852] Starting subtest: basic-sync-all
[97.740600] Subtest basic-sync-all: SUCCESS (7.011s)
[97.946358] [017/131] (922s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[98.068489] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[98.073101] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[98.199534] [018/131] (921s left) kms_tv_load_detect (load-detect)
[98.254701] Subtest load-detect: SKIP (0.000s)
[98.315617] [019/131] (921s left) vgem_basic (dmabuf-export)
[98.358451] Starting subtest: dmabuf-export
[98.394959] Subtest dmabuf-export: SUCCESS (0.038s)
[98.521159] [020/131] (921s left) kms_addfb_basic (small-bo)
[98.606935] Starting subtest: small-bo
[98.609118] Subtest small-bo: SUCCESS (0.000s)
[98.762606] [021/131] (921s left) kms_setmode (invalid-clone-single-crtc)
[98.828026] Starting subtest: invalid-clone-single-crtc
[98.834425] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[98.957833] [022/131] (921s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[99.061147] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[106.378350] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.319s)
[106.518794] [023/131] (913s left) gem_blits (basic)
[106.579659] Starting subtest: basic
[107.965415] Subtest basic: SUCCESS (1.386s)
[108.125831] [024/131] (912s left) kms_cdclk (mode-transition)
[108.223066] Starting subtest: mode-transition
[108.225514] Starting dynamic subtest: pipe-A-eDP-1
[108.510293] Dynamic subtest pipe-A-eDP-1: SKIP (0.284s)
[108.519071] Starting dynamic subtest: pipe-B-eDP-1
[108.523671] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[108.531060] Starting dynamic subtest: pipe-C-eDP-1
[108.535431] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[108.542557] Starting dynamic subtest: pipe-D-eDP-1
[108.546634] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[108.550681] Subtest mode-transition: SKIP (0.290s)
[109.334763] [025/131] (911s left) kms_content_protection (atomic)
[109.487693] Starting subtest: atomic
[109.491725] Subtest atomic: SKIP (0.000s)
[109.645257] [026/131] (910s left) gem_exec_balancer (bonded-false-hang)
[109.909735] Starting subtest: bonded-false-hang
[109.914747] Subtest bonded-false-hang: SKIP (0.000s)
[110.041130] [027/131] (910s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[110.147531] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[110.158737] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[110.288937] [028/131] (910s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[110.376806] Starting subtest: plane-upscale-20x20-with-pixel-format
[110.379141] Starting dynamic subtest: pipe-A
[111.426794] Dynamic subtest pipe-A: SUCCESS (1.050s)
[111.434097] Starting dynamic subtest: pipe-B
[113.539772] Dynamic subtest pipe-B: SUCCESS (2.111s)
[113.548021] Starting dynamic subtest: pipe-C
[114.736799] Dynamic subtest pipe-C: SUCCESS (1.196s)
[114.744528] Starting dynamic subtest: pipe-D
[115.965583] Dynamic subtest pipe-D: SUCCESS (1.227s)
[115.967987] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.588s)
[117.178771] [029/131] (903s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[117.289159] Starting subtest: y-tiled-16bpp-rotate-180
[117.293898] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[117.420801] [030/131] (903s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[117.535945] Starting subtest: x-tiled-8bpp-rotate-180
[118.760153] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.224s)
[118.925315] [031/131] (901s left) kms_psr (psr2-dpms)
[119.011338] Starting subtest: psr2-dpms
[119.013253] Starting dynamic subtest: eDP-1
[122.001630] Dynamic subtest eDP-1: SUCCESS (2.989s)
[122.003986] Subtest psr2-dpms: SUCCESS (2.990s)
[122.888694] [032/131] (897s left) kms_plane_alpha_blend (constant-alpha-mid)
[122.991707] Starting subtest: constant-alpha-mid
[123.271404] Starting dynamic subtest: pipe-A-eDP-1
[124.070304] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.796s)
[124.078965] Starting dynamic subtest: pipe-D-eDP-1
[125.532295] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.461s)
[125.534507] Subtest constant-alpha-mid: SUCCESS (2.542s)
[126.376276] [033/131] (894s left) i915_suspend (sysfs-reader)
[126.451431] Starting subtest: sysfs-reader