[55.979869] Initializing watchdogs
[55.979937]   /dev/watchdog0
[55.994088] [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]
[55.998622] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.000903] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.004353] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[56.125771] Starting subtest: fbcpsr-indfb-scaledprimary
[61.851883] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.801s)
[61.971820] [002/133] (954s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[62.078342] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[69.091627] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (7.051s)
[69.262451] [003/133] (947s left) prime_mmap (test_correct)
[69.323071] Starting subtest: test_correct
[69.325071] Starting dynamic subtest: test_correct-smem
[69.355833] Dynamic subtest test_correct-smem: SUCCESS (0.035s)
[69.358245] Subtest test_correct: SUCCESS (0.035s)
[69.461874] [004/133] (947s left) gem_exec_reloc (basic-write-read)
[69.524712] Subtest basic-write-read: SKIP (0.000s)
[69.594198] [005/133] (947s left) gem_ctx_isolation (preservation)
[69.662675] Starting subtest: preservation
[69.664606] Starting dynamic subtest: rcs0
[69.801057] Dynamic subtest rcs0: SUCCESS (0.141s)
[69.808870] Starting dynamic subtest: bcs0
[69.960382] Dynamic subtest bcs0: SUCCESS (0.159s)
[69.969578] Starting dynamic subtest: vcs0
[70.114365] Dynamic subtest vcs0: SUCCESS (0.153s)
[70.121994] Starting dynamic subtest: vcs1
[71.432408] Dynamic subtest vcs1: SUCCESS (1.322s)
[71.442862] Starting dynamic subtest: vecs0
[73.540590] Dynamic subtest vecs0: SUCCESS (2.113s)
[73.549155] Starting dynamic subtest: ccs0
[75.411422] Dynamic subtest ccs0: SUCCESS (1.873s)
[75.414146] Subtest preservation: SUCCESS (5.762s)
[75.648870] [006/133] (941s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[75.754990] Starting subtest: x-tiled-16bpp-rotate-270
[75.776157] Subtest x-tiled-16bpp-rotate-270: SKIP (0.018s)
[75.877919] [007/133] (940s left) gem_exec_fence (long-history)
[76.331342] Starting subtest: long-history
[83.101936] Subtest long-history: SUCCESS (6.778s)
[83.573571] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true
[83.576701] [008/133] (933s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[83.676359] Starting subtest: primary-yf-tiled-reflect-x-180
[83.738460] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.060s)
[83.838815] [009/133] (932s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[83.893664] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[83.895971] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[83.996786] [010/133] (932s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[84.084166] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[84.088386] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[84.164509] [011/133] (932s left) gem_exec_flush (basic-uc-set-default)
[84.220439] Starting subtest: basic-uc-set-default
[89.674818] Subtest basic-uc-set-default: SUCCESS (5.455s)
[89.864971] [012/133] (927s left) gem_ctx_bad_destroy (double-destroy)
[89.923267] Starting subtest: double-destroy
[89.925551] Subtest double-destroy: SUCCESS (0.000s)
[90.011161] [013/133] (926s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[90.126391] Starting subtest: y-tiled-32bpp-rotate-0
[90.130723] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[90.226801] [014/133] (926s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[90.340893] Starting subtest: 2x-flip-vs-cursor-legacy
[90.347308] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[90.500138] [015/133] (926s left) kms_cursor_crc (cursor-random-256x256)
[90.721723] Starting subtest: cursor-random-256x256
[90.724086] Starting dynamic subtest: pipe-A-eDP-1
[94.057555] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.332s)
[94.087419] Starting dynamic subtest: pipe-D-eDP-1
[98.043783] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.962s)
[98.045694] Subtest cursor-random-256x256: SUCCESS (7.322s)
[98.920689] [016/133] (918s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[99.317240] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[100.123749] [017/133] (917s left) gem_ctx_shared (q-independent)
[100.181358] Starting subtest: Q-independent
[100.183743] Starting dynamic subtest: rcs0
[100.243554] Dynamic subtest rcs0: SUCCESS (0.062s)
[100.251939] Starting dynamic subtest: vcs0
[100.289408] Dynamic subtest vcs0: SUCCESS (0.046s)
[100.299436] Starting dynamic subtest: vcs1
[100.341032] Dynamic subtest vcs1: SUCCESS (0.051s)
[100.351263] Starting dynamic subtest: vecs0
[100.383493] Dynamic subtest vecs0: SUCCESS (0.042s)
[100.396412] Starting dynamic subtest: ccs0
[100.431218] Dynamic subtest ccs0: SUCCESS (0.047s)
[100.433669] Subtest Q-independent: SUCCESS (0.250s)
[102.370903] [018/133] (914s left) gem_ctx_param (basic-default)
[102.440310] Starting subtest: basic-default
[102.442656] Subtest basic-default: SUCCESS (0.000s)
[102.513767] [019/133] (914s left) gem_exec_schedule (preempt-queue-contexts-chain)
[102.595794] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[102.886250] [020/133] (914s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[102.989350] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[102.991549] Starting dynamic subtest: pipe-A-eDP-1
[103.014276] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[103.023609] Starting dynamic subtest: pipe-B-eDP-1
[103.044671] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[103.052602] Starting dynamic subtest: pipe-C-eDP-1
[103.074512] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[103.082731] Starting dynamic subtest: pipe-D-eDP-1
[103.104776] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[103.108800] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[105.298988] [021/133] (912s left) kms_addfb_basic (tile-pitch-mismatch)
[105.363045] Starting subtest: tile-pitch-mismatch
[105.367513] Subtest tile-pitch-mismatch: SKIP (0.000s)
[105.517204] [022/133] (911s left) kms_cursor_crc (cursor-suspend)
[105.645248] Starting subtest: cursor-suspend
[105.647480] Starting dynamic subtest: pipe-A-eDP-1
[138.773715] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.252s)
[138.783164] Starting dynamic subtest: pipe-D-eDP-1
[172.775563] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.799s)
[172.777687] Subtest cursor-suspend: SUCCESS (7.054s)
[173.568099] [023/133] (843s left) core_getversion (basic)
[173.615556] Starting subtest: basic
[173.621106] Subtest basic: SUCCESS (0.000s)
[173.675634] [024/133] (843s left) gem_pread (bench)
[173.740483] Subtest bench: SKIP (0.000s)
[173.794497] [025/133] (843s left) gen9_exec_parse (bb-start-far)
[173.859225] Subtest bb-start-far: SKIP (0.000s)
[173.924893] [026/133] (843s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[174.020533] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[174.025331] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[174.125114] [027/133] (843s left) gem_ctx_param (get-priority-new-ctx)
[174.183670] Starting subtest: get-priority-new-ctx
[174.186558] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[174.285990] [028/133] (843s left) kms_big_fb (linear-8bpp-rotate-90)
[174.389281] Starting subtest: linear-8bpp-rotate-90
[174.409496] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[174.504820] [029/133] (843s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[174.592542] Starting subtest: basic-modeset-with-all-modifiers-formats
[174.977133] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[175.712479] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.750s)
[175.721939] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[175.733830] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[175.742840] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[175.754421] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[175.763436] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[175.908686] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.156s)
[175.918679] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[175.929229] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[175.940688] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[175.951694] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[175.960831] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[175.973337] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[175.982438] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[175.995669] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[176.004556] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[176.017125] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[176.026134] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[176.039384] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[176.048512] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[176.061130] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[176.069912] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[176.083143] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[176.092519] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[176.236558] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[176.250561] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[176.257795] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[176.267457] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[176.280104] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[176.296528] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[176.303450] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[176.314836] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[176.324034] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[176.333664] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[176.345922] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[176.355192] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[176.367358] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[176.376858] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[176.389538] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[176.399293] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[176.411337] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[176.420255] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[176.564694] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.156s)
[176.574837] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[176.586720] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[176.597693] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[176.608624] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[176.617926] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[176.630555] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[176.639673] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[176.652319] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[176.661322] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[176.674248] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[176.682870] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[176.696958] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[176.710049] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[176.718229] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.020s)
[176.727904] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[176.740197] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[177.141637] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.591s)
[177.964185] [030/133] (839s left) gem_exec_balancer (persistence)
[178.239072] Starting subtest: persistence
[179.168691] Subtest persistence: SUCCESS (0.940s)
[179.275770] [031/133] (838s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[179.377468] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[179.382636] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[179.460875] [032/133] (838s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[179.566593] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[179.571717] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[179.673516] [033/133] (838s left) i915_pm_rpm (gem-pread)
[181.602390] Starting subtest: gem-pread
[183.651430] Subtest gem-pread: SUCCESS (2.066s)
[183.760057] [034/133] (834s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[185.680347] Starting subtest: dpms-mode-unset-lpsp
[189.700077] Subtest dpms-mode-unset-lpsp: SUCCESS (4.038s)
[190.069673] [035/133] (827s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[190.134468] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[190.140469] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[190.325996] [036/133] (827s left) gem_exec_whisper (basic-queues-priority)
[190.381012] Starting subtest: basic-queues-priority
[213.531592] Subtest basic-queues-priority: SUCCESS (23.160s)
[213.714206] [037/133] (804s left) kms_addfb_basic (addfb25-modifier-no-flag)
[213.819423] Starting subtest: addfb25-modifier-no-flag
[213.821567] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[213.905060] [038/133] (804s left) kms_flip (dpms-off-confusion-interruptible)
[214.007208] Starting subtest: dpms-off-confusion-interruptible
[214.009735] Starting dynamic subtest: A-eDP1
[222.636610] Dynamic subtest A-eDP1: SUCCESS (8.628s)
[222.648453] Starting dynamic subtest: B-eDP1
[231.277331] Dynamic subtest B-eDP1: SUCCESS (8.640s)
[231.286962] Starting dynamic subtest: C-eDP1
[239.894739] Dynamic subtest C-eDP1: SUCCESS (8.618s)
[239.904691] Starting dynamic subtest: D-eDP1
[248.522335] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[248.527461] Subtest dpms-off-confusion-interruptible: SUCCESS (34.525s)
[249.693632] [039/133] (768s left) kms_flip (flip-vs-panning-vs-hang)
[249.799717] Starting subtest: flip-vs-panning-vs-hang
[249.802077] Starting dynamic subtest: A-eDP1
[300.915134] Dynamic subtest A-eDP1: SUCCESS (51.118s)
[300.924951] Starting dynamic subtest: D-eDP1
[350.961164] Dynamic subtest D-eDP1: SUCCESS (50.051s)
[350.963609] Subtest flip-vs-panning-vs-hang: SUCCESS (101.173s)
[352.206976] [040/133] (665s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[352.313588] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[358.851271] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.542s)
[358.975303] [041/133] (659s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[359.083151] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[366.617462] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.541s)
[366.766180] [042/133] (651s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[366.880427] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[366.885436] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[366.957891] [043/133] (651s left) gem_userptr_blits (create-destroy-unsync)
[367.045438] Subtest create-destroy-unsync: SKIP (0.000s)
[367.169860] [044/133] (651s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[367.265146] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[367.270390] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[367.361013] [045/133] (650s left) kms_psr (fbc-pr-sprite-render)
[367.458432] Starting subtest: fbc-pr-sprite-render
[367.463603] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[367.531417] [046/133] (650s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[367.632186] Starting subtest: psr2-plane-move-sf-dmg-area
[367.634344] Starting dynamic subtest: pipe-A-eDP-1
[372.182845] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.558s)
[372.194663] Starting dynamic subtest: pipe-B-eDP-1
[377.520421] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.338s)
[377.523273] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.898s)
[378.402917] [047/133] (640s left) kms_psr (psr-primary-blt)
[378.496306] Starting subtest: psr-primary-blt
[378.498707] Starting dynamic subtest: eDP-1
[380.291169] Dynamic subtest eDP-1: SUCCESS (1.795s)
[380.294118] Subtest psr-primary-blt: SUCCESS (1.796s)
[381.162833] [048/133] (637s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[381.256418] Starting subtest: fbc-psr-sprite-mmap-cpu
[381.258581] Starting dynamic subtest: eDP-1
[381.263527] Dynamic subtest eDP-1: SKIP (0.000s)
[381.268259] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[381.339830] [049/133] (637s left) i915_drm_fdinfo (memory-info-idle)
[381.389087] Starting subtest: memory-info-idle
[381.391432] Starting dynamic subtest: smem0
[381.432576] Dynamic subtest smem0: SUCCESS (0.045s)
[381.435493] Subtest memory-info-idle: SUCCESS (0.046s)
[381.520257] [050/133] (637s left) kms_plane_scaling (invalid-parameters)
[381.606624] Starting subtest: invalid-parameters
[381.608951] Starting dynamic subtest: less-than-1-height-src
[381.619401] Dynamic subtest less-than-1-height-src: SUCCESS (0.013s)
[381.629385] Starting dynamic subtest: less-than-1-width-src
[381.631685] Dynamic subtest less-than-1-width-src: SUCCESS (0.012s)
[381.634113] Subtest invalid-parameters: SUCCESS (0.026s)
[381.726058] [051/133] (636s left) gem_exec_reloc (basic-gtt-active)
[381.785618] Subtest basic-gtt-active: SKIP (0.000s)
[381.860283] [052/133] (636s left) gem_mmap_gtt (close-race)
[381.923458] Subtest close-race: SKIP (0.000s)
[381.992778] [053/133] (636s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[382.095396] Starting subtest: compare-crc-sanitycheck-nv12
[382.097295] Starting dynamic subtest: pipe-A-eDP-1
[382.854331] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.758s)
[382.866919] Starting dynamic subtest: pipe-B-eDP-1
[384.159416] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.303s)
[384.170465] Starting dynamic subtest: pipe-C-eDP-1
[385.472463] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.313s)
[385.486350] Starting dynamic subtest: pipe-D-eDP-1
[386.677994] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.206s)
[386.680532] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.586s)
[387.512426] [054/133] (631s left) api_intel_allocator (fork-simple-once)
[387.569570] Starting subtest: fork-simple-once
[387.583821] Subtest fork-simple-once: SUCCESS (0.017s)
[387.697881] [055/133] (631s left) kms_vrr (max-min)
[387.783686] Starting subtest: max-min
[387.791721] Subtest max-min: SKIP (0.000s)
[387.868978] [056/133] (630s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[387.963302] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[387.968152] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[388.037444] [057/133] (630s left) gem_exec_params (sol-reset-invalid)
[388.100314] Starting subtest: sol-reset-invalid
[388.103126] Subtest sol-reset-invalid: SUCCESS (0.003s)
[389.515987] [058/133] (629s left) kms_lease (invalid-create-leases)
[389.609954] Starting subtest: invalid-create-leases
[389.614725] Subtest invalid-create-leases: SUCCESS (0.006s)
[389.721169] [059/133] (629s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[389.778686] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[389.880001] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[389.960113] [060/133] (629s left) kms_psr (pr-primary-page-flip)
[390.051615] Starting subtest: pr-primary-page-flip
[390.056738] Subtest pr-primary-page-flip: SKIP (0.001s)
[390.136541] [061/133] (628s left) gem_exec_params (readonly)
[390.190463] Starting subtest: readonly
[390.193283] Subtest readonly: SUCCESS (0.003s)
[390.308086] [062/133] (628s left) gem_mmap_gtt (basic-copy)
[390.365542] Subtest basic-copy: SKIP (0.000s)
[390.430722] [063/133] (628s left) kms_psr (psr2-sprite-mmap-cpu)
[390.519992] Starting subtest: psr2-sprite-mmap-cpu
[390.522316] Starting dynamic subtest: eDP-1
[392.234971] Dynamic subtest eDP-1: SUCCESS (1.716s)
[392.237594] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.718s)
[393.113058] [064/133] (626s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[393.207316] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[400.174466] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.969s)
[400.304364] [065/133] (618s left) drm_read (empty-nonblock)
[400.456946] Starting subtest: empty-nonblock
[400.459028] Subtest empty-nonblock: SUCCESS (0.000s)
[400.584632] [066/133] (618s left) perf_pmu (busy-no-semaphores)
[400.636196] Starting subtest: busy-no-semaphores
[400.638234] Starting dynamic subtest: rcs0
[401.191394] Dynamic subtest rcs0: SUCCESS (0.554s)
[401.204541] Starting dynamic subtest: bcs0
[401.743590] Dynamic subtest bcs0: SUCCESS (0.548s)
[401.757804] Starting dynamic subtest: vcs0
[402.293630] Dynamic subtest vcs0: SUCCESS (0.547s)
[402.304335] Starting dynamic subtest: vcs1
[403.995326] Dynamic subtest vcs1: SUCCESS (1.679s)
[404.007385] Starting dynamic subtest: vecs0
[405.959123] Dynamic subtest vecs0: SUCCESS (1.979s)
[405.971583] Starting dynamic subtest: ccs0
[407.942999] Dynamic subtest ccs0: SUCCESS (1.980s)
[407.945700] Subtest busy-no-semaphores: SUCCESS (7.305s)
[408.074038] [067/133] (611s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[408.191521] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[408.194397] Starting dynamic subtest: pipe-A-eDP-1
[408.205245] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[408.220200] Starting dynamic subtest: pipe-B-eDP-1
[408.230930] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[408.242639] Starting dynamic subtest: pipe-C-eDP-1
[408.253357] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[408.263173] Starting dynamic subtest: pipe-D-eDP-1
[408.273551] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[408.278700] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[410.441203] [068/133] (608s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[410.545320] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[410.547749] Starting dynamic subtest: pipe-A-eDP-1
[410.570576] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[410.581679] Starting dynamic subtest: pipe-B-eDP-1
[410.606212] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[410.615532] Starting dynamic subtest: pipe-C-eDP-1
[410.640635] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[410.649635] Starting dynamic subtest: pipe-D-eDP-1
[410.675239] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[410.680246] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[412.830700] [069/133] (606s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[412.926617] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[412.929372] Starting dynamic subtest: pipe-A
[413.154157] Dynamic subtest pipe-A: SUCCESS (0.230s)
[413.164536] Starting dynamic subtest: pipe-B
[414.443587] Dynamic subtest pipe-B: SUCCESS (1.288s)
[414.458572] Starting dynamic subtest: pipe-C
[415.751677] Dynamic subtest pipe-C: SUCCESS (1.306s)
[415.761715] Starting dynamic subtest: pipe-D
[417.074500] Dynamic subtest pipe-D: SUCCESS (1.321s)
[417.077204] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.150s)
[418.257064] [070/133] (601s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[418.382726] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[418.387149] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[418.491796] [071/133] (600s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[418.602936] Starting subtest: protected-encrypted-src-copy-not-readible
[418.713707] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.112s)
[418.842987] [072/133] (600s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[418.934025] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[422.870695] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.940s)
[424.054946] [073/133] (595s left) fbdev (read)
[424.102826] Starting subtest: read
[424.637064] Subtest read: SUCCESS (0.532s)
[424.714226] [074/133] (594s left) gem_exec_parallel (basic)
[424.781584] Starting subtest: basic
[424.784255] Starting dynamic subtest: rcs0
[426.471144] Dynamic subtest rcs0: SUCCESS (1.688s)
[426.482838] Starting dynamic subtest: bcs0
[428.290407] Dynamic subtest bcs0: SUCCESS (1.817s)
[428.301186] Starting dynamic subtest: vcs0
[430.404999] Dynamic subtest vcs0: SUCCESS (2.111s)
[430.416746] Starting dynamic subtest: vcs1
[432.452564] Dynamic subtest vcs1: SUCCESS (2.044s)
[432.469706] Starting dynamic subtest: vecs0
[434.436178] Dynamic subtest vecs0: SUCCESS (1.980s)
[434.446173] Starting dynamic subtest: ccs0
[436.262448] Dynamic subtest ccs0: SUCCESS (1.826s)
[436.265289] Subtest basic: SUCCESS (11.479s)
[436.478161] [075/133] (583s left) kms_dsc (dsc-with-formats)
[436.579456] Starting subtest: dsc-with-formats
[436.625471] Subtest dsc-with-formats: SKIP (0.001s)
[436.669995] [076/133] (583s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[436.763423] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[436.768451] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[436.837709] [077/133] (582s left) kms_cursor_crc (cursor-onscreen-512x512)
[437.106216] Starting subtest: cursor-onscreen-512x512
[437.111309] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[437.263844] [078/133] (582s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[437.352925] Starting subtest: plane-lut1d-pre-ctm3x4
[437.521486] Starting dynamic subtest: pipe-A-plane-0
[437.698863] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[437.708922] Starting dynamic subtest: pipe-A-plane-1
[437.856842] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[437.866556] Starting dynamic subtest: pipe-A-plane-2
[438.009984] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[439.240124] Starting dynamic subtest: pipe-B-plane-0
[439.389275] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[439.399674] Starting dynamic subtest: pipe-B-plane-1
[439.542851] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[439.553220] Starting dynamic subtest: pipe-B-plane-2
[439.709673] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[440.911744] Starting dynamic subtest: pipe-C-plane-0
[441.059201] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[441.070637] Starting dynamic subtest: pipe-C-plane-1
[441.214682] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[441.225513] Starting dynamic subtest: pipe-C-plane-2
[441.370122] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[442.614470] Starting dynamic subtest: pipe-D-plane-0
[442.761674] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[442.772487] Starting dynamic subtest: pipe-D-plane-1
[442.928085] Dynamic subtest pipe-D-plane-1: SUCCESS (0.165s)
[442.938464] Starting dynamic subtest: pipe-D-plane-2
[443.095314] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[443.381346] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (6.029s)
[444.196225] [079/133] (575s left) kms_invalid_mode (overflow-vrefresh)
[444.285041] Starting subtest: overflow-vrefresh
[444.287670] Starting dynamic subtest: pipe-A-eDP-1
[444.582117] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[444.592725] Starting dynamic subtest: pipe-B-eDP-1
[444.595174] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[444.605529] Starting dynamic subtest: pipe-C-eDP-1
[444.608411] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[444.617973] Starting dynamic subtest: pipe-D-eDP-1
[444.620504] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[444.622993] Subtest overflow-vrefresh: SUCCESS (0.301s)
[445.423063] [080/133] (574s left) kms_async_flips (invalid-async-flip-atomic)
[445.517193] Starting subtest: invalid-async-flip-atomic
[445.905227] Starting dynamic subtest: pipe-A-eDP-1
[446.753569] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.848s)
[447.116889] Starting dynamic subtest: pipe-B-eDP-1
[447.895147] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.787s)
[448.258719] Starting dynamic subtest: pipe-C-eDP-1
[449.029379] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.780s)
[449.389285] Starting dynamic subtest: pipe-D-eDP-1
[450.157350] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.780s)
[450.159837] Subtest invalid-async-flip-atomic: SUCCESS (4.643s)
[451.306365] [081/133] (568s left) kms_content_protection (dp-mst-type-0)
[451.445248] Starting subtest: dp-mst-type-0
[451.450275] Subtest dp-mst-type-0: SKIP (0.000s)
[451.574129] [082/133] (568s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[451.667444] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[451.672700] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[451.773918] [083/133] (568s left) kms_getfb (getfb2-into-addfb2)
[451.859380] Starting subtest: getfb2-into-addfb2
[451.862386] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[451.960780] [084/133] (568s left) i915_module_load (resize-bar)
[452.001187] Starting subtest: resize-bar
[452.011338] Subtest resize-bar: SKIP (0.006s)
[452.055455] [085/133] (568s left) kms_flip (plain-flip-fb-recreate-interruptible)
[452.143207] Starting subtest: plain-flip-fb-recreate-interruptible
[452.145534] Starting dynamic subtest: A-eDP1
[460.991009] Dynamic subtest A-eDP1: SUCCESS (8.847s)
[461.002167] Starting dynamic subtest: B-eDP1
[469.819860] Dynamic subtest B-eDP1: SUCCESS (8.826s)
[469.830685] Starting dynamic subtest: C-eDP1
[478.635888] Dynamic subtest C-eDP1: SUCCESS (8.815s)
[478.647261] Starting dynamic subtest: D-eDP1
[487.470390] Dynamic subtest D-eDP1: SUCCESS (8.833s)
[487.475260] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.331s)
[488.661924] [086/133] (531s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[488.764029] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[489.412300] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.648s)
[489.572207] [087/133] (530s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[489.621954] Starting subtest: single-wait-for-submit-available-signaled
[489.624410] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[489.726694] [088/133] (530s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[489.816346] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[489.818682] Starting dynamic subtest: pipe-A-default-mode
[491.010088] Dynamic subtest pipe-A-default-mode: SKIP (1.189s)
[491.015304] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.191s)
[491.158695] [089/133] (529s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[491.271703] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[491.276800] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[491.427034] [090/133] (528s left) gem_exec_schedule (preempt-queue)
[491.511482] Subtest preempt-queue: SKIP (0.000s)
[491.807008] [091/133] (528s left) kms_cdclk (mode-transition-all-outputs)
[491.898118] Starting subtest: mode-transition-all-outputs
[492.186686] Subtest mode-transition-all-outputs: SKIP (0.287s)
[493.004281] [092/133] (527s left) gem_workarounds (reset-fd)
[493.072411] Starting subtest: reset-fd
[493.262040] Subtest reset-fd: SUCCESS (0.187s)
[493.396438] [093/133] (527s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[493.494531] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[493.499543] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[493.601272] [094/133] (526s left) gem_close_race (multigpu-basic-threads)
[493.673555] Starting subtest: multigpu-basic-threads
[493.679182] Subtest multigpu-basic-threads: SKIP (0.000s)
[493.897366] [095/133] (526s left) gem_exec_params (no-bsd)
[493.951864] Starting subtest: no-bsd
[493.958721] Subtest no-bsd: SUCCESS (0.003s)
[495.557347] [096/133] (525s left) kms_plane_multiple (2x-tiling-yf)
[495.655458] Starting subtest: 2x-tiling-yf
[495.660472] Subtest 2x-tiling-yf: SKIP (0.000s)
[495.730791] [097/133] (524s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[495.801408] Starting subtest: invalid-bsd2-flag-on-blt
[495.803543] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[495.908029] [098/133] (524s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[496.010692] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[500.907459] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.901s)
[502.115615] [099/133] (518s left) kms_pm_rpm (pm-tiling)
[503.640714] Starting subtest: pm-tiling
[503.646634] Subtest pm-tiling: SKIP (0.000s)
[504.346154] [100/133] (516s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[504.395509] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[504.495553] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[504.575038] [101/133] (516s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[504.641832] Starting subtest: invalid-multi-wait-unsubmitted
[504.644672] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[504.742321] [102/133] (516s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[504.850856] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[504.855688] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[504.969424] [103/133] (515s left) kms_chamelium_frames (hdmi-crc-single)
[505.356290] Subtest hdmi-crc-single: SKIP (0.000s)
[506.145097] [104/133] (514s left) syncobj_wait (multi-wait-submitted-signaled)
[506.198597] Starting subtest: multi-wait-submitted-signaled
[506.201220] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[506.286617] [105/133] (514s left) gem_userptr_blits (coherency-sync)
[506.366464] Starting subtest: coherency-sync
[506.792000] Subtest coherency-sync: SKIP (0.387s)
[506.884049] [106/133] (514s left) kms_vblank (ts-continuation-idle-hang)
[507.031556] Starting subtest: ts-continuation-idle-hang
[507.033986] Starting dynamic subtest: pipe-A-eDP-1
[533.249313] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.219s)
[533.271372] Starting dynamic subtest: pipe-D-eDP-1
[548.219988] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.968s)
[548.222865] Subtest ts-continuation-idle-hang: SUCCESS (41.196s)
[549.029054] [107/133] (472s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[549.133562] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[549.138475] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[549.214598] [108/133] (471s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[549.337665] Starting subtest: 2x-cursor-vs-flip-legacy
[549.343624] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[549.483315] [109/133] (471s left) gem_exec_balancer (parallel-balancer)
[549.752256] Starting subtest: parallel-balancer
[550.654992] Subtest parallel-balancer: SUCCESS (0.903s)
[550.779164] [110/133] (470s left) perf (stress-open-close)
[550.931108] Starting subtest: stress-open-close
[550.933530] Starting dynamic subtest: 0-rcs0
[553.098225] Dynamic subtest 0-rcs0: SUCCESS (2.171s)
[553.109897] Starting dynamic subtest: 1-vcs0
[555.261489] Dynamic subtest 1-vcs0: SUCCESS (2.162s)
[555.263718] Subtest stress-open-close: SUCCESS (4.335s)
[555.307525] [111/133] (465s left) gem_ctx_shared (create-shared-gtt)
[555.376177] Starting subtest: create-shared-gtt
[557.534319] Subtest create-shared-gtt: SUCCESS (2.157s)
[557.817513] [112/133] (463s left) kms_addfb_basic (small-bo)
[557.931541] Starting subtest: small-bo
[557.934572] Subtest small-bo: SUCCESS (0.000s)
[558.034995] [113/133] (463s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[558.134005] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[558.136713] Starting dynamic subtest: pipe-A-eDP-1
[558.162304] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[558.174769] Starting dynamic subtest: pipe-B-eDP-1
[558.198111] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[558.208431] Starting dynamic subtest: pipe-C-eDP-1
[558.231726] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[558.242143] Starting dynamic subtest: pipe-D-eDP-1
[558.265442] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[558.267693] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[560.384313] [114/133] (461s left) syncobj_timeline (wait-delayed-signal)
[560.433392] Starting subtest: wait-delayed-signal
[560.538194] Subtest wait-delayed-signal: SUCCESS (0.102s)
[560.627705] [115/133] (460s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[560.715923] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[560.720595] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[560.796863] [116/133] (460s left) gem_mmap_gtt (hang-user)
[560.848271] Subtest hang-user: SKIP (0.000s)
[560.908119] [117/133] (460s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[560.970690] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[561.071686] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.101s)
[561.149161] [118/133] (460s left) gem_tiled_wc
[561.274031] [119/133] (460s left) i915_pm_rps (thresholds-park)
[561.333488] Starting subtest: thresholds-park
[561.337855] Subtest thresholds-park: SKIP (0.001s)
[561.443074] [120/133] (460s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[561.540459] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[561.545096] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[561.640084] [121/133] (460s left) kms_busy (extended-pageflip-hang-newfb)
[561.731473] Starting subtest: extended-pageflip-hang-newfb
[561.734023] Starting dynamic subtest: pipe-A
[588.258831] Dynamic subtest pipe-A: SUCCESS (26.533s)
[588.270561] Starting dynamic subtest: pipe-D
[603.285747] Dynamic subtest pipe-D: SUCCESS (15.027s)
[603.288664] Subtest extended-pageflip-hang-newfb: SUCCESS (41.566s)
[604.150944] [122/133] (417s left) gem_spin_batch (engines)
[604.210789] Starting subtest: engines
[604.213300] Starting dynamic subtest: rcs0
[607.456685] Dynamic subtest rcs0: SUCCESS (3.241s)
[607.470278] Starting dynamic subtest: bcs0
[610.692296] Dynamic subtest bcs0: SUCCESS (3.233s)
[610.706699] Starting dynamic subtest: vcs0
[613.935735] Dynamic subtest vcs0: SUCCESS (3.236s)
[613.949596] Starting dynamic subtest: vcs1
[617.169594] Dynamic subtest vcs1: SUCCESS (3.238s)
[617.182970] Starting dynamic subtest: vecs0
[620.403427] Dynamic subtest vecs0: SUCCESS (3.231s)
[620.416092] Starting dynamic subtest: ccs0
[623.640675] Dynamic subtest ccs0: SUCCESS (3.235s)
[623.643493] Subtest engines: SUCCESS (19.430s)
[623.883431] [123/133] (397s left) kms_sequence (get-busy)
[623.976579] Starting subtest: get-busy
[623.979203] Starting dynamic subtest: pipe-A-eDP-1
[625.912192] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s)
[625.926378] Starting dynamic subtest: pipe-B-eDP-1
[628.545141] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.632s)
[628.562468] Starting dynamic subtest: pipe-C-eDP-1
[631.155483] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.609s)
[631.169325] Starting dynamic subtest: pipe-D-eDP-1
[633.792377] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.634s)
[633.795587] Subtest get-busy: SUCCESS (9.816s)
[634.666494] [124/133] (387s left) gem_exec_reloc (basic-cpu-read)
[634.723500] Subtest basic-cpu-read: SKIP (0.000s)
[634.781004] [125/133] (387s left) gem_exec_whisper (basic-forked-all)
[634.864341] Starting subtest: basic-forked-all
[648.709616] Subtest basic-forked-all: SUCCESS (13.845s)
[648.901685] [126/133] (373s left) kms_flip (basic-flip-vs-wf_vblank)
[649.000669] Starting subtest: basic-flip-vs-wf_vblank
[649.003162] Starting dynamic subtest: A-eDP1
[650.896710] Dynamic subtest A-eDP1: SUCCESS (1.898s)
[650.908243] Starting dynamic subtest: B-eDP1
[652.834738] Dynamic subtest B-eDP1: SUCCESS (1.935s)
[652.846721] Starting dynamic subtest: C-eDP1
[654.757346] Dynamic subtest C-eDP1: SUCCESS (1.920s)
[654.768521] Starting dynamic subtest: D-eDP1
[656.698973] Dynamic subtest D-eDP1: SUCCESS (1.939s)
[656.701488] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.701s)
[657.929282] [127/133] (364s left) core_auth (getclient-simple)
[657.968721] Starting subtest: getclient-simple
[657.986881] Subtest getclient-simple: SUCCESS (0.016s)
[658.082358] [128/133] (363s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[658.184679] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[658.190190] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[658.291235] [129/133] (363s left) perf (low-oa-exponent-permissions)
[658.391530] Starting subtest: low-oa-exponent-permissions
[658.427258] Subtest low-oa-exponent-permissions: SUCCESS (0.036s)
[658.480395] [130/133] (363s left) gem_vm_create (execbuf)
[658.533612] Starting subtest: execbuf
[658.542933] Subtest execbuf: SUCCESS (0.009s)
[658.680195] [131/133] (363s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[658.778362] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[659.904692] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.125s)
[660.009102] [132/133] (362s left) gem_mmap_gtt (basic-small-bo)
[660.063719] Subtest basic-small-bo: SKIP (0.000s)
[660.123902] [133/133] (362s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[660.227621] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[660.232182] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[660.320430] 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.