[55.205162] Initializing watchdogs
[55.205307]   /dev/watchdog0
[55.220259] [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]
[55.224591] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.226841] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.230645] [001/131] (960s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[55.376194] Starting subtest: cursorA-vs-flipB-varying-size
[55.380855] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[55.516183] [002/131] (960s left) kms_vblank (query-forked-busy)
[55.619059] Starting subtest: query-forked-busy
[55.621535] Starting dynamic subtest: pipe-A-eDP-1
[57.553598] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.922s)
[57.566663] Starting dynamic subtest: pipe-D-eDP-1
[60.115550] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.547s)
[60.117892] Subtest query-forked-busy: SUCCESS (4.472s)
[60.909206] [003/131] (954s left) syncobj_timeline (transfer-timeline-point)
[60.959186] Starting subtest: transfer-timeline-point
[60.961612] Subtest transfer-timeline-point: SUCCESS (0.000s)
[61.069937] [004/131] (954s left) kms_cursor_crc (cursor-offscreen-512x170)
[61.353419] Starting subtest: cursor-offscreen-512x170
[61.357938] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[61.512430] [005/131] (954s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[61.611445] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[69.259065] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.635s)
[69.378760] [006/131] (946s left) perf_pmu (busy-no-semaphores)
[69.418484] Starting subtest: busy-no-semaphores
[69.420678] Starting dynamic subtest: rcs0
[69.970748] Dynamic subtest rcs0: SUCCESS (0.549s)
[69.981103] Starting dynamic subtest: bcs0
[70.520608] Dynamic subtest bcs0: SUCCESS (0.549s)
[70.531042] Starting dynamic subtest: vcs0
[71.069979] Dynamic subtest vcs0: SUCCESS (0.547s)
[71.083215] Starting dynamic subtest: vcs1
[72.415240] Dynamic subtest vcs1: SUCCESS (1.343s)
[72.424856] Starting dynamic subtest: vecs0
[74.397425] Dynamic subtest vecs0: SUCCESS (1.980s)
[74.407132] Starting dynamic subtest: ccs0
[76.446699] Dynamic subtest ccs0: SUCCESS (2.047s)
[76.449791] Subtest busy-no-semaphores: SUCCESS (7.020s)
[76.577330] [007/131] (939s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[76.675336] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[83.099041] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.424s)
[83.243293] [008/131] (932s left) i915_module_load (resize-bar)
[83.281061] Starting subtest: resize-bar
[83.290039] Subtest resize-bar: SKIP (0.008s)
[83.332287] [009/131] (932s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[83.426110] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[83.428463] Starting dynamic subtest: pipe-A-eDP-1
[99.859684] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.556s)
[99.869506] Starting dynamic subtest: pipe-B-eDP-1
[116.774274] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.333s)
[116.783152] Starting dynamic subtest: pipe-C-eDP-1
[133.713829] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.266s)
[133.724153] Starting dynamic subtest: pipe-D-eDP-1
[150.758414] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.257s)
[150.760903] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.416s)
[151.973825] [010/131] (864s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[152.095225] Starting subtest: psr-rgb101010-draw-pwrite
[159.782911] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.623s)
[159.904897] [011/131] (856s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[160.011842] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[160.016339] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[160.124229] [012/131] (856s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[160.509151] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[161.277581] [013/131] (854s left) fbdev (pan)
[161.311496] Starting subtest: pan
[161.338603] Subtest pan: SUCCESS (0.029s)
[161.406129] [014/131] (854s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[166.477042] Starting subtest: pr-cursor-plane-update-sf
[166.482214] Subtest pr-cursor-plane-update-sf: SKIP (0.002s)
[167.312594] [015/131] (848s left) gem_eio (in-flight-internal-1us)
[167.527060] Starting subtest: in-flight-internal-1us
[168.794791] Subtest in-flight-internal-1us: SUCCESS (1.264s)
[168.926378] [016/131] (847s left) gem_exec_params (secure-non-root)
[168.980887] Starting subtest: secure-non-root
[168.985529] Subtest secure-non-root: SKIP (0.000s)
[169.080145] [017/131] (847s left) kms_joiner (basic-force-ultra-joiner)
[169.179044] Starting subtest: basic-force-ultra-joiner
[169.183350] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[169.241070] [018/131] (847s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[169.291764] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[169.294158] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[169.395731] [019/131] (847s left) kms_psr (fbc-pr-primary-page-flip)
[169.487634] Starting subtest: fbc-pr-primary-page-flip
[169.492610] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[169.557086] [020/131] (846s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[169.648905] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[169.651330] Starting dynamic subtest: pipe-A-eDP-1
[169.674579] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[169.685298] Starting dynamic subtest: pipe-B-eDP-1
[169.706632] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[169.715217] Starting dynamic subtest: pipe-C-eDP-1
[169.734181] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[169.742177] Starting dynamic subtest: pipe-D-eDP-1
[169.760563] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[169.764176] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[171.777364] [021/131] (844s left) gem_mmap_gtt (fault-concurrent)
[171.828249] Subtest fault-concurrent: SKIP (0.000s)
[171.882439] [022/131] (844s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[171.953468] Starting subtest: map-fixed-invalidate-overlap-busy
[171.958087] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[172.082935] [023/131] (844s left) kms_psr (fbc-psr-primary-render)
[172.184793] Starting subtest: fbc-psr-primary-render
[172.186947] Starting dynamic subtest: eDP-1
[172.191242] Dynamic subtest eDP-1: SKIP (0.000s)
[172.195577] Subtest fbc-psr-primary-render: SKIP (0.000s)
[172.253910] [024/131] (844s left) gem_eio (wait-wedge-1us)
[172.453170] Starting subtest: wait-wedge-1us
[173.781182] Subtest wait-wedge-1us: SUCCESS (1.326s)
[173.936068] [025/131] (842s left) gem_ppgtt (blt-vs-render-ctxn)
[173.995506] Starting subtest: blt-vs-render-ctxN
[206.963490] Subtest blt-vs-render-ctxN: SUCCESS (32.967s)
[207.094736] [026/131] (809s left) gem_flink_race (flink_name)
[207.158737] Starting subtest: flink_name
[212.567857] Subtest flink_name: SUCCESS (5.404s)
[212.692140] [027/131] (804s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[212.766233] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[212.871201] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[212.944993] [028/131] (803s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[212.999277] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[213.060895] [029/131] (803s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[213.189076] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[213.193280] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[213.289201] [030/131] (803s left) gem_ctx_create (basic-files)
[213.356198] Starting subtest: basic-files
[215.364828] Subtest basic-files: SUCCESS (2.008s)
[216.778232] [031/131] (800s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[216.839263] Starting subtest: y-tiled-ccs-to-yf-tiled
[216.843974] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[217.023326] [032/131] (799s left) gem_exec_reloc (basic-range)
[217.081224] Subtest basic-range: SKIP (0.000s)
[217.187392] [033/131] (799s left) syncobj_basic (bad-create-flags)
[217.239765] Starting subtest: bad-create-flags
[217.242123] Subtest bad-create-flags: SUCCESS (0.000s)
[217.357108] [034/131] (799s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[217.455040] Starting subtest: addfb25-y-tiled-legacy
[217.456970] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[217.535595] [035/131] (799s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[217.592864] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[217.595168] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[217.697989] [036/131] (799s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[218.085877] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[218.877911] [037/131] (798s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[218.980892] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[218.985080] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[219.080995] [038/131] (798s left) gem_mmap_gtt (big-copy-xy)
[219.132477] Subtest big-copy-XY: SKIP (0.000s)
[219.192902] [039/131] (798s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[219.285880] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[219.288240] Starting dynamic subtest: pipe-A-eDP-1
[219.308391] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[219.318395] Starting dynamic subtest: pipe-B-eDP-1
[219.337984] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[219.346595] Starting dynamic subtest: pipe-C-eDP-1
[219.366499] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[219.376598] Starting dynamic subtest: pipe-D-eDP-1
[219.395630] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[219.397515] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[221.469530] [040/131] (795s left) gem_exec_params (no-bsd)
[221.530632] Starting subtest: no-bsd
[221.532951] Subtest no-bsd: SUCCESS (0.002s)
[222.841857] [041/131] (794s left) gem_exec_reloc (basic-gtt-noreloc)
[222.904649] Subtest basic-gtt-noreloc: SKIP (0.000s)
[222.975375] [042/131] (794s left) gem_mmap_gtt (basic-read)
[223.035607] Subtest basic-read: SKIP (0.000s)
[223.098482] [043/131] (794s left) gem_mmap_gtt (medium-copy)
[223.152282] Subtest medium-copy: SKIP (0.000s)
[223.217033] [044/131] (794s left) kms_plane_multiple (tiling-yf)
[223.321573] Starting subtest: tiling-yf
[223.325961] Subtest tiling-yf: SKIP (0.000s)
[223.390603] [045/131] (794s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[223.490414] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[223.494873] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[223.574176] [046/131] (793s left) i915_power (sanity)
[223.630966] Starting subtest: sanity
[227.669243] Subtest sanity: SUCCESS (4.031s)
[228.823008] [047/131] (788s left) sw_sync (sync_expired_merge)
[228.859553] Starting subtest: sync_expired_merge
[229.932331] Subtest sync_expired_merge: SUCCESS (1.074s)
[229.991574] [048/131] (787s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[230.101843] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[230.470958] Starting dynamic subtest: pipe-A-eDP-1
[233.218399] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.746s)
[233.580513] Starting dynamic subtest: pipe-B-eDP-1
[236.341319] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.767s)
[236.704662] Starting dynamic subtest: pipe-C-eDP-1
[239.462207] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.764s)
[239.827410] Starting dynamic subtest: pipe-D-eDP-1
[242.586434] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.767s)
[242.588850] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.483s)
[243.770122] [049/131] (773s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[243.873423] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[243.877507] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[243.987681] [050/131] (773s left) kms_scaling_modes (scaling-mode-center)
[244.095068] Starting subtest: scaling-mode-center
[244.097426] Starting dynamic subtest: pipe-A-eDP-1
[244.211308] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.114s)
[244.221709] Starting dynamic subtest: pipe-B-eDP-1
[245.394520] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.180s)
[245.413302] Starting dynamic subtest: pipe-C-eDP-1
[246.596056] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.199s)
[246.606112] Starting dynamic subtest: pipe-D-eDP-1
[247.721252] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[247.723819] Subtest scaling-mode-center: SUCCESS (3.626s)
[248.878554] [051/131] (768s left) gem_exec_fence (keep-in-fence)
[249.060595] Starting subtest: keep-in-fence
[249.063571] Starting dynamic subtest: rcs0
[249.160194] Dynamic subtest rcs0: SUCCESS (0.099s)
[249.172613] Starting dynamic subtest: bcs0
[249.214113] Dynamic subtest bcs0: SUCCESS (0.053s)
[249.225284] Starting dynamic subtest: vcs0
[250.715850] Dynamic subtest vcs0: SUCCESS (1.499s)
[250.727996] Starting dynamic subtest: vcs1
[252.700877] Dynamic subtest vcs1: SUCCESS (1.984s)
[252.712890] Starting dynamic subtest: vecs0
[254.747755] Dynamic subtest vecs0: SUCCESS (2.046s)
[254.760138] Starting dynamic subtest: ccs0
[254.968125] Dynamic subtest ccs0: SUCCESS (0.220s)
[254.970888] Subtest keep-in-fence: SUCCESS (5.910s)
[256.830102] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[256.833327] [052/131] (760s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[256.941871] Starting subtest: flip-vs-dpms-on-nop-interruptible
[256.944187] Starting dynamic subtest: A-eDP1
[258.860190] Dynamic subtest A-eDP1: SUCCESS (1.918s)
[258.871062] Starting dynamic subtest: B-eDP1
[260.677461] Dynamic subtest B-eDP1: SUCCESS (1.817s)
[260.688676] Starting dynamic subtest: C-eDP1
[262.500439] Dynamic subtest C-eDP1: SUCCESS (1.822s)
[262.513293] Starting dynamic subtest: D-eDP1
[264.309568] Dynamic subtest D-eDP1: SUCCESS (1.809s)
[264.311947] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.372s)
[265.488058] [053/131] (752s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[265.591715] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[266.537832] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.948s)
[266.801876] [054/131] (751s left) kms_chamelium_color (ctm-max)
[266.905942] Subtest ctm-max: SKIP (0.000s)
[266.952544] [055/131] (750s left) syncobj_eventfd (binary-wait)
[267.010294] Starting subtest: binary-wait
[267.018402] Subtest binary-wait: SUCCESS (0.011s)
[267.128087] [056/131] (750s left) api_intel_bb (render)
[267.188860] Starting subtest: render
[267.191191] Starting dynamic subtest: render-none-512
[267.308170] Dynamic subtest render-none-512: SUCCESS (0.119s)
[267.320444] Starting dynamic subtest: render-none-1024
[267.753868] Dynamic subtest render-none-1024: SUCCESS (0.445s)
[267.766601] Starting dynamic subtest: render-x-512
[267.853744] Dynamic subtest render-x-512: SUCCESS (0.101s)
[267.866085] Starting dynamic subtest: render-x-1024
[268.256080] Dynamic subtest render-x-1024: SUCCESS (0.400s)
[268.270152] Starting dynamic subtest: render-y-512
[268.357707] Dynamic subtest render-y-512: SUCCESS (0.102s)
[268.369927] Starting dynamic subtest: render-y-1024
[268.763671] Dynamic subtest render-y-1024: SUCCESS (0.404s)
[268.766635] Subtest render: SUCCESS (1.575s)
[268.902700] [057/131] (749s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[268.999003] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[269.001358] Starting dynamic subtest: pipe-A-eDP-1
[269.026924] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[269.037549] Starting dynamic subtest: pipe-B-eDP-1
[269.061478] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[269.071667] Starting dynamic subtest: pipe-C-eDP-1
[269.095645] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[269.104957] Starting dynamic subtest: pipe-D-eDP-1
[269.129077] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[269.133457] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[271.135170] [058/131] (746s left) gem_ctx_freq (sysfs)
[271.202395] Starting subtest: sysfs
[271.204897] Starting dynamic subtest: gt0
[276.721579] Dynamic subtest gt0: SUCCESS (5.518s)
[276.733923] Starting dynamic subtest: gt1
[318.747166] Dynamic subtest gt1: SUCCESS (42.017s)
[318.749885] Subtest sysfs: SUCCESS (47.537s)
[318.828081] [059/131] (699s left) gem_lmem_swapping (parallel-random-engines)
[318.870874] Subtest parallel-random-engines: SKIP (0.000s)
[318.918075] [060/131] (699s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[319.027420] Starting subtest: fbcpsr-suspend
[358.996592] Subtest fbcpsr-suspend: SUCCESS (9.638s)
[359.157378] [061/131] (658s left) syncobj_timeline (single-wait-all-available-submitted)
[359.219858] Starting subtest: single-wait-all-available-submitted
[359.222713] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[359.334415] [062/131] (658s left) kms_pm_dc (dc6-dpms)
[360.450479] Starting subtest: dc6-dpms
[362.507455] Subtest dc6-dpms: SUCCESS (2.038s)
[362.588709] [063/131] (655s left) gem_eio (in-flight-contexts-1us)
[362.776201] Starting subtest: in-flight-contexts-1us
[376.064372] Subtest in-flight-contexts-1us: SUCCESS (13.236s)
[376.257247] [064/131] (641s left) kms_prop_blob (blob-prop-core)
[376.312281] Starting subtest: blob-prop-core
[376.314683] Subtest blob-prop-core: SUCCESS (0.000s)
[376.414701] [065/131] (641s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[376.504767] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[383.272191] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.761s)
[383.393040] [066/131] (634s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[383.494408] Starting subtest: primary-y-tiled-reflect-x-180
[383.554582] Subtest primary-y-tiled-reflect-x-180: SKIP (0.060s)
[383.660417] [067/131] (634s left) gen7_exec_parse (bitmasks)
[383.740737] Subtest bitmasks: SKIP (0.000s)
[383.821547] [068/131] (634s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[383.953306] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[392.675626] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (8.722s)
[393.533147] [069/131] (624s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[393.635875] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[393.640587] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[393.746446] [070/131] (624s left) i915_drm_fdinfo (virtual-busy-hang)
[393.787841] Starting subtest: virtual-busy-hang
[393.792538] Subtest virtual-busy-hang: SKIP (0.000s)
[393.859271] [071/131] (624s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[393.908723] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[393.913476] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[394.091941] [072/131] (624s left) kms_lease (implicit-plane-lease)
[394.186567] Starting subtest: implicit-plane-lease
[394.189168] Subtest implicit-plane-lease: SUCCESS (0.003s)
[394.282969] [073/131] (624s left) kms_draw_crc (draw-method-mmap-wc)
[394.375869] Starting subtest: draw-method-mmap-wc
[394.378500] Starting dynamic subtest: xrgb8888-untiled
[394.605739] Dynamic subtest xrgb8888-untiled: SUCCESS (0.232s)
[394.616432] Starting dynamic subtest: rgb565-untiled
[394.828116] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[394.838467] Starting dynamic subtest: xrgb2101010-untiled
[395.049722] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.220s)
[395.059493] Starting dynamic subtest: xbgr16161616f-untiled
[395.305106] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.255s)
[395.315000] Starting dynamic subtest: xrgb8888-xtiled
[395.437719] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[395.449470] Starting dynamic subtest: rgb565-xtiled
[395.559973] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[395.570106] Starting dynamic subtest: xrgb2101010-xtiled
[395.670887] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[395.682478] Starting dynamic subtest: xbgr16161616f-xtiled
[395.804344] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[395.814398] Starting dynamic subtest: xrgb8888-4tiled
[395.960201] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[395.970643] Starting dynamic subtest: rgb565-4tiled
[396.104164] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[396.114499] Starting dynamic subtest: xrgb2101010-4tiled
[396.238170] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[396.249735] Starting dynamic subtest: xbgr16161616f-4tiled
[396.404666] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.165s)
[396.406877] Subtest draw-method-mmap-wc: SUCCESS (2.034s)
[396.508220] [074/131] (622s left) kms_rotation_crc (sprite-rotation-180)
[396.614361] Starting subtest: sprite-rotation-180
[401.955451] Subtest sprite-rotation-180: SUCCESS (5.342s)
[403.190247] [075/131] (615s left) gem_eio (kms)
[403.454707] Starting subtest: kms
[425.347630] Subtest kms: SUCCESS (21.894s)
[426.519567] [076/131] (592s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[431.587441] Starting subtest: fbc-pr-cursor-plane-update-sf
[431.592398] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.002s)
[432.442201] [077/131] (586s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[432.544023] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[439.209539] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.667s)
[439.362371] [078/131] (579s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[439.468577] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[439.471613] Starting dynamic subtest: pipe-A-default-mode
[439.755713] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[439.760649] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.288s)
[440.565031] [079/131] (578s left) perf_pmu (render-node-busy)
[440.641835] Starting subtest: render-node-busy
[440.644975] Starting dynamic subtest: rcs0
[441.215707] Dynamic subtest rcs0: SUCCESS (0.573s)
[441.229008] Starting dynamic subtest: bcs0
[441.782573] Dynamic subtest bcs0: SUCCESS (0.565s)
[441.795516] Starting dynamic subtest: vcs0
[442.981765] Dynamic subtest vcs0: SUCCESS (1.195s)
[442.996469] Starting dynamic subtest: vcs1
[445.030134] Dynamic subtest vcs1: SUCCESS (2.045s)
[445.043345] Starting dynamic subtest: vecs0
[447.014384] Dynamic subtest vecs0: SUCCESS (1.981s)
[447.025741] Starting dynamic subtest: ccs0
[447.593590] Dynamic subtest ccs0: SUCCESS (0.578s)
[447.596629] Subtest render-node-busy: SUCCESS (6.951s)
[447.671515] [080/131] (571s left) gem_mmap (basic-small-bo)
[447.731048] Subtest basic-small-bo: SKIP (0.000s)
[447.793767] [081/131] (571s left) gem_exec_reloc (basic-cpu-noreloc)
[447.854526] Subtest basic-cpu-noreloc: SKIP (0.000s)
[447.929720] [082/131] (571s left) kms_3d
[450.321680] [083/131] (568s left) gem_userptr_blits (vma-merge)
[450.395835] Starting subtest: vma-merge
[450.440516] Subtest vma-merge: SUCCESS (0.044s)
[450.563469] [084/131] (568s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[450.621680] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[450.729479] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.109s)
[450.810254] [085/131] (568s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[450.904462] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[450.907019] Starting dynamic subtest: pipe-A-default-mode
[453.563408] Dynamic subtest pipe-A-default-mode: SUCCESS (2.654s)
[453.566006] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.656s)
[454.392223] [086/131] (564s left) kms_flip (nonblocking-read)
[454.485399] Starting subtest: nonblocking-read
[454.487742] Subtest nonblocking-read: SUCCESS (0.000s)
[454.605732] [087/131] (564s left) gem_create (create-ext-placement-all)
[454.772831] Starting subtest: create-ext-placement-all
[454.775464] Subtest create-ext-placement-all: SUCCESS (0.000s)
[454.883751] [088/131] (564s left) syncobj_wait (invalid-reset-one-illegal-handle)
[454.936636] Starting subtest: invalid-reset-one-illegal-handle
[454.939480] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[455.042221] [089/131] (564s left) kms_psr (fbc-psr2-suspend)
[455.149526] Starting subtest: fbc-psr2-suspend
[455.151578] Starting dynamic subtest: eDP-1
[455.155883] Dynamic subtest eDP-1: SKIP (0.000s)
[455.160488] Subtest fbc-psr2-suspend: SKIP (0.001s)
[455.223685] [090/131] (564s left) kms_cursor_edge_walk (64x64-left-edge)
[455.315823] Starting subtest: 64x64-left-edge
[455.318724] Starting dynamic subtest: pipe-A-eDP-1
[458.736749] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.420s)
[458.748130] Starting dynamic subtest: pipe-D-eDP-1
[461.909373] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.171s)
[461.911718] Subtest 64x64-left-edge: SUCCESS (6.593s)
[462.693237] [091/131] (556s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[462.795398] Starting subtest: y-tiled-32bpp-rotate-90
[462.800132] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[462.908211] [092/131] (556s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[463.004419] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[463.009638] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[463.091284] [093/131] (556s left) kms_cursor_crc (cursor-random-256x85)
[463.338525] Starting subtest: cursor-random-256x85
[463.384587] Subtest cursor-random-256x85: SKIP (0.039s)
[463.554110] [094/131] (555s left) kms_psr (psr2-primary-mmap-cpu)
[463.660144] Starting subtest: psr2-primary-mmap-cpu
[463.662432] Starting dynamic subtest: eDP-1
[465.452319] Dynamic subtest eDP-1: SUCCESS (1.789s)
[465.455172] Subtest psr2-primary-mmap-cpu: SUCCESS (1.790s)
[466.292747] [095/131] (553s left) syncobj_timeline (invalid-transfer-bad-pad)
[466.350310] Starting subtest: invalid-transfer-bad-pad
[466.352382] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[466.445825] [096/131] (553s left) gem_mmap_offset (perf)
[466.511552] Starting subtest: perf
[466.513646] Starting dynamic subtest: smem0
[466.866568] Dynamic subtest smem0: SUCCESS (0.353s)
[466.869691] Subtest perf: SUCCESS (0.354s)
[467.007027] [097/131] (552s left) gem_exercise_blt (fast-copy)
[467.073837] Starting subtest: fast-copy
[467.076467] Starting dynamic subtest: linear-smem-smem
[467.095154] Dynamic subtest linear-smem-smem: SUCCESS (0.024s)
[467.107350] Starting dynamic subtest: xmajor-smem-smem
[467.115309] Dynamic subtest xmajor-smem-smem: SUCCESS (0.019s)
[467.125531] Starting dynamic subtest: tile4-smem-smem
[467.132859] Dynamic subtest tile4-smem-smem: SUCCESS (0.018s)
[467.142866] Starting dynamic subtest: tile64-smem-smem
[467.151431] Dynamic subtest tile64-smem-smem: SUCCESS (0.018s)
[467.154134] Subtest fast-copy: SUCCESS (0.081s)
[467.277054] [098/131] (552s left) gem_basic (bad-close)
[467.332257] Starting subtest: bad-close
[467.337653] Subtest bad-close: SUCCESS (0.000s)
[467.444328] [099/131] (552s left) kms_flip (absolute-wf_vblank-interruptible)
[467.540760] Starting subtest: absolute-wf_vblank-interruptible
[467.543470] Starting dynamic subtest: A-eDP1
[476.319707] Dynamic subtest A-eDP1: SUCCESS (8.779s)
[476.331816] Starting dynamic subtest: B-eDP1
[485.015563] Dynamic subtest B-eDP1: SUCCESS (8.695s)
[485.027418] Starting dynamic subtest: C-eDP1
[493.704167] Dynamic subtest C-eDP1: SUCCESS (8.685s)
[493.720471] Starting dynamic subtest: D-eDP1
[502.401912] Dynamic subtest D-eDP1: SUCCESS (8.696s)
[502.407861] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.867s)
[503.590618] [100/131] (516s left) gem_exec_flush (basic-batch-kernel-default-uc)
[503.652857] Starting subtest: basic-batch-kernel-default-uc
[510.723854] Subtest basic-batch-kernel-default-uc: SUCCESS (7.072s)
[510.917687] [101/131] (508s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[511.026486] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[514.690555] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.669s)
[515.899089] [102/131] (503s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[516.003831] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[517.338899] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.337s)
[517.560956] [103/131] (502s left) gem_exec_reloc (basic-wc-active)
[517.616879] Subtest basic-wc-active: SKIP (0.000s)
[517.692853] [104/131] (502s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[517.800690] Starting subtest: extended-modeset-hang-oldfb-with-reset
[517.802855] Starting dynamic subtest: pipe-A
[529.333263] Dynamic subtest pipe-A: SUCCESS (11.529s)
[529.344279] Starting dynamic subtest: pipe-D
[541.626382] Dynamic subtest pipe-D: SUCCESS (12.289s)
[541.629041] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.822s)
[542.492042] [105/131] (477s left) kms_cursor_crc (cursor-suspend)
[542.633786] Starting subtest: cursor-suspend
[542.636326] Starting dynamic subtest: pipe-A-eDP-1
[575.086987] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.091s)
[575.098934] Starting dynamic subtest: pipe-D-eDP-1
[608.073781] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.628s)
[608.076442] Subtest cursor-suspend: SUCCESS (6.722s)
[608.961471] [106/131] (411s left) syncobj_wait (single-wait-all-for-submit-signaled)
[609.029130] Starting subtest: single-wait-all-for-submit-signaled
[609.031475] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[609.124252] [107/131] (410s left) syncobj_wait (multi-wait-submitted)
[609.178808] Starting subtest: multi-wait-submitted
[609.278414] Subtest multi-wait-submitted: SUCCESS (0.100s)
[609.358516] [108/131] (410s left) gem_render_copy (y-tiled)
[609.424193] Starting subtest: y-tiled
[609.429836] Subtest y-tiled: SKIP (0.000s)
[609.613544] [109/131] (410s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[609.708189] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[609.710713] Starting dynamic subtest: pipe-A-eDP-1
[609.734909] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[609.745943] Starting dynamic subtest: pipe-B-eDP-1
[609.770414] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[609.780988] Starting dynamic subtest: pipe-C-eDP-1
[609.806175] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[609.815984] Starting dynamic subtest: pipe-D-eDP-1
[609.841066] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[609.845734] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[611.994469] [110/131] (408s left) api_intel_allocator (reloc-allocator)
[612.058062] Starting subtest: reloc-allocator
[612.061069] Starting dynamic subtest: basic
[612.063892] Dynamic subtest basic: SUCCESS (0.004s)
[612.076653] Starting dynamic subtest: parallel-one
[612.078907] Dynamic subtest parallel-one: SUCCESS (0.008s)
[612.089731] Starting dynamic subtest: print
[612.092747] Dynamic subtest print: SUCCESS (0.000s)
[612.103227] Starting dynamic subtest: reuse
[612.106199] Dynamic subtest reuse: SUCCESS (0.000s)
[612.116679] Starting dynamic subtest: fork-reopen-allocator
[612.119344] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[612.121809] Subtest reloc-allocator: SUCCESS (0.027s)
[612.216836] [111/131] (408s left) kms_properties (crtc-properties-atomic)
[612.312675] Starting subtest: crtc-properties-atomic
[612.315211] Starting dynamic subtest: pipe-A-eDP-1
[612.775329] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.455s)
[612.786101] Starting dynamic subtest: pipe-B-eDP-1
[613.937661] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.151s)
[613.950806] Starting dynamic subtest: pipe-C-eDP-1
[615.144539] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.197s)
[615.155617] Starting dynamic subtest: pipe-D-eDP-1
[616.353040] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.199s)
[616.355796] Subtest crtc-properties-atomic: SUCCESS (4.009s)
[617.237853] [112/131] (403s left) gen9_exec_parse (bb-secure)
[617.309068] Subtest bb-secure: SKIP (0.000s)
[617.396291] [113/131] (402s left) gem_exec_schedule (fifo)
[617.467400] Starting subtest: fifo
[617.469349] Starting dynamic subtest: rcs0
[617.563586] Dynamic subtest rcs0: SUCCESS (0.105s)
[617.576475] Starting dynamic subtest: vcs0
[617.643100] Dynamic subtest vcs0: SUCCESS (0.079s)
[617.656033] Starting dynamic subtest: vcs1
[617.720797] Dynamic subtest vcs1: SUCCESS (0.076s)
[617.733034] Starting dynamic subtest: vecs0
[617.792689] Dynamic subtest vecs0: SUCCESS (0.071s)
[617.806295] Starting dynamic subtest: ccs0
[617.877594] Dynamic subtest ccs0: SUCCESS (0.084s)
[617.880458] Subtest fifo: SUCCESS (0.419s)
[618.823295] [114/131] (401s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[618.922272] Starting subtest: x-tiled-32bpp-rotate-180
[620.594608] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.668s)
[620.809090] [115/131] (399s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[620.915700] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[620.920647] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[621.030255] [116/131] (399s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[621.571235] Starting subtest: syncobj-timeline-invalid-flags
[621.574032] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[622.772809] [117/131] (397s left) kms_writeback (writeback-fb-id)
[622.878900] Subtest writeback-fb-id: SKIP (0.000s)
[622.928562] [118/131] (397s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[623.027741] Starting subtest: compare-crc-sanitycheck-nv12
[623.029902] Starting dynamic subtest: pipe-A-eDP-1
[623.724409] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.696s)
[623.734770] Starting dynamic subtest: pipe-B-eDP-1
[624.957959] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.227s)
[624.969061] Starting dynamic subtest: pipe-C-eDP-1
[626.124325] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.164s)
[626.134783] Starting dynamic subtest: pipe-D-eDP-1
[627.331324] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.202s)
[627.333910] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.295s)
[628.164845] [119/131] (392s left) gem_ctx_persistence (legacy-engines-mixed)
[628.224636] Starting subtest: legacy-engines-mixed
[628.227306] Starting dynamic subtest: render
[628.346301] Dynamic subtest render: SUCCESS (0.121s)
[628.359318] Starting dynamic subtest: bsd1
[628.423334] Dynamic subtest bsd1: SUCCESS (0.075s)
[628.436183] Starting dynamic subtest: bsd2
[628.493282] Dynamic subtest bsd2: SUCCESS (0.068s)
[628.506683] Starting dynamic subtest: blt
[628.565342] Dynamic subtest blt: SUCCESS (0.069s)
[628.578809] Starting dynamic subtest: vebox
[628.635392] Dynamic subtest vebox: SUCCESS (0.067s)
[628.638228] Subtest legacy-engines-mixed: SUCCESS (0.411s)
[628.716540] [120/131] (391s left) gem_exec_schedule (submit-early-slice)
[628.800776] Starting subtest: submit-early-slice
[628.803657] Starting dynamic subtest: rcs0
[628.838609] Dynamic subtest rcs0: SUCCESS (0.049s)
[628.856281] Starting dynamic subtest: bcs0
[628.879867] Dynamic subtest bcs0: SUCCESS (0.039s)
[628.892936] Starting dynamic subtest: vcs0
[628.927866] Dynamic subtest vcs0: SUCCESS (0.047s)
[628.939898] Starting dynamic subtest: vcs1
[628.966884] Dynamic subtest vcs1: SUCCESS (0.039s)
[628.977712] Starting dynamic subtest: vecs0
[629.003792] Dynamic subtest vecs0: SUCCESS (0.036s)
[629.013722] Starting dynamic subtest: ccs0
[629.042414] Dynamic subtest ccs0: SUCCESS (0.038s)
[629.044683] Subtest submit-early-slice: SUCCESS (0.253s)
[630.776037] [121/131] (389s left) kms_plane_scaling (planes-scaler-unity-scaling)
[630.878910] Starting subtest: planes-scaler-unity-scaling
[630.881440] Starting dynamic subtest: pipe-A
[630.963899] Dynamic subtest pipe-A: SUCCESS (0.085s)
[630.975180] Starting dynamic subtest: pipe-B
[632.163047] Dynamic subtest pipe-B: SUCCESS (1.197s)
[632.175627] Starting dynamic subtest: pipe-C
[633.351883] Dynamic subtest pipe-C: SUCCESS (1.186s)
[633.365336] Starting dynamic subtest: pipe-D
[634.441789] Dynamic subtest pipe-D: SUCCESS (1.088s)
[634.444228] Subtest planes-scaler-unity-scaling: SUCCESS (3.560s)
[635.570707] [122/131] (385s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[635.674647] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[644.158627] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.486s)
[644.295068] [123/131] (376s left) gem_ctx_persistence (heartbeat-hostile)
[644.361018] Starting subtest: heartbeat-hostile
[644.366654] Subtest heartbeat-hostile: SKIP (0.000s)
[644.467373] [124/131] (376s left) kms_plane (plane-position-hole)
[644.559697] Starting subtest: plane-position-hole
[645.089616] Starting dynamic subtest: pipe-A-plane-1
[646.358294] Dynamic subtest pipe-A-plane-1: SUCCESS (1.269s)
[646.369585] Starting dynamic subtest: pipe-A-plane-2
[647.619697] Dynamic subtest pipe-A-plane-2: SUCCESS (1.260s)
[647.631230] Starting dynamic subtest: pipe-A-plane-3
[648.907886] Dynamic subtest pipe-A-plane-3: SUCCESS (1.288s)
[648.919518] Starting dynamic subtest: pipe-A-plane-4
[650.194003] Dynamic subtest pipe-A-plane-4: SUCCESS (1.285s)
[650.205383] Starting dynamic subtest: pipe-A-plane-5
[650.234570] Dynamic subtest pipe-A-plane-5: SUCCESS (0.039s)
[651.424212] Starting dynamic subtest: pipe-B-plane-1
[652.693033] Dynamic subtest pipe-B-plane-1: SUCCESS (1.279s)
[652.704765] Starting dynamic subtest: pipe-B-plane-2
[654.015675] Dynamic subtest pipe-B-plane-2: SUCCESS (1.322s)
[654.027222] Starting dynamic subtest: pipe-B-plane-3
[655.344057] Dynamic subtest pipe-B-plane-3: SUCCESS (1.326s)
[655.355057] Starting dynamic subtest: pipe-B-plane-4
[656.615800] Dynamic subtest pipe-B-plane-4: SUCCESS (1.273s)
[656.627081] Starting dynamic subtest: pipe-B-plane-5
[656.661119] Dynamic subtest pipe-B-plane-5: SUCCESS (0.042s)
[656.663761] Subtest plane-position-hole: SUCCESS (12.099s)
[657.470543] [125/131] (363s left) vgem_basic (dmabuf-export)
[657.513299] Starting subtest: dmabuf-export
[657.535708] Subtest dmabuf-export: SUCCESS (0.026s)
[657.638450] [126/131] (363s left) gem_exec_balancer (sequential)
[657.696957] Starting subtest: sequential
[660.775354] Subtest sequential: SUCCESS (3.078s)
[661.112583] [127/131] (359s left) gem_pwrite (basic-exhaustion)
[661.179592] Subtest basic-exhaustion: SKIP (0.000s)
[661.245427] [128/131] (359s left) kms_psr (psr-primary-mmap-cpu)
[661.338540] Starting subtest: psr-primary-mmap-cpu
[661.341044] Starting dynamic subtest: eDP-1
[663.130362] Dynamic subtest eDP-1: SUCCESS (1.791s)
[663.132931] Subtest psr-primary-mmap-cpu: SUCCESS (1.792s)
[663.970280] [129/131] (357s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[664.080312] Starting subtest: 4-tiled-8bpp-rotate-270
[664.101367] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.021s)
[664.218372] [130/131] (356s left) gem_exec_schedule (u-semaphore-user)
[664.290027] Starting subtest: u-semaphore-user
[664.341960] Subtest u-semaphore-user: SUCCESS (0.058s)
[665.716051] [131/131] (355s left) vgem_basic (bad-handle)
[665.767964] Starting subtest: bad-handle
[665.771012] Subtest bad-handle: SUCCESS (0.000s)
[665.825969] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: kms_vblank
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: perf_pmu
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: i915_module_load
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_chamelium_frames
results: parsing output: 12/ for test: fbdev
results: parsing output: 13/ for test: kms_psr2_sf
results: parsing output: 14/ for test: gem_eio
results: parsing output: 15/ for test: gem_exec_params
results: parsing output: 16/ for test: kms_joiner
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: gem_mmap_gtt
results: parsing output: 21/ for test: gem_userptr_blits
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: gem_eio
results: parsing output: 24/ for test: gem_ppgtt
results: parsing output: 25/ for test: gem_flink_race
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: gem_mmap_gtt
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: gem_ctx_create
results: parsing output: 30/ for test: gem_render_copy
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: syncobj_basic
results: parsing output: 33/ for test: kms_addfb_basic
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_chamelium_hpd
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_mmap_gtt
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: gem_exec_params
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: gem_mmap_gtt
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: kms_plane_multiple
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: i915_power
results: parsing output: 46/ for test: sw_sync
results: parsing output: 47/ for test: kms_async_flips
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_scaling_modes
results: parsing output: 50/ for test: gem_exec_fence
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_chamelium_color
results: parsing output: 54/ for test: syncobj_eventfd
results: parsing output: 55/ for test: api_intel_bb
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: gem_ctx_freq
results: parsing output: 58/ for test: gem_lmem_swapping
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_pm_dc
results: parsing output: 62/ for test: gem_eio
results: parsing output: 63/ for test: kms_prop_blob
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_rotation_crc
results: parsing output: 66/ for test: gen7_exec_parse
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: i915_drm_fdinfo
results: parsing output: 70/ for test: gem_render_copy
results: parsing output: 71/ for test: kms_lease
results: parsing output: 72/ for test: kms_draw_crc
results: parsing output: 73/ for test: kms_rotation_crc
results: parsing output: 74/ for test: gem_eio
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_flip_scaled_crc
results: parsing output: 78/ for test: perf_pmu
results: parsing output: 79/ for test: gem_mmap
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: kms_3d
results: parsing output: 82/ for test: gem_userptr_blits
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: kms_flip_scaled_crc
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: gem_create
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_cursor_edge_walk
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: gem_mmap_offset
results: parsing output: 96/ for test: gem_exercise_blt
results: parsing output: 97/ for test: gem_basic
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: gem_exec_flush
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: gem_exec_reloc
results: parsing output: 103/ for test: kms_busy
results: parsing output: 104/ for test: kms_cursor_crc
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: gem_render_copy
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: api_intel_allocator
results: parsing output: 110/ for test: kms_properties
results: parsing output: 111/ for test: gen9_exec_parse
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_exec_fence
results: parsing output: 116/ for test: kms_writeback
results: parsing output: 117/ for test: kms_pipe_crc_basic
results: parsing output: 118/ for test: gem_ctx_persistence
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: kms_plane_scaling
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_ctx_persistence
results: parsing output: 123/ for test: kms_plane
results: parsing output: 124/ for test: vgem_basic
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: gem_pwrite
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: gem_exec_schedule
results: parsing output: 130/ for test: vgem_basic
Done.