[57.309725] Initializing watchdogs
[57.309770]   /dev/watchdog0
[57.324462] [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.328605] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.330757] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.334092] [001/132] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[57.457449] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[57.461836] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[57.568707] [002/132] (960s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[57.639579] Starting subtest: stress-mm-invalidate-close-overlap
[59.760109] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[59.887228] [003/132] (958s left) kms_psr (psr-basic)
[59.982601] Starting subtest: psr-basic
[59.984911] Starting dynamic subtest: eDP-1
[61.565600] Dynamic subtest eDP-1: SUCCESS (1.598s)
[61.567802] Subtest psr-basic: SUCCESS (1.599s)
[62.429174] [004/132] (955s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[62.532598] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[62.537077] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[62.639285] [005/132] (955s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[62.728725] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[62.733127] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[62.822186] [006/132] (955s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[62.914146] Starting subtest: flip-primary-invalidate-overlay
[74.504052] Subtest flip-primary-invalidate-overlay: SUCCESS (11.633s)
[74.656621] [007/132] (943s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[74.744459] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[82.356658] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.622s)
[82.488967] [008/132] (935s left) i915_drm_fdinfo (busy)
[82.531835] Starting subtest: busy
[82.534062] Starting dynamic subtest: rcs0
[82.561590] Dynamic subtest rcs0: SKIP (0.029s)
[82.569177] Starting dynamic subtest: bcs0
[82.573324] Dynamic subtest bcs0: SKIP (0.000s)
[82.580874] Starting dynamic subtest: vcs0
[82.584786] Dynamic subtest vcs0: SKIP (0.000s)
[82.591986] Starting dynamic subtest: vcs1
[82.596169] Dynamic subtest vcs1: SKIP (0.000s)
[82.604035] Starting dynamic subtest: vecs0
[82.608290] Dynamic subtest vecs0: SKIP (0.000s)
[82.615694] Starting dynamic subtest: ccs0
[82.620066] Dynamic subtest ccs0: SKIP (0.000s)
[82.624365] Subtest busy: SKIP (0.032s)
[82.657292] [009/132] (935s left) kms_vblank (wait-busy-hang)
[82.766514] Starting subtest: wait-busy-hang
[82.768492] Starting dynamic subtest: pipe-A-eDP-1
[109.054654] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.285s)
[109.068972] Starting dynamic subtest: pipe-D-eDP-1
[134.072557] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.015s)
[134.074705] Subtest wait-busy-hang: SUCCESS (51.304s)
[134.878872] [010/132] (883s left) syncobj_basic (bad-pad-fd-to-handle)
[134.937943] Starting subtest: bad-pad-fd-to-handle
[134.940431] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[135.029130] [011/132] (883s left) i915_pm_rpm (system-suspend)
[136.582688] Starting subtest: system-suspend
[155.056458] Subtest system-suspend: SUCCESS (3.012s)
[155.427874] [012/132] (862s left) sw_sync (sync_multi_timeline_wait)
[155.475163] Starting subtest: sync_multi_timeline_wait
[155.477021] Subtest sync_multi_timeline_wait: SUCCESS (0.001s)
[155.529624] [013/132] (862s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[155.629091] Starting subtest: fbc-psr2-primary-mmap-gtt
[155.631398] Starting dynamic subtest: eDP-1
[155.635752] Dynamic subtest eDP-1: SKIP (0.000s)
[155.640150] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.000s)
[155.697417] [014/132] (862s left) gem_exec_balancer (parallel-ordering)
[155.951451] Starting subtest: parallel-ordering
[156.987044] Subtest parallel-ordering: SUCCESS (1.060s)
[157.115816] [015/132] (861s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[157.202135] Starting subtest: stress-xrgb8888-xtiled
[163.001516] Subtest stress-xrgb8888-xtiled: SUCCESS (5.891s)
[163.047885] [016/132] (855s left) kms_dsc (dsc-with-formats)
[163.134969] Starting subtest: dsc-with-formats
[163.173345] Subtest dsc-with-formats: SKIP (0.001s)
[163.213637] [017/132] (855s left) kms_joiner (invalid-modeset-ultra-joiner)
[163.309062] Starting subtest: invalid-modeset-ultra-joiner
[163.312978] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[163.372120] [018/132] (855s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[163.470644] Starting subtest: psr2-cursor-plane-move-continuous-sf
[163.472890] Starting dynamic subtest: pipe-A-eDP-1
[173.778553] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.370s)
[173.789100] Starting dynamic subtest: pipe-B-eDP-1
[184.885811] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.125s)
[184.888075] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.497s)
[185.679764] [019/132] (832s left) kms_properties (colorop-properties-legacy)
[185.769048] Starting subtest: colorop-properties-legacy
[185.771224] Starting dynamic subtest: pipe-A-eDP-1
[186.137409] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.367s)
[186.146659] Starting dynamic subtest: pipe-B-eDP-1
[187.163113] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.024s)
[187.172326] Starting dynamic subtest: pipe-C-eDP-1
[188.209669] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.047s)
[188.222471] Starting dynamic subtest: pipe-D-eDP-1
[189.239946] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.028s)
[189.242322] Subtest colorop-properties-legacy: SUCCESS (3.470s)
[190.050061] [020/132] (828s left) prime_udl
[190.131509] [021/132] (828s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[190.228722] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[190.232856] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[190.325812] [022/132] (828s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[190.416403] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[190.420444] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[190.489475] [023/132] (828s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[190.588970] Starting subtest: x-tiled-64bpp-rotate-180
[192.156865] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.568s)
[192.320150] [024/132] (826s left) gem_mmap_wc (close)
[192.380908] Subtest close: SKIP (0.000s)
[192.439345] [025/132] (826s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[192.542170] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[199.295603] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.754s)
[199.429454] [026/132] (819s left) gem_create (create-massive)
[199.482119] Starting subtest: create-massive
[199.484495] Subtest create-massive: SUCCESS (0.000s)
[199.676388] [027/132] (819s left) kms_addfb_basic (no-handle)
[199.720216] Starting subtest: no-handle
[199.722047] Subtest no-handle: SUCCESS (0.000s)
[199.902485] [028/132] (818s left) gem_exec_reloc (basic-wc)
[199.976925] Subtest basic-wc: SKIP (0.000s)
[200.070832] [029/132] (818s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[200.183701] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[200.187593] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[200.249953] [030/132] (818s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[200.354405] Starting subtest: fbc-rgb101010-draw-render
[204.966806] Subtest fbc-rgb101010-draw-render: SUCCESS (4.616s)
[206.143759] [031/132] (812s left) intel_hwmon (hwmon-read)
[206.189922] Subtest hwmon-read: SKIP (0.000s)
[206.245684] [032/132] (812s left) gem_exec_reloc (basic-gtt-wc)
[206.314362] Subtest basic-gtt-wc: SKIP (0.000s)
[206.384639] [033/132] (812s left) gem_exec_flush (basic-wb-pro-default)
[206.440336] Starting subtest: basic-wb-pro-default
[211.890135] Subtest basic-wb-pro-default: SUCCESS (5.452s)
[212.071906] [034/132] (807s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[212.173264] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[212.199885] Starting dynamic subtest: pipe-A-plane-0
[212.812361] Dynamic subtest pipe-A-plane-0: SUCCESS (0.611s)
[212.823494] Starting dynamic subtest: pipe-A-plane-3
[213.243596] Dynamic subtest pipe-A-plane-3: SUCCESS (0.433s)
[214.327721] Starting dynamic subtest: pipe-B-plane-0
[214.964252] Dynamic subtest pipe-B-plane-0: SUCCESS (0.644s)
[214.976445] Starting dynamic subtest: pipe-B-plane-3
[215.374540] Dynamic subtest pipe-B-plane-3: SUCCESS (0.410s)
[215.698070] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.528s)
[216.495584] [035/132] (802s left) syncobj_timeline (reset-signaled)
[216.553795] Starting subtest: reset-signaled
[216.555708] Subtest reset-signaled: SUCCESS (0.000s)
[216.645417] [036/132] (802s left) gem_ctx_isolation (clean)
[216.701112] Starting subtest: clean
[216.703700] Starting dynamic subtest: rcs0
[216.750683] Dynamic subtest rcs0: SUCCESS (0.049s)
[216.760469] Starting dynamic subtest: bcs0
[216.828696] Dynamic subtest bcs0: SUCCESS (0.077s)
[216.837565] Starting dynamic subtest: vcs0
[216.886080] Dynamic subtest vcs0: SUCCESS (0.056s)
[216.894838] Starting dynamic subtest: vcs1
[218.754727] Dynamic subtest vcs1: SUCCESS (1.868s)
[218.766927] Starting dynamic subtest: vecs0
[220.817854] Dynamic subtest vecs0: SUCCESS (2.062s)
[220.828487] Starting dynamic subtest: ccs0
[222.770549] Dynamic subtest ccs0: SUCCESS (1.953s)
[222.772942] Subtest clean: SUCCESS (6.072s)
[222.989270] [037/132] (796s left) gem_exec_params (larger-than-life-batch)
[223.052885] Starting subtest: larger-than-life-batch
[225.321626] Subtest larger-than-life-batch: SUCCESS (2.271s)
[225.831940] [038/132] (793s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[225.992268] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[225.996416] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[226.092412] [039/132] (793s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[226.193761] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[232.948069] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.760s)
[233.057291] [040/132] (786s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[233.152733] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[233.154607] Starting dynamic subtest: pipe-A-eDP-1
[233.589481] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.437s)
[233.601339] Starting dynamic subtest: pipe-B-eDP-1
[233.620931] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[233.630415] Starting dynamic subtest: pipe-C-eDP-1
[233.647567] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s)
[233.656135] Starting dynamic subtest: pipe-D-eDP-1
[233.674526] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[233.676352] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.451s)
[235.887069] [041/132] (783s left) syncobj_wait (wait-all-snapshot)
[235.942636] Starting subtest: wait-all-snapshot
[236.024509] Subtest wait-all-snapshot: SUCCESS (0.081s)
[236.097043] [042/132] (783s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[236.202066] Starting subtest: yf-tiled-16bpp-rotate-0
[236.206602] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[236.291793] [043/132] (783s left) kms_lease (master-vs-lease)
[236.372549] Starting subtest: master-vs-lease
[236.374812] Subtest master-vs-lease: SUCCESS (0.002s)
[236.475249] [044/132] (783s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[236.537983] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[236.645925] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.108s)
[236.725260] [045/132] (782s left) gem_ctx_bad_destroy (double-destroy)
[236.793495] Starting subtest: double-destroy
[236.795889] Subtest double-destroy: SUCCESS (0.000s)
[236.870049] [046/132] (782s left) drm_read (empty-nonblock)
[237.015493] Starting subtest: empty-nonblock
[237.017796] Subtest empty-nonblock: SUCCESS (0.000s)
[237.143132] [047/132] (782s left) kms_busy (extended-pageflip-hang-newfb)
[237.237337] Starting subtest: extended-pageflip-hang-newfb
[237.239729] Starting dynamic subtest: pipe-A
[263.567521] Dynamic subtest pipe-A: SUCCESS (26.329s)
[263.579157] Starting dynamic subtest: pipe-D
[288.530374] Dynamic subtest pipe-D: SUCCESS (24.958s)
[288.532558] Subtest extended-pageflip-hang-newfb: SUCCESS (51.291s)
[289.360341] [048/132] (730s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[289.460180] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[289.464389] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[289.556197] [049/132] (730s left) gen9_exec_parse (basic-rejected)
[289.614608] Subtest basic-rejected: SKIP (0.000s)
[289.695291] [050/132] (730s left) kms_atomic_transition (plane-all-modeset-transition)
[289.780387] Starting subtest: plane-all-modeset-transition
[289.784866] Subtest plane-all-modeset-transition: SKIP (0.000s)
[289.866928] [051/132] (729s left) gem_mmap_gtt (fault-concurrent-x)
[289.923173] Subtest fault-concurrent-X: SKIP (0.000s)
[289.979317] [052/132] (729s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[290.076201] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[290.080433] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[290.170610] [053/132] (729s left) perf_pmu (busy-idle-no-semaphores)
[290.215512] Starting subtest: busy-idle-no-semaphores
[290.217839] Starting dynamic subtest: rcs0
[290.884745] Dynamic subtest rcs0: SUCCESS (0.671s)
[290.897644] Starting dynamic subtest: bcs0
[291.538906] Dynamic subtest bcs0: SUCCESS (0.651s)
[291.552606] Starting dynamic subtest: vcs0
[292.190825] Dynamic subtest vcs0: SUCCESS (0.650s)
[292.203172] Starting dynamic subtest: vcs1
[293.402856] Dynamic subtest vcs1: SUCCESS (1.209s)
[293.415156] Starting dynamic subtest: vecs0
[295.388471] Dynamic subtest vecs0: SUCCESS (1.983s)
[295.400626] Starting dynamic subtest: ccs0
[297.376729] Dynamic subtest ccs0: SUCCESS (1.986s)
[297.379550] Subtest busy-idle-no-semaphores: SUCCESS (7.166s)
[297.499838] [054/132] (722s left) kms_selftest (drm_damage_helper)
[297.548613] Starting subtest: drm_damage_helper
[297.589479] Starting dynamic subtest: drm_test_damage_iter_no_damage
[297.683167] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.094s)
[297.692898] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[297.777241] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.095s)
[297.789007] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[297.881537] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.100s)
[297.892040] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[297.971821] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.089s)
[297.984854] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[298.073409] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.101s)
[298.084113] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[298.199232] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.125s)
[298.208685] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[298.301284] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.100s)
[298.312982] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[298.404723] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.104s)
[298.415550] Starting dynamic subtest: drm_test_damage_iter_single_damage
[298.500836] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.095s)
[298.512099] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[298.598571] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.097s)
[298.609724] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[298.699831] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.101s)
[298.711193] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[298.800554] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.099s)
[298.811556] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[298.885518] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.085s)
[298.896734] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[298.995840] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.110s)
[299.006925] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[299.104183] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.107s)
[299.114319] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[299.199537] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.095s)
[299.210026] Starting dynamic subtest: drm_test_damage_iter_damage
[299.305061] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.106s)
[299.315637] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[299.401864] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.095s)
[299.413582] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[299.488081] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.087s)
[299.496958] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[299.592953] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.104s)
[299.603301] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[299.700708] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.106s)
[299.702356] Subtest drm_damage_helper: SUCCESS (2.154s)
[299.860463] [055/132] (720s left) gem_exec_params (rsvd2-dirt)
[299.919661] Starting subtest: rsvd2-dirt
[299.923906] Subtest rsvd2-dirt: SKIP (0.000s)
[300.016192] [056/132] (719s left) kms_addfb_basic (bad-pitch-256)
[300.072861] Starting subtest: bad-pitch-256
[300.074476] Subtest bad-pitch-256: SUCCESS (0.000s)
[300.214611] [057/132] (719s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[300.305036] Starting subtest: async-flip-with-page-flip-events-linear
[300.693507] Starting dynamic subtest: pipe-A-eDP-1
[303.428793] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.734s)
[303.796769] Starting dynamic subtest: pipe-B-eDP-1
[306.548284] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.758s)
[306.912336] Starting dynamic subtest: pipe-C-eDP-1
[309.672516] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.768s)
[310.039831] Starting dynamic subtest: pipe-D-eDP-1
[312.802328] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s)
[312.804973] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.500s)
[313.992407] [058/132] (706s left) gem_exec_whisper (basic-queues-priority)
[314.056999] Starting subtest: basic-queues-priority
[337.040643] Subtest basic-queues-priority: SUCCESS (22.983s)
[337.238120] [059/132] (682s left) gem_exec_schedule (preemptive-hang)
[337.428305] Starting subtest: preemptive-hang
[337.431033] Starting dynamic subtest: rcs0
[346.915348] Dynamic subtest rcs0: SUCCESS (9.488s)
[346.931130] Starting dynamic subtest: bcs0
[355.867915] Dynamic subtest bcs0: SUCCESS (8.953s)
[355.880495] Starting dynamic subtest: vcs0
[364.887577] Dynamic subtest vcs0: SUCCESS (9.022s)
[364.899392] Starting dynamic subtest: vcs1
[373.912245] Dynamic subtest vcs1: SUCCESS (9.027s)
[373.921831] Starting dynamic subtest: vecs0
[382.871838] Dynamic subtest vecs0: SUCCESS (8.954s)
[382.882532] Starting dynamic subtest: ccs0
[391.902343] Dynamic subtest ccs0: SUCCESS (9.025s)
[391.904588] Subtest preemptive-hang: SUCCESS (54.479s)
[392.138659] [060/132] (628s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[392.246685] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[392.250678] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[392.352855] [061/132] (627s left) gem_exec_schedule (preempt-self)
[392.423966] Starting subtest: preempt-self
[392.426278] Starting dynamic subtest: rcs0
[392.434292] Dynamic subtest rcs0: SUCCESS (0.019s)
[392.446234] Starting dynamic subtest: bcs0
[392.451709] Dynamic subtest bcs0: SUCCESS (0.017s)
[392.462327] Starting dynamic subtest: vcs0
[392.469189] Dynamic subtest vcs0: SUCCESS (0.017s)
[392.479737] Starting dynamic subtest: vcs1
[392.486683] Dynamic subtest vcs1: SUCCESS (0.017s)
[392.496472] Starting dynamic subtest: vecs0
[392.502289] Dynamic subtest vecs0: SUCCESS (0.015s)
[392.512144] Starting dynamic subtest: ccs0
[392.519771] Dynamic subtest ccs0: SUCCESS (0.017s)
[392.522161] Subtest preempt-self: SUCCESS (0.106s)
[393.878225] [062/132] (626s left) syncobj_timeline (multi-wait-all-available-submitted)
[393.938756] Starting subtest: multi-wait-all-available-submitted
[393.941095] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[394.056512] [063/132] (626s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[394.116724] Starting subtest: invalid-single-wait-all-unsubmitted
[394.118627] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[394.223342] [064/132] (626s left) gem_mmap_gtt (basic-write-read-distinct)
[394.271878] Subtest basic-write-read-distinct: SKIP (0.000s)
[394.341806] [065/132] (626s left) gem_exec_reloc (basic-write-gtt-active)
[394.395123] Subtest basic-write-gtt-active: SKIP (0.000s)
[394.490132] [066/132] (625s left) gem_exec_balancer (parallel-bb-first)
[394.747845] Starting subtest: parallel-bb-first
[395.874411] Subtest parallel-bb-first: SUCCESS (1.126s)
[396.772592] [067/132] (623s left) kms_pipe_crc_basic (bad-source)
[396.872265] Starting subtest: bad-source
[396.874502] Subtest bad-source: SUCCESS (0.000s)
[396.959240] [068/132] (623s left) kms_big_fb (linear-32bpp-rotate-90)
[397.070647] Starting subtest: linear-32bpp-rotate-90
[397.090443] Subtest linear-32bpp-rotate-90: SKIP (0.019s)
[397.202492] [069/132] (623s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[397.304853] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[397.309199] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[397.408611] [070/132] (623s left) kms_flip (2x-flip-vs-modeset)
[397.509593] Starting subtest: 2x-flip-vs-modeset
[397.520920] Subtest 2x-flip-vs-modeset: SKIP (0.013s)
[397.625876] [071/132] (622s left) gem_busy (semaphore)
[397.838109] Subtest semaphore: SKIP (0.000s)
[398.068569] [072/132] (622s left) kms_pm_dc (dc5-dpms)
[399.172366] Starting subtest: dc5-dpms
[401.243672] Subtest dc5-dpms: SUCCESS (2.070s)
[401.325206] [073/132] (619s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[401.433120] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[401.437715] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[401.525303] [074/132] (619s left) kms_frontbuffer_tracking (fbc-tiling-y)
[401.622046] Starting subtest: fbc-tiling-y
[401.626461] Subtest fbc-tiling-y: SKIP (0.000s)
[401.712866] [075/132] (619s left) i915_hangman (engine-error-state-capture)
[401.789315] Starting subtest: engine-error-state-capture
[401.791642] Starting dynamic subtest: rcs0
[405.711888] Dynamic subtest rcs0: SUCCESS (3.921s)
[405.724967] Starting dynamic subtest: bcs0
[411.728875] Dynamic subtest bcs0: SUCCESS (6.013s)
[411.745597] Starting dynamic subtest: vcs0
[417.682281] Dynamic subtest vcs0: SUCCESS (5.950s)
[417.698718] Starting dynamic subtest: vcs1
[422.674102] Dynamic subtest vcs1: SUCCESS (4.988s)
[422.693549] Starting dynamic subtest: vecs0
[427.664958] Dynamic subtest vecs0: SUCCESS (4.987s)
[427.680210] Starting dynamic subtest: ccs0
[433.744879] Dynamic subtest ccs0: SUCCESS (6.076s)
[433.747735] Subtest engine-error-state-capture: SUCCESS (31.952s)
[433.831790] [076/132] (587s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[433.884297] Subtest no-spare-fences-busy: SKIP (0.000s)
[433.950078] [077/132] (586s left) kms_psr (fbc-pr-basic)
[434.042857] Starting subtest: fbc-pr-basic
[434.047480] Subtest fbc-pr-basic: SKIP (0.000s)
[434.126697] [078/132] (586s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[434.359466] Starting subtest: cursor-rapid-movement-256x85
[434.405173] Subtest cursor-rapid-movement-256x85: SKIP (0.041s)
[434.562303] [079/132] (586s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[434.659015] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[434.663626] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[434.753971] [080/132] (586s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[434.846398] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[434.848299] Starting dynamic subtest: pipe-A-eDP-1
[434.867002] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[434.878568] Starting dynamic subtest: pipe-B-eDP-1
[434.895572] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[434.904959] Starting dynamic subtest: pipe-C-eDP-1
[434.921816] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[434.930741] Starting dynamic subtest: pipe-D-eDP-1
[434.948024] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[434.951235] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[437.177062] [081/132] (583s left) gem_softpin (allocator-nopin)
[437.241386] Starting subtest: allocator-nopin
[437.332589] Subtest allocator-nopin: SUCCESS (0.093s)
[437.469774] [082/132] (583s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[437.523574] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[437.630814] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.106s)
[437.706013] [083/132] (583s left) kms_cursor_crc (cursor-size-change)
[437.815506] Starting subtest: cursor-size-change
[437.817680] Starting dynamic subtest: pipe-A-eDP-1
[438.712160] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.893s)
[438.727030] Starting dynamic subtest: pipe-D-eDP-1
[440.211785] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.496s)
[440.213947] Subtest cursor-size-change: SUCCESS (2.394s)
[441.024996] [084/132] (580s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[441.414707] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[442.229401] [085/132] (578s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[442.338562] Starting subtest: plane-lut1d-ctm3x4
[442.473306] Starting dynamic subtest: pipe-A-plane-0
[442.673128] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[442.691292] Starting dynamic subtest: pipe-A-plane-1
[442.817864] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[442.828031] Starting dynamic subtest: pipe-A-plane-2
[442.951094] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[444.146502] Starting dynamic subtest: pipe-B-plane-0
[444.281458] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[444.292110] Starting dynamic subtest: pipe-B-plane-1
[444.415027] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[444.425839] Starting dynamic subtest: pipe-B-plane-2
[444.559431] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[445.783111] Starting dynamic subtest: pipe-C-plane-0
[445.907868] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[445.918298] Starting dynamic subtest: pipe-C-plane-1
[446.041217] Dynamic subtest pipe-C-plane-1: SUCCESS (0.132s)
[446.051823] Starting dynamic subtest: pipe-C-plane-2
[446.176057] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[447.410834] Starting dynamic subtest: pipe-D-plane-0
[447.546524] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[447.556949] Starting dynamic subtest: pipe-D-plane-1
[447.679689] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[447.691485] Starting dynamic subtest: pipe-D-plane-2
[447.846384] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[448.134134] Subtest plane-lut1d-ctm3x4: SUCCESS (5.796s)
[448.994656] [086/132] (572s left) gem_mmap_gtt (isolation)
[449.061800] Subtest isolation: SKIP (0.000s)
[449.120251] [087/132] (572s left) gem_exec_whisper (basic-queues)
[449.185663] Starting subtest: basic-queues
[455.764675] Subtest basic-queues: SUCCESS (6.574s)
[455.946736] [088/132] (565s left) prime_busy (after-wait)
[456.014199] Starting subtest: after-wait
[456.019671] Starting dynamic subtest: rcs0
[456.049257] Dynamic subtest rcs0: SUCCESS (0.031s)
[456.063602] Starting dynamic subtest: bcs0
[456.114077] Dynamic subtest bcs0: SUCCESS (0.062s)
[456.125491] Starting dynamic subtest: vcs0
[456.158926] Dynamic subtest vcs0: SUCCESS (0.043s)
[456.172211] Starting dynamic subtest: vcs1
[456.199854] Dynamic subtest vcs1: SUCCESS (0.040s)
[456.214622] Starting dynamic subtest: vecs0
[456.242188] Dynamic subtest vecs0: SUCCESS (0.041s)
[456.252860] Starting dynamic subtest: ccs0
[456.285122] Dynamic subtest ccs0: SUCCESS (0.042s)
[456.394009] Subtest after-wait: SUCCESS (0.377s)
[456.486087] [089/132] (564s left) gem_ctx_shared (create-shared-gtt)
[456.551076] Starting subtest: create-shared-gtt
[458.705072] Subtest create-shared-gtt: SUCCESS (2.153s)
[459.016854] [090/132] (562s left) syncobj_wait (wait-delayed-signal)
[459.072138] Starting subtest: wait-delayed-signal
[459.175477] Subtest wait-delayed-signal: SUCCESS (0.102s)
[459.251030] [091/132] (562s left) kms_flip (2x-blocking-wf_vblank)
[459.351181] Starting subtest: 2x-blocking-wf_vblank
[459.359909] Subtest 2x-blocking-wf_vblank: SKIP (0.010s)
[459.455413] [092/132] (562s left) kms_psr (pr-basic)
[459.544604] Starting subtest: pr-basic
[459.548660] Subtest pr-basic: SKIP (0.000s)
[459.616669] [093/132] (561s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[459.708711] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[464.259140] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.554s)
[465.382285] [094/132] (556s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[465.491887] Starting subtest: psr-modesetfrombusy
[471.632238] Subtest psr-modesetfrombusy: SUCCESS (6.145s)
[471.756328] [095/132] (549s left) sysfs_heartbeat_interval (mixed)
[471.819755] Starting subtest: mixed
[471.821916] Starting dynamic subtest: vecs0
[477.056224] Dynamic subtest vecs0: SUCCESS (5.236s)
[477.068729] Starting dynamic subtest: ccs0
[482.240464] Dynamic subtest ccs0: SUCCESS (5.183s)
[482.251272] Starting dynamic subtest: vcs0
[487.459566] Dynamic subtest vcs0: SUCCESS (5.218s)
[487.472298] Starting dynamic subtest: bcs0
[492.672497] Dynamic subtest bcs0: SUCCESS (5.211s)
[492.684607] Starting dynamic subtest: rcs0
[497.881466] Dynamic subtest rcs0: SUCCESS (5.207s)
[497.894367] Starting dynamic subtest: vcs1
[503.089172] Dynamic subtest vcs1: SUCCESS (5.206s)
[503.092093] Subtest mixed: SUCCESS (31.273s)
[503.170085] [096/132] (518s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[503.275851] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[503.280217] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[503.381049] [097/132] (518s left) gem_wait (write-busy)
[503.460218] Starting subtest: write-busy
[503.462470] Starting dynamic subtest: all-engines
[504.154172] Dynamic subtest all-engines: SUCCESS (0.693s)
[504.172814] Starting dynamic subtest: rcs0
[504.703015] Dynamic subtest rcs0: SUCCESS (0.548s)
[504.720195] Starting dynamic subtest: bcs0
[505.250410] Dynamic subtest bcs0: SUCCESS (0.546s)
[505.270963] Starting dynamic subtest: vcs0
[506.737783] Dynamic subtest vcs0: SUCCESS (1.484s)
[506.755352] Starting dynamic subtest: vcs1
[508.785841] Dynamic subtest vcs1: SUCCESS (2.046s)
[508.803038] Starting dynamic subtest: vecs0
[510.769954] Dynamic subtest vecs0: SUCCESS (1.982s)
[510.788226] Starting dynamic subtest: ccs0
[511.321286] Dynamic subtest ccs0: SUCCESS (0.550s)
[511.323784] Subtest write-busy: SUCCESS (7.862s)
[511.529291] [FACT gem_wait (write-busy)] new: kernel.kmod_is_loaded.vgem: true
[511.532610] [098/132] (510s left) kms_plane_scaling (planes-upscale-factor-0-25)
[511.634164] Starting subtest: planes-upscale-factor-0-25
[511.636310] Starting dynamic subtest: pipe-A
[511.695513] Dynamic subtest pipe-A: SUCCESS (0.063s)
[511.705686] Starting dynamic subtest: pipe-B
[512.827168] Dynamic subtest pipe-B: SUCCESS (1.131s)
[512.837074] Starting dynamic subtest: pipe-C
[513.934782] Dynamic subtest pipe-C: SUCCESS (1.106s)
[513.945575] Starting dynamic subtest: pipe-D
[515.073827] Dynamic subtest pipe-D: SUCCESS (1.138s)
[515.076063] Subtest planes-upscale-factor-0-25: SUCCESS (3.442s)
[516.227576] [099/132] (505s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[516.363136] Starting subtest: cursor-vs-flip-atomic-transitions
[546.553195] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.194s)
[547.353970] [100/132] (474s left) prime_mmap_coherency (read)
[547.405152] Starting subtest: read
[552.781726] Subtest read: SUCCESS (5.376s)
[552.910411] [101/132] (468s left) syncobj_timeline (single-wait-signaled)
[552.968017] Starting subtest: single-wait-signaled
[552.970486] Subtest single-wait-signaled: SUCCESS (0.000s)
[553.059951] [102/132] (468s left) kms_plane_scaling (invalid-parameters)
[553.165220] Starting subtest: invalid-parameters
[553.167349] Starting dynamic subtest: less-than-1-height-src
[553.179393] Dynamic subtest less-than-1-height-src: SUCCESS (0.013s)
[553.189785] Starting dynamic subtest: less-than-1-width-src
[553.192364] Dynamic subtest less-than-1-width-src: SUCCESS (0.014s)
[553.194830] Subtest invalid-parameters: SUCCESS (0.028s)
[553.308894] [103/132] (468s left) kms_pm_rpm (modeset-lpsp)
[554.908212] Starting subtest: modeset-lpsp
[556.367485] Subtest modeset-lpsp: SUCCESS (1.463s)
[556.471242] [104/132] (465s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[556.599910] Starting subtest: 4-tiled-8bpp-rotate-270
[556.633818] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.032s)
[556.738875] [105/132] (465s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[556.801708] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[556.877730] [106/132] (465s left) kms_debugfs (display-on-read-all)
[556.962087] Starting subtest: display-on-read-all
[557.126686] Subtest display-on-read-all: SUCCESS (0.164s)
[557.249356] [107/132] (464s left) gem_exec_fence (syncobj-export)
[557.694668] Starting subtest: syncobj-export
[557.700503] Subtest syncobj-export: SUCCESS (0.005s)
[558.854239] [108/132] (463s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[558.946112] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[558.950134] Starting dynamic subtest: pipe-A-eDP-1
[558.971874] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[558.983480] Starting dynamic subtest: pipe-B-eDP-1
[559.004036] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[559.013494] Starting dynamic subtest: pipe-C-eDP-1
[559.034074] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[559.043203] Starting dynamic subtest: pipe-D-eDP-1
[559.064029] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[559.068124] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[561.107015] [109/132] (461s left) kms_cursor_crc (cursor-offscreen-64x21)
[561.308086] Starting subtest: cursor-offscreen-64x21
[561.353758] Subtest cursor-offscreen-64x21: SKIP (0.040s)
[561.599955] [110/132] (460s left) kms_cursor_crc (cursor-sliding-64x64)
[561.767379] Starting subtest: cursor-sliding-64x64
[561.769694] Starting dynamic subtest: pipe-A-eDP-1
[564.991766] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.222s)
[565.023141] Starting dynamic subtest: pipe-D-eDP-1
[568.890180] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.874s)
[568.892351] Subtest cursor-sliding-64x64: SUCCESS (7.123s)
[569.765388] [111/132] (452s left) kms_chamelium_color (ctm-blue-to-red)
[569.855876] Subtest ctm-blue-to-red: SKIP (0.000s)
[569.901556] [112/132] (452s left) kms_chamelium_hpd (dp-hpd-fast)
[570.288737] Subtest dp-hpd-fast: SKIP (0.000s)
[571.080269] [113/132] (451s left) kms_psr (fbc-psr-sprite-plane-onoff)
[571.179914] Starting subtest: fbc-psr-sprite-plane-onoff
[571.182327] Starting dynamic subtest: eDP-1
[571.186963] Dynamic subtest eDP-1: SKIP (0.000s)
[571.191830] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[571.256076] [114/132] (451s left) kms_getfb (getfb2-handle-zero)
[571.347279] Starting subtest: getfb2-handle-zero
[571.349484] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[571.448500] [115/132] (451s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[571.543206] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[571.545326] Starting dynamic subtest: pipe-A-eDP-1
[572.320694] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.770s)
[572.331368] Starting dynamic subtest: pipe-B-eDP-1
[573.824084] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.502s)
[573.834842] Starting dynamic subtest: pipe-C-eDP-1
[575.322614] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.497s)
[575.337986] Starting dynamic subtest: pipe-D-eDP-1
[576.843816] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.519s)
[576.845657] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.293s)
[578.019820] [116/132] (444s left) gem_pxp (protected-raw-src-copy-not-readible)
[578.138295] Starting subtest: protected-raw-src-copy-not-readible
[578.194693] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.059s)
[578.315827] [117/132] (444s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[578.449019] Starting subtest: flip-vs-cursor-toggle
[587.376150] Subtest flip-vs-cursor-toggle: SUCCESS (8.929s)
[588.248501] [118/132] (434s left) core_debugfs (read-all-entries)
[588.311347] Starting subtest: read-all-entries
[588.405434] Subtest read-all-entries: SUCCESS (0.093s)
[588.473893] [119/132] (434s left) kms_flip (2x-absolute-wf_vblank)
[588.563343] Starting subtest: 2x-absolute-wf_vblank
[588.571627] Subtest 2x-absolute-wf_vblank: SKIP (0.010s)
[588.650858] [120/132] (434s left) dumb_buffer (create-valid-dumb)
[588.707565] Starting subtest: create-valid-dumb
[588.709466] Subtest create-valid-dumb: SUCCESS (0.000s)
[588.804817] [121/132] (433s left) kms_content_protection (dp-mst-type-1)
[588.947248] Starting subtest: dp-mst-type-1
[588.951880] Subtest dp-mst-type-1: SKIP (0.000s)
[589.085350] [122/132] (433s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[589.185245] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[595.996123] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.815s)
[596.130498] [123/132] (426s left) api_intel_allocator (default-alignment)
[596.188226] Starting subtest: default-alignment
[596.190469] Subtest default-alignment: SUCCESS (0.003s)
[596.309251] [124/132] (426s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[596.374405] Starting subtest: y-tiled-ccs-to-yf-tiled
[596.378462] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[596.558093] [125/132] (426s left) gem_flink_basic (bad-open)
[596.610358] Starting subtest: bad-open
[596.612533] Subtest bad-open: SUCCESS (0.000s)
[596.694649] [126/132] (426s left) kms_fbcon_fbt (fbc-suspend)
[596.760665] Starting subtest: fbc-suspend
[646.347118] Subtest fbc-suspend: SUCCESS (19.290s)
[647.650999] [127/132] (375s left) gem_pxp (create-valid-protected-context)
[647.771239] Starting subtest: create-valid-protected-context
[647.773665] Subtest create-valid-protected-context: SUCCESS (0.002s)
[647.898390] [128/132] (375s left) prime_vgem (basic-fence-mmap)
[647.963510] Starting subtest: basic-fence-mmap
[647.967978] Subtest basic-fence-mmap: SKIP (0.000s)
[648.053347] [129/132] (375s left) kms_async_flips (test-cursor)
[648.137304] Starting subtest: test-cursor
[648.521013] Starting dynamic subtest: pipe-A-eDP-1
[649.334104] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.822s)
[649.704983] Starting dynamic subtest: pipe-B-eDP-1
[650.448981] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.762s)
[650.829510] Starting dynamic subtest: pipe-C-eDP-1
[651.568325] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.754s)
[651.949543] Starting dynamic subtest: pipe-D-eDP-1
[652.689455] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.755s)
[652.691822] Subtest test-cursor: SUCCESS (4.597s)
[653.863078] [130/132] (369s left) perf (gen12-group-concurrent-oa-buffer-read)
[653.998068] Starting subtest: gen12-group-concurrent-oa-buffer-read
[664.020929] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.058s)
[664.072646] [131/132] (359s left) gem_ctx_param (set-priority-range)
[664.135166] Starting subtest: set-priority-range
[664.164978] Subtest set-priority-range: SUCCESS (0.030s)
[664.286445] [132/132] (358s left) sw_sync (timeline_closed_signaled)
[664.326110] Starting subtest: timeline_closed_signaled
[664.328369] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[664.375503] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_psr_stress_test
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: i915_drm_fdinfo
results: parsing output: 8/ for test: kms_vblank
results: parsing output: 9/ for test: syncobj_basic
results: parsing output: 10/ for test: i915_pm_rpm
results: parsing output: 11/ for test: sw_sync
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: gem_exec_balancer
results: parsing output: 14/ for test: kms_pipe_stress
results: parsing output: 15/ for test: kms_dsc
results: parsing output: 16/ for test: kms_joiner
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: kms_properties
results: parsing output: 19/ for test: prime_udl
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_flip_scaled_crc
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: gem_mmap_wc
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_create
results: parsing output: 26/ for test: kms_addfb_basic
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: kms_plane
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: intel_hwmon
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: gem_exec_flush
results: parsing output: 33/ for test: kms_plane
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: gem_ctx_isolation
results: parsing output: 36/ for test: gem_exec_params
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_lease
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: gem_ctx_bad_destroy
results: parsing output: 45/ for test: drm_read
results: parsing output: 46/ for test: kms_busy
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gen9_exec_parse
results: parsing output: 49/ for test: kms_atomic_transition
results: parsing output: 50/ for test: gem_mmap_gtt
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: perf_pmu
results: parsing output: 53/ for test: kms_selftest
results: parsing output: 54/ for test: gem_exec_params
results: parsing output: 55/ for test: kms_addfb_basic
results: parsing output: 56/ for test: kms_async_flips
results: parsing output: 57/ for test: gem_exec_whisper
results: parsing output: 58/ for test: gem_exec_schedule
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: gem_mmap_gtt
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: gem_exec_balancer
results: parsing output: 66/ for test: kms_pipe_crc_basic
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: gem_busy
results: parsing output: 71/ for test: kms_pm_dc
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: i915_hangman
results: parsing output: 75/ for test: gem_fenced_exec_thrash
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: kms_flip_scaled_crc
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: gem_softpin
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: kms_chamelium_edid
results: parsing output: 84/ for test: kms_color_pipeline
results: parsing output: 85/ for test: gem_mmap_gtt
results: parsing output: 86/ for test: gem_exec_whisper
results: parsing output: 87/ for test: prime_busy
results: parsing output: 88/ for test: gem_ctx_shared
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: sysfs_heartbeat_interval
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_wait
results: parsing output: 97/ for test: kms_plane_scaling
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: prime_mmap_coherency
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_plane_scaling
results: parsing output: 102/ for test: kms_pm_rpm
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: gem_exec_reloc
results: parsing output: 105/ for test: kms_debugfs
results: parsing output: 106/ for test: gem_exec_fence
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_cursor_crc
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: kms_chamelium_color
results: parsing output: 111/ for test: kms_chamelium_hpd
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: kms_getfb
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: gem_pxp
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: core_debugfs
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: dumb_buffer
results: parsing output: 120/ for test: kms_content_protection
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: api_intel_allocator
results: parsing output: 123/ for test: gem_render_copy
results: parsing output: 124/ for test: gem_flink_basic
results: parsing output: 125/ for test: kms_fbcon_fbt
results: parsing output: 126/ for test: gem_pxp
results: parsing output: 127/ for test: prime_vgem
results: parsing output: 128/ for test: kms_async_flips
results: parsing output: 129/ for test: perf
results: parsing output: 130/ for test: gem_ctx_param
results: parsing output: 131/ for test: sw_sync
Done.