[60.621642] Initializing watchdogs
[60.621697]   /dev/watchdog0
[60.637221] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[60.641148] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.643135] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.646608] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[60.756208] Starting subtest: fbcpsr-indfb-scaledprimary
[66.470322] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.738s)
[66.602644] [002/133] (954s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[66.732503] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[73.941898] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (7.221s)
[74.077108] [003/133] (947s left) prime_mmap (test_correct)
[74.143628] Starting subtest: test_correct
[74.146049] Starting dynamic subtest: test_correct-smem
[74.181217] Dynamic subtest test_correct-smem: SUCCESS (0.040s)
[74.183769] Subtest test_correct: SUCCESS (0.040s)
[74.275948] [004/133] (946s left) gem_exec_reloc (basic-write-read)
[74.331833] Subtest basic-write-read: SKIP (0.000s)
[74.394398] [005/133] (946s left) gem_ctx_isolation (preservation)
[74.452087] Starting subtest: preservation
[74.454328] Starting dynamic subtest: rcs0
[74.577578] Dynamic subtest rcs0: SUCCESS (0.125s)
[74.585049] Starting dynamic subtest: bcs0
[74.731479] Dynamic subtest bcs0: SUCCESS (0.153s)
[74.739453] Starting dynamic subtest: vcs0
[74.866989] Dynamic subtest vcs0: SUCCESS (0.136s)
[74.874567] Starting dynamic subtest: vcs1
[75.974159] Dynamic subtest vcs1: SUCCESS (1.108s)
[75.981713] Starting dynamic subtest: vecs0
[77.966169] Dynamic subtest vecs0: SUCCESS (1.993s)
[77.973975] Starting dynamic subtest: ccs0
[79.963311] Dynamic subtest ccs0: SUCCESS (1.998s)
[79.965894] Subtest preservation: SUCCESS (5.515s)
[80.207236] [006/133] (941s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[80.288856] Starting subtest: x-tiled-16bpp-rotate-270
[80.309778] Subtest x-tiled-16bpp-rotate-270: SKIP (0.020s)
[80.409367] [007/133] (940s left) gem_exec_fence (long-history)
[80.857214] Starting subtest: long-history
[87.598875] Subtest long-history: SUCCESS (6.746s)
[88.214042] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true
[88.217027] [008/133] (933s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[88.301034] Starting subtest: primary-yf-tiled-reflect-x-180
[88.361935] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[88.462235] [009/133] (932s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[88.514061] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[88.516423] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[88.629796] [010/133] (932s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[88.716411] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[88.720853] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[88.780743] [011/133] (932s left) gem_exec_flush (basic-uc-set-default)
[88.837585] Starting subtest: basic-uc-set-default
[94.318615] Subtest basic-uc-set-default: SUCCESS (5.452s)
[94.474977] [012/133] (927s left) gem_ctx_bad_destroy (double-destroy)
[94.537882] Starting subtest: double-destroy
[94.540272] Subtest double-destroy: SUCCESS (0.000s)
[94.615481] [013/133] (926s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[94.699342] Starting subtest: y-tiled-32bpp-rotate-0
[94.703693] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[94.798383] [014/133] (926s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[94.897254] Starting subtest: 2x-flip-vs-cursor-legacy
[94.901849] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[95.040385] [015/133] (926s left) kms_cursor_crc (cursor-random-256x256)
[95.258182] Starting subtest: cursor-random-256x256
[95.260448] Starting dynamic subtest: pipe-A-eDP-1
[98.588462] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.329s)
[98.620986] Starting dynamic subtest: pipe-D-eDP-1
[102.578367] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.965s)
[102.580766] Subtest cursor-random-256x256: SUCCESS (7.322s)
[103.453705] [016/133] (918s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[103.829854] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[104.664622] [017/133] (917s left) gem_ctx_shared (q-independent)
[104.725562] Starting subtest: Q-independent
[104.727956] Starting dynamic subtest: rcs0
[104.786996] Dynamic subtest rcs0: SUCCESS (0.061s)
[104.796551] Starting dynamic subtest: vcs0
[104.828543] Dynamic subtest vcs0: SUCCESS (0.041s)
[104.838723] Starting dynamic subtest: vcs1
[104.868505] Dynamic subtest vcs1: SUCCESS (0.040s)
[104.877775] Starting dynamic subtest: vecs0
[104.910925] Dynamic subtest vecs0: SUCCESS (0.042s)
[104.921527] Starting dynamic subtest: ccs0
[104.953968] Dynamic subtest ccs0: SUCCESS (0.043s)
[104.956444] Subtest Q-independent: SUCCESS (0.228s)
[106.925525] [018/133] (914s left) gem_ctx_param (basic-default)
[106.978084] Starting subtest: basic-default
[106.980377] Subtest basic-default: SUCCESS (0.000s)
[107.050906] [019/133] (914s left) gem_exec_schedule (preempt-queue-contexts-chain)
[107.122254] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[107.407735] [020/133] (914s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[107.477608] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[107.480294] Starting dynamic subtest: pipe-A-eDP-1
[107.503954] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[107.514931] Starting dynamic subtest: pipe-B-eDP-1
[107.537135] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[107.545057] Starting dynamic subtest: pipe-C-eDP-1
[107.567298] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[107.575175] Starting dynamic subtest: pipe-D-eDP-1
[107.598591] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[107.603273] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[109.633437] [021/133] (912s left) kms_addfb_basic (tile-pitch-mismatch)
[109.694862] Starting subtest: tile-pitch-mismatch
[109.700084] Subtest tile-pitch-mismatch: SKIP (0.000s)
[109.830060] [022/133] (912s left) kms_cursor_crc (cursor-suspend)
[109.939843] Starting subtest: cursor-suspend
[109.942186] Starting dynamic subtest: pipe-A-eDP-1
[143.575052] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.335s)
[143.585042] Starting dynamic subtest: pipe-D-eDP-1
[178.275869] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.560s)
[178.278153] Subtest cursor-suspend: SUCCESS (7.898s)
[178.818369] [023/133] (843s left) core_getversion (basic)
[178.862946] Starting subtest: basic
[178.866999] Subtest basic: SUCCESS (0.000s)
[178.943941] [024/133] (843s left) gem_pread (bench)
[179.006350] Subtest bench: SKIP (0.000s)
[179.059260] [025/133] (843s left) gen9_exec_parse (bb-start-far)
[179.117897] Subtest bb-start-far: SKIP (0.000s)
[179.182829] [026/133] (842s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[179.262656] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[179.266806] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[179.350708] [027/133] (842s left) gem_ctx_param (get-priority-new-ctx)
[179.403262] Starting subtest: get-priority-new-ctx
[179.405462] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[179.509785] [028/133] (842s left) kms_big_fb (linear-8bpp-rotate-90)
[179.589494] Starting subtest: linear-8bpp-rotate-90
[179.611262] Subtest linear-8bpp-rotate-90: SKIP (0.022s)
[179.722076] [029/133] (842s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[179.789345] Starting subtest: basic-modeset-with-all-modifiers-formats
[180.168513] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[180.926760] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.775s)
[180.936975] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[180.947304] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[180.956073] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[180.968773] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[180.977291] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[181.110151] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.144s)
[181.119238] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[181.132330] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[181.141040] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[181.153705] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[181.162359] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[181.175429] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[181.184087] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[181.197509] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[181.207708] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[181.219328] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[181.228289] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[181.241398] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[181.250357] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[181.263000] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[181.273084] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[181.284363] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[181.292984] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[181.426495] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.144s)
[181.435504] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[181.448102] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[181.456346] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[181.469811] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[181.477977] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[181.491579] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[181.499781] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[181.513413] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[181.521393] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[181.535200] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[181.543271] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[181.556987] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[181.565087] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[181.578827] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[181.586935] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[181.600634] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[181.608968] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[181.753518] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[181.763060] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[181.775436] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[181.783972] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[181.797272] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[181.805698] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[181.819056] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[181.827796] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[181.840925] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[181.849026] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[181.862568] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[181.870823] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[181.884665] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[181.892961] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[181.906554] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[181.914709] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[181.928274] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[182.315829] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.577s)
[183.083343] [030/133] (839s left) gem_exec_balancer (persistence)
[183.343806] Starting subtest: persistence
[184.235896] Subtest persistence: SUCCESS (0.887s)
[184.359595] [031/133] (837s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[184.438665] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[184.442811] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[184.541297] [032/133] (837s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[184.615330] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[184.619609] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[184.723135] [033/133] (837s left) i915_pm_rpm (gem-pread)
[186.528397] Starting subtest: gem-pread
[188.333829] Subtest gem-pread: SUCCESS (1.820s)
[188.420856] [034/133] (834s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[190.525439] Starting subtest: dpms-mode-unset-lpsp
[194.257730] Subtest dpms-mode-unset-lpsp: SUCCESS (3.750s)
[194.637864] [035/133] (827s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[194.696551] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[194.700979] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[194.877137] [036/133] (827s left) gem_exec_whisper (basic-queues-priority)
[194.941459] Starting subtest: basic-queues-priority
[219.462028] Subtest basic-queues-priority: SUCCESS (24.476s)
[219.603867] [037/133] (802s left) kms_addfb_basic (addfb25-modifier-no-flag)
[219.683039] Starting subtest: addfb25-modifier-no-flag
[219.684937] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[219.775232] [038/133] (802s left) kms_flip (dpms-off-confusion-interruptible)
[219.851349] Starting subtest: dpms-off-confusion-interruptible
[219.853617] Starting dynamic subtest: A-eDP1
[228.557883] Dynamic subtest A-eDP1: SUCCESS (8.666s)
[228.569250] Starting dynamic subtest: B-eDP1
[237.189117] Dynamic subtest B-eDP1: SUCCESS (8.627s)
[237.201258] Starting dynamic subtest: C-eDP1
[245.828182] Dynamic subtest C-eDP1: SUCCESS (8.627s)
[245.837713] Starting dynamic subtest: D-eDP1
[254.574164] Dynamic subtest D-eDP1: SUCCESS (8.646s)
[254.576699] Subtest dpms-off-confusion-interruptible: SUCCESS (34.577s)
[255.591091] [039/133] (767s left) kms_flip (flip-vs-panning-vs-hang)
[255.685491] Starting subtest: flip-vs-panning-vs-hang
[255.687727] Starting dynamic subtest: A-eDP1
[306.973391] Dynamic subtest A-eDP1: SUCCESS (51.287s)
[306.983695] Starting dynamic subtest: D-eDP1
[356.901222] Dynamic subtest D-eDP1: SUCCESS (49.929s)
[356.903954] Subtest flip-vs-panning-vs-hang: SUCCESS (101.219s)
[358.070541] [040/133] (664s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[358.156432] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[364.669517] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.517s)
[364.806050] [041/133] (657s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[364.891568] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[372.291870] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.405s)
[372.407555] [042/133] (650s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[372.490465] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[372.495093] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[372.560950] [043/133] (650s left) gem_userptr_blits (create-destroy-unsync)
[372.620287] Subtest create-destroy-unsync: SKIP (0.000s)
[372.728726] [044/133] (650s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[372.811282] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[372.815344] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[372.904860] [045/133] (649s left) kms_psr (fbc-pr-sprite-render)
[372.977028] Starting subtest: fbc-pr-sprite-render
[372.981415] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[373.055854] [046/133] (649s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[373.134908] Starting subtest: psr2-plane-move-sf-dmg-area
[373.137274] Starting dynamic subtest: pipe-A-eDP-1
[377.675413] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.546s)
[377.685666] Starting dynamic subtest: pipe-B-eDP-1
[382.984778] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.308s)
[382.987232] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.857s)
[383.863309] [047/133] (639s left) kms_psr (psr-primary-blt)
[383.932826] Starting subtest: psr-primary-blt
[383.935161] Starting dynamic subtest: eDP-1
[385.660793] Dynamic subtest eDP-1: SUCCESS (1.727s)
[385.663291] Subtest psr-primary-blt: SUCCESS (1.728s)
[386.527118] [048/133] (636s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[386.598284] Starting subtest: fbc-psr-sprite-mmap-cpu
[386.600542] Starting dynamic subtest: eDP-1
[386.604289] Dynamic subtest eDP-1: SKIP (0.000s)
[386.608397] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[386.709029] [049/133] (636s left) i915_drm_fdinfo (memory-info-idle)
[386.753543] Starting subtest: memory-info-idle
[386.755976] Starting dynamic subtest: smem0
[386.808883] Dynamic subtest smem0: SUCCESS (0.057s)
[386.811610] Subtest memory-info-idle: SUCCESS (0.057s)
[386.895205] [050/133] (636s left) kms_plane_scaling (invalid-parameters)
[386.975182] Starting subtest: invalid-parameters
[386.977421] Starting dynamic subtest: less-than-1-height-src
[386.988144] Dynamic subtest less-than-1-height-src: SUCCESS (0.013s)
[386.998459] Starting dynamic subtest: less-than-1-width-src
[387.000566] Dynamic subtest less-than-1-width-src: SUCCESS (0.012s)
[387.002828] Subtest invalid-parameters: SUCCESS (0.026s)
[387.123008] [051/133] (636s left) gem_exec_reloc (basic-gtt-active)
[387.188293] Subtest basic-gtt-active: SKIP (0.000s)
[387.261948] [052/133] (635s left) gem_mmap_gtt (close-race)
[387.319016] Subtest close-race: SKIP (0.000s)
[387.377366] [053/133] (635s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[387.449284] Starting subtest: compare-crc-sanitycheck-nv12
[387.451476] Starting dynamic subtest: pipe-A-eDP-1
[388.104083] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.653s)
[388.114815] Starting dynamic subtest: pipe-B-eDP-1
[389.370332] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.266s)
[389.380924] Starting dynamic subtest: pipe-C-eDP-1
[390.578305] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.206s)
[390.588809] Starting dynamic subtest: pipe-D-eDP-1
[391.815743] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s)
[391.817733] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.366s)
[392.638630] [054/133] (630s left) api_intel_allocator (fork-simple-once)
[392.693995] Starting subtest: fork-simple-once
[392.707317] Subtest fork-simple-once: SUCCESS (0.016s)
[392.819583] [055/133] (630s left) kms_vrr (max-min)
[392.899852] Starting subtest: max-min
[392.906334] Subtest max-min: SKIP (0.000s)
[392.979677] [056/133] (630s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[393.055862] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[393.060333] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[393.127020] [057/133] (630s left) gem_exec_params (sol-reset-invalid)
[393.181010] Starting subtest: sol-reset-invalid
[393.186512] Subtest sol-reset-invalid: SUCCESS (0.003s)
[394.469636] [058/133] (629s left) kms_lease (invalid-create-leases)
[394.559387] Starting subtest: invalid-create-leases
[394.564703] Subtest invalid-create-leases: SUCCESS (0.006s)
[394.674089] [059/133] (628s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[394.737872] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[394.838755] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[394.915714] [060/133] (628s left) kms_psr (pr-primary-page-flip)
[394.987834] Starting subtest: pr-primary-page-flip
[394.992273] Subtest pr-primary-page-flip: SKIP (0.000s)
[395.064535] [061/133] (628s left) gem_exec_params (readonly)
[395.123753] Starting subtest: readonly
[395.126048] Subtest readonly: SUCCESS (0.003s)
[395.248452] [062/133] (628s left) gem_mmap_gtt (basic-copy)
[395.307698] Subtest basic-copy: SKIP (0.000s)
[395.371329] [063/133] (628s left) kms_psr (psr2-sprite-mmap-cpu)
[395.448462] Starting subtest: psr2-sprite-mmap-cpu
[395.450427] Starting dynamic subtest: eDP-1
[397.131671] Dynamic subtest eDP-1: SUCCESS (1.683s)
[397.133978] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.684s)
[398.006108] [064/133] (625s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[398.081133] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[405.006368] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.927s)
[405.119761] [065/133] (618s left) drm_read (empty-nonblock)
[405.252898] Starting subtest: empty-nonblock
[405.255152] Subtest empty-nonblock: SUCCESS (0.000s)
[405.369148] [066/133] (618s left) perf_pmu (busy-no-semaphores)
[405.409634] Starting subtest: busy-no-semaphores
[405.411920] Starting dynamic subtest: rcs0
[405.978233] Dynamic subtest rcs0: SUCCESS (0.566s)
[405.991229] Starting dynamic subtest: bcs0
[406.528586] Dynamic subtest bcs0: SUCCESS (0.547s)
[406.541383] Starting dynamic subtest: vcs0
[407.079461] Dynamic subtest vcs0: SUCCESS (0.547s)
[407.090908] Starting dynamic subtest: vcs1
[408.950617] Dynamic subtest vcs1: SUCCESS (1.868s)
[408.962705] Starting dynamic subtest: vecs0
[410.935866] Dynamic subtest vecs0: SUCCESS (1.983s)
[410.948941] Starting dynamic subtest: ccs0
[412.920023] Dynamic subtest ccs0: SUCCESS (1.979s)
[412.924066] Subtest busy-no-semaphores: SUCCESS (7.508s)
[413.045893] [067/133] (610s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[413.124183] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[413.126328] Starting dynamic subtest: pipe-A-eDP-1
[413.134888] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[413.145468] Starting dynamic subtest: pipe-B-eDP-1
[413.154777] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[413.164237] Starting dynamic subtest: pipe-C-eDP-1
[413.172374] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[413.181546] Starting dynamic subtest: pipe-D-eDP-1
[413.189884] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[413.194143] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[415.434293] [068/133] (608s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[415.503910] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[415.506014] Starting dynamic subtest: pipe-A-eDP-1
[415.527769] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[415.539820] Starting dynamic subtest: pipe-B-eDP-1
[415.560408] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[415.569414] Starting dynamic subtest: pipe-C-eDP-1
[415.589952] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[415.598791] Starting dynamic subtest: pipe-D-eDP-1
[415.620244] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[415.624574] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[417.713840] [069/133] (606s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[417.783124] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[417.785364] Starting dynamic subtest: pipe-A
[418.010671] Dynamic subtest pipe-A: SUCCESS (0.229s)
[418.020589] Starting dynamic subtest: pipe-B
[419.299479] Dynamic subtest pipe-B: SUCCESS (1.288s)
[419.309653] Starting dynamic subtest: pipe-C
[420.658897] Dynamic subtest pipe-C: SUCCESS (1.359s)
[420.669241] Starting dynamic subtest: pipe-D
[421.980390] Dynamic subtest pipe-D: SUCCESS (1.321s)
[421.982837] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.200s)
[423.144333] [070/133] (600s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[423.233142] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[423.237616] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[423.326769] [071/133] (600s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[423.447757] Starting subtest: protected-encrypted-src-copy-not-readible
[423.558958] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.113s)
[423.680281] [072/133] (600s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[423.755745] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[427.616785] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.864s)
[428.755250] [073/133] (595s left) fbdev (read)
[428.802832] Starting subtest: read
[429.320129] Subtest read: SUCCESS (0.515s)
[429.381948] [074/133] (594s left) gem_exec_parallel (basic)
[429.440583] Starting subtest: basic
[429.442885] Starting dynamic subtest: rcs0
[430.857502] Dynamic subtest rcs0: SUCCESS (1.416s)
[430.868540] Starting dynamic subtest: bcs0
[432.315547] Dynamic subtest bcs0: SUCCESS (1.456s)
[432.328700] Starting dynamic subtest: vcs0
[434.419669] Dynamic subtest vcs0: SUCCESS (2.102s)
[434.433934] Starting dynamic subtest: vcs1
[436.403984] Dynamic subtest vcs1: SUCCESS (1.981s)
[436.417177] Starting dynamic subtest: vecs0
[438.388558] Dynamic subtest vecs0: SUCCESS (1.982s)
[438.401080] Starting dynamic subtest: ccs0
[439.886457] Dynamic subtest ccs0: SUCCESS (1.497s)
[439.888881] Subtest basic: SUCCESS (10.447s)
[440.096619] [075/133] (584s left) kms_dsc (dsc-with-formats)
[440.180429] Starting subtest: dsc-with-formats
[440.221228] Subtest dsc-with-formats: SKIP (0.001s)
[440.264921] [076/133] (583s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[440.341047] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[440.345512] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[440.430358] [077/133] (583s left) kms_cursor_crc (cursor-onscreen-512x512)
[440.665592] Starting subtest: cursor-onscreen-512x512
[440.670386] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[440.832919] [078/133] (583s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[440.914171] Starting subtest: plane-lut1d-pre-ctm3x4
[441.058785] Starting dynamic subtest: pipe-A-plane-0
[441.224997] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[441.235086] Starting dynamic subtest: pipe-A-plane-1
[441.358657] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[441.368155] Starting dynamic subtest: pipe-A-plane-2
[441.503071] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[442.798099] Starting dynamic subtest: pipe-B-plane-0
[442.968819] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[442.980884] Starting dynamic subtest: pipe-B-plane-1
[443.111132] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[443.121369] Starting dynamic subtest: pipe-B-plane-2
[443.244498] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[444.469173] Starting dynamic subtest: pipe-C-plane-0
[444.604628] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[444.615152] Starting dynamic subtest: pipe-C-plane-1
[444.760249] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[444.771261] Starting dynamic subtest: pipe-C-plane-2
[444.915652] Dynamic subtest pipe-C-plane-2: SUCCESS (0.154s)
[446.103810] Starting dynamic subtest: pipe-D-plane-0
[446.227796] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[446.242268] Starting dynamic subtest: pipe-D-plane-1
[446.371989] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[446.381985] Starting dynamic subtest: pipe-D-plane-2
[446.505361] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[446.794596] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.881s)
[447.617838] [079/133] (576s left) kms_invalid_mode (overflow-vrefresh)
[447.696352] Starting subtest: overflow-vrefresh
[447.698692] Starting dynamic subtest: pipe-A-eDP-1
[447.983416] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[447.993842] Starting dynamic subtest: pipe-B-eDP-1
[447.995814] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[448.005832] Starting dynamic subtest: pipe-C-eDP-1
[448.008092] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[448.017774] Starting dynamic subtest: pipe-D-eDP-1
[448.020140] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[448.022542] Subtest overflow-vrefresh: SUCCESS (0.295s)
[448.823558] [080/133] (575s left) kms_async_flips (invalid-async-flip-atomic)
[448.888286] Starting subtest: invalid-async-flip-atomic
[449.265638] Starting dynamic subtest: pipe-A-eDP-1
[450.047491] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.782s)
[450.410983] Starting dynamic subtest: pipe-B-eDP-1
[451.184329] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.781s)
[451.539923] Starting dynamic subtest: pipe-C-eDP-1
[452.306656] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.775s)
[452.661008] Starting dynamic subtest: pipe-D-eDP-1
[453.430269] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.777s)
[453.432521] Subtest invalid-async-flip-atomic: SUCCESS (4.543s)
[454.587985] [081/133] (569s left) kms_content_protection (dp-mst-type-0)
[454.706783] Starting subtest: dp-mst-type-0
[454.711023] Subtest dp-mst-type-0: SKIP (0.000s)
[454.839254] [082/133] (569s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[454.921873] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[454.925842] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[455.028443] [083/133] (569s left) kms_getfb (getfb2-into-addfb2)
[455.109089] Starting subtest: getfb2-into-addfb2
[455.111402] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[455.205848] [084/133] (569s left) i915_module_load (resize-bar)
[455.243792] Starting subtest: resize-bar
[455.252929] Subtest resize-bar: SKIP (0.006s)
[455.291034] [085/133] (569s left) kms_flip (plain-flip-fb-recreate-interruptible)
[455.358746] Starting subtest: plain-flip-fb-recreate-interruptible
[455.361032] Starting dynamic subtest: A-eDP1
[464.183989] Dynamic subtest A-eDP1: SUCCESS (8.824s)
[464.198006] Starting dynamic subtest: B-eDP1
[473.016296] Dynamic subtest B-eDP1: SUCCESS (8.830s)
[473.027606] Starting dynamic subtest: C-eDP1
[481.834688] Dynamic subtest C-eDP1: SUCCESS (8.818s)
[481.845968] Starting dynamic subtest: D-eDP1
[490.661831] Dynamic subtest D-eDP1: SUCCESS (8.827s)
[490.666071] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.310s)
[491.839387] [086/133] (532s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[491.939341] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[492.574503] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.637s)
[492.747449] [087/133] (531s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[492.796432] Starting subtest: single-wait-for-submit-available-signaled
[492.798761] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[492.889998] [088/133] (531s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[492.961602] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[492.963920] Starting dynamic subtest: pipe-A-default-mode
[494.086020] Dynamic subtest pipe-A-default-mode: SKIP (1.123s)
[494.090151] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.124s)
[494.240024] [089/133] (530s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[494.348571] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[494.353041] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[494.516751] [090/133] (530s left) gem_exec_schedule (preempt-queue)
[494.595842] Subtest preempt-queue: SKIP (0.000s)
[494.897763] [091/133] (529s left) kms_cdclk (mode-transition-all-outputs)
[494.976338] Starting subtest: mode-transition-all-outputs
[495.269774] Subtest mode-transition-all-outputs: SKIP (0.291s)
[496.090928] [092/133] (528s left) gem_workarounds (reset-fd)
[496.158040] Starting subtest: reset-fd
[496.336322] Subtest reset-fd: SUCCESS (0.176s)
[496.451329] [093/133] (528s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[496.526773] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[496.530837] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[496.625514] [094/133] (528s left) gem_close_race (multigpu-basic-threads)
[496.691001] Starting subtest: multigpu-basic-threads
[496.695659] Subtest multigpu-basic-threads: SKIP (0.000s)
[496.903337] [095/133] (528s left) gem_exec_params (no-bsd)
[496.966928] Starting subtest: no-bsd
[496.971904] Subtest no-bsd: SUCCESS (0.003s)
[498.492589] [096/133] (526s left) kms_plane_multiple (2x-tiling-yf)
[498.579373] Starting subtest: 2x-tiling-yf
[498.583594] Subtest 2x-tiling-yf: SKIP (0.000s)
[498.666556] [097/133] (526s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[498.725747] Starting subtest: invalid-bsd2-flag-on-blt
[498.728160] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[498.830627] [098/133] (526s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[498.908754] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[503.690519] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.785s)
[504.888730] [099/133] (520s left) kms_pm_rpm (pm-tiling)
[506.590907] Starting subtest: pm-tiling
[506.596252] Subtest pm-tiling: SKIP (0.000s)
[507.122202] [100/133] (518s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[507.180928] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[507.287748] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[507.363984] [101/133] (517s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[507.433466] Starting subtest: invalid-multi-wait-unsubmitted
[507.435699] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[507.534256] [102/133] (517s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[507.602178] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[507.606316] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[507.683985] [103/133] (517s left) kms_chamelium_frames (hdmi-crc-single)
[508.048052] Subtest hdmi-crc-single: SKIP (0.000s)
[508.826585] [104/133] (516s left) syncobj_wait (multi-wait-submitted-signaled)
[508.884861] Starting subtest: multi-wait-submitted-signaled
[508.887116] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[508.995608] [105/133] (516s left) gem_userptr_blits (coherency-sync)
[509.066440] Starting subtest: coherency-sync
[509.514977] Subtest coherency-sync: SKIP (0.412s)
[509.628265] [106/133] (515s left) kms_vblank (ts-continuation-idle-hang)
[509.743279] Starting subtest: ts-continuation-idle-hang
[509.745531] Starting dynamic subtest: pipe-A-eDP-1
[536.194872] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.454s)
[536.216376] Starting dynamic subtest: pipe-D-eDP-1
[551.241115] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.045s)
[551.243476] Subtest ts-continuation-idle-hang: SUCCESS (41.504s)
[552.097115] [107/133] (473s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[552.182518] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[552.186551] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[552.285082] [108/133] (473s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[552.393893] Starting subtest: 2x-cursor-vs-flip-legacy
[552.398360] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[552.555469] [109/133] (473s left) gem_exec_balancer (parallel-balancer)
[552.807609] Starting subtest: parallel-balancer
[553.668259] Subtest parallel-balancer: SUCCESS (0.864s)
[553.775220] [110/133] (471s left) perf (stress-open-close)
[553.927104] Starting subtest: stress-open-close
[553.929439] Starting dynamic subtest: 0-rcs0
[556.097208] Dynamic subtest 0-rcs0: SUCCESS (2.173s)
[556.110222] Starting dynamic subtest: 1-vcs0
[558.259494] Dynamic subtest 1-vcs0: SUCCESS (2.162s)
[558.261476] Subtest stress-open-close: SUCCESS (4.336s)
[558.312901] [111/133] (467s left) gem_ctx_shared (create-shared-gtt)
[558.370298] Starting subtest: create-shared-gtt
[560.576656] Subtest create-shared-gtt: SUCCESS (2.152s)
[560.837841] [112/133] (464s left) kms_addfb_basic (small-bo)
[560.911743] Starting subtest: small-bo
[560.913936] Subtest small-bo: SUCCESS (0.000s)
[561.020878] [113/133] (464s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[561.107122] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[561.109428] Starting dynamic subtest: pipe-A-eDP-1
[561.129757] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[561.142480] Starting dynamic subtest: pipe-B-eDP-1
[561.161729] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[561.172271] Starting dynamic subtest: pipe-C-eDP-1
[561.191418] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[561.201419] Starting dynamic subtest: pipe-D-eDP-1
[561.220391] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[561.222249] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[563.354898] [114/133] (462s left) syncobj_timeline (wait-delayed-signal)
[563.409868] Starting subtest: wait-delayed-signal
[563.514539] Subtest wait-delayed-signal: SUCCESS (0.102s)
[563.596552] [115/133] (462s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[563.678695] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[563.682841] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[563.783265] [116/133] (462s left) gem_mmap_gtt (hang-user)
[563.832373] Subtest hang-user: SKIP (0.000s)
[563.894577] [117/133] (462s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[563.952518] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[564.055887] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[564.133899] [118/133] (461s left) gem_tiled_wc
[564.250484] [119/133] (461s left) i915_pm_rps (thresholds-park)
[564.303224] Starting subtest: thresholds-park
[564.307915] Subtest thresholds-park: SKIP (0.001s)
[564.408550] [120/133] (461s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[564.486743] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[564.491152] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[564.580598] [121/133] (461s left) kms_busy (extended-pageflip-hang-newfb)
[564.660540] Starting subtest: extended-pageflip-hang-newfb
[564.665176] Starting dynamic subtest: pipe-A
[591.250861] Dynamic subtest pipe-A: SUCCESS (26.590s)
[591.262114] Starting dynamic subtest: pipe-D
[615.223834] Dynamic subtest pipe-D: SUCCESS (23.973s)
[615.226138] Subtest extended-pageflip-hang-newfb: SUCCESS (50.568s)
[616.106987] [122/133] (410s left) gem_spin_batch (engines)
[616.175588] Starting subtest: engines
[616.177539] Starting dynamic subtest: rcs0
[619.411596] Dynamic subtest rcs0: SUCCESS (3.234s)
[619.429711] Starting dynamic subtest: bcs0
[622.701227] Dynamic subtest bcs0: SUCCESS (3.237s)
[622.714624] Starting dynamic subtest: vcs0
[625.937988] Dynamic subtest vcs0: SUCCESS (3.234s)
[625.950725] Starting dynamic subtest: vcs1
[629.173491] Dynamic subtest vcs1: SUCCESS (3.234s)
[629.186959] Starting dynamic subtest: vecs0
[632.408941] Dynamic subtest vecs0: SUCCESS (3.233s)
[632.421478] Starting dynamic subtest: ccs0
[635.645152] Dynamic subtest ccs0: SUCCESS (3.234s)
[635.647744] Subtest engines: SUCCESS (19.422s)
[635.830610] [123/133] (390s left) kms_sequence (get-busy)
[635.914920] Starting subtest: get-busy
[635.917247] Starting dynamic subtest: pipe-A-eDP-1
[637.859231] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.942s)
[637.870181] Starting dynamic subtest: pipe-B-eDP-1
[640.449359] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.589s)
[640.465730] Starting dynamic subtest: pipe-C-eDP-1
[643.054752] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.605s)
[643.066582] Starting dynamic subtest: pipe-D-eDP-1
[645.609018] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.553s)
[645.611490] Subtest get-busy: SUCCESS (9.695s)
[646.408164] [124/133] (379s left) gem_exec_reloc (basic-cpu-read)
[646.468497] Subtest basic-cpu-read: SKIP (0.000s)
[646.536942] [125/133] (379s left) gem_exec_whisper (basic-forked-all)
[646.618165] Starting subtest: basic-forked-all
[660.515425] Subtest basic-forked-all: SUCCESS (13.894s)
[660.699163] [126/133] (365s left) kms_flip (basic-flip-vs-wf_vblank)
[660.781514] Starting subtest: basic-flip-vs-wf_vblank
[660.783838] Starting dynamic subtest: A-eDP1
[662.742782] Dynamic subtest A-eDP1: SUCCESS (1.962s)
[662.758472] Starting dynamic subtest: B-eDP1
[664.675830] Dynamic subtest B-eDP1: SUCCESS (1.930s)
[664.689030] Starting dynamic subtest: C-eDP1
[666.593751] Dynamic subtest C-eDP1: SUCCESS (1.915s)
[666.607209] Starting dynamic subtest: D-eDP1
[668.523813] Dynamic subtest D-eDP1: SUCCESS (1.927s)
[668.525953] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.745s)
[669.742591] [127/133] (356s left) core_auth (getclient-simple)
[669.780361] Starting subtest: getclient-simple
[669.801459] Subtest getclient-simple: SUCCESS (0.021s)
[669.899815] [128/133] (356s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[669.971483] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[669.975615] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[670.082134] [129/133] (356s left) perf (low-oa-exponent-permissions)
[670.170817] Starting subtest: low-oa-exponent-permissions
[670.204697] Subtest low-oa-exponent-permissions: SUCCESS (0.034s)
[670.247432] [130/133] (356s left) gem_vm_create (execbuf)
[670.295031] Starting subtest: execbuf
[670.304520] Subtest execbuf: SUCCESS (0.010s)
[670.436902] [131/133] (356s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[670.520564] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[671.522307] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.001s)
[671.632490] [132/133] (354s left) gem_mmap_gtt (basic-small-bo)
[671.679705] Subtest basic-small-bo: SKIP (0.000s)
[671.737474] [133/133] (354s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[671.809844] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[671.812979] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[671.891118] 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.