[57.400340] Initializing watchdogs
[57.400466]   /dev/watchdog0
[57.415627] [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.420679] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.422848] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.426255] [001/133] (960s left) gem_exec_gttfill (engines)
[57.504897] Starting subtest: engines
[57.507293] Starting dynamic subtest: rcs0
[80.850239] Dynamic subtest rcs0: SUCCESS (23.374s)
[80.858959] Starting dynamic subtest: bcs0
[104.148760] Dynamic subtest bcs0: SUCCESS (23.297s)
[104.158117] Starting dynamic subtest: vcs0
[127.434984] Dynamic subtest vcs0: SUCCESS (23.284s)
[127.447447] Starting dynamic subtest: vcs1
[150.699964] Dynamic subtest vcs1: SUCCESS (23.263s)
[150.707665] Starting dynamic subtest: vecs0
[173.961538] Dynamic subtest vecs0: SUCCESS (23.258s)
[173.969589] Starting dynamic subtest: ccs0
[197.242680] Dynamic subtest ccs0: SUCCESS (23.278s)
[197.245836] Subtest engines: SUCCESS (139.759s)
[197.428428] [002/133] (820s left) perf (gen12-unprivileged-single-ctx-counters)
[197.618074] Starting subtest: gen12-unprivileged-single-ctx-counters
[197.620260] Starting dynamic subtest: rcs0
[198.228710] Dynamic subtest rcs0: SUCCESS (0.611s)
[198.231122] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.612s)
[198.280935] [003/133] (819s left) kms_joiner (basic-ultra-joiner)
[198.394258] Starting subtest: basic-ultra-joiner
[198.397547] Subtest basic-ultra-joiner: SKIP (0.000s)
[198.482905] [004/133] (819s left) prime_mmap (test_aperture_limit)
[198.540218] Starting subtest: test_aperture_limit
[198.541921] Starting dynamic subtest: test_aperture_limit-smem
[198.551074] Dynamic subtest test_aperture_limit-smem: SKIP (0.010s)
[198.554715] Subtest test_aperture_limit: SKIP (0.010s)
[198.637318] [005/133] (819s left) kms_plane (plane-position-hole)
[198.732471] Starting subtest: plane-position-hole
[199.299474] Starting dynamic subtest: pipe-A-plane-1
[200.587468] Dynamic subtest pipe-A-plane-1: SUCCESS (1.288s)
[200.595476] Starting dynamic subtest: pipe-A-plane-2
[201.832588] Dynamic subtest pipe-A-plane-2: SUCCESS (1.244s)
[201.842865] Starting dynamic subtest: pipe-A-plane-3
[203.139897] Dynamic subtest pipe-A-plane-3: SUCCESS (1.307s)
[203.149720] Starting dynamic subtest: pipe-A-plane-4
[204.376064] Dynamic subtest pipe-A-plane-4: SUCCESS (1.237s)
[204.385397] Starting dynamic subtest: pipe-A-plane-5
[204.402660] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[205.544669] Starting dynamic subtest: pipe-B-plane-1
[206.886656] Dynamic subtest pipe-B-plane-1: SUCCESS (1.350s)
[206.896551] Starting dynamic subtest: pipe-B-plane-2
[208.178540] Dynamic subtest pipe-B-plane-2: SUCCESS (1.290s)
[208.188410] Starting dynamic subtest: pipe-B-plane-3
[209.432292] Dynamic subtest pipe-B-plane-3: SUCCESS (1.255s)
[209.442098] Starting dynamic subtest: pipe-B-plane-4
[210.754733] Dynamic subtest pipe-B-plane-4: SUCCESS (1.322s)
[210.765472] Starting dynamic subtest: pipe-B-plane-5
[210.778434] Dynamic subtest pipe-B-plane-5: SUCCESS (0.022s)
[210.780644] Subtest plane-position-hole: SUCCESS (12.045s)
[211.544441] [006/133] (806s left) kms_async_flips (alternate-sync-async-flip-atomic)
[211.641162] Starting subtest: alternate-sync-async-flip-atomic
[212.014048] Starting dynamic subtest: pipe-A-eDP-1
[214.838030] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.825s)
[215.215705] Starting dynamic subtest: pipe-B-eDP-1
[217.965823] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.757s)
[218.349770] Starting dynamic subtest: pipe-C-eDP-1
[221.092989] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.754s)
[221.466410] Starting dynamic subtest: pipe-D-eDP-1
[224.234392] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.776s)
[224.236452] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.596s)
[225.400687] [007/133] (792s left) kms_cursor_crc (cursor-random-64x21)
[225.587076] Starting subtest: cursor-random-64x21
[225.637233] Subtest cursor-random-64x21: SKIP (0.045s)
[225.868893] [008/133] (792s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[225.934269] Starting subtest: basic-batch-kernel-default-cmd
[225.938930] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[226.125375] [009/133] (792s left) gem_userptr_blits (map-fixed-invalidate)
[226.196635] Starting subtest: map-fixed-invalidate
[226.201186] Subtest map-fixed-invalidate: SKIP (0.000s)
[226.325950] [010/133] (791s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[226.380660] Starting subtest: multi-wait-for-submit-submitted-signaled
[226.382750] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[226.480184] [011/133] (791s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[226.584822] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[227.409346] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.826s)
[227.586660] [012/133] (790s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[227.706310] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[259.051206] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.342s)
[259.918647] [013/133] (758s left) kms_psr (psr2-basic)
[260.017096] Starting subtest: psr2-basic
[260.019206] Starting dynamic subtest: eDP-1
[261.588755] Dynamic subtest eDP-1: SUCCESS (1.570s)
[261.590636] Subtest psr2-basic: SUCCESS (1.571s)
[262.389951] [014/133] (756s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[262.488218] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[262.492407] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[262.584323] [015/133] (755s left) kms_big_fb (linear-16bpp-rotate-180)
[262.697385] Starting subtest: linear-16bpp-rotate-180
[263.987654] Subtest linear-16bpp-rotate-180: SUCCESS (1.289s)
[264.141650] [016/133] (754s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[264.234377] Starting subtest: bad-pixel-format-y-tiled-ccs
[264.236247] Starting dynamic subtest: pipe-A-eDP-1
[264.254899] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[264.264824] Starting dynamic subtest: pipe-B-eDP-1
[264.283189] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[264.292736] Starting dynamic subtest: pipe-C-eDP-1
[264.310046] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[264.318814] Starting dynamic subtest: pipe-D-eDP-1
[264.336577] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[264.339912] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[266.543824] [017/133] (752s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[266.632289] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[266.636282] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[266.700250] [018/133] (751s left) i915_drm_fdinfo (most-busy-idle-check-all)
[266.743680] Starting subtest: most-busy-idle-check-all
[266.745918] Starting dynamic subtest: rcs0
[266.753187] Dynamic subtest rcs0: SKIP (0.006s)
[266.764515] Starting dynamic subtest: bcs0
[266.768794] Dynamic subtest bcs0: SKIP (0.000s)
[266.777559] Starting dynamic subtest: vcs0
[266.781739] Dynamic subtest vcs0: SKIP (0.000s)
[266.788972] Starting dynamic subtest: vcs1
[266.792803] Dynamic subtest vcs1: SKIP (0.000s)
[266.799906] Starting dynamic subtest: vecs0
[266.803783] Dynamic subtest vecs0: SKIP (0.000s)
[266.810939] Starting dynamic subtest: ccs0
[266.814895] Dynamic subtest ccs0: SKIP (0.000s)
[266.818773] Subtest most-busy-idle-check-all: SKIP (0.011s)
[266.852786] [019/133] (751s left) perf_pmu (rc6-suspend)
[266.895951] Starting subtest: rc6-suspend
[289.413634] Subtest rc6-suspend: SUCCESS (8.443s)
[290.277787] [020/133] (728s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[290.396380] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[290.400503] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[290.497293] [021/133] (728s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[290.581917] Starting subtest: fbc-psr2-sprite-plane-onoff
[290.583834] Starting dynamic subtest: eDP-1
[290.587351] Dynamic subtest eDP-1: SKIP (0.000s)
[290.590703] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[290.700216] [022/133] (728s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[290.806840] Starting subtest: 4-tiled-16bpp-rotate-0
[292.164324] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.368s)
[292.284605] [023/133] (726s left) gem_workarounds (reset-fd)
[292.353172] Starting subtest: reset-fd
[292.533797] Subtest reset-fd: SUCCESS (0.182s)
[292.660295] [024/133] (726s left) kms_fence_pin_leak
[292.821313] [025/133] (726s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[292.874461] Starting subtest: y-tiled-to-vebox-y-tiled
[292.878138] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[293.054088] [026/133] (725s left) kms_cdclk (mode-transition)
[293.142266] Starting subtest: mode-transition
[293.144593] Starting dynamic subtest: pipe-A-eDP-1
[293.439888] Dynamic subtest pipe-A-eDP-1: SKIP (0.299s)
[293.449616] Starting dynamic subtest: pipe-B-eDP-1
[293.453918] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[293.462738] Starting dynamic subtest: pipe-C-eDP-1
[293.467164] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[293.475849] Starting dynamic subtest: pipe-D-eDP-1
[293.480183] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[293.484406] Subtest mode-transition: SKIP (0.306s)
[294.261423] [027/133] (724s left) gem_exec_params (dr4-dirt)
[294.322941] Starting subtest: DR4-dirt
[294.325068] Subtest DR4-dirt: SUCCESS (0.000s)
[294.421540] [028/133] (724s left) syncobj_wait (multi-wait-all-submitted)
[294.488297] Starting subtest: multi-wait-all-submitted
[294.594553] Subtest multi-wait-all-submitted: SUCCESS (0.105s)
[294.668382] [029/133] (724s left) gem_exec_store (basic)
[294.722549] Starting subtest: basic
[294.812122] Subtest basic: SUCCESS (0.092s)
[294.988740] [030/133] (724s left) gem_ctx_persistence (saturated-hostile)
[295.048443] Starting subtest: saturated-hostile
[295.050607] Starting dynamic subtest: rcs0
[295.875274] Dynamic subtest rcs0: SUCCESS (0.830s)
[295.887992] Starting dynamic subtest: bcs0
[296.654507] Dynamic subtest bcs0: SUCCESS (0.782s)
[296.667066] Starting dynamic subtest: vcs0
[297.439529] Dynamic subtest vcs0: SUCCESS (0.787s)
[297.451582] Starting dynamic subtest: vcs1
[298.243499] Dynamic subtest vcs1: SUCCESS (0.807s)
[298.255568] Starting dynamic subtest: vecs0
[299.040252] Dynamic subtest vecs0: SUCCESS (0.797s)
[299.052180] Starting dynamic subtest: ccs0
[299.878117] Dynamic subtest ccs0: SUCCESS (0.840s)
[299.880544] Subtest saturated-hostile: SUCCESS (4.852s)
[299.998125] [031/133] (719s left) kms_psr (psr-cursor-plane-onoff)
[300.084543] Starting subtest: psr-cursor-plane-onoff
[300.086751] Starting dynamic subtest: eDP-1
[301.819868] Dynamic subtest eDP-1: SUCCESS (1.738s)
[301.822217] Subtest psr-cursor-plane-onoff: SUCCESS (1.739s)
[302.688667] [032/133] (716s left) i915_hangman (detector)
[302.762574] Starting subtest: detector
[302.765098] Starting dynamic subtest: rcs0
[313.956960] Dynamic subtest rcs0: SUCCESS (11.210s)
[313.968946] Starting dynamic subtest: bcs0
[325.990211] Dynamic subtest bcs0: SUCCESS (12.028s)
[326.002465] Starting dynamic subtest: vcs0
[337.957523] Dynamic subtest vcs0: SUCCESS (11.965s)
[337.969962] Starting dynamic subtest: vcs1
[348.965318] Dynamic subtest vcs1: SUCCESS (11.007s)
[348.977338] Starting dynamic subtest: vecs0
[360.933296] Dynamic subtest vecs0: SUCCESS (11.969s)
[360.945920] Starting dynamic subtest: ccs0
[370.980536] Dynamic subtest ccs0: SUCCESS (10.048s)
[370.983149] Subtest detector: SUCCESS (68.242s)
[371.098316] [033/133] (648s left) kms_force_connector_basic (force-connector-state)
[371.191307] Starting subtest: force-connector-state
[371.813084] Subtest force-connector-state: SUCCESS (0.624s)
[372.698274] [034/133] (646s left) kms_universal_plane (universal-plane-sanity)
[372.804190] Starting subtest: universal-plane-sanity
[372.806088] Starting dynamic subtest: pipe-A-eDP-1
[373.405738] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.602s)
[373.416800] Starting dynamic subtest: pipe-B-eDP-1
[374.604318] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.199s)
[374.614967] Starting dynamic subtest: pipe-C-eDP-1
[375.775875] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.171s)
[375.786731] Starting dynamic subtest: pipe-D-eDP-1
[376.957559] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.180s)
[376.959711] Subtest universal-plane-sanity: SUCCESS (4.156s)
[377.789656] [035/133] (641s left) dmabuf_sync_file (import-multiple-read-write)
[377.910597] Starting subtest: import-multiple-read-write
[377.912741] Subtest import-multiple-read-write: SUCCESS (0.003s)
[377.965648] [FACT dmabuf_sync_file (import-multiple-read-write)] new: kernel.kmod_is_loaded.vgem: true
[377.969194] [036/133] (641s left) kms_pm_dc (dc5-dpms-negative)
[379.086065] Starting subtest: dc5-dpms-negative
[379.090573] Subtest dc5-dpms-negative: SKIP (0.000s)
[379.158212] [037/133] (640s left) gem_render_copy_redux (flink)
[379.215216] Starting subtest: flink
[380.053730] Subtest flink: SUCCESS (0.840s)
[380.192513] [038/133] (639s left) kms_cursor_crc (cursor-onscreen-64x64)
[380.370170] Starting subtest: cursor-onscreen-64x64
[380.374039] Starting dynamic subtest: pipe-A-eDP-1
[382.518456] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.142s)
[382.546660] Starting dynamic subtest: pipe-D-eDP-1
[385.323911] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.783s)
[385.326194] Subtest cursor-onscreen-64x64: SUCCESS (4.951s)
[386.194294] [039/133] (633s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[386.293465] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[386.297426] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[386.364273] [040/133] (633s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[386.458834] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[394.972755] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.512s)
[395.074435] [041/133] (624s left) gem_mmap_wc (bad-offset)
[395.140467] Subtest bad-offset: SKIP (0.000s)
[395.213295] [042/133] (624s left) gem_softpin (evict-single-offset)
[395.261507] Starting subtest: evict-single-offset
[419.977310] Subtest evict-single-offset: SUCCESS (24.710s)
[420.060251] [043/133] (599s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[420.261978] Starting subtest: dp-mst-type-1-suspend-resume
[420.266027] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[420.384101] [044/133] (599s left) gem_ctx_shared (q-out-order)
[420.443459] Starting subtest: Q-out-order
[420.445858] Starting dynamic subtest: rcs0
[420.558243] Dynamic subtest rcs0: SUCCESS (0.113s)
[420.570051] Starting dynamic subtest: vcs0
[420.654518] Dynamic subtest vcs0: SUCCESS (0.095s)
[420.671942] Starting dynamic subtest: vcs1
[420.746414] Dynamic subtest vcs1: SUCCESS (0.092s)
[420.764462] Starting dynamic subtest: vecs0
[420.827495] Dynamic subtest vecs0: SUCCESS (0.078s)
[420.844531] Starting dynamic subtest: ccs0
[420.918811] Dynamic subtest ccs0: SUCCESS (0.090s)
[420.921677] Subtest Q-out-order: SUCCESS (0.475s)
[422.117320] [045/133] (597s left) gem_softpin (softpin)
[422.176986] Starting subtest: softpin
[454.574948] Subtest softpin: SUCCESS (32.398s)
[454.725831] [046/133] (565s left) kms_plane_alpha_blend (coverage-7efc)
[454.820944] Starting subtest: coverage-7efc
[455.097407] Starting dynamic subtest: pipe-A-eDP-1
[455.648834] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s)
[455.676163] Starting dynamic subtest: pipe-D-eDP-1
[456.966409] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.295s)
[456.968572] Subtest coverage-7efc: SUCCESS (2.145s)
[457.780994] [047/133] (562s left) kms_busy (extended-pageflip-hang-oldfb)
[457.878812] Starting subtest: extended-pageflip-hang-oldfb
[457.881247] Starting dynamic subtest: pipe-A
[458.292620] Dynamic subtest pipe-A: SUCCESS (0.412s)
[458.304790] Starting dynamic subtest: pipe-D
[459.373939] Dynamic subtest pipe-D: SUCCESS (1.079s)
[459.376135] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.496s)
[460.191086] [048/133] (559s left) kms_big_fb (y-tiled-addfb)
[460.300433] Starting subtest: y-tiled-addfb
[460.304860] Subtest y-tiled-addfb: SKIP (0.000s)
[460.413591] [049/133] (559s left) kms_plane_multiple (tiling-none)
[460.515329] Starting subtest: tiling-none
[460.517614] Starting dynamic subtest: pipe-A-eDP-1
[464.411644] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.895s)
[464.421873] Starting dynamic subtest: pipe-B-eDP-1
[469.007030] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.595s)
[469.017613] Starting dynamic subtest: pipe-C-eDP-1
[473.592747] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.586s)
[473.603357] Starting dynamic subtest: pipe-D-eDP-1
[478.093453] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.502s)
[478.095876] Subtest tiling-none: SUCCESS (17.584s)
[478.987972] [050/133] (540s left) kms_chamelium_frames (dp-crc-fast)
[479.385417] Subtest dp-crc-fast: SKIP (0.000s)
[480.167203] [051/133] (539s left) i915_suspend (fence-restore-tiled2untiled)
[480.223129] Starting subtest: fence-restore-tiled2untiled
[480.227651] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[480.316976] [052/133] (539s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[480.407142] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[486.901701] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.498s)
[487.007193] [053/133] (533s left) kms_chamelium_hpd (hdmi-hpd-fast)
[487.394089] Subtest hdmi-hpd-fast: SKIP (0.000s)
[488.173994] [054/133] (531s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[488.270047] Starting subtest: fbc-psr2-primary-mmap-cpu
[488.272420] Starting dynamic subtest: eDP-1
[488.276920] Dynamic subtest eDP-1: SKIP (0.000s)
[488.281414] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[488.349316] [055/133] (531s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[488.454661] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[488.457015] Starting dynamic subtest: pipe-A-eDP-1
[504.905846] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.458s)
[504.917864] Starting dynamic subtest: pipe-B-eDP-1
[522.125575] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.213s)
[522.127953] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.674s)
[522.969998] [056/133] (497s left) api_intel_bb (object-reloc-keep-cache)
[523.032638] Starting subtest: object-reloc-keep-cache
[523.037434] Subtest object-reloc-keep-cache: SKIP (0.003s)
[523.158408] [057/133] (497s left) kms_flip (absolute-wf_vblank)
[523.252186] Starting subtest: absolute-wf_vblank
[523.254473] Starting dynamic subtest: A-eDP1
[532.003662] Dynamic subtest A-eDP1: SUCCESS (8.748s)
[532.017222] Starting dynamic subtest: B-eDP1
[540.698438] Dynamic subtest B-eDP1: SUCCESS (8.690s)
[540.708572] Starting dynamic subtest: C-eDP1
[549.392468] Dynamic subtest C-eDP1: SUCCESS (8.691s)
[549.403640] Starting dynamic subtest: D-eDP1
[558.087950] Dynamic subtest D-eDP1: SUCCESS (8.692s)
[558.093244] Subtest absolute-wf_vblank: SUCCESS (34.835s)
[559.276822] [058/133] (461s left) gem_exec_schedule (preempt-other-chain)
[559.368879] Starting subtest: preempt-other-chain
[559.371271] Starting dynamic subtest: rcs0
[559.448982] Dynamic subtest rcs0: SUCCESS (0.083s)
[559.459599] Starting dynamic subtest: bcs0
[559.527199] Dynamic subtest bcs0: SUCCESS (0.076s)
[559.541737] Starting dynamic subtest: vcs0
[559.608182] Dynamic subtest vcs0: SUCCESS (0.081s)
[559.624801] Starting dynamic subtest: vcs1
[559.687265] Dynamic subtest vcs1: SUCCESS (0.077s)
[559.703620] Starting dynamic subtest: vecs0
[559.765259] Dynamic subtest vecs0: SUCCESS (0.077s)
[559.778842] Starting dynamic subtest: ccs0
[559.852237] Dynamic subtest ccs0: SUCCESS (0.087s)
[559.854882] Subtest preempt-other-chain: SUCCESS (0.487s)
[561.096234] [059/133] (459s left) gem_exec_schedule (u-fairslice)
[561.170031] Starting subtest: u-fairslice
[561.172249] Starting dynamic subtest: rcs0
[563.213149] Dynamic subtest rcs0: SUCCESS (2.039s)
[563.224183] Starting dynamic subtest: bcs0
[565.245280] Dynamic subtest bcs0: SUCCESS (2.029s)
[565.256681] Starting dynamic subtest: vcs0
[567.265200] Dynamic subtest vcs0: SUCCESS (2.019s)
[567.274878] Starting dynamic subtest: vcs1
[569.290207] Dynamic subtest vcs1: SUCCESS (2.022s)
[569.300884] Starting dynamic subtest: vecs0
[571.308537] Dynamic subtest vecs0: SUCCESS (2.017s)
[571.320250] Starting dynamic subtest: ccs0
[573.329828] Dynamic subtest ccs0: SUCCESS (2.023s)
[573.331774] Subtest u-fairslice: SUCCESS (12.156s)
[573.642584] [060/133] (446s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[573.740480] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[573.744654] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[573.833675] [061/133] (446s left) kms_cursor_crc (cursor-sliding-256x85)
[574.098168] Starting subtest: cursor-sliding-256x85
[574.142863] Subtest cursor-sliding-256x85: SKIP (0.041s)
[574.300325] [062/133] (446s left) gem_shrink (reclaim)
[574.359153] Starting subtest: reclaim
[576.762552] Subtest reclaim: SUCCESS (2.403s)
[576.917304] [063/133] (443s left) syncobj_timeline (wait-for-submit-complex)
[576.968074] Starting subtest: wait-for-submit-complex
[577.028438] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[577.117434] [064/133] (443s left) kms_dsc (dsc-with-formats)
[577.207746] Starting subtest: dsc-with-formats
[577.247278] Subtest dsc-with-formats: SKIP (0.001s)
[577.286776] [065/133] (443s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[577.409189] Starting subtest: flip-vs-cursor-atomic
[584.528504] Subtest flip-vs-cursor-atomic: SUCCESS (7.118s)
[585.368281] [066/133] (435s left) kms_vblank (query-forked-busy)
[585.470198] Starting subtest: query-forked-busy
[585.472452] Starting dynamic subtest: pipe-A-eDP-1
[587.355044] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.885s)
[587.372693] Starting dynamic subtest: pipe-D-eDP-1
[589.898394] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.541s)
[589.900824] Subtest query-forked-busy: SUCCESS (4.430s)
[590.766802] [067/133] (429s left) kms_lease (lease-unleased-connector)
[590.870507] Starting subtest: lease-unleased-connector
[590.872745] Starting dynamic subtest: pipe-A-eDP-1
[590.875078] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[590.890366] Starting dynamic subtest: pipe-B-eDP-1
[590.892658] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[590.903243] Starting dynamic subtest: pipe-C-eDP-1
[590.905102] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[590.914408] Starting dynamic subtest: pipe-D-eDP-1
[590.916326] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[590.918218] Subtest lease-unleased-connector: SUCCESS (0.032s)
[591.011186] [068/133] (429s left) kms_addfb_basic (bad-pitch-63)
[591.063019] Starting subtest: bad-pitch-63
[591.065115] Subtest bad-pitch-63: SUCCESS (0.000s)
[591.197155] [069/133] (429s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[591.293819] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[591.298285] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[591.377779] [070/133] (429s left) gem_exec_params (dr1-dirt)
[591.436201] Starting subtest: DR1-dirt
[591.438556] Subtest DR1-dirt: SUCCESS (0.000s)
[591.543681] [071/133] (429s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[591.641256] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[591.645272] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[591.733341] [072/133] (429s left) kms_rmfb (rmfb-ioctl)
[591.817060] Starting subtest: rmfb-ioctl
[591.818873] Starting dynamic subtest: pipe-A-eDP-1
[591.920664] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[591.930445] Starting dynamic subtest: pipe-B-eDP-1
[593.103788] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.181s)
[593.115701] Starting dynamic subtest: pipe-C-eDP-1
[594.277241] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.172s)
[594.288539] Starting dynamic subtest: pipe-D-eDP-1
[595.483888] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.205s)
[595.486708] Subtest rmfb-ioctl: SUCCESS (3.671s)
[596.674758] [073/133] (424s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[596.785116] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[603.338234] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.557s)
[603.464354] [074/133] (417s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[603.564481] Starting subtest: fbc-rgb565-draw-blt
[607.669538] Subtest fbc-rgb565-draw-blt: SUCCESS (4.109s)
[608.893667] [075/133] (412s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[608.990116] Starting subtest: crc-primary-basic-yf-tiled-ccs
[608.992419] Starting dynamic subtest: pipe-A-eDP-1
[609.014369] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[609.026104] Starting dynamic subtest: pipe-B-eDP-1
[609.046680] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[609.056206] Starting dynamic subtest: pipe-C-eDP-1
[609.077561] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[609.086981] Starting dynamic subtest: pipe-D-eDP-1
[609.109605] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[609.114070] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[611.270763] [076/133] (409s left) i915_pm_rpm (sysfs-read)
[613.198716] Starting subtest: sysfs-read
[614.351345] Subtest sysfs-read: SUCCESS (1.151s)
[614.712030] [077/133] (406s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[614.806934] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[614.809090] Starting dynamic subtest: pipe-A-default-mode
[617.534362] Dynamic subtest pipe-A-default-mode: SUCCESS (2.726s)
[617.536197] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.728s)
[618.357271] [078/133] (402s left) gem_unfence_active_buffers
[618.522563] [079/133] (402s left) gem_exec_suspend (basic)
[618.576494] Starting subtest: basic
[618.578874] Starting dynamic subtest: smem
[620.039766] Dynamic subtest smem: SUCCESS (1.461s)
[620.042741] Subtest basic: SUCCESS (1.463s)
[620.227045] [080/133] (400s left) gem_exec_whisper (basic-sync)
[620.295197] Starting subtest: basic-sync
[630.559442] Subtest basic-sync: SUCCESS (10.263s)
[630.745548] [081/133] (390s left) gem_exec_params (invalid-bsd-ring)
[630.816848] Starting subtest: invalid-bsd-ring
[630.819065] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[630.922067] [082/133] (390s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[631.037223] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[631.041660] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[631.110693] [083/133] (390s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[631.175614] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[631.251321] [084/133] (390s left) gem_exec_fence (syncobj-signal)
[631.740143] Starting subtest: syncobj-signal
[631.745227] Subtest syncobj-signal: SUCCESS (0.007s)
[633.118267] [085/133] (388s left) i915_query (query-topology-coherent-slice-mask)
[633.176793] Starting subtest: query-topology-coherent-slice-mask
[633.181318] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[633.271230] [086/133] (388s left) syncobj_eventfd (invalid-illegal-handle)
[633.322018] Starting subtest: invalid-illegal-handle
[633.324290] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[633.418478] [087/133] (388s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[633.511556] Starting subtest: psr2-cursor-plane-update-sf
[633.513834] Starting dynamic subtest: pipe-A-eDP-1
[634.101949] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.595s)
[634.113055] Starting dynamic subtest: pipe-B-eDP-1
[635.407910] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.306s)
[635.410292] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.904s)
[636.260720] [088/133] (385s left) kms_flip (flip-vs-expired-vblank)
[636.353610] Starting subtest: flip-vs-expired-vblank
[636.355952] Starting dynamic subtest: A-eDP1
[645.040423] Dynamic subtest A-eDP1: SUCCESS (8.690s)
[645.052855] Starting dynamic subtest: B-eDP1
[653.738190] Dynamic subtest B-eDP1: SUCCESS (8.697s)
[653.754204] Starting dynamic subtest: C-eDP1
[662.420756] Dynamic subtest C-eDP1: SUCCESS (8.681s)
[662.441085] Starting dynamic subtest: D-eDP1
[671.135856] Dynamic subtest D-eDP1: SUCCESS (8.708s)
[671.137853] Subtest flip-vs-expired-vblank: SUCCESS (34.789s)
[672.348419] [089/133] (349s left) gem_create (create-massive)
[672.405077] Starting subtest: create-massive
[672.406984] Subtest create-massive: SUCCESS (0.000s)
[672.588159] [090/133] (349s left) kms_flip (flip-vs-wf_vblank-interruptible)
[672.685191] Starting subtest: flip-vs-wf_vblank-interruptible
[672.687382] Starting dynamic subtest: A-eDP1
[674.571056] Dynamic subtest A-eDP1: SUCCESS (1.885s)
[674.586791] Starting dynamic subtest: B-eDP1
[676.466509] Dynamic subtest B-eDP1: SUCCESS (1.893s)
[676.477232] Starting dynamic subtest: C-eDP1
[678.355941] Dynamic subtest C-eDP1: SUCCESS (1.888s)
[678.365993] Starting dynamic subtest: D-eDP1
[680.255751] Dynamic subtest D-eDP1: SUCCESS (1.898s)
[680.260501] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.576s)
[681.447360] [091/133] (340s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[681.547714] Starting subtest: psr-rgb101010-draw-mmap-cpu
[688.473946] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (6.929s)
[688.566843] [092/133] (333s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[688.622103] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[688.678293] [093/133] (333s left) gem_mmap_gtt (isolation)
[688.727161] Subtest isolation: SKIP (0.000s)
[688.793289] [094/133] (333s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[688.882108] Starting subtest: plane-lut1d-post-ctm3x4
[689.007395] Starting dynamic subtest: pipe-A-plane-0
[689.337236] Dynamic subtest pipe-A-plane-0: FAIL (0.159s)
[689.351012] Starting dynamic subtest: pipe-A-plane-1
[689.538739] Dynamic subtest pipe-A-plane-1: FAIL (0.158s)
[689.548094] Starting dynamic subtest: pipe-A-plane-2
[689.753153] Dynamic subtest pipe-A-plane-2: FAIL (0.166s)
[690.700860] Starting dynamic subtest: pipe-B-plane-0
[691.139695] Dynamic subtest pipe-B-plane-0: FAIL (0.174s)
[691.151811] Starting dynamic subtest: pipe-B-plane-1
[691.457321] Dynamic subtest pipe-B-plane-1: FAIL (0.155s)
[691.468651] Starting dynamic subtest: pipe-B-plane-2
[691.773857] Dynamic subtest pipe-B-plane-2: FAIL (0.167s)
[692.409863] Starting dynamic subtest: pipe-C-plane-0
[692.893847] Dynamic subtest pipe-C-plane-0: FAIL (0.129s)
[692.905488] Starting dynamic subtest: pipe-C-plane-1
[693.299265] Dynamic subtest pipe-C-plane-1: FAIL (0.616s)
[693.312083] Starting dynamic subtest: pipe-C-plane-2
[693.672810] Dynamic subtest pipe-C-plane-2: FAIL (0.147s)
[694.499024] Starting dynamic subtest: pipe-D-plane-0
[695.094598] Dynamic subtest pipe-D-plane-0: FAIL (0.163s)
[695.105565] Starting dynamic subtest: pipe-D-plane-1
[695.554793] Dynamic subtest pipe-D-plane-1: FAIL (0.591s)
[695.565977] Starting dynamic subtest: pipe-D-plane-2
[695.995755] Dynamic subtest pipe-D-plane-2: FAIL (0.538s)
[696.076382] Subtest plane-lut1d-post-ctm3x4: FAIL (7.197s)
[696.946880] [095/133] (324s left) kms_prime (d3hot)
[697.044342] Subtest D3hot: SKIP (0.000s)
[697.155089] [096/133] (324s left) gem_exec_reloc (basic-wc-gtt)
[697.208622] Subtest basic-wc-gtt: SKIP (0.000s)
[697.284990] [097/133] (324s left) gem_exec_balancer (parallel)
[697.542865] Starting subtest: parallel
[698.560948] Subtest parallel: SUCCESS (1.018s)
[699.061375] [098/133] (322s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[699.168727] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[699.173178] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[700.259420] [099/133] (321s left) kms_flip (plain-flip-interruptible)
[700.360764] Starting subtest: plain-flip-interruptible
[700.363211] Starting dynamic subtest: A-eDP1
[702.026690] Dynamic subtest A-eDP1: SUCCESS (1.665s)
[702.047708] Starting dynamic subtest: B-eDP1
[703.727762] Dynamic subtest B-eDP1: SUCCESS (1.698s)
[703.745182] Starting dynamic subtest: C-eDP1
[705.414247] Dynamic subtest C-eDP1: SUCCESS (1.684s)
[705.424301] Starting dynamic subtest: D-eDP1
[707.031334] Dynamic subtest D-eDP1: SUCCESS (1.615s)
[707.036403] Subtest plain-flip-interruptible: SUCCESS (6.678s)
[708.270088] [100/133] (313s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[708.401989] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[708.404090] Starting dynamic subtest: pipe-A-eDP-1
[708.426243] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[708.437459] Starting dynamic subtest: pipe-B-eDP-1
[708.458087] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[708.468123] Starting dynamic subtest: pipe-C-eDP-1
[708.489002] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[708.499169] Starting dynamic subtest: pipe-D-eDP-1
[708.521645] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[708.525758] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.005s)
[710.645507] [101/133] (311s left) gem_ctx_param (vm)
[710.711926] Starting subtest: vm
[710.761844] Subtest vm: SUCCESS (0.049s)
[710.900154] [102/133] (311s left) kms_properties (plane-properties-legacy)
[710.992259] Starting subtest: plane-properties-legacy
[710.994199] Starting dynamic subtest: pipe-A-eDP-1
[711.554447] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.560s)
[711.566129] Starting dynamic subtest: pipe-B-eDP-1
[712.782155] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.229s)
[712.793730] Starting dynamic subtest: pipe-C-eDP-1
[714.077828] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.294s)
[714.088145] Starting dynamic subtest: pipe-D-eDP-1
[715.375322] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.296s)
[715.377792] Subtest plane-properties-legacy: SUCCESS (4.384s)
[716.237213] [103/133] (305s left) gem_pxp (reject-modify-context-protection-off-3)
[716.363720] Starting subtest: reject-modify-context-protection-off-3
[716.366498] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[716.469220] [104/133] (305s left) prime_self_import (basic-with_one_bo_two_files)
[716.507960] Starting subtest: basic-with_one_bo_two_files
[716.524506] Subtest basic-with_one_bo_two_files: SUCCESS (0.017s)
[716.634488] [105/133] (305s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[716.735772] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[716.738146] Starting dynamic subtest: pipe-A
[716.798137] Dynamic subtest pipe-A: SUCCESS (0.064s)
[716.810465] Starting dynamic subtest: pipe-B
[717.927210] Dynamic subtest pipe-B: SUCCESS (1.128s)
[717.938815] Starting dynamic subtest: pipe-C
[719.018025] Dynamic subtest pipe-C: SUCCESS (1.089s)
[719.028432] Starting dynamic subtest: pipe-D
[720.110445] Dynamic subtest pipe-D: SUCCESS (1.092s)
[720.112831] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.378s)
[721.251330] [106/133] (301s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[721.368355] Starting subtest: 4-tiled-16bpp-rotate-90
[721.388569] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.020s)
[721.493508] [107/133] (300s left) gen9_exec_parse (batch-invalid-length)
[721.562997] Subtest batch-invalid-length: SKIP (0.000s)
[721.625317] [108/133] (300s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[721.685422] Starting subtest: invalid-signal-one-illegal-handle
[721.687639] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[721.792270] [109/133] (300s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[721.906053] Starting subtest: x-tiled-64bpp-rotate-180
[723.495571] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.590s)
[723.672871] [110/133] (298s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[723.771052] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[723.775399] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[723.868119] [111/133] (298s left) gem_exec_params (invalid-ring2)
[723.922940] Starting subtest: invalid-ring2
[723.924832] Subtest invalid-ring2: SUCCESS (0.000s)
[724.017725] [112/133] (298s left) gem_vm_create (invalid-create)
[724.068674] Starting subtest: invalid-create
[724.071335] Subtest invalid-create: SUCCESS (0.002s)
[724.172147] [113/133] (298s left) kms_addfb_basic (bad-pitch-128)
[724.236286] Starting subtest: bad-pitch-128
[724.238637] Subtest bad-pitch-128: SUCCESS (0.000s)
[724.362042] [114/133] (298s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[724.416971] Starting subtest: single-wait-all-for-submit-available-submitted
[724.419293] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[724.528359] [115/133] (298s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[724.650598] Starting subtest: cursorB-vs-flipA-toggle
[724.654303] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[724.809040] [116/133] (297s left) prime_vgem (fence-write-hang)
[724.885555] Subtest fence-write-hang: SKIP (0.000s)
[724.976706] [117/133] (297s left) fbdev (eof)
[725.013140] Starting subtest: eof
[725.015135] Subtest eof: SUCCESS (0.000s)
[725.116752] [118/133] (297s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[725.234048] Starting subtest: 2x-flip-vs-cursor-atomic
[725.237772] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[725.380399] [119/133] (297s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[725.469604] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[725.472777] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[725.560501] [120/133] (297s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[725.651774] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[732.472916] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.822s)
[732.632560] [121/133] (290s left) prime_mmap_kms (buffer-sharing)
[732.729324] Starting subtest: buffer-sharing
[733.175290] Subtest buffer-sharing: SUCCESS (0.445s)
[734.036151] [122/133] (288s left) gem_exec_fence (basic-await)
[734.214662] Starting subtest: basic-await
[734.217061] Starting dynamic subtest: rcs0
[734.290755] Dynamic subtest rcs0: SUCCESS (0.076s)
[734.305492] Starting dynamic subtest: bcs0
[734.369686] Dynamic subtest bcs0: SUCCESS (0.076s)
[734.382415] Starting dynamic subtest: vcs0
[734.441979] Dynamic subtest vcs0: SUCCESS (0.071s)
[734.453719] Starting dynamic subtest: vcs1
[734.515179] Dynamic subtest vcs1: SUCCESS (0.071s)
[734.526802] Starting dynamic subtest: vecs0
[734.588105] Dynamic subtest vecs0: SUCCESS (0.072s)
[734.600542] Starting dynamic subtest: ccs0
[734.660588] Dynamic subtest ccs0: SUCCESS (0.070s)
[734.663034] Subtest basic-await: SUCCESS (0.448s)
[736.210235] [123/133] (286s left) prime_busy (before-wait)
[736.268774] Starting subtest: before-wait
[736.274782] Starting dynamic subtest: rcs0
[736.304270] Dynamic subtest rcs0: SUCCESS (0.032s)
[736.316675] Starting dynamic subtest: bcs0
[736.351085] Dynamic subtest bcs0: SUCCESS (0.046s)
[736.362175] Starting dynamic subtest: vcs0
[736.391490] Dynamic subtest vcs0: SUCCESS (0.040s)
[736.401850] Starting dynamic subtest: vcs1
[736.433117] Dynamic subtest vcs1: SUCCESS (0.041s)
[736.444351] Starting dynamic subtest: vecs0
[736.473732] Dynamic subtest vecs0: SUCCESS (0.040s)
[736.483632] Starting dynamic subtest: ccs0
[736.516245] Dynamic subtest ccs0: SUCCESS (0.042s)
[736.624613] Subtest before-wait: SUCCESS (0.354s)
[736.702977] [124/133] (286s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[736.817315] Starting subtest: short-busy-flip-before-cursor-toggle
[736.822076] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[736.961679] [125/133] (286s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[737.030476] Starting subtest: invalid-multi-wait-unsubmitted
[737.032852] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[737.141039] [126/133] (286s left) gem_mmap_wc (invalid-flags)
[737.196609] Subtest invalid-flags: SKIP (0.000s)
[737.261454] [127/133] (285s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[737.348304] Starting subtest: yf-tiled-64bpp-rotate-270
[737.352647] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[737.435548] [128/133] (285s left) kms_tv_load_detect (load-detect)
[737.484701] Subtest load-detect: SKIP (0.000s)
[737.541143] [129/133] (285s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[737.634766] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[737.639172] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[737.718728] [130/133] (285s left) syncobj_wait (wait-any-complex)
[737.781878] Starting subtest: wait-any-complex
[737.842813] Subtest wait-any-complex: SUCCESS (0.062s)
[737.921586] [131/133] (285s left) sw_sync (sync_expired_merge)
[737.961390] Starting subtest: sync_expired_merge
[739.035620] Subtest sync_expired_merge: SUCCESS (1.074s)
[739.102029] [132/133] (284s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[739.201248] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[739.205597] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[739.311561] [133/133] (284s left) kms_psr (psr-suspend)
[739.398185] Starting subtest: psr-suspend
[739.400503] Starting dynamic subtest: eDP-1
[757.678046] Dynamic subtest eDP-1: SUCCESS (2.937s)
[757.679993] Subtest psr-suspend: SUCCESS (2.938s)
[758.537494] 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.