[50.435852] Initializing watchdogs
[50.435899]   /dev/watchdog0
[50.450068] [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]
[50.453989] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[50.456127] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[50.459300] [001/131] (960s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[50.627936] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[50.640760] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[50.709251] [002/131] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[50.814852] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[50.819107] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[50.925025] [003/131] (960s left) gem_flink_basic (double-flink)
[50.985256] Starting subtest: double-flink
[50.987614] Subtest double-flink: SUCCESS (0.000s)
[51.070311] [004/131] (959s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[51.134519] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[51.218052] [005/131] (959s left) gem_exec_schedule (u-semaphore-user)
[51.292443] Starting subtest: u-semaphore-user
[51.350693] Subtest u-semaphore-user: SUCCESS (0.058s)
[52.939093] [006/131] (958s left) drm_read (short-buffer-nonblock)
[53.137800] Starting subtest: short-buffer-nonblock
[53.140177] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[53.287763] [007/131] (957s left) gem_mmap_offset (partial-remap)
[53.348977] Starting subtest: partial-remap
[53.351059] Starting dynamic subtest: smem0
[53.360432] Dynamic subtest smem0: SUCCESS (0.005s)
[53.362784] Subtest partial-remap: SUCCESS (0.005s)
[53.475167] [008/131] (957s left) kms_selftest (drm_dp_mst_helper)
[53.512074] Starting subtest: drm_dp_mst_helper
[53.520079] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[53.649545] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.131s)
[53.657834] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[53.781873] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.132s)
[53.788988] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[53.923096] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.140s)
[53.925079] Subtest drm_dp_mst_helper: SUCCESS (0.410s)
[54.094451] [009/131] (957s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[54.155083] Starting subtest: map-fixed-invalidate-overlap
[54.159610] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[54.290344] [010/131] (956s left) gem_exec_balancer (bonded-true-hang)
[54.532309] Starting subtest: bonded-true-hang
[54.537385] Subtest bonded-true-hang: SKIP (0.000s)
[54.642085] [011/131] (956s left) gem_exec_nop (basic-series)
[54.713726] Starting subtest: basic-series
[70.958838] Subtest basic-series: SUCCESS (16.252s)
[71.395935] [012/131] (939s left) gem_ctx_exec (basic-invalid-context)
[71.522183] Starting subtest: basic-invalid-context
[71.534552] Subtest basic-invalid-context: SUCCESS (0.012s)
[71.721637] [013/131] (939s left) kms_joiner (invalid-modeset-big-joiner)
[71.890078] Starting subtest: invalid-modeset-big-joiner
[71.895017] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[71.949532] [014/131] (939s left) kms_getfb (getfb-handle-protection)
[72.056980] Starting subtest: getfb-handle-protection
[72.088397] Subtest getfb-handle-protection: SUCCESS (0.032s)
[72.201797] [015/131] (939s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[72.257795] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[72.260284] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[72.338428] [016/131] (939s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[72.407139] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[72.411320] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[72.582484] [017/131] (938s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[72.688778] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[72.692743] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[72.798403] [018/131] (938s left) fbdev (unaligned-write)
[72.836589] Starting subtest: unaligned-write
[72.937508] Subtest unaligned-write: SUCCESS (0.103s)
[72.991873] [019/131] (938s left) gem_ctx_param (vm)
[73.048454] Starting subtest: vm
[73.095662] Subtest vm: SUCCESS (0.046s)
[73.180175] [020/131] (938s left) kms_display_modes (extended-mode-basic)
[73.280236] Starting subtest: extended-mode-basic
[73.285035] Subtest extended-mode-basic: SKIP (0.000s)
[73.319499] [021/131] (938s left) syncobj_eventfd (binary-wait-signaled)
[73.377706] Starting subtest: binary-wait-signaled
[73.379940] Subtest binary-wait-signaled: SUCCESS (0.000s)
[73.490272] [022/131] (938s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[73.595965] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[74.452683] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.859s)
[74.660134] [023/131] (937s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[74.766406] Starting subtest: 2x-flip-vs-modeset-vs-hang
[74.777648] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s)
[74.850991] [024/131] (936s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[74.960710] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[74.965236] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[75.057519] [025/131] (936s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[75.146979] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[75.149362] Starting dynamic subtest: pipe-A-default-mode
[77.832531] Dynamic subtest pipe-A-default-mode: SUCCESS (2.682s)
[77.834466] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.683s)
[78.699852] [026/131] (933s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[78.800064] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[78.804702] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[79.924736] [027/131] (931s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[80.034108] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[80.036678] Starting dynamic subtest: pipe-A-eDP-1
[80.057730] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[80.067064] Starting dynamic subtest: pipe-B-eDP-1
[80.086484] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[80.094067] Starting dynamic subtest: pipe-C-eDP-1
[80.113906] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[80.121092] Starting dynamic subtest: pipe-D-eDP-1
[80.140947] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[80.143186] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[82.278347] [028/131] (929s left) sw_sync (sync_random_merge)
[82.316124] Starting subtest: sync_random_merge
[82.352369] Subtest sync_random_merge: SUCCESS (0.039s)
[82.405863] [029/131] (929s left) kms_cursor_legacy (single-move)
[82.532066] Starting subtest: single-move
[82.534276] Starting dynamic subtest: pipe-A
[87.915448] Dynamic subtest pipe-A: SUCCESS (5.381s)
[87.923442] Starting dynamic subtest: pipe-B
[93.300085] Dynamic subtest pipe-B: SUCCESS (5.381s)
[93.308810] Starting dynamic subtest: pipe-C
[98.681523] Dynamic subtest pipe-C: SUCCESS (5.383s)
[98.690209] Starting dynamic subtest: pipe-D
[104.064226] Dynamic subtest pipe-D: SUCCESS (5.382s)
[104.074217] Starting dynamic subtest: all-pipes
[109.454583] Dynamic subtest all-pipes: SUCCESS (5.390s)
[109.456792] Subtest single-move: SUCCESS (26.919s)
[109.575259] [030/131] (902s left) gem_sync (basic-all)
[109.658640] Starting subtest: basic-all
[112.657738] Subtest basic-all: SUCCESS (3.008s)
[112.834213] [031/131] (899s left) gem_ctx_persistence (legacy-engines-cleanup)
[112.903168] Starting subtest: legacy-engines-cleanup
[112.905486] Starting dynamic subtest: render
[113.008300] Dynamic subtest render: SUCCESS (0.104s)
[113.018676] Starting dynamic subtest: bsd1
[113.051469] Dynamic subtest bsd1: SUCCESS (0.043s)
[113.061238] Starting dynamic subtest: bsd2
[113.114218] Dynamic subtest bsd2: SUCCESS (0.061s)
[113.124683] Starting dynamic subtest: blt
[113.141473] Dynamic subtest blt: SUCCESS (0.027s)
[113.148255] Starting dynamic subtest: vebox
[113.234920] Dynamic subtest vebox: SUCCESS (0.093s)
[113.237423] Subtest legacy-engines-cleanup: SUCCESS (0.332s)
[113.308488] [032/131] (898s left) kms_color (ctm-red-to-blue)
[113.416941] Starting subtest: ctm-red-to-blue
[113.419321] Starting dynamic subtest: pipe-A-eDP-1
[114.102041] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.685s)
[114.109127] Starting dynamic subtest: pipe-B-eDP-1
[115.465940] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.363s)
[115.474793] Starting dynamic subtest: pipe-C-eDP-1
[116.822206] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.356s)
[116.830450] Starting dynamic subtest: pipe-D-eDP-1
[118.185875] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.362s)
[118.188271] Subtest ctm-red-to-blue: SUCCESS (4.767s)
[118.978215] [033/131] (893s left) drm_fdinfo (virtual-busy-idle)
[119.018511] Starting subtest: virtual-busy-idle
[119.023152] Subtest virtual-busy-idle: SKIP (0.000s)
[119.075059] [034/131] (892s left) syncobj_basic (bad-pad-fd-to-handle)
[119.127279] Starting subtest: bad-pad-fd-to-handle
[119.129618] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[119.219500] [035/131] (892s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[119.272275] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[119.274605] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[119.380883] [036/131] (892s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu)
[119.490580] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu
[124.054479] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (4.567s)
[124.182229] [037/131] (887s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[124.298283] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[129.495492] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (5.198s)
[129.633066] [038/131] (882s left) i915_pm_rps (waitboost)
[129.696939] Starting subtest: waitboost
[129.765215] Subtest waitboost: FAIL (0.015s)
[129.830737] [039/131] (882s left) gem_exec_whisper (basic-fds-forked)
[129.896516] Starting subtest: basic-fds-forked
[152.503753] Subtest basic-fds-forked: SUCCESS (22.606s)
[152.681580] [040/131] (859s left) kms_plane_alpha_blend (constant-alpha-min)
[152.786978] Starting subtest: constant-alpha-min
[153.235789] Starting dynamic subtest: pipe-A-eDP-1
[153.925865] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.687s)
[153.934067] Starting dynamic subtest: pipe-D-eDP-1
[155.334274] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.410s)
[155.336631] Subtest constant-alpha-min: SUCCESS (2.547s)
[156.128041] [041/131] (856s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[156.188903] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[156.296498] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.107s)
[156.366279] [042/131] (855s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[156.474977] Starting subtest: plane-upscale-20x20-with-rotation
[156.477336] Starting dynamic subtest: pipe-A
[156.702055] Dynamic subtest pipe-A: SUCCESS (0.227s)
[156.710525] Starting dynamic subtest: pipe-B
[158.008245] Dynamic subtest pipe-B: SUCCESS (1.306s)
[158.021462] Starting dynamic subtest: pipe-C
[159.329475] Dynamic subtest pipe-C: SUCCESS (1.321s)
[159.337562] Starting dynamic subtest: pipe-D
[160.655171] Dynamic subtest pipe-D: SUCCESS (1.325s)
[160.657517] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.181s)
[161.823724] [043/131] (850s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[161.924341] Starting subtest: fbc-psr2-cursor-mmap-cpu
[161.926722] Starting dynamic subtest: eDP-1
[161.930972] Dynamic subtest eDP-1: SKIP (0.000s)
[161.935238] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s)
[161.990450] [044/131] (850s left) gem_exec_fence (syncobj-timeline-signal)
[162.586357] Starting subtest: syncobj-timeline-signal
[162.592324] Subtest syncobj-timeline-signal: SUCCESS (0.007s)
[164.005469] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[164.008831] [045/131] (848s left) kms_big_fb (linear-8bpp-rotate-90)
[164.111878] Starting subtest: linear-8bpp-rotate-90
[164.133141] Subtest linear-8bpp-rotate-90: SKIP (0.021s)
[164.251901] [046/131] (848s left) i915_suspend (sysfs-reader)
[164.316084] Starting subtest: sysfs-reader
[182.196296] Subtest sysfs-reader: SUCCESS (3.142s)
[182.249315] [047/131] (844s left) drm_read (short-buffer-block)
[182.407670] Starting subtest: short-buffer-block
[182.409516] Subtest short-buffer-block: SUCCESS (0.000s)
[182.548263] [048/131] (844s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[182.604705] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[182.606675] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[182.701682] [049/131] (844s left) gem_exec_fence (invalid-fence-array)
[183.118780] Starting subtest: invalid-fence-array
[183.121210] Subtest invalid-fence-array: SUCCESS (0.002s)
[184.796818] [050/131] (842s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[184.909799] Starting subtest: psr-rgb101010-draw-mmap-cpu
[189.697661] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (4.795s)
[189.806842] [051/131] (837s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[189.909945] Starting subtest: 4-tiled-64bpp-rotate-180
[192.183611] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (2.276s)
[192.446288] [052/131] (834s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc)
[192.554410] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc
[197.206423] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (4.656s)
[197.359397] [053/131] (830s left) kms_psr (psr2-cursor-mmap-gtt)
[197.458873] Starting subtest: psr2-cursor-mmap-gtt
[197.461308] Starting dynamic subtest: eDP-1
[199.109599] Dynamic subtest eDP-1: SUCCESS (1.650s)
[199.111919] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.651s)
[199.893536] [054/131] (827s left) drm_buddy (drm_buddy)
[199.934439] Starting subtest: drm_buddy
[199.945279] Starting dynamic subtest: drm_test_buddy_alloc_limit
[200.087636] Dynamic subtest drm_test_buddy_alloc_limit: SUCCESS (0.141s)
[200.095486] Starting dynamic subtest: drm_test_buddy_alloc_optimistic
[200.209945] Dynamic subtest drm_test_buddy_alloc_optimistic: SUCCESS (0.121s)
[200.219032] Starting dynamic subtest: drm_test_buddy_alloc_pessimistic
[200.340414] Dynamic subtest drm_test_buddy_alloc_pessimistic: SUCCESS (0.131s)
[200.349433] Starting dynamic subtest: drm_test_buddy_alloc_pathological
[200.479212] Dynamic subtest drm_test_buddy_alloc_pathological: SUCCESS (0.137s)
[200.487623] Starting dynamic subtest: drm_test_buddy_alloc_contiguous
[200.564945] Dynamic subtest drm_test_buddy_alloc_contiguous: SUCCESS (0.087s)
[200.572645] Starting dynamic subtest: drm_test_buddy_alloc_clear
[200.726204] Dynamic subtest drm_test_buddy_alloc_clear: SUCCESS (0.160s)
[200.734256] Starting dynamic subtest: drm_test_buddy_alloc_range_bias
[200.843143] Dynamic subtest drm_test_buddy_alloc_range_bias: SUCCESS (0.116s)
[200.845022] Subtest drm_buddy: SUCCESS (0.911s)
[201.008300] [055/131] (826s left) gem_exec_schedule (preempt-engines)
[201.086012] Starting subtest: preempt-engines
[201.087956] Starting dynamic subtest: rcs0
[203.319291] Dynamic subtest rcs0: SUCCESS (2.240s)
[203.327469] Starting dynamic subtest: bcs0
[205.598417] Dynamic subtest bcs0: SUCCESS (2.278s)
[205.612657] Starting dynamic subtest: vcs0
[207.830766] Dynamic subtest vcs0: SUCCESS (2.232s)
[207.846170] Starting dynamic subtest: vcs1
[210.091675] Dynamic subtest vcs1: SUCCESS (2.259s)
[210.103329] Starting dynamic subtest: vecs0
[212.333831] Dynamic subtest vecs0: SUCCESS (2.242s)
[212.345093] Starting dynamic subtest: ccs0
[214.621379] Dynamic subtest ccs0: SUCCESS (2.286s)
[214.624039] Subtest preempt-engines: SUCCESS (13.545s)
[214.920465] [056/131] (812s left) kms_plane (plane-position-hole-dpms)
[215.018500] Starting subtest: plane-position-hole-dpms
[215.535772] Starting dynamic subtest: pipe-A-plane-1
[217.758397] Dynamic subtest pipe-A-plane-1: SUCCESS (2.226s)
[217.767308] Starting dynamic subtest: pipe-A-plane-2
[220.004808] Dynamic subtest pipe-A-plane-2: SUCCESS (2.246s)
[220.014126] Starting dynamic subtest: pipe-A-plane-3
[222.262547] Dynamic subtest pipe-A-plane-3: SUCCESS (2.256s)
[222.273433] Starting dynamic subtest: pipe-A-plane-4
[224.523988] Dynamic subtest pipe-A-plane-4: SUCCESS (2.260s)
[224.534032] Starting dynamic subtest: pipe-A-plane-5
[224.562386] Dynamic subtest pipe-A-plane-5: SUCCESS (0.038s)
[225.675004] Starting dynamic subtest: pipe-B-plane-1
[227.899627] Dynamic subtest pipe-B-plane-1: SUCCESS (2.231s)
[227.909112] Starting dynamic subtest: pipe-B-plane-2
[230.164558] Dynamic subtest pipe-B-plane-2: SUCCESS (2.265s)
[230.173930] Starting dynamic subtest: pipe-B-plane-3
[232.431984] Dynamic subtest pipe-B-plane-3: SUCCESS (2.267s)
[232.442229] Starting dynamic subtest: pipe-B-plane-4
[234.690192] Dynamic subtest pipe-B-plane-4: SUCCESS (2.259s)
[234.698633] Starting dynamic subtest: pipe-B-plane-5
[234.730006] Dynamic subtest pipe-B-plane-5: SUCCESS (0.037s)
[234.731907] Subtest plane-position-hole-dpms: SUCCESS (19.712s)
[235.500187] [057/131] (792s left) gem_userptr_blits (stress-purge)
[235.584268] Starting subtest: stress-purge
[240.973332] Subtest stress-purge: SUCCESS (5.392s)
[241.111754] [058/131] (786s left) kms_flip (2x-busy-flip)
[241.250107] Starting subtest: 2x-busy-flip
[241.261654] Subtest 2x-busy-flip: SKIP (0.011s)
[241.337738] [059/131] (786s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[246.341779] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[246.349607] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.005s)
[247.199632] [060/131] (780s left) kms_addfb_basic (unused-offsets)
[247.262002] Starting subtest: unused-offsets
[247.264305] Subtest unused-offsets: SUCCESS (0.000s)
[247.407921] [061/131] (780s left) kms_chamelium_color (ctm-negative)
[247.515594] Subtest ctm-negative: SKIP (0.000s)
[247.556168] [062/131] (780s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[247.632954] Starting subtest: stress-mm-invalidate-close-overlap
[249.782723] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[249.915242] [063/131] (777s left) kms_vblank (query-forked-busy-hang)
[250.012430] Starting subtest: query-forked-busy-hang
[250.014750] Starting dynamic subtest: pipe-A-eDP-1
[276.404616] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.392s)
[276.419658] Starting dynamic subtest: pipe-D-eDP-1
[291.465084] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.056s)
[291.467627] Subtest query-forked-busy-hang: SUCCESS (41.452s)
[292.252504] [064/131] (735s left) kms_addfb_basic (bad-pitch-999)
[292.315039] Starting subtest: bad-pitch-999
[292.317313] Subtest bad-pitch-999: SUCCESS (0.000s)
[292.461639] [065/131] (735s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[292.565485] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[292.567816] Starting dynamic subtest: pipe-A-eDP-1
[292.589969] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[292.599152] Starting dynamic subtest: pipe-B-eDP-1
[292.619619] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[292.628002] Starting dynamic subtest: pipe-C-eDP-1
[292.649333] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[292.659182] Starting dynamic subtest: pipe-D-eDP-1
[292.680627] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[292.684925] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[294.704022] [066/131] (733s left) gem_eio (in-flight-contexts-1us)
[294.913040] Starting subtest: in-flight-contexts-1us
[306.715780] Subtest in-flight-contexts-1us: SUCCESS (11.802s)
[306.897495] [067/131] (721s left) kms_content_protection (type1)
[307.080073] Starting subtest: type1
[310.434162] Subtest type1: SKIP (3.351s)
[311.605206] [068/131] (716s left) i915_pm_freq_api (freq-basic-api)
[311.667573] Starting subtest: freq-basic-api
[311.670104] Starting dynamic subtest: gt0
[311.672588] Dynamic subtest gt0: SUCCESS (0.003s)
[311.683755] Starting dynamic subtest: gt1
[311.686103] Dynamic subtest gt1: SUCCESS (0.003s)
[311.688423] Subtest freq-basic-api: SUCCESS (0.007s)
[311.785405] [069/131] (716s left) gem_exec_reloc (basic-cpu)
[311.842983] Subtest basic-cpu: SKIP (0.000s)
[311.926863] [070/131] (716s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[312.028519] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[312.032893] Starting dynamic subtest: pipe-A-default-mode
[314.710658] Dynamic subtest pipe-A-default-mode: SUCCESS (2.679s)
[314.712917] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.680s)
[315.582309] [071/131] (712s left) gem_exec_balancer (indices)
[315.649833] Starting subtest: indices
[317.660793] Subtest indices: SUCCESS (2.010s)
[317.929333] [072/131] (710s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[318.044778] Starting subtest: y-tiled-8bpp-rotate-90
[318.049107] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[318.156518] [073/131] (709s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[318.248099] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[318.252084] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[318.341201] [074/131] (709s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[318.436828] Starting subtest: fbcpsr-rgb565-draw-pwrite
[323.358562] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (4.926s)
[323.502612] [075/131] (704s left) syncobj_timeline (wait-any-snapshot)
[323.564781] Starting subtest: wait-any-snapshot
[323.646274] Subtest wait-any-snapshot: SUCCESS (0.081s)
[323.719296] [076/131] (704s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[325.898318] Starting subtest: dpms-mode-unset-non-lpsp
[327.058384] Subtest dpms-mode-unset-non-lpsp: SKIP (1.159s)
[327.435769] [077/131] (700s left) gem_watchdog (default-virtual)
[327.515693] Starting subtest: default-virtual
[333.785986] Subtest default-virtual: SUCCESS (6.283s)
[333.900102] [078/131] (694s left) kms_async_flips (crc-atomic)
[334.013233] Starting subtest: crc-atomic
[334.377556] Starting dynamic subtest: pipe-A-eDP-1
[337.297374] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.921s)
[337.677326] Starting dynamic subtest: pipe-B-eDP-1
[340.534850] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.867s)
[340.901887] Starting dynamic subtest: pipe-C-eDP-1
[343.738701] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.848s)
[344.101973] Starting dynamic subtest: pipe-D-eDP-1
[346.951657] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.859s)
[346.953905] Subtest crc-atomic: SUCCESS (12.938s)
[348.132664] [079/131] (680s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[348.249583] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[348.253900] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[348.367703] [080/131] (680s left) gen9_exec_parse (valid-registers)
[348.441876] Subtest valid-registers: SKIP (0.000s)
[348.504179] [081/131] (679s left) perf (gen12-invalid-class-instance)
[348.633405] Starting subtest: gen12-invalid-class-instance
[348.647756] Subtest gen12-invalid-class-instance: SUCCESS (0.016s)
[348.684211] [082/131] (679s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[348.754593] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[348.828328] [083/131] (679s left) gem_exec_reloc (basic-softpin)
[348.887711] Subtest basic-softpin: SKIP (0.000s)
[348.978888] [084/131] (679s left) gem_pxp (protected-raw-src-copy-not-readible)
[349.109297] Starting subtest: protected-raw-src-copy-not-readible
[349.165915] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.059s)
[349.316239] [085/131] (679s left) kms_lease (lease-unleased-connector)
[349.407093] Starting subtest: lease-unleased-connector
[349.409137] Starting dynamic subtest: pipe-A-eDP-1
[349.420381] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.011s)
[349.430465] Starting dynamic subtest: pipe-B-eDP-1
[349.432293] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[349.442750] Starting dynamic subtest: pipe-C-eDP-1
[349.444691] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[349.459953] Starting dynamic subtest: pipe-D-eDP-1
[349.461789] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[349.463605] Subtest lease-unleased-connector: SUCCESS (0.048s)
[349.563571] [086/131] (679s left) gem_exec_reloc (basic-concurrent0)
[349.626349] Subtest basic-concurrent0: SKIP (0.000s)
[349.696215] [087/131] (678s left) kms_big_fb (y-tiled-addfb-size-overflow)
[349.790025] Starting subtest: y-tiled-addfb-size-overflow
[349.793823] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[349.887815] [088/131] (678s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[349.972035] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[349.973876] Starting dynamic subtest: pipe-A-eDP-1
[350.020918] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[350.029401] Starting dynamic subtest: pipe-B-eDP-1
[350.077109] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[350.087234] Starting dynamic subtest: pipe-C-eDP-1
[350.135188] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[350.144769] Starting dynamic subtest: pipe-D-eDP-1
[350.192381] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[350.195823] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[352.083925] [089/131] (676s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[352.183753] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[352.188434] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[352.283331] [090/131] (676s left) i915_query (query-topology-matches-eu-total)
[352.347039] Starting subtest: query-topology-matches-eu-total
[352.349401] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[352.436573] [091/131] (676s left) kms_cursor_edge_walk (128x128-left-edge)
[352.532416] Starting subtest: 128x128-left-edge
[352.534701] Starting dynamic subtest: pipe-A-eDP-1
[355.940624] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.407s)
[355.950702] Starting dynamic subtest: pipe-D-eDP-1
[359.059962] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.115s)
[359.062037] Subtest 128x128-left-edge: SUCCESS (6.525s)
[359.864177] [092/131] (668s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[359.963470] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[359.968082] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[361.087486] [093/131] (667s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[361.195225] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[361.200033] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[361.290618] [094/131] (667s left) kms_atomic_interruptible (universal-setplane-primary)
[361.386408] Starting subtest: universal-setplane-primary
[361.388647] Starting dynamic subtest: pipe-A-eDP-1
[368.817492] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.428s)
[368.819846] Subtest universal-setplane-primary: SUCCESS (7.430s)
[369.640785] [095/131] (659s left) kms_cursor_crc (cursor-random-32x10)
[369.785855] Starting subtest: cursor-random-32x10
[369.826714] Subtest cursor-random-32x10: SKIP (0.035s)
[370.064083] [096/131] (658s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[370.166749] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[370.171049] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[370.280610] [097/131] (658s left) perf_pmu (invalid-open)
[370.325129] Starting subtest: invalid-open
[370.327369] Subtest invalid-open: SUCCESS (0.000s)
[370.430497] [098/131] (658s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[370.536603] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[370.540675] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[370.653254] [099/131] (658s left) kms_feature_discovery (chamelium)
[370.752643] Starting subtest: chamelium
[370.756073] Subtest chamelium: SKIP (0.000s)
[370.821995] [100/131] (658s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[375.786377] Starting subtest: psr2-cursor-plane-update-sf
[375.788622] Starting dynamic subtest: pipe-A-eDP-1
[377.102855] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.314s)
[377.112205] Starting dynamic subtest: pipe-B-eDP-1
[378.428843] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.324s)
[378.431284] Subtest psr2-cursor-plane-update-sf: SUCCESS (2.642s)
[379.287758] [101/131] (649s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[379.395413] Starting subtest: fbc-shrfb-scaledprimary
[383.491105] Subtest fbc-shrfb-scaledprimary: SUCCESS (4.099s)
[383.649766] [102/131] (645s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[383.708503] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[383.710848] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[383.805806] [103/131] (645s left) gem_exec_gttfill (basic)
[383.866608] Starting subtest: basic
[388.248704] Subtest basic: SUCCESS (4.380s)
[388.433233] [104/131] (640s left) sysfs_timeslice_duration (timeout)
[388.536917] Starting subtest: timeout
[388.539329] Starting dynamic subtest: vecs0
[397.718696] Dynamic subtest vecs0: SUCCESS (9.178s)
[397.730967] Starting dynamic subtest: ccs0
[399.098353] Dynamic subtest ccs0: SUCCESS (1.379s)
[399.111714] Starting dynamic subtest: vcs0
[408.710459] Dynamic subtest vcs0: SUCCESS (9.610s)
[408.721537] Starting dynamic subtest: bcs0
[409.400108] Dynamic subtest bcs0: SUCCESS (0.690s)
[409.412009] Starting dynamic subtest: rcs0
[410.729995] Dynamic subtest rcs0: SUCCESS (1.325s)
[410.741365] Starting dynamic subtest: vcs1
[420.698107] Dynamic subtest vcs1: SUCCESS (9.964s)
[420.700624] Subtest timeout: SUCCESS (32.156s)
[420.767797] [105/131] (608s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[420.883081] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[420.887593] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[420.992235] [106/131] (608s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[421.091128] Starting subtest: fbc-psr-sprite-mmap-cpu
[421.093932] Starting dynamic subtest: eDP-1
[421.098832] Dynamic subtest eDP-1: SKIP (0.000s)
[421.103136] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.002s)
[421.174985] [107/131] (608s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[421.240539] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[421.242988] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[421.332167] [108/131] (608s left) api_intel_allocator (open-vm)
[421.386951] Starting subtest: open-vm
[421.388940] Subtest open-vm: SUCCESS (0.003s)
[421.502953] [109/131] (607s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[421.604687] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[421.608694] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[421.690709] [110/131] (607s left) gem_shrink (reclaim)
[421.759072] Starting subtest: reclaim
[424.346012] Subtest reclaim: SUCCESS (2.584s)
[424.442909] [111/131] (605s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[424.560897] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[424.565411] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[424.667166] [112/131] (604s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[424.721536] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[424.828924] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[424.900588] [113/131] (604s left) kms_psr (fbc-psr-dpms)
[424.988750] Starting subtest: fbc-psr-dpms
[424.991087] Starting dynamic subtest: eDP-1
[424.995656] Dynamic subtest eDP-1: SKIP (0.000s)
[424.999674] Subtest fbc-psr-dpms: SKIP (0.002s)
[425.061505] [114/131] (604s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[425.159470] Starting subtest: primary-y-tiled-reflect-x-270
[425.164062] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[425.229807] [115/131] (604s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[425.617229] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[426.410501] [116/131] (603s left) gem_partial_pwrite_pread (write-snoop)
[426.492165] Subtest write-snoop: SKIP (0.000s)
[426.578782] [117/131] (603s left) gem_mmap_wc (write-read)
[426.646013] Subtest write-read: SKIP (0.000s)
[426.704161] [118/131] (603s left) gem_lmem_swapping (verify)
[426.748584] Subtest verify: SKIP (0.000s)
[426.794166] [119/131] (603s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[426.861146] Subtest untiled-to-tiled: SKIP (0.000s)
[426.938018] [120/131] (602s left) kms_flip (dpms-vs-vblank-race)
[427.038358] Starting subtest: dpms-vs-vblank-race
[427.040576] Starting dynamic subtest: A-eDP1
[431.991103] Dynamic subtest A-eDP1: SUCCESS (4.950s)
[432.001417] Starting dynamic subtest: B-eDP1
[436.605228] Dynamic subtest B-eDP1: SUCCESS (4.613s)
[436.617406] Starting dynamic subtest: C-eDP1
[441.109263] Dynamic subtest C-eDP1: SUCCESS (4.503s)
[441.121197] Starting dynamic subtest: D-eDP1
[445.525416] Dynamic subtest D-eDP1: SUCCESS (4.414s)
[445.527721] Subtest dpms-vs-vblank-race: SUCCESS (18.487s)
[446.396857] [121/131] (583s left) kms_psr (psr-sprite-plane-onoff)
[446.498317] Starting subtest: psr-sprite-plane-onoff
[446.500667] Starting dynamic subtest: eDP-1
[448.219327] Dynamic subtest eDP-1: SUCCESS (1.722s)
[448.221832] Subtest psr-sprite-plane-onoff: SUCCESS (1.723s)
[449.038205] [122/131] (580s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[449.142699] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[454.439057] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (5.297s)
[454.556786] [123/131] (575s left) syncobj_wait (invalid-reset-illegal-handle)
[454.616401] Starting subtest: invalid-reset-illegal-handle
[454.618796] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[454.730018] [124/131] (575s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[454.835957] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[455.791280] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.956s)
[455.954549] [125/131] (574s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[456.045162] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[456.047526] Starting dynamic subtest: pipe-A
[456.128044] Dynamic subtest pipe-A: SUCCESS (0.083s)
[456.139033] Starting dynamic subtest: pipe-B
[457.310070] Dynamic subtest pipe-B: SUCCESS (1.181s)
[457.320775] Starting dynamic subtest: pipe-C
[458.410676] Dynamic subtest pipe-C: SUCCESS (1.099s)
[458.420819] Starting dynamic subtest: pipe-D
[459.537208] Dynamic subtest pipe-D: SUCCESS (1.126s)
[459.539475] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.493s)
[460.692197] [126/131] (569s left) gem_mmap_gtt (zero-extend)
[460.751476] Subtest zero-extend: SKIP (0.000s)
[460.801146] [127/131] (569s left) api_intel_bb (offset-control)
[460.857176] Starting subtest: offset-control
[460.863632] Subtest offset-control: SUCCESS (0.009s)
[461.009731] [128/131] (569s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[461.108424] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[461.121022] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[461.194764] [129/131] (569s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[461.249874] Starting subtest: y-tiled-to-vebox-x-tiled
[461.254227] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[461.426132] [130/131] (568s left) kms_vblank (wait-forked-hang)
[461.533722] Starting subtest: wait-forked-hang
[461.536066] Starting dynamic subtest: pipe-A-eDP-1
[488.440466] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.903s)
[488.456333] Starting dynamic subtest: pipe-D-eDP-1
[503.414420] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.971s)
[503.416844] Subtest wait-forked-hang: SUCCESS (41.879s)
[504.232983] [131/131] (526s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[509.199429] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[509.204155] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.002s)
[510.034333] Closing watchdogs
Done.