[59.295736] Initializing watchdogs
[59.295786]   /dev/watchdog0
[59.310244] [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]
[59.314728] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.317456] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.320709] [001/133] (960s left) gem_exec_gttfill (engines)
[59.402859] Starting subtest: engines
[59.405276] Starting dynamic subtest: rcs0
[82.890267] Dynamic subtest rcs0: SUCCESS (23.486s)
[82.898091] Starting dynamic subtest: bcs0
[106.166338] Dynamic subtest bcs0: SUCCESS (23.274s)
[106.176975] Starting dynamic subtest: vcs0
[129.428838] Dynamic subtest vcs0: SUCCESS (23.262s)
[129.438904] Starting dynamic subtest: vcs1
[152.715231] Dynamic subtest vcs1: SUCCESS (23.284s)
[152.725652] Starting dynamic subtest: vecs0
[176.038716] Dynamic subtest vecs0: SUCCESS (23.321s)
[176.049069] Starting dynamic subtest: ccs0
[199.386714] Dynamic subtest ccs0: SUCCESS (23.346s)
[199.389514] Subtest engines: SUCCESS (139.978s)
[199.594128] [002/133] (820s left) perf (gen12-unprivileged-single-ctx-counters)
[199.780391] Starting subtest: gen12-unprivileged-single-ctx-counters
[199.782592] Starting dynamic subtest: rcs0
[200.224877] Dynamic subtest rcs0: SUCCESS (0.446s)
[200.227329] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.447s)
[200.275566] [003/133] (819s left) kms_joiner (basic-ultra-joiner)
[200.404532] Starting subtest: basic-ultra-joiner
[200.408835] Subtest basic-ultra-joiner: SKIP (0.000s)
[200.469082] [004/133] (819s left) prime_mmap (test_aperture_limit)
[200.524987] Starting subtest: test_aperture_limit
[200.526718] Starting dynamic subtest: test_aperture_limit-smem
[200.537065] Dynamic subtest test_aperture_limit-smem: SKIP (0.010s)
[200.540368] Subtest test_aperture_limit: SKIP (0.011s)
[200.611552] [005/133] (819s left) kms_plane (plane-position-hole)
[200.707941] Starting subtest: plane-position-hole
[201.259797] Starting dynamic subtest: pipe-A-plane-1
[202.598308] Dynamic subtest pipe-A-plane-1: SUCCESS (1.338s)
[202.608851] Starting dynamic subtest: pipe-A-plane-2
[203.908852] Dynamic subtest pipe-A-plane-2: SUCCESS (1.310s)
[203.917828] Starting dynamic subtest: pipe-A-plane-3
[205.250187] Dynamic subtest pipe-A-plane-3: SUCCESS (1.341s)
[205.259460] Starting dynamic subtest: pipe-A-plane-4
[206.557539] Dynamic subtest pipe-A-plane-4: SUCCESS (1.308s)
[206.566595] Starting dynamic subtest: pipe-A-plane-5
[206.585357] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[207.747619] Starting dynamic subtest: pipe-B-plane-1
[209.111535] Dynamic subtest pipe-B-plane-1: SUCCESS (1.371s)
[209.121289] Starting dynamic subtest: pipe-B-plane-2
[210.382296] Dynamic subtest pipe-B-plane-2: SUCCESS (1.270s)
[210.393185] Starting dynamic subtest: pipe-B-plane-3
[211.699477] Dynamic subtest pipe-B-plane-3: SUCCESS (1.315s)
[211.708723] Starting dynamic subtest: pipe-B-plane-4
[212.957218] Dynamic subtest pipe-B-plane-4: SUCCESS (1.258s)
[212.966207] Starting dynamic subtest: pipe-B-plane-5
[212.981411] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[212.983674] Subtest plane-position-hole: SUCCESS (12.271s)
[213.822422] [006/133] (806s left) kms_async_flips (alternate-sync-async-flip-atomic)
[213.937261] Starting subtest: alternate-sync-async-flip-atomic
[214.311488] Starting dynamic subtest: pipe-A-eDP-1
[217.119545] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.809s)
[217.499050] Starting dynamic subtest: pipe-B-eDP-1
[220.246976] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.755s)
[220.624523] Starting dynamic subtest: pipe-C-eDP-1
[223.377913] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.761s)
[223.744965] Starting dynamic subtest: pipe-D-eDP-1
[226.504094] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.767s)
[226.506092] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.569s)
[227.671701] [007/133] (792s left) kms_cursor_crc (cursor-random-64x21)
[227.877513] Starting subtest: cursor-random-64x21
[227.923914] Subtest cursor-random-64x21: SKIP (0.042s)
[228.149948] [008/133] (791s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[228.213484] Starting subtest: basic-batch-kernel-default-cmd
[228.217607] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[228.394638] [009/133] (791s left) gem_userptr_blits (map-fixed-invalidate)
[228.457244] Starting subtest: map-fixed-invalidate
[228.461993] Subtest map-fixed-invalidate: SKIP (0.000s)
[228.587785] [010/133] (791s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[228.652263] Starting subtest: multi-wait-for-submit-submitted-signaled
[228.654664] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[228.769531] [011/133] (791s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[228.881100] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[229.694117] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.815s)
[229.852195] [012/133] (790s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[229.971476] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[261.369180] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.396s)
[262.203307] [013/133] (758s left) kms_psr (psr2-basic)
[262.302619] Starting subtest: psr2-basic
[262.304792] Starting dynamic subtest: eDP-1
[263.895958] Dynamic subtest eDP-1: SUCCESS (1.593s)
[263.898251] Subtest psr2-basic: SUCCESS (1.594s)
[264.702400] [014/133] (755s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[264.801364] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[264.805860] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[264.896650] [015/133] (755s left) kms_big_fb (linear-16bpp-rotate-180)
[264.999350] Starting subtest: linear-16bpp-rotate-180
[266.344873] Subtest linear-16bpp-rotate-180: SUCCESS (1.345s)
[266.477746] [016/133] (753s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[266.568016] Starting subtest: bad-pixel-format-y-tiled-ccs
[266.569847] Starting dynamic subtest: pipe-A-eDP-1
[266.587708] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[266.602050] Starting dynamic subtest: pipe-B-eDP-1
[266.620657] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[266.628068] Starting dynamic subtest: pipe-C-eDP-1
[266.645569] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[266.652652] Starting dynamic subtest: pipe-D-eDP-1
[266.670734] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[266.674225] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[268.854795] [017/133] (751s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[268.955758] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[268.960182] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[269.024973] [018/133] (751s left) i915_drm_fdinfo (most-busy-idle-check-all)
[269.062751] Starting subtest: most-busy-idle-check-all
[269.065295] Starting dynamic subtest: rcs0
[269.069910] Dynamic subtest rcs0: SKIP (0.004s)
[269.079055] Starting dynamic subtest: bcs0
[269.083090] Dynamic subtest bcs0: SKIP (0.000s)
[269.091218] Starting dynamic subtest: vcs0
[269.095477] Dynamic subtest vcs0: SKIP (0.000s)
[269.103423] Starting dynamic subtest: vcs1
[269.107778] Dynamic subtest vcs1: SKIP (0.000s)
[269.115477] Starting dynamic subtest: vecs0
[269.119836] Dynamic subtest vecs0: SKIP (0.000s)
[269.127607] Starting dynamic subtest: ccs0
[269.131965] Dynamic subtest ccs0: SKIP (0.000s)
[269.136407] Subtest most-busy-idle-check-all: SKIP (0.008s)
[269.171450] [019/133] (751s left) perf_pmu (rc6-suspend)
[269.213677] Starting subtest: rc6-suspend
[291.953709] Subtest rc6-suspend: SUCCESS (7.617s)
[292.828114] [020/133] (727s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[292.946434] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[292.950607] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[293.045026] [021/133] (727s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[293.137337] Starting subtest: fbc-psr2-sprite-plane-onoff
[293.139277] Starting dynamic subtest: eDP-1
[293.142757] Dynamic subtest eDP-1: SKIP (0.000s)
[293.146181] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[293.209770] [022/133] (727s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[293.304162] Starting subtest: 4-tiled-16bpp-rotate-0
[294.664856] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.358s)
[294.794919] [023/133] (725s left) gem_workarounds (reset-fd)
[294.861553] Starting subtest: reset-fd
[295.044245] Subtest reset-fd: SUCCESS (0.183s)
[295.170235] [024/133] (725s left) kms_fence_pin_leak
[295.345977] [025/133] (725s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[295.404518] Starting subtest: y-tiled-to-vebox-y-tiled
[295.407981] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[295.589413] [026/133] (725s left) kms_cdclk (mode-transition)
[295.707597] Starting subtest: mode-transition
[295.709942] Starting dynamic subtest: pipe-A-eDP-1
[296.009905] Dynamic subtest pipe-A-eDP-1: SKIP (0.300s)
[296.019483] Starting dynamic subtest: pipe-B-eDP-1
[296.023688] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[296.032910] Starting dynamic subtest: pipe-C-eDP-1
[296.037338] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[296.046473] Starting dynamic subtest: pipe-D-eDP-1
[296.050680] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[296.054977] Subtest mode-transition: SKIP (0.308s)
[296.897097] [027/133] (723s left) gem_exec_params (dr4-dirt)
[296.956410] Starting subtest: DR4-dirt
[296.958650] Subtest DR4-dirt: SUCCESS (0.000s)
[297.052578] [028/133] (723s left) syncobj_wait (multi-wait-all-submitted)
[297.109216] Starting subtest: multi-wait-all-submitted
[297.214856] Subtest multi-wait-all-submitted: SUCCESS (0.105s)
[297.289455] [029/133] (723s left) gem_exec_store (basic)
[297.353877] Starting subtest: basic
[297.455142] Subtest basic: SUCCESS (0.102s)
[297.661769] [030/133] (723s left) gem_ctx_persistence (saturated-hostile)
[297.726748] Starting subtest: saturated-hostile
[297.728705] Starting dynamic subtest: rcs0
[298.513164] Dynamic subtest rcs0: SUCCESS (0.788s)
[298.525182] Starting dynamic subtest: bcs0
[299.276614] Dynamic subtest bcs0: SUCCESS (0.761s)
[299.289077] Starting dynamic subtest: vcs0
[300.061577] Dynamic subtest vcs0: SUCCESS (0.783s)
[300.073310] Starting dynamic subtest: vcs1
[300.851292] Dynamic subtest vcs1: SUCCESS (0.787s)
[300.863670] Starting dynamic subtest: vecs0
[301.644867] Dynamic subtest vecs0: SUCCESS (0.792s)
[301.657296] Starting dynamic subtest: ccs0
[302.489919] Dynamic subtest ccs0: SUCCESS (0.843s)
[302.492652] Subtest saturated-hostile: SUCCESS (4.764s)
[302.583114] [031/133] (718s left) kms_psr (psr-cursor-plane-onoff)
[302.687920] Starting subtest: psr-cursor-plane-onoff
[302.690118] Starting dynamic subtest: eDP-1
[304.392770] Dynamic subtest eDP-1: SUCCESS (1.702s)
[304.395097] Subtest psr-cursor-plane-onoff: SUCCESS (1.703s)
[305.266108] [032/133] (715s left) i915_hangman (detector)
[305.326833] Starting subtest: detector
[305.328814] Starting dynamic subtest: rcs0
[316.994048] Dynamic subtest rcs0: SUCCESS (11.663s)
[317.006693] Starting dynamic subtest: bcs0
[328.961913] Dynamic subtest bcs0: SUCCESS (11.963s)
[328.974090] Starting dynamic subtest: vcs0
[339.969310] Dynamic subtest vcs0: SUCCESS (11.003s)
[339.981718] Starting dynamic subtest: vcs1
[351.937666] Dynamic subtest vcs1: SUCCESS (11.964s)
[351.951462] Starting dynamic subtest: vecs0
[362.944698] Dynamic subtest vecs0: SUCCESS (11.003s)
[362.957902] Starting dynamic subtest: ccs0
[374.017563] Dynamic subtest ccs0: SUCCESS (11.070s)
[374.020584] Subtest detector: SUCCESS (68.679s)
[374.162083] [033/133] (646s left) kms_force_connector_basic (force-connector-state)
[374.248065] Starting subtest: force-connector-state
[374.873736] Subtest force-connector-state: SUCCESS (0.625s)
[375.823590] [034/133] (645s left) kms_universal_plane (universal-plane-sanity)
[375.917105] Starting subtest: universal-plane-sanity
[375.919395] Starting dynamic subtest: pipe-A-eDP-1
[376.523558] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.606s)
[376.533767] Starting dynamic subtest: pipe-B-eDP-1
[377.716092] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.191s)
[377.725660] Starting dynamic subtest: pipe-C-eDP-1
[378.917207] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.197s)
[378.927662] Starting dynamic subtest: pipe-D-eDP-1
[380.148563] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[380.150950] Subtest universal-plane-sanity: SUCCESS (4.230s)
[381.000889] [035/133] (640s left) dmabuf_sync_file (import-multiple-read-write)
[381.109415] Starting subtest: import-multiple-read-write
[381.111581] Subtest import-multiple-read-write: SUCCESS (0.003s)
[381.167025] [FACT dmabuf_sync_file (import-multiple-read-write)] new: kernel.kmod_is_loaded.vgem: true
[381.170756] [036/133] (640s left) kms_pm_dc (dc5-dpms-negative)
[382.281243] Starting subtest: dc5-dpms-negative
[382.285753] Subtest dc5-dpms-negative: SKIP (0.000s)
[382.354952] [037/133] (638s left) gem_render_copy_redux (flink)
[382.406647] Starting subtest: flink
[383.264117] Subtest flink: SUCCESS (0.858s)
[383.396779] [038/133] (637s left) kms_cursor_crc (cursor-onscreen-64x64)
[383.576444] Starting subtest: cursor-onscreen-64x64
[383.584539] Starting dynamic subtest: pipe-A-eDP-1
[385.692692] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.112s)
[385.724165] Starting dynamic subtest: pipe-D-eDP-1
[388.501574] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.788s)
[388.503897] Subtest cursor-onscreen-64x64: SUCCESS (4.926s)
[389.364520] [039/133] (632s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[389.465499] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[389.469647] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[389.544759] [040/133] (631s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[389.639045] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[398.428440] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.796s)
[398.547277] [041/133] (622s left) gem_mmap_wc (bad-offset)
[398.610135] Subtest bad-offset: SKIP (0.000s)
[398.672646] [042/133] (622s left) gem_softpin (evict-single-offset)
[398.741557] Starting subtest: evict-single-offset
[424.995746] Subtest evict-single-offset: SUCCESS (26.256s)
[425.092569] [043/133] (596s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[425.295628] Starting subtest: dp-mst-type-1-suspend-resume
[425.299808] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[425.428677] [044/133] (596s left) gem_ctx_shared (q-out-order)
[425.496649] Starting subtest: Q-out-order
[425.499156] Starting dynamic subtest: rcs0
[425.619112] Dynamic subtest rcs0: SUCCESS (0.120s)
[425.632556] Starting dynamic subtest: vcs0
[425.712858] Dynamic subtest vcs0: SUCCESS (0.094s)
[425.731359] Starting dynamic subtest: vcs1
[425.795545] Dynamic subtest vcs1: SUCCESS (0.082s)
[425.813769] Starting dynamic subtest: vecs0
[425.875142] Dynamic subtest vecs0: SUCCESS (0.078s)
[425.891996] Starting dynamic subtest: ccs0
[425.968492] Dynamic subtest ccs0: SUCCESS (0.092s)
[425.971094] Subtest Q-out-order: SUCCESS (0.472s)
[427.134665] [045/133] (594s left) gem_softpin (softpin)
[427.201939] Starting subtest: softpin
[459.612123] Subtest softpin: SUCCESS (32.404s)
[459.728484] [046/133] (561s left) kms_plane_alpha_blend (coverage-7efc)
[459.824588] Starting subtest: coverage-7efc
[460.107183] Starting dynamic subtest: pipe-A-eDP-1
[460.709772] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.600s)
[460.738302] Starting dynamic subtest: pipe-D-eDP-1
[461.983719] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.252s)
[461.986060] Subtest coverage-7efc: SUCCESS (2.158s)
[462.834970] [047/133] (558s left) kms_busy (extended-pageflip-hang-oldfb)
[462.940918] Starting subtest: extended-pageflip-hang-oldfb
[462.943213] Starting dynamic subtest: pipe-A
[463.360165] Dynamic subtest pipe-A: SUCCESS (0.418s)
[463.370729] Starting dynamic subtest: pipe-D
[464.442676] Dynamic subtest pipe-D: SUCCESS (1.081s)
[464.444901] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.505s)
[465.293456] [048/133] (556s left) kms_big_fb (y-tiled-addfb)
[465.404581] Starting subtest: y-tiled-addfb
[465.409043] Subtest y-tiled-addfb: SKIP (0.000s)
[465.509031] [049/133] (556s left) kms_plane_multiple (tiling-none)
[465.600430] Starting subtest: tiling-none
[465.602742] Starting dynamic subtest: pipe-A-eDP-1
[469.325767] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.726s)
[469.336172] Starting dynamic subtest: pipe-B-eDP-1
[473.757085] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.429s)
[473.767204] Starting dynamic subtest: pipe-C-eDP-1
[478.092318] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.333s)
[478.102949] Starting dynamic subtest: pipe-D-eDP-1
[482.427597] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.334s)
[482.429735] Subtest tiling-none: SUCCESS (16.826s)
[483.246006] [050/133] (538s left) kms_chamelium_frames (dp-crc-fast)
[483.627201] Subtest dp-crc-fast: SKIP (0.000s)
[484.441601] [051/133] (537s left) i915_suspend (fence-restore-tiled2untiled)
[484.509013] Starting subtest: fence-restore-tiled2untiled
[484.513745] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[484.621484] [052/133] (537s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[484.715625] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[491.230621] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.517s)
[491.336775] [053/133] (530s left) kms_chamelium_hpd (hdmi-hpd-fast)
[491.742509] Subtest hdmi-hpd-fast: SKIP (0.000s)
[492.595758] [054/133] (529s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[492.692851] Starting subtest: fbc-psr2-primary-mmap-cpu
[492.694962] Starting dynamic subtest: eDP-1
[492.698925] Dynamic subtest eDP-1: SKIP (0.000s)
[492.702903] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[492.767371] [055/133] (529s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[492.863184] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[492.865445] Starting dynamic subtest: pipe-A-eDP-1
[509.330168] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.469s)
[509.340452] Starting dynamic subtest: pipe-B-eDP-1
[526.472912] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.141s)
[526.475059] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.613s)
[527.273358] [056/133] (494s left) api_intel_bb (object-reloc-keep-cache)
[527.342045] Starting subtest: object-reloc-keep-cache
[527.346660] Subtest object-reloc-keep-cache: SKIP (0.003s)
[527.440884] [057/133] (494s left) kms_flip (absolute-wf_vblank)
[527.528597] Starting subtest: absolute-wf_vblank
[527.530937] Starting dynamic subtest: A-eDP1
[536.236759] Dynamic subtest A-eDP1: SUCCESS (8.707s)
[536.250337] Starting dynamic subtest: B-eDP1
[544.959471] Dynamic subtest B-eDP1: SUCCESS (8.720s)
[544.976395] Starting dynamic subtest: C-eDP1
[553.672283] Dynamic subtest C-eDP1: SUCCESS (8.710s)
[553.682541] Starting dynamic subtest: D-eDP1
[562.405789] Dynamic subtest D-eDP1: SUCCESS (8.733s)
[562.411012] Subtest absolute-wf_vblank: SUCCESS (34.883s)
[563.618785] [058/133] (458s left) gem_exec_schedule (preempt-other-chain)
[563.701409] Starting subtest: preempt-other-chain
[563.703631] Starting dynamic subtest: rcs0
[563.778620] Dynamic subtest rcs0: SUCCESS (0.083s)
[563.794250] Starting dynamic subtest: bcs0
[563.867012] Dynamic subtest bcs0: SUCCESS (0.088s)
[563.877308] Starting dynamic subtest: vcs0
[563.957026] Dynamic subtest vcs0: SUCCESS (0.089s)
[563.968728] Starting dynamic subtest: vcs1
[564.043914] Dynamic subtest vcs1: SUCCESS (0.085s)
[564.055853] Starting dynamic subtest: vecs0
[564.125939] Dynamic subtest vecs0: SUCCESS (0.082s)
[564.136325] Starting dynamic subtest: ccs0
[564.211974] Dynamic subtest ccs0: SUCCESS (0.085s)
[564.214563] Subtest preempt-other-chain: SUCCESS (0.518s)
[565.101552] [059/133] (457s left) gem_exec_schedule (u-fairslice)
[565.182821] Starting subtest: u-fairslice
[565.185145] Starting dynamic subtest: rcs0
[567.196685] Dynamic subtest rcs0: SUCCESS (2.021s)
[567.207613] Starting dynamic subtest: bcs0
[569.220778] Dynamic subtest bcs0: SUCCESS (2.023s)
[569.231742] Starting dynamic subtest: vcs0
[571.241130] Dynamic subtest vcs0: SUCCESS (2.018s)
[571.252546] Starting dynamic subtest: vcs1
[573.261650] Dynamic subtest vcs1: SUCCESS (2.019s)
[573.273656] Starting dynamic subtest: vecs0
[575.282077] Dynamic subtest vecs0: SUCCESS (2.021s)
[575.292231] Starting dynamic subtest: ccs0
[577.306451] Dynamic subtest ccs0: SUCCESS (2.023s)
[577.308449] Subtest u-fairslice: SUCCESS (12.131s)
[577.606359] [060/133] (444s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[577.714631] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[577.719250] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[577.796544] [061/133] (444s left) kms_cursor_crc (cursor-sliding-256x85)
[578.060300] Starting subtest: cursor-sliding-256x85
[578.109588] Subtest cursor-sliding-256x85: SKIP (0.043s)
[578.299004] [062/133] (444s left) gem_shrink (reclaim)
[578.368330] Starting subtest: reclaim
[580.802840] Subtest reclaim: SUCCESS (2.435s)
[580.922058] [063/133] (441s left) syncobj_timeline (wait-for-submit-complex)
[580.975944] Starting subtest: wait-for-submit-complex
[581.036618] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[581.156431] [064/133] (441s left) kms_dsc (dsc-with-formats)
[581.269514] Starting subtest: dsc-with-formats
[581.309042] Subtest dsc-with-formats: SKIP (0.001s)
[581.350295] [065/133] (441s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[581.467013] Starting subtest: flip-vs-cursor-atomic
[588.603455] Subtest flip-vs-cursor-atomic: SUCCESS (7.135s)
[589.453254] [066/133] (433s left) kms_vblank (query-forked-busy)
[589.556996] Starting subtest: query-forked-busy
[589.559294] Starting dynamic subtest: pipe-A-eDP-1
[591.434811] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[591.454850] Starting dynamic subtest: pipe-D-eDP-1
[593.994300] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.555s)
[593.997292] Subtest query-forked-busy: SUCCESS (4.437s)
[594.816176] [067/133] (427s left) kms_lease (lease-unleased-connector)
[594.915327] Starting subtest: lease-unleased-connector
[594.917675] Starting dynamic subtest: pipe-A-eDP-1
[594.923015] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[594.939554] Starting dynamic subtest: pipe-B-eDP-1
[594.941633] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[594.951933] Starting dynamic subtest: pipe-C-eDP-1
[594.954058] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[594.963966] Starting dynamic subtest: pipe-D-eDP-1
[594.966116] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[594.968348] Subtest lease-unleased-connector: SUCCESS (0.032s)
[595.060742] [068/133] (427s left) kms_addfb_basic (bad-pitch-63)
[595.123608] Starting subtest: bad-pitch-63
[595.125796] Subtest bad-pitch-63: SUCCESS (0.000s)
[595.252098] [069/133] (427s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[595.348541] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[595.352449] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[595.443045] [070/133] (427s left) gem_exec_params (dr1-dirt)
[595.505862] Starting subtest: DR1-dirt
[595.508187] Subtest DR1-dirt: SUCCESS (0.000s)
[595.615695] [071/133] (427s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[595.717756] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[595.721897] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[595.808972] [072/133] (427s left) kms_rmfb (rmfb-ioctl)
[595.900225] Starting subtest: rmfb-ioctl
[595.902241] Starting dynamic subtest: pipe-A-eDP-1
[596.003989] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s)
[596.018517] Starting dynamic subtest: pipe-B-eDP-1
[597.148870] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.142s)
[597.161341] Starting dynamic subtest: pipe-C-eDP-1
[598.287925] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.137s)
[598.299614] Starting dynamic subtest: pipe-D-eDP-1
[599.412549] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[599.414870] Subtest rmfb-ioctl: SUCCESS (3.515s)
[600.552548] [073/133] (422s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[600.646657] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[607.332003] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.686s)
[607.458554] [074/133] (415s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[607.571375] Starting subtest: fbc-rgb565-draw-blt
[611.735366] Subtest fbc-rgb565-draw-blt: SUCCESS (4.167s)
[612.861023] [075/133] (410s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[612.957595] Starting subtest: crc-primary-basic-yf-tiled-ccs
[612.959914] Starting dynamic subtest: pipe-A-eDP-1
[612.982450] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[612.995309] Starting dynamic subtest: pipe-B-eDP-1
[613.016142] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[613.025326] Starting dynamic subtest: pipe-C-eDP-1
[613.046443] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[613.058713] Starting dynamic subtest: pipe-D-eDP-1
[613.080507] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[613.084838] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[615.198384] [076/133] (407s left) i915_pm_rpm (sysfs-read)
[617.241336] Starting subtest: sysfs-read
[618.404921] Subtest sysfs-read: SUCCESS (1.160s)
[618.771459] [077/133] (404s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[618.860597] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[618.862997] Starting dynamic subtest: pipe-A-default-mode
[621.603306] Dynamic subtest pipe-A-default-mode: SUCCESS (2.741s)
[621.605447] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.743s)
[622.437424] [078/133] (400s left) gem_unfence_active_buffers
[622.603820] [079/133] (400s left) gem_exec_suspend (basic)
[622.677390] Starting subtest: basic
[622.679790] Starting dynamic subtest: smem
[624.035514] Dynamic subtest smem: SUCCESS (1.356s)
[624.038479] Subtest basic: SUCCESS (1.358s)
[624.224840] [080/133] (398s left) gem_exec_whisper (basic-sync)
[624.300587] Starting subtest: basic-sync
[634.442517] Subtest basic-sync: SUCCESS (10.141s)
[634.646660] [081/133] (388s left) gem_exec_params (invalid-bsd-ring)
[634.699985] Starting subtest: invalid-bsd-ring
[634.702294] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[634.798781] [082/133] (388s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[634.902778] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[634.907177] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[634.973872] [083/133] (388s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[635.035388] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[635.109325] [084/133] (388s left) gem_exec_fence (syncobj-signal)
[635.570926] Starting subtest: syncobj-signal
[635.576896] Subtest syncobj-signal: SUCCESS (0.007s)
[637.110073] [085/133] (386s left) i915_query (query-topology-coherent-slice-mask)
[637.169171] Starting subtest: query-topology-coherent-slice-mask
[637.173359] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[637.279107] [086/133] (386s left) syncobj_eventfd (invalid-illegal-handle)
[637.335327] Starting subtest: invalid-illegal-handle
[637.337587] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[637.423632] [087/133] (386s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[637.528405] Starting subtest: psr2-cursor-plane-update-sf
[637.530624] Starting dynamic subtest: pipe-A-eDP-1
[638.105304] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.580s)
[638.115949] Starting dynamic subtest: pipe-B-eDP-1
[639.427832] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.321s)
[639.429717] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.903s)
[640.299384] [088/133] (383s left) kms_flip (flip-vs-expired-vblank)
[640.393564] Starting subtest: flip-vs-expired-vblank
[640.395751] Starting dynamic subtest: A-eDP1
[649.106824] Dynamic subtest A-eDP1: SUCCESS (8.713s)
[649.117352] Starting dynamic subtest: B-eDP1
[657.742892] Dynamic subtest B-eDP1: SUCCESS (8.633s)
[657.754975] Starting dynamic subtest: C-eDP1
[666.379584] Dynamic subtest C-eDP1: SUCCESS (8.634s)
[666.390883] Starting dynamic subtest: D-eDP1
[675.013511] Dynamic subtest D-eDP1: SUCCESS (8.632s)
[675.019809] Subtest flip-vs-expired-vblank: SUCCESS (34.625s)
[676.190042] [089/133] (347s left) gem_create (create-massive)
[676.246762] Starting subtest: create-massive
[676.248751] Subtest create-massive: SUCCESS (0.000s)
[676.438130] [090/133] (347s left) kms_flip (flip-vs-wf_vblank-interruptible)
[676.540555] Starting subtest: flip-vs-wf_vblank-interruptible
[676.542862] Starting dynamic subtest: A-eDP1
[678.439879] Dynamic subtest A-eDP1: SUCCESS (1.898s)
[678.451539] Starting dynamic subtest: B-eDP1
[680.363251] Dynamic subtest B-eDP1: SUCCESS (1.921s)
[680.380435] Starting dynamic subtest: C-eDP1
[682.281990] Dynamic subtest C-eDP1: SUCCESS (1.917s)
[682.296897] Starting dynamic subtest: D-eDP1
[684.207720] Dynamic subtest D-eDP1: SUCCESS (1.923s)
[684.210137] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.670s)
[685.364614] [091/133] (338s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[685.469438] Starting subtest: psr-rgb101010-draw-mmap-cpu
[692.496661] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.028s)
[692.614443] [092/133] (331s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[692.679395] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[692.732353] [093/133] (330s left) gem_mmap_gtt (isolation)
[692.785047] Subtest isolation: SKIP (0.000s)
[692.844681] [094/133] (330s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[692.939962] Starting subtest: plane-lut1d-post-ctm3x4
[693.086882] Starting dynamic subtest: pipe-A-plane-0
[693.439460] Dynamic subtest pipe-A-plane-0: FAIL (0.182s)
[693.450878] Starting dynamic subtest: pipe-A-plane-1
[693.634044] Dynamic subtest pipe-A-plane-1: FAIL (0.169s)
[693.645754] Starting dynamic subtest: pipe-A-plane-2
[693.853853] Dynamic subtest pipe-A-plane-2: FAIL (0.166s)
[694.902704] Starting dynamic subtest: pipe-B-plane-0
[695.344077] Dynamic subtest pipe-B-plane-0: FAIL (0.163s)
[695.353905] Starting dynamic subtest: pipe-B-plane-1
[695.666798] Dynamic subtest pipe-B-plane-1: FAIL (0.167s)
[695.676907] Starting dynamic subtest: pipe-B-plane-2
[695.964565] Dynamic subtest pipe-B-plane-2: FAIL (0.176s)
[696.599424] Starting dynamic subtest: pipe-C-plane-0
[697.090400] Dynamic subtest pipe-C-plane-0: FAIL (0.128s)
[697.103040] Starting dynamic subtest: pipe-C-plane-1
[697.495784] Dynamic subtest pipe-C-plane-1: FAIL (0.608s)
[697.505654] Starting dynamic subtest: pipe-C-plane-2
[697.861497] Dynamic subtest pipe-C-plane-2: FAIL (0.170s)
[698.736796] Starting dynamic subtest: pipe-D-plane-0
[699.349794] Dynamic subtest pipe-D-plane-0: FAIL (0.166s)
[699.362602] Starting dynamic subtest: pipe-D-plane-1
[699.810009] Dynamic subtest pipe-D-plane-1: FAIL (0.605s)
[699.820698] Starting dynamic subtest: pipe-D-plane-2
[700.250821] Dynamic subtest pipe-D-plane-2: FAIL (0.536s)
[700.348932] Subtest plane-lut1d-post-ctm3x4: FAIL (7.409s)
[701.206057] [095/133] (322s left) kms_prime (d3hot)
[701.295371] Subtest D3hot: SKIP (0.000s)
[701.399789] [096/133] (322s left) gem_exec_reloc (basic-wc-gtt)
[701.467917] Subtest basic-wc-gtt: SKIP (0.000s)
[701.539256] [097/133] (322s left) gem_exec_balancer (parallel)
[701.821291] Starting subtest: parallel
[702.773304] Subtest parallel: SUCCESS (0.955s)
[703.055283] [098/133] (320s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[703.155069] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[703.159727] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[704.237239] [099/133] (319s left) kms_flip (plain-flip-interruptible)
[704.326774] Starting subtest: plain-flip-interruptible
[704.331724] Starting dynamic subtest: A-eDP1
[706.036474] Dynamic subtest A-eDP1: SUCCESS (1.707s)
[706.058367] Starting dynamic subtest: B-eDP1
[707.696480] Dynamic subtest B-eDP1: SUCCESS (1.656s)
[707.716037] Starting dynamic subtest: C-eDP1
[709.325557] Dynamic subtest C-eDP1: SUCCESS (1.626s)
[709.338120] Starting dynamic subtest: D-eDP1
[710.932253] Dynamic subtest D-eDP1: SUCCESS (1.604s)
[710.937479] Subtest plain-flip-interruptible: SUCCESS (6.608s)
[712.112038] [100/133] (311s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[712.206343] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[712.208684] Starting dynamic subtest: pipe-A-eDP-1
[712.231591] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[712.242592] Starting dynamic subtest: pipe-B-eDP-1
[712.264099] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[712.273671] Starting dynamic subtest: pipe-C-eDP-1
[712.295010] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[712.304556] Starting dynamic subtest: pipe-D-eDP-1
[712.326380] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[712.330679] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s)
[714.475942] [101/133] (309s left) gem_ctx_param (vm)
[714.528334] Starting subtest: vm
[714.577795] Subtest vm: SUCCESS (0.050s)
[714.707540] [102/133] (309s left) kms_properties (plane-properties-legacy)
[714.811448] Starting subtest: plane-properties-legacy
[714.813362] Starting dynamic subtest: pipe-A-eDP-1
[715.379157] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s)
[715.389966] Starting dynamic subtest: pipe-B-eDP-1
[716.651026] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.272s)
[716.662471] Starting dynamic subtest: pipe-C-eDP-1
[717.894381] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.242s)
[717.905573] Starting dynamic subtest: pipe-D-eDP-1
[719.138519] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.241s)
[719.140490] Subtest plane-properties-legacy: SUCCESS (4.326s)
[719.947761] [103/133] (304s left) gem_pxp (reject-modify-context-protection-off-3)
[720.080439] Starting subtest: reject-modify-context-protection-off-3
[720.083071] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[720.188415] [104/133] (304s left) prime_self_import (basic-with_one_bo_two_files)
[720.226798] Starting subtest: basic-with_one_bo_two_files
[720.238015] Subtest basic-with_one_bo_two_files: SUCCESS (0.014s)
[720.329644] [105/133] (303s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[720.421227] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[720.423551] Starting dynamic subtest: pipe-A
[720.484244] Dynamic subtest pipe-A: SUCCESS (0.065s)
[720.495191] Starting dynamic subtest: pipe-B
[721.657165] Dynamic subtest pipe-B: SUCCESS (1.172s)
[721.667331] Starting dynamic subtest: pipe-C
[722.775527] Dynamic subtest pipe-C: SUCCESS (1.117s)
[722.785690] Starting dynamic subtest: pipe-D
[723.893648] Dynamic subtest pipe-D: SUCCESS (1.117s)
[723.895967] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.475s)
[725.072345] [106/133] (299s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[725.179377] Starting subtest: 4-tiled-16bpp-rotate-90
[725.201705] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.022s)
[725.306137] [107/133] (299s left) gen9_exec_parse (batch-invalid-length)
[725.370883] Subtest batch-invalid-length: SKIP (0.000s)
[725.450506] [108/133] (298s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[725.520846] Starting subtest: invalid-signal-one-illegal-handle
[725.522793] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[725.637948] [109/133] (298s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[725.741781] Starting subtest: x-tiled-64bpp-rotate-180
[727.332119] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.590s)
[727.499537] [110/133] (296s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[727.595357] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[727.599288] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[727.710054] [111/133] (296s left) gem_exec_params (invalid-ring2)
[727.773780] Starting subtest: invalid-ring2
[727.775818] Subtest invalid-ring2: SUCCESS (0.000s)
[727.892010] [112/133] (296s left) gem_vm_create (invalid-create)
[727.948276] Starting subtest: invalid-create
[727.952362] Subtest invalid-create: SUCCESS (0.002s)
[728.051368] [113/133] (296s left) kms_addfb_basic (bad-pitch-128)
[728.098920] Starting subtest: bad-pitch-128
[728.100573] Subtest bad-pitch-128: SUCCESS (0.000s)
[728.225493] [114/133] (296s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[728.276655] Starting subtest: single-wait-all-for-submit-available-submitted
[728.278643] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[728.386471] [115/133] (296s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[728.504925] Starting subtest: cursorB-vs-flipA-toggle
[728.508953] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[728.651348] [116/133] (296s left) prime_vgem (fence-write-hang)
[728.733710] Subtest fence-write-hang: SKIP (0.000s)
[728.847063] [117/133] (295s left) fbdev (eof)
[728.894907] Starting subtest: eof
[728.896864] Subtest eof: SUCCESS (0.000s)
[728.979514] [118/133] (295s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[729.104311] Starting subtest: 2x-flip-vs-cursor-atomic
[729.107943] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[729.261388] [119/133] (295s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[729.356994] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[729.360517] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[729.453367] [120/133] (295s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[729.552141] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[736.478724] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.926s)
[736.633340] [121/133] (288s left) prime_mmap_kms (buffer-sharing)
[736.718646] Starting subtest: buffer-sharing
[737.180207] Subtest buffer-sharing: SUCCESS (0.461s)
[737.995493] [122/133] (286s left) gem_exec_fence (basic-await)
[738.183466] Starting subtest: basic-await
[738.185845] Starting dynamic subtest: rcs0
[738.261878] Dynamic subtest rcs0: SUCCESS (0.078s)
[738.276171] Starting dynamic subtest: bcs0
[738.336324] Dynamic subtest bcs0: SUCCESS (0.073s)
[738.351944] Starting dynamic subtest: vcs0
[738.411337] Dynamic subtest vcs0: SUCCESS (0.073s)
[738.423848] Starting dynamic subtest: vcs1
[738.485326] Dynamic subtest vcs1: SUCCESS (0.072s)
[738.498345] Starting dynamic subtest: vecs0
[738.563731] Dynamic subtest vecs0: SUCCESS (0.077s)
[738.580598] Starting dynamic subtest: ccs0
[738.638230] Dynamic subtest ccs0: SUCCESS (0.072s)
[738.640954] Subtest basic-await: SUCCESS (0.456s)
[740.088454] [123/133] (284s left) prime_busy (before-wait)
[740.146109] Starting subtest: before-wait
[740.152014] Starting dynamic subtest: rcs0
[740.180796] Dynamic subtest rcs0: SUCCESS (0.032s)
[740.192909] Starting dynamic subtest: bcs0
[740.233776] Dynamic subtest bcs0: SUCCESS (0.052s)
[740.244644] Starting dynamic subtest: vcs0
[740.275005] Dynamic subtest vcs0: SUCCESS (0.039s)
[740.285317] Starting dynamic subtest: vcs1
[740.315333] Dynamic subtest vcs1: SUCCESS (0.039s)
[740.325441] Starting dynamic subtest: vecs0
[740.357307] Dynamic subtest vecs0: SUCCESS (0.041s)
[740.370636] Starting dynamic subtest: ccs0
[740.397759] Dynamic subtest ccs0: SUCCESS (0.038s)
[740.503106] Subtest before-wait: SUCCESS (0.357s)
[740.582715] [124/133] (284s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[740.708742] Starting subtest: short-busy-flip-before-cursor-toggle
[740.713404] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[740.868693] [125/133] (284s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[740.929033] Starting subtest: invalid-multi-wait-unsubmitted
[740.931182] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[741.013354] [126/133] (284s left) gem_mmap_wc (invalid-flags)
[741.075330] Subtest invalid-flags: SKIP (0.000s)
[741.139904] [127/133] (284s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[741.245578] Starting subtest: yf-tiled-64bpp-rotate-270
[741.249365] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[741.354835] [128/133] (283s left) kms_tv_load_detect (load-detect)
[741.427613] Subtest load-detect: SKIP (0.000s)
[741.494403] [129/133] (283s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[741.602679] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[741.606208] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[741.724127] [130/133] (283s left) syncobj_wait (wait-any-complex)
[741.775507] Starting subtest: wait-any-complex
[741.839302] Subtest wait-any-complex: SUCCESS (0.062s)
[741.921822] [131/133] (283s left) sw_sync (sync_expired_merge)
[741.962920] Starting subtest: sync_expired_merge
[743.037523] Subtest sync_expired_merge: SUCCESS (1.074s)
[743.098212] [132/133] (282s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[743.209719] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[743.213659] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[743.312975] [133/133] (282s left) kms_psr (psr-suspend)
[743.411563] Starting subtest: psr-suspend
[743.413867] Starting dynamic subtest: eDP-1
[761.214979] Dynamic subtest eDP-1: SUCCESS (2.915s)
[761.217341] Subtest psr-suspend: SUCCESS (2.916s)
[762.075787] 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.