[56.999024] Initializing watchdogs
[56.999071]   /dev/watchdog0
[57.014442] [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]
[57.018864] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.021558] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.023546] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[57.134577] Starting subtest: fbcpsr-indfb-scaledprimary
[62.900917] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.766s)
[63.026927] [002/133] (954s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[63.118047] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[70.078591] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.961s)
[70.207796] [003/133] (947s left) prime_mmap (test_correct)
[70.254030] Starting subtest: test_correct
[70.255119] Starting dynamic subtest: test_correct-smem
[70.342763] Dynamic subtest test_correct-smem: SUCCESS (0.088s)
[70.344437] Subtest test_correct: SUCCESS (0.089s)
[70.450523] [004/133] (947s left) gem_exec_reloc (basic-write-read)
[70.506183] Subtest basic-write-read: SKIP (0.000s)
[70.561878] [005/133] (947s left) gem_ctx_isolation (preservation)
[70.613486] Starting subtest: preservation
[70.614470] Starting dynamic subtest: rcs0
[70.747055] Dynamic subtest rcs0: SUCCESS (0.132s)
[70.757117] Starting dynamic subtest: bcs0
[70.909075] Dynamic subtest bcs0: SUCCESS (0.161s)
[70.915700] Starting dynamic subtest: vcs0
[71.058565] Dynamic subtest vcs0: SUCCESS (0.149s)
[71.068300] Starting dynamic subtest: vcs1
[72.510489] Dynamic subtest vcs1: SUCCESS (1.452s)
[72.521514] Starting dynamic subtest: vecs0
[74.476058] Dynamic subtest vecs0: SUCCESS (1.963s)
[74.484697] Starting dynamic subtest: ccs0
[76.457565] Dynamic subtest ccs0: SUCCESS (1.982s)
[76.458770] Subtest preservation: SUCCESS (5.844s)
[76.692060] [006/133] (940s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[76.792749] Starting subtest: x-tiled-16bpp-rotate-270
[76.812539] Subtest x-tiled-16bpp-rotate-270: SKIP (0.020s)
[76.921535] [007/133] (940s left) gem_exec_fence (long-history)
[77.359921] Starting subtest: long-history
[85.057102] Subtest long-history: SUCCESS (7.689s)
[85.556445] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true
[85.558619] [008/133] (932s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[85.639938] Starting subtest: primary-yf-tiled-reflect-x-180
[85.700449] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[85.797324] [009/133] (931s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[85.849074] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[85.850056] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[85.942643] [010/133] (931s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[86.038440] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[86.042899] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[86.100918] [011/133] (931s left) gem_exec_flush (basic-uc-set-default)
[86.155040] Starting subtest: basic-uc-set-default
[91.606089] Subtest basic-uc-set-default: SUCCESS (5.454s)
[91.789362] [012/133] (926s left) gem_ctx_bad_destroy (double-destroy)
[91.831239] Starting subtest: double-destroy
[91.832131] Subtest double-destroy: SUCCESS (0.000s)
[91.902254] [013/133] (926s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[92.001102] Starting subtest: y-tiled-32bpp-rotate-0
[92.002821] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[92.086774] [014/133] (925s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[92.196924] Starting subtest: 2x-flip-vs-cursor-legacy
[92.199703] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[92.332602] [015/133] (925s left) kms_cursor_crc (cursor-random-256x256)
[92.567563] Starting subtest: cursor-random-256x256
[92.571911] Starting dynamic subtest: pipe-A-eDP-1
[95.941572] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.372s)
[95.972781] Starting dynamic subtest: pipe-D-eDP-1
[99.972304] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.006s)
[99.973290] Subtest cursor-random-256x256: SUCCESS (7.407s)
[100.828445] [016/133] (917s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[101.198192] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[102.027165] [017/133] (916s left) gem_ctx_shared (q-independent)
[102.086598] Starting subtest: Q-independent
[102.087468] Starting dynamic subtest: rcs0
[102.158676] Dynamic subtest rcs0: SUCCESS (0.072s)
[102.166862] Starting dynamic subtest: vcs0
[102.208143] Dynamic subtest vcs0: SUCCESS (0.050s)
[102.218834] Starting dynamic subtest: vcs1
[102.247700] Dynamic subtest vcs1: SUCCESS (0.039s)
[102.255655] Starting dynamic subtest: vecs0
[102.293191] Dynamic subtest vecs0: SUCCESS (0.045s)
[102.302594] Starting dynamic subtest: ccs0
[102.343548] Dynamic subtest ccs0: SUCCESS (0.050s)
[102.344941] Subtest Q-independent: SUCCESS (0.257s)
[103.401325] [018/133] (914s left) gem_ctx_param (basic-default)
[103.452422] Starting subtest: basic-default
[103.453434] Subtest basic-default: SUCCESS (0.000s)
[103.526052] [019/133] (914s left) gem_exec_schedule (preempt-queue-contexts-chain)
[103.586709] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[103.874574] [020/133] (914s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[103.973231] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[103.974138] Starting dynamic subtest: pipe-A-eDP-1
[103.982863] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[103.990421] Starting dynamic subtest: pipe-B-eDP-1
[103.998657] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[104.005416] Starting dynamic subtest: pipe-C-eDP-1
[104.013405] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[104.019932] Starting dynamic subtest: pipe-D-eDP-1
[104.028019] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[104.029737] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[106.128481] [021/133] (912s left) kms_addfb_basic (tile-pitch-mismatch)
[106.169777] Starting subtest: tile-pitch-mismatch
[106.171881] Subtest tile-pitch-mismatch: SKIP (0.000s)
[106.302149] [022/133] (911s left) kms_cursor_crc (cursor-suspend)
[106.426826] Starting subtest: cursor-suspend
[106.427687] Starting dynamic subtest: pipe-A-eDP-1
[140.188351] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.057s)
[140.196754] Starting dynamic subtest: pipe-D-eDP-1
[175.176857] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.545s)
[175.177791] Subtest cursor-suspend: SUCCESS (8.604s)
[182.053889] [023/133] (842s left) core_getversion (basic)
[182.102367] Starting subtest: basic
[182.104109] Subtest basic: SUCCESS (0.000s)
[182.175918] [024/133] (842s left) gem_pread (bench)
[182.239409] Subtest bench: SKIP (0.000s)
[182.298272] [025/133] (842s left) gen9_exec_parse (bb-start-far)
[182.362024] Subtest bb-start-far: SKIP (0.000s)
[182.422734] [026/133] (841s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[182.521603] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[182.523425] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[182.610582] [027/133] (841s left) gem_ctx_param (get-priority-new-ctx)
[182.665090] Starting subtest: get-priority-new-ctx
[182.666020] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[182.775282] [028/133] (841s left) kms_big_fb (linear-8bpp-rotate-90)
[182.878154] Starting subtest: linear-8bpp-rotate-90
[182.898920] Subtest linear-8bpp-rotate-90: SKIP (0.021s)
[183.022643] [029/133] (841s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[183.115173] Starting subtest: basic-modeset-with-all-modifiers-formats
[183.488715] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[184.283151] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.794s)
[184.290844] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[184.303846] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.020s)
[184.310966] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[184.326333] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[184.334041] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[184.470754] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.144s)
[184.478739] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[184.492752] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[184.502792] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[184.515161] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[184.524080] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[184.537270] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[184.545361] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[184.559540] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[184.567772] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[184.581748] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[184.588834] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[184.604023] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[184.611137] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[184.626287] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[184.633336] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[184.649305] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[184.658140] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[184.804302] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[184.812889] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[184.826569] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[184.834008] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[184.848736] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[184.855887] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[184.870883] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[184.877897] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[184.893206] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[184.901430] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[184.915446] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[184.926452] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[184.937722] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[184.948121] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[184.959908] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[184.967633] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[184.981981] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[184.989398] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[185.149233] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.167s)
[185.157973] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[185.171358] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[185.178769] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[185.193582] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[185.200762] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[185.215731] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[185.222985] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[185.238050] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[185.245128] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[185.260290] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[185.267708] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[185.282635] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[185.291921] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[185.304772] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[185.313547] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[185.327388] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[185.731306] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.615s)
[186.556724] [030/133] (837s left) gem_exec_balancer (persistence)
[186.824678] Starting subtest: persistence
[187.795420] Subtest persistence: SUCCESS (0.968s)
[187.905899] [031/133] (836s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[187.998164] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[187.999940] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[188.090055] [032/133] (836s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[188.185480] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[188.187258] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[188.275894] [033/133] (836s left) i915_pm_rpm (gem-pread)
[189.792613] Starting subtest: gem-pread
[192.176327] Subtest gem-pread: SUCCESS (2.386s)
[192.293008] [034/133] (832s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[193.808875] Starting subtest: dpms-mode-unset-lpsp
[197.870545] Subtest dpms-mode-unset-lpsp: SUCCESS (4.062s)
[198.251737] [035/133] (826s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[198.316895] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[198.318733] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[198.505752] [036/133] (826s left) gem_exec_whisper (basic-queues-priority)
[198.569158] Starting subtest: basic-queues-priority
[221.717686] Subtest basic-queues-priority: SUCCESS (23.137s)
[221.893411] [037/133] (802s left) kms_addfb_basic (addfb25-modifier-no-flag)
[221.983895] Starting subtest: addfb25-modifier-no-flag
[221.984786] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[222.083578] [038/133] (802s left) kms_flip (dpms-off-confusion-interruptible)
[222.175425] Starting subtest: dpms-off-confusion-interruptible
[222.177456] Starting dynamic subtest: A-eDP1
[230.877561] Dynamic subtest A-eDP1: SUCCESS (8.673s)
[230.888067] Starting dynamic subtest: B-eDP1
[239.475590] Dynamic subtest B-eDP1: SUCCESS (8.621s)
[239.484990] Starting dynamic subtest: C-eDP1
[248.128279] Dynamic subtest C-eDP1: SUCCESS (8.613s)
[248.138512] Starting dynamic subtest: D-eDP1
[256.721660] Dynamic subtest D-eDP1: SUCCESS (8.629s)
[256.725402] Subtest dpms-off-confusion-interruptible: SUCCESS (34.547s)
[257.890117] [039/133] (766s left) kms_flip (flip-vs-panning-vs-hang)
[257.992031] Starting subtest: flip-vs-panning-vs-hang
[257.992862] Starting dynamic subtest: A-eDP1
[308.922100] Dynamic subtest A-eDP1: SUCCESS (50.927s)
[308.932253] Starting dynamic subtest: D-eDP1
[358.969342] Dynamic subtest D-eDP1: SUCCESS (50.044s)
[358.972471] Subtest flip-vs-panning-vs-hang: SUCCESS (100.975s)
[360.168184] [040/133] (664s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[360.263338] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[366.826944] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.564s)
[366.934005] [041/133] (657s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[367.032207] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[374.469144] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.438s)
[374.593172] [042/133] (650s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[374.682883] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[374.684506] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[374.751629] [043/133] (650s left) gem_userptr_blits (create-destroy-unsync)
[374.813256] Subtest create-destroy-unsync: SKIP (0.000s)
[374.938091] [044/133] (650s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[375.025622] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[375.027331] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[375.109921] [045/133] (649s left) kms_psr (fbc-pr-sprite-render)
[375.196263] Starting subtest: fbc-pr-sprite-render
[375.198145] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[375.264318] [046/133] (649s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[375.360493] Starting subtest: psr2-plane-move-sf-dmg-area
[375.361430] Starting dynamic subtest: pipe-A-eDP-1
[379.852539] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.491s)
[379.861501] Starting dynamic subtest: pipe-B-eDP-1
[385.198837] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.345s)
[385.199730] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.838s)
[386.069018] [047/133] (639s left) kms_psr (psr-primary-blt)
[386.151116] Starting subtest: psr-primary-blt
[386.151956] Starting dynamic subtest: eDP-1
[387.881567] Dynamic subtest eDP-1: SUCCESS (1.730s)
[387.882465] Subtest psr-primary-blt: SUCCESS (1.731s)
[388.745903] [048/133] (636s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[388.839203] Starting subtest: fbc-psr-sprite-mmap-cpu
[388.840289] Starting dynamic subtest: eDP-1
[388.842120] Dynamic subtest eDP-1: SKIP (0.000s)
[388.843866] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[388.908089] [049/133] (636s left) i915_drm_fdinfo (memory-info-idle)
[388.944114] Starting subtest: memory-info-idle
[388.945291] Starting dynamic subtest: smem0
[388.999148] Dynamic subtest smem0: SUCCESS (0.054s)
[389.000508] Subtest memory-info-idle: SUCCESS (0.055s)
[389.071098] [050/133] (636s left) kms_plane_scaling (invalid-parameters)
[389.153424] Starting subtest: invalid-parameters
[389.154359] Starting dynamic subtest: less-than-1-height-src
[389.166169] Dynamic subtest less-than-1-height-src: SUCCESS (0.013s)
[389.174252] Starting dynamic subtest: less-than-1-width-src
[389.180217] Dynamic subtest less-than-1-width-src: SUCCESS (0.013s)
[389.181240] Subtest invalid-parameters: SUCCESS (0.028s)
[389.274442] [051/133] (635s left) gem_exec_reloc (basic-gtt-active)
[389.331028] Subtest basic-gtt-active: SKIP (0.000s)
[389.383546] [052/133] (635s left) gem_mmap_gtt (close-race)
[389.440096] Subtest close-race: SKIP (0.000s)
[389.498777] [053/133] (635s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[389.582293] Starting subtest: compare-crc-sanitycheck-nv12
[389.583252] Starting dynamic subtest: pipe-A-eDP-1
[390.266625] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.684s)
[390.274634] Starting dynamic subtest: pipe-B-eDP-1
[391.536529] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.269s)
[391.546009] Starting dynamic subtest: pipe-C-eDP-1
[392.817308] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.278s)
[392.825466] Starting dynamic subtest: pipe-D-eDP-1
[394.054623] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[394.055822] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.471s)
[394.888812] [054/133] (630s left) api_intel_allocator (fork-simple-once)
[394.943293] Starting subtest: fork-simple-once
[394.958276] Subtest fork-simple-once: SUCCESS (0.016s)
[395.083243] [055/133] (630s left) kms_vrr (max-min)
[395.169333] Starting subtest: max-min
[395.172018] Subtest max-min: SKIP (0.000s)
[395.238763] [056/133] (630s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[395.324327] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[395.326070] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[395.394852] [057/133] (630s left) gem_exec_params (sol-reset-invalid)
[395.449146] Starting subtest: sol-reset-invalid
[395.452817] Subtest sol-reset-invalid: SUCCESS (0.002s)
[397.529267] [058/133] (627s left) kms_lease (invalid-create-leases)
[397.621174] Starting subtest: invalid-create-leases
[397.625837] Subtest invalid-create-leases: SUCCESS (0.005s)
[397.715957] [059/133] (627s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[397.769084] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[397.876833] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[397.946395] [060/133] (627s left) kms_psr (pr-primary-page-flip)
[398.029180] Starting subtest: pr-primary-page-flip
[398.031174] Subtest pr-primary-page-flip: SKIP (0.000s)
[398.097014] [061/133] (627s left) gem_exec_params (readonly)
[398.151777] Starting subtest: readonly
[398.155119] Subtest readonly: SUCCESS (0.002s)
[398.253967] [062/133] (627s left) gem_mmap_gtt (basic-copy)
[398.312679] Subtest basic-copy: SKIP (0.000s)
[398.362951] [063/133] (627s left) kms_psr (psr2-sprite-mmap-cpu)
[398.449344] Starting subtest: psr2-sprite-mmap-cpu
[398.450268] Starting dynamic subtest: eDP-1
[400.206259] Dynamic subtest eDP-1: SUCCESS (1.757s)
[400.207190] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.758s)
[401.070467] [064/133] (624s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[401.155209] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[408.096288] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.942s)
[408.209065] [065/133] (617s left) drm_read (empty-nonblock)
[408.366884] Starting subtest: empty-nonblock
[408.367959] Subtest empty-nonblock: SUCCESS (0.000s)
[408.476209] [066/133] (617s left) perf_pmu (busy-no-semaphores)
[408.509690] Starting subtest: busy-no-semaphores
[408.510646] Starting dynamic subtest: rcs0
[409.073319] Dynamic subtest rcs0: SUCCESS (0.553s)
[409.084399] Starting dynamic subtest: bcs0
[409.625460] Dynamic subtest bcs0: SUCCESS (0.549s)
[409.636533] Starting dynamic subtest: vcs0
[410.176863] Dynamic subtest vcs0: SUCCESS (0.549s)
[410.187605] Starting dynamic subtest: vcs1
[411.996556] Dynamic subtest vcs1: SUCCESS (1.816s)
[412.007211] Starting dynamic subtest: vecs0
[413.984003] Dynamic subtest vecs0: SUCCESS (1.985s)
[413.994822] Starting dynamic subtest: ccs0
[416.029435] Dynamic subtest ccs0: SUCCESS (2.042s)
[416.030756] Subtest busy-no-semaphores: SUCCESS (7.511s)
[416.132807] [067/133] (609s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[416.224947] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[416.225768] Starting dynamic subtest: pipe-A-eDP-1
[416.229268] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[416.237676] Starting dynamic subtest: pipe-B-eDP-1
[416.241379] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[416.249638] Starting dynamic subtest: pipe-C-eDP-1
[416.253226] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[416.261505] Starting dynamic subtest: pipe-D-eDP-1
[416.264823] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[416.266493] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[418.506993] [068/133] (607s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[418.599175] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[418.600047] Starting dynamic subtest: pipe-A-eDP-1
[418.608552] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[418.617717] Starting dynamic subtest: pipe-B-eDP-1
[418.626372] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[418.635148] Starting dynamic subtest: pipe-C-eDP-1
[418.643185] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[418.651356] Starting dynamic subtest: pipe-D-eDP-1
[418.660085] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[418.661725] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[420.777103] [069/133] (605s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[420.863570] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[420.864491] Starting dynamic subtest: pipe-A
[421.091756] Dynamic subtest pipe-A: SUCCESS (0.229s)
[421.100901] Starting dynamic subtest: pipe-B
[422.366995] Dynamic subtest pipe-B: SUCCESS (1.274s)
[422.375816] Starting dynamic subtest: pipe-C
[423.731980] Dynamic subtest pipe-C: SUCCESS (1.364s)
[423.740507] Starting dynamic subtest: pipe-D
[425.051164] Dynamic subtest pipe-D: SUCCESS (1.318s)
[425.052010] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.189s)
[426.233722] [070/133] (599s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[426.331366] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[426.333142] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[426.430846] [071/133] (599s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[426.553136] Starting subtest: protected-encrypted-src-copy-not-readible
[426.682975] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.116s)
[426.788262] [072/133] (599s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[426.887859] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[430.820538] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.932s)
[431.946561] [073/133] (594s left) fbdev (read)
[431.978765] Starting subtest: read
[432.519514] Subtest read: SUCCESS (0.532s)
[432.568634] [074/133] (593s left) gem_exec_parallel (basic)
[432.624666] Starting subtest: basic
[432.625752] Starting dynamic subtest: rcs0
[434.025234] Dynamic subtest rcs0: SUCCESS (1.400s)
[434.034499] Starting dynamic subtest: bcs0
[435.501895] Dynamic subtest bcs0: SUCCESS (1.475s)
[435.513671] Starting dynamic subtest: vcs0
[437.465196] Dynamic subtest vcs0: SUCCESS (1.951s)
[437.473994] Starting dynamic subtest: vcs1
[439.449306] Dynamic subtest vcs1: SUCCESS (1.981s)
[439.460418] Starting dynamic subtest: vecs0
[441.498017] Dynamic subtest vecs0: SUCCESS (2.046s)
[441.508664] Starting dynamic subtest: ccs0
[442.952516] Dynamic subtest ccs0: SUCCESS (1.462s)
[442.953445] Subtest basic: SUCCESS (10.328s)
[443.139520] [075/133] (582s left) kms_dsc (dsc-with-formats)
[443.244048] Starting subtest: dsc-with-formats
[443.264366] Subtest dsc-with-formats: SKIP (0.001s)
[443.313430] [076/133] (582s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[443.395415] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[443.397271] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[443.480056] [077/133] (582s left) kms_cursor_crc (cursor-onscreen-512x512)
[443.742067] Starting subtest: cursor-onscreen-512x512
[443.744053] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[443.911486] [078/133] (582s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[444.008201] Starting subtest: plane-lut1d-pre-ctm3x4
[444.188670] Starting dynamic subtest: pipe-A-plane-0
[444.366157] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[444.375095] Starting dynamic subtest: pipe-A-plane-1
[444.532962] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[444.542181] Starting dynamic subtest: pipe-A-plane-2
[444.700125] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[445.928314] Starting dynamic subtest: pipe-B-plane-0
[446.075706] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[446.084891] Starting dynamic subtest: pipe-B-plane-1
[446.231086] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[446.240591] Starting dynamic subtest: pipe-B-plane-2
[446.431246] Dynamic subtest pipe-B-plane-2: SUCCESS (0.199s)
[447.681541] Starting dynamic subtest: pipe-C-plane-0
[447.828835] Dynamic subtest pipe-C-plane-0: SUCCESS (0.156s)
[447.840163] Starting dynamic subtest: pipe-C-plane-1
[447.984343] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[447.995314] Starting dynamic subtest: pipe-C-plane-2
[448.128722] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[449.275039] Starting dynamic subtest: pipe-D-plane-0
[449.433313] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[449.442142] Starting dynamic subtest: pipe-D-plane-1
[449.590512] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[449.599091] Starting dynamic subtest: pipe-D-plane-2
[449.733307] Dynamic subtest pipe-D-plane-2: SUCCESS (0.143s)
[450.019690] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (6.012s)
[450.839915] [079/133] (575s left) kms_invalid_mode (overflow-vrefresh)
[450.928508] Starting subtest: overflow-vrefresh
[450.929403] Starting dynamic subtest: pipe-A-eDP-1
[451.214300] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[451.227640] Starting dynamic subtest: pipe-B-eDP-1
[451.228462] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[451.236662] Starting dynamic subtest: pipe-C-eDP-1
[451.237509] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[451.247389] Starting dynamic subtest: pipe-D-eDP-1
[451.248505] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[451.249408] Subtest overflow-vrefresh: SUCCESS (0.295s)
[452.066048] [080/133] (574s left) kms_async_flips (invalid-async-flip-atomic)
[452.162341] Starting subtest: invalid-async-flip-atomic
[452.536569] Starting dynamic subtest: pipe-A-eDP-1
[453.391606] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.855s)
[453.769419] Starting dynamic subtest: pipe-B-eDP-1
[454.533146] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.776s)
[454.899579] Starting dynamic subtest: pipe-C-eDP-1
[455.664210] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.773s)
[456.021066] Starting dynamic subtest: pipe-D-eDP-1
[456.793768] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.782s)
[456.795046] Subtest invalid-async-flip-atomic: SUCCESS (4.633s)
[457.935861] [081/133] (568s left) kms_content_protection (dp-mst-type-0)
[458.070626] Starting subtest: dp-mst-type-0
[458.072664] Subtest dp-mst-type-0: SKIP (0.000s)
[458.188534] [082/133] (568s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[458.275144] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[458.276895] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[458.370476] [083/133] (568s left) kms_getfb (getfb2-into-addfb2)
[458.474084] Starting subtest: getfb2-into-addfb2
[458.474967] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[458.592890] [084/133] (567s left) i915_module_load (resize-bar)
[458.621474] Starting subtest: resize-bar
[458.628671] Subtest resize-bar: SKIP (0.006s)
[458.662778] [085/133] (567s left) kms_flip (plain-flip-fb-recreate-interruptible)
[458.755735] Starting subtest: plain-flip-fb-recreate-interruptible
[458.757319] Starting dynamic subtest: A-eDP1
[467.644467] Dynamic subtest A-eDP1: SUCCESS (8.886s)
[467.656444] Starting dynamic subtest: B-eDP1
[476.474504] Dynamic subtest B-eDP1: SUCCESS (8.828s)
[476.487678] Starting dynamic subtest: C-eDP1
[485.297883] Dynamic subtest C-eDP1: SUCCESS (8.822s)
[485.309133] Starting dynamic subtest: D-eDP1
[494.132119] Dynamic subtest D-eDP1: SUCCESS (8.833s)
[494.136119] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.380s)
[495.302196] [086/133] (531s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[495.399465] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[496.036425] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.637s)
[496.191718] [087/133] (530s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[496.245830] Starting subtest: single-wait-for-submit-available-signaled
[496.246993] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[496.348515] [088/133] (530s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[496.431910] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[496.432684] Starting dynamic subtest: pipe-A-default-mode
[497.565210] Dynamic subtest pipe-A-default-mode: SKIP (1.131s)
[497.566874] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.132s)
[497.706274] [089/133] (528s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[497.819747] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[497.821517] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[497.972955] [090/133] (528s left) gem_exec_schedule (preempt-queue)
[498.046279] Subtest preempt-queue: SKIP (0.000s)
[498.368550] [091/133] (528s left) kms_cdclk (mode-transition-all-outputs)
[498.457639] Starting subtest: mode-transition-all-outputs
[498.760435] Subtest mode-transition-all-outputs: SKIP (0.302s)
[499.567587] [092/133] (527s left) gem_workarounds (reset-fd)
[499.643075] Starting subtest: reset-fd
[499.827188] Subtest reset-fd: SUCCESS (0.184s)
[499.957991] [093/133] (526s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[500.048222] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[500.049843] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[500.137552] [094/133] (526s left) gem_close_race (multigpu-basic-threads)
[500.189365] Starting subtest: multigpu-basic-threads
[500.191475] Subtest multigpu-basic-threads: SKIP (0.000s)
[500.402620] [095/133] (526s left) gem_exec_params (no-bsd)
[500.454264] Starting subtest: no-bsd
[500.456404] Subtest no-bsd: SUCCESS (0.002s)
[502.563467] [096/133] (524s left) kms_plane_multiple (2x-tiling-yf)
[502.673874] Starting subtest: 2x-tiling-yf
[502.675683] Subtest 2x-tiling-yf: SKIP (0.000s)
[502.743308] [097/133] (524s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[502.801001] Starting subtest: invalid-bsd2-flag-on-blt
[502.801906] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[502.890206] [098/133] (524s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[502.984723] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[507.974465] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.990s)
[509.167136] [099/133] (517s left) kms_pm_rpm (pm-tiling)
[510.688160] Starting subtest: pm-tiling
[510.690695] Subtest pm-tiling: SKIP (0.000s)
[511.392241] [100/133] (515s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[511.445036] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[511.548661] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[511.622666] [101/133] (515s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[511.666940] Starting subtest: invalid-multi-wait-unsubmitted
[511.667947] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[511.797484] [102/133] (515s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[511.888956] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[511.890876] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[511.983522] [103/133] (515s left) kms_chamelium_frames (hdmi-crc-single)
[512.366861] Subtest hdmi-crc-single: SKIP (0.000s)
[513.182508] [104/133] (514s left) syncobj_wait (multi-wait-submitted-signaled)
[513.239267] Starting subtest: multi-wait-submitted-signaled
[513.240362] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[513.323010] [105/133] (513s left) gem_userptr_blits (coherency-sync)
[513.382775] Starting subtest: coherency-sync
[514.210820] Subtest coherency-sync: SKIP (0.810s)
[514.321419] [106/133] (512s left) kms_vblank (ts-continuation-idle-hang)
[514.459123] Starting subtest: ts-continuation-idle-hang
[514.459962] Starting dynamic subtest: pipe-A-eDP-1
[541.266994] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.805s)
[541.277745] Starting dynamic subtest: pipe-D-eDP-1
[556.305123] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.035s)
[556.305959] Subtest ts-continuation-idle-hang: SUCCESS (41.845s)
[557.165699] [107/133] (470s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[557.261423] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[557.263277] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[557.356380] [108/133] (469s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[557.472596] Starting subtest: 2x-cursor-vs-flip-legacy
[557.475263] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[557.628195] [109/133] (469s left) gem_exec_balancer (parallel-balancer)
[557.887560] Starting subtest: parallel-balancer
[559.150352] Subtest parallel-balancer: SUCCESS (1.258s)
[559.255197] [110/133] (468s left) perf (stress-open-close)
[559.390482] Starting subtest: stress-open-close
[559.391412] Starting dynamic subtest: 0-rcs0
[561.556757] Dynamic subtest 0-rcs0: SUCCESS (2.166s)
[561.567388] Starting dynamic subtest: 1-vecs0
[563.717769] Dynamic subtest 1-vecs0: SUCCESS (2.160s)
[563.718755] Subtest stress-open-close: SUCCESS (4.328s)
[563.754480] [111/133] (463s left) gem_ctx_shared (create-shared-gtt)
[563.810058] Starting subtest: create-shared-gtt
[566.008783] Subtest create-shared-gtt: SUCCESS (2.152s)
[566.260499] [112/133] (461s left) kms_addfb_basic (small-bo)
[566.352098] Starting subtest: small-bo
[566.353002] Subtest small-bo: SUCCESS (0.000s)
[566.479576] [113/133] (461s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[566.563155] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[566.564070] Starting dynamic subtest: pipe-A-eDP-1
[566.572855] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[566.582552] Starting dynamic subtest: pipe-B-eDP-1
[566.591308] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[566.601031] Starting dynamic subtest: pipe-C-eDP-1
[566.608676] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[566.617771] Starting dynamic subtest: pipe-D-eDP-1
[566.634034] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[566.634963] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[568.813838] [114/133] (458s left) syncobj_timeline (wait-delayed-signal)
[568.865397] Starting subtest: wait-delayed-signal
[568.968854] Subtest wait-delayed-signal: SUCCESS (0.103s)
[569.059299] [115/133] (458s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[569.155874] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[569.157779] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[569.249395] [116/133] (458s left) gem_mmap_gtt (hang-user)
[569.295219] Subtest hang-user: SKIP (0.000s)
[569.350944] [117/133] (458s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[569.395093] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[569.500389] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s)
[569.574334] [118/133] (458s left) gem_tiled_wc
[569.683937] [119/133] (458s left) i915_pm_rps (thresholds-park)
[569.737368] Starting subtest: thresholds-park
[569.739141] Subtest thresholds-park: SKIP (0.001s)
[569.827849] [120/133] (457s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[569.922255] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[569.923970] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[570.036007] [121/133] (457s left) kms_busy (extended-pageflip-hang-newfb)
[570.133177] Starting subtest: extended-pageflip-hang-newfb
[570.134081] Starting dynamic subtest: pipe-A
[596.321248] Dynamic subtest pipe-A: SUCCESS (26.186s)
[596.331865] Starting dynamic subtest: pipe-D
[611.317212] Dynamic subtest pipe-D: SUCCESS (14.992s)
[611.318148] Subtest extended-pageflip-hang-newfb: SUCCESS (41.182s)
[612.177358] [122/133] (415s left) gem_spin_batch (engines)
[612.229990] Starting subtest: engines
[612.230776] Starting dynamic subtest: rcs0
[615.478192] Dynamic subtest rcs0: SUCCESS (3.238s)
[615.490100] Starting dynamic subtest: bcs0
[618.754080] Dynamic subtest bcs0: SUCCESS (3.236s)
[618.765658] Starting dynamic subtest: vcs0
[621.991323] Dynamic subtest vcs0: SUCCESS (3.234s)
[622.002837] Starting dynamic subtest: vcs1
[625.230668] Dynamic subtest vcs1: SUCCESS (3.237s)
[625.242144] Starting dynamic subtest: vecs0
[628.470241] Dynamic subtest vecs0: SUCCESS (3.237s)
[628.482259] Starting dynamic subtest: ccs0
[631.709781] Dynamic subtest ccs0: SUCCESS (3.236s)
[631.711071] Subtest engines: SUCCESS (19.434s)
[631.889176] [123/133] (396s left) kms_sequence (get-busy)
[631.984176] Starting subtest: get-busy
[631.985163] Starting dynamic subtest: pipe-A-eDP-1
[633.918571] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[633.929354] Starting dynamic subtest: pipe-B-eDP-1
[636.479201] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.558s)
[636.492036] Starting dynamic subtest: pipe-C-eDP-1
[639.082560] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.603s)
[639.093226] Starting dynamic subtest: pipe-D-eDP-1
[641.624458] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.540s)
[641.625316] Subtest get-busy: SUCCESS (9.640s)
[642.501380] [124/133] (385s left) gem_exec_reloc (basic-cpu-read)
[642.574928] Subtest basic-cpu-read: SKIP (0.000s)
[642.637689] [125/133] (385s left) gem_exec_whisper (basic-forked-all)
[642.690001] Starting subtest: basic-forked-all
[656.310077] Subtest basic-forked-all: SUCCESS (13.619s)
[656.496885] [126/133] (371s left) kms_flip (basic-flip-vs-wf_vblank)
[656.601227] Starting subtest: basic-flip-vs-wf_vblank
[656.603470] Starting dynamic subtest: A-eDP1
[658.553191] Dynamic subtest A-eDP1: SUCCESS (1.949s)
[658.565468] Starting dynamic subtest: B-eDP1
[660.484849] Dynamic subtest B-eDP1: SUCCESS (1.928s)
[660.497097] Starting dynamic subtest: C-eDP1
[662.408188] Dynamic subtest C-eDP1: SUCCESS (1.920s)
[662.420024] Starting dynamic subtest: D-eDP1
[664.333849] Dynamic subtest D-eDP1: SUCCESS (1.925s)
[664.337035] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.734s)
[665.554987] [127/133] (362s left) core_auth (getclient-simple)
[665.587522] Starting subtest: getclient-simple
[665.607819] Subtest getclient-simple: SUCCESS (0.020s)
[665.711526] [128/133] (362s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[665.805213] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[665.807004] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[665.895981] [129/133] (362s left) perf (low-oa-exponent-permissions)
[665.987032] Starting subtest: low-oa-exponent-permissions
[666.023727] Subtest low-oa-exponent-permissions: SUCCESS (0.037s)
[666.058399] [130/133] (362s left) gem_vm_create (execbuf)
[666.118072] Starting subtest: execbuf
[666.124788] Subtest execbuf: SUCCESS (0.007s)
[666.246475] [131/133] (362s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[666.349426] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[667.384576] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.035s)
[667.489946] [132/133] (360s left) gem_mmap_gtt (basic-small-bo)
[667.535983] Subtest basic-small-bo: SKIP (0.000s)
[667.593667] [133/133] (360s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[667.676740] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[667.678329] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[667.768501] 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.