[58.593544] Initializing watchdogs
[58.593591]   /dev/watchdog0
[58.607276] [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]
[58.611779] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.614176] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.617636] [001/133] (960s left) gem_eio (throttle)
[58.786938] Starting subtest: throttle
[58.966501] Subtest throttle: SUCCESS (0.181s)
[59.094901] [002/133] (960s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[59.183593] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[59.188058] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[59.247281] [003/133] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[59.348864] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[63.062407] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.733s)
[64.195028] [004/133] (955s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[64.249543] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[64.309897] [005/133] (954s left) gem_mmap_wc (pf-nonblock)
[64.368997] Subtest pf-nonblock: SKIP (0.000s)
[64.426088] [006/133] (954s left) gem_wait (await)
[64.495771] Starting subtest: await
[64.498166] Starting dynamic subtest: all-engines
[65.636640] Dynamic subtest all-engines: SUCCESS (1.145s)
[65.651808] Starting dynamic subtest: rcs0
[66.691466] Dynamic subtest rcs0: SUCCESS (1.056s)
[66.705754] Starting dynamic subtest: bcs0
[67.892051] Dynamic subtest bcs0: SUCCESS (1.200s)
[67.907059] Starting dynamic subtest: vcs0
[68.945575] Dynamic subtest vcs0: SUCCESS (1.055s)
[68.961573] Starting dynamic subtest: vcs1
[69.999458] Dynamic subtest vcs1: SUCCESS (1.054s)
[70.012950] Starting dynamic subtest: vecs0
[71.050688] Dynamic subtest vecs0: SUCCESS (1.051s)
[71.065188] Starting dynamic subtest: ccs0
[72.107250] Dynamic subtest ccs0: SUCCESS (1.057s)
[72.109731] Subtest await: SUCCESS (7.625s)
[72.298095] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true
[72.301395] [007/133] (947s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[72.404696] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[79.735484] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.335s)
[79.856991] [008/133] (939s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[79.952750] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[79.957264] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[80.047907] [009/133] (939s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[80.131822] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[80.134170] Starting dynamic subtest: pipe-A-eDP-1
[81.110896] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.974s)
[81.119410] Starting dynamic subtest: pipe-B-eDP-1
[82.795769] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.680s)
[82.804250] Starting dynamic subtest: pipe-C-eDP-1
[84.391664] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.594s)
[84.400857] Starting dynamic subtest: pipe-D-eDP-1
[85.892954] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.502s)
[85.895712] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.753s)
[87.045731] [010/133] (932s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[87.158463] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[87.163068] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[87.260608] [011/133] (932s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[87.386126] Starting subtest: cursor-vs-flip-legacy
[117.125726] Subtest cursor-vs-flip-legacy: SUCCESS (29.737s)
[117.980819] [012/133] (901s left) gem_ctx_shared (exec-single-timeline)
[118.053913] Starting subtest: exec-single-timeline
[118.056414] Starting dynamic subtest: rcs0
[119.090384] Dynamic subtest rcs0: SUCCESS (1.037s)
[119.101347] Starting dynamic subtest: bcs0
[120.179085] Dynamic subtest bcs0: SUCCESS (1.088s)
[120.190406] Starting dynamic subtest: vcs0
[121.266072] Dynamic subtest vcs0: SUCCESS (1.085s)
[121.277307] Starting dynamic subtest: vcs1
[122.354389] Dynamic subtest vcs1: SUCCESS (1.087s)
[122.365543] Starting dynamic subtest: vecs0
[123.442878] Dynamic subtest vecs0: SUCCESS (1.087s)
[123.454226] Starting dynamic subtest: ccs0
[124.530378] Dynamic subtest ccs0: SUCCESS (1.086s)
[124.533064] Subtest exec-single-timeline: SUCCESS (6.479s)
[124.740379] [013/133] (894s left) syncobj_basic (create-signaled)
[124.789922] Starting subtest: create-signaled
[124.792254] Subtest create-signaled: SUCCESS (0.000s)
[124.871404] [014/133] (894s left) kms_flip (flip-vs-expired-vblank-interruptible)
[124.966994] Starting subtest: flip-vs-expired-vblank-interruptible
[124.969518] Starting dynamic subtest: A-eDP1
[133.597959] Dynamic subtest A-eDP1: SUCCESS (8.629s)
[133.605814] Starting dynamic subtest: B-eDP1
[142.219210] Dynamic subtest B-eDP1: SUCCESS (8.619s)
[142.228923] Starting dynamic subtest: C-eDP1
[150.835387] Dynamic subtest C-eDP1: SUCCESS (8.614s)
[150.844315] Starting dynamic subtest: D-eDP1
[159.465462] Dynamic subtest D-eDP1: SUCCESS (8.626s)
[159.467804] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.500s)
[160.642866] [015/133] (859s left) syncobj_timeline (wait-for-submit-complex)
[160.699773] Starting subtest: wait-for-submit-complex
[160.763448] Subtest wait-for-submit-complex: SUCCESS (0.065s)
[160.853663] [016/133] (858s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[160.963475] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[160.967593] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[161.046299] [017/133] (858s left) gem_exec_params (rsvd2-dirt)
[161.094752] Starting subtest: rsvd2-dirt
[161.099198] Subtest rsvd2-dirt: SKIP (0.000s)
[161.227878] [018/133] (858s left) gem_eio (in-flight-immediate)
[161.430666] Starting subtest: in-flight-immediate
[169.542281] Subtest in-flight-immediate: SUCCESS (8.113s)
[169.724579] [019/133] (850s left) kms_prop_blob (basic)
[169.781822] Starting subtest: basic
[169.784060] Subtest basic: SUCCESS (0.000s)
[169.865403] [020/133] (850s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[169.964890] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[169.968198] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[170.047966] [021/133] (849s left) gem_ctx_param (get-priority-new-ctx)
[170.093345] Starting subtest: get-priority-new-ctx
[170.095387] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[170.197100] [022/133] (849s left) i915_query (query-regions-unallocated)
[170.251186] Starting subtest: query-regions-unallocated
[170.253058] Subtest query-regions-unallocated: SUCCESS (0.000s)
[170.347463] [023/133] (849s left) gem_mmap_wc (fault-concurrent)
[170.401201] Subtest fault-concurrent: SKIP (0.000s)
[170.456634] [024/133] (849s left) perf (gen12-unprivileged-single-ctx-counters)
[170.591135] Starting subtest: gen12-unprivileged-single-ctx-counters
[170.592962] Starting dynamic subtest: rcs0
[170.672748] Dynamic subtest rcs0: SUCCESS (0.081s)
[170.674650] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.083s)
[170.725735] [025/133] (849s left) kms_psr (psr2-sprite-mmap-cpu)
[170.848589] Starting subtest: psr2-sprite-mmap-cpu
[170.850592] Starting dynamic subtest: eDP-1
[172.541887] Dynamic subtest eDP-1: SUCCESS (1.693s)
[172.544158] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.694s)
[173.405834] [026/133] (846s left) kms_joiner (invalid-modeset-big-joiner)
[173.500592] Starting subtest: invalid-modeset-big-joiner
[173.504835] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[173.571336] [027/133] (846s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[174.100086] Starting subtest: syncobj-backward-timeline-chain-engines
[174.218366] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.118s)
[175.986311] [028/133] (844s left) syncobj_wait (wait-delayed-signal)
[176.047911] Starting subtest: wait-delayed-signal
[176.149245] Subtest wait-delayed-signal: SUCCESS (0.102s)
[176.235923] [029/133] (844s left) intel_hwmon (hwmon-write)
[176.303730] Subtest hwmon-write: SKIP (0.000s)
[176.368928] [030/133] (843s left) kms_cursor_crc (cursor-onscreen-32x10)
[176.546817] Starting subtest: cursor-onscreen-32x10
[176.597630] Subtest cursor-onscreen-32x10: SKIP (0.049s)
[176.869109] [031/133] (843s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[176.958450] Starting subtest: fbc-farfromfence-mmap-gtt
[176.962589] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[177.061228] [032/133] (843s left) gem_fence_thrash (bo-write-verify-threaded-none)
[177.097367] Starting subtest: bo-write-verify-threaded-none
[177.110610] Subtest bo-write-verify-threaded-none: SKIP (0.015s)
[177.168143] [033/133] (843s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[177.292212] Starting subtest: cursorB-vs-flipB-toggle
[177.295918] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[177.433971] [034/133] (843s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[177.528932] Starting subtest: psr-rgb101010-draw-mmap-cpu
[184.627166] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.100s)
[184.756858] [035/133] (835s left) kms_getfb (getfb2-accept-nv12)
[184.853948] Starting subtest: getfb2-accept-nv12
[184.856208] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[184.956487] [036/133] (835s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[185.014823] Starting subtest: invalid-signal-one-illegal-handle
[185.017244] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[185.127511] [037/133] (835s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[185.222358] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[185.224603] Starting dynamic subtest: pipe-A-eDP-1
[185.245262] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.024s)
[185.254418] Starting dynamic subtest: pipe-B-eDP-1
[185.274307] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[185.282449] Starting dynamic subtest: pipe-C-eDP-1
[185.302493] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[185.310628] Starting dynamic subtest: pipe-D-eDP-1
[185.330409] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[185.332711] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.093s)
[187.599592] [038/133] (833s left) gem_exec_create (forked)
[187.657495] Starting subtest: forked
[187.659801] Starting dynamic subtest: smem
[208.856074] Dynamic subtest smem: SUCCESS (21.195s)
[208.859042] Subtest forked: SUCCESS (21.197s)
[209.039496] [039/133] (811s left) gem_spin_batch (legacy-resubmit-new)
[209.103636] Starting subtest: legacy-resubmit-new
[209.106068] Starting dynamic subtest: default
[209.115434] Dynamic subtest default: SUCCESS (0.011s)
[209.124061] Starting dynamic subtest: render
[209.126139] Dynamic subtest render: SUCCESS (0.005s)
[209.136466] Starting dynamic subtest: bsd
[209.138706] Dynamic subtest bsd: SUCCESS (0.007s)
[209.146872] Starting dynamic subtest: bsd1
[209.149221] Dynamic subtest bsd1: SUCCESS (0.004s)
[209.157067] Starting dynamic subtest: bsd2
[209.159362] Dynamic subtest bsd2: SUCCESS (0.006s)
[209.167112] Starting dynamic subtest: blt
[209.169297] Dynamic subtest blt: SUCCESS (0.008s)
[209.176784] Starting dynamic subtest: vebox
[209.178953] Dynamic subtest vebox: SUCCESS (0.008s)
[209.181176] Subtest legacy-resubmit-new: SUCCESS (0.053s)
[210.946743] [040/133] (809s left) gem_eio (execbuf)
[211.204877] Starting subtest: execbuf
[211.587837] Subtest execbuf: SUCCESS (0.382s)
[211.706264] [041/133] (809s left) syncobj_wait (invalid-signal-zero-handles)
[211.765234] Starting subtest: invalid-signal-zero-handles
[211.767469] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[211.865190] [042/133] (808s left) kms_rotation_crc (primary-rotation-180)
[211.964303] Starting subtest: primary-rotation-180
[219.022163] Subtest primary-rotation-180: SUCCESS (7.059s)
[220.264863] [043/133] (800s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[220.327861] Starting subtest: multi-wait-all-for-submit-signaled
[220.330197] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[220.444975] [044/133] (800s left) gem_exec_balancer (sliced)
[220.514726] Starting subtest: sliced
[220.519367] Subtest sliced: SKIP (0.000s)
[220.805491] [045/133] (800s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[220.903068] Starting subtest: fbc-tiling-linear
[224.601562] Subtest fbc-tiling-linear: SUCCESS (3.702s)
[225.768589] [046/133] (795s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[225.871091] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[233.063281] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.195s)
[233.202049] [047/133] (787s left) gem_readwrite (beyond-eob)
[233.256644] Subtest beyond-EOB: SKIP (0.000s)
[233.315018] [048/133] (787s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[233.454515] Starting subtest: dp-mst-lic-type-0-hdcp14
[233.458765] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[233.561735] [049/133] (787s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[233.736206] Starting subtest: cursor-rapid-movement-64x64
[233.740965] Starting dynamic subtest: pipe-A-eDP-1
[234.284609] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[234.311673] Starting dynamic subtest: pipe-D-eDP-1
[235.511162] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.204s)
[235.513538] Subtest cursor-rapid-movement-64x64: SUCCESS (1.773s)
[236.358856] [050/133] (784s left) kms_big_fb (4-tiled-addfb-size-overflow)
[236.457476] Starting subtest: 4-tiled-addfb-size-overflow
[236.459429] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[236.555963] [051/133] (784s left) core_setmaster (master-drop-set-root)
[236.636151] Starting subtest: master-drop-set-root
[236.654023] Subtest master-drop-set-root: SUCCESS (0.015s)
[236.699657] [052/133] (784s left) gem_ringfill (engines-basic)
[242.905591] Starting subtest: engines-basic
[242.908226] Starting dynamic subtest: rcs0
[242.958773] Dynamic subtest rcs0: SUCCESS (0.054s)
[242.969100] Starting dynamic subtest: bcs0
[243.002753] Dynamic subtest bcs0: SUCCESS (0.043s)
[243.011440] Starting dynamic subtest: vcs0
[243.044976] Dynamic subtest vcs0: SUCCESS (0.040s)
[243.054617] Starting dynamic subtest: vcs1
[243.088080] Dynamic subtest vcs1: SUCCESS (0.041s)
[243.097903] Starting dynamic subtest: vecs0
[243.131038] Dynamic subtest vecs0: SUCCESS (0.041s)
[243.140517] Starting dynamic subtest: ccs0
[243.175893] Dynamic subtest ccs0: SUCCESS (0.043s)
[243.178673] Subtest engines-basic: SUCCESS (0.273s)
[243.267024] [053/133] (777s left) kms_fb_coherency (memset-crc)
[243.373807] Starting subtest: memset-crc
[243.376078] Starting dynamic subtest: mmap-offset-wc
[243.774380] Dynamic subtest mmap-offset-wc: SUCCESS (0.399s)
[244.072771] Starting dynamic subtest: mmap-offset-uc
[250.216499] Dynamic subtest mmap-offset-uc: SUCCESS (6.150s)
[250.508083] Subtest memset-crc: SUCCESS (7.133s)
[251.320955] [054/133] (769s left) vgem_basic (dmabuf-fence)
[251.365609] Starting subtest: dmabuf-fence
[251.367448] Subtest dmabuf-fence: SUCCESS (0.000s)
[251.423766] [055/133] (769s left) kms_flip (flip-vs-absolute-wf_vblank)
[251.531230] Starting subtest: flip-vs-absolute-wf_vblank
[251.533074] Starting dynamic subtest: A-eDP1
[260.469714] Dynamic subtest A-eDP1: SUCCESS (8.940s)
[260.483084] Starting dynamic subtest: B-eDP1
[269.395529] Dynamic subtest B-eDP1: SUCCESS (8.923s)
[269.406940] Starting dynamic subtest: C-eDP1
[278.324087] Dynamic subtest C-eDP1: SUCCESS (8.925s)
[278.335244] Starting dynamic subtest: D-eDP1
[287.255539] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[287.261767] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.731s)
[288.476692] [056/133] (732s left) sw_sync (sync_multi_producer_single_consumer)
[288.531140] Starting subtest: sync_multi_producer_single_consumer
[289.607522] Subtest sync_multi_producer_single_consumer: SUCCESS (1.076s)
[289.670329] [057/133] (731s left) gen7_exec_parse (basic-offset)
[289.721646] Subtest basic-offset: SKIP (0.000s)
[289.794806] [058/133] (731s left) kms_psr (fbc-psr-primary-mmap-cpu)
[289.879164] Starting subtest: fbc-psr-primary-mmap-cpu
[289.881457] Starting dynamic subtest: eDP-1
[289.885894] Dynamic subtest eDP-1: SKIP (0.000s)
[289.890370] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[289.955833] [059/133] (731s left) kms_color (ctm-green-to-red)
[290.054316] Starting subtest: ctm-green-to-red
[290.056285] Starting dynamic subtest: pipe-A-eDP-1
[290.744408] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.689s)
[290.752990] Starting dynamic subtest: pipe-B-eDP-1
[292.197723] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.455s)
[292.206526] Starting dynamic subtest: pipe-C-eDP-1
[293.572213] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.371s)
[293.580044] Starting dynamic subtest: pipe-D-eDP-1
[294.895813] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s)
[294.898136] Subtest ctm-green-to-red: SUCCESS (4.843s)
[295.702720] [060/133] (725s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[295.810791] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[295.815127] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[295.908684] [061/133] (725s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[295.965754] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[296.034123] [062/133] (725s left) gem_ctx_persistence (legacy-engines-mixed-process)
[296.090801] Starting subtest: legacy-engines-mixed-process
[296.093315] Starting dynamic subtest: render
[297.875968] Dynamic subtest render: SUCCESS (1.785s)
[297.884971] Starting dynamic subtest: bsd1
[299.884797] Dynamic subtest bsd1: SUCCESS (2.007s)
[299.898149] Starting dynamic subtest: bsd2
[301.910704] Dynamic subtest bsd2: SUCCESS (2.023s)
[301.919562] Starting dynamic subtest: blt
[303.884382] Dynamic subtest blt: SUCCESS (1.972s)
[303.893384] Starting dynamic subtest: vebox
[305.941235] Dynamic subtest vebox: SUCCESS (2.055s)
[305.943945] Subtest legacy-engines-mixed-process: SUCCESS (9.852s)
[306.034537] [063/133] (715s left) perf_pmu (most-busy-idle-check-all)
[306.072843] Starting subtest: most-busy-idle-check-all
[306.075058] Starting dynamic subtest: rcs0
[307.925804] Dynamic subtest rcs0: SUCCESS (1.854s)
[307.937822] Starting dynamic subtest: bcs0
[309.914648] Dynamic subtest bcs0: SUCCESS (1.981s)
[309.923036] Starting dynamic subtest: vcs0
[311.894897] Dynamic subtest vcs0: SUCCESS (1.982s)
[311.906515] Starting dynamic subtest: vcs1
[313.876858] Dynamic subtest vcs1: SUCCESS (1.980s)
[313.888404] Starting dynamic subtest: vecs0
[315.925931] Dynamic subtest vecs0: SUCCESS (2.046s)
[315.936829] Starting dynamic subtest: ccs0
[317.910353] Dynamic subtest ccs0: SUCCESS (1.981s)
[317.913360] Subtest most-busy-idle-check-all: SUCCESS (11.841s)
[318.001647] [064/133] (703s left) kms_plane_multiple (tiling-x)
[318.105074] Starting subtest: tiling-x
[318.107343] Starting dynamic subtest: pipe-A-eDP-1
[321.836818] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.731s)
[321.847210] Starting dynamic subtest: pipe-B-eDP-1
[326.305535] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.467s)
[326.315100] Starting dynamic subtest: pipe-C-eDP-1
[330.760568] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.455s)
[330.769339] Starting dynamic subtest: pipe-D-eDP-1
[335.108776] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.346s)
[335.110583] Subtest tiling-x: SUCCESS (17.004s)
[335.920131] [065/133] (685s left) kms_vblank (ts-continuation-modeset)
[336.017413] Starting subtest: ts-continuation-modeset
[336.019643] Starting dynamic subtest: pipe-A-eDP-1
[337.491543] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.473s)
[337.505491] Starting dynamic subtest: pipe-D-eDP-1
[339.648209] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.155s)
[339.650380] Subtest ts-continuation-modeset: SUCCESS (3.632s)
[340.443131] [066/133] (681s left) api_intel_bb (render)
[340.505643] Starting subtest: render
[340.507636] Starting dynamic subtest: render-none-512
[340.604510] Dynamic subtest render-none-512: SUCCESS (0.100s)
[340.615532] Starting dynamic subtest: render-none-1024
[340.999065] Dynamic subtest render-none-1024: SUCCESS (0.391s)
[341.009866] Starting dynamic subtest: render-x-512
[341.126977] Dynamic subtest render-x-512: SUCCESS (0.126s)
[341.137706] Starting dynamic subtest: render-x-1024
[341.473985] Dynamic subtest render-x-1024: SUCCESS (0.346s)
[341.484807] Starting dynamic subtest: render-y-512
[341.564337] Dynamic subtest render-y-512: SUCCESS (0.090s)
[341.575052] Starting dynamic subtest: render-y-1024
[341.919138] Dynamic subtest render-y-1024: SUCCESS (0.353s)
[341.921326] Subtest render: SUCCESS (1.415s)
[342.023067] [067/133] (679s left) kms_atomic (plane-invalid-params-fence)
[342.119271] Starting subtest: plane-invalid-params-fence
[342.121537] Starting dynamic subtest: pipe-A-eDP-1
[342.473607] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.354s)
[342.475832] Subtest plane-invalid-params-fence: SUCCESS (0.355s)
[343.266431] [068/133] (678s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[343.359176] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[343.364569] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[343.458156] [069/133] (678s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[343.554244] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[343.556592] Starting dynamic subtest: pipe-A
[343.617912] Dynamic subtest pipe-A: SUCCESS (0.065s)
[343.630833] Starting dynamic subtest: pipe-B
[344.786167] Dynamic subtest pipe-B: SUCCESS (1.167s)
[344.796669] Starting dynamic subtest: pipe-C
[345.896017] Dynamic subtest pipe-C: SUCCESS (1.108s)
[345.909886] Starting dynamic subtest: pipe-D
[347.026210] Dynamic subtest pipe-D: SUCCESS (1.129s)
[347.028582] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.474s)
[348.192589] [070/133] (673s left) kms_chamelium_hpd (hdmi-hpd-storm)
[348.596630] Subtest hdmi-hpd-storm: SKIP (0.000s)
[349.413566] [071/133] (672s left) gem_exec_whisper (basic-queues-priority)
[349.470780] Starting subtest: basic-queues-priority
[373.980147] Subtest basic-queues-priority: SUCCESS (24.505s)
[374.165230] [072/133] (647s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[374.225590] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[374.329571] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.103s)
[374.404650] [073/133] (647s left) gem_exec_balancer (nohangcheck)
[374.669875] Starting subtest: nohangcheck
[375.587796] Subtest nohangcheck: SUCCESS (0.919s)
[375.704851] [074/133] (646s left) kms_cursor_crc (cursor-sliding-64x21)
[375.903842] Starting subtest: cursor-sliding-64x21
[375.953149] Subtest cursor-sliding-64x21: SKIP (0.046s)
[376.203381] [075/133] (645s left) kms_lease (cursor-implicit-plane)
[376.308151] Starting subtest: cursor-implicit-plane
[376.310468] Starting dynamic subtest: pipe-A-eDP-1
[376.769675] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.461s)
[376.781613] Starting dynamic subtest: pipe-B-eDP-1
[377.944064] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.175s)
[377.953949] Starting dynamic subtest: pipe-C-eDP-1
[379.059038] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.113s)
[379.069443] Starting dynamic subtest: pipe-D-eDP-1
[380.189732] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[380.192098] Subtest cursor-implicit-plane: SUCCESS (3.883s)
[381.050505] [076/133] (641s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[381.147177] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[381.149448] Starting dynamic subtest: pipe-A-default-mode
[382.312669] Dynamic subtest pipe-A-default-mode: SKIP (1.162s)
[382.316801] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.164s)
[382.459750] [077/133] (639s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[382.553387] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[382.556025] Starting dynamic subtest: pipe-A-eDP-1
[382.616426] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.065s)
[382.911418] Starting dynamic subtest: pipe-B-eDP-1
[383.685262] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.782s)
[383.981514] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.427s)
[384.858831] [078/133] (637s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[384.957202] Starting subtest: x-tiled-8bpp-rotate-180
[386.214274] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.258s)
[386.341929] [079/133] (635s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[386.444852] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[386.448289] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[386.544506] [080/133] (635s left) gem_exec_fence (syncobj-timeline-wait)
[387.108514] Starting subtest: syncobj-timeline-wait
[388.903257] Subtest syncobj-timeline-wait: SUCCESS (1.800s)
[390.981066] [081/133] (631s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[391.035828] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[391.039756] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[391.215515] [082/133] (631s left) kms_big_fb (linear-32bpp-rotate-90)
[391.313986] Starting subtest: linear-32bpp-rotate-90
[391.334100] Subtest linear-32bpp-rotate-90: SKIP (0.020s)
[391.449033] [083/133] (630s left) kms_display_modes (extended-mode-basic)
[391.542040] Starting subtest: extended-mode-basic
[391.546462] Subtest extended-mode-basic: SKIP (0.000s)
[391.589478] [084/133] (630s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[391.650968] Starting subtest: y-tiled-ccs-to-x-tiled
[391.655495] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[391.838317] [085/133] (630s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[391.932955] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[391.937297] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[392.036182] [086/133] (630s left) i915_drm_fdinfo (virtual-busy-hang)
[392.077312] Starting subtest: virtual-busy-hang
[392.081540] Subtest virtual-busy-hang: SKIP (0.000s)
[392.146092] [087/133] (630s left) gem_exec_reloc (basic-write-read-noreloc)
[392.213733] Subtest basic-write-read-noreloc: SKIP (0.000s)
[392.288111] [088/133] (630s left) gem_exec_reloc (basic-wc-read)
[392.348816] Subtest basic-wc-read: SKIP (0.000s)
[392.423223] [089/133] (630s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[392.518697] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[392.523207] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[392.620994] [090/133] (630s left) kms_pm_dc (dc5-retention-flops)
[393.727156] Starting subtest: dc5-retention-flops
[393.731623] Subtest dc5-retention-flops: SKIP (0.000s)
[393.798657] [091/133] (628s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[393.904452] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[393.906786] Starting dynamic subtest: pipe-A-eDP-1
[399.834797] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.931s)
[399.844897] Starting dynamic subtest: pipe-B-eDP-1
[406.506366] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.670s)
[406.508749] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.605s)
[407.373433] [092/133] (615s left) i915_pm_rpm (reg-read-ioctl)
[409.120879] Starting subtest: reg-read-ioctl
[411.398870] Subtest reg-read-ioctl: SUCCESS (2.282s)
[411.785540] [093/133] (611s left) gem_create (create-ext-cpu-access-sanity-check)
[411.957785] Starting subtest: create-ext-cpu-access-sanity-check
[411.962572] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[412.045593] [094/133] (610s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[412.139425] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[416.400356] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.264s)
[417.614307] [095/133] (605s left) gem_ctx_persistence (engines-hostile)
[417.686809] Starting subtest: engines-hostile
[417.689295] Starting dynamic subtest: rcs0
[417.815060] Dynamic subtest rcs0: SUCCESS (0.129s)
[417.831720] Starting dynamic subtest: bcs0
[417.924677] Dynamic subtest bcs0: SUCCESS (0.108s)
[417.936542] Starting dynamic subtest: vcs0
[418.038957] Dynamic subtest vcs0: SUCCESS (0.112s)
[418.050848] Starting dynamic subtest: vcs1
[418.108546] Dynamic subtest vcs1: SUCCESS (0.068s)
[418.117671] Starting dynamic subtest: vecs0
[418.238111] Dynamic subtest vecs0: SUCCESS (0.127s)
[418.249848] Starting dynamic subtest: ccs0
[418.342983] Dynamic subtest ccs0: SUCCESS (0.103s)
[418.345632] Subtest engines-hostile: SUCCESS (0.658s)
[418.420031] [096/133] (604s left) kms_psr (psr-primary-mmap-cpu)
[418.510985] Starting subtest: psr-primary-mmap-cpu
[418.513288] Starting dynamic subtest: eDP-1
[420.295376] Dynamic subtest eDP-1: SUCCESS (1.783s)
[420.297668] Subtest psr-primary-mmap-cpu: SUCCESS (1.784s)
[421.181400] [097/133] (601s left) gem_ccs (block-multicopy-inplace)
[421.240283] Starting subtest: block-multicopy-inplace
[421.244604] Subtest block-multicopy-inplace: SKIP (0.000s)
[421.365517] [098/133] (601s left) i915_pm_freq_api (freq-suspend)
[421.432288] Starting subtest: freq-suspend
[421.434205] Starting dynamic subtest: gt0
[438.415925] Dynamic subtest gt0: SUCCESS (1.503s)
[438.429760] Starting dynamic subtest: gt1
[454.269100] Dynamic subtest gt1: SUCCESS (1.210s)
[454.271019] Subtest freq-suspend: SUCCESS (2.716s)
[454.339058] [099/133] (568s left) kms_flip (2x-flip-vs-dpms-on-nop)
[454.446714] Starting subtest: 2x-flip-vs-dpms-on-nop
[454.455756] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[454.535710] [100/133] (568s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[454.636958] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[454.639527] Starting dynamic subtest: pipe-A-eDP-1
[455.113538] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.459s)
[455.124915] Starting dynamic subtest: pipe-B-eDP-1
[456.574365] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.497s)
[456.585719] Starting dynamic subtest: pipe-C-eDP-1
[457.921954] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.374s)
[457.934355] Starting dynamic subtest: pipe-D-eDP-1
[459.340697] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.444s)
[459.342931] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.779s)
[460.498334] [101/133] (562s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[460.562747] Starting subtest: etime-single-wait-for-submit-submitted
[460.673349] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.110s)
[460.753343] [102/133] (562s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[460.858132] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[460.862320] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[460.933773] [103/133] (562s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[461.030957] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[461.033201] Starting dynamic subtest: pipe-A
[462.220901] Dynamic subtest pipe-A: SUCCESS (1.206s)
[462.229561] Starting dynamic subtest: pipe-B
[464.427249] Dynamic subtest pipe-B: SUCCESS (2.226s)
[464.435996] Starting dynamic subtest: pipe-C
[465.640091] Dynamic subtest pipe-C: SUCCESS (1.220s)
[465.649799] Starting dynamic subtest: pipe-D
[466.886582] Dynamic subtest pipe-D: SUCCESS (1.254s)
[466.888717] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.911s)
[468.058353] [104/133] (555s left) gem_exec_flush (basic-wb-ro-default)
[468.131882] Starting subtest: basic-wb-ro-default
[473.565455] Subtest basic-wb-ro-default: SUCCESS (5.455s)
[473.758401] [105/133] (549s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[473.845916] Starting subtest: disable-crc-after-crtc
[473.848038] Starting dynamic subtest: pipe-A-eDP-1
[475.481160] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.638s)
[475.491509] Starting dynamic subtest: pipe-B-eDP-1
[477.860378] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.385s)
[477.869951] Starting dynamic subtest: pipe-C-eDP-1
[480.105232] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.245s)
[480.114980] Starting dynamic subtest: pipe-D-eDP-1
[482.368563] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.267s)
[482.370879] Subtest disable-crc-after-crtc: SUCCESS (8.540s)
[483.213996] [106/133] (540s left) syncobj_timeline (signal-point-0)
[483.268704] Starting subtest: signal-point-0
[483.271051] Subtest signal-point-0: SUCCESS (0.000s)
[483.383272] [107/133] (540s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[483.474758] Starting subtest: fbc-rgb101010-draw-blt
[488.100983] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.628s)
[489.219155] [108/133] (534s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[489.321490] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[496.985215] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.665s)
[497.098767] [109/133] (526s left) gem_exec_schedule (pi-distinct-iova)
[497.282006] Starting subtest: pi-distinct-iova
[497.284572] Starting dynamic subtest: rcs0
[497.363459] Dynamic subtest rcs0: SUCCESS (0.084s)
[497.377187] Starting dynamic subtest: vcs0
[497.419201] Dynamic subtest vcs0: SUCCESS (0.054s)
[497.435444] Starting dynamic subtest: vcs1
[497.475290] Dynamic subtest vcs1: SUCCESS (0.055s)
[497.485588] Starting dynamic subtest: vecs0
[497.535066] Dynamic subtest vecs0: SUCCESS (0.059s)
[497.546070] Starting dynamic subtest: ccs0
[497.598777] Dynamic subtest ccs0: SUCCESS (0.063s)
[497.601106] Subtest pi-distinct-iova: SUCCESS (0.321s)
[499.090663] [110/133] (524s left) syncobj_wait (multi-wait-for-submit-signaled)
[499.137142] Starting subtest: multi-wait-for-submit-signaled
[499.139285] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[499.241977] [111/133] (524s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[499.344676] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[499.348866] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[499.428677] [112/133] (524s left) kms_psr (pr-cursor-plane-onoff)
[499.529288] Starting subtest: pr-cursor-plane-onoff
[499.533800] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[499.604625] [113/133] (524s left) gem_ctx_param (invalid-param-get)
[499.647177] Starting subtest: invalid-param-get
[499.649536] Subtest invalid-param-get: SUCCESS (0.001s)
[499.741879] [114/133] (524s left) gem_eio (hibernate)
[499.983801] Starting subtest: hibernate
[514.698984] Subtest hibernate: SUCCESS (14.717s)
[522.827069] [115/133] (508s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[522.944789] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[523.811134] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.872s)
[524.007625] [116/133] (507s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[524.133484] Starting subtest: cursorB-vs-flipB-atomic-transitions
[524.138258] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[524.291510] [117/133] (507s left) gem_exec_schedule (thriceslice)
[524.368136] Starting subtest: thriceslice
[524.370150] Starting dynamic subtest: rcs0
[524.386709] Dynamic subtest rcs0: SUCCESS (0.030s)
[524.400682] Starting dynamic subtest: bcs0
[524.415425] Dynamic subtest bcs0: SUCCESS (0.028s)
[524.425065] Starting dynamic subtest: vcs0
[524.444605] Dynamic subtest vcs0: SUCCESS (0.028s)
[524.454271] Starting dynamic subtest: vcs1
[524.474283] Dynamic subtest vcs1: SUCCESS (0.029s)
[524.483894] Starting dynamic subtest: vecs0
[524.503197] Dynamic subtest vecs0: SUCCESS (0.028s)
[524.512809] Starting dynamic subtest: ccs0
[524.532981] Dynamic subtest ccs0: SUCCESS (0.029s)
[524.535138] Subtest thriceslice: SUCCESS (0.177s)
[524.836917] [118/133] (507s left) api_intel_allocator (reserve-simple)
[524.890106] Starting subtest: reserve-simple
[524.892332] Subtest reserve-simple: SUCCESS (0.003s)
[525.023836] [119/133] (506s left) gem_exec_whisper (basic-queues)
[525.090702] Starting subtest: basic-queues
[533.013164] Subtest basic-queues: SUCCESS (7.921s)
[533.196408] [120/133] (498s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[533.304662] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[533.308671] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[533.420087] [121/133] (498s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[533.525746] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[533.530013] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[533.625544] [122/133] (498s left) gem_reg_read (timestamp-moving)
[533.692133] Starting subtest: timestamp-moving
[534.692140] Subtest timestamp-moving: SUCCESS (1.001s)
[534.773024] [123/133] (497s left) kms_chamelium_color (ctm-red-to-blue)
[534.883596] Subtest ctm-red-to-blue: SKIP (0.000s)
[534.928868] [124/133] (497s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[535.024989] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[535.029353] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[535.165001] [125/133] (497s left) gem_exec_parallel (fds)
[535.231659] Starting subtest: fds
[535.234028] Starting dynamic subtest: rcs0
[538.116442] Dynamic subtest rcs0: SUCCESS (2.886s)
[538.129562] Starting dynamic subtest: bcs0
[542.004494] Dynamic subtest bcs0: SUCCESS (3.885s)
[542.017637] Starting dynamic subtest: vcs0
[546.355373] Dynamic subtest vcs0: SUCCESS (4.350s)
[546.368686] Starting dynamic subtest: vcs1
[550.340858] Dynamic subtest vcs1: SUCCESS (3.983s)
[550.352139] Starting dynamic subtest: vecs0
[554.301637] Dynamic subtest vecs0: SUCCESS (3.960s)
[554.314630] Starting dynamic subtest: ccs0
[558.582428] Dynamic subtest ccs0: SUCCESS (4.279s)
[558.585057] Subtest fds: SUCCESS (23.358s)
[558.790499] [126/133] (473s left) prime_busy (after-wait)
[558.845696] Starting subtest: after-wait
[558.851044] Starting dynamic subtest: rcs0
[558.897027] Dynamic subtest rcs0: SUCCESS (0.047s)
[558.909644] Starting dynamic subtest: bcs0
[558.950716] Dynamic subtest bcs0: SUCCESS (0.053s)
[558.961641] Starting dynamic subtest: vcs0
[558.994441] Dynamic subtest vcs0: SUCCESS (0.043s)
[559.004690] Starting dynamic subtest: vcs1
[559.035261] Dynamic subtest vcs1: SUCCESS (0.040s)
[559.046135] Starting dynamic subtest: vecs0
[559.078308] Dynamic subtest vecs0: SUCCESS (0.042s)
[559.088459] Starting dynamic subtest: ccs0
[559.124020] Dynamic subtest ccs0: SUCCESS (0.045s)
[559.232516] Subtest after-wait: SUCCESS (0.385s)
[559.311504] [127/133] (473s left) gem_mmap_offset (mmap-unmap)
[559.368726] Starting subtest: mmap-unmap
[559.370929] Starting dynamic subtest: smem0
[581.990965] Dynamic subtest smem0: SUCCESS (22.627s)
[581.993637] Subtest mmap-unmap: SUCCESS (22.628s)
[582.111922] [128/133] (450s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[582.219165] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[582.221615] Starting dynamic subtest: pipe-A-eDP-1
[582.971338] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.742s)
[582.987224] Starting dynamic subtest: pipe-B-eDP-1
[584.783908] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.812s)
[584.797938] Starting dynamic subtest: pipe-C-eDP-1
[586.600714] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.816s)
[586.612132] Starting dynamic subtest: pipe-D-eDP-1
[588.437329] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.836s)
[588.439211] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.212s)
[589.565463] [129/133] (442s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[589.670810] Starting subtest: pr-overlay-plane-move-continuous-sf
[589.674957] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[589.740234] [130/133] (442s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[589.840280] Starting subtest: bad-pixel-format-y-tiled-ccs
[589.842645] Starting dynamic subtest: pipe-A-eDP-1
[589.872830] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[589.884856] Starting dynamic subtest: pipe-B-eDP-1
[589.905787] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[589.916137] Starting dynamic subtest: pipe-C-eDP-1
[589.937904] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[589.947640] Starting dynamic subtest: pipe-D-eDP-1
[589.969710] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[589.973797] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.008s)
[592.126426] [131/133] (440s left) gem_mmap_gtt (cpuset-big-copy-xy)
[592.184693] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[592.254347] [132/133] (440s left) kms_psr (fbc-psr2-basic)
[592.341141] Starting subtest: fbc-psr2-basic
[592.343350] Starting dynamic subtest: eDP-1
[592.347342] Dynamic subtest eDP-1: SKIP (0.000s)
[592.351333] Subtest fbc-psr2-basic: SKIP (0.001s)
[592.415700] [133/133] (440s left) kms_scaling_modes (scaling-mode-none)
[592.517114] Starting subtest: scaling-mode-none
[592.519240] Starting dynamic subtest: pipe-A-eDP-1
[592.614874] Dynamic subtest pipe-A-eDP-1: SKIP (0.097s)
[592.625958] Starting dynamic subtest: pipe-B-eDP-1
[592.651954] Dynamic subtest pipe-B-eDP-1: SKIP (0.035s)
[592.662671] Starting dynamic subtest: pipe-C-eDP-1
[592.686347] Dynamic subtest pipe-C-eDP-1: SKIP (0.033s)
[592.698720] Starting dynamic subtest: pipe-D-eDP-1
[592.720035] Dynamic subtest pipe-D-eDP-1: SKIP (0.032s)
[592.724573] Subtest scaling-mode-none: SKIP (0.203s)
[592.849402] Closing watchdogs
results: parsing output: 0/ for test: gem_eio
results: parsing output: 1/ for test: kms_psr2_sf
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_pipe_b_c_ivb
results: parsing output: 4/ for test: gem_mmap_wc
results: parsing output: 5/ for test: gem_wait
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: gem_ctx_shared
results: parsing output: 12/ for test: syncobj_basic
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_exec_params
results: parsing output: 17/ for test: gem_eio
results: parsing output: 18/ for test: kms_prop_blob
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gem_ctx_param
results: parsing output: 21/ for test: i915_query
results: parsing output: 22/ for test: gem_mmap_wc
results: parsing output: 23/ for test: perf
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_joiner
results: parsing output: 26/ for test: gem_exec_fence
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: intel_hwmon
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_fence_thrash
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_getfb
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: gem_exec_create
results: parsing output: 38/ for test: gem_spin_batch
results: parsing output: 39/ for test: gem_eio
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: kms_rotation_crc
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: gem_exec_balancer
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_readwrite
results: parsing output: 47/ for test: kms_content_protection
results: parsing output: 48/ for test: kms_cursor_crc
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: core_setmaster
results: parsing output: 51/ for test: gem_ringfill
results: parsing output: 52/ for test: kms_fb_coherency
results: parsing output: 53/ for test: vgem_basic
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: sw_sync
results: parsing output: 56/ for test: gen7_exec_parse
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_color
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: gem_ctx_persistence
results: parsing output: 62/ for test: perf_pmu
results: parsing output: 63/ for test: kms_plane_multiple
results: parsing output: 64/ for test: kms_vblank
results: parsing output: 65/ for test: api_intel_bb
results: parsing output: 66/ for test: kms_atomic
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: kms_chamelium_hpd
results: parsing output: 70/ for test: gem_exec_whisper
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: gem_exec_balancer
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: kms_lease
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: kms_atomic_transition
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_fence
results: parsing output: 80/ for test: gem_render_copy
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_display_modes
results: parsing output: 83/ for test: gem_render_copy
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: i915_drm_fdinfo
results: parsing output: 86/ for test: gem_exec_reloc
results: parsing output: 87/ for test: gem_exec_reloc
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_pm_dc
results: parsing output: 90/ for test: kms_psr2_sf
results: parsing output: 91/ for test: i915_pm_rpm
results: parsing output: 92/ for test: gem_create
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_ctx_persistence
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: gem_ccs
results: parsing output: 97/ for test: i915_pm_freq_api
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_plane
results: parsing output: 102/ for test: kms_plane_scaling
results: parsing output: 103/ for test: gem_exec_flush
results: parsing output: 104/ for test: kms_pipe_crc_basic
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_exec_schedule
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: gem_ctx_param
results: parsing output: 113/ for test: gem_eio
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: api_intel_allocator
results: parsing output: 118/ for test: gem_exec_whisper
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_reg_read
results: parsing output: 122/ for test: kms_chamelium_color
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_parallel
results: parsing output: 125/ for test: prime_busy
results: parsing output: 126/ for test: gem_mmap_offset
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: kms_psr2_sf
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: gem_mmap_gtt
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: kms_scaling_modes
Done.