[63.943843] Initializing watchdogs
[63.943905]   /dev/watchdog0
[63.964288] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[63.974680] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.978547] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.980895] [001/134] (960s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[64.059414] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[64.165025] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[64.317269] [002/134] (960s left) gem_exec_create (madvise)
[64.401990] Starting subtest: madvise
[64.402948] Starting dynamic subtest: smem
[84.539912] Dynamic subtest smem: SUCCESS (20.138s)
[84.548131] Starting dynamic subtest: lmem0
[104.840203] Dynamic subtest lmem0: SUCCESS (20.300s)
[104.841172] Subtest madvise: SUCCESS (40.439s)
[105.923549] [003/134] (918s left) kms_psr (pr-primary-mmap-cpu)
[107.427393] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[107.482498] [004/134] (917s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[108.981046] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[108.984193] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[109.137182] [005/134] (915s left) gem_mmap_gtt (big-bo-tiledy)
[109.241970] Subtest big-bo-tiledY: SKIP (0.000s)
[109.322195] [006/134] (915s left) gem_userptr_blits (process-exit)
[109.401951] Starting subtest: process-exit
[109.410513] Subtest process-exit: SUCCESS (0.009s)
[109.627670] [007/134] (915s left) i915_suspend (basic-s2idle-without-i915)
[109.669506] Starting subtest: basic-s2idle-without-i915
[130.848911] Subtest basic-s2idle-without-i915: SUCCESS (5.645s)
[132.971440] [008/134] (893s left) kms_hdr (bpc-switch)
[134.473318] Starting subtest: bpc-switch
[134.476072] Subtest bpc-switch: SKIP (0.000s)
[134.630592] [009/134] (892s left) gem_softpin (full)
[134.745068] Starting subtest: full
[134.766576] Subtest full: SUCCESS (0.022s)
[134.991250] [010/134] (892s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[136.491433] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[136.492325] Starting dynamic subtest: pipe-A-HDMI-A-3
[136.500392] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[136.509091] Starting dynamic subtest: pipe-B-HDMI-A-3
[136.517723] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[136.526936] Starting dynamic subtest: pipe-C-HDMI-A-3
[136.535093] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[136.545134] Starting dynamic subtest: pipe-D-HDMI-A-3
[136.555479] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[136.557155] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SKIP (0.004s)
[136.806249] [011/134] (890s left) kms_psr (fbc-psr-cursor-blt)
[138.310651] Subtest fbc-psr-cursor-blt: SKIP (0.000s)
[138.359036] [012/134] (888s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[139.870467] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[139.872323] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[140.085485] [013/134] (887s left) gem_lmem_swapping (verify-random)
[144.552909] Starting subtest: verify-random
[144.553703] Starting dynamic subtest: lmem0
[152.819752] Dynamic subtest lmem0: SUCCESS (8.266s)
[152.820643] Subtest verify-random: SUCCESS (8.267s)
[153.854563] [FACT gem_lmem_swapping (verify-random)] deleted: kernel.kmod_is_loaded.i915: true
[153.856103] [014/134] (873s left) prime_vgem (coherency-blt)
[157.334959] Starting subtest: coherency-blt
[159.608396] Subtest coherency-blt: SUCCESS (2.273s)
[159.745504] [FACT prime_vgem (coherency-blt)] changed: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 -> card1
[159.748081] [FACT prime_vgem (coherency-blt)] new: kernel.kmod_is_loaded.i915: true
[159.748652] [FACT prime_vgem (coherency-blt)] new: kernel.kmod_is_loaded.vgem: true
[159.750548] [015/134] (867s left) kms_flip_scaled_crc (flip-32bpp-linear-to-32bpp-linear-reflect-x)
[161.261210] Starting subtest: flip-32bpp-linear-to-32bpp-linear-reflect-x
[161.262110] Starting dynamic subtest: pipe-A-valid-mode
[161.561084] Dynamic subtest pipe-A-valid-mode: SKIP (0.297s)
[161.563826] Subtest flip-32bpp-linear-to-32bpp-linear-reflect-x: SKIP (0.298s)
[161.847106] [016/134] (865s left) syncobj_wait (reset-signaled)
[161.922045] Starting subtest: reset-signaled
[161.922913] Subtest reset-signaled: SUCCESS (0.000s)
[162.093501] [017/134] (865s left) gem_exec_whisper (basic-contexts-forked)
[162.186132] Starting subtest: basic-contexts-forked
[184.788590] Subtest basic-contexts-forked: SUCCESS (22.599s)
[185.034649] [018/134] (842s left) gem_pxp (reject-modify-context-protection-off-1)
[187.636019] Starting subtest: reject-modify-context-protection-off-1
[187.638908] Subtest reject-modify-context-protection-off-1: SKIP (0.000s)
[187.770643] [019/134] (839s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[189.285735] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[189.287392] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[189.494117] [020/134] (838s left) kms_chamelium_frames (hdmi-crc-single)
[191.053408] Subtest hdmi-crc-single: SKIP (0.000s)
[191.150212] [021/134] (836s left) i915_pm_freq_api (freq-basic-api)
[191.242769] Starting subtest: freq-basic-api
[191.243678] Starting dynamic subtest: gt0
[191.246397] Dynamic subtest gt0: SUCCESS (0.004s)
[191.247340] Subtest freq-basic-api: SUCCESS (0.004s)
[191.368107] [022/134] (836s left) syncobj_wait (single-wait-all-submitted)
[191.443516] Starting subtest: single-wait-all-submitted
[191.546166] Subtest single-wait-all-submitted: SUCCESS (0.103s)
[191.675760] [023/134] (836s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[191.756616] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[191.758713] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[191.975585] [024/134] (835s left) gem_close_race (multigpu-basic-process)
[192.087449] Starting subtest: multigpu-basic-process
[192.089338] Subtest multigpu-basic-process: SKIP (0.000s)
[192.376046] [025/134] (835s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[193.889974] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[193.891614] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[194.122233] [026/134] (834s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[195.632303] Starting subtest: plane-downscale-factor-0-75-with-rotation
[195.633137] Starting dynamic subtest: pipe-A
[196.017901] Dynamic subtest pipe-A: SUCCESS (0.386s)
[196.041028] Starting dynamic subtest: pipe-B
[196.426841] Dynamic subtest pipe-B: SUCCESS (0.408s)
[196.450456] Starting dynamic subtest: pipe-C
[196.834569] Dynamic subtest pipe-C: SUCCESS (0.407s)
[196.854404] Starting dynamic subtest: pipe-D
[197.242235] Dynamic subtest pipe-D: SUCCESS (0.407s)
[197.243424] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (1.610s)
[197.519745] [027/134] (830s left) kms_psr (psr-primary-blt)
[199.039329] Subtest psr-primary-blt: SKIP (0.000s)
[199.090794] [028/134] (829s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[200.605324] Starting subtest: fbcpsr-shrfb-scaledprimary
[200.607073] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s)
[200.779811] [029/134] (827s left) gem_exec_fence (basic-busy-all)
[200.891745] Starting subtest: basic-busy-all
[201.027127] Subtest basic-busy-all: SUCCESS (0.135s)
[201.866834] [030/134] (826s left) kms_lease (setcrtc-implicit-plane)
[203.374276] Starting subtest: setcrtc-implicit-plane
[203.375154] Starting dynamic subtest: pipe-A-HDMI-A-3
[203.765194] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.388s)
[203.779193] Starting dynamic subtest: pipe-B-HDMI-A-3
[204.000160] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.234s)
[204.010574] Starting dynamic subtest: pipe-C-HDMI-A-3
[204.233122] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.232s)
[204.243512] Starting dynamic subtest: pipe-D-HDMI-A-3
[204.467078] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.233s)
[204.468063] Subtest setcrtc-implicit-plane: SUCCESS (1.093s)
[204.730882] [031/134] (823s left) kms_dirtyfb (default-dirtyfb-ioctl)
[206.240317] Starting subtest: default-dirtyfb-ioctl
[206.241242] Starting dynamic subtest: A-HDMI-A-3
[207.647550] Dynamic subtest A-HDMI-A-3: SUCCESS (1.406s)
[207.648447] Subtest default-dirtyfb-ioctl: SUCCESS (1.407s)
[207.852112] [032/134] (820s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[207.933341] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[208.010319] [033/134] (820s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[209.532478] Starting subtest: yf-tiled-64bpp-rotate-90
[209.534248] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[209.749323] [034/134] (818s left) gem_exec_schedule (smoketest)
[209.978253] Starting subtest: smoketest
[209.979737] Starting dynamic subtest: rcs0
[215.454604] Dynamic subtest rcs0: SUCCESS (5.470s)
[215.464412] Starting dynamic subtest: bcs0
[220.915307] Dynamic subtest bcs0: SUCCESS (5.460s)
[220.927195] Starting dynamic subtest: vcs0
[226.371076] Dynamic subtest vcs0: SUCCESS (5.455s)
[226.381298] Starting dynamic subtest: vcs1
[231.821973] Dynamic subtest vcs1: SUCCESS (5.452s)
[231.831750] Starting dynamic subtest: vecs0
[237.285215] Dynamic subtest vecs0: SUCCESS (5.461s)
[237.295356] Starting dynamic subtest: vecs1
[242.748607] Dynamic subtest vecs1: SUCCESS (5.463s)
[242.758949] Starting dynamic subtest: ccs0
[248.212529] Dynamic subtest ccs0: SUCCESS (5.463s)
[248.213387] Subtest smoketest: SUCCESS (38.227s)
[248.554596] [035/134] (780s left) prime_mmap (test_reprime)
[248.632593] Starting subtest: test_reprime
[248.633503] Starting dynamic subtest: test_reprime-smem
[248.677733] Dynamic subtest test_reprime-smem: SUCCESS (0.045s)
[248.687547] Starting dynamic subtest: test_reprime-lmem0
[248.862767] Dynamic subtest test_reprime-lmem0: SUCCESS (0.184s)
[248.863735] Subtest test_reprime: SUCCESS (0.230s)
[249.001715] [036/134] (779s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[250.510180] Starting subtest: addfb25-y-tiled-small-legacy
[250.511790] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[250.734808] [037/134] (778s left) gem_eio (in-flight-internal-10ms)
[251.027581] Starting subtest: in-flight-internal-10ms
[252.399633] Subtest in-flight-internal-10ms: SUCCESS (1.372s)
[253.974073] [038/134] (775s left) gem_exec_reloc (basic-wc-noreloc)
[254.082843] Subtest basic-wc-noreloc: SKIP (0.000s)
[254.184998] [039/134] (774s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[255.697653] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[255.699348] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[255.920411] [040/134] (773s left) kms_vblank (ts-continuation-suspend)
[257.428349] Starting subtest: ts-continuation-suspend
[257.429255] Starting dynamic subtest: pipe-A-HDMI-A-3
[276.293070] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.146s)
[276.306547] Starting dynamic subtest: pipe-D-HDMI-A-3
[296.258889] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.613s)
[296.260201] Subtest ts-continuation-suspend: SUCCESS (7.764s)
[302.435213] [041/134] (732s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[304.606738] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[304.621710] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.013s)
[304.750806] [042/134] (730s left) kms_flip (dpms-off-confusion-interruptible)
[306.291074] Starting subtest: dpms-off-confusion-interruptible
[306.296985] Starting dynamic subtest: A-HDMI-A3
[314.044988] Dynamic subtest A-HDMI-A3: SUCCESS (7.747s)
[314.063868] Starting dynamic subtest: B-HDMI-A3
[321.708111] Dynamic subtest B-HDMI-A3: SUCCESS (7.660s)
[321.723867] Starting dynamic subtest: C-HDMI-A3
[329.371577] Dynamic subtest C-HDMI-A3: SUCCESS (7.660s)
[329.403015] Starting dynamic subtest: D-HDMI-A3
[337.052355] Dynamic subtest D-HDMI-A3: SUCCESS (7.678s)
[337.053947] Subtest dpms-off-confusion-interruptible: SUCCESS (30.760s)
[337.313822] [043/134] (698s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[338.820998] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[340.501713] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.681s)
[340.753736] [044/134] (694s left) syncobj_timeline (invalid-query-illegal-handle)
[340.832869] Starting subtest: invalid-query-illegal-handle
[340.833802] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[340.975802] [045/134] (694s left) gem_mmap_wc (pf-nonblock)
[341.052615] Subtest pf-nonblock: SKIP (0.000s)
[341.125191] [046/134] (694s left) gem_exec_schedule (preempt)
[341.213008] Starting subtest: preempt
[341.213903] Starting dynamic subtest: rcs0
[341.279684] Dynamic subtest rcs0: SUCCESS (0.066s)
[341.292606] Starting dynamic subtest: bcs0
[341.314088] Dynamic subtest bcs0: SUCCESS (0.033s)
[341.326297] Starting dynamic subtest: vcs0
[341.351099] Dynamic subtest vcs0: SUCCESS (0.035s)
[341.363377] Starting dynamic subtest: vcs1
[341.387522] Dynamic subtest vcs1: SUCCESS (0.037s)
[341.399873] Starting dynamic subtest: vecs0
[341.426544] Dynamic subtest vecs0: SUCCESS (0.038s)
[341.438789] Starting dynamic subtest: vecs1
[341.465507] Dynamic subtest vecs1: SUCCESS (0.038s)
[341.477809] Starting dynamic subtest: ccs0
[341.504328] Dynamic subtest ccs0: SUCCESS (0.038s)
[341.505210] Subtest preempt: SUCCESS (0.292s)
[341.910174] [047/134] (693s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[341.993741] Starting subtest: etime-single-wait-for-submit-unsubmitted
[342.099465] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[342.274179] [048/134] (693s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[343.780287] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[343.781094] Starting dynamic subtest: pipe-A-HDMI-A-3
[343.789656] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[343.801813] Starting dynamic subtest: pipe-B-HDMI-A-3
[343.810414] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[343.822102] Starting dynamic subtest: pipe-C-HDMI-A-3
[343.839660] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[343.852300] Starting dynamic subtest: pipe-D-HDMI-A-3
[343.860975] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[343.862501] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SKIP (0.006s)
[344.104245] [049/134] (691s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[345.623879] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[345.625784] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[345.858332] [050/134] (690s left) i915_drm_fdinfo (memory-info-idle)
[345.927635] Starting subtest: memory-info-idle
[345.928591] Starting dynamic subtest: lmem0
[345.977283] Dynamic subtest lmem0: SUCCESS (0.049s)
[345.989849] Starting dynamic subtest: smem0
[346.012774] Dynamic subtest smem0: SUCCESS (0.035s)
[346.013688] Subtest memory-info-idle: SUCCESS (0.086s)
[346.189543] [051/134] (689s left) gem_exec_params (larger-than-life-batch)
[346.289162] Starting subtest: larger-than-life-batch
[356.405716] Subtest larger-than-life-batch: SUCCESS (10.116s)
[356.936649] [052/134] (679s left) kms_chamelium_color (ctm-0-25)
[358.498754] Subtest ctm-0-25: SKIP (0.000s)
[358.559320] [053/134] (677s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[360.068271] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[360.069099] Starting dynamic subtest: pipe-A-valid-mode
[360.121652] Dynamic subtest pipe-A-valid-mode: SKIP (0.052s)
[360.123375] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.054s)
[360.333314] [054/134] (675s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[360.414579] Subtest writes-after-reads: SKIP (0.000s)
[360.476865] [055/134] (675s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[361.993468] Starting subtest: plane-lut1d-ctm3x4
[362.015203] Starting dynamic subtest: pipe-A-HDMI-A-3
[362.432148] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.416s)
[362.557084] Starting dynamic subtest: pipe-B-HDMI-A-3
[362.893603] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.349s)
[363.037993] Starting dynamic subtest: pipe-C-HDMI-A-3
[363.357595] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.332s)
[363.473256] Starting dynamic subtest: pipe-D-HDMI-A-3
[363.810211] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.349s)
[363.865892] Subtest plane-lut1d-ctm3x4: SUCCESS (1.873s)
[364.080693] [056/134] (672s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[365.597384] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[365.599007] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[365.821252] [057/134] (670s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[367.341799] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[367.343698] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[367.567161] [058/134] (669s left) perf_pmu (busy-no-semaphores)
[367.639708] Starting subtest: busy-no-semaphores
[367.640674] Starting dynamic subtest: rcs0
[368.234299] Dynamic subtest rcs0: SUCCESS (0.594s)
[368.251398] Starting dynamic subtest: bcs0
[368.785689] Dynamic subtest bcs0: SUCCESS (0.548s)
[368.802638] Starting dynamic subtest: vcs0
[369.337902] Dynamic subtest vcs0: SUCCESS (0.549s)
[369.357001] Starting dynamic subtest: vcs1
[369.890654] Dynamic subtest vcs1: SUCCESS (0.550s)
[369.907236] Starting dynamic subtest: vecs0
[370.444338] Dynamic subtest vecs0: SUCCESS (0.550s)
[370.464677] Starting dynamic subtest: vecs1
[370.996845] Dynamic subtest vecs1: SUCCESS (0.549s)
[371.013229] Starting dynamic subtest: ccs0
[371.551283] Dynamic subtest ccs0: SUCCESS (0.551s)
[371.552937] Subtest busy-no-semaphores: SUCCESS (3.913s)
[371.749632] [059/134] (664s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[373.269481] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[373.272283] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[373.500062] [060/134] (663s left) kms_atomic (plane-invalid-params)
[375.014319] Starting subtest: plane-invalid-params
[375.015109] Starting dynamic subtest: pipe-A-HDMI-A-3
[375.853274] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.838s)
[375.854144] Subtest plane-invalid-params: SUCCESS (0.840s)
[376.074225] [061/134] (660s left) kms_invalid_mode (bad-vsync-end)
[377.583778] Starting subtest: bad-vsync-end
[377.584707] Starting dynamic subtest: pipe-A-HDMI-A-3
[377.632927] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.048s)
[377.647278] Starting dynamic subtest: pipe-B-HDMI-A-3
[377.648364] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s)
[377.661974] Starting dynamic subtest: pipe-C-HDMI-A-3
[377.663035] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.002s)
[377.676118] Starting dynamic subtest: pipe-D-HDMI-A-3
[377.676989] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s)
[377.677879] Subtest bad-vsync-end: SUCCESS (0.057s)
[377.874478] [062/134] (659s left) gem_exec_balancer (busy)
[377.960186] Starting subtest: busy
[378.825872] Subtest busy: SUCCESS (0.865s)
[379.234641] [063/134] (657s left) api_intel_bb (object-noreloc-purge-cache-simple)
[379.309937] Starting subtest: object-noreloc-purge-cache-simple
[379.340942] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.031s)
[379.565056] [064/134] (657s left) kms_big_fb (linear-64bpp-rotate-270)
[381.086363] Starting subtest: linear-64bpp-rotate-270
[381.146903] Subtest linear-64bpp-rotate-270: SKIP (0.060s)
[381.352095] [065/134] (655s left) kms_prime (basic-modeset-hybrid)
[382.868008] Subtest basic-modeset-hybrid: SKIP (0.000s)
[383.094095] [066/134] (654s left) gem_ctx_sseu (engines)
[383.175296] Subtest engines: SKIP (0.000s)
[383.260714] [067/134] (654s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[387.619524] Starting subtest: dpms-mode-unset-lpsp
[388.546529] Subtest dpms-mode-unset-lpsp: SKIP (0.929s)
[389.708427] [068/134] (647s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[391.221527] Starting subtest: basic-flip-after-cursor-legacy
[392.214840] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.993s)
[392.512839] [069/134] (645s left) gem_mmap_gtt (basic-read)
[392.596659] Subtest basic-read: SKIP (0.000s)
[392.668346] [070/134] (645s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[392.749704] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[392.851228] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.101s)
[393.018908] [071/134] (644s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[394.532022] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[394.533684] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[394.746573] [072/134] (643s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[396.278469] Starting subtest: cursorB-vs-flipA-atomic-transitions
[396.280637] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.002s)
[396.452242] [073/134] (641s left) perf (non-zero-reason)
[396.865108] Starting subtest: non-zero-reason
[396.865987] Starting dynamic subtest: 0-rcs0
[399.888600] Dynamic subtest 0-rcs0: FAIL (2.750s)
[399.889798] Subtest non-zero-reason: FAIL (2.751s)
[399.962813] [074/134] (638s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[401.474538] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[401.505578] Starting dynamic subtest: pipe-A-plane-0
[401.507434] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[401.521274] Starting dynamic subtest: pipe-A-plane-3
[401.522975] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[401.537222] Starting dynamic subtest: pipe-A-plane-5
[401.538912] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[401.652412] Starting dynamic subtest: pipe-B-plane-0
[401.654523] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[401.679402] Starting dynamic subtest: pipe-B-plane-3
[401.681543] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[401.706984] Starting dynamic subtest: pipe-B-plane-5
[401.709375] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[401.711477] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.219s)
[401.936668] [075/134] (636s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[402.026777] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[402.121064] [076/134] (636s left) core_setmaster (master-drop-set-shared-fd)
[402.296738] Starting subtest: master-drop-set-shared-fd
[402.328857] Subtest master-drop-set-shared-fd: SUCCESS (0.033s)
[402.379421] [077/134] (635s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-blt)
[403.892393] Starting subtest: fbcpsr-abgr161616f-draw-blt
[403.894027] Subtest fbcpsr-abgr161616f-draw-blt: SKIP (0.000s)
[404.122535] [078/134] (634s left) kms_addfb_basic (clobberred-modifier)
[404.208057] Starting subtest: clobberred-modifier
[404.209902] Subtest clobberred-modifier: SKIP (0.000s)
[405.868926] [079/134] (632s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[407.391616] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[407.392571] Starting dynamic subtest: pipe-A
[407.478975] Dynamic subtest pipe-A: SUCCESS (0.088s)
[407.501383] Starting dynamic subtest: pipe-B
[407.641036] Dynamic subtest pipe-B: SUCCESS (0.161s)
[407.665564] Starting dynamic subtest: pipe-C
[407.782874] Dynamic subtest pipe-C: SUCCESS (0.140s)
[407.798940] Starting dynamic subtest: pipe-D
[407.908783] Dynamic subtest pipe-D: SUCCESS (0.125s)
[407.909713] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.519s)
[408.173161] [080/134] (630s left) gem_busy (close-race)
[408.264218] Starting subtest: close-race
[430.252645] Subtest close-race: SUCCESS (21.988s)
[430.775005] [081/134] (607s left) kms_psr (fbc-psr2-cursor-render)
[432.332202] Subtest fbc-psr2-cursor-render: SKIP (0.000s)
[432.397347] [082/134] (606s left) kms_cursor_crc (cursor-onscreen-64x64)
[434.061867] Starting subtest: cursor-onscreen-64x64
[434.067043] Starting dynamic subtest: pipe-A-HDMI-A-3
[436.824817] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.758s)
[436.865642] Starting dynamic subtest: pipe-D-HDMI-A-3
[439.464778] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.612s)
[439.465666] Subtest cursor-onscreen-64x64: SUCCESS (5.402s)
[439.891111] [083/134] (598s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[441.405351] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[441.406995] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[441.619822] [084/134] (597s left) gem_exec_endless (dispatch)
[441.736374] Starting subtest: dispatch
[441.737276] Starting dynamic subtest: rcs0
[441.743975] Dynamic subtest rcs0: SUCCESS (0.007s)
[441.761726] Starting dynamic subtest: bcs0
[441.763478] Dynamic subtest bcs0: SUCCESS (0.006s)
[441.779232] Starting dynamic subtest: vcs0
[441.780919] Dynamic subtest vcs0: SUCCESS (0.008s)
[441.796683] Starting dynamic subtest: vcs1
[441.798524] Dynamic subtest vcs1: SUCCESS (0.009s)
[441.812404] Starting dynamic subtest: vecs0
[441.814050] Dynamic subtest vecs0: SUCCESS (0.006s)
[441.827664] Starting dynamic subtest: vecs1
[441.829681] Dynamic subtest vecs1: SUCCESS (0.006s)
[441.843192] Starting dynamic subtest: ccs0
[441.844941] Dynamic subtest ccs0: SUCCESS (0.007s)
[441.845929] Subtest dispatch: SUCCESS (0.057s)
[441.982572] [085/134] (597s left) kms_plane_alpha_blend (constant-alpha-max)
[443.493662] Starting subtest: constant-alpha-max
[443.737455] Starting dynamic subtest: pipe-A-HDMI-A-3
[444.600929] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.864s)
[444.616654] Starting dynamic subtest: pipe-D-HDMI-A-3
[445.472568] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.868s)
[445.473401] Subtest constant-alpha-max: SUCCESS (1.980s)
[445.695499] [086/134] (593s left) kms_feature_discovery (display-2x)
[447.206935] Starting subtest: display-2x
[447.208679] Subtest display-2x: SKIP (0.000s)
[447.351535] [087/134] (591s left) sw_sync (timeline_closed)
[447.430022] Starting subtest: timeline_closed
[447.430953] Subtest timeline_closed: SUCCESS (0.000s)
[447.570857] [088/134] (591s left) sw_sync (sync_multi_consumer)
[447.617597] Starting subtest: sync_multi_consumer
[447.950915] Subtest sync_multi_consumer: SUCCESS (0.334s)
[448.113888] [089/134] (591s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[448.193730] Subtest invalidate-primary-flip-overlay: SKIP (0.000s)
[448.265540] [090/134] (591s left) kms_selftest (drm_format)
[448.321223] Starting subtest: drm_format
[448.359047] Starting dynamic subtest: drm_test_format_block_width_invalid
[448.437864] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.078s)
[448.473241] Starting dynamic subtest: drm_test_format_block_width_one_plane
[448.523698] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.083s)
[448.565952] Starting dynamic subtest: drm_test_format_block_width_two_plane
[448.606428] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.080s)
[448.632064] Starting dynamic subtest: drm_test_format_block_width_three_plane
[448.691649] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.083s)
[448.709927] Starting dynamic subtest: drm_test_format_block_width_tiled
[448.778335] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.083s)
[448.824176] Starting dynamic subtest: drm_test_format_block_height_invalid
[448.862479] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.081s)
[448.889103] Starting dynamic subtest: drm_test_format_block_height_one_plane
[448.929634] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.065s)
[448.962898] Starting dynamic subtest: drm_test_format_block_height_two_plane
[448.996280] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.065s)
[449.022681] Starting dynamic subtest: drm_test_format_block_height_three_plane
[449.071560] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.072s)
[449.116041] Starting dynamic subtest: drm_test_format_block_height_tiled
[449.153422] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.079s)
[449.176368] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[449.225420] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.070s)
[449.270359] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[449.315910] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.088s)
[449.330263] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[449.382797] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.066s)
[449.410732] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[449.470766] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.085s)
[449.516653] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[449.548021] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.074s)
[449.566558] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[449.632805] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.083s)
[449.648668] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[449.710482] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.075s)
[449.728053] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[449.779191] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.066s)
[449.780350] Subtest drm_format: SUCCESS (1.458s)
[449.991954] [091/134] (589s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[451.509973] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[454.337004] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (2.826s)
[454.585378] [092/134] (584s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[456.145828] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[456.247548] [093/134] (583s left) gem_lmem_swapping (parallel-multi)
[460.824715] Starting subtest: parallel-multi
[460.826648] Starting dynamic subtest: lmem0
[517.616275] Dynamic subtest lmem0: SUCCESS (56.788s)
[517.617318] Subtest parallel-multi: SUCCESS (56.789s)
[518.591542] [FACT gem_lmem_swapping (parallel-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card1
[518.592427] [FACT gem_lmem_swapping (parallel-multi)] deleted: kernel.kmod_is_loaded.i915: true
[518.594835] [094/134] (521s left) kms_cursor_crc (cursor-random-64x21)
[523.638051] Starting subtest: cursor-random-64x21
[523.651945] Starting dynamic subtest: pipe-A-HDMI-A-3
[527.641924] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.991s)
[527.676096] Starting dynamic subtest: pipe-D-HDMI-A-3
[531.959893] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.295s)
[531.960804] Subtest cursor-random-64x21: SUCCESS (8.321s)
[532.378277] [FACT kms_cursor_crc (cursor-random-64x21)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card1
[532.380693] [FACT kms_cursor_crc (cursor-random-64x21)] new: kernel.kmod_is_loaded.i915: true
[532.383289] [095/134] (507s left) gem_exec_params (secure-non-root)
[532.474641] Starting subtest: secure-non-root
[532.476638] Subtest secure-non-root: SKIP (0.000s)
[532.665309] [096/134] (507s left) gem_ppgtt (blt-vs-render-ctx0)
[532.754281] Starting subtest: blt-vs-render-ctx0
[565.511637] Subtest blt-vs-render-ctx0: SUCCESS (32.757s)
[565.731092] [097/134] (474s left) gen7_exec_parse (chained-batch)
[565.860364] Subtest chained-batch: SKIP (0.000s)
[565.931807] [098/134] (474s left) gem_eio (wait-10ms)
[566.205348] Starting subtest: wait-10ms
[566.804609] Subtest wait-10ms: SUCCESS (0.601s)
[568.416491] [099/134] (471s left) kms_properties (colorop-properties-atomic)
[569.958638] Starting subtest: colorop-properties-atomic
[569.959648] Starting dynamic subtest: pipe-A-HDMI-A-3
[570.091123] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.133s)
[570.105920] Starting dynamic subtest: pipe-B-HDMI-A-3
[570.186988] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.094s)
[570.201597] Starting dynamic subtest: pipe-C-HDMI-A-3
[570.281936] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.093s)
[570.296399] Starting dynamic subtest: pipe-D-HDMI-A-3
[570.379666] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.096s)
[570.380547] Subtest colorop-properties-atomic: SUCCESS (0.423s)
[570.650927] [100/134] (469s left) api_intel_allocator (default-alignment)
[570.727078] Starting subtest: default-alignment
[570.731596] Subtest default-alignment: SUCCESS (0.006s)
[570.915834] [101/134] (469s left) i915_pm_rpm (gem-execbuf)
[574.657721] Starting subtest: gem-execbuf
[574.659080] Starting dynamic subtest: lmem0
[578.855819] Dynamic subtest lmem0: SUCCESS (4.196s)
[578.911721] Starting dynamic subtest: smem0
[582.675310] Dynamic subtest smem0: SUCCESS (3.816s)
[582.676520] Subtest gem-execbuf: SUCCESS (8.019s)
[583.691871] [102/134] (456s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[585.216605] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[585.217539] Starting dynamic subtest: pipe-A-HDMI-A-3
[585.238767] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.002s)
[585.252868] Starting dynamic subtest: pipe-B-HDMI-A-3
[585.274726] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.002s)
[585.288095] Starting dynamic subtest: pipe-C-HDMI-A-3
[585.311841] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.002s)
[585.326710] Starting dynamic subtest: pipe-D-HDMI-A-3
[585.349508] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.002s)
[585.351244] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.015s)
[585.542886] [103/134] (454s left) gem_bad_reloc (negative-reloc)
[585.625029] Subtest negative-reloc: SKIP (0.000s)
[585.723358] [104/134] (454s left) kms_cursor_edge_walk (128x128-left-edge)
[587.231658] Starting subtest: 128x128-left-edge
[587.232595] Starting dynamic subtest: pipe-A-HDMI-A-3
[590.557925] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.325s)
[590.571921] Starting dynamic subtest: pipe-D-HDMI-A-3
[593.761012] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.202s)
[593.761859] Subtest 128x128-left-edge: SUCCESS (6.531s)
[594.017423] [105/134] (446s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[595.535699] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[595.537465] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[595.806084] [106/134] (444s left) gem_close (basic)
[595.889047] Starting subtest: basic
[595.890016] Subtest basic: SUCCESS (0.000s)
[596.056623] [107/134] (444s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[597.579866] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[598.898733] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.318s)
[599.112603] [108/134] (441s left) gem_render_copy (linear)
[599.197238] Starting subtest: linear
[599.198061] Starting dynamic subtest: smem
[599.313507] Dynamic subtest smem: SUCCESS (0.115s)
[599.327664] Starting dynamic subtest: lmem0
[599.650102] Dynamic subtest lmem0: SUCCESS (0.335s)
[599.651087] Subtest linear: SUCCESS (0.453s)
[599.983235] [109/134] (440s left) kms_content_protection (uevent)
[601.550229] Starting subtest: uevent
[601.558569] Subtest uevent: SKIP (0.005s)
[601.788217] [110/134] (439s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[603.313033] Starting subtest: y-tiled-addfb-size-offset-overflow
[603.314938] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[603.536197] [111/134] (437s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[605.049748] Starting subtest: 2x-plain-flip-ts-check-interruptible
[605.061983] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.013s)
[605.267855] [112/134] (436s left) syncobj_wait (multi-wait-all-submitted)
[605.353992] Starting subtest: multi-wait-all-submitted
[605.459444] Subtest multi-wait-all-submitted: SUCCESS (0.105s)
[605.622489] [113/134] (435s left) gem_userptr_blits (stress-purge)
[605.716925] Starting subtest: stress-purge
[611.093578] Subtest stress-purge: SUCCESS (5.378s)
[611.287133] [114/134] (430s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[612.857865] Starting subtest: 4-tiled-64bpp-rotate-180
[614.866029] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (2.007s)
[615.081360] [115/134] (426s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[616.601530] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[616.603408] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[616.821405] [116/134] (424s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[618.331668] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[618.366915] Starting dynamic subtest: pipe-A-plane-0
[618.368851] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[618.382339] Starting dynamic subtest: pipe-A-plane-3
[618.384046] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[618.397822] Starting dynamic subtest: pipe-A-plane-5
[618.399616] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[618.514674] Starting dynamic subtest: pipe-B-plane-0
[618.516732] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[618.532954] Starting dynamic subtest: pipe-B-plane-3
[618.534789] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[618.550943] Starting dynamic subtest: pipe-B-plane-5
[618.553122] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[618.555281] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SKIP (0.210s)
[618.747114] [117/134] (422s left) prime_mmap (test_correct_cpu_write)
[618.830012] Starting subtest: test_correct_cpu_write
[618.830915] Starting dynamic subtest: test_correct_cpu_write-smem
[618.831786] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[618.845244] Starting dynamic subtest: test_correct_cpu_write-lmem0
[618.846199] Dynamic subtest test_correct_cpu_write-lmem0: SUCCESS (0.000s)
[618.847063] Subtest test_correct_cpu_write: SUCCESS (0.002s)
[619.011994] [118/134] (422s left) kms_force_connector_basic (force-connector-state)
[619.164734] Starting subtest: force-connector-state
[620.839689] Subtest force-connector-state: SUCCESS (1.675s)
[622.577866] [119/134] (419s left) gem_ctx_persistence (legacy-engines-hang)
[622.688169] Starting subtest: legacy-engines-hang
[622.689102] Starting dynamic subtest: render
[622.805793] Dynamic subtest render: SUCCESS (0.117s)
[622.825530] Starting dynamic subtest: bsd1
[622.914491] Dynamic subtest bsd1: SUCCESS (0.107s)
[622.960136] Starting dynamic subtest: bsd2
[622.978980] Dynamic subtest bsd2: SUCCESS (0.060s)
[623.001360] Starting dynamic subtest: blt
[623.029002] Dynamic subtest blt: SUCCESS (0.048s)
[623.048521] Starting dynamic subtest: vebox
[623.133585] Dynamic subtest vebox: SUCCESS (0.102s)
[623.138293] Subtest legacy-engines-hang: SUCCESS (0.447s)
[623.295703] [120/134] (418s left) gem_exec_fence (long-history)
[623.797696] Starting subtest: long-history
[630.377304] Subtest long-history: SUCCESS (6.587s)
[631.610121] [121/134] (410s left) sysfs_heartbeat_interval (invalid)
[631.695467] Starting subtest: invalid
[631.697789] Starting dynamic subtest: vecs0
[631.698708] Dynamic subtest vecs0: SUCCESS (0.000s)
[631.713228] Starting dynamic subtest: ccs0
[631.714289] Dynamic subtest ccs0: SUCCESS (0.000s)
[631.728274] Starting dynamic subtest: vcs0
[631.729364] Dynamic subtest vcs0: SUCCESS (0.000s)
[631.743223] Starting dynamic subtest: bcs0
[631.744310] Dynamic subtest bcs0: SUCCESS (0.000s)
[631.758353] Starting dynamic subtest: vecs1
[631.759467] Dynamic subtest vecs1: SUCCESS (0.000s)
[631.773215] Starting dynamic subtest: rcs0
[631.774339] Dynamic subtest rcs0: SUCCESS (0.000s)
[631.788010] Starting dynamic subtest: vcs1
[631.789440] Dynamic subtest vcs1: SUCCESS (0.000s)
[631.790445] Subtest invalid: SUCCESS (0.010s)
[631.839913] [122/134] (410s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-mmap-gtt)
[633.355405] Starting subtest: fbcpsr-abgr161616f-draw-mmap-gtt
[633.357052] Subtest fbcpsr-abgr161616f-draw-mmap-gtt: SKIP (0.000s)
[633.579991] [123/134] (408s left) syncobj_timeline (single-wait-available-submitted)
[633.662876] Starting subtest: single-wait-available-submitted
[633.663922] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[633.810896] [124/134] (408s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[635.324488] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[635.326328] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[635.565549] [125/134] (406s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[637.115403] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[637.169764] [126/134] (405s left) gem_ctx_isolation (dirty-switch)
[637.259030] Starting subtest: dirty-switch
[637.259926] Starting dynamic subtest: rcs0
[637.882861] Dynamic subtest rcs0: SUCCESS (0.623s)
[637.900388] Starting dynamic subtest: bcs0
[638.508358] Dynamic subtest bcs0: SUCCESS (0.624s)
[638.523029] Starting dynamic subtest: vcs0
[639.139989] Dynamic subtest vcs0: SUCCESS (0.631s)
[639.156007] Starting dynamic subtest: vcs1
[639.761634] Dynamic subtest vcs1: SUCCESS (0.620s)
[639.776108] Starting dynamic subtest: vecs0
[640.388643] Dynamic subtest vecs0: SUCCESS (0.626s)
[640.403292] Starting dynamic subtest: vecs1
[641.019938] Dynamic subtest vecs1: SUCCESS (0.630s)
[641.035714] Starting dynamic subtest: ccs0
[641.643687] Dynamic subtest ccs0: SUCCESS (0.622s)
[641.644599] Subtest dirty-switch: SUCCESS (4.385s)
[641.960255] [127/134] (400s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[643.477220] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[643.478811] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[643.695708] [128/134] (398s left) gem_mmap_offset (blt-coherency)
[643.772970] Starting subtest: blt-coherency
[643.810990] Subtest blt-coherency: SUCCESS (0.038s)
[644.036594] [129/134] (398s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[645.563476] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[647.874003] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (2.311s)
[648.138381] [130/134] (394s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[649.648662] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[649.649571] Starting dynamic subtest: pipe-A-HDMI-A-3
[649.657735] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[649.672036] Starting dynamic subtest: pipe-B-HDMI-A-3
[649.680639] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[649.694635] Starting dynamic subtest: pipe-C-HDMI-A-3
[649.703654] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[649.717701] Starting dynamic subtest: pipe-D-HDMI-A-3
[649.728219] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[649.730202] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[649.935939] [131/134] (392s left) syncobj_wait (wait-for-submit-delayed-submit)
[650.012989] Starting subtest: wait-for-submit-delayed-submit
[650.116135] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[650.249737] [132/134] (392s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[650.325760] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[650.326683] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[650.501433] [133/134] (392s left) kms_psr2_su (page_flip-nv12)
[650.579655] Subtest page_flip-NV12: SKIP (0.000s)
[650.652154] [134/134] (392s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[652.173646] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[652.175427] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[652.396948] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: gem_exec_create
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: gem_userptr_blits
results: parsing output: 6/ for test: i915_suspend
results: parsing output: 7/ for test: kms_hdr
results: parsing output: 8/ for test: gem_softpin
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_lmem_swapping
results: parsing output: 13/ for test: prime_vgem
results: parsing output: 14/ for test: kms_flip_scaled_crc
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: gem_exec_whisper
results: parsing output: 17/ for test: gem_pxp
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_chamelium_frames
results: parsing output: 20/ for test: i915_pm_freq_api
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: gem_render_copy
results: parsing output: 23/ for test: gem_close_race
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_plane_scaling
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_exec_fence
results: parsing output: 29/ for test: kms_lease
results: parsing output: 30/ for test: kms_dirtyfb
results: parsing output: 31/ for test: kms_pipe_b_c_ivb
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: prime_mmap
results: parsing output: 35/ for test: kms_addfb_basic
results: parsing output: 36/ for test: gem_eio
results: parsing output: 37/ for test: gem_exec_reloc
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_vblank
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: gem_mmap_wc
results: parsing output: 45/ for test: gem_exec_schedule
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: i915_drm_fdinfo
results: parsing output: 50/ for test: gem_exec_params
results: parsing output: 51/ for test: kms_chamelium_color
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 54/ for test: kms_color_pipeline
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: perf_pmu
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_atomic
results: parsing output: 60/ for test: kms_invalid_mode
results: parsing output: 61/ for test: gem_exec_balancer
results: parsing output: 62/ for test: api_intel_bb
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_prime
results: parsing output: 65/ for test: gem_ctx_sseu
results: parsing output: 66/ for test: kms_pm_rpm
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: perf
results: parsing output: 73/ for test: kms_plane
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: core_setmaster
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_addfb_basic
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: gem_busy
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_cursor_crc
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_exec_endless
results: parsing output: 84/ for test: kms_plane_alpha_blend
results: parsing output: 85/ for test: kms_feature_discovery
results: parsing output: 86/ for test: sw_sync
results: parsing output: 87/ for test: sw_sync
results: parsing output: 88/ for test: kms_psr_stress_test
results: parsing output: 89/ for test: kms_selftest
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_chamelium_hpd
results: parsing output: 92/ for test: gem_lmem_swapping
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: gem_exec_params
results: parsing output: 95/ for test: gem_ppgtt
results: parsing output: 96/ for test: gen7_exec_parse
results: parsing output: 97/ for test: gem_eio
results: parsing output: 98/ for test: kms_properties
results: parsing output: 99/ for test: api_intel_allocator
results: parsing output: 100/ for test: i915_pm_rpm
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: gem_bad_reloc
results: parsing output: 103/ for test: kms_cursor_edge_walk
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: gem_close
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: gem_render_copy
results: parsing output: 108/ for test: kms_content_protection
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: gem_userptr_blits
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_plane
results: parsing output: 116/ for test: prime_mmap
results: parsing output: 117/ for test: kms_force_connector_basic
results: parsing output: 118/ for test: gem_ctx_persistence
results: parsing output: 119/ for test: gem_exec_fence
results: parsing output: 120/ for test: sysfs_heartbeat_interval
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: gem_ctx_isolation
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_mmap_offset
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: syncobj_timeline
results: parsing output: 132/ for test: kms_psr2_su
results: parsing output: 133/ for test: kms_frontbuffer_tracking
Done.