[57.231114] Initializing watchdogs
[57.231159]   /dev/watchdog0
[57.245145] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.249463] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.251632] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.254955] [001/133] (960s left) kms_chamelium_color (ctm-green-to-red)
[57.375836] Subtest ctm-green-to-red: SKIP (0.000s)
[57.417732] [002/133] (960s left) gem_exec_schedule (out-order)
[57.479788] Starting subtest: out-order
[57.482054] Starting dynamic subtest: rcs0
[57.584869] Dynamic subtest rcs0: SUCCESS (0.108s)
[57.594888] Starting dynamic subtest: vcs0
[57.666824] Dynamic subtest vcs0: SUCCESS (0.082s)
[57.677130] Starting dynamic subtest: vcs1
[57.743980] Dynamic subtest vcs1: SUCCESS (0.077s)
[57.757441] Starting dynamic subtest: vecs0
[57.818318] Dynamic subtest vecs0: SUCCESS (0.075s)
[57.828215] Starting dynamic subtest: ccs0
[57.904712] Dynamic subtest ccs0: SUCCESS (0.087s)
[57.907087] Subtest out-order: SUCCESS (0.431s)
[59.001270] [003/133] (958s left) kms_flip (flip-vs-suspend-interruptible)
[59.089387] Starting subtest: flip-vs-suspend-interruptible
[59.091757] Starting dynamic subtest: A-eDP1
[93.193846] Dynamic subtest A-eDP1: SUCCESS (4.558s)
[93.202754] Starting dynamic subtest: B-eDP1
[142.182614] Dynamic subtest B-eDP1: SUCCESS (5.204s)
[142.194812] Starting dynamic subtest: C-eDP1
[191.180378] Dynamic subtest C-eDP1: SUCCESS (4.530s)
[191.188707] Starting dynamic subtest: D-eDP1
[240.181822] Dynamic subtest D-eDP1: SUCCESS (4.565s)
[240.183660] Subtest flip-vs-suspend-interruptible: SUCCESS (18.863s)
[241.418061] [004/133] (776s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[241.532816] Starting subtest: 4-tiled-16bpp-rotate-90
[241.567703] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.033s)
[241.695655] [005/133] (776s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[241.800072] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[245.855494] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.147s)
[247.001644] [006/133] (770s left) tools_test (tools_test)
[247.054572] Starting subtest: tools_test
[247.100861] Subtest tools_test: SUCCESS (0.061s)
[247.162211] [007/133] (770s left) kms_psr (psr2-primary-page-flip)
[247.260504] Starting subtest: psr2-primary-page-flip
[247.262801] Starting dynamic subtest: eDP-1
[248.950167] Dynamic subtest eDP-1: SUCCESS (1.710s)
[248.952179] Subtest psr2-primary-page-flip: SUCCESS (1.711s)
[249.814522] [008/133] (768s left) gem_busy (parallel)
[249.999830] Starting subtest: parallel
[250.002294] Starting dynamic subtest: rcs0
[251.520324] Dynamic subtest rcs0: SUCCESS (1.531s)
[251.531773] Starting dynamic subtest: bcs0
[253.503121] Dynamic subtest bcs0: SUCCESS (1.996s)
[253.514462] Starting dynamic subtest: vcs0
[255.487657] Dynamic subtest vcs0: SUCCESS (1.994s)
[255.498566] Starting dynamic subtest: vcs1
[257.535824] Dynamic subtest vcs1: SUCCESS (2.056s)
[257.545106] Starting dynamic subtest: vecs0
[259.519056] Dynamic subtest vecs0: SUCCESS (1.989s)
[259.531383] Starting dynamic subtest: ccs0
[261.440540] Dynamic subtest ccs0: SUCCESS (1.925s)
[261.443403] Subtest parallel: SUCCESS (11.499s)
[261.690347] [009/133] (756s left) gem_busy (close-race)
[261.781317] Starting subtest: close-race
[287.516595] Subtest close-race: SUCCESS (25.734s)
[287.876006] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[287.880384] [010/133] (730s left) kms_selftest (drm_plane_helper)
[287.977778] Starting subtest: drm_plane_helper
[288.002869] Starting dynamic subtest: drm_test_check_plane_state
[288.115023] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.112s)
[288.124402] Starting dynamic subtest: drm_test_check_invalid_plane_state
[288.206936] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.092s)
[288.209386] Subtest drm_plane_helper: SUCCESS (0.232s)
[288.352454] [011/133] (729s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[288.466715] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[288.469000] Starting dynamic subtest: pipe-A-eDP-1
[288.527867] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[288.538603] Starting dynamic subtest: pipe-B-eDP-1
[288.595820] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[288.606210] Starting dynamic subtest: pipe-C-eDP-1
[288.661365] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[288.670628] Starting dynamic subtest: pipe-D-eDP-1
[288.726283] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[288.730670] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[290.723791] [012/133] (727s left) sw_sync (sync_multi_consumer_producer)
[290.766149] Starting subtest: sync_multi_consumer_producer
[291.087483] Subtest sync_multi_consumer_producer: SUCCESS (0.319s)
[291.146327] [013/133] (727s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[291.202058] Starting subtest: yf-tiled-to-vebox-yf-tiled
[291.206436] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[291.384633] [014/133] (726s left) gem_ppgtt (blt-vs-render-ctx0)
[291.437185] Starting subtest: blt-vs-render-ctx0
[324.136313] Subtest blt-vs-render-ctx0: SUCCESS (32.701s)
[324.274841] [015/133] (694s left) gem_softpin (allocator-nopin)
[324.367345] Starting subtest: allocator-nopin
[324.450686] Subtest allocator-nopin: SUCCESS (0.086s)
[324.576388] [016/133] (693s left) kms_psr (psr-no-drrs)
[324.678494] Starting subtest: psr-no-drrs
[324.680929] Starting dynamic subtest: eDP-1
[326.279220] Dynamic subtest eDP-1: SUCCESS (1.602s)
[326.281502] Subtest psr-no-drrs: SUCCESS (1.603s)
[327.157850] [017/133] (691s left) gem_fence_thrash (bo-write-verify-threaded-none)
[327.194232] Starting subtest: bo-write-verify-threaded-none
[327.208943] Subtest bo-write-verify-threaded-none: SKIP (0.015s)
[327.273271] [018/133] (691s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[327.325849] Starting subtest: multi-wait-for-submit-submitted-signaled
[327.328112] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[327.401514] [019/133] (691s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[327.491978] Starting subtest: stress-xrgb8888-yftiled
[327.496576] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[327.566939] [020/133] (690s left) kms_vblank (ts-continuation-modeset)
[327.664496] Starting subtest: ts-continuation-modeset
[327.666719] Starting dynamic subtest: pipe-A-eDP-1
[329.135719] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.470s)
[329.149622] Starting dynamic subtest: pipe-D-eDP-1
[331.297558] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.158s)
[331.299743] Subtest ts-continuation-modeset: SUCCESS (3.633s)
[332.101339] [021/133] (686s left) kms_joiner (basic-force-ultra-joiner)
[332.219243] Starting subtest: basic-force-ultra-joiner
[332.223521] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[332.299696] [022/133] (686s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[332.403348] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[336.948743] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.549s)
[338.098192] [023/133] (680s left) kms_cursor_crc (cursor-sliding-128x128)
[338.305176] Starting subtest: cursor-sliding-128x128
[338.307499] Starting dynamic subtest: pipe-A-eDP-1
[341.577034] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.268s)
[341.608313] Starting dynamic subtest: pipe-D-eDP-1
[345.507413] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.905s)
[345.510188] Subtest cursor-sliding-128x128: SUCCESS (7.201s)
[346.358570] [024/133] (672s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[346.459505] Starting subtest: 2x-absolute-wf_vblank-interruptible
[346.471312] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[346.549811] [025/133] (672s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[346.643877] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[346.646022] Starting dynamic subtest: pipe-A-eDP-1
[346.674176] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.029s)
[346.684486] Starting dynamic subtest: pipe-B-eDP-1
[346.704487] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[346.713363] Starting dynamic subtest: pipe-C-eDP-1
[346.733510] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[346.744065] Starting dynamic subtest: pipe-D-eDP-1
[346.765102] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[346.767389] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.099s)
[349.027242] [026/133] (669s left) gem_eio (wait-wedge-1us)
[349.264850] Starting subtest: wait-wedge-1us
[350.603695] Subtest wait-wedge-1us: SUCCESS (1.338s)
[350.748512] [027/133] (668s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[350.813437] Subtest untiled-to-tiled: SKIP (0.000s)
[350.880110] [028/133] (667s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[350.985571] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[350.989986] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[351.112203] [029/133] (667s left) kms_chamelium_hpd (common-hpd-after-suspend)
[351.513028] Subtest common-hpd-after-suspend: SKIP (0.000s)
[352.316003] [030/133] (666s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[352.416810] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[352.420958] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[352.533128] [031/133] (666s left) kms_async_flips (test-time-stamp)
[352.625648] Starting subtest: test-time-stamp
[352.996475] Starting dynamic subtest: pipe-A-eDP-1
[353.834638] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.835s)
[354.212324] Starting dynamic subtest: pipe-B-eDP-1
[354.955171] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.747s)
[355.329860] Starting dynamic subtest: pipe-C-eDP-1
[356.075714] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.751s)
[356.455587] Starting dynamic subtest: pipe-D-eDP-1
[357.215452] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.765s)
[357.217783] Subtest test-time-stamp: SUCCESS (4.590s)
[358.387384] [032/133] (660s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[358.489934] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[358.494068] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[358.588987] [033/133] (660s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[358.659448] Starting subtest: basic-batch-kernel-default-cmd
[358.664081] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[358.856808] [034/133] (660s left) sw_sync (sync_busy)
[358.896069] Starting subtest: sync_busy
[358.898203] Subtest sync_busy: SUCCESS (0.002s)
[358.951871] [035/133] (660s left) kms_getfb (getfb2-into-addfb2)
[359.038396] Starting subtest: getfb2-into-addfb2
[359.040573] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[359.153269] [036/133] (660s left) gem_create (create-invalid-size)
[359.210680] Starting subtest: create-invalid-size
[359.212652] Subtest create-invalid-size: SUCCESS (0.000s)
[359.402084] [037/133] (659s left) kms_color (degamma)
[359.507733] Starting subtest: degamma
[359.509639] Starting dynamic subtest: pipe-A-eDP-1
[360.228221] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s)
[360.238468] Starting dynamic subtest: pipe-B-eDP-1
[361.703923] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.475s)
[361.713648] Starting dynamic subtest: pipe-C-eDP-1
[363.058610] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.355s)
[363.069037] Starting dynamic subtest: pipe-D-eDP-1
[364.428601] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.366s)
[364.430836] Subtest degamma: SUCCESS (4.920s)
[365.292574] [038/133] (654s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[365.350241] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[365.403627] [039/133] (653s left) kms_draw_crc (draw-method-mmap-wc)
[365.506559] Starting subtest: draw-method-mmap-wc
[365.508495] Starting dynamic subtest: xrgb8888-untiled
[365.772236] Dynamic subtest xrgb8888-untiled: SUCCESS (0.266s)
[365.791735] Starting dynamic subtest: rgb565-untiled
[366.027352] Dynamic subtest rgb565-untiled: SUCCESS (0.253s)
[366.037493] Starting dynamic subtest: xrgb2101010-untiled
[366.249413] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.220s)
[366.260649] Starting dynamic subtest: xbgr16161616f-untiled
[366.482455] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[366.491752] Starting dynamic subtest: xrgb8888-xtiled
[366.604795] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[366.616270] Starting dynamic subtest: rgb565-xtiled
[366.738144] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[366.747621] Starting dynamic subtest: xrgb2101010-xtiled
[366.860471] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[366.872058] Starting dynamic subtest: xbgr16161616f-xtiled
[366.993723] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.130s)
[367.002675] Starting dynamic subtest: xrgb8888-4tiled
[367.160580] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.165s)
[367.170091] Starting dynamic subtest: rgb565-4tiled
[367.293941] Dynamic subtest rgb565-4tiled: SUCCESS (0.132s)
[367.304419] Starting dynamic subtest: xrgb2101010-4tiled
[367.438101] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[367.447651] Starting dynamic subtest: xbgr16161616f-4tiled
[367.604967] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s)
[367.607083] Subtest draw-method-mmap-wc: SUCCESS (2.100s)
[367.714049] [040/133] (651s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[367.763238] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[367.809446] [041/133] (651s left) prime_mmap (test_userptr)
[367.865080] Starting subtest: test_userptr
[367.867091] Starting dynamic subtest: test_userptr-smem
[367.868918] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[367.870763] Subtest test_userptr: SUCCESS (0.002s)
[367.972247] [042/133] (651s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[368.068347] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[368.071992] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[368.170672] [043/133] (651s left) kms_plane (pixel-format-linear-modifier)
[368.269985] Starting subtest: pixel-format-linear-modifier
[368.298740] Starting dynamic subtest: pipe-A-plane-0
[371.965308] Dynamic subtest pipe-A-plane-0: SUCCESS (3.667s)
[371.974507] Starting dynamic subtest: pipe-A-plane-3
[373.632096] Dynamic subtest pipe-A-plane-3: SUCCESS (1.665s)
[373.643355] Starting dynamic subtest: pipe-A-plane-5
[373.843114] Dynamic subtest pipe-A-plane-5: SUCCESS (0.209s)
[374.974857] Starting dynamic subtest: pipe-B-plane-0
[378.666152] Dynamic subtest pipe-B-plane-0: SUCCESS (3.700s)
[378.677746] Starting dynamic subtest: pipe-B-plane-3
[380.543988] Dynamic subtest pipe-B-plane-3: SUCCESS (1.877s)
[380.553054] Starting dynamic subtest: pipe-B-plane-5
[380.777261] Dynamic subtest pipe-B-plane-5: SUCCESS (0.233s)
[381.090255] Subtest pixel-format-linear-modifier: SUCCESS (12.819s)
[381.952090] [044/133] (637s left) i915_suspend (forcewake)
[382.007608] Starting subtest: forcewake
[414.190228] Subtest forcewake: SUCCESS (2.258s)
[414.268722] [045/133] (605s left) kms_psr (pr-basic)
[414.363317] Starting subtest: pr-basic
[414.368664] Subtest pr-basic: SKIP (0.000s)
[414.446179] [046/133] (605s left) kms_addfb_basic (small-bo)
[414.555312] Starting subtest: small-bo
[414.557785] Subtest small-bo: SUCCESS (0.000s)
[414.638028] [047/133] (605s left) prime_busy (after-wait)
[414.700567] Starting subtest: after-wait
[414.706809] Starting dynamic subtest: rcs0
[414.739731] Dynamic subtest rcs0: SUCCESS (0.037s)
[414.750031] Starting dynamic subtest: bcs0
[414.780428] Dynamic subtest bcs0: SUCCESS (0.041s)
[414.790245] Starting dynamic subtest: vcs0
[414.822214] Dynamic subtest vcs0: SUCCESS (0.042s)
[414.832057] Starting dynamic subtest: vcs1
[414.865658] Dynamic subtest vcs1: SUCCESS (0.044s)
[414.878074] Starting dynamic subtest: vecs0
[414.909597] Dynamic subtest vecs0: SUCCESS (0.042s)
[414.924378] Starting dynamic subtest: ccs0
[414.951487] Dynamic subtest ccs0: SUCCESS (0.041s)
[415.059241] Subtest after-wait: SUCCESS (0.368s)
[415.134724] [048/133] (604s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[415.236799] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[415.242500] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[415.320914] [049/133] (604s left) kms_psr2_su (page_flip-xrgb8888)
[415.379568] Subtest page_flip-XRGB8888: SKIP (0.000s)
[415.448099] [050/133] (604s left) gem_render_copy_redux (normal)
[415.508300] Starting subtest: normal
[415.814540] Subtest normal: SUCCESS (0.314s)
[415.930603] [051/133] (603s left) gem_exec_params (invalid-flag)
[415.990929] Starting subtest: invalid-flag
[415.993606] Subtest invalid-flag: SUCCESS (0.000s)
[416.090969] [052/133] (603s left) i915_module_load (resize-bar)
[416.121329] Starting subtest: resize-bar
[416.131246] Subtest resize-bar: SKIP (0.006s)
[416.174761] [053/133] (603s left) dumb_buffer (map-invalid-size)
[416.238015] Starting subtest: map-invalid-size
[416.239889] Subtest map-invalid-size: SUCCESS (0.000s)
[416.345456] [054/133] (603s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[416.436373] Starting subtest: fbc-psr-sprite-mmap-gtt
[416.438451] Starting dynamic subtest: eDP-1
[416.442422] Dynamic subtest eDP-1: SKIP (0.000s)
[416.446461] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[416.508382] [055/133] (603s left) kms_chamelium_edid (dp-edid-resolution-list)
[416.898695] Subtest dp-edid-resolution-list: SKIP (0.000s)
[417.669146] [056/133] (602s left) gem_mmap_wc (write-prefaulted)
[417.726384] Subtest write-prefaulted: SKIP (0.000s)
[417.783570] [057/133] (602s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[417.871944] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[417.874207] Starting dynamic subtest: pipe-A-eDP-1
[417.896983] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[417.906769] Starting dynamic subtest: pipe-B-eDP-1
[417.930147] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[417.939090] Starting dynamic subtest: pipe-C-eDP-1
[417.961275] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[417.969968] Starting dynamic subtest: pipe-D-eDP-1
[417.992613] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[417.996563] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s)
[420.111568] [058/133] (600s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[420.227498] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[424.462231] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.290s)
[425.662226] [059/133] (594s left) vgem_basic (bad-pad)
[425.703649] Starting subtest: bad-pad
[425.706060] Subtest bad-pad: SUCCESS (0.000s)
[425.762158] [060/133] (594s left) kms_pm_rpm (cursor-dpms)
[427.596688] Starting subtest: cursor-dpms
[427.602406] Subtest cursor-dpms: SKIP (0.000s)
[428.082601] [061/133] (592s left) gem_ccs (large-ctrl-surf-copy)
[428.147531] Starting subtest: large-ctrl-surf-copy
[428.152780] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[428.245960] [062/133] (592s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[428.344408] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[435.019983] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.702s)
[435.130590] [063/133] (585s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[435.236691] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[435.239390] Starting dynamic subtest: pipe-A-eDP-1
[435.330939] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[435.341553] Starting dynamic subtest: pipe-B-eDP-1
[436.443896] Dynamic subtest pipe-B-eDP-1: SKIP (1.112s)
[436.449436] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.215s)
[437.635229] [064/133] (582s left) syncobj_timeline (host-signal-ordered)
[437.701092] Starting subtest: host-signal-ordered
[437.704061] Subtest host-signal-ordered: SUCCESS (0.001s)
[437.803872] [065/133] (582s left) gem_exec_store (basic)
[437.863609] Starting subtest: basic
[437.957092] Subtest basic: SUCCESS (0.098s)
[438.147336] [066/133] (582s left) gem_ctx_param (get-priority-new-ctx)
[438.204638] Starting subtest: get-priority-new-ctx
[438.207619] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[438.307271] [067/133] (582s left) gem_ctx_shared (exec-single-timeline)
[438.377407] Starting subtest: exec-single-timeline
[438.380247] Starting dynamic subtest: rcs0
[439.423051] Dynamic subtest rcs0: SUCCESS (1.046s)
[439.435148] Starting dynamic subtest: bcs0
[440.508765] Dynamic subtest bcs0: SUCCESS (1.084s)
[440.522793] Starting dynamic subtest: vcs0
[441.596660] Dynamic subtest vcs0: SUCCESS (1.087s)
[441.614298] Starting dynamic subtest: vcs1
[442.684397] Dynamic subtest vcs1: SUCCESS (1.086s)
[442.697401] Starting dynamic subtest: vecs0
[443.771962] Dynamic subtest vecs0: SUCCESS (1.086s)
[443.784765] Starting dynamic subtest: ccs0
[444.860599] Dynamic subtest ccs0: SUCCESS (1.086s)
[444.863780] Subtest exec-single-timeline: SUCCESS (6.490s)
[445.054213] [068/133] (575s left) kms_content_protection (suspend-resume)
[445.228798] Starting subtest: suspend-resume
[445.233781] Subtest suspend-resume: SKIP (0.000s)
[445.360128] [069/133] (575s left) drm_read (empty-block)
[445.528486] Starting subtest: empty-block
[446.528914] Subtest empty-block: SUCCESS (0.999s)
[446.678212] [070/133] (574s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[446.825460] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[446.830726] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[446.899301] [071/133] (573s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[446.966919] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[447.039049] [072/133] (573s left) gem_exec_schedule (u-submit-early-slice)
[447.111680] Starting subtest: u-submit-early-slice
[447.114043] Starting dynamic subtest: rcs0
[447.149408] Dynamic subtest rcs0: SUCCESS (0.047s)
[447.161002] Starting dynamic subtest: bcs0
[447.193148] Dynamic subtest bcs0: SUCCESS (0.043s)
[447.209764] Starting dynamic subtest: vcs0
[447.237504] Dynamic subtest vcs0: SUCCESS (0.043s)
[447.249366] Starting dynamic subtest: vcs1
[447.281962] Dynamic subtest vcs1: SUCCESS (0.044s)
[447.293294] Starting dynamic subtest: vecs0
[447.322462] Dynamic subtest vecs0: SUCCESS (0.040s)
[447.332372] Starting dynamic subtest: ccs0
[447.369193] Dynamic subtest ccs0: SUCCESS (0.045s)
[447.371371] Subtest u-submit-early-slice: SUCCESS (0.268s)
[448.525337] [073/133] (572s left) gem_mmap_wc (write-read)
[448.594274] Subtest write-read: SKIP (0.000s)
[448.669284] [074/133] (572s left) gem_exec_fence (syncobj-invalid-flags)
[449.143149] Starting subtest: syncobj-invalid-flags
[449.146281] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[450.474803] [075/133] (570s left) gem_userptr_blits (relocations)
[450.595756] Starting subtest: relocations
[450.600768] Subtest relocations: SKIP (0.000s)
[450.723585] [076/133] (570s left) perf_pmu (busy-start)
[450.768819] Starting subtest: busy-start
[450.772073] Starting dynamic subtest: rcs0
[453.325573] Dynamic subtest rcs0: SUCCESS (2.557s)
[453.336805] Starting dynamic subtest: bcs0
[455.875047] Dynamic subtest bcs0: SUCCESS (2.546s)
[455.886658] Starting dynamic subtest: vcs0
[459.423298] Dynamic subtest vcs0: SUCCESS (3.544s)
[459.434917] Starting dynamic subtest: vcs1
[463.455760] Dynamic subtest vcs1: SUCCESS (4.029s)
[463.468894] Starting dynamic subtest: vecs0
[467.423523] Dynamic subtest vecs0: SUCCESS (3.965s)
[467.436938] Starting dynamic subtest: ccs0
[469.975274] Dynamic subtest ccs0: SUCCESS (2.550s)
[469.978404] Subtest busy-start: SUCCESS (19.208s)
[470.093428] [077/133] (550s left) i915_drm_fdinfo (memory-info-idle)
[470.151128] Starting subtest: memory-info-idle
[470.154053] Starting dynamic subtest: smem0
[470.218311] Dynamic subtest smem0: SUCCESS (0.066s)
[470.221404] Subtest memory-info-idle: SUCCESS (0.068s)
[470.316880] [078/133] (550s left) gem_exec_balancer (hog)
[470.378763] Starting subtest: hog
[470.384389] Subtest hog: SKIP (0.000s)
[470.687940] [079/133] (550s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[470.789432] Starting subtest: y-tiled-64bpp-rotate-0
[470.794673] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[470.894848] [080/133] (550s left) gem_exec_basic (basic)
[470.951418] Starting subtest: basic
[470.954114] Starting dynamic subtest: rcs0-smem
[470.956759] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[470.968375] Starting dynamic subtest: bcs0-smem
[470.971047] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[470.981043] Starting dynamic subtest: vcs0-smem
[470.983330] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[470.992992] Starting dynamic subtest: vcs1-smem
[470.995244] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[471.004794] Starting dynamic subtest: vecs0-smem
[471.007191] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[471.016471] Starting dynamic subtest: ccs0-smem
[471.018698] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[471.021139] Subtest basic: SUCCESS (0.019s)
[472.471580] [081/133] (548s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[472.530776] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[472.635356] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[472.733576] [082/133] (548s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[472.794589] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[472.797578] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[472.901135] [083/133] (548s left) gem_ctx_persistence (file)
[472.976531] Starting subtest: file
[473.094771] Subtest file: SUCCESS (0.119s)
[473.210309] [084/133] (548s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[473.339154] Starting subtest: cursorB-vs-flipB-legacy
[473.344096] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[473.485751] [085/133] (547s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[473.580500] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[473.583041] Starting dynamic subtest: pipe-A
[473.602340] Dynamic subtest pipe-A: SKIP (0.017s)
[473.612606] Starting dynamic subtest: pipe-B
[473.631752] Dynamic subtest pipe-B: SKIP (0.029s)
[473.641697] Starting dynamic subtest: pipe-C
[473.661061] Dynamic subtest pipe-C: SKIP (0.029s)
[473.670693] Starting dynamic subtest: pipe-D
[473.688751] Dynamic subtest pipe-D: SKIP (0.029s)
[473.692744] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.107s)
[473.781182] [086/133] (547s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[473.872528] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[482.553747] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.686s)
[482.669171] [087/133] (538s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[482.736980] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[482.843802] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s)
[482.949295] [088/133] (538s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[483.068634] Starting subtest: modeset-atomic-cursor-hotspot
[483.074633] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[483.225630] [089/133] (538s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[483.338617] Starting subtest: basic-busy-flip-before-cursor-legacy
[483.343992] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[483.501783] [090/133] (538s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[483.603050] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[483.608599] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[483.708998] [091/133] (537s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[483.800608] Starting subtest: x-tiled-8bpp-rotate-270
[483.823374] Subtest x-tiled-8bpp-rotate-270: SKIP (0.022s)
[483.932422] [092/133] (537s left) syncobj_wait (wait-for-submit-snapshot)
[484.004675] Starting subtest: wait-for-submit-snapshot
[484.087224] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[484.165607] [093/133] (537s left) gem_mmap_gtt (basic-wc)
[484.228423] Subtest basic-wc: SKIP (0.000s)
[484.323079] [094/133] (537s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[484.436352] Starting subtest: 2x-flip-vs-rmfb-interruptible
[484.448275] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.011s)
[484.527486] [095/133] (537s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[484.617556] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[484.622117] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[484.700980] [096/133] (537s left) gen9_exec_parse (bb-oversize)
[484.745541] Subtest bb-oversize: SKIP (0.000s)
[484.815917] [097/133] (537s left) gem_mmap_offset (bad-extensions)
[484.872656] Starting subtest: bad-extensions
[484.875284] Subtest bad-extensions: SUCCESS (0.000s)
[484.971213] [098/133] (537s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[485.061541] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[485.065415] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[485.155661] [099/133] (536s left) kms_cursor_crc (cursor-offscreen-256x85)
[485.411148] Starting subtest: cursor-offscreen-256x85
[485.456048] Subtest cursor-offscreen-256x85: SKIP (0.042s)
[485.614134] [100/133] (536s left) i915_pm_rpm (gem-idle)
[487.647770] Starting subtest: gem-idle
[493.853675] Subtest gem-idle: SUCCESS (6.211s)
[494.192696] [101/133] (527s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[495.365068] Starting subtest: single-wait-all-for-submit-signaled
[495.367541] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[495.482325] [102/133] (526s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[495.599765] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[495.604803] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[495.725856] [103/133] (526s left) gem_pxp (verify-pxp-stale-ctx-execution)
[495.857345] Starting subtest: verify-pxp-stale-ctx-execution
[496.924070] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.065s)
[497.039103] [104/133] (525s left) gem_wait (write-wait)
[497.106549] Starting subtest: write-wait
[497.109018] Starting dynamic subtest: all-engines
[498.225997] Dynamic subtest all-engines: SUCCESS (1.122s)
[498.244960] Starting dynamic subtest: rcs0
[499.288889] Dynamic subtest rcs0: SUCCESS (1.061s)
[499.306587] Starting dynamic subtest: bcs0
[500.350798] Dynamic subtest bcs0: SUCCESS (1.060s)
[500.368941] Starting dynamic subtest: vcs0
[501.409622] Dynamic subtest vcs0: SUCCESS (1.057s)
[501.434567] Starting dynamic subtest: vcs1
[502.485454] Dynamic subtest vcs1: SUCCESS (1.073s)
[502.502756] Starting dynamic subtest: vecs0
[503.543675] Dynamic subtest vecs0: SUCCESS (1.057s)
[503.561465] Starting dynamic subtest: ccs0
[504.605814] Dynamic subtest ccs0: SUCCESS (1.060s)
[504.608760] Subtest write-wait: SUCCESS (7.506s)
[504.807176] [105/133] (517s left) gem_exec_gttfill (engines)
[504.874562] Starting subtest: engines
[504.877337] Starting dynamic subtest: rcs0
[528.374877] Dynamic subtest rcs0: SUCCESS (23.490s)
[528.385540] Starting dynamic subtest: bcs0
[551.645126] Dynamic subtest bcs0: SUCCESS (23.264s)
[551.655345] Starting dynamic subtest: vcs0
[574.951740] Dynamic subtest vcs0: SUCCESS (23.303s)
[574.964769] Starting dynamic subtest: vcs1
[598.265081] Dynamic subtest vcs1: SUCCESS (23.313s)
[598.278174] Starting dynamic subtest: vecs0
[621.505798] Dynamic subtest vecs0: SUCCESS (23.242s)
[621.519010] Starting dynamic subtest: ccs0
[644.803509] Dynamic subtest ccs0: SUCCESS (23.296s)
[644.806687] Subtest engines: SUCCESS (139.925s)
[645.014962] [106/133] (377s left) perf_pmu (busy-double-start)
[645.094240] Starting subtest: busy-double-start
[645.096666] Starting dynamic subtest: rcs0
[648.759782] Dynamic subtest rcs0: FAIL (3.595s)
[648.771207] Starting dynamic subtest: bcs0
[652.257976] Dynamic subtest bcs0: SUCCESS (3.566s)
[652.270672] Starting dynamic subtest: vcs0
[655.967024] Dynamic subtest vcs0: SUCCESS (3.706s)
[655.979138] Starting dynamic subtest: vcs1
[659.961270] Dynamic subtest vcs1: SUCCESS (3.991s)
[659.974763] Starting dynamic subtest: vecs0
[663.968976] Dynamic subtest vecs0: SUCCESS (4.005s)
[663.981743] Starting dynamic subtest: ccs0
[667.623221] Dynamic subtest ccs0: FAIL (3.565s)
[667.625662] Subtest busy-double-start: FAIL (22.438s)
[667.673606] [107/133] (354s left) syncobj_timeline (multi-wait-all-signaled)
[667.742771] Starting subtest: multi-wait-all-signaled
[667.745769] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[667.846677] [108/133] (354s left) api_intel_bb (add-remove-objects)
[667.901782] Starting subtest: add-remove-objects
[667.912311] Subtest add-remove-objects: SUCCESS (0.013s)
[668.036458] [109/133] (354s left) kms_pm_rpm (pm-caching)
[669.612765] Starting subtest: pm-caching
[669.617916] Subtest pm-caching: SKIP (0.000s)
[670.339674] [110/133] (352s left) kms_flip (bo-too-big-interruptible)
[670.432441] Starting subtest: bo-too-big-interruptible
[670.434504] Starting dynamic subtest: A-eDP1
[671.772766] Dynamic subtest A-eDP1: SUCCESS (1.341s)
[671.786595] Starting dynamic subtest: B-eDP1
[673.015966] Dynamic subtest B-eDP1: SUCCESS (1.240s)
[673.028588] Starting dynamic subtest: C-eDP1
[674.273317] Dynamic subtest C-eDP1: SUCCESS (1.254s)
[674.285775] Starting dynamic subtest: D-eDP1
[675.511942] Dynamic subtest D-eDP1: SUCCESS (1.236s)
[675.514794] Subtest bo-too-big-interruptible: SUCCESS (5.083s)
[676.723498] [111/133] (345s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[676.812461] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[676.817767] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[677.954160] [112/133] (344s left) kms_cursor_edge_walk (64x64-right-edge)
[678.045610] Starting subtest: 64x64-right-edge
[678.048306] Starting dynamic subtest: pipe-A-eDP-1
[681.511036] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.466s)
[681.521770] Starting dynamic subtest: pipe-D-eDP-1
[684.646591] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.133s)
[684.649442] Subtest 64x64-right-edge: SUCCESS (6.603s)
[685.451276] [113/133] (337s left) syncobj_timeline (invalid-signal-illegal-handle)
[685.516695] Starting subtest: invalid-signal-illegal-handle
[685.519227] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[685.608300] [114/133] (337s left) kms_pm_backlight (bad-brightness)
[685.704534] Starting subtest: bad-brightness
[685.755395] Starting dynamic subtest: eDP-1
[686.063549] Dynamic subtest eDP-1: SUCCESS (0.306s)
[686.066655] Subtest bad-brightness: SUCCESS (0.360s)
[686.871456] [115/133] (335s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[686.970553] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[686.975360] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[687.072538] [116/133] (335s left) i915_query (query-topology-matches-eu-total)
[687.129004] Starting subtest: query-topology-matches-eu-total
[687.131611] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[687.214042] [117/133] (335s left) gem_eio (in-flight-suspend)
[687.422769] Starting subtest: in-flight-suspend
[731.448416] Subtest in-flight-suspend: SUCCESS (14.007s)
[731.591075] [118/133] (291s left) kms_lease (lease-revoke)
[731.688625] Starting subtest: lease-revoke
[731.690828] Starting dynamic subtest: pipe-A-eDP-1
[731.722925] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.033s)
[731.734081] Starting dynamic subtest: pipe-B-eDP-1
[731.751870] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.028s)
[731.762404] Starting dynamic subtest: pipe-C-eDP-1
[731.780838] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.029s)
[731.791241] Starting dynamic subtest: pipe-D-eDP-1
[731.805685] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s)
[731.807954] Subtest lease-revoke: SUCCESS (0.122s)
[731.926736] [119/133] (291s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[732.019823] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[739.315202] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.443s)
[739.430471] [120/133] (283s left) kms_addfb_basic (bad-pitch-256)
[739.494070] Starting subtest: bad-pitch-256
[739.496217] Subtest bad-pitch-256: SUCCESS (0.000s)
[739.636752] [121/133] (283s left) api_intel_bb (full-batch)
[739.695313] Starting subtest: full-batch
[739.699997] Subtest full-batch: SUCCESS (0.006s)
[739.815778] [122/133] (283s left) kms_psr (fbc-pr-sprite-plane-onoff)
[739.904936] Starting subtest: fbc-pr-sprite-plane-onoff
[739.908877] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[739.990490] [123/133] (283s left) gem_ctx_isolation (preservation)
[740.058556] Starting subtest: preservation
[740.060522] Starting dynamic subtest: rcs0
[740.182618] Dynamic subtest rcs0: SUCCESS (0.128s)
[740.197830] Starting dynamic subtest: bcs0
[740.336609] Dynamic subtest bcs0: SUCCESS (0.155s)
[740.349339] Starting dynamic subtest: vcs0
[740.475495] Dynamic subtest vcs0: SUCCESS (0.139s)
[740.489633] Starting dynamic subtest: vcs1
[741.580136] Dynamic subtest vcs1: SUCCESS (1.114s)
[741.593334] Starting dynamic subtest: vecs0
[743.579634] Dynamic subtest vecs0: SUCCESS (2.014s)
[743.590052] Starting dynamic subtest: ccs0
[745.581504] Dynamic subtest ccs0: SUCCESS (2.012s)
[745.584042] Subtest preservation: SUCCESS (5.569s)
[745.807483] [124/133] (277s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[745.933893] Starting subtest: yf-tiled-16bpp-rotate-180
[745.938588] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[746.027401] [125/133] (277s left) kms_async_flips (async-flip-dpms)
[746.123071] Starting subtest: async-flip-dpms
[746.508955] Starting dynamic subtest: pipe-A-eDP-1
[750.368980] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.873s)
[750.750477] Starting dynamic subtest: pipe-B-eDP-1
[753.532673] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.798s)
[753.899206] Starting dynamic subtest: pipe-C-eDP-1
[756.689011] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.802s)
[757.062822] Starting dynamic subtest: pipe-D-eDP-1
[759.849478] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.798s)
[759.851903] Subtest async-flip-dpms: SUCCESS (13.764s)
[761.019584] [126/133] (262s left) kms_busy (basic-hang)
[761.120984] Starting subtest: basic-hang
[761.123289] Starting dynamic subtest: flip-pipe-A
[761.723322] Dynamic subtest flip-pipe-A: SUCCESS (0.602s)
[761.733930] Starting dynamic subtest: modeset-pipe-A
[765.163386] Dynamic subtest modeset-pipe-A: SUCCESS (3.440s)
[765.174508] Starting dynamic subtest: flip-pipe-D
[766.369240] Dynamic subtest flip-pipe-D: SUCCESS (1.205s)
[766.379924] Starting dynamic subtest: modeset-pipe-D
[769.803819] Dynamic subtest modeset-pipe-D: SUCCESS (3.432s)
[769.806233] Subtest basic-hang: SUCCESS (8.685s)
[770.606702] [127/133] (252s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[770.710092] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[777.287891] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.583s)
[777.403599] [128/133] (245s left) kms_big_fb (linear-8bpp-rotate-90)
[777.504493] Starting subtest: linear-8bpp-rotate-90
[777.529053] Subtest linear-8bpp-rotate-90: SKIP (0.022s)
[777.645068] [129/133] (245s left) kms_plane_multiple (2x-tiling-y)
[777.744278] Starting subtest: 2x-tiling-y
[777.748638] Subtest 2x-tiling-y: SKIP (0.000s)
[777.820792] [130/133] (245s left) kms_getfb (getfb-repeated-different-handles)
[777.914203] Starting subtest: getfb-repeated-different-handles
[777.916505] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[778.016798] [131/133] (245s left) syncobj_wait (multi-wait-all-submitted)
[778.064370] Starting subtest: multi-wait-all-submitted
[778.167399] Subtest multi-wait-all-submitted: SUCCESS (0.102s)
[778.246366] [132/133] (245s left) kms_properties (crtc-properties-legacy)
[778.345196] Starting subtest: crtc-properties-legacy
[778.347132] Starting dynamic subtest: pipe-A-eDP-1
[778.780526] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.435s)
[778.792387] Starting dynamic subtest: pipe-B-eDP-1
[779.958636] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.176s)
[779.969761] Starting dynamic subtest: pipe-C-eDP-1
[781.087551] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.129s)
[781.098669] Starting dynamic subtest: pipe-D-eDP-1
[782.209470] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.119s)
[782.211673] Subtest crtc-properties-legacy: SUCCESS (3.865s)
[783.017352] [133/133] (240s left) gem_exec_reloc (basic-gtt-cpu-active)
[783.090736] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[783.164820] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_color
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: kms_flip
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: tools_test
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: gem_busy
results: parsing output: 8/ for test: gem_busy
results: parsing output: 9/ for test: kms_selftest
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: sw_sync
results: parsing output: 12/ for test: gem_render_copy
results: parsing output: 13/ for test: gem_ppgtt
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: gem_fence_thrash
results: parsing output: 17/ for test: syncobj_wait
results: parsing output: 18/ for test: kms_pipe_stress
results: parsing output: 19/ for test: kms_vblank
results: parsing output: 20/ for test: kms_joiner
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: gem_eio
results: parsing output: 26/ for test: gem_set_tiling_vs_blt
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_chamelium_hpd
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_async_flips
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_flush
results: parsing output: 33/ for test: sw_sync
results: parsing output: 34/ for test: kms_getfb
results: parsing output: 35/ for test: gem_create
results: parsing output: 36/ for test: kms_color
results: parsing output: 37/ for test: kms_pipe_b_c_ivb
results: parsing output: 38/ for test: kms_draw_crc
results: parsing output: 39/ for test: gem_lmem_swapping
results: parsing output: 40/ for test: prime_mmap
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_plane
results: parsing output: 43/ for test: i915_suspend
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_addfb_basic
results: parsing output: 46/ for test: prime_busy
results: parsing output: 47/ for test: kms_flip_scaled_crc
results: parsing output: 48/ for test: kms_psr2_su
results: parsing output: 49/ for test: gem_render_copy_redux
results: parsing output: 50/ for test: gem_exec_params
results: parsing output: 51/ for test: i915_module_load
results: parsing output: 52/ for test: dumb_buffer
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: kms_chamelium_edid
results: parsing output: 55/ for test: gem_mmap_wc
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: vgem_basic
results: parsing output: 59/ for test: kms_pm_rpm
results: parsing output: 60/ for test: gem_ccs
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_psr2_sf
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: gem_exec_store
results: parsing output: 65/ for test: gem_ctx_param
results: parsing output: 66/ for test: gem_ctx_shared
results: parsing output: 67/ for test: kms_content_protection
results: parsing output: 68/ for test: drm_read
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: gem_mmap_gtt
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: gem_mmap_wc
results: parsing output: 73/ for test: gem_exec_fence
results: parsing output: 74/ for test: gem_userptr_blits
results: parsing output: 75/ for test: perf_pmu
results: parsing output: 76/ for test: i915_drm_fdinfo
results: parsing output: 77/ for test: gem_exec_balancer
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: gem_exec_basic
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: gem_ctx_persistence
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: kms_plane_scaling
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: kms_cursor_legacy
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: gem_mmap_gtt
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gen9_exec_parse
results: parsing output: 96/ for test: gem_mmap_offset
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: i915_pm_rpm
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_pxp
results: parsing output: 103/ for test: gem_wait
results: parsing output: 104/ for test: gem_exec_gttfill
results: parsing output: 105/ for test: perf_pmu
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: api_intel_bb
results: parsing output: 108/ for test: kms_pm_rpm
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: kms_cursor_edge_walk
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_pm_backlight
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: i915_query
results: parsing output: 116/ for test: gem_eio
results: parsing output: 117/ for test: kms_lease
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_addfb_basic
results: parsing output: 120/ for test: api_intel_bb
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: gem_ctx_isolation
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_async_flips
results: parsing output: 125/ for test: kms_busy
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_plane_multiple
results: parsing output: 129/ for test: kms_getfb
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: kms_properties
results: parsing output: 132/ for test: gem_exec_reloc
Done.