[57.376127] Initializing watchdogs
[57.376224]   /dev/watchdog0
[57.391459] [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.396232] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.398489] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.402225] [001/133] (960s left) gem_exec_gttfill (engines)
[57.487508] Starting subtest: engines
[57.489830] Starting dynamic subtest: rcs0
[80.885819] Dynamic subtest rcs0: SUCCESS (23.401s)
[80.894897] Starting dynamic subtest: bcs0
[104.158711] Dynamic subtest bcs0: SUCCESS (23.272s)
[104.166521] Starting dynamic subtest: vcs0
[127.412759] Dynamic subtest vcs0: SUCCESS (23.253s)
[127.423367] Starting dynamic subtest: vcs1
[150.738362] Dynamic subtest vcs1: SUCCESS (23.324s)
[150.749060] Starting dynamic subtest: vecs0
[174.041455] Dynamic subtest vecs0: SUCCESS (23.300s)
[174.050322] Starting dynamic subtest: ccs0
[197.361954] Dynamic subtest ccs0: SUCCESS (23.318s)
[197.364180] Subtest engines: SUCCESS (139.872s)
[197.552839] [002/133] (820s left) perf (gen12-unprivileged-single-ctx-counters)
[197.735879] Starting subtest: gen12-unprivileged-single-ctx-counters
[197.738156] Starting dynamic subtest: rcs0
[198.253757] Dynamic subtest rcs0: SUCCESS (0.518s)
[198.257075] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.519s)
[198.303694] [003/133] (819s left) kms_joiner (basic-ultra-joiner)
[198.451233] Starting subtest: basic-ultra-joiner
[198.455559] Subtest basic-ultra-joiner: SKIP (0.000s)
[198.529765] [004/133] (819s left) prime_mmap (test_aperture_limit)
[198.580990] Starting subtest: test_aperture_limit
[198.582634] Starting dynamic subtest: test_aperture_limit-smem
[198.592068] Dynamic subtest test_aperture_limit-smem: SKIP (0.010s)
[198.595704] Subtest test_aperture_limit: SKIP (0.010s)
[198.681992] [005/133] (819s left) kms_plane (plane-position-hole)
[198.772462] Starting subtest: plane-position-hole
[199.309064] Starting dynamic subtest: pipe-A-plane-1
[200.580165] Dynamic subtest pipe-A-plane-1: SUCCESS (1.272s)
[200.590839] Starting dynamic subtest: pipe-A-plane-2
[201.900924] Dynamic subtest pipe-A-plane-2: SUCCESS (1.319s)
[201.909862] Starting dynamic subtest: pipe-A-plane-3
[203.236451] Dynamic subtest pipe-A-plane-3: SUCCESS (1.334s)
[203.245949] Starting dynamic subtest: pipe-A-plane-4
[204.552819] Dynamic subtest pipe-A-plane-4: SUCCESS (1.317s)
[204.562369] Starting dynamic subtest: pipe-A-plane-5
[204.577056] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[205.707757] Starting dynamic subtest: pipe-B-plane-1
[206.970370] Dynamic subtest pipe-B-plane-1: SUCCESS (1.271s)
[206.981177] Starting dynamic subtest: pipe-B-plane-2
[208.268190] Dynamic subtest pipe-B-plane-2: SUCCESS (1.299s)
[208.277145] Starting dynamic subtest: pipe-B-plane-3
[209.492324] Dynamic subtest pipe-B-plane-3: SUCCESS (1.223s)
[209.502550] Starting dynamic subtest: pipe-B-plane-4
[210.763466] Dynamic subtest pipe-B-plane-4: SUCCESS (1.271s)
[210.771898] Starting dynamic subtest: pipe-B-plane-5
[210.787054] Dynamic subtest pipe-B-plane-5: SUCCESS (0.022s)
[210.788922] Subtest plane-position-hole: SUCCESS (12.014s)
[211.625359] [006/133] (806s left) kms_async_flips (alternate-sync-async-flip-atomic)
[211.737997] Starting subtest: alternate-sync-async-flip-atomic
[212.123721] Starting dynamic subtest: pipe-A-eDP-1
[214.918455] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.795s)
[215.302597] Starting dynamic subtest: pipe-B-eDP-1
[218.048370] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.757s)
[218.449773] Starting dynamic subtest: pipe-C-eDP-1
[221.191428] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.749s)
[221.564806] Starting dynamic subtest: pipe-D-eDP-1
[224.331019] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.772s)
[224.333242] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.594s)
[225.492218] [007/133] (792s left) kms_cursor_crc (cursor-random-64x21)
[225.695730] Starting subtest: cursor-random-64x21
[225.744468] Subtest cursor-random-64x21: SKIP (0.043s)
[225.972097] [008/133] (792s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[226.035597] Starting subtest: basic-batch-kernel-default-cmd
[226.039790] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[226.219179] [009/133] (791s left) gem_userptr_blits (map-fixed-invalidate)
[226.282529] Starting subtest: map-fixed-invalidate
[226.286662] Subtest map-fixed-invalidate: SKIP (0.000s)
[226.394654] [010/133] (791s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[226.458789] Starting subtest: multi-wait-for-submit-submitted-signaled
[226.460755] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[226.550924] [011/133] (791s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[226.655655] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[227.490677] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.837s)
[227.638144] [012/133] (790s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[227.761158] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[259.089709] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.330s)
[259.922839] [013/133] (758s left) kms_psr (psr2-basic)
[260.024654] Starting subtest: psr2-basic
[260.026769] Starting dynamic subtest: eDP-1
[261.598124] Dynamic subtest eDP-1: SUCCESS (1.572s)
[261.600047] Subtest psr2-basic: SUCCESS (1.573s)
[262.389662] [014/133] (756s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[262.496398] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[262.500377] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[262.592772] [015/133] (755s left) kms_big_fb (linear-16bpp-rotate-180)
[262.684447] Starting subtest: linear-16bpp-rotate-180
[263.986245] Subtest linear-16bpp-rotate-180: SUCCESS (1.302s)
[264.120922] [016/133] (754s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[264.207280] Starting subtest: bad-pixel-format-y-tiled-ccs
[264.209205] Starting dynamic subtest: pipe-A-eDP-1
[264.227541] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[264.238930] Starting dynamic subtest: pipe-B-eDP-1
[264.255697] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[264.263129] Starting dynamic subtest: pipe-C-eDP-1
[264.280700] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[264.288233] Starting dynamic subtest: pipe-D-eDP-1
[264.306165] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[264.309688] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[266.364661] [017/133] (752s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[266.464738] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[266.469058] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[266.546908] [018/133] (752s left) i915_drm_fdinfo (most-busy-idle-check-all)
[266.585241] Starting subtest: most-busy-idle-check-all
[266.587329] Starting dynamic subtest: rcs0
[266.591627] Dynamic subtest rcs0: SKIP (0.004s)
[266.599712] Starting dynamic subtest: bcs0
[266.603884] Dynamic subtest bcs0: SKIP (0.000s)
[266.611616] Starting dynamic subtest: vcs0
[266.615264] Dynamic subtest vcs0: SKIP (0.000s)
[266.622714] Starting dynamic subtest: vcs1
[266.626644] Dynamic subtest vcs1: SKIP (0.000s)
[266.634425] Starting dynamic subtest: vecs0
[266.638345] Dynamic subtest vecs0: SKIP (0.000s)
[266.646080] Starting dynamic subtest: ccs0
[266.650224] Dynamic subtest ccs0: SKIP (0.000s)
[266.654100] Subtest most-busy-idle-check-all: SKIP (0.008s)
[266.687948] [019/133] (751s left) perf_pmu (rc6-suspend)
[266.737958] Starting subtest: rc6-suspend
[289.971729] Subtest rc6-suspend: SUCCESS (8.862s)
[293.862171] [020/133] (727s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[293.981201] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[293.985368] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[294.079686] [021/133] (727s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[294.170062] Starting subtest: fbc-psr2-sprite-plane-onoff
[294.172064] Starting dynamic subtest: eDP-1
[294.176346] Dynamic subtest eDP-1: SKIP (0.000s)
[294.180583] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[294.253374] [022/133] (727s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[294.365209] Starting subtest: 4-tiled-16bpp-rotate-0
[295.723000] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.356s)
[295.848199] [023/133] (725s left) gem_workarounds (reset-fd)
[295.928587] Starting subtest: reset-fd
[296.141819] Subtest reset-fd: SUCCESS (0.212s)
[296.246874] [024/133] (725s left) kms_fence_pin_leak
[296.426770] [025/133] (725s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[296.483483] Starting subtest: y-tiled-to-vebox-y-tiled
[296.488028] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[296.675951] [026/133] (725s left) kms_cdclk (mode-transition)
[296.761789] Starting subtest: mode-transition
[296.764165] Starting dynamic subtest: pipe-A-eDP-1
[297.050336] Dynamic subtest pipe-A-eDP-1: SKIP (0.286s)
[297.060223] Starting dynamic subtest: pipe-B-eDP-1
[297.064840] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[297.074192] Starting dynamic subtest: pipe-C-eDP-1
[297.078879] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[297.087988] Starting dynamic subtest: pipe-D-eDP-1
[297.092260] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[297.096588] Subtest mode-transition: SKIP (0.293s)
[297.897048] [027/133] (724s left) gem_exec_params (dr4-dirt)
[297.956551] Starting subtest: DR4-dirt
[297.958755] Subtest DR4-dirt: SUCCESS (0.000s)
[298.061884] [028/133] (723s left) syncobj_wait (multi-wait-all-submitted)
[298.118888] Starting subtest: multi-wait-all-submitted
[298.219610] Subtest multi-wait-all-submitted: SUCCESS (0.101s)
[298.308071] [029/133] (723s left) gem_exec_store (basic)
[298.372449] Starting subtest: basic
[298.465976] Subtest basic: SUCCESS (0.095s)
[298.649284] [030/133] (723s left) gem_ctx_persistence (saturated-hostile)
[298.721127] Starting subtest: saturated-hostile
[298.723671] Starting dynamic subtest: rcs0
[299.542969] Dynamic subtest rcs0: SUCCESS (0.825s)
[299.555990] Starting dynamic subtest: bcs0
[300.340432] Dynamic subtest bcs0: SUCCESS (0.795s)
[300.354378] Starting dynamic subtest: vcs0
[301.141847] Dynamic subtest vcs0: SUCCESS (0.799s)
[301.154418] Starting dynamic subtest: vcs1
[301.936408] Dynamic subtest vcs1: SUCCESS (0.793s)
[301.948456] Starting dynamic subtest: vecs0
[302.737546] Dynamic subtest vecs0: SUCCESS (0.799s)
[302.749924] Starting dynamic subtest: ccs0
[303.579940] Dynamic subtest ccs0: SUCCESS (0.841s)
[303.582877] Subtest saturated-hostile: SUCCESS (4.861s)
[303.669959] [031/133] (718s left) kms_psr (psr-cursor-plane-onoff)
[303.787091] Starting subtest: psr-cursor-plane-onoff
[303.789504] Starting dynamic subtest: eDP-1
[305.496970] Dynamic subtest eDP-1: SUCCESS (1.709s)
[305.499124] Subtest psr-cursor-plane-onoff: SUCCESS (1.710s)
[306.360710] [032/133] (715s left) i915_hangman (detector)
[306.430157] Starting subtest: detector
[306.432367] Starting dynamic subtest: rcs0
[317.270909] Dynamic subtest rcs0: SUCCESS (10.838s)
[317.283544] Starting dynamic subtest: bcs0
[329.239970] Dynamic subtest bcs0: SUCCESS (11.965s)
[329.251917] Starting dynamic subtest: vcs0
[340.246959] Dynamic subtest vcs0: SUCCESS (11.004s)
[340.259418] Starting dynamic subtest: vcs1
[351.254930] Dynamic subtest vcs1: SUCCESS (11.004s)
[351.267589] Starting dynamic subtest: vecs0
[362.262557] Dynamic subtest vecs0: SUCCESS (11.004s)
[362.274645] Starting dynamic subtest: ccs0
[374.230297] Dynamic subtest ccs0: SUCCESS (11.964s)
[374.233445] Subtest detector: SUCCESS (67.793s)
[374.346501] [033/133] (647s left) kms_force_connector_basic (force-connector-state)
[374.429151] Starting subtest: force-connector-state
[375.045998] Subtest force-connector-state: SUCCESS (0.616s)
[376.019400] [034/133] (646s left) kms_universal_plane (universal-plane-sanity)
[376.127284] Starting subtest: universal-plane-sanity
[376.129569] Starting dynamic subtest: pipe-A-eDP-1
[376.728684] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.600s)
[376.739205] Starting dynamic subtest: pipe-B-eDP-1
[377.983979] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.253s)
[377.994501] Starting dynamic subtest: pipe-C-eDP-1
[379.167752] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.181s)
[379.178100] Starting dynamic subtest: pipe-D-eDP-1
[380.363501] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.195s)
[380.365816] Subtest universal-plane-sanity: SUCCESS (4.235s)
[381.189386] [035/133] (641s left) dmabuf_sync_file (import-multiple-read-write)
[381.309872] Starting subtest: import-multiple-read-write
[381.312067] Subtest import-multiple-read-write: SUCCESS (0.003s)
[381.365414] [FACT dmabuf_sync_file (import-multiple-read-write)] new: kernel.kmod_is_loaded.vgem: true
[381.368631] [036/133] (640s left) kms_pm_dc (dc5-dpms-negative)
[382.478307] Starting subtest: dc5-dpms-negative
[382.482761] Subtest dc5-dpms-negative: SKIP (0.000s)
[382.568148] [037/133] (639s left) gem_render_copy_redux (flink)
[382.627143] Starting subtest: flink
[383.442410] Subtest flink: SUCCESS (0.816s)
[383.560974] [038/133] (638s left) kms_cursor_crc (cursor-onscreen-64x64)
[383.740496] Starting subtest: cursor-onscreen-64x64
[383.744620] Starting dynamic subtest: pipe-A-eDP-1
[385.860423] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.115s)
[385.890588] Starting dynamic subtest: pipe-D-eDP-1
[388.657366] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.776s)
[388.659640] Subtest cursor-onscreen-64x64: SUCCESS (4.917s)
[389.503746] [039/133] (632s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[389.602619] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[389.606783] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[389.674836] [040/133] (632s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[389.764055] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[398.444341] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.684s)
[398.570803] [041/133] (623s left) gem_mmap_wc (bad-offset)
[398.637429] Subtest bad-offset: SKIP (0.000s)
[398.699496] [042/133] (623s left) gem_softpin (evict-single-offset)
[398.755673] Starting subtest: evict-single-offset
[424.312947] Subtest evict-single-offset: SUCCESS (25.557s)
[424.397686] [043/133] (598s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[424.590509] Starting subtest: dp-mst-type-1-suspend-resume
[424.595074] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[424.713371] [044/133] (597s left) gem_ctx_shared (q-out-order)
[424.783762] Starting subtest: Q-out-order
[424.786164] Starting dynamic subtest: rcs0
[424.896626] Dynamic subtest rcs0: SUCCESS (0.111s)
[424.916066] Starting dynamic subtest: vcs0
[424.987623] Dynamic subtest vcs0: SUCCESS (0.091s)
[425.004064] Starting dynamic subtest: vcs1
[425.077164] Dynamic subtest vcs1: SUCCESS (0.087s)
[425.097547] Starting dynamic subtest: vecs0
[425.156797] Dynamic subtest vecs0: SUCCESS (0.078s)
[425.173617] Starting dynamic subtest: ccs0
[425.250001] Dynamic subtest ccs0: SUCCESS (0.093s)
[425.252414] Subtest Q-out-order: SUCCESS (0.467s)
[426.394786] [045/133] (596s left) gem_softpin (softpin)
[426.454145] Starting subtest: softpin
[458.796265] Subtest softpin: SUCCESS (32.337s)
[458.917918] [046/133] (563s left) kms_plane_alpha_blend (coverage-7efc)
[459.005281] Starting subtest: coverage-7efc
[459.292811] Starting dynamic subtest: pipe-A-eDP-1
[459.856207] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.560s)
[459.887167] Starting dynamic subtest: pipe-D-eDP-1
[461.176799] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.298s)
[461.179005] Subtest coverage-7efc: SUCCESS (2.173s)
[461.993645] [047/133] (560s left) kms_busy (extended-pageflip-hang-oldfb)
[462.087493] Starting subtest: extended-pageflip-hang-oldfb
[462.089827] Starting dynamic subtest: pipe-A
[462.506232] Dynamic subtest pipe-A: SUCCESS (0.418s)
[462.516806] Starting dynamic subtest: pipe-D
[463.656039] Dynamic subtest pipe-D: SUCCESS (1.148s)
[463.658385] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.571s)
[464.496639] [048/133] (558s left) kms_big_fb (y-tiled-addfb)
[464.586599] Starting subtest: y-tiled-addfb
[464.591144] Subtest y-tiled-addfb: SKIP (0.000s)
[464.681713] [049/133] (558s left) kms_plane_multiple (tiling-none)
[464.784608] Starting subtest: tiling-none
[464.786982] Starting dynamic subtest: pipe-A-eDP-1
[468.601209] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.815s)
[468.612153] Starting dynamic subtest: pipe-B-eDP-1
[473.209929] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.610s)
[473.220306] Starting dynamic subtest: pipe-C-eDP-1
[477.806421] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.593s)
[477.817361] Starting dynamic subtest: pipe-D-eDP-1
[482.409211] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.602s)
[482.411433] Subtest tiling-none: SUCCESS (17.625s)
[483.273910] [050/133] (539s left) kms_chamelium_frames (dp-crc-fast)
[483.662169] Subtest dp-crc-fast: SKIP (0.000s)
[484.459637] [051/133] (538s left) i915_suspend (fence-restore-tiled2untiled)
[484.512567] Starting subtest: fence-restore-tiled2untiled
[484.516788] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[484.601451] [052/133] (538s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[484.708782] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[491.122385] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.417s)
[491.235861] [053/133] (531s left) kms_chamelium_hpd (hdmi-hpd-fast)
[491.627285] Subtest hdmi-hpd-fast: SKIP (0.000s)
[492.460382] [054/133] (530s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[492.545461] Starting subtest: fbc-psr2-primary-mmap-cpu
[492.547774] Starting dynamic subtest: eDP-1
[492.551776] Dynamic subtest eDP-1: SKIP (0.000s)
[492.555835] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[492.635662] [055/133] (530s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[492.729420] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[492.731657] Starting dynamic subtest: pipe-A-eDP-1
[509.186735] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.461s)
[509.203758] Starting dynamic subtest: pipe-B-eDP-1
[526.313252] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.123s)
[526.315681] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.587s)
[527.190079] [056/133] (495s left) api_intel_bb (object-reloc-keep-cache)
[527.245924] Starting subtest: object-reloc-keep-cache
[527.250486] Subtest object-reloc-keep-cache: SKIP (0.003s)
[527.361024] [057/133] (495s left) kms_flip (absolute-wf_vblank)
[527.460937] Starting subtest: absolute-wf_vblank
[527.463205] Starting dynamic subtest: A-eDP1
[536.201270] Dynamic subtest A-eDP1: SUCCESS (8.742s)
[536.211088] Starting dynamic subtest: B-eDP1
[544.899148] Dynamic subtest B-eDP1: SUCCESS (8.696s)
[544.912832] Starting dynamic subtest: C-eDP1
[553.594142] Dynamic subtest C-eDP1: SUCCESS (8.693s)
[553.615766] Starting dynamic subtest: D-eDP1
[562.291705] Dynamic subtest D-eDP1: SUCCESS (8.696s)
[562.296991] Subtest absolute-wf_vblank: SUCCESS (34.837s)
[563.483403] [058/133] (459s left) gem_exec_schedule (preempt-other-chain)
[563.568747] Starting subtest: preempt-other-chain
[563.570986] Starting dynamic subtest: rcs0
[563.648773] Dynamic subtest rcs0: SUCCESS (0.083s)
[563.661259] Starting dynamic subtest: bcs0
[563.731544] Dynamic subtest bcs0: SUCCESS (0.081s)
[563.748304] Starting dynamic subtest: vcs0
[563.810353] Dynamic subtest vcs0: SUCCESS (0.079s)
[563.824097] Starting dynamic subtest: vcs1
[563.896406] Dynamic subtest vcs1: SUCCESS (0.084s)
[563.910433] Starting dynamic subtest: vecs0
[563.978177] Dynamic subtest vecs0: SUCCESS (0.080s)
[563.994694] Starting dynamic subtest: ccs0
[564.057789] Dynamic subtest ccs0: SUCCESS (0.079s)
[564.060413] Subtest preempt-other-chain: SUCCESS (0.492s)
[565.422747] [059/133] (457s left) gem_exec_schedule (u-fairslice)
[565.498957] Starting subtest: u-fairslice
[565.500950] Starting dynamic subtest: rcs0
[567.528614] Dynamic subtest rcs0: SUCCESS (2.027s)
[567.539990] Starting dynamic subtest: bcs0
[569.550188] Dynamic subtest bcs0: SUCCESS (2.022s)
[569.563176] Starting dynamic subtest: vcs0
[571.572565] Dynamic subtest vcs0: SUCCESS (2.020s)
[571.583844] Starting dynamic subtest: vcs1
[573.590442] Dynamic subtest vcs1: SUCCESS (2.018s)
[573.602259] Starting dynamic subtest: vecs0
[575.610423] Dynamic subtest vecs0: SUCCESS (2.020s)
[575.621260] Starting dynamic subtest: ccs0
[577.636720] Dynamic subtest ccs0: SUCCESS (2.024s)
[577.638963] Subtest u-fairslice: SUCCESS (12.136s)
[577.951550] [060/133] (445s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[578.057389] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[578.061932] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[578.161002] [061/133] (445s left) kms_cursor_crc (cursor-sliding-256x85)
[578.427200] Starting subtest: cursor-sliding-256x85
[578.481051] Subtest cursor-sliding-256x85: SKIP (0.048s)
[578.660591] [062/133] (444s left) gem_shrink (reclaim)
[578.719818] Starting subtest: reclaim
[581.192056] Subtest reclaim: SUCCESS (2.469s)
[581.350959] [063/133] (442s left) syncobj_timeline (wait-for-submit-complex)
[581.404788] Starting subtest: wait-for-submit-complex
[581.465486] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[581.578620] [064/133] (441s left) kms_dsc (dsc-with-formats)
[581.684491] Starting subtest: dsc-with-formats
[581.724396] Subtest dsc-with-formats: SKIP (0.001s)
[581.770653] [065/133] (441s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[581.892243] Starting subtest: flip-vs-cursor-atomic
[588.995445] Subtest flip-vs-cursor-atomic: SUCCESS (7.103s)
[589.879793] [066/133] (433s left) kms_vblank (query-forked-busy)
[589.970766] Starting subtest: query-forked-busy
[589.972695] Starting dynamic subtest: pipe-A-eDP-1
[591.858453] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.889s)
[591.874157] Starting dynamic subtest: pipe-D-eDP-1
[594.404311] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.541s)
[594.406541] Subtest query-forked-busy: SUCCESS (4.434s)
[595.271955] [067/133] (428s left) kms_lease (lease-unleased-connector)
[595.370334] Starting subtest: lease-unleased-connector
[595.372549] Starting dynamic subtest: pipe-A-eDP-1
[595.377975] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[595.392327] Starting dynamic subtest: pipe-B-eDP-1
[595.394554] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[595.405114] Starting dynamic subtest: pipe-C-eDP-1
[595.407283] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[595.420128] Starting dynamic subtest: pipe-D-eDP-1
[595.422395] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[595.424580] Subtest lease-unleased-connector: SUCCESS (0.033s)
[595.520209] [068/133] (428s left) kms_addfb_basic (bad-pitch-63)
[595.579592] Starting subtest: bad-pitch-63
[595.581786] Subtest bad-pitch-63: SUCCESS (0.000s)
[595.715950] [069/133] (428s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[595.817497] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[595.821663] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[595.905868] [070/133] (427s left) gem_exec_params (dr1-dirt)
[595.961315] Starting subtest: DR1-dirt
[595.963642] Subtest DR1-dirt: SUCCESS (0.000s)
[596.066979] [071/133] (427s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[596.152900] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[596.157254] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[596.266452] [072/133] (427s left) kms_rmfb (rmfb-ioctl)
[596.359013] Starting subtest: rmfb-ioctl
[596.360672] Starting dynamic subtest: pipe-A-eDP-1
[596.464496] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[596.475344] Starting dynamic subtest: pipe-B-eDP-1
[597.596167] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.129s)
[597.609708] Starting dynamic subtest: pipe-C-eDP-1
[598.783585] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.185s)
[598.795156] Starting dynamic subtest: pipe-D-eDP-1
[599.977202] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.192s)
[599.979558] Subtest rmfb-ioctl: SUCCESS (3.620s)
[601.182725] [073/133] (422s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[601.288659] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[607.851403] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.563s)
[607.986398] [074/133] (416s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[608.084564] Starting subtest: fbc-rgb565-draw-blt
[612.181533] Subtest fbc-rgb565-draw-blt: SUCCESS (4.101s)
[613.388925] [075/133] (410s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[613.485213] Starting subtest: crc-primary-basic-yf-tiled-ccs
[613.487457] Starting dynamic subtest: pipe-A-eDP-1
[613.510152] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[613.521897] Starting dynamic subtest: pipe-B-eDP-1
[613.543355] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[613.553352] Starting dynamic subtest: pipe-C-eDP-1
[613.574664] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[613.584619] Starting dynamic subtest: pipe-D-eDP-1
[613.606481] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[613.610580] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[615.762271] [076/133] (408s left) i915_pm_rpm (sysfs-read)
[617.400444] Starting subtest: sysfs-read
[618.555281] Subtest sysfs-read: SUCCESS (1.155s)
[618.934581] [077/133] (405s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[619.029785] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[619.032122] Starting dynamic subtest: pipe-A-default-mode
[621.730129] Dynamic subtest pipe-A-default-mode: SUCCESS (2.700s)
[621.732535] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.702s)
[622.584901] [078/133] (401s left) gem_unfence_active_buffers
[622.742926] [079/133] (401s left) gem_exec_suspend (basic)
[622.796871] Starting subtest: basic
[622.799369] Starting dynamic subtest: smem
[624.247962] Dynamic subtest smem: SUCCESS (1.449s)
[624.250977] Subtest basic: SUCCESS (1.451s)
[624.439559] [080/133] (399s left) gem_exec_whisper (basic-sync)
[624.498482] Starting subtest: basic-sync
[634.589836] Subtest basic-sync: SUCCESS (10.089s)
[634.774458] [081/133] (389s left) gem_exec_params (invalid-bsd-ring)
[634.838608] Starting subtest: invalid-bsd-ring
[634.840562] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[634.943172] [082/133] (389s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[635.035366] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[635.039481] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[635.122837] [083/133] (389s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[635.176725] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[635.253267] [084/133] (389s left) gem_exec_fence (syncobj-signal)
[635.724158] Starting subtest: syncobj-signal
[635.729987] Subtest syncobj-signal: SUCCESS (0.004s)
[637.407940] [085/133] (387s left) i915_query (query-topology-coherent-slice-mask)
[637.467573] Starting subtest: query-topology-coherent-slice-mask
[637.471807] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[637.558627] [086/133] (387s left) syncobj_eventfd (invalid-illegal-handle)
[637.628570] Starting subtest: invalid-illegal-handle
[637.630562] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[637.749705] [087/133] (386s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[637.863359] Starting subtest: psr2-cursor-plane-update-sf
[637.865605] Starting dynamic subtest: pipe-A-eDP-1
[638.449420] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.588s)
[638.460229] Starting dynamic subtest: pipe-B-eDP-1
[639.714270] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.264s)
[639.716985] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.855s)
[640.568124] [088/133] (384s left) kms_flip (flip-vs-expired-vblank)
[640.674760] Starting subtest: flip-vs-expired-vblank
[640.676906] Starting dynamic subtest: A-eDP1
[649.338466] Dynamic subtest A-eDP1: SUCCESS (8.665s)
[649.348791] Starting dynamic subtest: B-eDP1
[658.034053] Dynamic subtest B-eDP1: SUCCESS (8.693s)
[658.045976] Starting dynamic subtest: C-eDP1
[666.730982] Dynamic subtest C-eDP1: SUCCESS (8.695s)
[666.745583] Starting dynamic subtest: D-eDP1
[675.422847] Dynamic subtest D-eDP1: SUCCESS (8.688s)
[675.428637] Subtest flip-vs-expired-vblank: SUCCESS (34.755s)
[676.584918] [089/133] (348s left) gem_create (create-massive)
[676.650962] Starting subtest: create-massive
[676.653253] Subtest create-massive: SUCCESS (0.000s)
[676.849799] [090/133] (347s left) kms_flip (flip-vs-wf_vblank-interruptible)
[676.946441] Starting subtest: flip-vs-wf_vblank-interruptible
[676.948892] Starting dynamic subtest: A-eDP1
[678.872710] Dynamic subtest A-eDP1: SUCCESS (1.924s)
[678.887722] Starting dynamic subtest: B-eDP1
[680.775818] Dynamic subtest B-eDP1: SUCCESS (1.900s)
[680.788563] Starting dynamic subtest: C-eDP1
[682.668555] Dynamic subtest C-eDP1: SUCCESS (1.890s)
[682.680576] Starting dynamic subtest: D-eDP1
[684.563047] Dynamic subtest D-eDP1: SUCCESS (1.893s)
[684.565389] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.619s)
[685.767261] [091/133] (339s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[685.865691] Starting subtest: psr-rgb101010-draw-mmap-cpu
[692.841967] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (6.978s)
[692.968917] [092/133] (331s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[693.035982] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[693.100388] [093/133] (331s left) gem_mmap_gtt (isolation)
[693.150630] Subtest isolation: SKIP (0.000s)
[693.214810] [094/133] (331s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[693.320927] Starting subtest: plane-lut1d-post-ctm3x4
[693.489840] Starting dynamic subtest: pipe-A-plane-0
[693.825550] Dynamic subtest pipe-A-plane-0: FAIL (0.172s)
[693.837445] Starting dynamic subtest: pipe-A-plane-1
[694.019411] Dynamic subtest pipe-A-plane-1: FAIL (0.175s)
[694.031363] Starting dynamic subtest: pipe-A-plane-2
[694.236852] Dynamic subtest pipe-A-plane-2: FAIL (0.170s)
[695.222716] Starting dynamic subtest: pipe-B-plane-0
[695.650228] Dynamic subtest pipe-B-plane-0: FAIL (0.175s)
[695.660648] Starting dynamic subtest: pipe-B-plane-1
[695.968890] Dynamic subtest pipe-B-plane-1: FAIL (0.178s)
[695.979675] Starting dynamic subtest: pipe-B-plane-2
[696.283276] Dynamic subtest pipe-B-plane-2: FAIL (0.165s)
[696.917852] Starting dynamic subtest: pipe-C-plane-0
[697.420509] Dynamic subtest pipe-C-plane-0: FAIL (0.151s)
[697.432735] Starting dynamic subtest: pipe-C-plane-1
[697.828026] Dynamic subtest pipe-C-plane-1: FAIL (0.605s)
[697.839033] Starting dynamic subtest: pipe-C-plane-2
[698.200618] Dynamic subtest pipe-C-plane-2: FAIL (0.178s)
[699.037879] Starting dynamic subtest: pipe-D-plane-0
[699.626201] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[699.638387] Starting dynamic subtest: pipe-D-plane-1
[700.093178] Dynamic subtest pipe-D-plane-1: FAIL (0.606s)
[700.104914] Starting dynamic subtest: pipe-D-plane-2
[700.541554] Dynamic subtest pipe-D-plane-2: FAIL (0.577s)
[700.656330] Subtest plane-lut1d-post-ctm3x4: FAIL (7.336s)
[701.461148] [095/133] (323s left) kms_prime (d3hot)
[701.550751] Subtest D3hot: SKIP (0.000s)
[701.663336] [096/133] (323s left) gem_exec_reloc (basic-wc-gtt)
[701.731576] Subtest basic-wc-gtt: SKIP (0.000s)
[701.809454] [097/133] (323s left) gem_exec_balancer (parallel)
[702.092386] Starting subtest: parallel
[703.061251] Subtest parallel: SUCCESS (0.971s)
[704.304178] [098/133] (320s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[704.406576] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[704.411080] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[705.562271] [099/133] (319s left) kms_flip (plain-flip-interruptible)
[705.659995] Starting subtest: plain-flip-interruptible
[705.662373] Starting dynamic subtest: A-eDP1
[707.335212] Dynamic subtest A-eDP1: SUCCESS (1.674s)
[707.345964] Starting dynamic subtest: B-eDP1
[709.028859] Dynamic subtest B-eDP1: SUCCESS (1.692s)
[709.043956] Starting dynamic subtest: C-eDP1
[710.628762] Dynamic subtest C-eDP1: SUCCESS (1.597s)
[710.649553] Starting dynamic subtest: D-eDP1
[712.322453] Dynamic subtest D-eDP1: SUCCESS (1.690s)
[712.328544] Subtest plain-flip-interruptible: SUCCESS (6.668s)
[713.555235] [100/133] (311s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[713.645760] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[713.648140] Starting dynamic subtest: pipe-A-eDP-1
[713.671208] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[713.683022] Starting dynamic subtest: pipe-B-eDP-1
[713.704558] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[713.714035] Starting dynamic subtest: pipe-C-eDP-1
[713.735191] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[713.744812] Starting dynamic subtest: pipe-D-eDP-1
[713.766336] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[713.770687] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s)
[715.857103] [101/133] (309s left) gem_ctx_param (vm)
[715.911341] Starting subtest: vm
[715.961611] Subtest vm: SUCCESS (0.050s)
[716.096977] [102/133] (309s left) kms_properties (plane-properties-legacy)
[716.208852] Starting subtest: plane-properties-legacy
[716.211181] Starting dynamic subtest: pipe-A-eDP-1
[716.764572] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.557s)
[716.776027] Starting dynamic subtest: pipe-B-eDP-1
[717.989334] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.221s)
[717.999456] Starting dynamic subtest: pipe-C-eDP-1
[719.292776] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.304s)
[719.307596] Starting dynamic subtest: pipe-D-eDP-1
[720.598213] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.304s)
[720.600641] Subtest plane-properties-legacy: SUCCESS (4.392s)
[721.464417] [103/133] (303s left) gem_pxp (reject-modify-context-protection-off-3)
[721.580474] Starting subtest: reject-modify-context-protection-off-3
[721.582881] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[721.717806] [104/133] (303s left) prime_self_import (basic-with_one_bo_two_files)
[721.755997] Starting subtest: basic-with_one_bo_two_files
[721.769908] Subtest basic-with_one_bo_two_files: SUCCESS (0.018s)
[721.869629] [105/133] (303s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[721.959476] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[721.961720] Starting dynamic subtest: pipe-A
[722.022447] Dynamic subtest pipe-A: SUCCESS (0.065s)
[722.033625] Starting dynamic subtest: pipe-B
[723.150461] Dynamic subtest pipe-B: SUCCESS (1.126s)
[723.163049] Starting dynamic subtest: pipe-C
[724.251961] Dynamic subtest pipe-C: SUCCESS (1.099s)
[724.261900] Starting dynamic subtest: pipe-D
[725.333958] Dynamic subtest pipe-D: SUCCESS (1.081s)
[725.336391] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.377s)
[726.456609] [106/133] (298s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[726.574672] Starting subtest: 4-tiled-16bpp-rotate-90
[726.595451] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.020s)
[726.723163] [107/133] (298s left) gen9_exec_parse (batch-invalid-length)
[726.791155] Subtest batch-invalid-length: SKIP (0.000s)
[726.855902] [108/133] (298s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[726.913745] Starting subtest: invalid-signal-one-illegal-handle
[726.915793] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[727.011136] [109/133] (298s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[727.127617] Starting subtest: x-tiled-64bpp-rotate-180
[728.773430] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.646s)
[728.940775] [110/133] (296s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[729.037626] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[729.041020] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[729.133778] [111/133] (296s left) gem_exec_params (invalid-ring2)
[729.191050] Starting subtest: invalid-ring2
[729.193045] Subtest invalid-ring2: SUCCESS (0.000s)
[729.315514] [112/133] (296s left) gem_vm_create (invalid-create)
[729.384560] Starting subtest: invalid-create
[729.388885] Subtest invalid-create: SUCCESS (0.002s)
[729.501813] [113/133] (296s left) kms_addfb_basic (bad-pitch-128)
[729.550528] Starting subtest: bad-pitch-128
[729.552073] Subtest bad-pitch-128: SUCCESS (0.000s)
[729.671303] [114/133] (296s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[729.728778] Starting subtest: single-wait-all-for-submit-available-submitted
[729.730607] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[729.829363] [115/133] (296s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[729.945473] Starting subtest: cursorB-vs-flipA-toggle
[729.949132] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[730.089470] [116/133] (295s left) prime_vgem (fence-write-hang)
[730.160700] Subtest fence-write-hang: SKIP (0.000s)
[730.259926] [117/133] (295s left) fbdev (eof)
[730.297801] Starting subtest: eof
[730.299605] Subtest eof: SUCCESS (0.000s)
[730.375301] [118/133] (295s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[730.486699] Starting subtest: 2x-flip-vs-cursor-atomic
[730.490819] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.002s)
[730.655467] [119/133] (295s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[730.744420] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[730.747978] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[730.838470] [120/133] (295s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[730.932329] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[737.776593] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.846s)
[737.914681] [121/133] (288s left) prime_mmap_kms (buffer-sharing)
[738.025025] Starting subtest: buffer-sharing
[738.495706] Subtest buffer-sharing: SUCCESS (0.472s)
[739.368797] [122/133] (286s left) gem_exec_fence (basic-await)
[739.545566] Starting subtest: basic-await
[739.547770] Starting dynamic subtest: rcs0
[739.617297] Dynamic subtest rcs0: SUCCESS (0.074s)
[739.634442] Starting dynamic subtest: bcs0
[739.692314] Dynamic subtest bcs0: SUCCESS (0.073s)
[739.707093] Starting dynamic subtest: vcs0
[739.767089] Dynamic subtest vcs0: SUCCESS (0.073s)
[739.782253] Starting dynamic subtest: vcs1
[739.841186] Dynamic subtest vcs1: SUCCESS (0.072s)
[739.854223] Starting dynamic subtest: vecs0
[739.914557] Dynamic subtest vecs0: SUCCESS (0.072s)
[739.928555] Starting dynamic subtest: ccs0
[739.987753] Dynamic subtest ccs0: SUCCESS (0.072s)
[739.990567] Subtest basic-await: SUCCESS (0.447s)
[741.410529] [123/133] (284s left) prime_busy (before-wait)
[741.465847] Starting subtest: before-wait
[741.471251] Starting dynamic subtest: rcs0
[741.492674] Dynamic subtest rcs0: SUCCESS (0.023s)
[741.504671] Starting dynamic subtest: bcs0
[741.532898] Dynamic subtest bcs0: SUCCESS (0.040s)
[741.543245] Starting dynamic subtest: vcs0
[741.574187] Dynamic subtest vcs0: SUCCESS (0.040s)
[741.584632] Starting dynamic subtest: vcs1
[741.616017] Dynamic subtest vcs1: SUCCESS (0.041s)
[741.625845] Starting dynamic subtest: vecs0
[741.657129] Dynamic subtest vecs0: SUCCESS (0.040s)
[741.669565] Starting dynamic subtest: ccs0
[741.696873] Dynamic subtest ccs0: SUCCESS (0.039s)
[741.805993] Subtest before-wait: SUCCESS (0.338s)
[741.887334] [124/133] (284s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[742.008777] Starting subtest: short-busy-flip-before-cursor-toggle
[742.013110] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[742.157851] [125/133] (284s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[742.206289] Starting subtest: invalid-multi-wait-unsubmitted
[742.208403] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[742.297007] [126/133] (283s left) gem_mmap_wc (invalid-flags)
[742.350621] Subtest invalid-flags: SKIP (0.000s)
[742.418814] [127/133] (283s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[742.515619] Starting subtest: yf-tiled-64bpp-rotate-270
[742.519765] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[742.614213] [128/133] (283s left) kms_tv_load_detect (load-detect)
[742.668272] Subtest load-detect: SKIP (0.000s)
[742.743309] [129/133] (283s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[742.843138] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[742.846603] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[742.943441] [130/133] (283s left) syncobj_wait (wait-any-complex)
[742.999624] Starting subtest: wait-any-complex
[743.061241] Subtest wait-any-complex: SUCCESS (0.062s)
[743.138186] [131/133] (283s left) sw_sync (sync_expired_merge)
[743.187324] Starting subtest: sync_expired_merge
[744.261567] Subtest sync_expired_merge: SUCCESS (1.074s)
[744.334282] [132/133] (282s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[744.427766] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[744.431964] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[744.538072] [133/133] (282s left) kms_psr (psr-suspend)
[744.623385] Starting subtest: psr-suspend
[744.625598] Starting dynamic subtest: eDP-1
[763.258825] Dynamic subtest eDP-1: SUCCESS (3.346s)
[763.261088] Subtest psr-suspend: SUCCESS (3.348s)
[771.063998] 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.