[56.056944] Initializing watchdogs
[56.056991]   /dev/watchdog0
[56.071675] [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]
[56.076142] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.078477] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.081977] [001/155] (960s left) kms_plane (pixel-format-yf-tiled-modifier)
[56.209833] Starting subtest: pixel-format-yf-tiled-modifier
[56.214070] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[56.279402] [002/155] (960s left) gem_exec_schedule (preempt-queue-contexts-chain)
[56.359235] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[56.648701] [003/155] (960s left) gem_mmap_gtt (bad-object)
[56.708282] Subtest bad-object: SKIP (0.000s)
[56.769841] [004/155] (959s left) kms_getfb (getfb-handle-not-fb)
[56.858084] Starting subtest: getfb-handle-not-fb
[56.860333] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[56.956357] [005/155] (959s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[57.011500] Starting subtest: y-tiled-ccs-to-yf-tiled
[57.016256] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[57.203612] [006/155] (959s left) i915_pm_rpm (debugfs-read)
[62.051309] Starting subtest: debugfs-read
[63.209070] Subtest debugfs-read: SUCCESS (1.158s)
[63.592342] [007/155] (953s left) prime_vgem (fence-wait)
[63.686661] Starting subtest: fence-wait
[63.688657] Starting dynamic subtest: rcs0
[64.729110] Dynamic subtest rcs0: SUCCESS (1.041s)
[64.739647] Starting dynamic subtest: bcs0
[65.776471] Dynamic subtest bcs0: SUCCESS (1.046s)
[65.787039] Starting dynamic subtest: vcs0
[66.825356] Dynamic subtest vcs0: SUCCESS (1.048s)
[66.835876] Starting dynamic subtest: vcs1
[67.869275] Dynamic subtest vcs1: SUCCESS (1.042s)
[67.879505] Starting dynamic subtest: vecs0
[68.910386] Dynamic subtest vecs0: SUCCESS (1.040s)
[68.921104] Starting dynamic subtest: ccs0
[69.956958] Dynamic subtest ccs0: SUCCESS (1.044s)
[69.959375] Subtest fence-wait: SUCCESS (6.269s)
[70.072104] [FACT prime_vgem (fence-wait)] new: kernel.kmod_is_loaded.vgem: true
[70.075446] [008/155] (946s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[70.187666] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[70.192250] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[70.290759] [009/155] (946s left) kms_cursor_crc (cursor-random-max-size)
[70.597993] Starting subtest: cursor-random-max-size
[70.604725] Subtest cursor-random-max-size: SKIP (0.000s)
[70.721612] [010/155] (946s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[70.783281] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[70.892251] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.108s)
[70.984548] [011/155] (945s left) gem_wait (wait)
[71.045227] Starting subtest: wait
[71.047642] Starting dynamic subtest: all-engines
[72.318927] Dynamic subtest all-engines: SUCCESS (1.272s)
[72.328274] Starting dynamic subtest: rcs0
[73.387925] Dynamic subtest rcs0: SUCCESS (1.069s)
[73.398765] Starting dynamic subtest: bcs0
[74.435929] Dynamic subtest bcs0: SUCCESS (1.046s)
[74.446579] Starting dynamic subtest: vcs0
[75.480239] Dynamic subtest vcs0: SUCCESS (1.044s)
[75.490897] Starting dynamic subtest: vcs1
[76.523724] Dynamic subtest vcs1: SUCCESS (1.042s)
[76.533309] Starting dynamic subtest: vecs0
[77.569297] Dynamic subtest vecs0: SUCCESS (1.045s)
[77.578891] Starting dynamic subtest: ccs0
[78.616758] Dynamic subtest ccs0: SUCCESS (1.046s)
[78.619765] Subtest wait: SUCCESS (7.571s)
[78.826497] [012/155] (938s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[78.927982] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[78.933072] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[80.120403] [013/155] (936s left) gem_softpin (overlap)
[80.181367] Starting subtest: overlap
[81.100633] Subtest overlap: SUCCESS (0.917s)
[81.228226] [014/155] (935s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[81.315604] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[81.317998] Starting dynamic subtest: pipe-A
[81.544279] Dynamic subtest pipe-A: SUCCESS (0.230s)
[81.553546] Starting dynamic subtest: pipe-B
[82.911091] Dynamic subtest pipe-B: SUCCESS (1.367s)
[82.920822] Starting dynamic subtest: pipe-C
[84.237498] Dynamic subtest pipe-C: SUCCESS (1.326s)
[84.246084] Starting dynamic subtest: pipe-D
[85.588170] Dynamic subtest pipe-D: SUCCESS (1.351s)
[85.590559] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.275s)
[86.764106] [015/155] (930s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[86.865606] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[86.869992] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[86.973187] [016/155] (930s left) kms_joiner (basic-big-joiner)
[87.087995] Starting subtest: basic-big-joiner
[87.092465] Subtest basic-big-joiner: SKIP (0.000s)
[87.153366] [017/155] (930s left) i915_drm_fdinfo (idle)
[87.190732] Starting subtest: idle
[87.193124] Starting dynamic subtest: rcs0
[87.737939] Dynamic subtest rcs0: SUCCESS (0.547s)
[87.748985] Starting dynamic subtest: bcs0
[88.244494] Dynamic subtest bcs0: SUCCESS (0.504s)
[88.255717] Starting dynamic subtest: vcs0
[88.749376] Dynamic subtest vcs0: SUCCESS (0.504s)
[88.760812] Starting dynamic subtest: vcs1
[89.254256] Dynamic subtest vcs1: SUCCESS (0.504s)
[89.265658] Starting dynamic subtest: vecs0
[89.759571] Dynamic subtest vecs0: SUCCESS (0.504s)
[89.770861] Starting dynamic subtest: ccs0
[90.264044] Dynamic subtest ccs0: SUCCESS (0.503s)
[90.266895] Subtest idle: SUCCESS (3.073s)
[90.354289] [018/155] (926s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[90.469016] Starting subtest: psr-rgb101010-draw-mmap-gtt
[90.473534] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[90.571117] [019/155] (926s left) kms_psr (fbc-psr-suspend)
[90.666894] Starting subtest: fbc-psr-suspend
[90.668939] Starting dynamic subtest: eDP-1
[90.673277] Dynamic subtest eDP-1: SKIP (0.000s)
[90.677605] Subtest fbc-psr-suspend: SKIP (0.000s)
[90.737359] [020/155] (926s left) gen9_exec_parse (cmd-crossing-page)
[90.793205] Subtest cmd-crossing-page: SKIP (0.000s)
[90.866015] [021/155] (926s left) gem_mmap_wc (bad-offset)
[90.926228] Subtest bad-offset: SKIP (0.000s)
[90.991672] [022/155] (926s left) gem_ctx_bad_destroy (invalid-ctx)
[91.037678] Starting subtest: invalid-ctx
[91.040021] Subtest invalid-ctx: SUCCESS (0.000s)
[91.101894] [023/155] (926s left) vgem_basic (unload)
[91.132896] Starting subtest: unload
[120.193812] Subtest unload: SUCCESS (29.059s)
[120.301496] [024/155] (897s left) gem_ctx_param (invalid-set-ringsize)
[120.360089] Starting subtest: invalid-set-ringsize
[120.362544] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[120.432718] [025/155] (897s left) kms_frontbuffer_tracking (hdr-rgb565-draw-pwrite)
[120.544623] Starting subtest: hdr-rgb565-draw-pwrite
[120.548784] Subtest hdr-rgb565-draw-pwrite: SKIP (0.000s)
[120.647713] [026/155] (896s left) kms_prop_blob (basic)
[120.698029] Starting subtest: basic
[120.700225] Subtest basic: SUCCESS (0.000s)
[120.816966] [027/155] (896s left) kms_psr (psr2-primary-mmap-cpu)
[120.914793] Starting subtest: psr2-primary-mmap-cpu
[120.917153] Starting dynamic subtest: eDP-1
[122.652915] Dynamic subtest eDP-1: SUCCESS (1.739s)
[122.655280] Subtest psr2-primary-mmap-cpu: SUCCESS (1.740s)
[123.529718] [028/155] (894s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[123.622968] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[123.627191] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[123.730912] [029/155] (893s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[123.819714] Starting subtest: plane-all-transition-nonblocking-fencing
[123.822101] Starting dynamic subtest: pipe-A-eDP-1
[126.314501] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s)
[126.619806] Starting dynamic subtest: pipe-B-eDP-1
[129.858775] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.247s)
[130.161930] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.343s)
[130.977972] [030/155] (886s left) gem_exec_balancer (bonded-dual)
[131.052472] Starting subtest: bonded-dual
[131.057182] Subtest bonded-dual: SKIP (0.000s)
[131.375042] [031/155] (886s left) kms_pm_rpm (dpms-lpsp)
[133.510038] Starting subtest: dpms-lpsp
[133.827355] Subtest dpms-lpsp: SUCCESS (0.321s)
[133.926692] [032/155] (883s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[134.009941] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[134.014483] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[134.083465] [033/155] (883s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[134.177677] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[134.179821] Starting dynamic subtest: pipe-A-eDP-1
[134.253402] Dynamic subtest pipe-A-eDP-1: SKIP (0.079s)
[134.262612] Starting dynamic subtest: pipe-B-eDP-1
[135.361806] Dynamic subtest pipe-B-eDP-1: SKIP (1.107s)
[135.366286] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.188s)
[136.543156] [034/155] (881s left) gem_exec_nop (basic-sequential)
[136.616796] Starting subtest: basic-sequential
[153.286055] Subtest basic-sequential: SUCCESS (16.675s)
[153.529020] [035/155] (864s left) perf_pmu (invalid-init)
[153.566806] Starting subtest: invalid-init
[153.569075] Subtest invalid-init: SUCCESS (0.000s)
[153.676051] [036/155] (864s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[153.781665] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[153.785967] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[153.894282] [037/155] (864s left) kms_cursor_crc (cursor-suspend)
[154.035215] Starting subtest: cursor-suspend
[154.037257] Starting dynamic subtest: pipe-A-eDP-1
[186.709402] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.313s)
[186.719554] Starting dynamic subtest: pipe-D-eDP-1
[220.678799] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.708s)
[220.681079] Subtest cursor-suspend: SUCCESS (7.024s)
[221.528936] [038/155] (796s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[221.624293] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[221.626600] Starting dynamic subtest: pipe-A-eDP-1
[221.650026] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[221.661299] Starting dynamic subtest: pipe-B-eDP-1
[221.682965] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[221.692671] Starting dynamic subtest: pipe-C-eDP-1
[221.715328] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[221.726162] Starting dynamic subtest: pipe-D-eDP-1
[221.748572] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[221.752694] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[223.862702] [039/155] (794s left) kms_psr (fbc-psr2-primary-render)
[223.958295] Starting subtest: fbc-psr2-primary-render
[223.960634] Starting dynamic subtest: eDP-1
[223.965521] Dynamic subtest eDP-1: SKIP (0.000s)
[223.969656] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[224.039934] [040/155] (794s left) vgem_basic (mmap)
[224.084655] Starting subtest: mmap
[224.092831] Subtest mmap: SUCCESS (0.010s)
[224.153911] [041/155] (794s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[224.254344] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[225.378651] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.124s)
[225.503114] [042/155] (792s left) gem_close (basic)
[225.561363] Starting subtest: basic
[225.563426] Subtest basic: SUCCESS (0.000s)
[225.676475] [043/155] (792s left) gem_create (create-size-update)
[225.724035] Starting subtest: create-size-update
[225.725897] Subtest create-size-update: SUCCESS (0.000s)
[225.958353] [044/155] (792s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-blt)
[226.066865] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-blt
[226.070729] Subtest hdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[226.193565] [045/155] (792s left) kms_hdr (bpc-switch)
[226.281774] Starting subtest: bpc-switch
[226.284091] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[230.835641] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (4.554s)
[230.846949] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[235.411210] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (4.572s)
[235.413653] Subtest bpc-switch: SUCCESS (9.129s)
[235.523383] [046/155] (782s left) syncobj_wait (wait-for-submit-complex)
[235.583087] Starting subtest: wait-for-submit-complex
[235.643508] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[235.719726] [047/155] (782s left) gem_userptr_blits (dmabuf-unsync)
[235.785796] Subtest dmabuf-unsync: SKIP (0.000s)
[235.890930] [048/155] (782s left) gem_softpin (allocator-basic-reserve)
[235.940165] Starting subtest: allocator-basic-reserve
[236.017963] Subtest allocator-basic-reserve: SUCCESS (0.076s)
[236.149042] [049/155] (782s left) kms_chamelium_color (ctm-0-25)
[236.250346] Subtest ctm-0-25: SKIP (0.000s)
[236.296189] [050/155] (782s left) kms_chamelium_hpd (dp-hpd-storm)
[236.692117] Subtest dp-hpd-storm: SKIP (0.000s)
[237.485970] [051/155] (781s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-msflip-blt)
[237.594780] Starting subtest: fbchdr-1p-primscrn-indfb-msflip-blt
[237.598875] Subtest fbchdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[237.701200] [052/155] (780s left) gem_pxp (verify-pxp-stale-buf-execution)
[237.818437] Starting subtest: verify-pxp-stale-buf-execution
[238.886923] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.067s)
[239.018668] [053/155] (779s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[239.082541] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[239.084898] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[239.190954] [054/155] (779s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-pwrite)
[239.285839] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-pwrite
[239.290437] Subtest hdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[239.369521] [055/155] (779s left) api_intel_allocator (gem-pool)
[239.421361] Starting subtest: gem-pool
[239.426614] Subtest gem-pool: SUCCESS (0.008s)
[239.565528] [056/155] (779s left) gem_workarounds (suspend-resume)
[239.628057] Starting subtest: suspend-resume
[256.187246] Subtest suspend-resume: SUCCESS (1.157s)
[256.324316] [057/155] (762s left) kms_lease (setcrtc-implicit-plane)
[256.415577] Starting subtest: setcrtc-implicit-plane
[256.418342] Starting dynamic subtest: pipe-A-eDP-1
[256.902089] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.487s)
[256.913422] Starting dynamic subtest: pipe-B-eDP-1
[258.026094] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.121s)
[258.037600] Starting dynamic subtest: pipe-C-eDP-1
[259.150944] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.122s)
[259.161801] Starting dynamic subtest: pipe-D-eDP-1
[260.283873] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[260.286490] Subtest setcrtc-implicit-plane: SUCCESS (3.870s)
[261.127225] [058/155] (757s left) kms_color (legacy-gamma)
[261.218968] Starting subtest: legacy-gamma
[261.221314] Starting dynamic subtest: pipe-A-eDP-1
[261.962826] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.745s)
[261.975461] Starting dynamic subtest: pipe-B-eDP-1
[263.381445] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.416s)
[263.391560] Starting dynamic subtest: pipe-C-eDP-1
[264.744021] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.360s)
[264.754093] Starting dynamic subtest: pipe-D-eDP-1
[266.080978] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s)
[266.083897] Subtest legacy-gamma: SUCCESS (4.860s)
[266.898286] [059/155] (752s left) kms_flip (absolute-wf_vblank)
[266.992635] Starting subtest: absolute-wf_vblank
[266.995109] Starting dynamic subtest: A-eDP1
[275.769739] Dynamic subtest A-eDP1: SUCCESS (8.774s)
[275.783589] Starting dynamic subtest: B-eDP1
[284.502096] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[284.512143] Starting dynamic subtest: C-eDP1
[293.231840] Dynamic subtest C-eDP1: SUCCESS (8.727s)
[293.242132] Starting dynamic subtest: D-eDP1
[301.958936] Dynamic subtest D-eDP1: SUCCESS (8.724s)
[301.965687] Subtest absolute-wf_vblank: SUCCESS (34.963s)
[303.175038] [060/155] (715s left) kms_chamelium_frames (hdmi-crc-single)
[303.586170] Subtest hdmi-crc-single: SKIP (0.000s)
[304.399093] [061/155] (714s left) kms_sequence (get-forked-busy)
[304.498892] Starting subtest: get-forked-busy
[304.501899] Starting dynamic subtest: pipe-A-eDP-1
[306.451707] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.948s)
[306.462892] Starting dynamic subtest: pipe-B-eDP-1
[309.020707] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.570s)
[309.031486] Starting dynamic subtest: pipe-C-eDP-1
[311.625998] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.602s)
[311.636176] Starting dynamic subtest: pipe-D-eDP-1
[314.263365] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.637s)
[314.265992] Subtest get-forked-busy: SUCCESS (9.763s)
[315.147220] [062/155] (703s left) perf_pmu (semaphore-busy)
[315.192740] Starting subtest: semaphore-busy
[315.195064] Starting dynamic subtest: rcs0
[316.821984] Dynamic subtest rcs0: SUCCESS (1.625s)
[316.834432] Starting dynamic subtest: bcs0
[318.456795] Dynamic subtest bcs0: SUCCESS (1.631s)
[318.468284] Starting dynamic subtest: vcs0
[319.096100] Dynamic subtest vcs0: FAIL (0.568s)
[319.107705] Starting dynamic subtest: vcs1
[320.930561] Dynamic subtest vcs1: FAIL (1.820s)
[320.942111] Starting dynamic subtest: vecs0
[322.909007] Dynamic subtest vecs0: FAIL (1.980s)
[322.920646] Starting dynamic subtest: ccs0
[324.893388] Dynamic subtest ccs0: FAIL (1.985s)
[324.895796] Subtest semaphore-busy: FAIL (9.619s)
[324.938957] [063/155] (694s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-render)
[325.056500] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-render
[325.061478] Subtest hdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[325.146064] [064/155] (694s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[325.236171] Starting subtest: 2x-plain-flip-ts-check-interruptible
[325.248349] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[325.344886] [065/155] (693s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-plflip-blt)
[325.453790] Starting subtest: psrhdr-1p-primscrn-shrfb-plflip-blt
[325.458496] Subtest psrhdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[325.542018] [066/155] (693s left) gem_mmap_gtt (basic-small-copy-odd)
[325.595087] Subtest basic-small-copy-odd: SKIP (0.000s)
[325.653390] [067/155] (693s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[325.755162] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[325.760386] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[325.857442] [068/155] (693s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[325.950132] Starting subtest: y-tiled-addfb-size-offset-overflow
[325.954898] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[326.062890] [069/155] (693s left) gem_render_copy_redux (flink-interruptible)
[326.116963] Starting subtest: flink-interruptible
[326.888839] Subtest flink-interruptible: SUCCESS (0.774s)
[327.006607] [070/155] (692s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[327.100341] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[327.102555] Starting dynamic subtest: pipe-A-default-mode
[328.302377] Dynamic subtest pipe-A-default-mode: SKIP (1.201s)
[328.307383] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.202s)
[328.440526] [071/155] (691s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[328.538128] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[328.543734] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[328.643578] [072/155] (690s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[328.731836] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[328.734497] Starting dynamic subtest: pipe-A-eDP-1
[328.759951] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[328.771911] Starting dynamic subtest: pipe-B-eDP-1
[328.797236] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[328.807103] Starting dynamic subtest: pipe-C-eDP-1
[328.832829] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[328.842705] Starting dynamic subtest: pipe-D-eDP-1
[328.869105] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[328.874400] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[331.048323] [073/155] (688s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[331.156980] Starting subtest: fbc-modesetfrombusy
[335.019917] Subtest fbc-modesetfrombusy: SUCCESS (3.869s)
[336.207298] [074/155] (683s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[336.317881] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[336.323875] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[336.429642] [075/155] (683s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-msflip-blt)
[336.529047] Starting subtest: hdr-1p-primscrn-shrfb-msflip-blt
[336.534476] Subtest hdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[336.640471] [076/155] (683s left) kms_frontbuffer_tracking (fbchdr-tiling-linear)
[336.739894] Starting subtest: fbchdr-tiling-linear
[336.745657] Subtest fbchdr-tiling-linear: SKIP (0.000s)
[336.837206] [077/155] (682s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[336.926826] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[336.929611] Starting dynamic subtest: pipe-A-eDP-1
[336.953592] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[336.965248] Starting dynamic subtest: pipe-B-eDP-1
[336.990655] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[337.001126] Starting dynamic subtest: pipe-C-eDP-1
[337.027920] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[337.038091] Starting dynamic subtest: pipe-D-eDP-1
[337.069781] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[337.074794] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[339.243089] [078/155] (680s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[339.347728] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[339.352356] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[339.445345] [079/155] (680s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-onoff)
[339.543944] Starting subtest: hdr-2p-scndscrn-cur-indfb-onoff
[339.548858] Subtest hdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[339.637865] [080/155] (680s left) kms_cursor_legacy (single-move)
[339.761906] Starting subtest: single-move
[339.764707] Starting dynamic subtest: pipe-A
[345.143085] Dynamic subtest pipe-A: SUCCESS (5.379s)
[345.155107] Starting dynamic subtest: pipe-B
[350.526074] Dynamic subtest pipe-B: SUCCESS (5.379s)
[350.537810] Starting dynamic subtest: pipe-C
[355.909777] Dynamic subtest pipe-C: SUCCESS (5.379s)
[355.921599] Starting dynamic subtest: pipe-D
[361.292630] Dynamic subtest pipe-D: SUCCESS (5.380s)
[361.305014] Starting dynamic subtest: all-pipes
[366.681481] Dynamic subtest all-pipes: SUCCESS (5.387s)
[366.684119] Subtest single-move: SUCCESS (26.918s)
[366.828525] [081/155] (653s left) gem_mmap_gtt (zero-extend)
[366.881911] Subtest zero-extend: SKIP (0.000s)
[366.947118] [082/155] (653s left) syncobj_timeline (multi-wait-available-submitted)
[367.001945] Starting subtest: multi-wait-available-submitted
[367.004943] Subtest multi-wait-available-submitted: SUCCESS (0.001s)
[367.091407] [083/155] (652s left) dumb_buffer (create-clear)
[367.145001] Starting subtest: create-clear
[401.257447] Subtest create-clear: SUCCESS (34.110s)
[401.364538] [084/155] (618s left) perf_pmu (busy-idle-no-semaphores)
[401.403759] Starting subtest: busy-idle-no-semaphores
[401.406696] Starting dynamic subtest: rcs0
[402.050256] Dynamic subtest rcs0: SUCCESS (0.647s)
[402.064387] Starting dynamic subtest: bcs0
[402.704316] Dynamic subtest bcs0: SUCCESS (0.653s)
[402.717466] Starting dynamic subtest: vcs0
[403.359455] Dynamic subtest vcs0: SUCCESS (0.653s)
[403.373289] Starting dynamic subtest: vcs1
[404.914585] Dynamic subtest vcs1: SUCCESS (1.553s)
[404.928143] Starting dynamic subtest: vecs0
[406.904644] Dynamic subtest vecs0: SUCCESS (1.987s)
[406.918839] Starting dynamic subtest: ccs0
[408.946530] Dynamic subtest ccs0: SUCCESS (2.040s)
[408.949710] Subtest busy-idle-no-semaphores: SUCCESS (7.545s)
[409.067516] [085/155] (611s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-pwrite)
[409.175632] Starting subtest: psrhdr-rgb101010-draw-pwrite
[409.180717] Subtest psrhdr-rgb101010-draw-pwrite: SKIP (0.000s)
[409.275049] [086/155] (610s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[409.334874] Starting subtest: wait-all-for-submit-delayed-submit
[409.435888] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[409.530374] [087/155] (610s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[409.629761] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[414.108271] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.485s)
[415.347946] [088/155] (604s left) gem_request_retire (retire-vma-not-inactive)
[415.401674] Starting subtest: retire-vma-not-inactive
[415.464034] Subtest retire-vma-not-inactive: SUCCESS (0.060s)
[415.590088] [089/155] (604s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[415.703759] Starting subtest: 2x-cursor-vs-flip-atomic
[415.708828] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[415.848870] [090/155] (604s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[415.941600] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[415.944008] Starting dynamic subtest: pipe-A
[416.005620] Dynamic subtest pipe-A: SUCCESS (0.066s)
[416.016955] Starting dynamic subtest: pipe-B
[417.163986] Dynamic subtest pipe-B: SUCCESS (1.157s)
[417.176011] Starting dynamic subtest: pipe-C
[418.269728] Dynamic subtest pipe-C: SUCCESS (1.104s)
[418.280020] Starting dynamic subtest: pipe-D
[419.421848] Dynamic subtest pipe-D: SUCCESS (1.151s)
[419.424461] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.482s)
[420.572408] [091/155] (599s left) kms_psr2_su (page_flip-xrgb8888)
[420.635988] Subtest page_flip-XRGB8888: SKIP (0.000s)
[420.703763] [092/155] (599s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[420.806399] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[428.154759] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.354s)
[428.293440] [093/155] (592s left) syncobj_wait (multi-wait-submitted-signaled)
[428.350944] Starting subtest: multi-wait-submitted-signaled
[428.353574] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[428.450800] [094/155] (592s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[428.558720] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[428.563534] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[428.650164] [095/155] (591s left) gem_exec_schedule (implicit-boths)
[428.725956] Starting subtest: implicit-boths
[428.728635] Starting dynamic subtest: rcs0
[428.818563] Dynamic subtest rcs0: SUCCESS (0.106s)
[428.832478] Starting dynamic subtest: vcs0
[428.905425] Dynamic subtest vcs0: SUCCESS (0.086s)
[428.918000] Starting dynamic subtest: vcs1
[428.991395] Dynamic subtest vcs1: SUCCESS (0.085s)
[429.004118] Starting dynamic subtest: vecs0
[429.072120] Dynamic subtest vecs0: SUCCESS (0.080s)
[429.086188] Starting dynamic subtest: ccs0
[429.161780] Dynamic subtest ccs0: SUCCESS (0.089s)
[429.164541] Subtest implicit-boths: SUCCESS (0.451s)
[430.380819] [096/155] (590s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[430.482852] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[430.488075] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[430.590744] [097/155] (590s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt)
[430.693430] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt
[430.698517] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[430.781742] [098/155] (589s left) kms_scaling_modes (scaling-mode-full-aspect)
[430.874829] Starting subtest: scaling-mode-full-aspect
[430.877505] Starting dynamic subtest: pipe-A-eDP-1
[430.985684] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.113s)
[431.000738] Starting dynamic subtest: pipe-B-eDP-1
[432.202782] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.215s)
[432.215132] Starting dynamic subtest: pipe-C-eDP-1
[433.419665] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.216s)
[433.430245] Starting dynamic subtest: pipe-D-eDP-1
[434.547917] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[434.550690] Subtest scaling-mode-full-aspect: SUCCESS (3.676s)
[435.713700] [099/155] (585s left) gem_mmap (short-mmap)
[435.772508] Subtest short-mmap: SKIP (0.000s)
[435.839859] [100/155] (584s left) kms_force_connector_basic (force-edid)
[435.920882] Starting subtest: force-edid
[436.288997] Subtest force-edid: SUCCESS (0.370s)
[436.427908] [101/155] (584s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-render)
[436.530019] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-render
[436.535268] Subtest fbchdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[436.612193] [102/155] (584s left) kms_plane_multiple (2x-tiling-yf)
[436.708479] Starting subtest: 2x-tiling-yf
[436.712878] Subtest 2x-tiling-yf: SKIP (0.000s)
[436.788659] [103/155] (584s left) kms_atomic_interruptible (legacy-cursor)
[436.884124] Starting subtest: legacy-cursor
[436.886572] Starting dynamic subtest: pipe-A-eDP-1
[444.320010] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.434s)
[444.322951] Subtest legacy-cursor: SUCCESS (7.436s)
[445.140817] [104/155] (575s left) gem_lmem_swapping (heavy-multi)
[445.187741] Subtest heavy-multi: SKIP (0.000s)
[445.235626] [105/155] (575s left) kms_big_fb (linear-32bpp-rotate-0)
[445.330711] Starting subtest: linear-32bpp-rotate-0
[446.866027] Subtest linear-32bpp-rotate-0: SUCCESS (1.534s)
[446.987244] [106/155] (574s left) perf_pmu (all-busy-check-all)
[447.024973] Starting subtest: all-busy-check-all
[448.331617] Subtest all-busy-check-all: SUCCESS (1.306s)
[448.426873] [107/155] (572s left) gem_exec_fence (syncobj-invalid-flags)
[448.876045] Starting subtest: syncobj-invalid-flags
[448.878995] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[450.391587] [108/155] (570s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[450.496417] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[450.501827] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[450.593374] [109/155] (570s left) kms_flip (bo-too-big-interruptible)
[450.692936] Starting subtest: bo-too-big-interruptible
[450.695103] Starting dynamic subtest: A-eDP1
[451.964041] Dynamic subtest A-eDP1: SUCCESS (1.271s)
[451.980829] Starting dynamic subtest: B-eDP1
[453.256595] Dynamic subtest B-eDP1: SUCCESS (1.291s)
[453.269239] Starting dynamic subtest: C-eDP1
[454.564078] Dynamic subtest C-eDP1: SUCCESS (1.304s)
[454.576985] Starting dynamic subtest: D-eDP1
[455.865124] Dynamic subtest D-eDP1: SUCCESS (1.302s)
[455.867856] Subtest bo-too-big-interruptible: SUCCESS (5.176s)
[457.034814] [110/155] (564s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[457.142695] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[457.147849] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[457.245678] [111/155] (564s left) drm_read (empty-nonblock)
[457.389022] Starting subtest: empty-nonblock
[457.391783] Subtest empty-nonblock: SUCCESS (0.000s)
[457.530931] [112/155] (563s left) kms_cursor_crc (cursor-offscreen-max-size)
[457.835230] Starting subtest: cursor-offscreen-max-size
[457.843700] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[457.953393] [113/155] (563s left) core_getclient (basic)
[458.006482] Starting subtest: basic
[458.008491] Subtest basic: SUCCESS (0.000s)
[458.118119] [114/155] (563s left) kms_vblank (ts-continuation-dpms-rpm)
[458.205966] Starting subtest: ts-continuation-dpms-rpm
[458.208559] Starting dynamic subtest: pipe-A-eDP-1
[460.702986] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s)
[460.720925] Starting dynamic subtest: pipe-D-eDP-1
[462.883070] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.179s)
[462.886093] Subtest ts-continuation-dpms-rpm: SUCCESS (4.680s)
[463.734104] [115/155] (557s left) gem_close_race (basic-process)
[463.797860] Starting subtest: basic-process
[463.838927] Subtest basic-process: SUCCESS (0.041s)
[464.038965] [116/155] (557s left) gem_exec_schedule (u-submit-early-slice)
[464.126124] Starting subtest: u-submit-early-slice
[464.128423] Starting dynamic subtest: rcs0
[464.161446] Dynamic subtest rcs0: SUCCESS (0.043s)
[464.174794] Starting dynamic subtest: bcs0
[464.199896] Dynamic subtest bcs0: SUCCESS (0.038s)
[464.211172] Starting dynamic subtest: vcs0
[464.242222] Dynamic subtest vcs0: SUCCESS (0.041s)
[464.255841] Starting dynamic subtest: vcs1
[464.286221] Dynamic subtest vcs1: SUCCESS (0.043s)
[464.298833] Starting dynamic subtest: vecs0
[464.329098] Dynamic subtest vecs0: SUCCESS (0.041s)
[464.342960] Starting dynamic subtest: ccs0
[464.364217] Dynamic subtest ccs0: SUCCESS (0.035s)
[464.366741] Subtest u-submit-early-slice: SUCCESS (0.247s)
[465.377753] [117/155] (556s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[465.477633] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[465.482736] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[465.559455] [118/155] (556s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[465.662773] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[469.930256] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.274s)
[471.155407] [119/155] (550s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[471.265298] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[471.270820] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[471.360756] [120/155] (550s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[471.466096] Starting subtest: yf-tiled-8bpp-rotate-0
[471.471547] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[471.574203] [121/155] (550s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen)
[471.680437] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen
[471.684985] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[471.797420] [122/155] (549s left) i915_query (engine-info-invalid)
[471.846931] Starting subtest: engine-info-invalid
[471.849281] Subtest engine-info-invalid: SUCCESS (0.000s)
[471.931593] [123/155] (549s left) kms_content_protection (content-type-change)
[472.072347] Starting subtest: content-type-change
[472.077130] Subtest content-type-change: SKIP (0.000s)
[472.187720] [124/155] (549s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[472.283475] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[472.287913] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[472.376530] [125/155] (549s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-pwrite)
[472.481795] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-pwrite
[472.485333] Subtest fbchdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[472.562587] [126/155] (549s left) kms_atomic (crtc-invalid-params-fence)
[472.656630] Starting subtest: crtc-invalid-params-fence
[472.658819] Starting dynamic subtest: pipe-A-eDP-1
[473.082981] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.423s)
[473.085990] Subtest crtc-invalid-params-fence: SUCCESS (0.425s)
[473.937604] [127/155] (548s left) kms_addfb_basic (unused-handle)
[473.984643] Starting subtest: unused-handle
[473.986806] Subtest unused-handle: SUCCESS (0.000s)
[474.133787] [128/155] (547s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[474.191941] Starting subtest: saturated-hostile-nopreempt
[474.194729] Starting dynamic subtest: rcs0
[474.247235] Dynamic subtest rcs0: SKIP (0.055s)
[474.258845] Starting dynamic subtest: bcs0
[474.267627] Dynamic subtest bcs0: SKIP (0.016s)
[474.283784] Starting dynamic subtest: vcs0
[474.289006] Dynamic subtest vcs0: SKIP (0.012s)
[474.299910] Starting dynamic subtest: vcs1
[474.304747] Dynamic subtest vcs1: SKIP (0.017s)
[474.315774] Starting dynamic subtest: vecs0
[474.320538] Dynamic subtest vecs0: SKIP (0.012s)
[474.330994] Starting dynamic subtest: ccs0
[474.335866] Dynamic subtest ccs0: SKIP (0.010s)
[474.340585] Subtest saturated-hostile-nopreempt: SKIP (0.128s)
[474.394921] [129/155] (547s left) kms_dsc (dsc-with-bpc)
[474.493628] Starting subtest: dsc-with-bpc
[474.526807] Subtest dsc-with-bpc: SKIP (0.001s)
[474.578361] [130/155] (547s left) gem_exec_fence (basic-wait)
[474.749084] Starting subtest: basic-wait
[474.751998] Starting dynamic subtest: rcs0
[474.831322] Dynamic subtest rcs0: SUCCESS (0.085s)
[474.845670] Starting dynamic subtest: bcs0
[474.887088] Dynamic subtest bcs0: SUCCESS (0.053s)
[474.899993] Starting dynamic subtest: vcs0
[474.950386] Dynamic subtest vcs0: SUCCESS (0.061s)
[474.963093] Starting dynamic subtest: vcs1
[475.008404] Dynamic subtest vcs1: SUCCESS (0.057s)
[475.020666] Starting dynamic subtest: vecs0
[475.068011] Dynamic subtest vecs0: SUCCESS (0.059s)
[475.079386] Starting dynamic subtest: ccs0
[475.133143] Dynamic subtest ccs0: SUCCESS (0.062s)
[475.136118] Subtest basic-wait: SUCCESS (0.389s)
[477.420921] [131/155] (544s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[477.524613] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[478.582825] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.057s)
[478.707529] [132/155] (543s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[478.811030] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[478.815785] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[478.905293] [133/155] (543s left) gem_ctx_param (set-priority-range)
[478.961658] Starting subtest: set-priority-range
[478.975967] Subtest set-priority-range: SUCCESS (0.015s)
[479.075864] [134/155] (543s left) syncobj_timeline (etime-multi-wait-all-submitted)
[479.140357] Starting subtest: etime-multi-wait-all-submitted
[479.246419] Subtest etime-multi-wait-all-submitted: SUCCESS (0.105s)
[479.331918] [135/155] (543s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[479.432996] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc
[479.438128] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[479.529669] [136/155] (542s left) gem_exec_schedule (wide)
[479.709726] Starting subtest: wide
[479.712356] Starting dynamic subtest: rcs0
[490.999187] Dynamic subtest rcs0: SUCCESS (11.286s)
[491.013860] Starting dynamic subtest: vcs0
[502.498336] Dynamic subtest vcs0: SUCCESS (11.500s)
[502.509968] Starting dynamic subtest: vcs1
[513.089950] Dynamic subtest vcs1: SUCCESS (10.590s)
[513.103106] Starting dynamic subtest: vecs0
[524.127046] Dynamic subtest vecs0: SUCCESS (11.037s)
[524.141211] Starting dynamic subtest: ccs0
[540.094724] Dynamic subtest ccs0: SUCCESS (15.965s)
[540.097687] Subtest wide: SUCCESS (60.385s)
[542.245817] [137/155] (480s left) kms_async_flips (async-flip-hang)
[542.338524] Starting subtest: async-flip-hang
[542.724781] Starting dynamic subtest: pipe-A-eDP-1
[557.803922] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.079s)
[558.185111] Starting dynamic subtest: pipe-B-eDP-1
[573.800764] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.621s)
[574.185643] Starting dynamic subtest: pipe-C-eDP-1
[589.796092] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.617s)
[590.180987] Starting dynamic subtest: pipe-D-eDP-1
[605.801719] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.623s)
[605.804489] Subtest async-flip-hang: SUCCESS (63.457s)
[607.024122] [138/155] (415s left) kms_plane_alpha_blend (coverage-7efc)
[607.123421] Starting subtest: coverage-7efc
[607.424286] Starting dynamic subtest: pipe-A-eDP-1
[608.005044] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.578s)
[608.032728] Starting dynamic subtest: pipe-D-eDP-1
[609.319009] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.294s)
[609.322084] Subtest coverage-7efc: SUCCESS (2.199s)
[610.116235] [139/155] (412s left) i915_hangman (gt-engine-error)
[610.175350] Starting subtest: gt-engine-error
[610.177627] Starting dynamic subtest: rcs0
[611.304645] Dynamic subtest rcs0: SUCCESS (1.130s)
[611.317834] Starting dynamic subtest: bcs0
[613.289472] Dynamic subtest bcs0: SUCCESS (1.981s)
[613.303563] Starting dynamic subtest: vcs0
[615.272734] Dynamic subtest vcs0: SUCCESS (1.980s)
[615.286096] Starting dynamic subtest: vcs1
[617.255487] Dynamic subtest vcs1: SUCCESS (1.980s)
[617.271472] Starting dynamic subtest: vecs0
[619.240786] Dynamic subtest vecs0: SUCCESS (1.982s)
[619.260963] Starting dynamic subtest: ccs0
[621.288486] Dynamic subtest ccs0: SUCCESS (2.045s)
[621.291517] Subtest gt-engine-error: SUCCESS (11.115s)
[621.373417] [140/155] (401s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[621.424096] Starting subtest: multi-wait-available-unsubmitted-signaled
[621.427150] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[621.512898] [141/155] (401s left) gem_busy (semaphore)
[621.706618] Subtest semaphore: SKIP (0.000s)
[621.938097] [142/155] (400s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[622.041835] Starting subtest: 4-tiled-64bpp-rotate-90
[622.060918] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[622.202188] [143/155] (400s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[622.328453] Starting subtest: cursorA-vs-flipA-atomic
[633.493111] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.163s)
[634.327710] [144/155] (388s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[634.430874] Starting subtest: extended-modeset-hang-newfb-with-reset
[634.433425] Starting dynamic subtest: pipe-A
[648.854850] Dynamic subtest pipe-A: SUCCESS (14.423s)
[648.866910] Starting dynamic subtest: pipe-D
[664.477732] Dynamic subtest pipe-D: SUCCESS (15.617s)
[664.479727] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (30.044s)
[665.339240] [145/155] (357s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[665.425064] Starting subtest: primary-x-tiled-reflect-x-0
[672.936454] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.511s)
[674.127028] [146/155] (348s left) sysfs_timeslice_duration (invalid)
[674.187891] Starting subtest: invalid
[674.190588] Starting dynamic subtest: vecs0
[674.193127] Dynamic subtest vecs0: SUCCESS (0.000s)
[674.205130] Starting dynamic subtest: ccs0
[674.207952] Dynamic subtest ccs0: SUCCESS (0.000s)
[674.219044] Starting dynamic subtest: vcs0
[674.222025] Dynamic subtest vcs0: SUCCESS (0.000s)
[674.233001] Starting dynamic subtest: bcs0
[674.235948] Dynamic subtest bcs0: SUCCESS (0.000s)
[674.247273] Starting dynamic subtest: rcs0
[674.250276] Dynamic subtest rcs0: SUCCESS (0.000s)
[674.262107] Starting dynamic subtest: vcs1
[674.265087] Dynamic subtest vcs1: SUCCESS (0.000s)
[674.267944] Subtest invalid: SUCCESS (0.006s)
[674.310725] [147/155] (348s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[674.436805] Starting subtest: cursorB-vs-flipA-atomic
[674.442101] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[674.594925] [148/155] (348s left) kms_psr (pr-dpms)
[674.686407] Starting subtest: pr-dpms
[674.691617] Subtest pr-dpms: SKIP (0.000s)
[674.778736] [149/155] (348s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[674.885691] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[674.890751] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[674.954875] [150/155] (348s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-pwrite)
[675.053120] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-pwrite
[675.058390] Subtest psrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[675.175212] [151/155] (347s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-move)
[675.276925] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-move
[675.281421] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[675.370514] [152/155] (347s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt)
[675.467248] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt
[675.471825] Subtest fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[675.578762] [153/155] (347s left) gem_exec_params (secure-non-master)
[675.632116] Starting subtest: secure-non-master
[675.636851] Subtest secure-non-master: SKIP (0.000s)
[675.730330] [154/155] (347s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[675.830836] Starting subtest: psr-farfromfence-mmap-gtt
[675.834992] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[675.928901] [155/155] (347s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[676.025453] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[676.029880] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[676.116529] Closing watchdogs
results: parsing output: 0/ for test: kms_plane
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: kms_getfb
results: parsing output: 4/ for test: gem_render_copy
results: parsing output: 5/ for test: i915_pm_rpm
results: parsing output: 6/ for test: prime_vgem
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_cursor_crc
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: gem_wait
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: gem_softpin
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_joiner
results: parsing output: 16/ for test: i915_drm_fdinfo
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: gen9_exec_parse
results: parsing output: 20/ for test: gem_mmap_wc
results: parsing output: 21/ for test: gem_ctx_bad_destroy
results: parsing output: 22/ for test: vgem_basic
results: parsing output: 23/ for test: gem_ctx_param
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_prop_blob
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_atomic_transition
results: parsing output: 29/ for test: gem_exec_balancer
results: parsing output: 30/ for test: kms_pm_rpm
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: kms_psr2_sf
results: parsing output: 33/ for test: gem_exec_nop
results: parsing output: 34/ for test: perf_pmu
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_cursor_crc
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: vgem_basic
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: gem_close
results: parsing output: 42/ for test: gem_create
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_hdr
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: gem_userptr_blits
results: parsing output: 47/ for test: gem_softpin
results: parsing output: 48/ for test: kms_chamelium_color
results: parsing output: 49/ for test: kms_chamelium_hpd
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_pxp
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: api_intel_allocator
results: parsing output: 55/ for test: gem_workarounds
results: parsing output: 56/ for test: kms_lease
results: parsing output: 57/ for test: kms_color
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_chamelium_frames
results: parsing output: 60/ for test: kms_sequence
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_mmap_gtt
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_render_copy_redux
results: parsing output: 69/ for test: kms_flip_scaled_crc
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_ccs
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_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: gem_mmap_gtt
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: dumb_buffer
results: parsing output: 83/ for test: perf_pmu
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_request_retire
results: parsing output: 88/ for test: kms_cursor_legacy
results: parsing output: 89/ for test: kms_plane_scaling
results: parsing output: 90/ for test: kms_psr2_su
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_exec_schedule
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_scaling_modes
results: parsing output: 98/ for test: gem_mmap
results: parsing output: 99/ for test: kms_force_connector_basic
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_plane_multiple
results: parsing output: 102/ for test: kms_atomic_interruptible
results: parsing output: 103/ for test: gem_lmem_swapping
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: perf_pmu
results: parsing output: 106/ for test: gem_exec_fence
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: drm_read
results: parsing output: 111/ for test: kms_cursor_crc
results: parsing output: 112/ for test: core_getclient
results: parsing output: 113/ for test: kms_vblank
results: parsing output: 114/ for test: gem_close_race
results: parsing output: 115/ for test: gem_exec_schedule
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: i915_query
results: parsing output: 122/ for test: kms_content_protection
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_atomic
results: parsing output: 126/ for test: kms_addfb_basic
results: parsing output: 127/ for test: gem_ctx_persistence
results: parsing output: 128/ for test: kms_dsc
results: parsing output: 129/ for test: gem_exec_fence
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_ctx_param
results: parsing output: 133/ for test: syncobj_timeline
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: gem_exec_schedule
results: parsing output: 136/ for test: kms_async_flips
results: parsing output: 137/ for test: kms_plane_alpha_blend
results: parsing output: 138/ for test: i915_hangman
results: parsing output: 139/ for test: syncobj_timeline
results: parsing output: 140/ for test: gem_busy
results: parsing output: 141/ for test: kms_big_fb
results: parsing output: 142/ for test: kms_cursor_legacy
results: parsing output: 143/ for test: kms_busy
results: parsing output: 144/ for test: kms_rotation_crc
results: parsing output: 145/ for test: sysfs_timeslice_duration
results: parsing output: 146/ for test: kms_cursor_legacy
results: parsing output: 147/ for test: kms_psr
results: parsing output: 148/ for test: kms_psr2_sf
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: gem_exec_params
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.