[58.234197] Initializing watchdogs
[58.234243]   /dev/watchdog0
[58.247905] [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]
[58.252584] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.255095] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.258457] [001/132] (960s left) kms_flip (flip-vs-expired-vblank)
[58.387861] Starting subtest: flip-vs-expired-vblank
[58.390287] Starting dynamic subtest: A-eDP1
[67.125626] Dynamic subtest A-eDP1: SUCCESS (8.740s)
[67.133195] Starting dynamic subtest: B-eDP1
[75.858930] Dynamic subtest B-eDP1: SUCCESS (8.732s)
[75.867845] Starting dynamic subtest: C-eDP1
[84.563281] Dynamic subtest C-eDP1: SUCCESS (8.703s)
[84.570077] Starting dynamic subtest: D-eDP1
[93.188186] Dynamic subtest D-eDP1: SUCCESS (8.623s)
[93.190699] Subtest flip-vs-expired-vblank: SUCCESS (34.805s)
[94.380937] [002/132] (924s left) gem_exec_whisper (basic-contexts-forked)
[94.461951] Starting subtest: basic-contexts-forked
[119.283524] Subtest basic-contexts-forked: SUCCESS (24.820s)
[119.494629] [003/132] (899s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[119.604113] Starting subtest: 4-tiled-16bpp-rotate-0
[120.970158] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.365s)
[121.127584] [004/132] (897s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[121.231358] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[122.243103] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.012s)
[122.418791] [005/132] (896s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[122.479065] Starting subtest: etime-multi-wait-for-submit-submitted
[122.584617] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.103s)
[122.678150] [006/132] (896s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[122.780525] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[122.784857] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[122.920303] [007/132] (896s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[122.977979] Starting subtest: multi-wait-all-for-submit-signaled
[122.980465] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[123.108996] [008/132] (895s left) core_setmaster (master-drop-set-user)
[123.216617] Starting subtest: master-drop-set-user
[123.230967] Subtest master-drop-set-user: SUCCESS (0.015s)
[123.269716] [009/132] (895s left) kms_pm_rpm (system-suspend-idle)
[124.991577] Starting subtest: system-suspend-idle
[144.870997] Subtest system-suspend-idle: SUCCESS (8.224s)
[145.253420] [010/132] (873s left) gem_exec_schedule (pi-ringfull)
[145.455437] Starting subtest: pi-ringfull
[145.457971] Starting dynamic subtest: rcs0
[145.568636] Dynamic subtest rcs0: SUCCESS (0.116s)
[145.581093] Starting dynamic subtest: bcs0
[145.595219] Dynamic subtest bcs0: SUCCESS (0.026s)
[145.605876] Starting dynamic subtest: vcs0
[145.622666] Dynamic subtest vcs0: SUCCESS (0.027s)
[145.634842] Starting dynamic subtest: vcs1
[145.649732] Dynamic subtest vcs1: SUCCESS (0.027s)
[145.661290] Starting dynamic subtest: vecs0
[145.677091] Dynamic subtest vecs0: SUCCESS (0.027s)
[145.688355] Starting dynamic subtest: ccs0
[145.704555] Dynamic subtest ccs0: SUCCESS (0.027s)
[145.706953] Subtest pi-ringfull: SUCCESS (0.252s)
[145.918112] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[145.921543] [011/132] (873s left) kms_flip (bo-too-big-interruptible)
[146.023062] Starting subtest: bo-too-big-interruptible
[146.025666] Starting dynamic subtest: A-eDP1
[147.288058] Dynamic subtest A-eDP1: SUCCESS (1.263s)
[147.297478] Starting dynamic subtest: B-eDP1
[148.537557] Dynamic subtest B-eDP1: SUCCESS (1.248s)
[148.552194] Starting dynamic subtest: C-eDP1
[149.856064] Dynamic subtest C-eDP1: SUCCESS (1.317s)
[149.866496] Starting dynamic subtest: D-eDP1
[151.099665] Dynamic subtest D-eDP1: SUCCESS (1.243s)
[151.105641] Subtest bo-too-big-interruptible: SUCCESS (5.082s)
[152.335458] [012/132] (866s left) gem_pread (exhaustion)
[152.399059] Subtest exhaustion: SKIP (0.000s)
[152.459043] [013/132] (866s left) kms_plane_scaling (2x-scaler-multi-pipe)
[152.549942] Starting subtest: 2x-scaler-multi-pipe
[152.555324] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[152.702359] [014/132] (866s left) api_intel_bb (blit-reloc-purge-cache)
[152.762065] Starting subtest: blit-reloc-purge-cache
[152.767640] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[152.921582] [015/132] (866s left) syncobj_timeline (single-wait-all-available-submitted)
[152.981185] Starting subtest: single-wait-all-available-submitted
[152.984029] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[153.108196] [016/132] (866s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[158.097817] Starting subtest: psr2-cursor-plane-move-continuous-sf
[158.100089] Starting dynamic subtest: pipe-A-eDP-1
[169.196512] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.096s)
[169.207034] Starting dynamic subtest: pipe-B-eDP-1
[180.248214] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.051s)
[180.251189] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.150s)
[181.146437] [017/132] (838s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[181.279471] Starting subtest: 2x-long-flip-vs-cursor-atomic
[181.285081] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[181.448832] [018/132] (838s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[181.553968] Starting subtest: 2x-plain-flip-ts-check-interruptible
[181.567428] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[181.690503] [019/132] (837s left) gem_exec_nop (basic-sequential)
[181.769732] Starting subtest: basic-sequential
[197.651186] Subtest basic-sequential: SUCCESS (15.895s)
[197.906486] [020/132] (821s left) gem_fence_thrash (bo-write-verify-threaded-none)
[197.952192] Starting subtest: bo-write-verify-threaded-none
[197.977372] Subtest bo-write-verify-threaded-none: SKIP (0.023s)
[198.039811] [021/132] (821s left) prime_mmap_kms (buffer-sharing)
[198.131949] Starting subtest: buffer-sharing
[198.577456] Subtest buffer-sharing: SUCCESS (0.448s)
[199.477014] [022/132] (820s left) gem_userptr_blits (stress-mm)
[199.543955] Starting subtest: stress-mm
[204.911689] Subtest stress-mm: SUCCESS (5.370s)
[205.098522] [023/132] (814s left) kms_pm_backlight (fade)
[205.202014] Starting subtest: fade
[205.251704] Starting dynamic subtest: eDP-1
[207.935219] Dynamic subtest eDP-1: SUCCESS (2.681s)
[207.938109] Subtest fade: SUCCESS (2.733s)
[208.811969] [024/132] (810s left) gem_exec_params (rs-invalid)
[208.877449] Starting subtest: rs-invalid
[208.880202] Subtest rs-invalid: SUCCESS (0.003s)
[209.032101] [025/132] (810s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[209.140055] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[209.146035] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[209.273362] [026/132] (810s left) gem_fence_thrash (bo-write-verify-none)
[209.312959] Starting subtest: bo-write-verify-none
[209.342019] Subtest bo-write-verify-none: SKIP (0.025s)
[209.407685] [027/132] (810s left) gem_workarounds (suspend-resume-context)
[209.475117] Starting subtest: suspend-resume-context
[225.643262] Subtest suspend-resume-context: SUCCESS (1.208s)
[225.816423] [028/132] (794s left) syncobj_wait (wait-all-delayed-signal)
[225.885600] Starting subtest: wait-all-delayed-signal
[225.988722] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[226.086449] [029/132] (793s left) gem_softpin (evict-active-interruptible)
[226.158381] Starting subtest: evict-active-interruptible
[226.163444] Subtest evict-active-interruptible: SUCCESS (0.008s)
[226.311964] [030/132] (793s left) i915_query (query-regions-garbage-items)
[226.366383] Starting subtest: query-regions-garbage-items
[226.368707] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[226.498190] [031/132] (793s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[226.583816] Starting subtest: compare-crc-sanitycheck-xr24
[226.586111] Starting dynamic subtest: pipe-A-eDP-1
[227.171567] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.588s)
[227.187799] Starting dynamic subtest: pipe-B-eDP-1
[228.485460] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.313s)
[228.495088] Starting dynamic subtest: pipe-C-eDP-1
[229.757940] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.271s)
[229.767814] Starting dynamic subtest: pipe-D-eDP-1
[230.981590] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.224s)
[230.983982] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.400s)
[231.847774] [032/132] (788s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[231.934966] Starting subtest: fbc-psr2-primary-mmap-gtt
[231.937229] Starting dynamic subtest: eDP-1
[231.941727] Dynamic subtest eDP-1: SKIP (0.000s)
[231.946252] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[232.030497] [033/132] (788s left) gem_ctx_exec (basic-nohangcheck)
[232.079730] Starting subtest: basic-nohangcheck
[232.329657] Subtest basic-nohangcheck: SUCCESS (0.251s)
[232.490090] [034/132] (787s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[232.563548] Starting subtest: x-tiled-to-vebox-yf-tiled
[232.567636] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[232.768035] [035/132] (787s left) i915_drm_fdinfo (virtual-busy)
[232.803696] Starting subtest: virtual-busy
[232.808340] Subtest virtual-busy: SKIP (0.000s)
[232.884427] [036/132] (787s left) prime_vgem (busy)
[232.968251] Starting subtest: busy
[232.970638] Starting dynamic subtest: rcs0
[233.035737] Dynamic subtest rcs0: SUCCESS (0.067s)
[233.044259] Starting dynamic subtest: bcs0
[233.104068] Dynamic subtest bcs0: SUCCESS (0.068s)
[233.112364] Starting dynamic subtest: vcs0
[233.147989] Dynamic subtest vcs0: SUCCESS (0.043s)
[233.156432] Starting dynamic subtest: vcs1
[233.194678] Dynamic subtest vcs1: SUCCESS (0.046s)
[233.203115] Starting dynamic subtest: vecs0
[233.240589] Dynamic subtest vecs0: SUCCESS (0.045s)
[233.249008] Starting dynamic subtest: ccs0
[233.287924] Dynamic subtest ccs0: SUCCESS (0.047s)
[233.290194] Subtest busy: SUCCESS (0.320s)
[233.453452] [037/132] (786s left) kms_big_fb (linear-16bpp-rotate-180)
[233.547925] Starting subtest: linear-16bpp-rotate-180
[234.948249] Subtest linear-16bpp-rotate-180: SUCCESS (1.403s)
[235.124685] [038/132] (785s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[235.213903] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[235.215670] Starting dynamic subtest: pipe-A-default-mode
[235.508083] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[235.512807] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.291s)
[236.361646] [039/132] (784s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[236.456771] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[236.459218] Starting dynamic subtest: pipe-A-eDP-1
[236.611157] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.148s)
[236.621771] Starting dynamic subtest: pipe-B-eDP-1
[236.641917] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[236.652322] Starting dynamic subtest: pipe-C-eDP-1
[236.672258] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[236.680732] Starting dynamic subtest: pipe-D-eDP-1
[236.700137] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[236.702307] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.182s)
[238.922205] [040/132] (781s left) gem_softpin (evict-prime)
[238.994431] Starting subtest: evict-prime
[238.996783] Starting dynamic subtest: rcs0
[240.179806] Dynamic subtest rcs0: SUCCESS (1.185s)
[240.191200] Starting dynamic subtest: bcs0
[241.321864] Dynamic subtest bcs0: SUCCESS (1.141s)
[241.332732] Starting dynamic subtest: vcs0
[242.516517] Dynamic subtest vcs0: SUCCESS (1.191s)
[242.528357] Starting dynamic subtest: vcs1
[244.517155] Dynamic subtest vcs1: SUCCESS (2.000s)
[244.528423] Starting dynamic subtest: vecs0
[246.511038] Dynamic subtest vecs0: SUCCESS (1.992s)
[246.522328] Starting dynamic subtest: ccs0
[247.648131] Dynamic subtest ccs0: SUCCESS (1.136s)
[247.664180] Starting dynamic subtest: all
[249.507852] Dynamic subtest all: SUCCESS (1.858s)
[249.510292] Subtest evict-prime: SUCCESS (10.513s)
[249.610086] [041/132] (770s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[249.726173] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[256.393149] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.668s)
[256.545911] [042/132] (763s left) kms_plane_alpha_blend (alpha-opaque-fb)
[256.643246] Starting subtest: alpha-opaque-fb
[256.933019] Starting dynamic subtest: pipe-A-eDP-1
[257.589071] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.654s)
[257.598074] Starting dynamic subtest: pipe-D-eDP-1
[258.947620] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.358s)
[258.949851] Subtest alpha-opaque-fb: SUCCESS (2.306s)
[259.787512] [043/132] (760s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[259.902459] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[259.906721] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[260.036504] [044/132] (760s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[260.145082] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[260.147380] Starting dynamic subtest: pipe-A-eDP-1
[260.173056] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[260.183340] Starting dynamic subtest: pipe-B-eDP-1
[260.206868] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[260.214592] Starting dynamic subtest: pipe-C-eDP-1
[260.237936] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[260.245622] Starting dynamic subtest: pipe-D-eDP-1
[260.269203] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[260.273538] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[262.459490] [045/132] (758s left) perf_pmu (busy-accuracy-2)
[262.502153] Starting subtest: busy-accuracy-2
[262.504325] Starting dynamic subtest: rcs0
[265.545659] Dynamic subtest rcs0: SUCCESS (3.041s)
[265.557698] Starting dynamic subtest: bcs0
[268.604327] Dynamic subtest bcs0: SUCCESS (3.057s)
[268.615328] Starting dynamic subtest: vcs0
[271.650833] Dynamic subtest vcs0: SUCCESS (3.044s)
[271.662045] Starting dynamic subtest: vcs1
[274.696311] Dynamic subtest vcs1: SUCCESS (3.043s)
[274.707944] Starting dynamic subtest: vecs0
[277.743790] Dynamic subtest vecs0: SUCCESS (3.046s)
[277.754648] Starting dynamic subtest: ccs0
[280.799786] Dynamic subtest ccs0: SUCCESS (3.054s)
[280.802215] Subtest busy-accuracy-2: SUCCESS (18.297s)
[280.958465] [046/132] (739s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[281.016914] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[281.019164] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[281.170292] [047/132] (739s left) kms_content_protection (srm)
[281.307777] Starting subtest: srm
[281.314975] Subtest srm: SKIP (0.003s)
[281.468261] [048/132] (739s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[281.571908] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[281.574110] Starting dynamic subtest: pipe-A-eDP-1
[281.597675] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[281.609675] Starting dynamic subtest: pipe-B-eDP-1
[281.630839] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[281.639826] Starting dynamic subtest: pipe-C-eDP-1
[281.661209] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[281.669873] Starting dynamic subtest: pipe-D-eDP-1
[281.691763] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[281.695908] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[283.928638] [049/132] (736s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[284.043426] Starting subtest: psr-rgb565-draw-mmap-gtt
[284.047876] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[284.183003] [050/132] (736s left) kms_cursor_crc (cursor-onscreen-32x10)
[284.345580] Starting subtest: cursor-onscreen-32x10
[284.403311] Subtest cursor-onscreen-32x10: SKIP (0.053s)
[284.685209] [051/132] (736s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[284.786509] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[291.805097] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.020s)
[291.956237] [052/132] (728s left) gem_ctx_bad_destroy (double-destroy)
[292.020382] Starting subtest: double-destroy
[292.022799] Subtest double-destroy: SUCCESS (0.000s)
[292.123196] [053/132] (728s left) gem_lmem_swapping (basic)
[292.164346] Subtest basic: SKIP (0.000s)
[292.216228] [054/132] (728s left) gen9_exec_parse (bb-start-cmd)
[292.269816] Subtest bb-start-cmd: SKIP (0.000s)
[292.335811] [055/132] (728s left) sw_sync (sync_multi_timeline_wait)
[292.375178] Starting subtest: sync_multi_timeline_wait
[292.377306] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[292.465924] [056/132] (728s left) i915_pm_rc6_residency (rc6-accuracy)
[292.526265] Starting subtest: rc6-accuracy
[292.528459] Starting dynamic subtest: gt0
[295.698958] Dynamic subtest gt0: SUCCESS (3.170s)
[295.709056] Starting dynamic subtest: gt1
[298.869878] Dynamic subtest gt1: SUCCESS (3.168s)
[298.872542] Subtest rc6-accuracy: SUCCESS (6.343s)
[298.970821] [057/132] (722s left) api_intel_bb (simple-bb-ctx)
[299.029600] Starting subtest: simple-bb-ctx
[299.043553] Subtest simple-bb-ctx: SUCCESS (0.016s)
[299.212027] [058/132] (721s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[299.322983] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[299.327353] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[299.470254] [059/132] (721s left) kms_vblank (crtc-id)
[299.561877] Starting subtest: crtc-id
[299.564126] Starting dynamic subtest: pipe-A-eDP-1
[300.008434] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.442s)
[300.022862] Starting dynamic subtest: pipe-D-eDP-1
[301.164544] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.154s)
[301.166464] Subtest crtc-id: SUCCESS (1.600s)
[302.026165] [060/132] (719s left) gem_basic (bad-close)
[302.093389] Starting subtest: bad-close
[302.097764] Subtest bad-close: SUCCESS (0.000s)
[302.219191] [061/132] (719s left) kms_flip (dpms-vs-vblank-race-interruptible)
[302.317498] Starting subtest: dpms-vs-vblank-race-interruptible
[302.319886] Starting dynamic subtest: A-eDP1
[307.289475] Dynamic subtest A-eDP1: SUCCESS (4.971s)
[307.298795] Starting dynamic subtest: B-eDP1
[311.919468] Dynamic subtest B-eDP1: SUCCESS (4.626s)
[311.929233] Starting dynamic subtest: C-eDP1
[316.536217] Dynamic subtest C-eDP1: SUCCESS (4.616s)
[316.545429] Starting dynamic subtest: D-eDP1
[320.053406] Dynamic subtest D-eDP1: SUCCESS (3.516s)
[320.055567] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.738s)
[320.934042] [062/132] (700s left) kms_vblank (wait-forked-busy)
[321.032871] Starting subtest: wait-forked-busy
[321.034716] Starting dynamic subtest: pipe-A-eDP-1
[322.905738] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[322.920124] Starting dynamic subtest: pipe-D-eDP-1
[325.455780] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.545s)
[325.458140] Subtest wait-forked-busy: SUCCESS (4.423s)
[326.278919] [063/132] (695s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[326.384067] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[326.388108] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[326.526202] [064/132] (694s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[326.616528] Starting subtest: 4-tiled-64bpp-rotate-180
[328.118015] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.502s)
[328.405984] [065/132] (693s left) kms_flip (absolute-wf_vblank-interruptible)
[328.513185] Starting subtest: absolute-wf_vblank-interruptible
[328.515474] Starting dynamic subtest: A-eDP1
[337.221807] Dynamic subtest A-eDP1: SUCCESS (8.700s)
[337.233440] Starting dynamic subtest: B-eDP1
[345.947377] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[345.957829] Starting dynamic subtest: C-eDP1
[354.672334] Dynamic subtest C-eDP1: SUCCESS (8.723s)
[354.686373] Starting dynamic subtest: D-eDP1
[363.396391] Dynamic subtest D-eDP1: SUCCESS (8.722s)
[363.401675] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.885s)
[364.634393] [066/132] (656s left) gem_exec_flush (basic-uc-prw-default)
[364.708410] Starting subtest: basic-uc-prw-default
[370.164674] Subtest basic-uc-prw-default: SUCCESS (5.457s)
[370.376091] [067/132] (651s left) vgem_basic (busy-fence)
[370.415440] Starting subtest: busy-fence
[370.417543] Subtest busy-fence: SUCCESS (0.000s)
[370.500500] [068/132] (651s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[370.619326] Starting subtest: psr-rgb565-draw-render
[377.676196] Subtest psr-rgb565-draw-render: SUCCESS (7.056s)
[377.832916] [069/132] (643s left) kms_dp_link_training (uhbr-sst)
[377.924616] Starting subtest: uhbr-sst
[377.932829] Subtest uhbr-sst: SKIP (0.000s)
[378.020203] [070/132] (643s left) kms_universal_plane (disable-primary-vs-flip)
[378.114696] Starting subtest: disable-primary-vs-flip
[378.116899] Starting dynamic subtest: pipe-A-eDP-1
[379.678296] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.563s)
[379.687600] Starting dynamic subtest: pipe-B-eDP-1
[381.872579] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.193s)
[381.882234] Starting dynamic subtest: pipe-C-eDP-1
[384.117538] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.243s)
[384.129701] Starting dynamic subtest: pipe-D-eDP-1
[386.267687] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.148s)
[386.269579] Subtest disable-primary-vs-flip: SUCCESS (8.152s)
[387.091365] [071/132] (634s left) gem_exec_balancer (invalid-balancer)
[387.174079] Starting subtest: invalid-balancer
[388.060710] Subtest invalid-balancer: SUCCESS (0.886s)
[388.398297] [072/132] (633s left) gem_mmap_offset (bad-extensions)
[388.456945] Starting subtest: bad-extensions
[388.458831] Subtest bad-extensions: SUCCESS (0.000s)
[388.593319] [073/132] (633s left) kms_atomic_transition (plane-all-transition)
[388.695894] Starting subtest: plane-all-transition
[388.698168] Starting dynamic subtest: pipe-A-eDP-1
[391.190756] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[391.509462] Starting dynamic subtest: pipe-B-eDP-1
[394.711237] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.211s)
[395.026609] Subtest plane-all-transition: SUCCESS (6.329s)
[395.862448] [074/132] (626s left) kms_rotation_crc (multiplane-rotation)
[395.947191] Starting subtest: multiplane-rotation
[413.360526] Subtest multiplane-rotation: SUCCESS (17.416s)
[413.526712] [075/132] (608s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[413.628876] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[413.632570] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[413.767543] [076/132] (608s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[418.707350] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[418.709980] Starting dynamic subtest: pipe-A-eDP-1
[419.505281] Dynamic subtest pipe-A-eDP-1: SKIP (0.797s)
[419.515311] Starting dynamic subtest: pipe-B-eDP-1
[420.637152] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s)
[420.641644] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.930s)
[421.873046] [077/132] (600s left) kms_psr (pr-sprite-blt)
[421.977329] Starting subtest: pr-sprite-blt
[421.981868] Subtest pr-sprite-blt: SKIP (0.000s)
[422.074816] [078/132] (600s left) kms_psr (pr-cursor-render)
[422.183357] Starting subtest: pr-cursor-render
[422.187441] Subtest pr-cursor-render: SKIP (0.000s)
[422.276597] [079/132] (599s left) syncobj_wait (single-wait-all-signaled)
[422.342438] Starting subtest: single-wait-all-signaled
[422.344861] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[422.481914] [080/132] (599s left) kms_chamelium_hpd (dp-hpd-storm)
[422.888584] Subtest dp-hpd-storm: SKIP (0.000s)
[423.735331] [081/132] (598s left) gem_mmap_gtt (basic-write-gtt)
[423.790614] Subtest basic-write-gtt: SKIP (0.000s)
[423.851874] [082/132] (598s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[423.945831] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[423.948103] Starting dynamic subtest: pipe-A
[424.317299] Dynamic subtest pipe-A: SUCCESS (0.373s)
[424.326912] Starting dynamic subtest: pipe-B
[425.771486] Dynamic subtest pipe-B: SUCCESS (1.452s)
[425.780811] Starting dynamic subtest: pipe-C
[427.191112] Dynamic subtest pipe-C: SUCCESS (1.419s)
[427.201717] Starting dynamic subtest: pipe-D
[428.657469] Dynamic subtest pipe-D: SUCCESS (1.464s)
[428.659977] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.715s)
[429.915345] [083/132] (592s left) gem_exec_schedule (thriceslice)
[429.995243] Starting subtest: thriceslice
[429.997759] Starting dynamic subtest: rcs0
[430.015235] Dynamic subtest rcs0: SUCCESS (0.029s)
[430.026550] Starting dynamic subtest: bcs0
[430.067298] Dynamic subtest bcs0: SUCCESS (0.051s)
[430.080152] Starting dynamic subtest: vcs0
[430.119659] Dynamic subtest vcs0: SUCCESS (0.050s)
[430.131267] Starting dynamic subtest: vcs1
[430.149804] Dynamic subtest vcs1: SUCCESS (0.028s)
[430.158991] Starting dynamic subtest: vecs0
[430.179196] Dynamic subtest vecs0: SUCCESS (0.028s)
[430.191002] Starting dynamic subtest: ccs0
[430.209822] Dynamic subtest ccs0: SUCCESS (0.030s)
[430.212130] Subtest thriceslice: SUCCESS (0.225s)
[430.533527] [084/132] (591s left) gem_exec_fence (nb-await)
[430.703713] Starting subtest: nb-await
[430.706152] Starting dynamic subtest: rcs0
[430.772295] Dynamic subtest rcs0: SUCCESS (0.068s)
[430.784242] Starting dynamic subtest: bcs0
[430.829196] Dynamic subtest bcs0: SUCCESS (0.056s)
[430.840416] Starting dynamic subtest: vcs0
[430.888647] Dynamic subtest vcs0: SUCCESS (0.057s)
[430.899828] Starting dynamic subtest: vcs1
[430.947699] Dynamic subtest vcs1: SUCCESS (0.057s)
[430.959034] Starting dynamic subtest: vecs0
[431.006356] Dynamic subtest vecs0: SUCCESS (0.057s)
[431.018451] Starting dynamic subtest: ccs0
[431.064086] Dynamic subtest ccs0: SUCCESS (0.056s)
[431.066512] Subtest nb-await: SUCCESS (0.362s)
[432.665931] [085/132] (589s left) gem_userptr_blits (set-cache-level)
[432.723993] Starting subtest: set-cache-level
[432.728558] Subtest set-cache-level: SKIP (0.000s)
[432.884545] [086/132] (589s left) gem_ctx_persistence (hang)
[432.962000] Starting subtest: hang
[432.966553] Subtest hang: SKIP (0.000s)
[433.094824] [087/132] (589s left) kms_psr (psr-cursor-mmap-gtt)
[433.197202] Starting subtest: psr-cursor-mmap-gtt
[433.199802] Starting dynamic subtest: eDP-1
[434.885034] Dynamic subtest eDP-1: SUCCESS (1.688s)
[434.886906] Subtest psr-cursor-mmap-gtt: SUCCESS (1.689s)
[435.771344] [088/132] (586s left) gem_eio (in-flight-contexts-immediate)
[436.003382] Starting subtest: in-flight-contexts-immediate
[447.533314] Subtest in-flight-contexts-immediate: SUCCESS (11.528s)
[447.727801] [089/132] (574s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[447.833979] Starting subtest: basic-modeset-with-all-modifiers-formats
[448.206581] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[449.018602] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.813s)
[449.029567] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[449.041055] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[449.050132] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[449.063414] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[449.072525] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[449.207798] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.144s)
[449.217142] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[449.229882] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[449.238853] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[449.252226] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[449.261450] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[449.274409] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[449.283542] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[449.296364] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[449.311134] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[449.319075] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[449.333398] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[449.341168] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[449.355659] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[449.363320] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[449.374038] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[449.385192] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[449.394320] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[449.541017] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[449.551185] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[449.563266] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[449.572356] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[449.585580] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[449.594710] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[449.607778] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[449.616806] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[449.629880] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[449.639036] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[449.652305] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[449.663197] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[449.674300] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[449.683300] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[449.696668] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[449.705425] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[449.718783] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[449.727453] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[449.874815] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[449.884584] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[449.897177] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[449.906140] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[449.919234] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[449.928499] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[449.941429] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[449.950097] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[449.963679] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[449.972427] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[449.985939] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[449.994830] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[450.007938] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s)
[450.016626] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[450.029922] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[450.038584] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[450.052200] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[450.436061] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.605s)
[451.216282] [090/132] (571s left) kms_color (ctm-max)
[451.322813] Starting subtest: ctm-max
[451.325028] Starting dynamic subtest: pipe-A-eDP-1
[452.019697] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.698s)
[452.039740] Starting dynamic subtest: pipe-B-eDP-1
[453.416968] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.396s)
[453.426565] Starting dynamic subtest: pipe-C-eDP-1
[454.786712] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.371s)
[454.796812] Starting dynamic subtest: pipe-D-eDP-1
[456.125235] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[456.127553] Subtest ctm-max: SUCCESS (4.803s)
[456.947844] [091/132] (565s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[457.052966] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[461.309160] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.260s)
[462.459141] [092/132] (560s left) gem_render_copy (linear)
[462.520260] Starting subtest: linear
[462.522625] Starting dynamic subtest: smem
[462.561440] Dynamic subtest smem: SUCCESS (0.040s)
[462.564265] Subtest linear: SUCCESS (0.041s)
[462.829388] [093/132] (559s left) gem_userptr_blits (access-control)
[462.905293] Starting subtest: access-control
[462.909842] Subtest access-control: SKIP (0.000s)
[463.044916] [094/132] (559s left) kms_flip (2x-nonexisting-fb)
[463.141300] Starting subtest: 2x-nonexisting-fb
[463.149953] Subtest 2x-nonexisting-fb: SKIP (0.011s)
[463.302537] [095/132] (559s left) gem_ccs (block-copy-compressed)
[463.356010] Starting subtest: block-copy-compressed
[463.360311] Subtest block-copy-compressed: SKIP (0.000s)
[463.485542] [096/132] (559s left) prime_mmap (test_invalid_sync_flags)
[463.542667] Starting subtest: test_invalid_sync_flags
[463.544972] Starting dynamic subtest: test_invalid_sync_flags-smem
[463.547261] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[463.549534] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[463.661077] [097/132] (559s left) gem_exec_params (invalid-bsd-ring)
[463.731416] Starting subtest: invalid-bsd-ring
[463.733433] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[463.852565] [098/132] (559s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[463.957081] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[470.675282] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.719s)
[470.848633] [099/132] (552s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[470.957869] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[470.961992] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[471.084078] [100/132] (551s left) kms_plane (planar-pixel-format-settings)
[471.180792] Starting subtest: planar-pixel-format-settings
[471.220936] Subtest planar-pixel-format-settings: SUCCESS (0.042s)
[471.321923] [101/132] (551s left) syncobj_timeline (wait-for-submit-delayed-submit)
[471.373684] Starting subtest: wait-for-submit-delayed-submit
[471.474633] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[471.582428] [102/132] (551s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[471.895005] Starting subtest: cursor-rapid-movement-max-size
[471.901661] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[472.070711] [103/132] (551s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[472.196226] Starting subtest: modeset-atomic-cursor-hotspot
[472.200840] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[472.369183] [104/132] (550s left) gem_exec_balancer (parallel-keep-submit-fence)
[472.629472] Starting subtest: parallel-keep-submit-fence
[473.827534] Subtest parallel-keep-submit-fence: SUCCESS (1.198s)
[473.973557] [105/132] (549s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[474.354282] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[475.149193] [106/132] (548s left) kms_getfb (getfb-addfb-different-handles)
[475.241929] Starting subtest: getfb-addfb-different-handles
[475.244119] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[475.375767] [107/132] (547s left) gem_ctx_sseu (invalid-args)
[475.443265] Subtest invalid-args: SKIP (0.000s)
[475.519476] [108/132] (547s left) gem_lmem_swapping (parallel-random-verify)
[475.565020] Subtest parallel-random-verify: SKIP (0.000s)
[475.610983] [109/132] (547s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[475.701027] Starting subtest: psr-2p-primscrn-spr-indfb-move
[475.704887] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[475.835249] [110/132] (547s left) gem_exec_reloc (basic-write-cpu-noreloc)
[475.901552] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[475.978764] [111/132] (547s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[476.028530] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[476.030755] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[476.170222] [112/132] (547s left) i915_hangman (gt-engine-hang)
[476.233285] Starting subtest: gt-engine-hang
[476.234928] Starting dynamic subtest: rcs0
[477.485626] Dynamic subtest rcs0: SUCCESS (1.252s)
[477.498219] Starting dynamic subtest: bcs0
[479.468549] Dynamic subtest bcs0: SUCCESS (1.980s)
[479.481417] Starting dynamic subtest: vcs0
[481.516223] Dynamic subtest vcs0: SUCCESS (2.044s)
[481.529031] Starting dynamic subtest: vcs1
[483.500013] Dynamic subtest vcs1: SUCCESS (1.981s)
[483.515655] Starting dynamic subtest: vecs0
[485.484564] Dynamic subtest vecs0: SUCCESS (1.981s)
[485.496891] Starting dynamic subtest: ccs0
[487.468607] Dynamic subtest ccs0: SUCCESS (1.981s)
[487.471573] Subtest gt-engine-hang: SUCCESS (11.236s)
[487.575664] [113/132] (536s left) gem_mmap (bad-object)
[487.636873] Subtest bad-object: SKIP (0.000s)
[487.710884] [114/132] (535s left) kms_feature_discovery (psr1)
[487.818810] Starting subtest: psr1
[487.821098] Subtest psr1: SUCCESS (0.000s)
[487.919139] [115/132] (535s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[488.017544] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[494.840356] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.825s)
[495.039476] [116/132] (528s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[495.146162] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[495.150537] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[495.262390] [117/132] (528s left) gem_mmap_gtt (fault-concurrent)
[495.326683] Subtest fault-concurrent: SKIP (0.000s)
[495.393870] [118/132] (528s left) kms_pm_rpm (legacy-planes-dpms)
[497.626691] Starting subtest: legacy-planes-dpms
[497.629346] Starting dynamic subtest: plane-63
[506.203294] Dynamic subtest plane-63: SUCCESS (8.579s)
[506.215529] Starting dynamic subtest: plane-93
[514.808336] Dynamic subtest plane-93: SUCCESS (8.602s)
[514.820957] Starting dynamic subtest: plane-123
[523.504206] Dynamic subtest plane-123: SUCCESS (8.692s)
[523.516966] Starting dynamic subtest: plane-133
[531.794227] Dynamic subtest plane-133: SUCCESS (8.289s)
[531.796730] Subtest legacy-planes-dpms: SUCCESS (34.171s)
[532.180877] [119/132] (491s left) kms_chamelium_color (ctm-negative)
[532.280011] Subtest ctm-negative: SKIP (0.000s)
[532.325038] [120/132] (491s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[532.420861] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[532.423143] Starting dynamic subtest: pipe-A-default-mode
[532.720412] Dynamic subtest pipe-A-default-mode: SKIP (0.297s)
[532.725295] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.298s)
[533.612498] [121/132] (490s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[533.710257] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[534.743941] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.034s)
[534.904728] [122/132] (489s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[535.002959] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[535.004927] Starting dynamic subtest: pipe-A-eDP-1
[535.012405] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[535.028311] Starting dynamic subtest: pipe-B-eDP-1
[535.036067] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[535.047132] Starting dynamic subtest: pipe-C-eDP-1
[535.054293] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[535.064969] Starting dynamic subtest: pipe-D-eDP-1
[535.071824] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[535.075214] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[537.277738] [123/132] (486s left) kms_invalid_mode (overflow-vrefresh)
[537.395078] Starting subtest: overflow-vrefresh
[537.397407] Starting dynamic subtest: pipe-A-eDP-1
[537.687839] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[537.698001] Starting dynamic subtest: pipe-B-eDP-1
[537.699936] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[537.709429] Starting dynamic subtest: pipe-C-eDP-1
[537.711645] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[537.720769] Starting dynamic subtest: pipe-D-eDP-1
[537.723023] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[537.725248] Subtest overflow-vrefresh: SUCCESS (0.299s)
[538.517561] [124/132] (485s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[538.618451] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[538.623051] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[538.754642] [125/132] (485s left) kms_psr (fbc-pr-cursor-plane-move)
[538.857051] Starting subtest: fbc-pr-cursor-plane-move
[538.861157] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[538.956432] [126/132] (485s left) prime_busy (before)
[539.017144] Starting subtest: before
[539.022653] Starting dynamic subtest: rcs0
[539.067577] Dynamic subtest rcs0: SUCCESS (0.047s)
[539.078603] Starting dynamic subtest: bcs0
[539.139800] Dynamic subtest bcs0: SUCCESS (0.071s)
[539.148844] Starting dynamic subtest: vcs0
[539.178781] Dynamic subtest vcs0: SUCCESS (0.037s)
[539.194654] Starting dynamic subtest: vcs1
[539.217391] Dynamic subtest vcs1: SUCCESS (0.039s)
[539.228267] Starting dynamic subtest: vecs0
[539.257436] Dynamic subtest vecs0: SUCCESS (0.039s)
[539.267963] Starting dynamic subtest: ccs0
[539.297296] Dynamic subtest ccs0: SUCCESS (0.039s)
[539.406505] Subtest before: SUCCESS (0.387s)
[539.505101] [127/132] (484s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[539.611100] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[539.615193] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[539.750560] [128/132] (484s left) kms_hdr (invalid-metadata-sizes)
[539.851929] Starting subtest: invalid-metadata-sizes
[539.858134] Subtest invalid-metadata-sizes: SKIP (0.000s)
[539.958418] [129/132] (484s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[540.026348] Starting subtest: y-tiled-ccs-to-yf-tiled
[540.030899] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[540.232792] [130/132] (484s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[540.331225] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[547.258805] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.928s)
[547.419118] [131/132] (476s left) gem_userptr_blits (unsync-unmap)
[547.490151] Subtest unsync-unmap: SKIP (0.000s)
[547.662141] [132/132] (476s left) gem_ccs (suspend-resume)
[547.720366] Starting subtest: suspend-resume
[547.724978] Subtest suspend-resume: SKIP (0.000s)
[547.863651] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: gem_exec_whisper
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: core_setmaster
results: parsing output: 8/ for test: kms_pm_rpm
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: gem_pread
results: parsing output: 12/ for test: kms_plane_scaling
results: parsing output: 13/ for test: api_intel_bb
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: gem_exec_nop
results: parsing output: 19/ for test: gem_fence_thrash
results: parsing output: 20/ for test: prime_mmap_kms
results: parsing output: 21/ for test: gem_userptr_blits
results: parsing output: 22/ for test: kms_pm_backlight
results: parsing output: 23/ for test: gem_exec_params
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_fence_thrash
results: parsing output: 26/ for test: gem_workarounds
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: gem_softpin
results: parsing output: 29/ for test: i915_query
results: parsing output: 30/ for test: kms_pipe_crc_basic
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: gem_ctx_exec
results: parsing output: 33/ for test: gem_render_copy
results: parsing output: 34/ for test: i915_drm_fdinfo
results: parsing output: 35/ for test: prime_vgem
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_flip_scaled_crc
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_plane_alpha_blend
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: kms_content_protection
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_ctx_bad_destroy
results: parsing output: 52/ for test: gem_lmem_swapping
results: parsing output: 53/ for test: gen9_exec_parse
results: parsing output: 54/ for test: sw_sync
results: parsing output: 55/ for test: i915_pm_rc6_residency
results: parsing output: 56/ for test: api_intel_bb
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_vblank
results: parsing output: 59/ for test: gem_basic
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: kms_vblank
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: gem_exec_flush
results: parsing output: 66/ for test: vgem_basic
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_dp_link_training
results: parsing output: 69/ for test: kms_universal_plane
results: parsing output: 70/ for test: gem_exec_balancer
results: parsing output: 71/ for test: gem_mmap_offset
results: parsing output: 72/ for test: kms_atomic_transition
results: parsing output: 73/ for test: kms_rotation_crc
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: kms_chamelium_hpd
results: parsing output: 80/ for test: gem_mmap_gtt
results: parsing output: 81/ for test: kms_plane_scaling
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: gem_exec_fence
results: parsing output: 84/ for test: gem_userptr_blits
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: gem_eio
results: parsing output: 88/ for test: kms_async_flips
results: parsing output: 89/ for test: kms_color
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_render_copy
results: parsing output: 92/ for test: gem_userptr_blits
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: gem_ccs
results: parsing output: 95/ for test: prime_mmap
results: parsing output: 96/ for test: gem_exec_params
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_plane
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: gem_exec_balancer
results: parsing output: 104/ for test: kms_chamelium_frames
results: parsing output: 105/ for test: kms_getfb
results: parsing output: 106/ for test: gem_ctx_sseu
results: parsing output: 107/ for test: gem_lmem_swapping
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_exec_reloc
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: i915_hangman
results: parsing output: 112/ for test: gem_mmap
results: parsing output: 113/ for test: kms_feature_discovery
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: kms_pm_rpm
results: parsing output: 118/ for test: kms_chamelium_color
results: parsing output: 119/ for test: kms_flip_scaled_crc
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: kms_invalid_mode
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: prime_busy
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_hdr
results: parsing output: 128/ for test: gem_render_copy
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_userptr_blits
results: parsing output: 131/ for test: gem_ccs
Done.