[58.131374] Initializing watchdogs
[58.131421]   /dev/watchdog0
[58.145013] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.149270] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.151477] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.155149] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[58.279610] Starting subtest: fbcpsr-indfb-scaledprimary
[63.997169] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.792s)
[64.113424] [002/133] (954s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[64.214772] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[71.084073] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.907s)
[71.215231] [003/133] (947s left) prime_mmap (test_correct)
[71.272777] Starting subtest: test_correct
[71.275051] Starting dynamic subtest: test_correct-smem
[71.301637] Dynamic subtest test_correct-smem: SUCCESS (0.031s)
[71.304091] Subtest test_correct: SUCCESS (0.031s)
[71.390957] [004/133] (947s left) gem_exec_reloc (basic-write-read)
[71.453294] Subtest basic-write-read: SKIP (0.000s)
[71.513477] [005/133] (947s left) gem_ctx_isolation (preservation)
[71.575099] Starting subtest: preservation
[71.577550] Starting dynamic subtest: rcs0
[71.701558] Dynamic subtest rcs0: SUCCESS (0.126s)
[71.711640] Starting dynamic subtest: bcs0
[71.848530] Dynamic subtest bcs0: SUCCESS (0.148s)
[71.863346] Starting dynamic subtest: vcs0
[71.996040] Dynamic subtest vcs0: SUCCESS (0.147s)
[72.007828] Starting dynamic subtest: vcs1
[73.555301] Dynamic subtest vcs1: SUCCESS (1.563s)
[73.563943] Starting dynamic subtest: vecs0
[75.437606] Dynamic subtest vecs0: SUCCESS (1.885s)
[75.446709] Starting dynamic subtest: ccs0
[77.440720] Dynamic subtest ccs0: SUCCESS (2.006s)
[77.443485] Subtest preservation: SUCCESS (5.878s)
[77.677929] [006/133] (941s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[77.786760] Starting subtest: x-tiled-16bpp-rotate-270
[77.806329] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[77.928718] [007/133] (940s left) gem_exec_fence (long-history)
[78.364948] Starting subtest: long-history
[86.014385] Subtest long-history: SUCCESS (7.654s)
[87.172072] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true
[87.175117] [008/133] (931s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[87.264558] Starting subtest: primary-yf-tiled-reflect-x-180
[87.324791] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[87.462237] [009/133] (931s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[87.531090] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[87.533338] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[87.639785] [010/133] (931s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[87.737485] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[87.741891] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[87.807878] [011/133] (931s left) gem_exec_flush (basic-uc-set-default)
[87.870794] Starting subtest: basic-uc-set-default
[93.326910] Subtest basic-uc-set-default: SUCCESS (5.454s)
[93.516314] [012/133] (925s left) gem_ctx_bad_destroy (double-destroy)
[93.579511] Starting subtest: double-destroy
[93.581920] Subtest double-destroy: SUCCESS (0.000s)
[93.669437] [013/133] (925s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[93.776713] Starting subtest: y-tiled-32bpp-rotate-0
[93.780739] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[93.877028] [014/133] (925s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[93.991189] Starting subtest: 2x-flip-vs-cursor-legacy
[93.995833] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[94.137736] [015/133] (925s left) kms_cursor_crc (cursor-random-256x256)
[94.371861] Starting subtest: cursor-random-256x256
[94.376697] Starting dynamic subtest: pipe-A-eDP-1
[97.728908] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.349s)
[97.772396] Starting dynamic subtest: pipe-D-eDP-1
[101.736155] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.969s)
[101.738476] Subtest cursor-random-256x256: SUCCESS (7.360s)
[102.620155] [016/133] (916s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[102.993385] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[103.824219] [017/133] (915s left) gem_ctx_shared (q-independent)
[103.887945] Starting subtest: Q-independent
[103.890298] Starting dynamic subtest: rcs0
[103.964735] Dynamic subtest rcs0: SUCCESS (0.077s)
[103.975921] Starting dynamic subtest: vcs0
[104.006962] Dynamic subtest vcs0: SUCCESS (0.042s)
[104.016291] Starting dynamic subtest: vcs1
[104.046281] Dynamic subtest vcs1: SUCCESS (0.039s)
[104.057179] Starting dynamic subtest: vecs0
[104.090317] Dynamic subtest vecs0: SUCCESS (0.043s)
[104.101048] Starting dynamic subtest: ccs0
[104.137287] Dynamic subtest ccs0: SUCCESS (0.047s)
[104.139599] Subtest Q-independent: SUCCESS (0.249s)
[105.359624] [018/133] (913s left) gem_ctx_param (basic-default)
[105.412572] Starting subtest: basic-default
[105.414906] Subtest basic-default: SUCCESS (0.000s)
[105.484566] [019/133] (913s left) gem_exec_schedule (preempt-queue-contexts-chain)
[105.564231] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[105.852239] [020/133] (913s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[105.941971] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[105.944149] Starting dynamic subtest: pipe-A-eDP-1
[105.965842] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[105.976284] Starting dynamic subtest: pipe-B-eDP-1
[105.997110] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[106.004352] Starting dynamic subtest: pipe-C-eDP-1
[106.025499] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[106.032757] Starting dynamic subtest: pipe-D-eDP-1
[106.053665] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[106.057600] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[108.135963] [021/133] (911s left) kms_addfb_basic (tile-pitch-mismatch)
[108.204518] Starting subtest: tile-pitch-mismatch
[108.208788] Subtest tile-pitch-mismatch: SKIP (0.000s)
[108.355046] [022/133] (911s left) kms_cursor_crc (cursor-suspend)
[108.487846] Starting subtest: cursor-suspend
[108.490137] Starting dynamic subtest: pipe-A-eDP-1
[141.423162] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.288s)
[141.433108] Starting dynamic subtest: pipe-D-eDP-1
[175.406500] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.833s)
[175.408753] Subtest cursor-suspend: SUCCESS (7.123s)
[176.200805] [023/133] (843s left) core_getversion (basic)
[176.239281] Starting subtest: basic
[176.243328] Subtest basic: SUCCESS (0.000s)
[176.312471] [024/133] (843s left) gem_pread (bench)
[176.374180] Subtest bench: SKIP (0.000s)
[176.428171] [025/133] (843s left) gen9_exec_parse (bb-start-far)
[176.482300] Subtest bb-start-far: SKIP (0.000s)
[176.549911] [026/133] (843s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[176.648242] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[176.652724] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[176.739233] [027/133] (842s left) gem_ctx_param (get-priority-new-ctx)
[176.796599] Starting subtest: get-priority-new-ctx
[176.798831] Subtest get-priority-new-ctx: SUCCESS (0.002s)
[176.892573] [028/133] (842s left) kms_big_fb (linear-8bpp-rotate-90)
[177.004123] Starting subtest: linear-8bpp-rotate-90
[177.022998] Subtest linear-8bpp-rotate-90: SKIP (0.019s)
[177.132497] [029/133] (842s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[177.220904] Starting subtest: basic-modeset-with-all-modifiers-formats
[177.596186] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[178.333358] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.758s)
[178.341936] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[178.354253] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[178.364562] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[178.374998] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[178.383391] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[178.527000] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[178.536789] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[178.549090] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[178.560077] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[178.570370] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[178.578903] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[178.592062] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[178.600322] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[178.613861] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[178.622344] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[178.635457] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[178.643548] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[178.657052] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[178.665016] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[178.678995] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[178.687025] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[178.700613] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[178.708861] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[178.853989] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[178.862694] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[178.874106] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[178.882184] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[178.895891] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[178.903753] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[178.917574] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[178.925738] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[178.939202] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[178.947330] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[178.960919] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[178.968920] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[178.982634] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[178.990978] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[179.004288] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[179.012351] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[179.025933] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[179.034000] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[179.178204] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.156s)
[179.186830] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[179.199948] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[179.209273] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[179.221692] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[179.230056] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[179.243401] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[179.251622] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[179.265009] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[179.273246] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[179.286403] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[179.294318] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[179.307868] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[179.315631] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[179.329690] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[179.337750] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[179.351291] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[179.728455] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.573s)
[180.559441] [030/133] (839s left) gem_exec_balancer (persistence)
[180.814912] Starting subtest: persistence
[181.687622] Subtest persistence: SUCCESS (0.888s)
[181.796881] [031/133] (838s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[181.896095] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[181.900588] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[182.002604] [032/133] (837s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[182.099122] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[182.103142] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[182.186129] [033/133] (837s left) i915_pm_rpm (gem-pread)
[184.324470] Starting subtest: gem-pread
[186.362375] Subtest gem-pread: SUCCESS (2.058s)
[186.464571] [034/133] (833s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[188.385087] Starting subtest: dpms-mode-unset-lpsp
[192.461723] Subtest dpms-mode-unset-lpsp: SUCCESS (4.102s)
[192.843077] [035/133] (827s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[192.898617] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[192.903074] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[193.081542] [036/133] (826s left) gem_exec_whisper (basic-queues-priority)
[193.138586] Starting subtest: basic-queues-priority
[216.549856] Subtest basic-queues-priority: SUCCESS (23.425s)
[216.747037] [037/133] (803s left) kms_addfb_basic (addfb25-modifier-no-flag)
[216.851073] Starting subtest: addfb25-modifier-no-flag
[216.853369] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[216.938512] [038/133] (803s left) kms_flip (dpms-off-confusion-interruptible)
[217.028557] Starting subtest: dpms-off-confusion-interruptible
[217.031442] Starting dynamic subtest: A-eDP1
[225.713655] Dynamic subtest A-eDP1: SUCCESS (8.685s)
[225.725121] Starting dynamic subtest: B-eDP1
[234.346870] Dynamic subtest B-eDP1: SUCCESS (8.631s)
[234.358604] Starting dynamic subtest: C-eDP1
[242.977552] Dynamic subtest C-eDP1: SUCCESS (8.630s)
[242.989875] Starting dynamic subtest: D-eDP1
[251.606348] Dynamic subtest D-eDP1: SUCCESS (8.630s)
[251.613262] Subtest dpms-off-confusion-interruptible: SUCCESS (34.589s)
[252.781136] [039/133] (767s left) kms_flip (flip-vs-panning-vs-hang)
[252.876274] Starting subtest: flip-vs-panning-vs-hang
[252.878196] Starting dynamic subtest: A-eDP1
[303.672756] Dynamic subtest A-eDP1: SUCCESS (50.805s)
[303.686318] Starting dynamic subtest: D-eDP1
[343.670142] Dynamic subtest D-eDP1: SUCCESS (40.003s)
[343.672531] Subtest flip-vs-panning-vs-hang: SUCCESS (90.813s)
[344.831068] [040/133] (675s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[344.933192] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[351.462772] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.535s)
[351.575381] [041/133] (668s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[351.682396] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[359.135074] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.459s)
[359.273930] [042/133] (661s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[359.377894] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[359.382884] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[359.450031] [043/133] (660s left) gem_userptr_blits (create-destroy-unsync)
[359.520908] Subtest create-destroy-unsync: SKIP (0.000s)
[359.632930] [044/133] (660s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[359.719432] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[359.723854] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[359.807405] [045/133] (660s left) kms_psr (fbc-pr-sprite-render)
[359.925072] Starting subtest: fbc-pr-sprite-render
[359.929053] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[359.997473] [046/133] (660s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[360.099642] Starting subtest: psr2-plane-move-sf-dmg-area
[360.101664] Starting dynamic subtest: pipe-A-eDP-1
[364.615995] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.525s)
[364.626692] Starting dynamic subtest: pipe-B-eDP-1
[369.940434] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.322s)
[369.942841] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.850s)
[370.816368] [047/133] (649s left) kms_psr (psr-primary-blt)
[370.922677] Starting subtest: psr-primary-blt
[370.924993] Starting dynamic subtest: eDP-1
[372.635156] Dynamic subtest eDP-1: SUCCESS (1.712s)
[372.637410] Subtest psr-primary-blt: SUCCESS (1.713s)
[373.485314] [048/133] (647s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[373.588630] Starting subtest: fbc-psr-sprite-mmap-cpu
[373.590938] Starting dynamic subtest: eDP-1
[373.595131] Dynamic subtest eDP-1: SKIP (0.000s)
[373.599400] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[373.664597] [049/133] (646s left) i915_drm_fdinfo (memory-info-idle)
[373.707298] Starting subtest: memory-info-idle
[373.709853] Starting dynamic subtest: smem0
[373.753262] Dynamic subtest smem0: SUCCESS (0.048s)
[373.755640] Subtest memory-info-idle: SUCCESS (0.049s)
[373.843204] [050/133] (646s left) kms_plane_scaling (invalid-parameters)
[373.935627] Starting subtest: invalid-parameters
[373.937857] Starting dynamic subtest: less-than-1-height-src
[373.948023] Dynamic subtest less-than-1-height-src: SUCCESS (0.013s)
[373.958052] Starting dynamic subtest: less-than-1-width-src
[373.963304] Dynamic subtest less-than-1-width-src: SUCCESS (0.013s)
[373.965165] Subtest invalid-parameters: SUCCESS (0.027s)
[374.059512] [051/133] (646s left) gem_exec_reloc (basic-gtt-active)
[374.116147] Subtest basic-gtt-active: SKIP (0.000s)
[374.195428] [052/133] (646s left) gem_mmap_gtt (close-race)
[374.249377] Subtest close-race: SKIP (0.000s)
[374.303900] [053/133] (646s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[374.391943] Starting subtest: compare-crc-sanitycheck-nv12
[374.394171] Starting dynamic subtest: pipe-A-eDP-1
[375.051883] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.661s)
[375.062016] Starting dynamic subtest: pipe-B-eDP-1
[376.370459] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.317s)
[376.382557] Starting dynamic subtest: pipe-C-eDP-1
[377.653022] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.279s)
[377.663642] Starting dynamic subtest: pipe-D-eDP-1
[378.876330] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.222s)
[378.878535] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.486s)
[379.701563] [054/133] (641s left) api_intel_allocator (fork-simple-once)
[379.757361] Starting subtest: fork-simple-once
[379.767967] Subtest fork-simple-once: SUCCESS (0.013s)
[379.894121] [055/133] (640s left) kms_vrr (max-min)
[379.987039] Starting subtest: max-min
[379.993444] Subtest max-min: SKIP (0.000s)
[380.078627] [056/133] (640s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[380.176087] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[380.180045] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[380.260551] [057/133] (640s left) gem_exec_params (sol-reset-invalid)
[380.313605] Starting subtest: sol-reset-invalid
[380.318734] Subtest sol-reset-invalid: SUCCESS (0.003s)
[382.289861] [058/133] (638s left) kms_lease (invalid-create-leases)
[382.397003] Starting subtest: invalid-create-leases
[382.406838] Subtest invalid-create-leases: SUCCESS (0.009s)
[382.538672] [059/133] (638s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[382.599078] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[382.704850] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[382.784909] [060/133] (638s left) kms_psr (pr-primary-page-flip)
[382.872872] Starting subtest: pr-primary-page-flip
[382.876861] Subtest pr-primary-page-flip: SKIP (0.000s)
[382.962272] [061/133] (638s left) gem_exec_params (readonly)
[383.012688] Starting subtest: readonly
[383.017916] Subtest readonly: SUCCESS (0.003s)
[383.141220] [062/133] (638s left) gem_mmap_gtt (basic-copy)
[383.208602] Subtest basic-copy: SKIP (0.000s)
[383.262446] [063/133] (637s left) kms_psr (psr2-sprite-mmap-cpu)
[383.347550] Starting subtest: psr2-sprite-mmap-cpu
[383.349751] Starting dynamic subtest: eDP-1
[385.082973] Dynamic subtest eDP-1: SUCCESS (1.736s)
[385.085717] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.736s)
[385.954728] [064/133] (635s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[386.064124] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[392.898217] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.839s)
[393.021696] [065/133] (628s left) drm_read (empty-nonblock)
[393.174845] Starting subtest: empty-nonblock
[393.177154] Subtest empty-nonblock: SUCCESS (0.000s)
[393.299422] [066/133] (628s left) perf_pmu (busy-no-semaphores)
[393.338751] Starting subtest: busy-no-semaphores
[393.341417] Starting dynamic subtest: rcs0
[393.891697] Dynamic subtest rcs0: SUCCESS (0.553s)
[393.904356] Starting dynamic subtest: bcs0
[394.443305] Dynamic subtest bcs0: SUCCESS (0.548s)
[394.455418] Starting dynamic subtest: vcs0
[394.993617] Dynamic subtest vcs0: SUCCESS (0.547s)
[395.005769] Starting dynamic subtest: vcs1
[396.752768] Dynamic subtest vcs1: SUCCESS (1.757s)
[396.765585] Starting dynamic subtest: vecs0
[398.731126] Dynamic subtest vecs0: SUCCESS (1.975s)
[398.744229] Starting dynamic subtest: ccs0
[400.722261] Dynamic subtest ccs0: SUCCESS (1.985s)
[400.724971] Subtest busy-no-semaphores: SUCCESS (7.384s)
[400.843877] [067/133] (620s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[400.943549] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[400.945757] Starting dynamic subtest: pipe-A-eDP-1
[400.954139] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[400.964375] Starting dynamic subtest: pipe-B-eDP-1
[400.972904] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[400.982061] Starting dynamic subtest: pipe-C-eDP-1
[400.990390] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[400.999309] Starting dynamic subtest: pipe-D-eDP-1
[401.007461] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[401.011668] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s)
[403.223760] [068/133] (618s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[403.312543] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[403.314791] Starting dynamic subtest: pipe-A-eDP-1
[403.336979] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[403.347006] Starting dynamic subtest: pipe-B-eDP-1
[403.367962] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[403.376611] Starting dynamic subtest: pipe-C-eDP-1
[403.397997] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[403.406607] Starting dynamic subtest: pipe-D-eDP-1
[403.429901] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[403.434380] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[405.581820] [069/133] (615s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[405.680016] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[405.682249] Starting dynamic subtest: pipe-A
[405.907398] Dynamic subtest pipe-A: SUCCESS (0.229s)
[405.917759] Starting dynamic subtest: pipe-B
[407.185051] Dynamic subtest pipe-B: SUCCESS (1.275s)
[407.195706] Starting dynamic subtest: pipe-C
[408.505116] Dynamic subtest pipe-C: SUCCESS (1.318s)
[408.517406] Starting dynamic subtest: pipe-D
[409.844211] Dynamic subtest pipe-D: SUCCESS (1.336s)
[409.846626] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.162s)
[411.024547] [070/133] (610s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[411.120520] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[411.124653] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[411.213695] [071/133] (610s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[411.333312] Starting subtest: protected-encrypted-src-copy-not-readible
[411.447310] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.115s)
[411.553683] [072/133] (610s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[411.645623] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[415.514614] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.869s)
[416.648257] [073/133] (604s left) fbdev (read)
[416.702443] Starting subtest: read
[417.228839] Subtest read: SUCCESS (0.526s)
[417.303806] [074/133] (604s left) gem_exec_parallel (basic)
[417.364502] Starting subtest: basic
[417.366813] Starting dynamic subtest: rcs0
[418.780689] Dynamic subtest rcs0: SUCCESS (1.414s)
[418.792482] Starting dynamic subtest: bcs0
[420.239380] Dynamic subtest bcs0: SUCCESS (1.456s)
[420.252198] Starting dynamic subtest: vcs0
[422.157160] Dynamic subtest vcs0: SUCCESS (1.912s)
[422.168374] Starting dynamic subtest: vcs1
[424.139971] Dynamic subtest vcs1: SUCCESS (1.979s)
[424.152712] Starting dynamic subtest: vecs0
[426.189274] Dynamic subtest vecs0: SUCCESS (2.045s)
[426.201746] Starting dynamic subtest: ccs0
[427.675104] Dynamic subtest ccs0: SUCCESS (1.484s)
[427.677549] Subtest basic: SUCCESS (10.304s)
[427.869025] [075/133] (593s left) kms_dsc (dsc-with-formats)
[427.967570] Starting subtest: dsc-with-formats
[428.005345] Subtest dsc-with-formats: SKIP (0.001s)
[428.045933] [076/133] (593s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[428.140779] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[428.144895] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[428.227013] [077/133] (593s left) kms_cursor_crc (cursor-onscreen-512x512)
[428.488628] Starting subtest: cursor-onscreen-512x512
[428.493069] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[428.661399] [078/133] (593s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[428.758656] Starting subtest: plane-lut1d-pre-ctm3x4
[428.882527] Starting dynamic subtest: pipe-A-plane-0
[429.026886] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[429.036367] Starting dynamic subtest: pipe-A-plane-1
[429.204621] Dynamic subtest pipe-A-plane-1: SUCCESS (0.177s)
[429.213874] Starting dynamic subtest: pipe-A-plane-2
[429.393627] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[430.525932] Starting dynamic subtest: pipe-B-plane-0
[430.673036] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[430.682717] Starting dynamic subtest: pipe-B-plane-1
[430.806402] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[430.816846] Starting dynamic subtest: pipe-B-plane-2
[430.951158] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[432.153513] Starting dynamic subtest: pipe-C-plane-0
[432.289494] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[432.299970] Starting dynamic subtest: pipe-C-plane-1
[432.435353] Dynamic subtest pipe-C-plane-1: SUCCESS (0.143s)
[432.446697] Starting dynamic subtest: pipe-C-plane-2
[432.567663] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[433.836516] Starting dynamic subtest: pipe-D-plane-0
[433.995061] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[434.004719] Starting dynamic subtest: pipe-D-plane-1
[434.172600] Dynamic subtest pipe-D-plane-1: SUCCESS (0.177s)
[434.184821] Starting dynamic subtest: pipe-D-plane-2
[434.306206] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[434.599687] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.837s)
[435.486686] [079/133] (586s left) kms_invalid_mode (overflow-vrefresh)
[435.578454] Starting subtest: overflow-vrefresh
[435.580709] Starting dynamic subtest: pipe-A-eDP-1
[435.870136] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[435.880741] Starting dynamic subtest: pipe-B-eDP-1
[435.883270] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[435.892621] Starting dynamic subtest: pipe-C-eDP-1
[435.895040] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[435.906918] Starting dynamic subtest: pipe-D-eDP-1
[435.909276] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[435.911642] Subtest overflow-vrefresh: SUCCESS (0.296s)
[436.713822] [080/133] (585s left) kms_async_flips (invalid-async-flip-atomic)
[436.818871] Starting subtest: invalid-async-flip-atomic
[437.191467] Starting dynamic subtest: pipe-A-eDP-1
[438.034365] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.843s)
[438.407093] Starting dynamic subtest: pipe-B-eDP-1
[439.172754] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.773s)
[439.534135] Starting dynamic subtest: pipe-C-eDP-1
[440.301057] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.774s)
[440.657287] Starting dynamic subtest: pipe-D-eDP-1
[441.451675] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.802s)
[441.454276] Subtest invalid-async-flip-atomic: SUCCESS (4.634s)
[442.674409] [081/133] (579s left) kms_content_protection (dp-mst-type-0)
[442.826688] Starting subtest: dp-mst-type-0
[442.831290] Subtest dp-mst-type-0: SKIP (0.000s)
[442.931273] [082/133] (579s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[443.025421] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[443.029609] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[443.149213] [083/133] (578s left) kms_getfb (getfb2-into-addfb2)
[443.256142] Starting subtest: getfb2-into-addfb2
[443.258459] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[443.367685] [084/133] (578s left) i915_module_load (resize-bar)
[443.404071] Starting subtest: resize-bar
[443.414423] Subtest resize-bar: SKIP (0.005s)
[443.461653] [085/133] (578s left) kms_flip (plain-flip-fb-recreate-interruptible)
[443.561170] Starting subtest: plain-flip-fb-recreate-interruptible
[443.563425] Starting dynamic subtest: A-eDP1
[452.375376] Dynamic subtest A-eDP1: SUCCESS (8.812s)
[452.387760] Starting dynamic subtest: B-eDP1
[461.204963] Dynamic subtest B-eDP1: SUCCESS (8.825s)
[461.214573] Starting dynamic subtest: C-eDP1
[470.023882] Dynamic subtest C-eDP1: SUCCESS (8.816s)
[470.035878] Starting dynamic subtest: D-eDP1
[478.856403] Dynamic subtest D-eDP1: SUCCESS (8.829s)
[478.861229] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.297s)
[480.034340] [086/133] (542s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[480.127598] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[480.751633] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.625s)
[480.913953] [087/133] (541s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[480.975726] Starting subtest: single-wait-for-submit-available-signaled
[480.978129] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[481.114809] [088/133] (541s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[481.197716] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[481.200017] Starting dynamic subtest: pipe-A-default-mode
[482.387250] Dynamic subtest pipe-A-default-mode: SKIP (1.187s)
[482.391837] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.188s)
[482.530450] [089/133] (539s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[482.647318] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[482.651876] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[482.799858] [090/133] (539s left) gem_exec_schedule (preempt-queue)
[482.874217] Subtest preempt-queue: SKIP (0.000s)
[483.160578] [091/133] (539s left) kms_cdclk (mode-transition-all-outputs)
[483.262285] Starting subtest: mode-transition-all-outputs
[483.548989] Subtest mode-transition-all-outputs: SKIP (0.286s)
[484.392658] [092/133] (538s left) gem_workarounds (reset-fd)
[484.463625] Starting subtest: reset-fd
[484.635377] Subtest reset-fd: SUCCESS (0.173s)
[484.755290] [093/133] (537s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[484.841647] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[484.845874] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[484.947637] [094/133] (537s left) gem_close_race (multigpu-basic-threads)
[485.018386] Starting subtest: multigpu-basic-threads
[485.023008] Subtest multigpu-basic-threads: SKIP (0.000s)
[485.252062] [095/133] (537s left) gem_exec_params (no-bsd)
[485.307442] Starting subtest: no-bsd
[485.309739] Subtest no-bsd: SUCCESS (0.003s)
[487.230457] [096/133] (535s left) kms_plane_multiple (2x-tiling-yf)
[487.335121] Starting subtest: 2x-tiling-yf
[487.339653] Subtest 2x-tiling-yf: SKIP (0.000s)
[487.408299] [097/133] (535s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[487.474742] Starting subtest: invalid-bsd2-flag-on-blt
[487.477091] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[487.599458] [098/133] (535s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[487.700977] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[492.572268] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.874s)
[493.704703] [099/133] (529s left) kms_pm_rpm (pm-tiling)
[495.427466] Starting subtest: pm-tiling
[495.432089] Subtest pm-tiling: SKIP (0.000s)
[495.949284] [100/133] (526s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[496.001313] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[496.104385] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[496.180943] [101/133] (526s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[496.244394] Starting subtest: invalid-multi-wait-unsubmitted
[496.246690] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[496.364679] [102/133] (526s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[496.467998] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[496.471971] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[496.559745] [103/133] (526s left) kms_chamelium_frames (hdmi-crc-single)
[496.949526] Subtest hdmi-crc-single: SKIP (0.000s)
[497.739418] [104/133] (525s left) syncobj_wait (multi-wait-submitted-signaled)
[497.801643] Starting subtest: multi-wait-submitted-signaled
[497.803818] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[497.903844] [105/133] (525s left) gem_userptr_blits (coherency-sync)
[497.985072] Starting subtest: coherency-sync
[498.402876] Subtest coherency-sync: SKIP (0.381s)
[498.517970] [106/133] (524s left) kms_vblank (ts-continuation-idle-hang)
[498.663632] Starting subtest: ts-continuation-idle-hang
[498.665471] Starting dynamic subtest: pipe-A-eDP-1
[524.946174] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.281s)
[524.961900] Starting dynamic subtest: pipe-D-eDP-1
[549.971222] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.023s)
[549.973159] Subtest ts-continuation-idle-hang: SUCCESS (51.309s)
[550.814778] [107/133] (472s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[550.910836] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[550.914958] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[551.009344] [108/133] (472s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[551.124380] Starting subtest: 2x-cursor-vs-flip-legacy
[551.128525] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s)
[551.293537] [109/133] (471s left) gem_exec_balancer (parallel-balancer)
[551.563536] Starting subtest: parallel-balancer
[552.429188] Subtest parallel-balancer: SUCCESS (0.866s)
[552.534046] [110/133] (470s left) perf (stress-open-close)
[552.692322] Starting subtest: stress-open-close
[552.694453] Starting dynamic subtest: 0-rcs0
[554.859360] Dynamic subtest 0-rcs0: SUCCESS (2.169s)
[554.870237] Starting dynamic subtest: 1-vecs0
[557.023864] Dynamic subtest 1-vecs0: SUCCESS (2.164s)
[557.025664] Subtest stress-open-close: SUCCESS (4.334s)
[557.076291] [111/133] (466s left) gem_ctx_shared (create-shared-gtt)
[557.137833] Starting subtest: create-shared-gtt
[559.288448] Subtest create-shared-gtt: SUCCESS (2.151s)
[559.580361] [112/133] (463s left) kms_addfb_basic (small-bo)
[559.680239] Starting subtest: small-bo
[559.682334] Subtest small-bo: SUCCESS (0.000s)
[559.789064] [113/133] (463s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[559.886814] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[559.889146] Starting dynamic subtest: pipe-A-eDP-1
[559.910226] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[559.922548] Starting dynamic subtest: pipe-B-eDP-1
[559.941224] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[559.954220] Starting dynamic subtest: pipe-C-eDP-1
[559.973841] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[559.984948] Starting dynamic subtest: pipe-D-eDP-1
[560.004371] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[560.006300] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[562.168078] [114/133] (461s left) syncobj_timeline (wait-delayed-signal)
[562.225420] Starting subtest: wait-delayed-signal
[562.330163] Subtest wait-delayed-signal: SUCCESS (0.102s)
[562.422781] [115/133] (460s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[562.520598] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[562.524839] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[562.613962] [116/133] (460s left) gem_mmap_gtt (hang-user)
[562.672867] Subtest hang-user: SKIP (0.000s)
[562.741316] [117/133] (460s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[562.793347] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[562.896709] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[562.990926] [118/133] (460s left) gem_tiled_wc
[563.109423] [119/133] (460s left) i915_pm_rps (thresholds-park)
[563.165302] Starting subtest: thresholds-park
[563.169516] Subtest thresholds-park: SKIP (0.001s)
[563.307725] [120/133] (460s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[563.413871] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[563.417895] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[563.522748] [121/133] (460s left) kms_busy (extended-pageflip-hang-newfb)
[563.625211] Starting subtest: extended-pageflip-hang-newfb
[563.627352] Starting dynamic subtest: pipe-A
[589.980534] Dynamic subtest pipe-A: SUCCESS (26.354s)
[589.992055] Starting dynamic subtest: pipe-D
[615.021180] Dynamic subtest pipe-D: SUCCESS (25.041s)
[615.023409] Subtest extended-pageflip-hang-newfb: SUCCESS (51.401s)
[615.821784] [122/133] (407s left) gem_spin_batch (engines)
[615.881223] Starting subtest: engines
[615.883467] Starting dynamic subtest: rcs0
[619.120791] Dynamic subtest rcs0: SUCCESS (3.235s)
[619.133477] Starting dynamic subtest: bcs0
[622.358194] Dynamic subtest bcs0: SUCCESS (3.235s)
[622.371453] Starting dynamic subtest: vcs0
[625.594704] Dynamic subtest vcs0: SUCCESS (3.234s)
[625.607515] Starting dynamic subtest: vcs1
[628.831915] Dynamic subtest vcs1: SUCCESS (3.235s)
[628.844590] Starting dynamic subtest: vecs0
[632.070405] Dynamic subtest vecs0: SUCCESS (3.234s)
[632.082523] Starting dynamic subtest: ccs0
[635.309841] Dynamic subtest ccs0: SUCCESS (3.236s)
[635.312345] Subtest engines: SUCCESS (19.426s)
[635.548056] [123/133] (388s left) kms_sequence (get-busy)
[635.650550] Starting subtest: get-busy
[635.652685] Starting dynamic subtest: pipe-A-eDP-1
[637.594999] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.943s)
[637.606252] Starting dynamic subtest: pipe-B-eDP-1
[640.211640] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.615s)
[640.222702] Starting dynamic subtest: pipe-C-eDP-1
[642.821517] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.610s)
[642.832374] Starting dynamic subtest: pipe-D-eDP-1
[645.454767] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.633s)
[645.457065] Subtest get-busy: SUCCESS (9.806s)
[646.345004] [124/133] (377s left) gem_exec_reloc (basic-cpu-read)
[646.401583] Subtest basic-cpu-read: SKIP (0.000s)
[646.478934] [125/133] (377s left) gem_exec_whisper (basic-forked-all)
[646.542435] Starting subtest: basic-forked-all
[660.223483] Subtest basic-forked-all: SUCCESS (13.680s)
[660.405674] [126/133] (363s left) kms_flip (basic-flip-vs-wf_vblank)
[660.510777] Starting subtest: basic-flip-vs-wf_vblank
[660.513244] Starting dynamic subtest: A-eDP1
[662.472412] Dynamic subtest A-eDP1: SUCCESS (1.964s)
[662.482570] Starting dynamic subtest: B-eDP1
[664.404838] Dynamic subtest B-eDP1: SUCCESS (1.930s)
[664.418326] Starting dynamic subtest: C-eDP1
[666.330711] Dynamic subtest C-eDP1: SUCCESS (1.922s)
[666.343258] Starting dynamic subtest: D-eDP1
[668.268362] Dynamic subtest D-eDP1: SUCCESS (1.933s)
[668.270502] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.760s)
[669.500341] [127/133] (354s left) core_auth (getclient-simple)
[669.533202] Starting subtest: getclient-simple
[669.553919] Subtest getclient-simple: SUCCESS (0.020s)
[669.654586] [128/133] (354s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[669.755290] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[669.759755] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[669.853763] [129/133] (354s left) perf (low-oa-exponent-permissions)
[669.945389] Starting subtest: low-oa-exponent-permissions
[669.977298] Subtest low-oa-exponent-permissions: SUCCESS (0.032s)
[670.018054] [130/133] (354s left) gem_vm_create (execbuf)
[670.080459] Starting subtest: execbuf
[670.087962] Subtest execbuf: SUCCESS (0.007s)
[670.225202] [131/133] (353s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[670.315320] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[671.294681] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.979s)
[671.415484] [132/133] (352s left) gem_mmap_gtt (basic-small-bo)
[671.461832] Subtest basic-small-bo: SKIP (0.000s)
[671.522611] [133/133] (352s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[671.615787] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[671.619113] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[671.720235] 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.