[57.921308] Initializing watchdogs
[57.921352]   /dev/watchdog0
[57.935612] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.939940] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.942222] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.945859] [001/133] (960s left) gem_exec_gttfill (engines)
[58.032929] Starting subtest: engines
[58.035375] Starting dynamic subtest: rcs0
[81.429414] Dynamic subtest rcs0: SUCCESS (23.468s)
[81.439718] Starting dynamic subtest: bcs0
[104.770828] Dynamic subtest bcs0: SUCCESS (23.334s)
[104.781542] Starting dynamic subtest: vcs0
[128.102275] Dynamic subtest vcs0: SUCCESS (23.330s)
[128.112403] Starting dynamic subtest: vcs1
[151.351351] Dynamic subtest vcs1: SUCCESS (23.246s)
[151.361919] Starting dynamic subtest: vecs0
[174.765930] Dynamic subtest vecs0: SUCCESS (23.411s)
[174.776285] Starting dynamic subtest: ccs0
[198.138742] Dynamic subtest ccs0: SUCCESS (23.371s)
[198.141472] Subtest engines: SUCCESS (140.165s)
[198.329652] [002/133] (820s left) perf (gen12-unprivileged-single-ctx-counters)
[198.527180] Starting subtest: gen12-unprivileged-single-ctx-counters
[198.529524] Starting dynamic subtest: rcs0
[198.924239] Dynamic subtest rcs0: SUCCESS (0.399s)
[198.926534] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.400s)
[198.973241] [003/133] (819s left) kms_joiner (basic-ultra-joiner)
[199.102719] Starting subtest: basic-ultra-joiner
[199.107285] Subtest basic-ultra-joiner: SKIP (0.000s)
[199.175984] [004/133] (819s left) prime_mmap (test_aperture_limit)
[199.234696] Starting subtest: test_aperture_limit
[199.236934] Starting dynamic subtest: test_aperture_limit-smem
[199.245636] Dynamic subtest test_aperture_limit-smem: SKIP (0.009s)
[199.249729] Subtest test_aperture_limit: SKIP (0.010s)
[199.330433] [005/133] (819s left) kms_plane (plane-position-hole)
[199.417571] Starting subtest: plane-position-hole
[199.932464] Starting dynamic subtest: pipe-A-plane-1
[201.281168] Dynamic subtest pipe-A-plane-1: SUCCESS (1.350s)
[201.290121] Starting dynamic subtest: pipe-A-plane-2
[202.578767] Dynamic subtest pipe-A-plane-2: SUCCESS (1.297s)
[202.588399] Starting dynamic subtest: pipe-A-plane-3
[203.881073] Dynamic subtest pipe-A-plane-3: SUCCESS (1.301s)
[203.891059] Starting dynamic subtest: pipe-A-plane-4
[205.124504] Dynamic subtest pipe-A-plane-4: SUCCESS (1.242s)
[205.134142] Starting dynamic subtest: pipe-A-plane-5
[205.148094] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[206.290094] Starting dynamic subtest: pipe-B-plane-1
[207.602092] Dynamic subtest pipe-B-plane-1: SUCCESS (1.318s)
[207.611890] Starting dynamic subtest: pipe-B-plane-2
[208.898954] Dynamic subtest pipe-B-plane-2: SUCCESS (1.298s)
[208.909360] Starting dynamic subtest: pipe-B-plane-3
[210.143882] Dynamic subtest pipe-B-plane-3: SUCCESS (1.245s)
[210.153427] Starting dynamic subtest: pipe-B-plane-4
[211.373807] Dynamic subtest pipe-B-plane-4: SUCCESS (1.227s)
[211.383769] Starting dynamic subtest: pipe-B-plane-5
[211.397124] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[211.399399] Subtest plane-position-hole: SUCCESS (11.978s)
[212.191772] [006/133] (806s left) kms_async_flips (alternate-sync-async-flip-atomic)
[212.301765] Starting subtest: alternate-sync-async-flip-atomic
[212.677131] Starting dynamic subtest: pipe-A-eDP-1
[215.465126] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.788s)
[216.565465] Starting dynamic subtest: pipe-B-eDP-1
[218.855077] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.297s)
[219.233105] Starting dynamic subtest: pipe-C-eDP-1
[221.986729] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.761s)
[222.362791] Starting dynamic subtest: pipe-D-eDP-1
[225.120355] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.765s)
[225.122369] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.821s)
[226.278698] [007/133] (792s left) kms_cursor_crc (cursor-random-64x21)
[226.494830] Starting subtest: cursor-random-64x21
[226.542712] Subtest cursor-random-64x21: SKIP (0.042s)
[226.784660] [008/133] (791s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[226.849533] Starting subtest: basic-batch-kernel-default-cmd
[226.853899] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[227.032496] [009/133] (791s left) gem_userptr_blits (map-fixed-invalidate)
[227.095493] Starting subtest: map-fixed-invalidate
[227.099744] Subtest map-fixed-invalidate: SKIP (0.000s)
[227.199338] [010/133] (791s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[227.254569] Starting subtest: multi-wait-for-submit-submitted-signaled
[227.256962] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[227.370294] [011/133] (791s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[227.474699] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[228.276528] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.803s)
[228.446054] [012/133] (790s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[228.564530] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[259.818659] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.252s)
[260.625352] [013/133] (758s left) kms_psr (psr2-basic)
[260.725460] Starting subtest: psr2-basic
[260.727672] Starting dynamic subtest: eDP-1
[262.307920] Dynamic subtest eDP-1: SUCCESS (1.581s)
[262.310156] Subtest psr2-basic: SUCCESS (1.582s)
[263.096728] [014/133] (755s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[263.191440] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[263.195472] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[263.284317] [015/133] (755s left) kms_big_fb (linear-16bpp-rotate-180)
[263.387183] Starting subtest: linear-16bpp-rotate-180
[264.832604] Subtest linear-16bpp-rotate-180: SUCCESS (1.445s)
[264.938858] [016/133] (754s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[265.027735] Starting subtest: bad-pixel-format-y-tiled-ccs
[265.029678] Starting dynamic subtest: pipe-A-eDP-1
[265.048448] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[265.058975] Starting dynamic subtest: pipe-B-eDP-1
[265.076513] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[265.083693] Starting dynamic subtest: pipe-C-eDP-1
[265.100773] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[265.108382] Starting dynamic subtest: pipe-D-eDP-1
[265.125661] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[265.129073] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[267.270311] [017/133] (751s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[267.364981] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[267.369095] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[267.441692] [018/133] (751s left) i915_drm_fdinfo (most-busy-idle-check-all)
[267.487596] Starting subtest: most-busy-idle-check-all
[267.489560] Starting dynamic subtest: rcs0
[267.493902] Dynamic subtest rcs0: SKIP (0.004s)
[267.504818] Starting dynamic subtest: bcs0
[267.509033] Dynamic subtest bcs0: SKIP (0.000s)
[267.516478] Starting dynamic subtest: vcs0
[267.520668] Dynamic subtest vcs0: SKIP (0.000s)
[267.528402] Starting dynamic subtest: vcs1
[267.532604] Dynamic subtest vcs1: SKIP (0.000s)
[267.540209] Starting dynamic subtest: vecs0
[267.544346] Dynamic subtest vecs0: SKIP (0.000s)
[267.551982] Starting dynamic subtest: ccs0
[267.556320] Dynamic subtest ccs0: SKIP (0.000s)
[267.560653] Subtest most-busy-idle-check-all: SKIP (0.008s)
[267.594217] [019/133] (751s left) perf_pmu (rc6-suspend)
[267.633390] Starting subtest: rc6-suspend
[290.483579] Subtest rc6-suspend: SUCCESS (7.790s)
[291.335686] [020/133] (727s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[291.450273] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[291.454145] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[291.539841] [021/133] (727s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[291.637492] Starting subtest: fbc-psr2-sprite-plane-onoff
[291.639319] Starting dynamic subtest: eDP-1
[291.642848] Dynamic subtest eDP-1: SKIP (0.000s)
[291.646411] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[291.707931] [022/133] (727s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[291.800294] Starting subtest: 4-tiled-16bpp-rotate-0
[292.984605] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.211s)
[293.085138] [023/133] (726s left) gem_workarounds (reset-fd)
[293.150764] Starting subtest: reset-fd
[293.330109] Subtest reset-fd: SUCCESS (0.183s)
[293.442147] [024/133] (725s left) kms_fence_pin_leak
[293.602162] [025/133] (725s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[293.669142] Starting subtest: y-tiled-to-vebox-y-tiled
[293.672947] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[293.848143] [026/133] (725s left) kms_cdclk (mode-transition)
[293.940070] Starting subtest: mode-transition
[293.942433] Starting dynamic subtest: pipe-A-eDP-1
[294.234839] Dynamic subtest pipe-A-eDP-1: SKIP (0.297s)
[294.245352] Starting dynamic subtest: pipe-B-eDP-1
[294.249898] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[294.258945] Starting dynamic subtest: pipe-C-eDP-1
[294.263251] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[294.272095] Starting dynamic subtest: pipe-D-eDP-1
[294.276216] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[294.280322] Subtest mode-transition: SKIP (0.304s)
[295.047030] [027/133] (724s left) gem_exec_params (dr4-dirt)
[295.113274] Starting subtest: DR4-dirt
[295.115472] Subtest DR4-dirt: SUCCESS (0.000s)
[295.218295] [028/133] (724s left) syncobj_wait (multi-wait-all-submitted)
[295.275861] Starting subtest: multi-wait-all-submitted
[295.382551] Subtest multi-wait-all-submitted: SUCCESS (0.107s)
[295.456277] [029/133] (724s left) gem_exec_store (basic)
[295.515542] Starting subtest: basic
[295.623570] Subtest basic: SUCCESS (0.114s)
[295.804669] [030/133] (723s left) gem_ctx_persistence (saturated-hostile)
[295.864189] Starting subtest: saturated-hostile
[295.866093] Starting dynamic subtest: rcs0
[296.679922] Dynamic subtest rcs0: SUCCESS (0.829s)
[296.691722] Starting dynamic subtest: bcs0
[297.465240] Dynamic subtest bcs0: SUCCESS (0.793s)
[297.477533] Starting dynamic subtest: vcs0
[298.275746] Dynamic subtest vcs0: SUCCESS (0.817s)
[298.288358] Starting dynamic subtest: vcs1
[299.076622] Dynamic subtest vcs1: SUCCESS (0.807s)
[299.089787] Starting dynamic subtest: vecs0
[299.880105] Dynamic subtest vecs0: SUCCESS (0.809s)
[299.891274] Starting dynamic subtest: ccs0
[300.719152] Dynamic subtest ccs0: SUCCESS (0.841s)
[300.721185] Subtest saturated-hostile: SUCCESS (4.908s)
[300.840858] [031/133] (718s left) kms_psr (psr-cursor-plane-onoff)
[300.941873] Starting subtest: psr-cursor-plane-onoff
[300.943969] Starting dynamic subtest: eDP-1
[302.667090] Dynamic subtest eDP-1: SUCCESS (1.734s)
[302.669010] Subtest psr-cursor-plane-onoff: SUCCESS (1.735s)
[303.522864] [032/133] (716s left) i915_hangman (detector)
[303.591779] Starting subtest: detector
[303.594121] Starting dynamic subtest: rcs0
[315.033661] Dynamic subtest rcs0: SUCCESS (11.476s)
[315.046153] Starting dynamic subtest: bcs0
[327.002659] Dynamic subtest bcs0: SUCCESS (11.962s)
[327.015883] Starting dynamic subtest: vcs0
[339.035227] Dynamic subtest vcs0: SUCCESS (12.028s)
[339.049675] Starting dynamic subtest: vcs1
[351.064308] Dynamic subtest vcs1: SUCCESS (12.028s)
[351.076508] Starting dynamic subtest: vecs0
[363.034377] Dynamic subtest vecs0: SUCCESS (11.970s)
[363.050101] Starting dynamic subtest: ccs0
[375.001373] Dynamic subtest ccs0: SUCCESS (11.968s)
[375.004009] Subtest detector: SUCCESS (71.447s)
[375.164741] [033/133] (644s left) kms_force_connector_basic (force-connector-state)
[375.248126] Starting subtest: force-connector-state
[375.878424] Subtest force-connector-state: SUCCESS (0.631s)
[376.815867] [034/133] (642s left) kms_universal_plane (universal-plane-sanity)
[376.923519] Starting subtest: universal-plane-sanity
[376.925832] Starting dynamic subtest: pipe-A-eDP-1
[377.529942] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.607s)
[377.540260] Starting dynamic subtest: pipe-B-eDP-1
[378.726502] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.196s)
[378.736932] Starting dynamic subtest: pipe-C-eDP-1
[379.895656] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.167s)
[379.906148] Starting dynamic subtest: pipe-D-eDP-1
[381.082864] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.184s)
[381.085071] Subtest universal-plane-sanity: SUCCESS (4.161s)
[381.916421] [035/133] (637s left) dmabuf_sync_file (import-multiple-read-write)
[382.026640] Starting subtest: import-multiple-read-write
[382.029148] Subtest import-multiple-read-write: SUCCESS (0.002s)
[382.079851] [FACT dmabuf_sync_file (import-multiple-read-write)] new: kernel.kmod_is_loaded.vgem: true
[382.083143] [036/133] (637s left) kms_pm_dc (dc5-dpms-negative)
[383.181292] Starting subtest: dc5-dpms-negative
[383.185813] Subtest dc5-dpms-negative: SKIP (0.000s)
[383.266390] [037/133] (636s left) gem_render_copy_redux (flink)
[383.322545] Starting subtest: flink
[384.144315] Subtest flink: SUCCESS (0.822s)
[384.262328] [038/133] (635s left) kms_cursor_crc (cursor-onscreen-64x64)
[384.447721] Starting subtest: cursor-onscreen-64x64
[384.451688] Starting dynamic subtest: pipe-A-eDP-1
[386.560604] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.106s)
[386.588836] Starting dynamic subtest: pipe-D-eDP-1
[389.393718] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.812s)
[389.396155] Subtest cursor-onscreen-64x64: SUCCESS (4.942s)
[390.207651] [039/133] (629s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[390.300717] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[390.304844] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[390.384360] [040/133] (629s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[390.487378] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[399.067126] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.579s)
[399.167222] [041/133] (620s left) gem_mmap_wc (bad-offset)
[399.230282] Subtest bad-offset: SKIP (0.000s)
[399.292537] [042/133] (620s left) gem_softpin (evict-single-offset)
[399.341629] Starting subtest: evict-single-offset
[425.148248] Subtest evict-single-offset: SUCCESS (25.802s)
[425.243184] [043/133] (594s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[425.447801] Starting subtest: dp-mst-type-1-suspend-resume
[425.452395] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[425.583582] [044/133] (594s left) gem_ctx_shared (q-out-order)
[425.644149] Starting subtest: Q-out-order
[425.646337] Starting dynamic subtest: rcs0
[425.757076] Dynamic subtest rcs0: SUCCESS (0.113s)
[425.770218] Starting dynamic subtest: vcs0
[425.849444] Dynamic subtest vcs0: SUCCESS (0.093s)
[425.864877] Starting dynamic subtest: vcs1
[425.932742] Dynamic subtest vcs1: SUCCESS (0.082s)
[425.950389] Starting dynamic subtest: vecs0
[426.009999] Dynamic subtest vecs0: SUCCESS (0.076s)
[426.027992] Starting dynamic subtest: ccs0
[426.108872] Dynamic subtest ccs0: SUCCESS (0.098s)
[426.111630] Subtest Q-out-order: SUCCESS (0.467s)
[427.233346] [045/133] (592s left) gem_softpin (softpin)
[427.297279] Starting subtest: softpin
[459.654822] Subtest softpin: SUCCESS (32.360s)
[459.777297] [046/133] (560s left) kms_plane_alpha_blend (coverage-7efc)
[459.890020] Starting subtest: coverage-7efc
[460.165488] Starting dynamic subtest: pipe-A-eDP-1
[460.722985] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.556s)
[460.752158] Starting dynamic subtest: pipe-D-eDP-1
[461.990085] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.248s)
[461.992425] Subtest coverage-7efc: SUCCESS (2.107s)
[462.797459] [047/133] (557s left) kms_busy (extended-pageflip-hang-oldfb)
[462.915308] Starting subtest: extended-pageflip-hang-oldfb
[462.917594] Starting dynamic subtest: pipe-A
[463.357722] Dynamic subtest pipe-A: SUCCESS (0.443s)
[463.370007] Starting dynamic subtest: pipe-D
[464.490560] Dynamic subtest pipe-D: SUCCESS (1.131s)
[464.492715] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.579s)
[465.309229] [048/133] (554s left) kms_big_fb (y-tiled-addfb)
[465.416505] Starting subtest: y-tiled-addfb
[465.420491] Subtest y-tiled-addfb: SKIP (0.000s)
[465.519841] [049/133] (554s left) kms_plane_multiple (tiling-none)
[465.613253] Starting subtest: tiling-none
[465.615118] Starting dynamic subtest: pipe-A-eDP-1
[469.447580] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.835s)
[469.457953] Starting dynamic subtest: pipe-B-eDP-1
[474.042130] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.595s)
[474.053503] Starting dynamic subtest: pipe-C-eDP-1
[478.617458] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.575s)
[478.628662] Starting dynamic subtest: pipe-D-eDP-1
[483.224751] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.608s)
[483.227162] Subtest tiling-none: SUCCESS (17.618s)
[484.098414] [050/133] (536s left) kms_chamelium_frames (dp-crc-fast)
[484.485690] Subtest dp-crc-fast: SKIP (0.000s)
[485.282689] [051/133] (535s left) i915_suspend (fence-restore-tiled2untiled)
[485.334930] Starting subtest: fence-restore-tiled2untiled
[485.339336] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[485.437015] [052/133] (535s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[485.535591] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[491.963111] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.431s)
[492.079108] [053/133] (528s left) kms_chamelium_hpd (hdmi-hpd-fast)
[492.456082] Subtest hdmi-hpd-fast: SKIP (0.000s)
[493.270572] [054/133] (527s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[493.363681] Starting subtest: fbc-psr2-primary-mmap-cpu
[493.366087] Starting dynamic subtest: eDP-1
[493.370561] Dynamic subtest eDP-1: SKIP (0.000s)
[493.375149] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[493.454478] [055/133] (527s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[493.563021] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[493.565435] Starting dynamic subtest: pipe-A-eDP-1
[510.024084] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.469s)
[510.034708] Starting dynamic subtest: pipe-B-eDP-1
[527.234927] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.202s)
[527.237119] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.675s)
[528.090519] [056/133] (492s left) api_intel_bb (object-reloc-keep-cache)
[528.145036] Starting subtest: object-reloc-keep-cache
[528.149570] Subtest object-reloc-keep-cache: SKIP (0.003s)
[528.237954] [057/133] (492s left) kms_flip (absolute-wf_vblank)
[528.335093] Starting subtest: absolute-wf_vblank
[528.337429] Starting dynamic subtest: A-eDP1
[537.052614] Dynamic subtest A-eDP1: SUCCESS (8.680s)
[537.064692] Starting dynamic subtest: B-eDP1
[545.756641] Dynamic subtest B-eDP1: SUCCESS (8.701s)
[545.766508] Starting dynamic subtest: C-eDP1
[554.474508] Dynamic subtest C-eDP1: SUCCESS (8.704s)
[554.484573] Starting dynamic subtest: D-eDP1
[563.153309] Dynamic subtest D-eDP1: SUCCESS (8.673s)
[563.155718] Subtest absolute-wf_vblank: SUCCESS (34.769s)
[564.290260] [058/133] (456s left) gem_exec_schedule (preempt-other-chain)
[564.366427] Starting subtest: preempt-other-chain
[564.368772] Starting dynamic subtest: rcs0
[564.440307] Dynamic subtest rcs0: SUCCESS (0.080s)
[564.457771] Starting dynamic subtest: bcs0
[564.516186] Dynamic subtest bcs0: SUCCESS (0.074s)
[564.530162] Starting dynamic subtest: vcs0
[564.593242] Dynamic subtest vcs0: SUCCESS (0.077s)
[564.605327] Starting dynamic subtest: vcs1
[564.680663] Dynamic subtest vcs1: SUCCESS (0.087s)
[564.692956] Starting dynamic subtest: vecs0
[564.761443] Dynamic subtest vecs0: SUCCESS (0.079s)
[564.772330] Starting dynamic subtest: ccs0
[564.846886] Dynamic subtest ccs0: SUCCESS (0.086s)
[564.849087] Subtest preempt-other-chain: SUCCESS (0.487s)
[566.237252] [059/133] (454s left) gem_exec_schedule (u-fairslice)
[566.320382] Starting subtest: u-fairslice
[566.322635] Starting dynamic subtest: rcs0
[568.337392] Dynamic subtest rcs0: SUCCESS (2.024s)
[568.347304] Starting dynamic subtest: bcs0
[570.360045] Dynamic subtest bcs0: SUCCESS (2.022s)
[570.370563] Starting dynamic subtest: vcs0
[572.378548] Dynamic subtest vcs0: SUCCESS (2.018s)
[572.389994] Starting dynamic subtest: vcs1
[574.399737] Dynamic subtest vcs1: SUCCESS (2.020s)
[574.411396] Starting dynamic subtest: vecs0
[576.422391] Dynamic subtest vecs0: SUCCESS (2.020s)
[576.434091] Starting dynamic subtest: ccs0
[578.443455] Dynamic subtest ccs0: SUCCESS (2.021s)
[578.445492] Subtest u-fairslice: SUCCESS (12.130s)
[578.784356] [060/133] (442s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[578.891510] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[578.895909] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[578.972418] [061/133] (441s left) kms_cursor_crc (cursor-sliding-256x85)
[579.229724] Starting subtest: cursor-sliding-256x85
[579.278996] Subtest cursor-sliding-256x85: SKIP (0.045s)
[579.468628] [062/133] (441s left) gem_shrink (reclaim)
[579.533843] Starting subtest: reclaim
[582.004607] Subtest reclaim: SUCCESS (2.469s)
[582.107973] [063/133] (438s left) syncobj_timeline (wait-for-submit-complex)
[582.181635] Starting subtest: wait-for-submit-complex
[582.242479] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[582.325174] [064/133] (438s left) kms_dsc (dsc-with-formats)
[582.433139] Starting subtest: dsc-with-formats
[582.472450] Subtest dsc-with-formats: SKIP (0.001s)
[582.513474] [065/133] (438s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[582.646778] Starting subtest: flip-vs-cursor-atomic
[589.698794] Subtest flip-vs-cursor-atomic: SUCCESS (7.053s)
[590.497498] [066/133] (430s left) kms_vblank (query-forked-busy)
[590.604429] Starting subtest: query-forked-busy
[590.606383] Starting dynamic subtest: pipe-A-eDP-1
[592.479101] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[592.494700] Starting dynamic subtest: pipe-D-eDP-1
[595.023351] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.540s)
[595.025696] Subtest query-forked-busy: SUCCESS (4.420s)
[595.889214] [067/133] (425s left) kms_lease (lease-unleased-connector)
[595.983467] Starting subtest: lease-unleased-connector
[595.985780] Starting dynamic subtest: pipe-A-eDP-1
[595.990885] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[596.001848] Starting dynamic subtest: pipe-B-eDP-1
[596.004245] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s)
[596.014331] Starting dynamic subtest: pipe-C-eDP-1
[596.016657] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[596.026473] Starting dynamic subtest: pipe-D-eDP-1
[596.028308] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[596.030134] Subtest lease-unleased-connector: SUCCESS (0.040s)
[596.150456] [068/133] (425s left) kms_addfb_basic (bad-pitch-63)
[596.208606] Starting subtest: bad-pitch-63
[596.210952] Subtest bad-pitch-63: SUCCESS (0.000s)
[596.354831] [069/133] (424s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[596.447620] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[596.451741] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[596.558028] [070/133] (424s left) gem_exec_params (dr1-dirt)
[596.612740] Starting subtest: DR1-dirt
[596.614812] Subtest DR1-dirt: SUCCESS (0.000s)
[596.702897] [071/133] (424s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[596.809932] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[596.814304] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[596.892842] [072/133] (424s left) kms_rmfb (rmfb-ioctl)
[596.978742] Starting subtest: rmfb-ioctl
[596.980445] Starting dynamic subtest: pipe-A-eDP-1
[597.082580] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s)
[597.092722] Starting dynamic subtest: pipe-B-eDP-1
[598.225080] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.140s)
[598.237469] Starting dynamic subtest: pipe-C-eDP-1
[599.398875] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.172s)
[599.413885] Starting dynamic subtest: pipe-D-eDP-1
[600.603127] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.202s)
[600.605466] Subtest rmfb-ioctl: SUCCESS (3.627s)
[601.793041] [073/133] (419s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[601.898923] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[608.472115] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.576s)
[608.598394] [074/133] (412s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[608.707696] Starting subtest: fbc-rgb565-draw-blt
[612.827936] Subtest fbc-rgb565-draw-blt: SUCCESS (4.124s)
[613.994412] [075/133] (407s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[614.084034] Starting subtest: crc-primary-basic-yf-tiled-ccs
[614.086176] Starting dynamic subtest: pipe-A-eDP-1
[614.108240] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[614.120283] Starting dynamic subtest: pipe-B-eDP-1
[614.141611] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[614.151704] Starting dynamic subtest: pipe-C-eDP-1
[614.173104] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[614.183463] Starting dynamic subtest: pipe-D-eDP-1
[614.206579] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[614.210659] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[616.285366] [076/133] (405s left) i915_pm_rpm (sysfs-read)
[618.312554] Starting subtest: sysfs-read
[619.463449] Subtest sysfs-read: SUCCESS (1.149s)
[619.825153] [077/133] (401s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[619.912384] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[619.914782] Starting dynamic subtest: pipe-A-default-mode
[622.558282] Dynamic subtest pipe-A-default-mode: SUCCESS (2.646s)
[622.560571] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.647s)
[623.387140] [078/133] (398s left) gem_unfence_active_buffers
[623.547287] [079/133] (398s left) gem_exec_suspend (basic)
[623.607361] Starting subtest: basic
[623.609838] Starting dynamic subtest: smem
[625.147955] Dynamic subtest smem: SUCCESS (1.538s)
[625.150898] Subtest basic: SUCCESS (1.540s)
[625.335931] [080/133] (396s left) gem_exec_whisper (basic-sync)
[625.398242] Starting subtest: basic-sync
[635.532410] Subtest basic-sync: SUCCESS (10.114s)
[635.720736] [081/133] (386s left) gem_exec_params (invalid-bsd-ring)
[635.782535] Starting subtest: invalid-bsd-ring
[635.784800] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[635.888467] [082/133] (385s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[635.985428] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[635.989446] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[636.074777] [083/133] (385s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[636.143019] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[636.223607] [084/133] (385s left) gem_exec_fence (syncobj-signal)
[636.706202] Starting subtest: syncobj-signal
[636.712227] Subtest syncobj-signal: SUCCESS (0.005s)
[638.223111] [085/133] (383s left) i915_query (query-topology-coherent-slice-mask)
[638.286273] Starting subtest: query-topology-coherent-slice-mask
[638.290813] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[638.384215] [086/133] (383s left) syncobj_eventfd (invalid-illegal-handle)
[638.440585] Starting subtest: invalid-illegal-handle
[638.442859] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[638.530632] [087/133] (383s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[638.621175] Starting subtest: psr2-cursor-plane-update-sf
[638.623453] Starting dynamic subtest: pipe-A-eDP-1
[639.190183] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.572s)
[639.201969] Starting dynamic subtest: pipe-B-eDP-1
[640.454006] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.261s)
[640.456433] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.835s)
[641.285806] [088/133] (380s left) kms_flip (flip-vs-expired-vblank)
[641.383457] Starting subtest: flip-vs-expired-vblank
[641.385894] Starting dynamic subtest: A-eDP1
[650.092075] Dynamic subtest A-eDP1: SUCCESS (8.677s)
[650.103986] Starting dynamic subtest: B-eDP1
[658.790356] Dynamic subtest B-eDP1: SUCCESS (8.701s)
[658.801026] Starting dynamic subtest: C-eDP1
[667.486191] Dynamic subtest C-eDP1: SUCCESS (8.679s)
[667.498154] Starting dynamic subtest: D-eDP1
[676.184561] Dynamic subtest D-eDP1: SUCCESS (8.697s)
[676.187231] Subtest flip-vs-expired-vblank: SUCCESS (34.763s)
[677.365767] [089/133] (344s left) gem_create (create-massive)
[677.423482] Starting subtest: create-massive
[677.425437] Subtest create-massive: SUCCESS (0.000s)
[677.608433] [090/133] (344s left) kms_flip (flip-vs-wf_vblank-interruptible)
[677.701917] Starting subtest: flip-vs-wf_vblank-interruptible
[677.704243] Starting dynamic subtest: A-eDP1
[679.581674] Dynamic subtest A-eDP1: SUCCESS (1.879s)
[679.593806] Starting dynamic subtest: B-eDP1
[681.491239] Dynamic subtest B-eDP1: SUCCESS (1.907s)
[681.506247] Starting dynamic subtest: C-eDP1
[683.369729] Dynamic subtest C-eDP1: SUCCESS (1.876s)
[683.384015] Starting dynamic subtest: D-eDP1
[685.275020] Dynamic subtest D-eDP1: SUCCESS (1.903s)
[685.279875] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.578s)
[686.503961] [091/133] (335s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[686.608662] Starting subtest: psr-rgb101010-draw-mmap-cpu
[693.599924] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (6.994s)
[693.704807] [092/133] (328s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[693.771297] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[693.841648] [093/133] (328s left) gem_mmap_gtt (isolation)
[693.909146] Subtest isolation: SKIP (0.000s)
[693.972706] [094/133] (328s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[694.067750] Starting subtest: plane-lut1d-post-ctm3x4
[694.224931] Starting dynamic subtest: pipe-A-plane-0
[694.576915] Dynamic subtest pipe-A-plane-0: FAIL (0.193s)
[694.588507] Starting dynamic subtest: pipe-A-plane-1
[694.767561] Dynamic subtest pipe-A-plane-1: FAIL (0.158s)
[694.778992] Starting dynamic subtest: pipe-A-plane-2
[694.984088] Dynamic subtest pipe-A-plane-2: FAIL (0.176s)
[695.960499] Starting dynamic subtest: pipe-B-plane-0
[696.425102] Dynamic subtest pipe-B-plane-0: FAIL (0.197s)
[696.438983] Starting dynamic subtest: pipe-B-plane-1
[696.747132] Dynamic subtest pipe-B-plane-1: FAIL (0.155s)
[696.759011] Starting dynamic subtest: pipe-B-plane-2
[697.055339] Dynamic subtest pipe-B-plane-2: FAIL (0.617s)
[698.155791] Starting dynamic subtest: pipe-C-plane-0
[698.686970] Dynamic subtest pipe-C-plane-0: FAIL (0.172s)
[698.697122] Starting dynamic subtest: pipe-C-plane-1
[699.083931] Dynamic subtest pipe-C-plane-1: FAIL (0.618s)
[699.094619] Starting dynamic subtest: pipe-C-plane-2
[699.454898] Dynamic subtest pipe-C-plane-2: FAIL (0.169s)
[700.325558] Starting dynamic subtest: pipe-D-plane-0
[700.941354] Dynamic subtest pipe-D-plane-0: FAIL (0.162s)
[700.952914] Starting dynamic subtest: pipe-D-plane-1
[701.405501] Dynamic subtest pipe-D-plane-1: FAIL (0.601s)
[701.417304] Starting dynamic subtest: pipe-D-plane-2
[701.847512] Dynamic subtest pipe-D-plane-2: FAIL (0.550s)
[701.924288] Subtest plane-lut1d-post-ctm3x4: FAIL (7.860s)
[702.775916] [095/133] (319s left) kms_prime (d3hot)
[702.870012] Subtest D3hot: SKIP (0.000s)
[702.975231] [096/133] (319s left) gem_exec_reloc (basic-wc-gtt)
[703.034145] Subtest basic-wc-gtt: SKIP (0.000s)
[703.094070] [097/133] (319s left) gem_exec_balancer (parallel)
[703.355481] Starting subtest: parallel
[704.294700] Subtest parallel: SUCCESS (0.939s)
[705.123867] [098/133] (317s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[705.218471] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[705.223079] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[706.356411] [099/133] (316s left) kms_flip (plain-flip-interruptible)
[706.462499] Starting subtest: plain-flip-interruptible
[706.464838] Starting dynamic subtest: A-eDP1
[708.153347] Dynamic subtest A-eDP1: SUCCESS (1.689s)
[708.174787] Starting dynamic subtest: B-eDP1
[709.845907] Dynamic subtest B-eDP1: SUCCESS (1.689s)
[709.863040] Starting dynamic subtest: C-eDP1
[711.534882] Dynamic subtest C-eDP1: SUCCESS (1.688s)
[711.549317] Starting dynamic subtest: D-eDP1
[713.238474] Dynamic subtest D-eDP1: SUCCESS (1.701s)
[713.240882] Subtest plain-flip-interruptible: SUCCESS (6.780s)
[714.459250] [100/133] (308s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[714.554408] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[714.556617] Starting dynamic subtest: pipe-A-eDP-1
[714.578738] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[714.590506] Starting dynamic subtest: pipe-B-eDP-1
[714.611378] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[714.621021] Starting dynamic subtest: pipe-C-eDP-1
[714.642154] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[714.651218] Starting dynamic subtest: pipe-D-eDP-1
[714.673066] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[714.677347] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s)
[716.767527] [101/133] (305s left) gem_ctx_param (vm)
[716.828065] Starting subtest: vm
[716.880911] Subtest vm: SUCCESS (0.052s)
[717.014129] [102/133] (305s left) kms_properties (plane-properties-legacy)
[717.115639] Starting subtest: plane-properties-legacy
[717.117623] Starting dynamic subtest: pipe-A-eDP-1
[717.677169] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.561s)
[717.687357] Starting dynamic subtest: pipe-B-eDP-1
[718.911409] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.233s)
[718.922280] Starting dynamic subtest: pipe-C-eDP-1
[720.205732] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.294s)
[720.215917] Starting dynamic subtest: pipe-D-eDP-1
[721.501475] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.293s)
[721.503404] Subtest plane-properties-legacy: SUCCESS (4.386s)
[722.378515] [103/133] (300s left) gem_pxp (reject-modify-context-protection-off-3)
[722.508655] Starting subtest: reject-modify-context-protection-off-3
[722.511154] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[722.629805] [104/133] (300s left) prime_self_import (basic-with_one_bo_two_files)
[722.667757] Starting subtest: basic-with_one_bo_two_files
[722.692762] Subtest basic-with_one_bo_two_files: SUCCESS (0.024s)
[722.811308] [105/133] (299s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[722.908891] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[722.911131] Starting dynamic subtest: pipe-A
[722.973120] Dynamic subtest pipe-A: SUCCESS (0.065s)
[722.983643] Starting dynamic subtest: pipe-B
[724.147711] Dynamic subtest pipe-B: SUCCESS (1.174s)
[724.159539] Starting dynamic subtest: pipe-C
[725.233446] Dynamic subtest pipe-C: SUCCESS (1.084s)
[725.244472] Starting dynamic subtest: pipe-D
[726.329533] Dynamic subtest pipe-D: SUCCESS (1.096s)
[726.331791] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.423s)
[727.463407] [106/133] (295s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[727.564156] Starting subtest: 4-tiled-16bpp-rotate-90
[727.583017] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.018s)
[727.702496] [107/133] (295s left) gen9_exec_parse (batch-invalid-length)
[727.757715] Subtest batch-invalid-length: SKIP (0.000s)
[727.826347] [108/133] (295s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[727.867867] Starting subtest: invalid-signal-one-illegal-handle
[727.870212] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[727.964954] [109/133] (295s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[728.071425] Starting subtest: x-tiled-64bpp-rotate-180
[729.695042] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.623s)
[729.879478] [110/133] (293s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[729.995203] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[729.998643] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[730.074822] [111/133] (292s left) gem_exec_params (invalid-ring2)
[730.130985] Starting subtest: invalid-ring2
[730.132970] Subtest invalid-ring2: SUCCESS (0.000s)
[730.240645] [112/133] (292s left) gem_vm_create (invalid-create)
[730.300743] Starting subtest: invalid-create
[730.302728] Subtest invalid-create: SUCCESS (0.002s)
[730.410118] [113/133] (292s left) kms_addfb_basic (bad-pitch-128)
[730.460946] Starting subtest: bad-pitch-128
[730.462964] Subtest bad-pitch-128: SUCCESS (0.000s)
[730.594397] [114/133] (292s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[730.652584] Starting subtest: single-wait-all-for-submit-available-submitted
[730.654562] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[730.765004] [115/133] (292s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[730.897963] Starting subtest: cursorB-vs-flipA-toggle
[730.901701] Subtest cursorB-vs-flipA-toggle: SKIP (0.002s)
[731.055247] [116/133] (292s left) prime_vgem (fence-write-hang)
[731.132393] Subtest fence-write-hang: SKIP (0.000s)
[731.239868] [117/133] (292s left) fbdev (eof)
[731.278774] Starting subtest: eof
[731.280552] Subtest eof: SUCCESS (0.000s)
[731.360722] [118/133] (291s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[731.477341] Starting subtest: 2x-flip-vs-cursor-atomic
[731.481178] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[731.634549] [119/133] (291s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[731.728217] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[731.731571] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[731.830574] [120/133] (291s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[731.928993] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[738.764239] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.837s)
[738.909542] [121/133] (284s left) prime_mmap_kms (buffer-sharing)
[738.998363] Starting subtest: buffer-sharing
[739.444102] Subtest buffer-sharing: SUCCESS (0.445s)
[740.256525] [122/133] (283s left) gem_exec_fence (basic-await)
[740.426590] Starting subtest: basic-await
[740.429116] Starting dynamic subtest: rcs0
[740.500616] Dynamic subtest rcs0: SUCCESS (0.074s)
[740.514087] Starting dynamic subtest: bcs0
[740.582819] Dynamic subtest bcs0: SUCCESS (0.080s)
[740.596614] Starting dynamic subtest: vcs0
[740.656594] Dynamic subtest vcs0: SUCCESS (0.072s)
[740.669676] Starting dynamic subtest: vcs1
[740.729295] Dynamic subtest vcs1: SUCCESS (0.071s)
[740.742074] Starting dynamic subtest: vecs0
[740.801722] Dynamic subtest vecs0: SUCCESS (0.071s)
[740.815267] Starting dynamic subtest: ccs0
[740.874647] Dynamic subtest ccs0: SUCCESS (0.072s)
[740.877129] Subtest basic-await: SUCCESS (0.449s)
[742.249923] [123/133] (281s left) prime_busy (before-wait)
[742.309706] Starting subtest: before-wait
[742.315697] Starting dynamic subtest: rcs0
[742.337539] Dynamic subtest rcs0: SUCCESS (0.025s)
[742.351780] Starting dynamic subtest: bcs0
[742.399092] Dynamic subtest bcs0: SUCCESS (0.061s)
[742.409890] Starting dynamic subtest: vcs0
[742.440866] Dynamic subtest vcs0: SUCCESS (0.041s)
[742.450979] Starting dynamic subtest: vcs1
[742.481921] Dynamic subtest vcs1: SUCCESS (0.040s)
[742.491871] Starting dynamic subtest: vecs0
[742.522880] Dynamic subtest vecs0: SUCCESS (0.040s)
[742.532952] Starting dynamic subtest: ccs0
[742.563183] Dynamic subtest ccs0: SUCCESS (0.040s)
[742.672106] Subtest before-wait: SUCCESS (0.361s)
[742.758366] [124/133] (280s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[742.897731] Starting subtest: short-busy-flip-before-cursor-toggle
[742.902475] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[743.056606] [125/133] (280s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[743.114407] Starting subtest: invalid-multi-wait-unsubmitted
[743.116666] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[743.237290] [126/133] (280s left) gem_mmap_wc (invalid-flags)
[743.289377] Subtest invalid-flags: SKIP (0.000s)
[743.350108] [127/133] (280s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[743.457921] Starting subtest: yf-tiled-64bpp-rotate-270
[743.462482] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[743.547314] [128/133] (280s left) kms_tv_load_detect (load-detect)
[743.616630] Subtest load-detect: SKIP (0.000s)
[743.683024] [129/133] (280s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[743.781258] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[743.784806] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[743.873659] [130/133] (280s left) syncobj_wait (wait-any-complex)
[743.936271] Starting subtest: wait-any-complex
[743.996933] Subtest wait-any-complex: SUCCESS (0.062s)
[744.076183] [131/133] (279s left) sw_sync (sync_expired_merge)
[744.113232] Starting subtest: sync_expired_merge
[745.183100] Subtest sync_expired_merge: SUCCESS (1.074s)
[745.247602] [132/133] (278s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[745.360301] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[745.364772] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[745.461189] [133/133] (278s left) kms_psr (psr-suspend)
[745.551406] Starting subtest: psr-suspend
[745.553737] Starting dynamic subtest: eDP-1
[763.734091] Dynamic subtest eDP-1: SUCCESS (2.984s)
[763.736527] Subtest psr-suspend: SUCCESS (2.985s)
[764.564055] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_gttfill
results: parsing output: 1/ for test: perf
results: parsing output: 2/ for test: kms_joiner
results: parsing output: 3/ for test: prime_mmap
results: parsing output: 4/ for test: kms_plane
results: parsing output: 5/ for test: kms_async_flips
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: gem_exec_flush
results: parsing output: 8/ for test: gem_userptr_blits
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: i915_drm_fdinfo
results: parsing output: 18/ for test: perf_pmu
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: gem_workarounds
results: parsing output: 23/ for test: kms_fence_pin_leak
results: parsing output: 24/ for test: gem_render_copy
results: parsing output: 25/ for test: kms_cdclk
results: parsing output: 26/ for test: gem_exec_params
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: gem_exec_store
results: parsing output: 29/ for test: gem_ctx_persistence
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: i915_hangman
results: parsing output: 32/ for test: kms_force_connector_basic
results: parsing output: 33/ for test: kms_universal_plane
results: parsing output: 34/ for test: dmabuf_sync_file
results: parsing output: 35/ for test: kms_pm_dc
results: parsing output: 36/ for test: gem_render_copy_redux
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_mmap_wc
results: parsing output: 41/ for test: gem_softpin
results: parsing output: 42/ for test: kms_content_protection
results: parsing output: 43/ for test: gem_ctx_shared
results: parsing output: 44/ for test: gem_softpin
results: parsing output: 45/ for test: kms_plane_alpha_blend
results: parsing output: 46/ for test: kms_busy
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_plane_multiple
results: parsing output: 49/ for test: kms_chamelium_frames
results: parsing output: 50/ for test: i915_suspend
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_chamelium_hpd
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: kms_psr2_sf
results: parsing output: 55/ for test: api_intel_bb
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: gem_exec_schedule
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_cursor_crc
results: parsing output: 61/ for test: gem_shrink
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_dsc
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: kms_vblank
results: parsing output: 66/ for test: kms_lease
results: parsing output: 67/ for test: kms_addfb_basic
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_exec_params
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_rmfb
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: i915_pm_rpm
results: parsing output: 76/ for test: kms_flip_scaled_crc
results: parsing output: 77/ for test: gem_unfence_active_buffers
results: parsing output: 78/ for test: gem_exec_suspend
results: parsing output: 79/ for test: gem_exec_whisper
results: parsing output: 80/ for test: gem_exec_params
results: parsing output: 81/ for test: kms_flip_scaled_crc
results: parsing output: 82/ for test: gem_fenced_exec_thrash
results: parsing output: 83/ for test: gem_exec_fence
results: parsing output: 84/ for test: i915_query
results: parsing output: 85/ for test: syncobj_eventfd
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: gem_create
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_mmap_gtt
results: parsing output: 92/ for test: gem_mmap_gtt
results: parsing output: 93/ for test: kms_color_pipeline
results: parsing output: 94/ for test: kms_prime
results: parsing output: 95/ for test: gem_exec_reloc
results: parsing output: 96/ for test: gem_exec_balancer
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: gem_ctx_param
results: parsing output: 101/ for test: kms_properties
results: parsing output: 102/ for test: gem_pxp
results: parsing output: 103/ for test: prime_self_import
results: parsing output: 104/ for test: kms_plane_scaling
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: gen9_exec_parse
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_exec_params
results: parsing output: 111/ for test: gem_vm_create
results: parsing output: 112/ for test: kms_addfb_basic
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: prime_vgem
results: parsing output: 116/ for test: fbdev
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: prime_mmap_kms
results: parsing output: 121/ for test: gem_exec_fence
results: parsing output: 122/ for test: prime_busy
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: gem_mmap_wc
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_tv_load_detect
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: sw_sync
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_psr
Done.