[63.819391] Initializing watchdogs
[63.819441]   /dev/watchdog0
[63.836093] [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]
[63.840573] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.842929] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.846412] [001/132] (960s left) kms_flip (flip-vs-expired-vblank)
[63.975267] Starting subtest: flip-vs-expired-vblank
[63.977601] Starting dynamic subtest: A-eDP1
[72.717860] Dynamic subtest A-eDP1: SUCCESS (8.735s)
[72.725136] Starting dynamic subtest: B-eDP1
[81.362021] Dynamic subtest B-eDP1: SUCCESS (8.639s)
[81.374015] Starting dynamic subtest: C-eDP1
[90.091175] Dynamic subtest C-eDP1: SUCCESS (8.726s)
[90.103435] Starting dynamic subtest: D-eDP1
[98.728451] Dynamic subtest D-eDP1: SUCCESS (8.635s)
[98.732640] Subtest flip-vs-expired-vblank: SUCCESS (34.745s)
[100.142965] [002/132] (924s left) gem_exec_whisper (basic-contexts-forked)
[100.213071] Starting subtest: basic-contexts-forked
[123.683850] Subtest basic-contexts-forked: SUCCESS (23.468s)
[123.890340] [003/132] (900s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[123.994782] Starting subtest: 4-tiled-16bpp-rotate-0
[125.261338] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.267s)
[125.429367] [004/132] (899s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[125.537677] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[126.551970] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.015s)
[126.730249] [005/132] (897s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[126.799344] Starting subtest: etime-multi-wait-for-submit-submitted
[126.904793] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.103s)
[127.001195] [006/132] (897s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[127.103471] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[127.107802] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[127.226113] [007/132] (897s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[127.288994] Starting subtest: multi-wait-all-for-submit-signaled
[127.291259] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[127.419937] [008/132] (897s left) core_setmaster (master-drop-set-user)
[127.518787] Starting subtest: master-drop-set-user
[127.530505] Subtest master-drop-set-user: SUCCESS (0.014s)
[127.568030] [009/132] (897s left) kms_pm_rpm (system-suspend-idle)
[129.099199] Starting subtest: system-suspend-idle
[148.225449] Subtest system-suspend-idle: SUCCESS (8.093s)
[148.613733] [010/132] (876s left) gem_exec_schedule (pi-ringfull)
[148.818490] Starting subtest: pi-ringfull
[148.820346] Starting dynamic subtest: rcs0
[148.912251] Dynamic subtest rcs0: SUCCESS (0.095s)
[148.924915] Starting dynamic subtest: bcs0
[148.938835] Dynamic subtest bcs0: SUCCESS (0.026s)
[148.952012] Starting dynamic subtest: vcs0
[148.965229] Dynamic subtest vcs0: SUCCESS (0.026s)
[148.978940] Starting dynamic subtest: vcs1
[148.993265] Dynamic subtest vcs1: SUCCESS (0.028s)
[149.005892] Starting dynamic subtest: vecs0
[149.022159] Dynamic subtest vecs0: SUCCESS (0.028s)
[149.035039] Starting dynamic subtest: ccs0
[149.048125] Dynamic subtest ccs0: SUCCESS (0.026s)
[149.050331] Subtest pi-ringfull: SUCCESS (0.231s)
[149.298509] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[149.301611] [011/132] (875s left) kms_flip (bo-too-big-interruptible)
[149.387260] Starting subtest: bo-too-big-interruptible
[149.389592] Starting dynamic subtest: A-eDP1
[150.648985] Dynamic subtest A-eDP1: SUCCESS (1.254s)
[150.658195] Starting dynamic subtest: B-eDP1
[151.880573] Dynamic subtest B-eDP1: SUCCESS (1.227s)
[151.888988] Starting dynamic subtest: C-eDP1
[153.124404] Dynamic subtest C-eDP1: SUCCESS (1.238s)
[153.134900] Starting dynamic subtest: D-eDP1
[154.363218] Dynamic subtest D-eDP1: SUCCESS (1.233s)
[154.365510] Subtest bo-too-big-interruptible: SUCCESS (4.960s)
[155.601876] [012/132] (869s left) gem_pread (exhaustion)
[155.690477] Subtest exhaustion: SKIP (0.000s)
[155.765447] [013/132] (869s left) kms_plane_scaling (2x-scaler-multi-pipe)
[155.880228] Starting subtest: 2x-scaler-multi-pipe
[155.884678] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[155.997976] [014/132] (868s left) api_intel_bb (blit-reloc-purge-cache)
[156.069378] Starting subtest: blit-reloc-purge-cache
[156.074001] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[156.226212] [015/132] (868s left) syncobj_timeline (single-wait-all-available-submitted)
[156.293111] Starting subtest: single-wait-all-available-submitted
[156.295055] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[156.426109] [016/132] (868s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[161.483981] Starting subtest: psr2-cursor-plane-move-continuous-sf
[161.486233] Starting dynamic subtest: pipe-A-eDP-1
[172.569319] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.073s)
[172.579713] Starting dynamic subtest: pipe-B-eDP-1
[183.596600] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.025s)
[183.598992] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.102s)
[184.416065] [017/132] (840s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[184.539837] Starting subtest: 2x-long-flip-vs-cursor-atomic
[184.544490] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[184.711627] [018/132] (840s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[184.820154] Starting subtest: 2x-plain-flip-ts-check-interruptible
[184.832630] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[184.980791] [019/132] (840s left) gem_exec_nop (basic-sequential)
[185.067099] Starting subtest: basic-sequential
[199.399564] Subtest basic-sequential: SUCCESS (14.342s)
[199.672207] [020/132] (825s left) gem_fence_thrash (bo-write-verify-threaded-none)
[199.713063] Starting subtest: bo-write-verify-threaded-none
[199.737879] Subtest bo-write-verify-threaded-none: SKIP (0.024s)
[199.805399] [021/132] (825s left) prime_mmap_kms (buffer-sharing)
[199.900641] Starting subtest: buffer-sharing
[200.351713] Subtest buffer-sharing: SUCCESS (0.449s)
[201.233772] [022/132] (823s left) gem_userptr_blits (stress-mm)
[201.303292] Starting subtest: stress-mm
[206.673694] Subtest stress-mm: SUCCESS (5.370s)
[206.870273] [023/132] (818s left) kms_pm_backlight (fade)
[206.973322] Starting subtest: fade
[207.022830] Starting dynamic subtest: eDP-1
[209.709089] Dynamic subtest eDP-1: SUCCESS (2.683s)
[209.711460] Subtest fade: SUCCESS (2.735s)
[210.582531] [024/132] (814s left) gem_exec_params (rs-invalid)
[210.636182] Starting subtest: rs-invalid
[210.638558] Subtest rs-invalid: SUCCESS (0.003s)
[210.802191] [025/132] (814s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[210.914012] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[210.918362] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[211.053261] [026/132] (814s left) gem_fence_thrash (bo-write-verify-none)
[211.092527] Starting subtest: bo-write-verify-none
[211.119619] Subtest bo-write-verify-none: SKIP (0.024s)
[211.194158] [027/132] (814s left) gem_workarounds (suspend-resume-context)
[211.268212] Starting subtest: suspend-resume-context
[226.988117] Subtest suspend-resume-context: SUCCESS (1.917s)
[227.159124] [028/132] (798s left) syncobj_wait (wait-all-delayed-signal)
[227.227656] Starting subtest: wait-all-delayed-signal
[227.331278] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[227.435480] [029/132] (798s left) gem_softpin (evict-active-interruptible)
[227.500270] Starting subtest: evict-active-interruptible
[227.504825] Subtest evict-active-interruptible: SUCCESS (0.007s)
[227.626061] [030/132] (797s left) i915_query (query-regions-garbage-items)
[227.675520] Starting subtest: query-regions-garbage-items
[227.677478] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[227.802212] [031/132] (797s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[227.900915] Starting subtest: compare-crc-sanitycheck-xr24
[227.903402] Starting dynamic subtest: pipe-A-eDP-1
[228.509205] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.607s)
[228.518583] Starting dynamic subtest: pipe-B-eDP-1
[229.725018] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.206s)
[229.735446] Starting dynamic subtest: pipe-C-eDP-1
[230.919486] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.187s)
[230.929162] Starting dynamic subtest: pipe-D-eDP-1
[232.133278] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.207s)
[232.135612] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.213s)
[233.015534] [032/132] (792s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[233.133181] Starting subtest: fbc-psr2-primary-mmap-gtt
[233.135523] Starting dynamic subtest: eDP-1
[233.139687] Dynamic subtest eDP-1: SKIP (0.000s)
[233.143800] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[233.232973] [033/132] (792s left) gem_ctx_exec (basic-nohangcheck)
[233.298365] Starting subtest: basic-nohangcheck
[233.583199] Subtest basic-nohangcheck: SUCCESS (0.283s)
[233.739119] [034/132] (791s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[233.803769] Starting subtest: x-tiled-to-vebox-yf-tiled
[233.808169] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[234.007519] [035/132] (791s left) i915_drm_fdinfo (virtual-busy)
[234.049308] Starting subtest: virtual-busy
[234.053195] Subtest virtual-busy: SKIP (0.000s)
[234.139316] [036/132] (791s left) prime_vgem (busy)
[234.230064] Starting subtest: busy
[234.232459] Starting dynamic subtest: rcs0
[234.296694] Dynamic subtest rcs0: SUCCESS (0.066s)
[234.305598] Starting dynamic subtest: bcs0
[234.379266] Dynamic subtest bcs0: SUCCESS (0.082s)
[234.388217] Starting dynamic subtest: vcs0
[234.427727] Dynamic subtest vcs0: SUCCESS (0.048s)
[234.436345] Starting dynamic subtest: vcs1
[234.469888] Dynamic subtest vcs1: SUCCESS (0.042s)
[234.478584] Starting dynamic subtest: vecs0
[234.517194] Dynamic subtest vecs0: SUCCESS (0.047s)
[234.526007] Starting dynamic subtest: ccs0
[234.562432] Dynamic subtest ccs0: SUCCESS (0.045s)
[234.564659] Subtest busy: SUCCESS (0.332s)
[234.736038] [037/132] (791s left) kms_big_fb (linear-16bpp-rotate-180)
[234.850565] Starting subtest: linear-16bpp-rotate-180
[236.243887] Subtest linear-16bpp-rotate-180: SUCCESS (1.389s)
[236.401698] [038/132] (789s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[236.503587] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[236.505507] Starting dynamic subtest: pipe-A-default-mode
[236.798152] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[236.802811] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.291s)
[237.666703] [039/132] (788s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[237.759585] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[237.761786] Starting dynamic subtest: pipe-A-eDP-1
[237.914605] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.145s)
[237.925665] Starting dynamic subtest: pipe-B-eDP-1
[237.944216] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[237.952888] Starting dynamic subtest: pipe-C-eDP-1
[237.973338] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[237.981869] Starting dynamic subtest: pipe-D-eDP-1
[238.001371] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[238.003285] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.182s)
[240.232487] [040/132] (785s left) gem_softpin (evict-prime)
[240.301969] Starting subtest: evict-prime
[240.304337] Starting dynamic subtest: rcs0
[241.509845] Dynamic subtest rcs0: SUCCESS (1.205s)
[241.521999] Starting dynamic subtest: bcs0
[242.668246] Dynamic subtest bcs0: SUCCESS (1.155s)
[242.679267] Starting dynamic subtest: vcs0
[244.725240] Dynamic subtest vcs0: SUCCESS (2.052s)
[244.737605] Starting dynamic subtest: vcs1
[246.760870] Dynamic subtest vcs1: SUCCESS (2.032s)
[246.772727] Starting dynamic subtest: vecs0
[248.739967] Dynamic subtest vecs0: SUCCESS (1.976s)
[248.752642] Starting dynamic subtest: ccs0
[249.898318] Dynamic subtest ccs0: SUCCESS (1.158s)
[249.910394] Starting dynamic subtest: all
[251.752490] Dynamic subtest all: SUCCESS (1.849s)
[251.755439] Subtest evict-prime: SUCCESS (11.437s)
[251.853762] [041/132] (774s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[251.965900] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[258.614099] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.646s)
[258.791120] [042/132] (767s left) kms_plane_alpha_blend (alpha-opaque-fb)
[258.885655] Starting subtest: alpha-opaque-fb
[259.176529] Starting dynamic subtest: pipe-A-eDP-1
[259.802774] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.626s)
[259.812503] Starting dynamic subtest: pipe-D-eDP-1
[261.182011] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.378s)
[261.184500] Subtest alpha-opaque-fb: SUCCESS (2.298s)
[262.017275] [043/132] (764s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[262.127496] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[262.131757] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[262.247437] [044/132] (763s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[262.351696] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[262.354032] Starting dynamic subtest: pipe-A-eDP-1
[262.379960] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[262.390885] Starting dynamic subtest: pipe-B-eDP-1
[262.415567] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[262.424978] Starting dynamic subtest: pipe-C-eDP-1
[262.448836] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[262.457276] Starting dynamic subtest: pipe-D-eDP-1
[262.481384] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[262.485494] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[264.583889] [045/132] (761s left) perf_pmu (busy-accuracy-2)
[264.629928] Starting subtest: busy-accuracy-2
[264.632219] Starting dynamic subtest: rcs0
[267.670810] Dynamic subtest rcs0: SUCCESS (3.040s)
[267.682145] Starting dynamic subtest: bcs0
[270.725560] Dynamic subtest bcs0: SUCCESS (3.054s)
[270.734294] Starting dynamic subtest: vcs0
[273.772891] Dynamic subtest vcs0: SUCCESS (3.045s)
[273.781814] Starting dynamic subtest: vcs1
[276.817401] Dynamic subtest vcs1: SUCCESS (3.043s)
[276.828580] Starting dynamic subtest: vecs0
[279.865476] Dynamic subtest vecs0: SUCCESS (3.046s)
[279.876848] Starting dynamic subtest: ccs0
[282.924257] Dynamic subtest ccs0: SUCCESS (3.057s)
[282.926703] Subtest busy-accuracy-2: SUCCESS (18.296s)
[283.093239] [046/132] (743s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[283.160839] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[283.163124] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[283.296195] [047/132] (742s left) kms_content_protection (srm)
[283.430141] Starting subtest: srm
[283.437619] Subtest srm: SKIP (0.003s)
[283.577584] [048/132] (742s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[283.670261] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[283.672582] Starting dynamic subtest: pipe-A-eDP-1
[283.695770] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[283.711452] Starting dynamic subtest: pipe-B-eDP-1
[283.733671] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[283.742092] Starting dynamic subtest: pipe-C-eDP-1
[283.763255] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[283.771515] Starting dynamic subtest: pipe-D-eDP-1
[283.793834] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[283.797922] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[285.956904] [049/132] (740s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[286.054277] Starting subtest: psr-rgb565-draw-mmap-gtt
[286.058708] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[286.171794] [050/132] (740s left) kms_cursor_crc (cursor-onscreen-32x10)
[286.342073] Starting subtest: cursor-onscreen-32x10
[286.385261] Subtest cursor-onscreen-32x10: SKIP (0.041s)
[286.683275] [051/132] (739s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[286.789807] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[293.813466] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.025s)
[293.971279] [052/132] (732s left) gem_ctx_bad_destroy (double-destroy)
[294.035291] Starting subtest: double-destroy
[294.037721] Subtest double-destroy: SUCCESS (0.000s)
[294.137761] [053/132] (732s left) gem_lmem_swapping (basic)
[294.181763] Subtest basic: SKIP (0.000s)
[294.222385] [054/132] (732s left) gen9_exec_parse (bb-start-cmd)
[294.276888] Subtest bb-start-cmd: SKIP (0.000s)
[294.363217] [055/132] (732s left) sw_sync (sync_multi_timeline_wait)
[294.396520] Starting subtest: sync_multi_timeline_wait
[294.398816] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[294.469775] [056/132] (732s left) i915_pm_rc6_residency (rc6-accuracy)
[294.525463] Starting subtest: rc6-accuracy
[294.527438] Starting dynamic subtest: gt0
[297.697704] Dynamic subtest gt0: SUCCESS (3.169s)
[297.709237] Starting dynamic subtest: gt1
[300.869162] Dynamic subtest gt1: SUCCESS (3.168s)
[300.871881] Subtest rc6-accuracy: SUCCESS (6.342s)
[300.970889] [057/132] (725s left) api_intel_bb (simple-bb-ctx)
[301.037810] Starting subtest: simple-bb-ctx
[301.049318] Subtest simple-bb-ctx: SUCCESS (0.013s)
[301.197968] [058/132] (725s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[301.306587] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[301.310518] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[301.426331] [059/132] (725s left) kms_vblank (crtc-id)
[301.525999] Starting subtest: crtc-id
[301.528196] Starting dynamic subtest: pipe-A-eDP-1
[301.967148] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.442s)
[301.981846] Starting dynamic subtest: pipe-D-eDP-1
[303.071332] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.098s)
[303.073587] Subtest crtc-id: SUCCESS (1.544s)
[303.928097] [060/132] (722s left) gem_basic (bad-close)
[303.984401] Starting subtest: bad-close
[303.988565] Subtest bad-close: SUCCESS (0.000s)
[304.112535] [061/132] (722s left) kms_flip (dpms-vs-vblank-race-interruptible)
[304.217704] Starting subtest: dpms-vs-vblank-race-interruptible
[304.220073] Starting dynamic subtest: A-eDP1
[309.178377] Dynamic subtest A-eDP1: SUCCESS (4.956s)
[309.188024] Starting dynamic subtest: B-eDP1
[313.821160] Dynamic subtest B-eDP1: SUCCESS (4.642s)
[313.833291] Starting dynamic subtest: C-eDP1
[317.320507] Dynamic subtest C-eDP1: SUCCESS (3.497s)
[317.330102] Starting dynamic subtest: D-eDP1
[321.961799] Dynamic subtest D-eDP1: SUCCESS (4.641s)
[321.964178] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.744s)
[322.851805] [062/132] (704s left) kms_vblank (wait-forked-busy)
[322.947625] Starting subtest: wait-forked-busy
[322.949460] Starting dynamic subtest: pipe-A-eDP-1
[324.828923] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.882s)
[324.843912] Starting dynamic subtest: pipe-D-eDP-1
[327.382077] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.548s)
[327.384348] Subtest wait-forked-busy: SUCCESS (4.433s)
[328.213052] [063/132] (698s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[328.309422] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[328.313722] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[328.449155] [064/132] (698s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[328.562107] Starting subtest: 4-tiled-64bpp-rotate-180
[330.175454] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.612s)
[330.355560] [065/132] (696s left) kms_flip (absolute-wf_vblank-interruptible)
[330.460125] Starting subtest: absolute-wf_vblank-interruptible
[330.464454] Starting dynamic subtest: A-eDP1
[339.154642] Dynamic subtest A-eDP1: SUCCESS (8.689s)
[339.165363] Starting dynamic subtest: B-eDP1
[347.885580] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[347.896233] Starting dynamic subtest: C-eDP1
[356.606702] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[356.618523] Starting dynamic subtest: D-eDP1
[365.345841] Dynamic subtest D-eDP1: SUCCESS (8.736s)
[365.351448] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.881s)
[366.594822] [066/132] (660s left) gem_exec_flush (basic-uc-prw-default)
[366.657049] Starting subtest: basic-uc-prw-default
[372.146777] Subtest basic-uc-prw-default: SUCCESS (5.489s)
[372.354094] [067/132] (654s left) vgem_basic (busy-fence)
[372.393285] Starting subtest: busy-fence
[372.395156] Subtest busy-fence: SUCCESS (0.000s)
[372.475356] [068/132] (654s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[372.578579] Starting subtest: psr-rgb565-draw-render
[379.677511] Subtest psr-rgb565-draw-render: SUCCESS (7.098s)
[379.839971] [069/132] (647s left) kms_dp_link_training (uhbr-sst)
[379.944643] Starting subtest: uhbr-sst
[379.952779] Subtest uhbr-sst: SKIP (0.000s)
[380.042378] [070/132] (647s left) kms_universal_plane (disable-primary-vs-flip)
[380.127968] Starting subtest: disable-primary-vs-flip
[380.130172] Starting dynamic subtest: pipe-A-eDP-1
[381.694056] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.564s)
[381.703597] Starting dynamic subtest: pipe-B-eDP-1
[383.899593] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.205s)
[383.908725] Starting dynamic subtest: pipe-C-eDP-1
[386.140252] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.236s)
[386.149870] Starting dynamic subtest: pipe-D-eDP-1
[388.316073] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.173s)
[388.318454] Subtest disable-primary-vs-flip: SUCCESS (8.185s)
[389.162748] [071/132] (638s left) gem_exec_balancer (invalid-balancer)
[389.245618] Starting subtest: invalid-balancer
[390.130926] Subtest invalid-balancer: SUCCESS (0.886s)
[390.465325] [072/132] (636s left) gem_mmap_offset (bad-extensions)
[390.527023] Starting subtest: bad-extensions
[390.529207] Subtest bad-extensions: SUCCESS (0.000s)
[390.666257] [073/132] (636s left) kms_atomic_transition (plane-all-transition)
[390.770210] Starting subtest: plane-all-transition
[390.772542] Starting dynamic subtest: pipe-A-eDP-1
[393.265697] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[393.571264] Starting dynamic subtest: pipe-B-eDP-1
[396.845191] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.283s)
[397.144310] Subtest plane-all-transition: SUCCESS (6.372s)
[397.995513] [074/132] (629s left) kms_rotation_crc (multiplane-rotation)
[398.102738] Starting subtest: multiplane-rotation
[415.499273] Subtest multiplane-rotation: SUCCESS (17.394s)
[415.671511] [075/132] (611s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[415.785136] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[415.788931] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[415.894448] [076/132] (611s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[420.957022] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[420.959341] Starting dynamic subtest: pipe-A-eDP-1
[421.744347] Dynamic subtest pipe-A-eDP-1: SKIP (0.785s)
[421.754496] Starting dynamic subtest: pipe-B-eDP-1
[422.861325] Dynamic subtest pipe-B-eDP-1: SKIP (1.116s)
[422.865537] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.905s)
[424.072606] [077/132] (603s left) kms_psr (pr-sprite-blt)
[424.170127] Starting subtest: pr-sprite-blt
[424.173986] Subtest pr-sprite-blt: SKIP (0.000s)
[424.268393] [078/132] (603s left) kms_psr (pr-cursor-render)
[424.373242] Starting subtest: pr-cursor-render
[424.377560] Subtest pr-cursor-render: SKIP (0.000s)
[424.479854] [079/132] (603s left) syncobj_wait (single-wait-all-signaled)
[424.534062] Starting subtest: single-wait-all-signaled
[424.536040] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[424.658306] [080/132] (603s left) kms_chamelium_hpd (dp-hpd-storm)
[425.046874] Subtest dp-hpd-storm: SKIP (0.000s)
[425.851590] [081/132] (601s left) gem_mmap_gtt (basic-write-gtt)
[425.928271] Subtest basic-write-gtt: SKIP (0.000s)
[425.994309] [082/132] (601s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[426.098047] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[426.100265] Starting dynamic subtest: pipe-A
[426.469864] Dynamic subtest pipe-A: SUCCESS (0.373s)
[426.479425] Starting dynamic subtest: pipe-B
[427.924751] Dynamic subtest pipe-B: SUCCESS (1.454s)
[427.936086] Starting dynamic subtest: pipe-C
[429.302396] Dynamic subtest pipe-C: SUCCESS (1.377s)
[429.321467] Starting dynamic subtest: pipe-D
[430.728372] Dynamic subtest pipe-D: SUCCESS (1.425s)
[430.730691] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.634s)
[431.929879] [083/132] (595s left) gem_exec_schedule (thriceslice)
[432.007397] Starting subtest: thriceslice
[432.009517] Starting dynamic subtest: rcs0
[432.027900] Dynamic subtest rcs0: SUCCESS (0.030s)
[432.039359] Starting dynamic subtest: bcs0
[432.057459] Dynamic subtest bcs0: SUCCESS (0.029s)
[432.066371] Starting dynamic subtest: vcs0
[432.087582] Dynamic subtest vcs0: SUCCESS (0.029s)
[432.096134] Starting dynamic subtest: vcs1
[432.115756] Dynamic subtest vcs1: SUCCESS (0.027s)
[432.124175] Starting dynamic subtest: vecs0
[432.144961] Dynamic subtest vecs0: SUCCESS (0.028s)
[432.154188] Starting dynamic subtest: ccs0
[432.194764] Dynamic subtest ccs0: SUCCESS (0.049s)
[432.197361] Subtest thriceslice: SUCCESS (0.198s)
[432.520116] [084/132] (595s left) gem_exec_fence (nb-await)
[432.701158] Starting subtest: nb-await
[432.703530] Starting dynamic subtest: rcs0
[432.769753] Dynamic subtest rcs0: SUCCESS (0.068s)
[432.781751] Starting dynamic subtest: bcs0
[432.828164] Dynamic subtest bcs0: SUCCESS (0.057s)
[432.838322] Starting dynamic subtest: vcs0
[432.887180] Dynamic subtest vcs0: SUCCESS (0.057s)
[432.897701] Starting dynamic subtest: vcs1
[432.945744] Dynamic subtest vcs1: SUCCESS (0.056s)
[432.957267] Starting dynamic subtest: vecs0
[433.004386] Dynamic subtest vecs0: SUCCESS (0.057s)
[433.015942] Starting dynamic subtest: ccs0
[433.062082] Dynamic subtest ccs0: SUCCESS (0.056s)
[433.064428] Subtest nb-await: SUCCESS (0.362s)
[434.880341] [085/132] (592s left) gem_userptr_blits (set-cache-level)
[434.952185] Starting subtest: set-cache-level
[434.956304] Subtest set-cache-level: SKIP (0.000s)
[435.109981] [086/132] (592s left) gem_ctx_persistence (hang)
[435.165031] Starting subtest: hang
[435.169708] Subtest hang: SKIP (0.000s)
[435.308376] [087/132] (592s left) kms_psr (psr-cursor-mmap-gtt)
[435.410901] Starting subtest: psr-cursor-mmap-gtt
[435.413319] Starting dynamic subtest: eDP-1
[437.106634] Dynamic subtest eDP-1: SUCCESS (1.697s)
[437.108860] Subtest psr-cursor-mmap-gtt: SUCCESS (1.698s)
[438.003629] [088/132] (589s left) gem_eio (in-flight-contexts-immediate)
[438.245170] Starting subtest: in-flight-contexts-immediate
[449.771004] Subtest in-flight-contexts-immediate: SUCCESS (11.526s)
[449.985425] [089/132] (578s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[450.093734] Starting subtest: basic-modeset-with-all-modifiers-formats
[450.477166] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[451.258573] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.783s)
[451.267980] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[451.280605] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.022s)
[451.289622] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[451.303222] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[451.312150] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[451.458507] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[451.468070] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[451.480796] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[451.489993] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[451.502994] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[451.511986] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[451.525395] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[451.534450] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[451.547582] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[451.556357] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[451.569745] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[451.578812] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[451.592138] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[451.601095] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[451.614297] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[451.623389] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[451.636760] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[451.646909] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[451.792137] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[451.802015] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[451.814385] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[451.826435] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[451.836629] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[451.845433] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[451.858677] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[451.867326] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[451.880938] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[451.889523] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[451.903221] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[451.911875] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[451.925454] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[451.934012] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[451.947621] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[451.956107] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[451.969776] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[451.978476] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[452.125497] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[452.135594] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[452.148094] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[452.159916] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[452.170345] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[452.180637] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[452.192468] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[452.201430] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[452.214294] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[452.223743] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[452.236918] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[452.245866] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[452.258742] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[452.267319] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[452.280959] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[452.289679] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[452.303186] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[452.689805] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.597s)
[453.481031] [090/132] (574s left) kms_color (ctm-max)
[453.575360] Starting subtest: ctm-max
[453.577332] Starting dynamic subtest: pipe-A-eDP-1
[454.285836] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[454.295447] Starting dynamic subtest: pipe-B-eDP-1
[455.659504] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.375s)
[455.669759] Starting dynamic subtest: pipe-C-eDP-1
[457.028278] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.369s)
[457.037856] Starting dynamic subtest: pipe-D-eDP-1
[458.367845] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s)
[458.370191] Subtest ctm-max: SUCCESS (4.796s)
[459.194977] [091/132] (568s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[459.310112] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[463.538652] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.232s)
[464.692333] [092/132] (563s left) gem_render_copy (linear)
[464.748104] Starting subtest: linear
[464.750563] Starting dynamic subtest: smem
[464.792966] Dynamic subtest smem: SUCCESS (0.045s)
[464.795440] Subtest linear: SUCCESS (0.045s)
[465.083562] [093/132] (563s left) gem_userptr_blits (access-control)
[465.157476] Starting subtest: access-control
[465.161827] Subtest access-control: SKIP (0.000s)
[465.290429] [094/132] (562s left) kms_flip (2x-nonexisting-fb)
[465.388333] Starting subtest: 2x-nonexisting-fb
[465.398520] Subtest 2x-nonexisting-fb: SKIP (0.011s)
[465.522802] [095/132] (562s left) gem_ccs (block-copy-compressed)
[465.575390] Starting subtest: block-copy-compressed
[465.580011] Subtest block-copy-compressed: SKIP (0.000s)
[465.695757] [096/132] (562s left) prime_mmap (test_invalid_sync_flags)
[465.757233] Starting subtest: test_invalid_sync_flags
[465.759228] Starting dynamic subtest: test_invalid_sync_flags-smem
[465.761215] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[465.763204] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[465.886932] [097/132] (562s left) gem_exec_params (invalid-bsd-ring)
[465.945607] Starting subtest: invalid-bsd-ring
[465.947154] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[466.084316] [098/132] (562s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[466.175648] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[472.936652] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.761s)
[473.130048] [099/132] (555s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[473.245031] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[473.249103] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[473.388357] [100/132] (555s left) kms_plane (planar-pixel-format-settings)
[473.494985] Starting subtest: planar-pixel-format-settings
[473.535877] Subtest planar-pixel-format-settings: SUCCESS (0.042s)
[473.673209] [101/132] (554s left) syncobj_timeline (wait-for-submit-delayed-submit)
[473.736841] Starting subtest: wait-for-submit-delayed-submit
[473.839035] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[473.939955] [102/132] (554s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[474.259440] Starting subtest: cursor-rapid-movement-max-size
[474.266016] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[474.428382] [103/132] (554s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[474.547644] Starting subtest: modeset-atomic-cursor-hotspot
[474.552204] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[474.717782] [104/132] (553s left) gem_exec_balancer (parallel-keep-submit-fence)
[474.973432] Starting subtest: parallel-keep-submit-fence
[476.200281] Subtest parallel-keep-submit-fence: SUCCESS (1.227s)
[476.344392] [105/132] (552s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[476.721297] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[477.494634] [106/132] (551s left) kms_getfb (getfb-addfb-different-handles)
[477.602719] Starting subtest: getfb-addfb-different-handles
[477.604759] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[477.728970] [107/132] (551s left) gem_ctx_sseu (invalid-args)
[477.802880] Subtest invalid-args: SKIP (0.000s)
[477.890884] [108/132] (550s left) gem_lmem_swapping (parallel-random-verify)
[477.931482] Subtest parallel-random-verify: SKIP (0.000s)
[477.977424] [109/132] (550s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[478.084426] Starting subtest: psr-2p-primscrn-spr-indfb-move
[478.088512] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[478.230605] [110/132] (550s left) gem_exec_reloc (basic-write-cpu-noreloc)
[478.300659] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[478.388530] [111/132] (550s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[478.448908] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[478.450803] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[478.573808] [112/132] (550s left) i915_hangman (gt-engine-hang)
[478.655436] Starting subtest: gt-engine-hang
[478.657241] Starting dynamic subtest: rcs0
[479.726017] Dynamic subtest rcs0: SUCCESS (1.070s)
[479.738351] Starting dynamic subtest: bcs0
[481.708445] Dynamic subtest bcs0: SUCCESS (1.980s)
[481.720682] Starting dynamic subtest: vcs0
[483.694576] Dynamic subtest vcs0: SUCCESS (1.983s)
[483.711420] Starting dynamic subtest: vcs1
[485.676826] Dynamic subtest vcs1: SUCCESS (1.980s)
[485.692986] Starting dynamic subtest: vecs0
[487.659430] Dynamic subtest vecs0: SUCCESS (1.980s)
[487.676457] Starting dynamic subtest: ccs0
[489.708668] Dynamic subtest ccs0: SUCCESS (2.046s)
[489.711695] Subtest gt-engine-hang: SUCCESS (11.054s)
[489.891350] [113/132] (539s left) gem_mmap (bad-object)
[489.947471] Subtest bad-object: SKIP (0.000s)
[490.008934] [114/132] (539s left) kms_feature_discovery (psr1)
[490.126939] Starting subtest: psr1
[490.129296] Subtest psr1: SUCCESS (0.000s)
[490.230603] [115/132] (538s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[490.349591] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[497.227009] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.880s)
[497.425602] [116/132] (531s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[497.537089] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[497.541287] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[497.649386] [117/132] (531s left) gem_mmap_gtt (fault-concurrent)
[497.705459] Subtest fault-concurrent: SKIP (0.000s)
[497.772859] [118/132] (531s left) kms_pm_rpm (legacy-planes-dpms)
[499.910942] Starting subtest: legacy-planes-dpms
[499.913116] Starting dynamic subtest: plane-63
[508.308146] Dynamic subtest plane-63: SUCCESS (8.399s)
[508.321251] Starting dynamic subtest: plane-93
[516.933115] Dynamic subtest plane-93: SUCCESS (8.621s)
[516.944841] Starting dynamic subtest: plane-123
[525.652479] Dynamic subtest plane-123: SUCCESS (8.716s)
[525.664535] Starting dynamic subtest: plane-133
[534.258723] Dynamic subtest plane-133: SUCCESS (8.601s)
[534.261740] Subtest legacy-planes-dpms: SUCCESS (34.348s)
[534.645660] [119/132] (494s left) kms_chamelium_color (ctm-negative)
[534.754821] Subtest ctm-negative: SKIP (0.000s)
[534.802246] [120/132] (494s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[534.900473] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[534.902748] Starting dynamic subtest: pipe-A-default-mode
[535.201060] Dynamic subtest pipe-A-default-mode: SKIP (0.296s)
[535.205728] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.299s)
[536.069793] [121/132] (493s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[536.167461] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[537.213076] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.045s)
[537.372467] [122/132] (492s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[537.463871] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[537.465779] Starting dynamic subtest: pipe-A-eDP-1
[537.474433] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[537.486056] Starting dynamic subtest: pipe-B-eDP-1
[537.493602] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[537.502802] Starting dynamic subtest: pipe-C-eDP-1
[537.509922] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[537.518686] Starting dynamic subtest: pipe-D-eDP-1
[537.525700] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[537.529150] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[539.724702] [123/132] (489s left) kms_invalid_mode (overflow-vrefresh)
[539.826420] Starting subtest: overflow-vrefresh
[539.828793] Starting dynamic subtest: pipe-A-eDP-1
[540.109743] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[540.120907] Starting dynamic subtest: pipe-B-eDP-1
[540.123220] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[540.132043] Starting dynamic subtest: pipe-C-eDP-1
[540.134378] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[540.143204] Starting dynamic subtest: pipe-D-eDP-1
[540.145191] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[540.147185] Subtest overflow-vrefresh: SUCCESS (0.290s)
[540.949052] [124/132] (488s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[541.053246] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[541.057537] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[541.168681] [125/132] (488s left) kms_psr (fbc-pr-cursor-plane-move)
[541.275580] Starting subtest: fbc-pr-cursor-plane-move
[541.280002] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[541.374647] [126/132] (488s left) prime_busy (before)
[541.439594] Starting subtest: before
[541.441981] Starting dynamic subtest: rcs0
[541.467883] Dynamic subtest rcs0: SUCCESS (0.028s)
[541.479588] Starting dynamic subtest: bcs0
[541.542285] Dynamic subtest bcs0: SUCCESS (0.074s)
[541.551838] Starting dynamic subtest: vcs0
[541.582113] Dynamic subtest vcs0: SUCCESS (0.039s)
[541.591092] Starting dynamic subtest: vcs1
[541.621844] Dynamic subtest vcs1: SUCCESS (0.037s)
[541.631933] Starting dynamic subtest: vecs0
[541.661680] Dynamic subtest vecs0: SUCCESS (0.040s)
[541.671005] Starting dynamic subtest: ccs0
[541.703734] Dynamic subtest ccs0: SUCCESS (0.041s)
[541.812389] Subtest before: SUCCESS (0.374s)
[541.909738] [127/132] (487s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[542.013213] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[542.017702] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[542.152241] [128/132] (487s left) kms_hdr (invalid-metadata-sizes)
[542.242201] Starting subtest: invalid-metadata-sizes
[542.248260] Subtest invalid-metadata-sizes: SKIP (0.000s)
[542.338934] [129/132] (487s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[542.408248] Starting subtest: y-tiled-ccs-to-yf-tiled
[542.412741] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[542.613266] [130/132] (487s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[542.702318] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[549.735663] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.034s)
[549.881927] [131/132] (479s left) gem_userptr_blits (unsync-unmap)
[549.951533] Subtest unsync-unmap: SKIP (0.000s)
[550.113512] [132/132] (479s left) gem_ccs (suspend-resume)
[550.176482] Starting subtest: suspend-resume
[550.180520] Subtest suspend-resume: SKIP (0.000s)
[550.297021] 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.