[91.734751] Initializing watchdogs
[91.734797]   /dev/watchdog0
[91.750249] [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]
[91.754918] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[91.757178] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[91.760553] [001/133] (960s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[91.895784] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[91.898344] Starting dynamic subtest: pipe-A-eDP-1
[91.918068] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[91.927402] Starting dynamic subtest: pipe-B-eDP-1
[91.945742] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[91.952439] Starting dynamic subtest: pipe-C-eDP-1
[91.971113] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[91.977573] Starting dynamic subtest: pipe-D-eDP-1
[91.996268] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[91.998135] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.004s)
[94.059928] [002/133] (958s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[94.122774] Starting subtest: multi-wait-available-unsubmitted-submitted
[94.125115] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[94.230896] [003/133] (958s left) kms_pm_rpm (system-suspend-modeset)
[96.083247] Starting subtest: system-suspend-modeset
[116.269826] Subtest system-suspend-modeset: SUCCESS (4.866s)
[124.672843] [004/133] (935s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[124.792579] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[124.805492] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[124.881784] [005/133] (935s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[124.980299] Starting subtest: addfb25-y-tiled-legacy
[124.982212] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[125.073885] [006/133] (935s left) kms_selftest (drm_damage_helper)
[125.110445] Starting subtest: drm_damage_helper
[125.123620] Starting dynamic subtest: drm_test_damage_iter_no_damage
[125.208498] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.088s)
[125.216028] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[125.298612] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.092s)
[125.308366] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[125.385750] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.088s)
[125.396556] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[125.470834] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.085s)
[125.480402] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[125.554205] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.083s)
[125.562403] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[125.641749] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.090s)
[125.650976] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[125.737870] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.099s)
[125.747068] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[125.823495] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.085s)
[125.830574] Starting dynamic subtest: drm_test_damage_iter_single_damage
[125.903431] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.082s)
[125.912004] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[126.024524] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.122s)
[126.034139] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[126.116674] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.094s)
[126.125967] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[126.198571] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.082s)
[126.207607] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[126.278142] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.081s)
[126.285750] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[126.359553] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.081s)
[126.367918] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[126.437836] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.080s)
[126.446412] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[126.510261] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.072s)
[126.517821] Starting dynamic subtest: drm_test_damage_iter_damage
[126.593366] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.084s)
[126.600919] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[126.681411] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.088s)
[126.691081] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[126.764050] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.084s)
[126.775926] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[126.841743] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.078s)
[126.850670] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[126.918384] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.077s)
[126.920742] Subtest drm_damage_helper: SUCCESS (1.837s)
[127.059173] [007/133] (933s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[127.164387] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[127.167809] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[127.242320] [008/133] (933s left) kms_psr (fbc-pr-primary-mmap-gtt)
[127.331465] Starting subtest: fbc-pr-primary-mmap-gtt
[127.334876] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[127.405749] [009/133] (933s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[127.498601] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[127.501986] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[127.618549] [010/133] (933s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[127.717728] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[128.357255] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.649s)
[128.527565] [011/133] (932s left) gem_exec_whisper (basic-queues-priority)
[128.614039] Starting subtest: basic-queues-priority
[151.489281] Subtest basic-queues-priority: SUCCESS (22.962s)
[151.676690] [012/133] (909s left) kms_plane_scaling (2x-scaler-multi-pipe)
[151.767419] Starting subtest: 2x-scaler-multi-pipe
[151.771963] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[151.870795] [013/133] (908s left) prime_mmap_coherency (read)
[151.925102] Starting subtest: read
[157.352387] Subtest read: SUCCESS (5.375s)
[157.401597] [014/133] (903s left) perf (low-oa-exponent-permissions)
[157.519587] Starting subtest: low-oa-exponent-permissions
[157.558111] Subtest low-oa-exponent-permissions: SUCCESS (0.039s)
[157.605248] [015/133] (903s left) prime_vgem (fence-read-hang)
[157.764199] Subtest fence-read-hang: SKIP (0.000s)
[157.854783] [FACT prime_vgem (fence-read-hang)] new: kernel.kmod_is_loaded.vgem: true
[157.857958] [016/133] (903s left) kms_atomic_transition (modeset-transition-fencing)
[157.943958] Starting subtest: modeset-transition-fencing
[157.945863] Starting dynamic subtest: 1x-outputs
[168.755545] Dynamic subtest 1x-outputs: SUCCESS (10.812s)
[168.757966] Subtest modeset-transition-fencing: SUCCESS (10.813s)
[169.635230] [017/133] (891s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[169.724601] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[169.726954] Starting dynamic subtest: pipe-A-eDP-1
[170.625298] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.893s)
[170.642957] Starting dynamic subtest: pipe-B-eDP-1
[172.178450] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.549s)
[172.188638] Starting dynamic subtest: pipe-C-eDP-1
[173.711334] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.534s)
[173.721257] Starting dynamic subtest: pipe-D-eDP-1
[175.208716] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.496s)
[175.211007] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.476s)
[176.375677] [018/133] (884s left) kms_vrr (lobf)
[176.465572] Starting subtest: lobf
[176.470135] Subtest lobf: SKIP (0.000s)
[176.536188] [019/133] (884s left) gem_exec_reloc (basic-softpin)
[176.602724] Subtest basic-softpin: SKIP (0.000s)
[176.671852] [020/133] (884s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[176.731330] Starting subtest: etime-multi-wait-all-submitted-signaled
[176.839787] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[176.927329] [021/133] (884s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[177.023412] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[184.400171] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.386s)
[184.522544] [022/133] (876s left) gem_ringfill (engines-basic)
[190.314015] Starting subtest: engines-basic
[190.316447] Starting dynamic subtest: rcs0
[190.318452] Dynamic subtest rcs0: SUCCESS (0.052s)
[190.328965] Starting dynamic subtest: bcs0
[190.357267] Dynamic subtest bcs0: SUCCESS (0.043s)
[190.366817] Starting dynamic subtest: vcs0
[190.400520] Dynamic subtest vcs0: SUCCESS (0.042s)
[190.410721] Starting dynamic subtest: vcs1
[190.442613] Dynamic subtest vcs1: SUCCESS (0.041s)
[190.452559] Starting dynamic subtest: vecs0
[190.484677] Dynamic subtest vecs0: SUCCESS (0.041s)
[190.494857] Starting dynamic subtest: ccs0
[190.530554] Dynamic subtest ccs0: SUCCESS (0.045s)
[190.533095] Subtest engines-basic: SUCCESS (0.270s)
[190.622370] [023/133] (870s left) gem_userptr_blits (map-fixed-invalidate)
[190.689527] Starting subtest: map-fixed-invalidate
[190.693596] Subtest map-fixed-invalidate: SKIP (0.000s)
[190.816488] [024/133] (870s left) i915_query (query-garbage)
[190.869942] Starting subtest: query-garbage
[190.872241] Subtest query-garbage: SUCCESS (0.000s)
[190.969517] [025/133] (870s left) kms_cursor_crc (cursor-sliding-512x170)
[191.231739] Starting subtest: cursor-sliding-512x170
[191.236037] Subtest cursor-sliding-512x170: SKIP (0.001s)
[191.393593] [026/133] (869s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[191.450294] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[191.558443] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s)
[191.646938] [027/133] (869s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[191.706556] Starting subtest: mixed-tiled-to-y-tiled-ccs
[191.711246] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[191.889390] [028/133] (869s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[191.979657] Starting subtest: bad-aux-stride-y-tiled-ccs
[191.982042] Starting dynamic subtest: pipe-A-eDP-1
[192.005681] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[192.016314] Starting dynamic subtest: pipe-B-eDP-1
[192.038081] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[192.047262] Starting dynamic subtest: pipe-C-eDP-1
[192.069022] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[192.077926] Starting dynamic subtest: pipe-D-eDP-1
[192.099938] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[192.104301] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.003s)
[194.228171] [029/133] (867s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[194.353619] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[195.455295] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.101s)
[195.570255] [030/133] (865s left) gem_mmap_offset (oob-read)
[195.618077] Starting subtest: oob-read
[195.619836] Subtest oob-read: SUCCESS (0.000s)
[195.711142] [031/133] (865s left) prime_udl
[195.787239] [032/133] (865s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[195.877110] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[199.712826] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.839s)
[200.859325] [033/133] (860s left) gem_eio (in-flight-10ms)
[201.093195] Starting subtest: in-flight-10ms
[210.142383] Subtest in-flight-10ms: SUCCESS (9.052s)
[210.277012] [034/133] (851s left) gem_flink_basic (bad-flink)
[210.336246] Starting subtest: bad-flink
[210.338367] Subtest bad-flink: SUCCESS (0.000s)
[210.438710] [035/133] (851s left) sysfs_timeslice_duration (idempotent)
[210.487912] Starting subtest: idempotent
[210.490309] Starting dynamic subtest: vecs0
[210.492574] Dynamic subtest vecs0: SUCCESS (0.000s)
[210.503860] Starting dynamic subtest: ccs0
[210.505920] Dynamic subtest ccs0: SUCCESS (0.000s)
[210.514942] Starting dynamic subtest: vcs0
[210.517047] Dynamic subtest vcs0: SUCCESS (0.000s)
[210.525939] Starting dynamic subtest: bcs0
[210.528041] Dynamic subtest bcs0: SUCCESS (0.000s)
[210.537510] Starting dynamic subtest: rcs0
[210.539598] Dynamic subtest rcs0: SUCCESS (0.000s)
[210.548880] Starting dynamic subtest: vcs1
[210.550711] Dynamic subtest vcs1: SUCCESS (0.000s)
[210.552505] Subtest idempotent: SUCCESS (0.004s)
[210.603176] [036/133] (851s left) kms_big_fb (y-tiled-addfb-size-overflow)
[210.718018] Starting subtest: y-tiled-addfb-size-overflow
[210.722448] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[210.816833] [037/133] (850s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[210.908820] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[210.912421] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[210.997129] [038/133] (850s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[211.086381] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[211.089849] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[211.185511] [039/133] (850s left) syncobj_timeline (invalid-signal-illegal-handle)
[211.247889] Starting subtest: invalid-signal-illegal-handle
[211.249806] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[211.363052] [040/133] (850s left) perf (gen8-unprivileged-single-ctx-counters)
[211.462739] Starting subtest: gen8-unprivileged-single-ctx-counters
[211.466396] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[211.503330] [041/133] (850s left) gem_mmap_gtt (cpuset-basic-small-copy)
[211.566243] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[211.628928] [042/133] (850s left) gem_exec_endless (dispatch)
[211.694862] Starting subtest: dispatch
[211.696738] Starting dynamic subtest: rcs0
[211.703352] Dynamic subtest rcs0: SUCCESS (0.005s)
[211.713035] Starting dynamic subtest: bcs0
[211.716689] Dynamic subtest bcs0: SUCCESS (0.004s)
[211.725988] Starting dynamic subtest: vcs0
[211.729799] Dynamic subtest vcs0: SUCCESS (0.007s)
[211.738576] Starting dynamic subtest: vcs1
[211.742080] Dynamic subtest vcs1: SUCCESS (0.004s)
[211.750580] Starting dynamic subtest: vecs0
[211.754228] Dynamic subtest vecs0: SUCCESS (0.005s)
[211.762793] Starting dynamic subtest: ccs0
[211.766283] Dynamic subtest ccs0: SUCCESS (0.004s)
[211.768097] Subtest dispatch: SUCCESS (0.033s)
[213.275334] [043/133] (848s left) kms_plane_alpha_blend (alpha-opaque-fb)
[213.368491] Starting subtest: alpha-opaque-fb
[213.649779] Starting dynamic subtest: pipe-A-eDP-1
[214.225608] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.574s)
[214.236176] Starting dynamic subtest: pipe-D-eDP-1
[215.573050] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.346s)
[215.575392] Subtest alpha-opaque-fb: SUCCESS (2.205s)
[216.410177] [044/133] (845s left) gem_exec_schedule (preempt-self)
[216.485593] Starting subtest: preempt-self
[216.487497] Starting dynamic subtest: rcs0
[216.497648] Dynamic subtest rcs0: SUCCESS (0.021s)
[216.507199] Starting dynamic subtest: bcs0
[216.516251] Dynamic subtest bcs0: SUCCESS (0.018s)
[216.525441] Starting dynamic subtest: vcs0
[216.538042] Dynamic subtest vcs0: SUCCESS (0.021s)
[216.547045] Starting dynamic subtest: vcs1
[216.557021] Dynamic subtest vcs1: SUCCESS (0.018s)
[216.568776] Starting dynamic subtest: vecs0
[216.578743] Dynamic subtest vecs0: SUCCESS (0.022s)
[216.587970] Starting dynamic subtest: ccs0
[216.603663] Dynamic subtest ccs0: SUCCESS (0.024s)
[216.605906] Subtest preempt-self: SUCCESS (0.127s)
[218.314604] [045/133] (843s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[218.411945] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[218.414107] Starting dynamic subtest: pipe-A-eDP-1
[218.487186] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[218.498154] Starting dynamic subtest: pipe-B-eDP-1
[219.573816] Dynamic subtest pipe-B-eDP-1: SKIP (1.084s)
[219.578215] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.164s)
[220.758831] [046/133] (841s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[220.830849] Starting subtest: invalid-bsd2-flag-on-vebox
[220.833163] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[220.928204] [047/133] (841s left) sw_sync (sync_multi_consumer)
[220.960427] Starting subtest: sync_multi_consumer
[221.423545] Subtest sync_multi_consumer: SUCCESS (0.464s)
[221.485378] [048/133] (840s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[221.568675] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[221.593974] Starting dynamic subtest: pipe-A-plane-0
[221.883177] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[221.892697] Starting dynamic subtest: pipe-A-plane-3
[222.116530] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[222.125547] Starting dynamic subtest: pipe-A-plane-5
[222.130279] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[223.249490] Starting dynamic subtest: pipe-B-plane-0
[223.536631] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[223.546285] Starting dynamic subtest: pipe-B-plane-3
[223.770360] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[223.779991] Starting dynamic subtest: pipe-B-plane-5
[223.784162] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[224.078194] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.510s)
[224.922450] [049/133] (837s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[225.020512] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[225.024451] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[225.137889] [050/133] (837s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[225.236589] Starting subtest: fbc-rgb565-draw-pwrite
[229.881312] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.645s)
[231.018197] [051/133] (831s left) kms_color (ctm-green-to-red)
[231.120548] Starting subtest: ctm-green-to-red
[231.122712] Starting dynamic subtest: pipe-A-eDP-1
[231.819556] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.698s)
[231.829814] Starting dynamic subtest: pipe-B-eDP-1
[233.185804] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.365s)
[233.195962] Starting dynamic subtest: pipe-C-eDP-1
[234.578715] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.395s)
[234.591028] Starting dynamic subtest: pipe-D-eDP-1
[235.882098] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.302s)
[235.884582] Subtest ctm-green-to-red: SUCCESS (4.762s)
[236.748638] [052/133] (825s left) kms_feature_discovery (display-2x)
[236.832695] Starting subtest: display-2x
[236.837272] Subtest display-2x: SKIP (0.000s)
[236.906610] [053/133] (825s left) kms_psr (psr-sprite-mmap-cpu)
[236.997137] Starting subtest: psr-sprite-mmap-cpu
[236.999538] Starting dynamic subtest: eDP-1
[238.781403] Dynamic subtest eDP-1: SUCCESS (1.784s)
[238.783836] Subtest psr-sprite-mmap-cpu: SUCCESS (1.785s)
[239.625700] [054/133] (822s left) kms_joiner (invalid-modeset-big-joiner)
[239.715161] Starting subtest: invalid-modeset-big-joiner
[239.719717] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[239.787471] [055/133] (822s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[239.885611] Starting subtest: plane-all-modeset-transition-internal-panels
[239.887855] Starting dynamic subtest: pipe-A-eDP-1
[241.251241] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.364s)
[241.539161] Starting dynamic subtest: pipe-B-eDP-1
[242.583675] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.054s)
[242.850023] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.965s)
[243.702832] [056/133] (818s left) prime_vgem (basic-read)
[243.764385] Starting subtest: basic-read
[243.771648] Subtest basic-read: SKIP (0.008s)
[243.886167] [057/133] (818s left) gem_ccs (ctrl-surf-copy-new-ctx)
[243.938460] Starting subtest: ctrl-surf-copy-new-ctx
[243.942679] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[244.036298] [058/133] (818s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[244.127307] Starting subtest: plane-downscale-factor-0-75-with-rotation
[244.129617] Starting dynamic subtest: pipe-A
[244.368726] Dynamic subtest pipe-A: SUCCESS (0.243s)
[244.378658] Starting dynamic subtest: pipe-B
[245.719567] Dynamic subtest pipe-B: SUCCESS (1.350s)
[245.731560] Starting dynamic subtest: pipe-C
[247.028042] Dynamic subtest pipe-C: SUCCESS (1.308s)
[247.039070] Starting dynamic subtest: pipe-D
[248.381662] Dynamic subtest pipe-D: SUCCESS (1.353s)
[248.383886] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.257s)
[249.537190] [059/133] (813s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[249.629242] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[256.364984] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.736s)
[256.477579] [060/133] (806s left) kms_cursor_crc (cursor-onscreen-512x512)
[256.767137] Starting subtest: cursor-onscreen-512x512
[256.771928] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[256.923236] [061/133] (805s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[257.011961] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[257.015955] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[257.083767] [062/133] (805s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[257.180944] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[264.051478] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.873s)
[264.177708] [063/133] (798s left) gem_exec_whisper (basic-fds)
[264.239164] Starting subtest: basic-fds
[271.040268] Subtest basic-fds: SUCCESS (6.801s)
[271.231112] [064/133] (791s left) kms_vblank (query-idle-hang)
[271.323284] Starting subtest: query-idle-hang
[271.325486] Starting dynamic subtest: pipe-A-eDP-1
[298.033591] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.715s)
[298.047838] Starting dynamic subtest: pipe-D-eDP-1
[313.021606] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.989s)
[313.023743] Subtest query-idle-hang: SUCCESS (41.708s)
[313.885287] [065/133] (749s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[313.988798] Starting subtest: fbcpsr-rgb101010-draw-blt
[320.699285] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.715s)
[320.816654] [066/133] (742s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[320.915054] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[322.027754] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.112s)
[322.166934] [067/133] (740s left) gem_ctx_persistence (hang)
[322.224762] Starting subtest: hang
[322.228633] Subtest hang: SKIP (0.000s)
[322.331791] [068/133] (740s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[322.425518] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[322.428843] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[322.518229] [069/133] (740s left) gem_exec_params (rel-constants-invalid)
[322.564557] Starting subtest: rel-constants-invalid
[322.566611] Subtest rel-constants-invalid: SUCCESS (0.000s)
[322.661801] [070/133] (740s left) gem_userptr_blits (usage-restrictions)
[322.725173] Starting subtest: usage-restrictions
[322.727106] Subtest usage-restrictions: SUCCESS (0.000s)
[322.846059] [071/133] (740s left) perf_pmu (rc6-all-gts)
[322.884807] Starting subtest: rc6-all-gts
[329.300898] Subtest rc6-all-gts: SUCCESS (6.363s)
[330.117056] [072/133] (733s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[330.226301] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[330.228561] Starting dynamic subtest: pipe-A
[330.563223] Dynamic subtest pipe-A: SUCCESS (0.339s)
[330.574776] Starting dynamic subtest: pipe-B
[331.954150] Dynamic subtest pipe-B: SUCCESS (1.390s)
[331.967411] Starting dynamic subtest: pipe-C
[333.385478] Dynamic subtest pipe-C: SUCCESS (1.429s)
[333.395255] Starting dynamic subtest: pipe-D
[334.820730] Dynamic subtest pipe-D: SUCCESS (1.435s)
[334.823034] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.598s)
[336.024075] [073/133] (727s left) gem_exec_schedule (noreorder-priority)
[336.203122] Starting subtest: noreorder-priority
[336.205709] Starting dynamic subtest: rcs0
[337.339979] Dynamic subtest rcs0: SUCCESS (1.136s)
[337.354526] Starting dynamic subtest: vcs0
[339.246473] Dynamic subtest vcs0: SUCCESS (1.904s)
[339.259779] Starting dynamic subtest: vcs1
[341.210106] Dynamic subtest vcs1: SUCCESS (1.961s)
[341.223711] Starting dynamic subtest: vecs0
[343.222083] Dynamic subtest vecs0: SUCCESS (2.010s)
[343.235381] Starting dynamic subtest: ccs0
[344.370766] Dynamic subtest ccs0: SUCCESS (1.148s)
[344.373714] Subtest noreorder-priority: SUCCESS (8.171s)
[344.575634] [074/133] (718s left) i915_pm_rpm (reg-read-ioctl)
[346.403216] Starting subtest: reg-read-ioctl
[348.711040] Subtest reg-read-ioctl: SUCCESS (2.309s)
[349.121514] [075/133] (714s left) syncobj_timeline (signal-point-0)
[349.172898] Starting subtest: signal-point-0
[349.175186] Subtest signal-point-0: SUCCESS (0.000s)
[349.269751] [076/133] (714s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[349.391086] Starting subtest: basic-flip-after-cursor-atomic
[350.313404] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.920s)
[351.126977] [077/133] (712s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[351.180138] Starting subtest: single-wait-for-submit-unsubmitted
[351.286280] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[351.377346] [078/133] (712s left) kms_chamelium_hpd (common-hpd-after-suspend)
[351.752198] Subtest common-hpd-after-suspend: SKIP (0.000s)
[352.537075] [079/133] (711s left) kms_setmode (invalid-clone-single-crtc-stealing)
[352.596839] Starting subtest: invalid-clone-single-crtc-stealing
[352.603059] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[352.695083] [080/133] (710s left) kms_cursor_crc (cursor-random-256x256)
[352.937310] Starting subtest: cursor-random-256x256
[352.939546] Starting dynamic subtest: pipe-A-eDP-1
[356.268797] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.329s)
[356.299572] Starting dynamic subtest: pipe-D-eDP-1
[360.288928] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.995s)
[360.291434] Subtest cursor-random-256x256: SUCCESS (7.350s)
[361.121496] [081/133] (702s left) gem_eio (in-flight-suspend)
[361.351947] Starting subtest: in-flight-suspend
[405.548690] Subtest in-flight-suspend: SUCCESS (14.526s)
[411.712223] [082/133] (658s left) prime_mmap (test_dup)
[411.777777] Starting subtest: test_dup
[411.779994] Starting dynamic subtest: test_dup-smem
[411.807296] Dynamic subtest test_dup-smem: SUCCESS (0.032s)
[411.809680] Subtest test_dup: SUCCESS (0.033s)
[411.887006] [083/133] (657s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[411.985443] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[413.032416] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.060s)
[413.171865] [084/133] (656s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[413.260155] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[413.263916] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[413.330790] [085/133] (656s left) i915_drm_fdinfo (busy-check-all)
[413.372278] Starting subtest: busy-check-all
[413.374059] Starting dynamic subtest: rcs0
[413.377707] Dynamic subtest rcs0: SKIP (0.003s)
[413.388503] Starting dynamic subtest: bcs0
[413.391876] Dynamic subtest bcs0: SKIP (0.000s)
[413.401494] Starting dynamic subtest: vcs0
[413.404692] Dynamic subtest vcs0: SKIP (0.000s)
[413.413852] Starting dynamic subtest: vcs1
[413.417248] Dynamic subtest vcs1: SKIP (0.000s)
[413.426635] Starting dynamic subtest: vecs0
[413.430138] Dynamic subtest vecs0: SKIP (0.000s)
[413.439834] Starting dynamic subtest: ccs0
[413.443348] Dynamic subtest ccs0: SKIP (0.000s)
[413.446886] Subtest busy-check-all: SKIP (0.009s)
[413.484264] [086/133] (656s left) dmabuf_sync_file (export-wait-after-attach)
[413.533367] Starting subtest: export-wait-after-attach
[413.535037] Subtest export-wait-after-attach: SUCCESS (0.001s)
[413.592828] [087/133] (656s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[413.721463] Starting subtest: fbcpsr-tiling-4
[420.704575] Subtest fbcpsr-tiling-4: SUCCESS (7.040s)
[420.831246] [088/133] (649s left) gem_exec_fence (syncobj-timeline-signal)
[421.372559] Starting subtest: syncobj-timeline-signal
[421.378686] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[422.966222] [089/133] (647s left) kms_atomic_interruptible (universal-setplane-primary)
[423.069626] Starting subtest: universal-setplane-primary
[423.071957] Starting dynamic subtest: pipe-A-eDP-1
[430.443846] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.394s)
[430.446260] Subtest universal-setplane-primary: SUCCESS (7.395s)
[431.263931] [090/133] (638s left) gem_ctx_shared (disjoint-timelines)
[431.321562] Starting subtest: disjoint-timelines
[431.340734] Subtest disjoint-timelines: SUCCESS (0.019s)
[431.566986] [091/133] (638s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[431.656449] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[431.658616] Starting dynamic subtest: pipe-A-default-mode
[432.831606] Dynamic subtest pipe-A-default-mode: SKIP (1.176s)
[432.836112] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.177s)
[432.992159] [092/133] (637s left) sriov_basic (bind-unbind-vf)
[433.048356] Starting subtest: bind-unbind-vf
[433.050753] Starting dynamic subtest: vf-1
[433.125576] Dynamic subtest vf-1: FAIL (0.013s)
[433.137919] Starting dynamic subtest: vf-2
[433.210712] Dynamic subtest vf-2: FAIL (0.004s)
[433.222508] Starting dynamic subtest: vf-3
[433.294034] Dynamic subtest vf-3: FAIL (0.003s)
[433.304628] Starting dynamic subtest: vf-4
[433.375877] Dynamic subtest vf-4: FAIL (0.004s)
[433.387167] Starting dynamic subtest: vf-5
[433.458724] Dynamic subtest vf-5: FAIL (0.004s)
[433.469729] Starting dynamic subtest: vf-6
[433.541929] Dynamic subtest vf-6: FAIL (0.004s)
[433.552834] Starting dynamic subtest: vf-7
[433.624648] Dynamic subtest vf-7: FAIL (0.003s)
[433.635719] Starting dynamic subtest: vf-random
[433.708519] Dynamic subtest vf-random: FAIL (0.004s)
[433.719769] Starting dynamic subtest: vf-last
[433.779919] Dynamic subtest vf-last: FAIL (0.513s)
[433.781619] Subtest bind-unbind-vf: FAIL (0.559s)
[433.820501] [093/133] (636s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[433.927227] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[433.931046] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[433.991022] [094/133] (636s left) i915_suspend (fence-restore-untiled)
[434.042886] Starting subtest: fence-restore-untiled
[434.046191] Subtest fence-restore-untiled: SKIP (0.000s)
[434.161266] [095/133] (636s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[434.262642] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[434.266236] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[434.358742] [096/133] (635s left) kms_psr (fbc-psr2-dpms)
[434.453797] Starting subtest: fbc-psr2-dpms
[434.455746] Starting dynamic subtest: eDP-1
[434.459250] Dynamic subtest eDP-1: SKIP (0.000s)
[434.462925] Subtest fbc-psr2-dpms: SKIP (0.001s)
[434.526683] [097/133] (635s left) kms_lease (lease-unleased-crtc)
[434.613984] Starting subtest: lease-unleased-crtc
[434.615854] Starting dynamic subtest: pipe-A-eDP-1
[434.902522] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[434.913121] Starting dynamic subtest: pipe-B-eDP-1
[435.642090] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.740s)
[435.654848] Starting dynamic subtest: pipe-C-eDP-1
[435.657085] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[435.667083] Starting dynamic subtest: pipe-D-eDP-1
[435.669290] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s)
[435.671480] Subtest lease-unleased-crtc: SUCCESS (1.045s)
[436.024156] [098/133] (634s left) kms_chamelium_frames (hdmi-crc-single)
[436.418553] Subtest hdmi-crc-single: SKIP (0.000s)
[437.232307] [099/133] (633s left) gem_mmap_wc (write-read)
[437.284018] Subtest write-read: SKIP (0.000s)
[437.339700] [100/133] (633s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[437.426244] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[437.428487] Starting dynamic subtest: pipe-A-eDP-1
[438.345668] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.914s)
[438.357690] Starting dynamic subtest: pipe-B-eDP-1
[439.929231] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.580s)
[439.939295] Starting dynamic subtest: pipe-C-eDP-1
[441.483532] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.556s)
[441.494266] Starting dynamic subtest: pipe-D-eDP-1
[443.018329] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.536s)
[443.020216] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.591s)
[444.176858] [101/133] (626s left) gem_mmap_offset (pf-nonblock)
[444.232550] Starting subtest: pf-nonblock
[444.237270] Subtest pf-nonblock: SUCCESS (0.006s)
[444.350134] [102/133] (626s left) kms_pm_dc (dc6-dpms)
[445.452436] Starting subtest: dc6-dpms
[447.543860] Subtest dc6-dpms: SUCCESS (2.091s)
[447.629161] [103/133] (622s left) kms_atomic_transition (plane-toggle-modeset-transition)
[447.723835] Starting subtest: plane-toggle-modeset-transition
[447.726173] Starting dynamic subtest: pipe-A-eDP-1
[460.471933] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.741s)
[460.483952] Starting dynamic subtest: pipe-B-eDP-1
[472.914387] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.444s)
[472.917155] Subtest plane-toggle-modeset-transition: SUCCESS (25.192s)
[473.749412] [104/133] (596s left) kms_flip (plain-flip-interruptible)
[473.849264] Starting subtest: plain-flip-interruptible
[473.851589] Starting dynamic subtest: A-eDP1
[475.549084] Dynamic subtest A-eDP1: SUCCESS (1.700s)
[475.561149] Starting dynamic subtest: B-eDP1
[477.178712] Dynamic subtest B-eDP1: SUCCESS (1.628s)
[477.200575] Starting dynamic subtest: C-eDP1
[478.813688] Dynamic subtest C-eDP1: SUCCESS (1.633s)
[478.827924] Starting dynamic subtest: D-eDP1
[480.449846] Dynamic subtest D-eDP1: SUCCESS (1.633s)
[480.455181] Subtest plain-flip-interruptible: SUCCESS (6.609s)
[481.617314] [105/133] (589s left) kms_frontbuffer_tracking (basic)
[481.717241] Starting subtest: basic
[484.959458] Subtest basic: SUCCESS (3.247s)
[485.066245] [106/133] (585s left) kms_content_protection (atomic)
[485.206030] Starting subtest: atomic
[485.210003] Subtest atomic: SKIP (0.000s)
[485.328301] [107/133] (585s left) kms_psr (pr-cursor-plane-onoff)
[485.423124] Starting subtest: pr-cursor-plane-onoff
[485.426829] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[485.494803] [108/133] (585s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[485.592697] Starting subtest: random-ccs-data-y-tiled-ccs
[485.594620] Starting dynamic subtest: pipe-A-eDP-1
[485.614446] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[485.627896] Starting dynamic subtest: pipe-B-eDP-1
[485.646901] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[485.655779] Starting dynamic subtest: pipe-C-eDP-1
[485.675005] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[485.684098] Starting dynamic subtest: pipe-D-eDP-1
[485.703517] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[485.707109] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.005s)
[487.874511] [109/133] (582s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[487.971402] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[487.975769] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[488.070685] [110/133] (582s left) gem_softpin (evict-prime)
[488.128057] Starting subtest: evict-prime
[488.130412] Starting dynamic subtest: rcs0
[489.294305] Dynamic subtest rcs0: SUCCESS (1.166s)
[489.307284] Starting dynamic subtest: bcs0
[490.420105] Dynamic subtest bcs0: SUCCESS (1.124s)
[490.431976] Starting dynamic subtest: vcs0
[491.868145] Dynamic subtest vcs0: SUCCESS (1.445s)
[491.881430] Starting dynamic subtest: vcs1
[493.850051] Dynamic subtest vcs1: SUCCESS (1.980s)
[493.862649] Starting dynamic subtest: vecs0
[495.837422] Dynamic subtest vecs0: SUCCESS (1.985s)
[495.850454] Starting dynamic subtest: ccs0
[496.964325] Dynamic subtest ccs0: SUCCESS (1.127s)
[496.981724] Starting dynamic subtest: all
[498.903649] Dynamic subtest all: SUCCESS (1.937s)
[498.906170] Subtest evict-prime: SUCCESS (10.779s)
[498.988092] [111/133] (571s left) gen9_exec_parse (bb-start-param)
[499.056155] Subtest bb-start-param: SKIP (0.000s)
[499.137718] [112/133] (571s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[499.231410] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[499.235483] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[499.328495] [113/133] (571s left) kms_atomic_interruptible (legacy-pageflip)
[499.430960] Starting subtest: legacy-pageflip
[499.433194] Starting dynamic subtest: pipe-A-eDP-1
[506.910898] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.483s)
[506.913306] Subtest legacy-pageflip: SUCCESS (7.484s)
[507.735900] [114/133] (563s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[507.832535] Starting subtest: fbc-dirtyfb-ioctl
[507.834705] Starting dynamic subtest: A-eDP-1
[510.395559] Dynamic subtest A-eDP-1: SUCCESS (2.560s)
[510.397474] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.561s)
[511.197934] [115/133] (559s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[511.291893] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[511.296182] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[511.386210] [116/133] (559s left) kms_psr (psr2-no-drrs)
[511.477279] Starting subtest: psr2-no-drrs
[511.479410] Starting dynamic subtest: eDP-1
[513.063757] Dynamic subtest eDP-1: SUCCESS (1.586s)
[513.065948] Subtest psr2-no-drrs: SUCCESS (1.587s)
[513.863284] [117/133] (557s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[514.446277] Starting subtest: syncobj-backward-timeline-chain-engines
[514.566134] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.124s)
[516.029531] [118/133] (555s left) i915_hangman (gt-error-state-capture)
[516.083658] Starting subtest: gt-error-state-capture
[516.085942] Starting dynamic subtest: rcs0
[526.903786] Dynamic subtest rcs0: SUCCESS (10.814s)
[526.917073] Starting dynamic subtest: bcs0
[538.872023] Dynamic subtest bcs0: SUCCESS (11.964s)
[538.885111] Starting dynamic subtest: vcs0
[549.815768] Dynamic subtest vcs0: SUCCESS (10.940s)
[549.829007] Starting dynamic subtest: vcs1
[560.938387] Dynamic subtest vcs1: SUCCESS (11.069s)
[560.950316] Starting dynamic subtest: vecs0
[570.871093] Dynamic subtest vecs0: SUCCESS (9.983s)
[570.884374] Starting dynamic subtest: ccs0
[582.903271] Dynamic subtest ccs0: SUCCESS (12.031s)
[582.905945] Subtest gt-error-state-capture: SUCCESS (66.818s)
[582.986181] [119/133] (488s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[583.109452] Starting subtest: cursorB-vs-flipA-atomic-transitions
[583.113759] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[583.256787] [120/133] (488s left) gem_exec_balancer (nohangcheck)
[583.508907] Starting subtest: nohangcheck
[584.434794] Subtest nohangcheck: SUCCESS (0.924s)
[584.566985] [121/133] (486s left) gem_watchdog (default-virtual)
[584.636940] Starting subtest: default-virtual
[590.910684] Subtest default-virtual: SUCCESS (6.285s)
[590.996574] [122/133] (480s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[591.116478] Starting subtest: plane-all-transition-nonblocking-fencing
[591.118797] Starting dynamic subtest: pipe-A-eDP-1
[593.634561] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.517s)
[593.955927] Starting dynamic subtest: pipe-B-eDP-1
[597.189077] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.246s)
[597.485009] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.370s)
[598.322273] [123/133] (473s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[598.419259] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[598.423223] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[598.518168] [124/133] (472s left) api_intel_bb (purge-bb)
[598.584926] Starting subtest: purge-bb
[598.590743] Subtest purge-bb: SUCCESS (0.004s)
[598.715357] [125/133] (472s left) vgem_basic (second-client)
[598.766902] Starting subtest: second-client
[598.788811] Subtest second-client: SUCCESS (0.022s)
[598.849551] [126/133] (472s left) gem_mmap_gtt (basic)
[598.908546] Subtest basic: SKIP (0.000s)
[598.972378] [127/133] (472s left) kms_busy (extended-pageflip-hang-oldfb)
[599.081541] Starting subtest: extended-pageflip-hang-oldfb
[599.083853] Starting dynamic subtest: pipe-A
[599.492531] Dynamic subtest pipe-A: SUCCESS (0.411s)
[599.502913] Starting dynamic subtest: pipe-D
[600.629087] Dynamic subtest pipe-D: SUCCESS (1.133s)
[600.631723] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.549s)
[601.492124] [128/133] (470s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[601.584461] Starting subtest: fbc-psr2-sprite-mmap-gtt
[601.586655] Starting dynamic subtest: eDP-1
[601.590627] Dynamic subtest eDP-1: SKIP (0.000s)
[601.594577] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[601.664332] [129/133] (470s left) kms_addfb_basic (tile-pitch-mismatch)
[601.725889] Starting subtest: tile-pitch-mismatch
[601.729891] Subtest tile-pitch-mismatch: SKIP (0.000s)
[601.884758] [130/133] (469s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[601.973370] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[601.977497] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[602.045774] [131/133] (469s left) gem_ctx_param (non-root-set)
[602.105733] Starting subtest: non-root-set
[602.133031] Subtest non-root-set: SUCCESS (0.028s)
[602.227492] [132/133] (469s left) gem_ctx_param (invalid-get-ringsize)
[602.286378] Starting subtest: invalid-get-ringsize
[602.288715] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[602.399879] [133/133] (469s left) gem_ctx_engines (none)
[602.449367] Starting subtest: none
[602.451372] Subtest none: SUCCESS (0.001s)
[602.632078] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: kms_pm_rpm
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: kms_addfb_basic
results: parsing output: 5/ for test: kms_selftest
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: gem_exec_whisper
results: parsing output: 11/ for test: kms_plane_scaling
results: parsing output: 12/ for test: prime_mmap_coherency
results: parsing output: 13/ for test: perf
results: parsing output: 14/ for test: prime_vgem
results: parsing output: 15/ for test: kms_atomic_transition
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_vrr
results: parsing output: 18/ for test: gem_exec_reloc
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_ringfill
results: parsing output: 22/ for test: gem_userptr_blits
results: parsing output: 23/ for test: i915_query
results: parsing output: 24/ for test: kms_cursor_crc
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: gem_render_copy
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: gem_mmap_offset
results: parsing output: 30/ for test: prime_udl
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_eio
results: parsing output: 33/ for test: gem_flink_basic
results: parsing output: 34/ for test: sysfs_timeslice_duration
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: perf
results: parsing output: 40/ for test: gem_mmap_gtt
results: parsing output: 41/ for test: gem_exec_endless
results: parsing output: 42/ for test: kms_plane_alpha_blend
results: parsing output: 43/ for test: gem_exec_schedule
results: parsing output: 44/ for test: kms_psr2_sf
results: parsing output: 45/ for test: gem_exec_params
results: parsing output: 46/ for test: sw_sync
results: parsing output: 47/ for test: kms_plane
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_color
results: parsing output: 51/ for test: kms_feature_discovery
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_joiner
results: parsing output: 54/ for test: kms_atomic_transition
results: parsing output: 55/ for test: prime_vgem
results: parsing output: 56/ for test: gem_ccs
results: parsing output: 57/ for test: kms_plane_scaling
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_cursor_crc
results: parsing output: 60/ for test: kms_plane
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_exec_whisper
results: parsing output: 63/ for test: kms_vblank
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: gem_ctx_persistence
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_exec_params
results: parsing output: 69/ for test: gem_userptr_blits
results: parsing output: 70/ for test: perf_pmu
results: parsing output: 71/ for test: kms_plane_scaling
results: parsing output: 72/ for test: gem_exec_schedule
results: parsing output: 73/ for test: i915_pm_rpm
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: syncobj_wait
results: parsing output: 77/ for test: kms_chamelium_hpd
results: parsing output: 78/ for test: kms_setmode
results: parsing output: 79/ for test: kms_cursor_crc
results: parsing output: 80/ for test: gem_eio
results: parsing output: 81/ for test: prime_mmap
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_flip_scaled_crc
results: parsing output: 84/ for test: i915_drm_fdinfo
results: parsing output: 85/ for test: dmabuf_sync_file
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: kms_atomic_interruptible
results: parsing output: 89/ for test: gem_ctx_shared
results: parsing output: 90/ for test: kms_flip_scaled_crc
results: parsing output: 91/ for test: sriov_basic
results: parsing output: 92/ for test: kms_psr2_sf
results: parsing output: 93/ for test: i915_suspend
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_lease
results: parsing output: 97/ for test: kms_chamelium_frames
results: parsing output: 98/ for test: gem_mmap_wc
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: gem_mmap_offset
results: parsing output: 101/ for test: kms_pm_dc
results: parsing output: 102/ for test: kms_atomic_transition
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_content_protection
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_softpin
results: parsing output: 110/ for test: gen9_exec_parse
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_atomic_interruptible
results: parsing output: 113/ for test: kms_dirtyfb
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: gem_exec_fence
results: parsing output: 117/ for test: i915_hangman
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: gem_exec_balancer
results: parsing output: 120/ for test: gem_watchdog
results: parsing output: 121/ for test: kms_atomic_transition
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: api_intel_bb
results: parsing output: 124/ for test: vgem_basic
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: kms_busy
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_addfb_basic
results: parsing output: 129/ for test: kms_flip_scaled_crc
results: parsing output: 130/ for test: gem_ctx_param
results: parsing output: 131/ for test: gem_ctx_param
results: parsing output: 132/ for test: gem_ctx_engines
Done.