[56.403648] Initializing watchdogs
[56.403697]   /dev/watchdog0
[56.419394] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.424211] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.426535] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.430404] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[56.562076] Starting subtest: fbcpsr-indfb-scaledprimary
[62.319813] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.758s)
[62.461720] [002/133] (954s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[62.568759] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[69.474021] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.902s)
[69.609915] [003/133] (947s left) prime_mmap (test_correct)
[69.673966] Starting subtest: test_correct
[69.676191] Starting dynamic subtest: test_correct-smem
[69.706100] Dynamic subtest test_correct-smem: SUCCESS (0.034s)
[69.708593] Subtest test_correct: SUCCESS (0.034s)
[69.810168] [004/133] (947s left) gem_exec_reloc (basic-write-read)
[69.874698] Subtest basic-write-read: SKIP (0.000s)
[69.947803] [005/133] (947s left) gem_ctx_isolation (preservation)
[70.010671] Starting subtest: preservation
[70.013044] Starting dynamic subtest: rcs0
[70.146308] Dynamic subtest rcs0: SUCCESS (0.135s)
[70.156716] Starting dynamic subtest: bcs0
[70.305797] Dynamic subtest bcs0: SUCCESS (0.159s)
[70.316474] Starting dynamic subtest: vcs0
[70.447731] Dynamic subtest vcs0: SUCCESS (0.141s)
[70.458828] Starting dynamic subtest: vcs1
[72.447277] Dynamic subtest vcs1: SUCCESS (1.999s)
[72.455865] Starting dynamic subtest: vecs0
[74.434832] Dynamic subtest vecs0: SUCCESS (1.986s)
[74.445999] Starting dynamic subtest: ccs0
[76.422122] Dynamic subtest ccs0: SUCCESS (1.986s)
[76.425049] Subtest preservation: SUCCESS (6.408s)
[76.662829] [006/133] (940s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[76.763106] Starting subtest: x-tiled-16bpp-rotate-270
[76.782635] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[76.886573] [007/133] (940s left) gem_exec_fence (long-history)
[77.314259] Starting subtest: long-history
[84.051505] Subtest long-history: SUCCESS (6.736s)
[84.691250] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true
[84.694325] [008/133] (932s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[84.786751] Starting subtest: primary-yf-tiled-reflect-x-180
[84.846570] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[84.959130] [009/133] (932s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[85.018187] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[85.020601] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[85.109424] [010/133] (932s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[85.220458] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[85.224676] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[85.286878] [011/133] (932s left) gem_exec_flush (basic-uc-set-default)
[85.356903] Starting subtest: basic-uc-set-default
[90.811282] Subtest basic-uc-set-default: SUCCESS (5.456s)
[91.005682] [012/133] (926s left) gem_ctx_bad_destroy (double-destroy)
[91.075576] Starting subtest: double-destroy
[91.078068] Subtest double-destroy: SUCCESS (0.000s)
[91.148767] [013/133] (926s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[91.250077] Starting subtest: y-tiled-32bpp-rotate-0
[91.254261] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[91.362529] [014/133] (926s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[91.486391] Starting subtest: 2x-flip-vs-cursor-legacy
[91.491110] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[91.646335] [015/133] (925s left) kms_cursor_crc (cursor-random-256x256)
[91.885936] Starting subtest: cursor-random-256x256
[91.890915] Starting dynamic subtest: pipe-A-eDP-1
[95.234076] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.342s)
[95.265058] Starting dynamic subtest: pipe-D-eDP-1
[99.319309] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.059s)
[99.321512] Subtest cursor-random-256x256: SUCCESS (7.430s)
[100.136813] [016/133] (917s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[100.519640] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[101.346202] [017/133] (916s left) gem_ctx_shared (q-independent)
[101.413946] Starting subtest: Q-independent
[101.416336] Starting dynamic subtest: rcs0
[101.475619] Dynamic subtest rcs0: SUCCESS (0.061s)
[101.485442] Starting dynamic subtest: vcs0
[101.517518] Dynamic subtest vcs0: SUCCESS (0.042s)
[101.531740] Starting dynamic subtest: vcs1
[101.552606] Dynamic subtest vcs1: SUCCESS (0.035s)
[101.563089] Starting dynamic subtest: vecs0
[101.587201] Dynamic subtest vecs0: SUCCESS (0.035s)
[101.595860] Starting dynamic subtest: ccs0
[101.638691] Dynamic subtest ccs0: SUCCESS (0.051s)
[101.641077] Subtest Q-independent: SUCCESS (0.225s)
[103.392783] [018/133] (914s left) gem_ctx_param (basic-default)
[103.444572] Starting subtest: basic-default
[103.446765] Subtest basic-default: SUCCESS (0.000s)
[103.520608] [019/133] (914s left) gem_exec_schedule (preempt-queue-contexts-chain)
[103.596492] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[103.890886] [020/133] (913s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[103.975225] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[103.977664] Starting dynamic subtest: pipe-A-eDP-1
[104.001862] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[104.012444] Starting dynamic subtest: pipe-B-eDP-1
[104.034744] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[104.042750] Starting dynamic subtest: pipe-C-eDP-1
[104.065055] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[104.072956] Starting dynamic subtest: pipe-D-eDP-1
[104.095553] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[104.100049] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[106.223531] [021/133] (911s left) kms_addfb_basic (tile-pitch-mismatch)
[106.274653] Starting subtest: tile-pitch-mismatch
[106.279175] Subtest tile-pitch-mismatch: SKIP (0.000s)
[106.411032] [022/133] (911s left) kms_cursor_crc (cursor-suspend)
[106.546892] Starting subtest: cursor-suspend
[106.549567] Starting dynamic subtest: pipe-A-eDP-1
[139.675764] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.277s)
[139.689432] Starting dynamic subtest: pipe-D-eDP-1
[173.671129] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.726s)
[173.673579] Subtest cursor-suspend: SUCCESS (7.006s)
[174.484661] [023/133] (843s left) core_getversion (basic)
[174.531004] Starting subtest: basic
[174.535201] Subtest basic: SUCCESS (0.000s)
[174.612771] [024/133] (843s left) gem_pread (bench)
[174.666956] Subtest bench: SKIP (0.000s)
[174.734621] [025/133] (843s left) gen9_exec_parse (bb-start-far)
[174.785421] Subtest bb-start-far: SKIP (0.000s)
[174.848160] [026/133] (843s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[174.944317] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[174.948593] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[175.047447] [027/133] (842s left) gem_ctx_param (get-priority-new-ctx)
[175.110713] Starting subtest: get-priority-new-ctx
[175.113079] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[175.208942] [028/133] (842s left) kms_big_fb (linear-8bpp-rotate-90)
[175.311348] Starting subtest: linear-8bpp-rotate-90
[175.332733] Subtest linear-8bpp-rotate-90: SKIP (0.021s)
[175.448194] [029/133] (842s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[175.531812] Starting subtest: basic-modeset-with-all-modifiers-formats
[175.907295] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[176.669179] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.759s)
[176.678371] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[176.690073] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.020s)
[176.698673] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[176.713110] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[176.728410] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[176.857281] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.143s)
[176.867428] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[176.879547] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[176.890142] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[176.902155] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[176.911639] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[176.924310] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[176.933090] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[176.946539] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[176.955080] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[176.969028] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[176.979549] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[176.991310] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[177.000016] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[177.013454] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[177.022103] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[177.035778] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[177.044572] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[177.180635] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.144s)
[177.190172] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[177.203404] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[177.213544] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[177.225277] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[177.234576] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[177.247499] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[177.257625] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[177.269829] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[177.279155] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[177.292189] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[177.301589] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[177.314538] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[177.324424] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[177.336696] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[177.346223] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[177.359097] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[177.368280] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[177.515006] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[177.525406] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[177.537133] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[177.547712] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[177.559526] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[177.568115] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[177.581946] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[177.590391] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[177.604200] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[177.612383] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[177.626594] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[177.634986] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[177.648903] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[177.657742] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[177.671098] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[177.679995] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[177.693503] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[178.084658] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.546s)
[178.851847] [030/133] (839s left) gem_exec_balancer (persistence)
[179.127377] Starting subtest: persistence
[180.068766] Subtest persistence: SUCCESS (0.938s)
[180.180445] [031/133] (838s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[180.273536] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[180.278067] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[180.368236] [032/133] (837s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[180.474325] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[180.478887] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[180.580942] [033/133] (837s left) i915_pm_rpm (gem-pread)
[182.527132] Starting subtest: gem-pread
[184.564886] Subtest gem-pread: SUCCESS (2.037s)
[184.668975] [034/133] (833s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[186.498218] Starting subtest: dpms-mode-unset-lpsp
[190.548417] Subtest dpms-mode-unset-lpsp: SUCCESS (4.049s)
[190.940280] [035/133] (827s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[190.994339] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[190.999026] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[191.180181] [036/133] (827s left) gem_exec_whisper (basic-queues-priority)
[191.253411] Starting subtest: basic-queues-priority
[215.455683] Subtest basic-queues-priority: SUCCESS (24.193s)
[215.655166] [037/133] (802s left) kms_addfb_basic (addfb25-modifier-no-flag)
[215.754819] Starting subtest: addfb25-modifier-no-flag
[215.756779] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[215.858140] [038/133] (802s left) kms_flip (dpms-off-confusion-interruptible)
[215.957172] Starting subtest: dpms-off-confusion-interruptible
[215.959384] Starting dynamic subtest: A-eDP1
[224.627245] Dynamic subtest A-eDP1: SUCCESS (8.668s)
[224.642432] Starting dynamic subtest: B-eDP1
[233.265540] Dynamic subtest B-eDP1: SUCCESS (8.634s)
[233.283622] Starting dynamic subtest: C-eDP1
[241.875948] Dynamic subtest C-eDP1: SUCCESS (8.606s)
[241.887519] Starting dynamic subtest: D-eDP1
[250.503186] Dynamic subtest D-eDP1: SUCCESS (8.622s)
[250.505615] Subtest dpms-off-confusion-interruptible: SUCCESS (34.542s)
[251.678716] [039/133] (766s left) kms_flip (flip-vs-panning-vs-hang)
[251.781323] Starting subtest: flip-vs-panning-vs-hang
[251.783589] Starting dynamic subtest: A-eDP1
[302.889046] Dynamic subtest A-eDP1: SUCCESS (51.107s)
[302.901611] Starting dynamic subtest: D-eDP1
[342.895707] Dynamic subtest D-eDP1: SUCCESS (39.999s)
[342.898858] Subtest flip-vs-panning-vs-hang: SUCCESS (91.109s)
[344.092107] [040/133] (674s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[344.206316] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[350.721324] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.518s)
[350.854678] [041/133] (667s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[350.958009] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[358.550907] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.593s)
[358.676825] [042/133] (659s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[358.779519] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[358.783617] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[358.865973] [043/133] (659s left) gem_userptr_blits (create-destroy-unsync)
[358.944263] Subtest create-destroy-unsync: SKIP (0.000s)
[359.057040] [044/133] (659s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[359.148538] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[359.152794] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[359.270534] [045/133] (659s left) kms_psr (fbc-pr-sprite-render)
[359.357518] Starting subtest: fbc-pr-sprite-render
[359.361717] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[359.432663] [046/133] (659s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[359.538968] Starting subtest: psr2-plane-move-sf-dmg-area
[359.540958] Starting dynamic subtest: pipe-A-eDP-1
[364.090740] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.551s)
[364.101294] Starting dynamic subtest: pipe-B-eDP-1
[369.433166] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.340s)
[369.435439] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.894s)
[370.298880] [047/133] (648s left) kms_psr (psr-primary-blt)
[370.397296] Starting subtest: psr-primary-blt
[370.399424] Starting dynamic subtest: eDP-1
[372.106253] Dynamic subtest eDP-1: SUCCESS (1.707s)
[372.108423] Subtest psr-primary-blt: SUCCESS (1.708s)
[372.974191] [048/133] (645s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[373.071987] Starting subtest: fbc-psr-sprite-mmap-cpu
[373.074513] Starting dynamic subtest: eDP-1
[373.078960] Dynamic subtest eDP-1: SKIP (0.000s)
[373.083347] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[373.155251] [049/133] (645s left) i915_drm_fdinfo (memory-info-idle)
[373.196970] Starting subtest: memory-info-idle
[373.199560] Starting dynamic subtest: smem0
[373.249453] Dynamic subtest smem0: SUCCESS (0.053s)
[373.252309] Subtest memory-info-idle: SUCCESS (0.054s)
[373.330040] [050/133] (645s left) kms_plane_scaling (invalid-parameters)
[373.414493] Starting subtest: invalid-parameters
[373.416714] Starting dynamic subtest: less-than-1-height-src
[373.426906] Dynamic subtest less-than-1-height-src: SUCCESS (0.013s)
[373.437400] Starting dynamic subtest: less-than-1-width-src
[373.442613] Dynamic subtest less-than-1-width-src: SUCCESS (0.013s)
[373.444904] Subtest invalid-parameters: SUCCESS (0.028s)
[373.532144] [051/133] (645s left) gem_exec_reloc (basic-gtt-active)
[373.599277] Subtest basic-gtt-active: SKIP (0.000s)
[373.680454] [052/133] (645s left) gem_mmap_gtt (close-race)
[373.751861] Subtest close-race: SKIP (0.000s)
[373.818157] [053/133] (645s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[373.908014] Starting subtest: compare-crc-sanitycheck-nv12
[373.910118] Starting dynamic subtest: pipe-A-eDP-1
[374.578328] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.672s)
[374.589269] Starting dynamic subtest: pipe-B-eDP-1
[375.858852] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.277s)
[375.873711] Starting dynamic subtest: pipe-C-eDP-1
[377.138839] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.279s)
[377.150936] Starting dynamic subtest: pipe-D-eDP-1
[378.408194] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.267s)
[378.410470] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.501s)
[379.231675] [054/133] (639s left) api_intel_allocator (fork-simple-once)
[379.298382] Starting subtest: fork-simple-once
[379.315611] Subtest fork-simple-once: SUCCESS (0.020s)
[379.436703] [055/133] (639s left) kms_vrr (max-min)
[379.529101] Starting subtest: max-min
[379.535578] Subtest max-min: SKIP (0.000s)
[379.607306] [056/133] (639s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[379.694045] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[379.698141] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[379.768779] [057/133] (639s left) gem_exec_params (sol-reset-invalid)
[379.817806] Starting subtest: sol-reset-invalid
[379.823678] Subtest sol-reset-invalid: SUCCESS (0.003s)
[381.460352] [058/133] (637s left) kms_lease (invalid-create-leases)
[381.543139] Starting subtest: invalid-create-leases
[381.547870] Subtest invalid-create-leases: SUCCESS (0.006s)
[381.656546] [059/133] (637s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[381.727515] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[381.829990] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[381.912417] [060/133] (637s left) kms_psr (pr-primary-page-flip)
[382.003160] Starting subtest: pr-primary-page-flip
[382.007429] Subtest pr-primary-page-flip: SKIP (0.000s)
[382.077339] [061/133] (637s left) gem_exec_params (readonly)
[382.130561] Starting subtest: readonly
[382.135407] Subtest readonly: SUCCESS (0.003s)
[382.257035] [062/133] (637s left) gem_mmap_gtt (basic-copy)
[382.309812] Subtest basic-copy: SKIP (0.000s)
[382.370568] [063/133] (637s left) kms_psr (psr2-sprite-mmap-cpu)
[382.460262] Starting subtest: psr2-sprite-mmap-cpu
[382.462193] Starting dynamic subtest: eDP-1
[384.209376] Dynamic subtest eDP-1: SUCCESS (1.748s)
[384.211741] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.749s)
[385.081784] [064/133] (634s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[385.174150] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[392.108207] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.934s)
[392.220602] [065/133] (627s left) drm_read (empty-nonblock)
[392.369111] Starting subtest: empty-nonblock
[392.371483] Subtest empty-nonblock: SUCCESS (0.000s)
[392.495610] [066/133] (627s left) perf_pmu (busy-no-semaphores)
[392.540740] Starting subtest: busy-no-semaphores
[392.543069] Starting dynamic subtest: rcs0
[393.096348] Dynamic subtest rcs0: SUCCESS (0.556s)
[393.107721] Starting dynamic subtest: bcs0
[393.645572] Dynamic subtest bcs0: SUCCESS (0.546s)
[393.657195] Starting dynamic subtest: vcs0
[394.194361] Dynamic subtest vcs0: SUCCESS (0.545s)
[394.207466] Starting dynamic subtest: vcs1
[395.909398] Dynamic subtest vcs1: SUCCESS (1.711s)
[395.922497] Starting dynamic subtest: vecs0
[397.892257] Dynamic subtest vecs0: SUCCESS (1.980s)
[397.904807] Starting dynamic subtest: ccs0
[399.879155] Dynamic subtest ccs0: SUCCESS (1.984s)
[399.881966] Subtest busy-no-semaphores: SUCCESS (7.341s)
[399.996414] [067/133] (619s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[400.089950] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[400.092287] Starting dynamic subtest: pipe-A-eDP-1
[400.101975] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[400.114510] Starting dynamic subtest: pipe-B-eDP-1
[400.123881] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[400.133965] Starting dynamic subtest: pipe-C-eDP-1
[400.142654] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[400.153083] Starting dynamic subtest: pipe-D-eDP-1
[400.161639] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[400.165761] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[402.327535] [068/133] (617s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[402.414903] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[402.417266] Starting dynamic subtest: pipe-A-eDP-1
[402.440437] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[402.452677] Starting dynamic subtest: pipe-B-eDP-1
[402.474681] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[402.484529] Starting dynamic subtest: pipe-C-eDP-1
[402.506679] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[402.516239] Starting dynamic subtest: pipe-D-eDP-1
[402.538700] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[402.543148] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[404.706477] [069/133] (615s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[404.809399] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[404.811760] Starting dynamic subtest: pipe-A
[405.036409] Dynamic subtest pipe-A: SUCCESS (0.229s)
[405.047089] Starting dynamic subtest: pipe-B
[406.381217] Dynamic subtest pipe-B: SUCCESS (1.344s)
[406.391751] Starting dynamic subtest: pipe-C
[407.695675] Dynamic subtest pipe-C: SUCCESS (1.313s)
[407.708449] Starting dynamic subtest: pipe-D
[409.020408] Dynamic subtest pipe-D: SUCCESS (1.325s)
[409.022792] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.215s)
[410.199412] [070/133] (609s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[410.307749] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[410.312315] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[410.406154] [071/133] (609s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[410.530942] Starting subtest: protected-encrypted-src-copy-not-readible
[410.653637] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.125s)
[410.783053] [072/133] (609s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[410.885449] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[414.794670] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.914s)
[416.025112] [073/133] (604s left) fbdev (read)
[416.069992] Starting subtest: read
[416.723554] Subtest read: SUCCESS (0.651s)
[416.787205] [074/133] (603s left) gem_exec_parallel (basic)
[416.850654] Starting subtest: basic
[416.853106] Starting dynamic subtest: rcs0
[418.297500] Dynamic subtest rcs0: SUCCESS (1.446s)
[418.307840] Starting dynamic subtest: bcs0
[419.778300] Dynamic subtest bcs0: SUCCESS (1.480s)
[419.791837] Starting dynamic subtest: vcs0
[421.402963] Dynamic subtest vcs0: SUCCESS (1.621s)
[421.416313] Starting dynamic subtest: vcs1
[423.363408] Dynamic subtest vcs1: SUCCESS (1.957s)
[423.376681] Starting dynamic subtest: vecs0
[425.410511] Dynamic subtest vecs0: SUCCESS (2.045s)
[425.422472] Starting dynamic subtest: ccs0
[426.917989] Dynamic subtest ccs0: SUCCESS (1.506s)
[426.920443] Subtest basic: SUCCESS (10.070s)
[427.118508] [075/133] (593s left) kms_dsc (dsc-with-formats)
[427.220034] Starting subtest: dsc-with-formats
[427.258792] Subtest dsc-with-formats: SKIP (0.001s)
[427.303596] [076/133] (592s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[427.395149] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[427.399202] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[427.485300] [077/133] (592s left) kms_cursor_crc (cursor-onscreen-512x512)
[427.759564] Starting subtest: cursor-onscreen-512x512
[427.764153] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[427.924736] [078/133] (592s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[428.024650] Starting subtest: plane-lut1d-pre-ctm3x4
[428.171110] Starting dynamic subtest: pipe-A-plane-0
[428.347698] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[428.358010] Starting dynamic subtest: pipe-A-plane-1
[428.514524] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[428.524773] Starting dynamic subtest: pipe-A-plane-2
[428.692162] Dynamic subtest pipe-A-plane-2: SUCCESS (0.177s)
[429.886001] Starting dynamic subtest: pipe-B-plane-0
[430.053861] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[430.064435] Starting dynamic subtest: pipe-B-plane-1
[430.230188] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s)
[430.240607] Starting dynamic subtest: pipe-B-plane-2
[430.397150] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[431.639283] Starting dynamic subtest: pipe-C-plane-0
[431.786356] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[431.797321] Starting dynamic subtest: pipe-C-plane-1
[431.941340] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[431.951984] Starting dynamic subtest: pipe-C-plane-2
[432.097286] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[433.351890] Starting dynamic subtest: pipe-D-plane-0
[433.489393] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[433.503394] Starting dynamic subtest: pipe-D-plane-1
[433.643281] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[433.654132] Starting dynamic subtest: pipe-D-plane-2
[433.787623] Dynamic subtest pipe-D-plane-2: SUCCESS (0.143s)
[434.075294] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (6.053s)
[434.901890] [079/133] (585s left) kms_invalid_mode (overflow-vrefresh)
[435.001212] Starting subtest: overflow-vrefresh
[435.003466] Starting dynamic subtest: pipe-A-eDP-1
[435.291653] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[435.302057] Starting dynamic subtest: pipe-B-eDP-1
[435.304255] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[435.314114] Starting dynamic subtest: pipe-C-eDP-1
[435.315991] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[435.325814] Starting dynamic subtest: pipe-D-eDP-1
[435.328086] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[435.330373] Subtest overflow-vrefresh: SUCCESS (0.298s)
[436.136419] [080/133] (584s left) kms_async_flips (invalid-async-flip-atomic)
[436.223824] Starting subtest: invalid-async-flip-atomic
[436.601010] Starting dynamic subtest: pipe-A-eDP-1
[437.461539] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.861s)
[437.831274] Starting dynamic subtest: pipe-B-eDP-1
[438.689940] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.867s)
[439.050237] Starting dynamic subtest: pipe-C-eDP-1
[439.898374] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.858s)
[440.256610] Starting dynamic subtest: pipe-D-eDP-1
[441.027188] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.780s)
[441.029558] Subtest invalid-async-flip-atomic: SUCCESS (4.807s)
[442.193058] [081/133] (578s left) kms_content_protection (dp-mst-type-0)
[442.337331] Starting subtest: dp-mst-type-0
[442.342180] Subtest dp-mst-type-0: SKIP (0.000s)
[442.470712] [082/133] (577s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[442.564813] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[442.569344] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[442.662467] [083/133] (577s left) kms_getfb (getfb2-into-addfb2)
[442.749143] Starting subtest: getfb2-into-addfb2
[442.751153] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[442.861212] [084/133] (577s left) i915_module_load (resize-bar)
[442.900850] Starting subtest: resize-bar
[442.907834] Subtest resize-bar: SKIP (0.006s)
[442.951274] [085/133] (577s left) kms_flip (plain-flip-fb-recreate-interruptible)
[443.043058] Starting subtest: plain-flip-fb-recreate-interruptible
[443.045335] Starting dynamic subtest: A-eDP1
[451.867996] Dynamic subtest A-eDP1: SUCCESS (8.824s)
[451.882976] Starting dynamic subtest: B-eDP1
[460.699017] Dynamic subtest B-eDP1: SUCCESS (8.828s)
[460.711056] Starting dynamic subtest: C-eDP1
[469.511625] Dynamic subtest C-eDP1: SUCCESS (8.811s)
[469.525106] Starting dynamic subtest: D-eDP1
[478.343579] Dynamic subtest D-eDP1: SUCCESS (8.829s)
[478.348649] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.306s)
[479.534288] [086/133] (541s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[479.636245] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[480.260734] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.626s)
[480.416801] [087/133] (540s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[480.471537] Starting subtest: single-wait-for-submit-available-signaled
[480.473506] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[480.563969] [088/133] (540s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[480.657877] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[480.660167] Starting dynamic subtest: pipe-A-default-mode
[481.785617] Dynamic subtest pipe-A-default-mode: SKIP (1.126s)
[481.789470] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.127s)
[481.946905] [089/133] (538s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[482.070464] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[482.075079] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[482.240065] [090/133] (538s left) gem_exec_schedule (preempt-queue)
[482.322712] Subtest preempt-queue: SKIP (0.000s)
[482.627244] [091/133] (538s left) kms_cdclk (mode-transition-all-outputs)
[482.718986] Starting subtest: mode-transition-all-outputs
[483.007014] Subtest mode-transition-all-outputs: SKIP (0.287s)
[483.893767] [092/133] (536s left) gem_workarounds (reset-fd)
[483.958853] Starting subtest: reset-fd
[484.150710] Subtest reset-fd: SUCCESS (0.190s)
[484.283974] [093/133] (536s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[484.377222] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[484.381675] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[484.477774] [094/133] (536s left) gem_close_race (multigpu-basic-threads)
[484.554067] Starting subtest: multigpu-basic-threads
[484.558117] Subtest multigpu-basic-threads: SKIP (0.000s)
[484.788534] [095/133] (536s left) gem_exec_params (no-bsd)
[484.847861] Starting subtest: no-bsd
[484.850278] Subtest no-bsd: SUCCESS (0.002s)
[486.479441] [096/133] (534s left) kms_plane_multiple (2x-tiling-yf)
[486.583061] Starting subtest: 2x-tiling-yf
[486.587532] Subtest 2x-tiling-yf: SKIP (0.000s)
[486.660148] [097/133] (534s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[486.731494] Starting subtest: invalid-bsd2-flag-on-blt
[486.733871] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[486.827496] [098/133] (534s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[486.929411] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[491.944646] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (5.018s)
[493.104323] [099/133] (528s left) kms_pm_rpm (pm-tiling)
[494.629570] Starting subtest: pm-tiling
[494.634360] Subtest pm-tiling: SKIP (0.000s)
[495.342143] [100/133] (525s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[495.397726] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[495.503012] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[495.582252] [101/133] (525s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[495.632807] Starting subtest: invalid-multi-wait-unsubmitted
[495.634886] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[495.739384] [102/133] (525s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[495.838267] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[495.842652] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[495.934488] [103/133] (525s left) kms_chamelium_frames (hdmi-crc-single)
[496.331271] Subtest hdmi-crc-single: SKIP (0.000s)
[497.141422] [104/133] (524s left) syncobj_wait (multi-wait-submitted-signaled)
[497.192421] Starting subtest: multi-wait-submitted-signaled
[497.194451] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[497.284369] [105/133] (524s left) gem_userptr_blits (coherency-sync)
[497.346555] Starting subtest: coherency-sync
[497.727820] Subtest coherency-sync: SKIP (0.343s)
[497.828776] [106/133] (523s left) kms_vblank (ts-continuation-idle-hang)
[497.975640] Starting subtest: ts-continuation-idle-hang
[497.977715] Starting dynamic subtest: pipe-A-eDP-1
[524.176768] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.196s)
[524.192830] Starting dynamic subtest: pipe-D-eDP-1
[550.149618] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.964s)
[550.151838] Subtest ts-continuation-idle-hang: SUCCESS (52.165s)
[551.055590] [107/133] (470s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[551.158434] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[551.162556] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[551.255844] [108/133] (470s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[551.380932] Starting subtest: 2x-cursor-vs-flip-legacy
[551.385474] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[551.542631] [109/133] (470s left) gem_exec_balancer (parallel-balancer)
[551.801681] Starting subtest: parallel-balancer
[552.814847] Subtest parallel-balancer: SUCCESS (1.013s)
[552.922864] [110/133] (468s left) perf (stress-open-close)
[553.086029] Starting subtest: stress-open-close
[553.088152] Starting dynamic subtest: 0-rcs0
[555.259220] Dynamic subtest 0-rcs0: SUCCESS (2.175s)
[555.271764] Starting dynamic subtest: 1-vecs0
[557.424612] Dynamic subtest 1-vecs0: SUCCESS (2.164s)
[557.426611] Subtest stress-open-close: SUCCESS (4.341s)
[557.475141] [111/133] (464s left) gem_ctx_shared (create-shared-gtt)
[557.564995] Starting subtest: create-shared-gtt
[559.726347] Subtest create-shared-gtt: SUCCESS (2.159s)
[560.026650] [112/133] (461s left) kms_addfb_basic (small-bo)
[560.122670] Starting subtest: small-bo
[560.124829] Subtest small-bo: SUCCESS (0.000s)
[560.215772] [113/133] (461s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[560.309593] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[560.311987] Starting dynamic subtest: pipe-A-eDP-1
[560.332085] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[560.346473] Starting dynamic subtest: pipe-B-eDP-1
[560.365208] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[560.375764] Starting dynamic subtest: pipe-C-eDP-1
[560.394508] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[560.405127] Starting dynamic subtest: pipe-D-eDP-1
[560.424046] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[560.426168] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[562.573810] [114/133] (459s left) syncobj_timeline (wait-delayed-signal)
[562.634181] Starting subtest: wait-delayed-signal
[562.736861] Subtest wait-delayed-signal: SUCCESS (0.102s)
[562.817221] [115/133] (459s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[562.910188] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[562.914417] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[563.010661] [116/133] (458s left) gem_mmap_gtt (hang-user)
[563.063456] Subtest hang-user: SKIP (0.000s)
[563.122513] [117/133] (458s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[563.189497] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[563.294705] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[563.371720] [118/133] (458s left) gem_tiled_wc
[563.495155] [119/133] (458s left) i915_pm_rps (thresholds-park)
[563.563449] Starting subtest: thresholds-park
[563.568157] Subtest thresholds-park: SKIP (0.001s)
[563.664481] [120/133] (458s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[563.767840] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[563.772190] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[563.874055] [121/133] (458s left) kms_busy (extended-pageflip-hang-newfb)
[563.980946] Starting subtest: extended-pageflip-hang-newfb
[563.983128] Starting dynamic subtest: pipe-A
[590.164364] Dynamic subtest pipe-A: SUCCESS (26.179s)
[590.175426] Starting dynamic subtest: pipe-D
[605.150337] Dynamic subtest pipe-D: SUCCESS (14.979s)
[605.152572] Subtest extended-pageflip-hang-newfb: SUCCESS (41.163s)
[605.949805] [122/133] (416s left) gem_spin_batch (engines)
[606.018637] Starting subtest: engines
[606.021068] Starting dynamic subtest: rcs0
[609.262302] Dynamic subtest rcs0: SUCCESS (3.237s)
[609.275515] Starting dynamic subtest: bcs0
[612.502612] Dynamic subtest bcs0: SUCCESS (3.236s)
[612.513702] Starting dynamic subtest: vcs0
[615.739227] Dynamic subtest vcs0: SUCCESS (3.234s)
[615.754980] Starting dynamic subtest: vcs1
[618.978537] Dynamic subtest vcs1: SUCCESS (3.236s)
[618.991106] Starting dynamic subtest: vecs0
[622.217424] Dynamic subtest vecs0: SUCCESS (3.235s)
[622.230806] Starting dynamic subtest: ccs0
[625.457422] Dynamic subtest ccs0: SUCCESS (3.237s)
[625.459625] Subtest engines: SUCCESS (19.432s)
[625.690960] [123/133] (396s left) kms_sequence (get-busy)
[625.780689] Starting subtest: get-busy
[625.782907] Starting dynamic subtest: pipe-A-eDP-1
[627.717269] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s)
[627.728940] Starting dynamic subtest: pipe-B-eDP-1
[630.362094] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.644s)
[630.373337] Starting dynamic subtest: pipe-C-eDP-1
[632.952891] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.586s)
[632.964738] Starting dynamic subtest: pipe-D-eDP-1
[635.510500] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.558s)
[635.512856] Subtest get-busy: SUCCESS (9.728s)
[636.378401] [124/133] (385s left) gem_exec_reloc (basic-cpu-read)
[636.451321] Subtest basic-cpu-read: SKIP (0.000s)
[636.532758] [125/133] (385s left) gem_exec_whisper (basic-forked-all)
[636.601033] Starting subtest: basic-forked-all
[650.374898] Subtest basic-forked-all: SUCCESS (13.767s)
[650.574521] [126/133] (371s left) kms_flip (basic-flip-vs-wf_vblank)
[650.675828] Starting subtest: basic-flip-vs-wf_vblank
[650.678240] Starting dynamic subtest: A-eDP1
[652.634454] Dynamic subtest A-eDP1: SUCCESS (1.960s)
[652.650075] Starting dynamic subtest: B-eDP1
[654.564492] Dynamic subtest B-eDP1: SUCCESS (1.927s)
[654.580426] Starting dynamic subtest: C-eDP1
[656.491785] Dynamic subtest C-eDP1: SUCCESS (1.923s)
[656.503761] Starting dynamic subtest: D-eDP1
[658.427524] Dynamic subtest D-eDP1: SUCCESS (1.935s)
[658.432459] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.759s)
[659.659612] [127/133] (362s left) core_auth (getclient-simple)
[659.696861] Starting subtest: getclient-simple
[659.713619] Subtest getclient-simple: SUCCESS (0.017s)
[659.842998] [128/133] (362s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[659.950149] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[659.954567] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[660.052084] [129/133] (362s left) perf (low-oa-exponent-permissions)
[660.154883] Starting subtest: low-oa-exponent-permissions
[660.189445] Subtest low-oa-exponent-permissions: SUCCESS (0.038s)
[660.241663] [130/133] (362s left) gem_vm_create (execbuf)
[660.296703] Starting subtest: execbuf
[660.303756] Subtest execbuf: SUCCESS (0.007s)
[660.439682] [131/133] (362s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[660.533030] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[661.601108] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.068s)
[661.736195] [132/133] (360s left) gem_mmap_gtt (basic-small-bo)
[661.797572] Subtest basic-small-bo: SKIP (0.000s)
[661.862810] [133/133] (360s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[661.964007] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[661.967524] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[662.078007] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: prime_mmap
results: parsing output: 3/ for test: gem_exec_reloc
results: parsing output: 4/ for test: gem_ctx_isolation
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: gem_exec_fence
results: parsing output: 7/ for test: kms_rotation_crc
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_psr2_sf
results: parsing output: 10/ for test: gem_exec_flush
results: parsing output: 11/ for test: gem_ctx_bad_destroy
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_cursor_legacy
results: parsing output: 14/ for test: kms_cursor_crc
results: parsing output: 15/ for test: kms_chamelium_hpd
results: parsing output: 16/ for test: gem_ctx_shared
results: parsing output: 17/ for test: gem_ctx_param
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_addfb_basic
results: parsing output: 21/ for test: kms_cursor_crc
results: parsing output: 22/ for test: core_getversion
results: parsing output: 23/ for test: gem_pread
results: parsing output: 24/ for test: gen9_exec_parse
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_ctx_param
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_async_flips
results: parsing output: 29/ for test: gem_exec_balancer
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: i915_pm_rpm
results: parsing output: 33/ for test: kms_pm_rpm
results: parsing output: 34/ for test: gem_render_copy
results: parsing output: 35/ for test: gem_exec_whisper
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_psr2_sf
results: parsing output: 42/ for test: gem_userptr_blits
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_psr2_sf
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: i915_drm_fdinfo
results: parsing output: 49/ for test: kms_plane_scaling
results: parsing output: 50/ for test: gem_exec_reloc
results: parsing output: 51/ for test: gem_mmap_gtt
results: parsing output: 52/ for test: kms_pipe_crc_basic
results: parsing output: 53/ for test: api_intel_allocator
results: parsing output: 54/ for test: kms_vrr
results: parsing output: 55/ for test: kms_flip_scaled_crc
results: parsing output: 56/ for test: gem_exec_params
results: parsing output: 57/ for test: kms_lease
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: gem_exec_params
results: parsing output: 61/ for test: gem_mmap_gtt
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: drm_read
results: parsing output: 65/ for test: perf_pmu
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_pxp
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: fbdev
results: parsing output: 73/ for test: gem_exec_parallel
results: parsing output: 74/ for test: kms_dsc
results: parsing output: 75/ for test: kms_plane
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: kms_color_pipeline
results: parsing output: 78/ for test: kms_invalid_mode
results: parsing output: 79/ for test: kms_async_flips
results: parsing output: 80/ for test: kms_content_protection
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_getfb
results: parsing output: 83/ for test: i915_module_load
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: kms_flip_scaled_crc
results: parsing output: 88/ for test: kms_cursor_legacy
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: kms_cdclk
results: parsing output: 91/ for test: gem_workarounds
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_close_race
results: parsing output: 94/ for test: gem_exec_params
results: parsing output: 95/ for test: kms_plane_multiple
results: parsing output: 96/ for test: gem_exec_params
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_pm_rpm
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_chamelium_frames
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: kms_vblank
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: gem_exec_balancer
results: parsing output: 109/ for test: perf
results: parsing output: 110/ for test: gem_ctx_shared
results: parsing output: 111/ for test: kms_addfb_basic
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_mmap_gtt
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: gem_tiled_wc
results: parsing output: 118/ for test: i915_pm_rps
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_busy
results: parsing output: 121/ for test: gem_spin_batch
results: parsing output: 122/ for test: kms_sequence
results: parsing output: 123/ for test: gem_exec_reloc
results: parsing output: 124/ for test: gem_exec_whisper
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: core_auth
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: perf
results: parsing output: 129/ for test: gem_vm_create
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: gem_mmap_gtt
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.