[58.518839] Initializing watchdogs
[58.518915]   /dev/watchdog0
[58.537537] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[58.547297] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[58.550730] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.553237] [001/131] (960s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[58.626423] Starting subtest: framebuffer-vs-set-tiling
[58.628172] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[58.868764] [002/131] (960s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[59.067346] Starting subtest: modeset-transition-nonblocking-fencing
[59.068257] Starting dynamic subtest: 1x-outputs
[61.705112] Dynamic subtest 1x-outputs: SUCCESS (2.633s)
[61.767769] Subtest modeset-transition-nonblocking-fencing: SUCCESS (2.696s)
[62.023821] [003/131] (957s left) gem_exec_fence (basic-await)
[62.234266] Starting subtest: basic-await
[62.235212] Starting dynamic subtest: rcs0
[62.354950] Dynamic subtest rcs0: SUCCESS (0.120s)
[62.362232] Starting dynamic subtest: bcs0
[62.447175] Dynamic subtest bcs0: SUCCESS (0.092s)
[62.454929] Starting dynamic subtest: vcs0
[62.541117] Dynamic subtest vcs0: SUCCESS (0.093s)
[62.550494] Starting dynamic subtest: vcs1
[62.641622] Dynamic subtest vcs1: SUCCESS (0.100s)
[62.650127] Starting dynamic subtest: vecs0
[62.738430] Dynamic subtest vecs0: SUCCESS (0.096s)
[62.747279] Starting dynamic subtest: vecs1
[62.838582] Dynamic subtest vecs1: SUCCESS (0.100s)
[62.848064] Starting dynamic subtest: ccs0
[62.938287] Dynamic subtest ccs0: SUCCESS (0.099s)
[62.939322] Subtest basic-await: SUCCESS (0.703s)
[63.682144] [FACT gem_exec_fence (basic-await)] new: kernel.kmod_is_loaded.vgem: true
[63.684116] [004/131] (955s left) kms_flip (basic-plain-flip)
[63.892969] Starting subtest: basic-plain-flip
[63.896657] Starting dynamic subtest: A-DP3
[64.728069] Dynamic subtest A-DP3: SUCCESS (0.831s)
[64.737431] Starting dynamic subtest: B-DP3
[65.483058] Dynamic subtest B-DP3: SUCCESS (0.754s)
[65.491201] Starting dynamic subtest: C-DP3
[66.264127] Dynamic subtest C-DP3: SUCCESS (0.779s)
[66.291593] Starting dynamic subtest: D-DP3
[67.066382] Dynamic subtest D-DP3: SUCCESS (0.801s)
[67.068082] Subtest basic-plain-flip: SUCCESS (3.173s)
[67.817440] [005/131] (951s left) gem_exec_params (rs-invalid)
[67.901816] Starting subtest: rs-invalid
[67.904921] Subtest rs-invalid: SUCCESS (0.002s)
[68.087814] [006/131] (951s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[68.181624] Starting subtest: map-fixed-invalidate-overlap-busy
[68.183425] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[68.370651] [007/131] (951s left) kms_vblank (wait-idle-hang)
[68.579165] Starting subtest: wait-idle-hang
[68.581187] Starting dynamic subtest: pipe-A-DP-3
[94.618146] Dynamic subtest pipe-A-DP-3: SUCCESS (26.034s)
[94.627617] Starting dynamic subtest: pipe-D-DP-3
[119.546399] Dynamic subtest pipe-D-DP-3: SUCCESS (24.925s)
[119.547290] Subtest wait-idle-hang: SUCCESS (50.964s)
[119.788972] [008/131] (899s left) gem_ctx_shared (q-out-order)
[119.881908] Starting subtest: Q-out-order
[119.882849] Starting dynamic subtest: rcs0
[120.133130] Dynamic subtest rcs0: SUCCESS (0.251s)
[120.141503] Starting dynamic subtest: bcs0
[120.309400] Dynamic subtest bcs0: SUCCESS (0.176s)
[120.317701] Starting dynamic subtest: vcs0
[120.488180] Dynamic subtest vcs0: SUCCESS (0.179s)
[120.496418] Starting dynamic subtest: vcs1
[120.668232] Dynamic subtest vcs1: SUCCESS (0.180s)
[120.676381] Starting dynamic subtest: vecs0
[120.849197] Dynamic subtest vecs0: SUCCESS (0.181s)
[120.857329] Starting dynamic subtest: vecs1
[121.031740] Dynamic subtest vecs1: SUCCESS (0.183s)
[121.039826] Starting dynamic subtest: ccs0
[121.216027] Dynamic subtest ccs0: SUCCESS (0.184s)
[121.216918] Subtest Q-out-order: SUCCESS (1.334s)
[121.561815] [009/131] (898s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[121.777060] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[121.778868] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[121.897936] [010/131] (897s left) kms_flip (absolute-wf_vblank-interruptible)
[122.111209] Starting subtest: absolute-wf_vblank-interruptible
[122.115521] Starting dynamic subtest: A-DP3
[129.930129] Dynamic subtest A-DP3: SUCCESS (7.814s)
[129.938732] Starting dynamic subtest: B-DP3
[137.667326] Dynamic subtest B-DP3: SUCCESS (7.736s)
[137.678060] Starting dynamic subtest: C-DP3
[145.396894] Dynamic subtest C-DP3: SUCCESS (7.728s)
[145.405528] Starting dynamic subtest: D-DP3
[153.130493] Dynamic subtest D-DP3: SUCCESS (7.733s)
[153.132421] Subtest absolute-wf_vblank-interruptible: SUCCESS (31.020s)
[153.468646] [011/131] (866s left) dmabuf_sync_file (export-multiwait)
[153.535247] Starting subtest: export-multiwait
[153.536292] Subtest export-multiwait: SUCCESS (0.000s)
[153.647782] [012/131] (866s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[153.856165] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[153.857030] Starting dynamic subtest: pipe-A
[156.001631] Dynamic subtest pipe-A: SUCCESS (2.145s)
[156.017842] Starting dynamic subtest: pipe-B
[158.256202] Dynamic subtest pipe-B: SUCCESS (2.254s)
[158.270679] Starting dynamic subtest: pipe-C
[158.575596] Dynamic subtest pipe-C: SUCCESS (0.319s)
[158.590759] Starting dynamic subtest: pipe-D
[158.898881] Dynamic subtest pipe-D: SUCCESS (0.323s)
[158.900148] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.042s)
[159.253427] [013/131] (860s left) gem_softpin (full)
[159.334608] Starting subtest: full
[159.350413] Subtest full: SUCCESS (0.016s)
[159.534187] [014/131] (860s left) i915_getparams_basic (basic-subslice-total)
[159.612032] Starting subtest: basic-subslice-total
[159.614360] Subtest basic-subslice-total: SUCCESS (0.000s)
[159.756603] [015/131] (860s left) sysfs_timeslice_duration (timeout)
[159.842738] Starting subtest: timeout
[159.843903] Starting dynamic subtest: vecs0
[161.740310] Dynamic subtest vecs0: SUCCESS (1.896s)
[161.748958] Starting dynamic subtest: ccs0
[163.555188] Dynamic subtest ccs0: SUCCESS (1.815s)
[163.563258] Starting dynamic subtest: vcs0
[165.290400] Dynamic subtest vcs0: SUCCESS (1.735s)
[165.299415] Starting dynamic subtest: bcs0
[166.393246] Dynamic subtest bcs0: SUCCESS (1.102s)
[166.401722] Starting dynamic subtest: vecs1
[168.104203] Dynamic subtest vecs1: SUCCESS (1.710s)
[168.112176] Starting dynamic subtest: rcs0
[169.774182] Dynamic subtest rcs0: SUCCESS (1.670s)
[169.782156] Starting dynamic subtest: vcs1
[171.467266] Dynamic subtest vcs1: SUCCESS (1.693s)
[171.468462] Subtest timeout: SUCCESS (11.624s)
[171.612872] [016/131] (848s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[171.821303] Starting subtest: disable-crc-after-crtc
[171.823213] Starting dynamic subtest: pipe-A-DP-3
[172.527150] Dynamic subtest pipe-A-DP-3: SUCCESS (0.704s)
[172.539063] Starting dynamic subtest: pipe-B-DP-3
[173.141898] Dynamic subtest pipe-B-DP-3: SUCCESS (0.614s)
[173.151385] Starting dynamic subtest: pipe-C-DP-3
[173.746623] Dynamic subtest pipe-C-DP-3: SUCCESS (0.603s)
[173.755806] Starting dynamic subtest: pipe-D-DP-3
[174.372933] Dynamic subtest pipe-D-DP-3: SUCCESS (0.626s)
[174.373963] Subtest disable-crc-after-crtc: SUCCESS (2.551s)
[174.640319] [017/131] (845s left) gem_mmap_gtt (fault-concurrent-y)
[174.720397] Subtest fault-concurrent-Y: SKIP (0.000s)
[174.794294] [018/131] (845s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[175.006827] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[175.008523] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[175.142687] [019/131] (845s left) gem_userptr_blits (access-control)
[175.246567] Starting subtest: access-control
[175.248283] Subtest access-control: SKIP (0.000s)
[175.424354] [020/131] (844s left) gem_fence_thrash (bo-write-verify-x)
[175.473212] Starting subtest: bo-write-verify-x
[175.505162] Subtest bo-write-verify-x: SKIP (0.031s)
[175.581998] [021/131] (844s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[175.796200] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[175.797151] Starting dynamic subtest: pipe-A-DP-3
[176.374912] Dynamic subtest pipe-A-DP-3: SUCCESS (0.574s)
[176.382983] Starting dynamic subtest: pipe-B-DP-3
[177.061238] Dynamic subtest pipe-B-DP-3: SUCCESS (0.685s)
[177.069254] Starting dynamic subtest: pipe-C-DP-3
[177.749176] Dynamic subtest pipe-C-DP-3: SUCCESS (0.687s)
[177.757135] Starting dynamic subtest: pipe-D-DP-3
[178.438420] Dynamic subtest pipe-D-DP-3: SUCCESS (0.687s)
[178.439516] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SUCCESS (2.638s)
[178.738918] [022/131] (841s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[178.946197] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[178.947145] Starting dynamic subtest: pipe-A-DP-3
[178.955692] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[178.963441] Starting dynamic subtest: pipe-B-DP-3
[178.972143] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[178.979794] Starting dynamic subtest: pipe-C-DP-3
[178.988296] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[178.995888] Starting dynamic subtest: pipe-D-DP-3
[179.006566] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[179.008889] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s)
[179.393592] [023/131] (841s left) gem_exec_balancer (nop)
[179.482289] Starting subtest: nop
[228.742392] Subtest nop: SUCCESS (49.259s)
[229.150604] [024/131] (791s left) i915_pm_rpm (reg-read-ioctl)
[231.104572] Starting subtest: reg-read-ioctl
[231.898202] Subtest reg-read-ioctl: SUCCESS (0.793s)
[232.289927] [025/131] (788s left) kms_psr (pr-sprite-mmap-cpu)
[232.500556] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[232.557290] [026/131] (788s left) kms_psr (psr-basic)
[232.770552] Subtest psr-basic: SKIP (0.000s)
[232.824702] [027/131] (787s left) gem_ctx_isolation (dirty-switch)
[232.915208] Starting subtest: dirty-switch
[232.916176] Starting dynamic subtest: rcs0
[233.465889] Dynamic subtest rcs0: SUCCESS (0.551s)
[233.474028] Starting dynamic subtest: bcs0
[234.058889] Dynamic subtest bcs0: SUCCESS (0.593s)
[234.067123] Starting dynamic subtest: vcs0
[234.656189] Dynamic subtest vcs0: SUCCESS (0.597s)
[234.664557] Starting dynamic subtest: vcs1
[235.258934] Dynamic subtest vcs1: SUCCESS (0.602s)
[235.267037] Starting dynamic subtest: vecs0
[235.873817] Dynamic subtest vecs0: SUCCESS (0.614s)
[235.882033] Starting dynamic subtest: vecs1
[236.486474] Dynamic subtest vecs1: SUCCESS (0.612s)
[236.494529] Starting dynamic subtest: ccs0
[237.095302] Dynamic subtest ccs0: SUCCESS (0.608s)
[237.096271] Subtest dirty-switch: SUCCESS (4.181s)
[237.384533] [028/131] (783s left) gem_barrier_race (remote-request)
[237.467309] Starting subtest: remote-request
[237.468230] Starting dynamic subtest: rcs0
[242.765566] Dynamic subtest rcs0: SUCCESS (5.298s)
[242.766446] Subtest remote-request: SUCCESS (5.299s)
[242.982492] [029/131] (777s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[243.195368] Starting subtest: crc-primary-suspend-y-tiled-ccs
[243.196277] Starting dynamic subtest: pipe-A-DP-3
[243.199894] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[243.208173] Starting dynamic subtest: pipe-B-DP-3
[243.211483] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[243.219430] Starting dynamic subtest: pipe-C-DP-3
[243.223037] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[243.230876] Starting dynamic subtest: pipe-D-DP-3
[243.234271] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[243.235992] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[243.639117] [030/131] (777s left) gem_exec_schedule (semaphore-resolve)
[243.740007] Starting subtest: semaphore-resolve
[243.813727] Subtest semaphore-resolve: SUCCESS (0.074s)
[244.205974] [031/131] (776s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[244.414685] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[255.362698] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (10.947s)
[255.629721] [032/131] (765s left) syncobj_wait (invalid-signal-bad-pad)
[255.707656] Starting subtest: invalid-signal-bad-pad
[255.708669] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[255.874386] [033/131] (765s left) drm_read (invalid-buffer)
[256.157787] Starting subtest: invalid-buffer
[256.158715] Subtest invalid-buffer: SUCCESS (0.000s)
[256.411259] [034/131] (764s left) kms_rotation_crc (sprite-rotation-90)
[256.618301] Starting subtest: sprite-rotation-90
[256.620135] Subtest sprite-rotation-90: SKIP (0.001s)
[256.703212] [035/131] (764s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[256.914894] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[256.916593] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[257.044474] [036/131] (764s left) kms_atomic (crtc-invalid-params)
[257.255304] Starting subtest: crtc-invalid-params
[257.257354] Starting dynamic subtest: pipe-A-DP-3
[257.770238] Dynamic subtest pipe-A-DP-3: SUCCESS (0.513s)
[257.771448] Subtest crtc-invalid-params: SUCCESS (0.515s)
[258.059567] [037/131] (763s left) kms_panel_fitting (legacy)
[258.267310] Starting subtest: legacy
[258.269161] Subtest legacy: SKIP (0.000s)
[258.350608] [038/131] (763s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[258.560928] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[258.562729] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[258.689983] [039/131] (762s left) gem_exec_whisper (basic-fds-priority)
[258.780455] Starting subtest: basic-fds-priority
[281.161594] Subtest basic-fds-priority: SUCCESS (22.379s)
[281.415935] [040/131] (740s left) gem_exec_reloc (basic-write-read)
[281.499480] Subtest basic-write-read: SKIP (0.000s)
[281.561913] [041/131] (740s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[281.639521] Starting subtest: etime-multi-wait-available-unsubmitted
[281.742291] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.102s)
[281.873657] [042/131] (740s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc)
[282.083930] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc
[282.085729] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[282.235674] [043/131] (739s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[282.333431] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[282.335295] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[282.583925] [044/131] (739s left) kms_vblank (ts-continuation-idle)
[282.789274] Starting subtest: ts-continuation-idle
[282.791233] Starting dynamic subtest: pipe-A-DP-3
[283.123959] Dynamic subtest pipe-A-DP-3: SUCCESS (0.332s)
[283.148176] Starting dynamic subtest: pipe-D-DP-3
[283.404656] Dynamic subtest pipe-D-DP-3: SUCCESS (0.273s)
[283.405612] Subtest ts-continuation-idle: SUCCESS (0.615s)
[283.649580] [045/131] (738s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[283.867921] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[283.869673] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[283.997771] [046/131] (738s left) kms_content_protection (srm)
[284.260067] Starting subtest: srm
[284.296799] Starting dynamic subtest: pipe-A-DP-3
[406.963555] Dynamic subtest pipe-A-DP-3: FAIL (122.489s)
[406.964956] Subtest srm: FAIL (122.630s)
[407.179156] [047/131] (615s left) kms_plane (plane-position-covered)
[407.386320] Starting subtest: plane-position-covered
[407.818742] Starting dynamic subtest: pipe-A-plane-1
[408.286422] Dynamic subtest pipe-A-plane-1: SUCCESS (0.466s)
[408.303460] Starting dynamic subtest: pipe-A-plane-2
[408.754152] Dynamic subtest pipe-A-plane-2: SUCCESS (0.467s)
[408.762646] Starting dynamic subtest: pipe-A-plane-3
[409.201292] Dynamic subtest pipe-A-plane-3: SUCCESS (0.446s)
[409.215304] Starting dynamic subtest: pipe-A-plane-4
[409.667243] Dynamic subtest pipe-A-plane-4: SUCCESS (0.465s)
[409.675925] Starting dynamic subtest: pipe-A-plane-5
[409.683837] Dynamic subtest pipe-A-plane-5: SUCCESS (0.016s)
[410.047356] Starting dynamic subtest: pipe-B-plane-1
[410.462937] Dynamic subtest pipe-B-plane-1: SUCCESS (0.432s)
[410.472556] Starting dynamic subtest: pipe-B-plane-2
[410.905393] Dynamic subtest pipe-B-plane-2: SUCCESS (0.442s)
[410.914059] Starting dynamic subtest: pipe-B-plane-3
[411.365402] Dynamic subtest pipe-B-plane-3: SUCCESS (0.458s)
[411.374140] Starting dynamic subtest: pipe-B-plane-4
[411.804969] Dynamic subtest pipe-B-plane-4: SUCCESS (0.439s)
[411.813614] Starting dynamic subtest: pipe-B-plane-5
[411.821108] Dynamic subtest pipe-B-plane-5: SUCCESS (0.015s)
[411.821987] Subtest plane-position-covered: SUCCESS (4.434s)
[412.114126] [048/131] (610s left) kms_atomic_transition (plane-all-transition-fencing)
[412.321572] Starting subtest: plane-all-transition-fencing
[412.323532] Starting dynamic subtest: pipe-A-DP-3
[416.033828] Dynamic subtest pipe-A-DP-3: SUCCESS (3.710s)
[416.119334] Starting dynamic subtest: pipe-B-DP-3
[419.883824] Dynamic subtest pipe-B-DP-3: SUCCESS (3.775s)
[419.936798] Subtest plane-all-transition-fencing: SUCCESS (7.614s)
[420.212642] [049/131] (602s left) kms_pm_rpm (modeset-stress-extra-wait)
[422.071474] Starting subtest: modeset-stress-extra-wait
[474.202645] Subtest modeset-stress-extra-wait: SUCCESS (52.130s)
[474.328700] [050/131] (548s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[474.534504] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[474.536636] Starting dynamic subtest: pipe-A-valid-mode
[474.608035] Dynamic subtest pipe-A-valid-mode: SKIP (0.070s)
[474.609819] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.072s)
[474.820065] [051/131] (547s left) perf (whitelisted-registers-userspace-config)
[475.018445] Starting subtest: whitelisted-registers-userspace-config
[475.019425] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[475.074600] [052/131] (547s left) kms_busy (basic-hang)
[475.287444] Starting subtest: basic-hang
[475.289602] Starting dynamic subtest: flip-pipe-A
[475.846523] Dynamic subtest flip-pipe-A: SUCCESS (0.556s)
[475.866855] Starting dynamic subtest: modeset-pipe-A
[476.839054] Dynamic subtest modeset-pipe-A: SUCCESS (0.992s)
[476.860069] Starting dynamic subtest: flip-pipe-D
[477.357158] Dynamic subtest flip-pipe-D: SUCCESS (0.511s)
[477.371325] Starting dynamic subtest: modeset-pipe-D
[478.294431] Dynamic subtest modeset-pipe-D: SUCCESS (0.936s)
[478.295398] Subtest basic-hang: SUCCESS (3.007s)
[478.564329] [053/131] (544s left) kms_invalid_mode (int-max-clock)
[478.776145] Starting subtest: int-max-clock
[478.777080] Starting dynamic subtest: pipe-A-DP-3
[478.857862] Dynamic subtest pipe-A-DP-3: SUCCESS (0.080s)
[478.868929] Starting dynamic subtest: pipe-B-DP-3
[478.870144] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[478.880607] Starting dynamic subtest: pipe-C-DP-3
[478.881543] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[478.892167] Starting dynamic subtest: pipe-D-DP-3
[478.893180] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[478.894159] Subtest int-max-clock: SUCCESS (0.090s)
[479.094261] [054/131] (543s left) gem_exec_reloc (basic-gtt-wc-active)
[479.179487] Subtest basic-gtt-wc-active: SKIP (0.000s)
[479.268393] [055/131] (543s left) kms_psr (fbc-psr2-cursor-render)
[479.476981] Subtest fbc-psr2-cursor-render: SKIP (0.000s)
[479.531569] [056/131] (543s left) gem_exec_fence (basic-busy-all)
[479.619465] Starting subtest: basic-busy-all
[479.764936] Subtest basic-busy-all: SUCCESS (0.144s)
[480.657984] [057/131] (542s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[480.879821] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[480.930765] [058/131] (542s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[481.148155] Starting subtest: yf-tiled-8bpp-rotate-90
[481.149883] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[481.312036] [059/131] (541s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[481.519550] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[481.521884] Starting dynamic subtest: pipe-A-valid-mode
[483.906192] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.382s)
[483.908085] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.385s)
[484.179733] [060/131] (538s left) gem_exec_fence (syncobj-signal)
[484.658513] Starting subtest: syncobj-signal
[484.685275] Subtest syncobj-signal: SUCCESS (0.027s)
[485.109700] [061/131] (538s left) gem_exec_schedule (semaphore-noskip)
[485.207488] Starting subtest: semaphore-noskip
[485.947389] Subtest semaphore-noskip: SUCCESS (0.739s)
[486.304672] [062/131] (536s left) api_intel_allocator (alloc-simple)
[486.381447] Starting subtest: alloc-simple
[486.405496] Subtest alloc-simple: SUCCESS (0.024s)
[486.590761] [063/131] (536s left) api_intel_bb (reset-flags)
[486.668355] Starting subtest: reset-flags
[486.699961] Subtest reset-flags: SUCCESS (0.032s)
[486.905728] [064/131] (536s left) kms_pm_rpm (modeset-non-lpsp)
[489.050389] Starting subtest: modeset-non-lpsp
[489.613103] Subtest modeset-non-lpsp: SUCCESS (0.562s)
[489.837695] [065/131] (533s left) gem_exec_flush (basic-wb-prw-default)
[489.923210] Subtest basic-wb-prw-default: SKIP (0.000s)
[489.997314] [066/131] (533s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[490.090419] Starting subtest: yf-tiled-to-vebox-x-tiled
[490.092581] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[490.330274] [067/131] (533s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[490.542147] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[490.679632] [068/131] (532s left) gem_exec_reloc (basic-wc-read-active)
[490.767570] Subtest basic-wc-read-active: SKIP (0.000s)
[490.833120] [069/131] (532s left) syncobj_timeline (wait-all-interrupted)
[490.914438] Starting subtest: wait-all-interrupted
[491.017805] Subtest wait-all-interrupted: SUCCESS (0.102s)
[491.134461] [070/131] (532s left) kms_dsc (dsc-with-formats)
[491.346569] Starting subtest: dsc-with-formats
[491.362555] Subtest dsc-with-formats: SKIP (0.002s)
[491.441962] [071/131] (532s left) perf (short-reads)
[491.615503] Starting subtest: short-reads
[491.637584] Subtest short-reads: SUCCESS (0.022s)
[491.685770] [072/131] (532s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[491.892992] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[491.894853] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[492.032423] [073/131] (531s left) gem_exec_params (no-vebox)
[492.116640] Starting subtest: no-vebox
[492.118807] Subtest no-vebox: SUCCESS (0.002s)
[492.294947] [074/131] (531s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[492.513486] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[492.515749] Starting dynamic subtest: pipe-A-DP-3
[492.524285] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[492.533064] Starting dynamic subtest: pipe-B-DP-3
[492.541792] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[492.550484] Starting dynamic subtest: pipe-C-DP-3
[492.558891] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[492.567550] Starting dynamic subtest: pipe-D-DP-3
[492.578369] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[492.580416] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SKIP (0.006s)
[492.964771] [075/131] (531s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[493.170487] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[493.172643] Starting dynamic subtest: pipe-A-DP-3
[493.181165] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[493.190196] Starting dynamic subtest: pipe-B-DP-3
[493.198925] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[493.207748] Starting dynamic subtest: pipe-C-DP-3
[493.216059] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[493.224776] Starting dynamic subtest: pipe-D-DP-3
[493.234962] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[493.237140] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.006s)
[493.624961] [076/131] (530s left) gem_mmap_gtt (hang)
[493.705313] Subtest hang: SKIP (0.000s)
[493.782230] [077/131] (530s left) i915_module_load (reload-no-display)
[493.835179] Starting subtest: reload-no-display
[497.789642] Subtest reload-no-display: SUCCESS (3.955s)
[497.823683] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[497.824771] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[497.826962] [078/131] (526s left) kms_getfb (getfb2-accept-ccs)
[502.236981] Starting subtest: getfb2-accept-ccs
[502.237918] Subtest getfb2-accept-ccs: SUCCESS (0.000s)
[502.321420] [FACT kms_getfb (getfb2-accept-ccs)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[502.324441] [FACT kms_getfb (getfb2-accept-ccs)] new: kernel.kmod_is_loaded.amdgpu: true
[502.324563] [FACT kms_getfb (getfb2-accept-ccs)] new: kernel.kmod_is_loaded.i915: true
[502.325422] [FACT kms_getfb (getfb2-accept-ccs)] new: kernel.kmod_is_loaded.xe: true
[502.327627] [079/131] (521s left) kms_chamelium_color (ctm-0-75)
[502.549295] Subtest ctm-0-75: SKIP (0.000s)
[502.608414] [080/131] (521s left) kms_setmode (invalid-clone-single-crtc)
[502.695432] Starting subtest: invalid-clone-single-crtc
[502.698567] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[502.867362] [081/131] (521s left) syncobj_eventfd (binary-wait)
[502.950174] Starting subtest: binary-wait
[502.960290] Subtest binary-wait: SUCCESS (0.010s)
[503.066136] [082/131] (521s left) gem_exec_capture (userptr)
[503.162576] Starting subtest: userptr
[504.087809] Subtest userptr: SUCCESS (0.925s)
[504.226943] [083/131] (520s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[504.440198] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[504.441985] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[504.572163] [084/131] (520s left) kms_lease (lease-invalid-plane)
[504.781466] Starting subtest: lease-invalid-plane
[504.783615] Starting dynamic subtest: pipe-A-DP-3
[504.784499] Dynamic subtest pipe-A-DP-3: SUCCESS (0.000s)
[504.792919] Starting dynamic subtest: pipe-B-DP-3
[504.794233] Dynamic subtest pipe-B-DP-3: SUCCESS (0.000s)
[504.802151] Starting dynamic subtest: pipe-C-DP-3
[504.803214] Dynamic subtest pipe-C-DP-3: SUCCESS (0.000s)
[504.811131] Starting dynamic subtest: pipe-D-DP-3
[504.812142] Dynamic subtest pipe-D-DP-3: SUCCESS (0.000s)
[504.813380] Subtest lease-invalid-plane: SUCCESS (0.006s)
[504.881932] [085/131] (519s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[505.096234] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[505.098037] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[505.250502] [086/131] (519s left) api_intel_bb (crc32)
[505.330333] Starting subtest: crc32
[505.331243] Starting dynamic subtest: rcs0-lmem0
[505.599243] Dynamic subtest rcs0-lmem0: SUCCESS (0.267s)
[505.612823] Starting dynamic subtest: rcs0-smem0
[505.935330] Dynamic subtest rcs0-smem0: SUCCESS (0.332s)
[505.948079] Starting dynamic subtest: bcs0-lmem0
[506.198080] Dynamic subtest bcs0-lmem0: SUCCESS (0.258s)
[506.211836] Starting dynamic subtest: bcs0-smem0
[506.573359] Dynamic subtest bcs0-smem0: SUCCESS (0.371s)
[506.583702] Starting dynamic subtest: vcs0-lmem0
[506.961300] Dynamic subtest vcs0-lmem0: SUCCESS (0.383s)
[506.974882] Starting dynamic subtest: vcs0-smem0
[507.464313] Dynamic subtest vcs0-smem0: SUCCESS (0.501s)
[507.477232] Starting dynamic subtest: vcs1-lmem0
[507.852985] Dynamic subtest vcs1-lmem0: SUCCESS (0.384s)
[507.866777] Starting dynamic subtest: vcs1-smem0
[508.355193] Dynamic subtest vcs1-smem0: SUCCESS (0.498s)
[508.367324] Starting dynamic subtest: vecs0-lmem0
[508.743127] Dynamic subtest vecs0-lmem0: SUCCESS (0.384s)
[508.756794] Starting dynamic subtest: vecs0-smem0
[509.245288] Dynamic subtest vecs0-smem0: SUCCESS (0.498s)
[509.258168] Starting dynamic subtest: vecs1-lmem0
[509.635840] Dynamic subtest vecs1-lmem0: SUCCESS (0.386s)
[509.649726] Starting dynamic subtest: vecs1-smem0
[510.144543] Dynamic subtest vecs1-smem0: SUCCESS (0.505s)
[510.157662] Starting dynamic subtest: ccs0-lmem0
[510.427039] Dynamic subtest ccs0-lmem0: SUCCESS (0.278s)
[510.439459] Starting dynamic subtest: ccs0-smem0
[510.825604] Dynamic subtest ccs0-smem0: SUCCESS (0.394s)
[510.827745] Subtest crc32: SUCCESS (5.496s)
[510.967898] [087/131] (513s left) kms_rotation_crc (multiplane-rotation)
[511.176522] Starting subtest: multiplane-rotation
[522.824081] Subtest multiplane-rotation: SUCCESS (11.646s)
[523.050055] [088/131] (501s left) kms_big_fb (linear-32bpp-rotate-270)
[523.268437] Starting subtest: linear-32bpp-rotate-270
[523.321244] Subtest linear-32bpp-rotate-270: SKIP (0.052s)
[523.530995] [089/131] (501s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[523.743853] Starting subtest: fbcpsr-stridechange
[523.745785] Subtest fbcpsr-stridechange: SKIP (0.000s)
[523.868562] [090/131] (501s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[524.081893] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[524.083611] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[524.228592] [091/131] (500s left) syncobj_wait (wait-all-delayed-signal)
[524.309197] Starting subtest: wait-all-delayed-signal
[524.412264] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[524.524910] [092/131] (500s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[524.736554] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[524.793528] [093/131] (500s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[525.006500] Starting subtest: 2x-flip-vs-rmfb-interruptible
[525.021871] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.014s)
[525.125209] [094/131] (500s left) gem_userptr_blits (vma-merge)
[525.227114] Starting subtest: vma-merge
[525.310422] Subtest vma-merge: SUCCESS (0.083s)
[525.460704] [095/131] (499s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[525.672044] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[525.673777] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[525.800220] [096/131] (499s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-25)
[526.006508] Starting subtest: planes-upscale-20x20-downscale-factor-0-25
[526.007435] Starting dynamic subtest: pipe-A
[526.792906] Dynamic subtest pipe-A: SKIP (0.784s)
[526.801278] Starting dynamic subtest: pipe-B
[527.964894] Dynamic subtest pipe-B: SKIP (1.172s)
[527.973126] Starting dynamic subtest: pipe-C
[529.138466] Dynamic subtest pipe-C: SKIP (1.172s)
[529.146666] Starting dynamic subtest: pipe-D
[530.309805] Dynamic subtest pipe-D: SKIP (1.171s)
[530.311300] Subtest planes-upscale-20x20-downscale-factor-0-25: SKIP (4.302s)
[530.433031] [097/131] (494s left) kms_cursor_crc (cursor-sliding-128x128)
[530.782945] Starting subtest: cursor-sliding-128x128
[530.787435] Starting dynamic subtest: pipe-A-DP-3
[535.137201] Dynamic subtest pipe-A-DP-3: SUCCESS (4.349s)
[535.179954] Starting dynamic subtest: pipe-D-DP-3
[539.365393] Dynamic subtest pipe-D-DP-3: SUCCESS (4.192s)
[539.366341] Subtest cursor-sliding-128x128: SUCCESS (8.582s)
[539.801189] [098/131] (485s left) gem_mmap_offset (ptrace)
[539.881412] Starting subtest: ptrace
[539.885656] Starting dynamic subtest: lmem0-fixed
[539.998797] Dynamic subtest lmem0-fixed: SUCCESS (0.113s)
[540.009280] Starting dynamic subtest: smem0-fixed
[540.019273] Dynamic subtest smem0-fixed: SUCCESS (0.018s)
[540.020207] Subtest ptrace: SUCCESS (0.139s)
[540.186111] [099/131] (485s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[540.396040] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[540.397918] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[540.523061] [100/131] (485s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[540.746473] Starting subtest: y-tiled-32bpp-rotate-90
[540.748134] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[540.922473] [101/131] (484s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[541.136348] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[541.151422] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.014s)
[541.240940] [102/131] (484s left) gem_exec_flush (basic-batch-kernel-default-wb)
[541.325410] Subtest basic-batch-kernel-default-wb: SKIP (0.000s)
[541.401564] [103/131] (484s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[541.616541] Starting subtest: x-tiled-64bpp-rotate-270
[541.677154] Subtest x-tiled-64bpp-rotate-270: SKIP (0.060s)
[541.887261] [104/131] (483s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[542.101060] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[542.102916] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[542.253447] [105/131] (483s left) kms_3d
[544.527985] [106/131] (481s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[544.610950] Starting subtest: multi-wait-all-for-submit-available-submitted
[544.611880] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[544.749543] [107/131] (481s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[544.960056] Starting subtest: fbc-modesetfrombusy
[546.274376] Subtest fbc-modesetfrombusy: SUCCESS (1.315s)
[546.475120] [108/131] (479s left) kms_cursor_crc (cursor-random-64x21)
[546.798457] Starting subtest: cursor-random-64x21
[546.803458] Starting dynamic subtest: pipe-A-DP-3
[551.126926] Dynamic subtest pipe-A-DP-3: SUCCESS (4.322s)
[551.176359] Starting dynamic subtest: pipe-D-DP-3
[555.546858] Dynamic subtest pipe-D-DP-3: SUCCESS (4.378s)
[555.547970] Subtest cursor-random-64x21: SUCCESS (8.749s)
[555.976317] [109/131] (470s left) gem_flink_basic (basic)
[556.058433] Starting subtest: basic
[556.059332] Subtest basic: SUCCESS (0.000s)
[556.221927] [110/131] (470s left) fbdev (nullptr)
[556.288174] Starting subtest: nullptr
[556.289165] Subtest nullptr: SUCCESS (0.000s)
[556.370041] [111/131] (469s left) kms_psr (fbc-psr2-basic)
[556.575263] Subtest fbc-psr2-basic: SKIP (0.000s)
[556.627758] [112/131] (469s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[556.836526] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[556.838729] Starting dynamic subtest: pipe-A-valid-mode
[556.915022] Dynamic subtest pipe-A-valid-mode: SKIP (0.075s)
[556.916960] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.077s)
[557.181766] [113/131] (469s left) gem_workarounds (reset)
[557.277126] Starting subtest: reset
[557.564483] Subtest reset: SUCCESS (0.287s)
[557.722854] [114/131] (468s left) kms_flip (2x-plain-flip-interruptible)
[557.937443] Starting subtest: 2x-plain-flip-interruptible
[557.952512] Subtest 2x-plain-flip-interruptible: SKIP (0.014s)
[558.065095] [115/131] (468s left) kms_addfb_basic (clobberred-modifier)
[558.149343] Starting subtest: clobberred-modifier
[558.151167] Subtest clobberred-modifier: SKIP (0.000s)
[558.404960] [116/131] (468s left) kms_chamelium_frames (hdmi-aspect-ratio)
[558.682494] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[558.842480] [117/131] (467s left) gem_pxp (create-regular-buffer)
[561.448950] Starting subtest: create-regular-buffer
[561.451348] Subtest create-regular-buffer: SKIP (0.000s)
[561.550998] [118/131] (465s left) gem_mmap_wc (coherency)
[561.630398] Subtest coherency: SKIP (0.000s)
[561.691907] [119/131] (465s left) prime_busy (after)
[561.779077] Starting subtest: after
[561.785517] Starting dynamic subtest: rcs0
[561.824177] Dynamic subtest rcs0: SUCCESS (0.039s)
[561.833920] Starting dynamic subtest: bcs0
[561.886443] Dynamic subtest bcs0: SUCCESS (0.061s)
[561.909038] Starting dynamic subtest: vcs0
[561.927457] Dynamic subtest vcs0: SUCCESS (0.039s)
[561.951119] Starting dynamic subtest: vcs1
[561.967698] Dynamic subtest vcs1: SUCCESS (0.038s)
[561.984799] Starting dynamic subtest: vecs0
[562.007863] Dynamic subtest vecs0: SUCCESS (0.039s)
[562.025049] Starting dynamic subtest: vecs1
[562.049043] Dynamic subtest vecs1: SUCCESS (0.040s)
[562.066075] Starting dynamic subtest: ccs0
[562.089077] Dynamic subtest ccs0: SUCCESS (0.039s)
[562.208116] Subtest after: SUCCESS (0.419s)
[562.335596] [120/131] (464s left) kms_psr (pr-cursor-blt)
[562.545313] Subtest pr-cursor-blt: SKIP (0.000s)
[562.609923] [121/131] (464s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[562.687977] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[562.688934] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[562.873122] [122/131] (464s left) gem_lmem_swapping (parallel-multi)
[565.706555] Starting subtest: parallel-multi
[565.707713] Starting dynamic subtest: lmem0
[622.553718] Dynamic subtest lmem0: SUCCESS (56.845s)
[622.554878] Subtest parallel-multi: SUCCESS (56.846s)
[623.940499] [FACT gem_lmem_swapping (parallel-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[623.941585] [FACT gem_lmem_swapping (parallel-multi)] deleted: kernel.kmod_is_loaded.i915: true
[623.943654] [123/131] (403s left) kms_color (ctm-blue-to-red)
[625.632653] Starting subtest: ctm-blue-to-red
[625.633657] Starting dynamic subtest: pipe-A-DP-3
[626.336082] Dynamic subtest pipe-A-DP-3: SUCCESS (0.702s)
[626.357733] Starting dynamic subtest: pipe-B-DP-3
[626.926668] Dynamic subtest pipe-B-DP-3: SUCCESS (0.588s)
[626.941663] Starting dynamic subtest: pipe-C-DP-3
[627.551223] Dynamic subtest pipe-C-DP-3: SUCCESS (0.624s)
[627.570484] Starting dynamic subtest: pipe-D-DP-3
[628.194246] Dynamic subtest pipe-D-DP-3: SUCCESS (0.641s)
[628.195172] Subtest ctm-blue-to-red: SUCCESS (2.562s)
[628.421477] [FACT kms_color (ctm-blue-to-red)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[628.425197] [FACT kms_color (ctm-blue-to-red)] new: kernel.kmod_is_loaded.i915: true
[628.427902] [124/131] (398s left) perf (gen12-unprivileged-single-ctx-counters)
[628.777283] Starting subtest: gen12-unprivileged-single-ctx-counters
[628.778202] Starting dynamic subtest: rcs0
[628.882140] Dynamic subtest rcs0: SUCCESS (0.104s)
[628.883145] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.105s)
[628.934820] [125/131] (398s left) syncobj_timeline (host-signal-ordered)
[629.036920] Starting subtest: host-signal-ordered
[629.037984] Subtest host-signal-ordered: SUCCESS (0.000s)
[629.203229] [126/131] (398s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[629.423139] Starting subtest: x-tiled-64bpp-rotate-90
[629.474186] Subtest x-tiled-64bpp-rotate-90: SKIP (0.050s)
[629.658861] [127/131] (397s left) gem_exec_balancer (bonded-sync)
[629.752152] Starting subtest: bonded-sync
[629.754019] Subtest bonded-sync: SKIP (0.000s)
[630.135070] [128/131] (397s left) gem_mmap_gtt (coherency)
[630.214605] Subtest coherency: SKIP (0.000s)
[630.282632] [129/131] (397s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[630.493935] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[630.495784] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[630.621513] [130/131] (396s left) kms_cursor_edge_walk (256x256-top-bottom)
[630.827781] Starting subtest: 256x256-top-bottom
[630.830161] Starting dynamic subtest: pipe-A-DP-3
[634.301673] Dynamic subtest pipe-A-DP-3: SUCCESS (3.472s)
[634.312997] Starting dynamic subtest: pipe-D-DP-3
[637.627017] Dynamic subtest pipe-D-DP-3: SUCCESS (3.324s)
[637.628084] Subtest 256x256-top-bottom: SUCCESS (6.800s)
[637.892684] [131/131] (389s left) gem_ctx_persistence (hostile)
[637.976514] Starting subtest: hostile
[647.483667] Subtest hostile: SUCCESS (9.503s)
[647.608058] Closing watchdogs
results: parsing output: 0/ for test: kms_addfb_basic
results: parsing output: 1/ for test: kms_atomic_transition
results: parsing output: 2/ for test: gem_exec_fence
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: gem_exec_params
results: parsing output: 5/ for test: gem_userptr_blits
results: parsing output: 6/ for test: kms_vblank
results: parsing output: 7/ for test: gem_ctx_shared
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: dmabuf_sync_file
results: parsing output: 11/ for test: kms_plane_scaling
results: parsing output: 12/ for test: gem_softpin
results: parsing output: 13/ for test: i915_getparams_basic
results: parsing output: 14/ for test: sysfs_timeslice_duration
results: parsing output: 15/ for test: kms_pipe_crc_basic
results: parsing output: 16/ for test: gem_mmap_gtt
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_userptr_blits
results: parsing output: 19/ for test: gem_fence_thrash
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: gem_exec_balancer
results: parsing output: 23/ for test: i915_pm_rpm
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: gem_ctx_isolation
results: parsing output: 27/ for test: gem_barrier_race
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: syncobj_wait
results: parsing output: 32/ for test: drm_read
results: parsing output: 33/ for test: kms_rotation_crc
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_atomic
results: parsing output: 36/ for test: kms_panel_fitting
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_exec_whisper
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_render_copy
results: parsing output: 43/ for test: kms_vblank
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_content_protection
results: parsing output: 46/ for test: kms_plane
results: parsing output: 47/ for test: kms_atomic_transition
results: parsing output: 48/ for test: kms_pm_rpm
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: perf
results: parsing output: 51/ for test: kms_busy
results: parsing output: 52/ for test: kms_invalid_mode
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_exec_fence
results: parsing output: 56/ for test: kms_psr2_sf
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_flip_scaled_crc
results: parsing output: 59/ for test: gem_exec_fence
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: api_intel_allocator
results: parsing output: 62/ for test: api_intel_bb
results: parsing output: 63/ for test: kms_pm_rpm
results: parsing output: 64/ for test: gem_exec_flush
results: parsing output: 65/ for test: gem_render_copy
results: parsing output: 66/ for test: kms_addfb_basic
results: parsing output: 67/ for test: gem_exec_reloc
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_dsc
results: parsing output: 70/ for test: perf
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_exec_params
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: gem_mmap_gtt
results: parsing output: 76/ for test: i915_module_load
results: parsing output: 77/ for test: kms_getfb
results: parsing output: 78/ for test: kms_chamelium_color
results: parsing output: 79/ for test: kms_setmode
results: parsing output: 80/ for test: syncobj_eventfd
results: parsing output: 81/ for test: gem_exec_capture
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_lease
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: api_intel_bb
results: parsing output: 86/ for test: kms_rotation_crc
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: gem_userptr_blits
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_plane_scaling
results: parsing output: 96/ for test: kms_cursor_crc
results: parsing output: 97/ for test: gem_mmap_offset
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: gem_exec_flush
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_3d
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_cursor_crc
results: parsing output: 108/ for test: gem_flink_basic
results: parsing output: 109/ for test: fbdev
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: kms_flip_scaled_crc
results: parsing output: 112/ for test: gem_workarounds
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: kms_addfb_basic
results: parsing output: 115/ for test: kms_chamelium_frames
results: parsing output: 116/ for test: gem_pxp
results: parsing output: 117/ for test: gem_mmap_wc
results: parsing output: 118/ for test: prime_busy
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: gem_lmem_swapping
results: parsing output: 122/ for test: kms_color
results: parsing output: 123/ for test: perf
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: gem_exec_balancer
results: parsing output: 127/ for test: gem_mmap_gtt
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_cursor_edge_walk
results: parsing output: 130/ for test: gem_ctx_persistence
Done.