[57.535586] Initializing watchdogs
[57.535634]   /dev/watchdog0
[57.549340] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.553706] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.555895] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.559143] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[57.692557] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[57.696943] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[57.797726] [002/133] (960s left) vgem_basic (second-client)
[57.866767] Starting subtest: second-client
[57.888626] Subtest second-client: SUCCESS (0.022s)
[57.951597] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[57.954489] [003/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[58.056071] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[58.060041] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[58.158109] [004/133] (960s left) gem_madvise (dontneed-before-exec)
[58.196659] Starting subtest: dontneed-before-exec
[58.211774] Subtest dontneed-before-exec: SKIP (0.013s)
[58.272598] [005/133] (959s left) kms_async_flips (async-flip-suspend-resume)
[58.362926] Starting subtest: async-flip-suspend-resume
[58.752631] Starting dynamic subtest: pipe-A-eDP-1
[77.293920] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.776s)
[77.684979] Starting dynamic subtest: pipe-B-eDP-1
[95.281137] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.935s)
[95.652326] Starting dynamic subtest: pipe-C-eDP-1
[113.279473] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.020s)
[113.653639] Starting dynamic subtest: pipe-D-eDP-1
[131.277026] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.919s)
[131.279501] Subtest async-flip-suspend-resume: SUCCESS (14.181s)
[132.437847] [006/133] (885s left) perf_pmu (most-busy-idle-check-all)
[132.485542] Starting subtest: most-busy-idle-check-all
[132.488364] Starting dynamic subtest: rcs0
[133.952090] Dynamic subtest rcs0: SUCCESS (1.509s)
[133.963439] Starting dynamic subtest: bcs0
[135.936114] Dynamic subtest bcs0: SUCCESS (2.029s)
[135.947472] Starting dynamic subtest: vcs0
[137.982144] Dynamic subtest vcs0: SUCCESS (2.083s)
[137.993725] Starting dynamic subtest: vcs1
[139.966847] Dynamic subtest vcs1: SUCCESS (2.011s)
[139.978552] Starting dynamic subtest: vecs0
[141.950539] Dynamic subtest vecs0: SUCCESS (2.004s)
[141.962411] Starting dynamic subtest: ccs0
[143.937353] Dynamic subtest ccs0: SUCCESS (2.002s)
[143.940293] Subtest most-busy-idle-check-all: SUCCESS (11.645s)
[144.050953] [007/133] (874s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[144.104164] Starting subtest: multi-wait-all-available-submitted-signaled
[144.106732] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[144.204362] [008/133] (874s left) kms_chamelium_hpd (hdmi-hpd)
[144.584698] Subtest hdmi-hpd: SKIP (0.000s)
[145.435409] [009/133] (872s left) perf_pmu (busy-double-start)
[145.479722] Starting subtest: busy-double-start
[145.482171] Starting dynamic subtest: rcs0
[149.134435] Dynamic subtest rcs0: FAIL (3.608s)
[149.143572] Starting dynamic subtest: bcs0
[152.648062] Dynamic subtest bcs0: SUCCESS (3.591s)
[152.658810] Starting dynamic subtest: vcs0
[156.504055] Dynamic subtest vcs0: SUCCESS (3.863s)
[156.514706] Starting dynamic subtest: vcs1
[160.463446] Dynamic subtest vcs1: SUCCESS (3.964s)
[160.474736] Starting dynamic subtest: vecs0
[164.499197] Dynamic subtest vecs0: SUCCESS (4.034s)
[164.510733] Starting dynamic subtest: ccs0
[168.151700] Dynamic subtest ccs0: FAIL (3.565s)
[168.154521] Subtest busy-double-start: FAIL (22.629s)
[168.199588] [010/133] (850s left) gem_ctx_persistence (many-contexts)
[168.266740] Starting subtest: many-contexts
[205.936990] Subtest many-contexts: SUCCESS (37.669s)
[206.019433] [011/133] (812s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[206.131137] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[213.001003] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.872s)
[213.139975] [012/133] (805s left) gem_exec_schedule (out-order)
[213.218402] Starting subtest: out-order
[213.221624] Starting dynamic subtest: rcs0
[213.306490] Dynamic subtest rcs0: SUCCESS (0.098s)
[213.318259] Starting dynamic subtest: vcs0
[213.393133] Dynamic subtest vcs0: SUCCESS (0.086s)
[213.404603] Starting dynamic subtest: vcs1
[213.478691] Dynamic subtest vcs1: SUCCESS (0.086s)
[213.489032] Starting dynamic subtest: vecs0
[213.570033] Dynamic subtest vecs0: SUCCESS (0.091s)
[213.581727] Starting dynamic subtest: ccs0
[213.654068] Dynamic subtest ccs0: SUCCESS (0.084s)
[213.657293] Subtest out-order: SUCCESS (0.447s)
[215.075521] [013/133] (803s left) gem_mmap_gtt (medium-copy)
[215.134531] Subtest medium-copy: SKIP (0.000s)
[215.194845] [014/133] (803s left) gem_mmap_offset (close-race)
[215.246349] Starting subtest: close-race
[235.354265] Subtest close-race: SUCCESS (20.108s)
[235.485482] [015/133] (783s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[235.578209] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[235.580769] Starting dynamic subtest: pipe-A-eDP-1
[235.591446] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[235.601678] Starting dynamic subtest: pipe-B-eDP-1
[235.611747] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[235.620679] Starting dynamic subtest: pipe-C-eDP-1
[235.630741] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[235.639550] Starting dynamic subtest: pipe-D-eDP-1
[235.649634] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[235.654827] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[237.882278] [016/133] (780s left) kms_psr (fbc-psr2-dpms)
[237.980434] Starting subtest: fbc-psr2-dpms
[237.982647] Starting dynamic subtest: eDP-1
[237.987497] Dynamic subtest eDP-1: SKIP (0.000s)
[237.992478] Subtest fbc-psr2-dpms: SKIP (0.000s)
[238.050559] [017/133] (780s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[238.152220] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[242.612303] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.463s)
[243.780785] [018/133] (774s left) gem_vm_create (isolation)
[243.843086] Starting subtest: isolation
[243.851329] Subtest isolation: SUCCESS (0.009s)
[243.965893] [019/133] (774s left) kms_hdr (static-toggle-dpms)
[244.058961] Starting subtest: static-toggle-dpms
[244.066293] Subtest static-toggle-dpms: SKIP (0.000s)
[244.135855] [020/133] (774s left) gem_exec_balancer (sequential)
[244.198569] Starting subtest: sequential
[247.901427] Subtest sequential: SUCCESS (3.700s)
[248.236275] [021/133] (770s left) kms_chamelium_audio (hdmi-audio-edid)
[248.616413] Subtest hdmi-audio-edid: SKIP (0.000s)
[249.384889] [022/133] (769s left) kms_pm_rpm (legacy-planes)
[251.136778] Starting subtest: legacy-planes
[251.139606] Starting dynamic subtest: plane-64
[259.708146] Dynamic subtest plane-64: SUCCESS (8.574s)
[259.717741] Starting dynamic subtest: plane-94
[268.001739] Dynamic subtest plane-94: SUCCESS (8.292s)
[268.012536] Starting dynamic subtest: plane-124
[276.290342] Dynamic subtest plane-124: SUCCESS (8.287s)
[276.302722] Starting dynamic subtest: plane-134
[284.591130] Dynamic subtest plane-134: SUCCESS (8.300s)
[284.593976] Subtest legacy-planes: SUCCESS (33.460s)
[284.987101] [023/133] (733s left) kms_prop_blob (blob-prop-lifetime)
[285.048703] Starting subtest: blob-prop-lifetime
[285.051246] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[285.143524] [024/133] (733s left) gem_ctx_param (invalid-set-ringsize)
[285.193896] Starting subtest: invalid-set-ringsize
[285.196581] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[285.267702] [025/133] (733s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[285.380535] Starting subtest: y-tiled-32bpp-rotate-0
[285.385490] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[285.483493] [026/133] (733s left) gem_reg_read (bad-register)
[285.550627] Starting subtest: bad-register
[285.553588] Subtest bad-register: SUCCESS (0.000s)
[285.648302] [027/133] (733s left) kms_addfb_basic (bad-pitch-63)
[285.705742] Starting subtest: bad-pitch-63
[285.708259] Subtest bad-pitch-63: SUCCESS (0.000s)
[285.834239] [028/133] (733s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[285.890571] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[285.995115] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.104s)
[286.073939] [029/133] (733s left) i915_pm_freq_api (freq-reset-multiple)
[286.135605] Starting subtest: freq-reset-multiple
[286.138591] Starting dynamic subtest: gt0
[295.940696] Dynamic subtest gt0: SUCCESS (9.806s)
[295.950427] Starting dynamic subtest: gt1
[304.452423] Dynamic subtest gt1: SUCCESS (8.511s)
[304.455172] Subtest freq-reset-multiple: SUCCESS (18.319s)
[304.531021] [030/133] (714s left) kms_addfb_basic (unused-handle)
[304.591414] Starting subtest: unused-handle
[304.593628] Subtest unused-handle: SUCCESS (0.000s)
[304.721629] [031/133] (714s left) i915_pm_rpm (gem-mmap-type)
[306.251980] Starting subtest: gem-mmap-type
[306.254873] Starting dynamic subtest: wb-smem0
[310.104583] Dynamic subtest wb-smem0: SUCCESS (3.855s)
[310.113422] Starting dynamic subtest: wc-smem0
[313.261204] Dynamic subtest wc-smem0: SUCCESS (3.159s)
[313.271203] Starting dynamic subtest: uc-smem0
[317.701494] Dynamic subtest uc-smem0: SUCCESS (4.439s)
[317.704308] Subtest gem-mmap-type: SUCCESS (11.455s)
[317.807215] [032/133] (701s left) gem_mmap_gtt (fault-concurrent-x)
[317.865353] Subtest fault-concurrent-X: SKIP (0.000s)
[317.933406] [033/133] (701s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[318.004732] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[318.094869] [034/133] (701s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[318.186484] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[321.924126] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.743s)
[323.072390] [035/133] (696s left) kms_dp_link_training (non-uhbr-mst)
[323.161961] Starting subtest: non-uhbr-mst
[323.172634] Subtest non-uhbr-mst: SKIP (0.000s)
[323.237479] [036/133] (696s left) sw_sync (sync_multi_consumer_producer)
[323.279755] Starting subtest: sync_multi_consumer_producer
[323.615535] Subtest sync_multi_consumer_producer: SUCCESS (0.339s)
[323.679095] [037/133] (695s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[323.774595] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[323.777377] Starting dynamic subtest: pipe-A-eDP-1
[334.481337] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.713s)
[334.494540] Starting dynamic subtest: pipe-B-eDP-1
[345.888040] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.405s)
[345.890360] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.121s)
[346.715968] [038/133] (672s left) kms_lease (implicit-plane-lease)
[346.807464] Starting subtest: implicit-plane-lease
[346.810026] Subtest implicit-plane-lease: SUCCESS (0.003s)
[346.928422] [039/133] (672s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[347.030647] Starting subtest: fbc-rgb565-draw-mmap-wc
[351.019607] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (3.993s)
[352.213087] [040/133] (667s left) kms_psr (fbc-psr-dpms)
[352.325842] Starting subtest: fbc-psr-dpms
[352.328712] Starting dynamic subtest: eDP-1
[352.333955] Dynamic subtest eDP-1: SKIP (0.000s)
[352.339388] Subtest fbc-psr-dpms: SKIP (0.001s)
[352.400188] [041/133] (667s left) gen9_exec_parse (bb-oversize)
[352.462531] Subtest bb-oversize: SKIP (0.000s)
[352.541336] [042/133] (667s left) kms_scaling_modes (scaling-mode-none)
[352.635434] Starting subtest: scaling-mode-none
[352.638114] Starting dynamic subtest: pipe-A-eDP-1
[352.735843] Dynamic subtest pipe-A-eDP-1: SKIP (0.097s)
[352.747464] Starting dynamic subtest: pipe-B-eDP-1
[352.801073] Dynamic subtest pipe-B-eDP-1: SKIP (0.063s)
[352.812352] Starting dynamic subtest: pipe-C-eDP-1
[352.857907] Dynamic subtest pipe-C-eDP-1: SKIP (0.054s)
[352.867536] Starting dynamic subtest: pipe-D-eDP-1
[352.891492] Dynamic subtest pipe-D-eDP-1: SKIP (0.033s)
[352.896376] Subtest scaling-mode-none: SKIP (0.254s)
[353.010033] [043/133] (666s left) i915_selftest (live)
[354.732406] Starting subtest: live
[354.734986] Starting dynamic subtest: sanitycheck
[358.282895] Dynamic subtest sanitycheck: SUCCESS (3.549s)
[358.292960] Starting dynamic subtest: uncore
[361.759827] Dynamic subtest uncore: SUCCESS (3.475s)
[361.769671] Starting dynamic subtest: workarounds
[365.760000] Dynamic subtest workarounds: SUCCESS (3.998s)
[365.769621] Starting dynamic subtest: gt_engines
[369.684734] Dynamic subtest gt_engines: SUCCESS (3.923s)
[369.694609] Starting dynamic subtest: gt_timelines
[386.839559] Dynamic subtest gt_timelines: SUCCESS (17.150s)
[386.849549] Starting dynamic subtest: gt_contexts
[391.971378] Dynamic subtest gt_contexts: SUCCESS (5.129s)
[391.981012] Starting dynamic subtest: gt_lrc
[397.137398] Dynamic subtest gt_lrc: SUCCESS (5.165s)
[397.152334] Starting dynamic subtest: gt_mocs
[400.937109] Dynamic subtest gt_mocs: SUCCESS (3.798s)
[400.945613] Starting dynamic subtest: gt_pm
[406.626194] Dynamic subtest gt_pm: SUCCESS (5.686s)
[406.635549] Starting dynamic subtest: gt_heartbeat
[410.206920] Dynamic subtest gt_heartbeat: SUCCESS (3.579s)
[410.221608] Starting dynamic subtest: gt_tlb
[420.507275] Dynamic subtest gt_tlb: SUCCESS (10.298s)
[420.516079] Starting dynamic subtest: requests
[432.733693] Dynamic subtest requests: SUCCESS (12.225s)
[432.743035] Starting dynamic subtest: migrate
[439.196105] Dynamic subtest migrate: SUCCESS (6.462s)
[439.205904] Starting dynamic subtest: active
[442.767723] Dynamic subtest active: SUCCESS (3.569s)
[442.777088] Starting dynamic subtest: objects
[446.799034] Dynamic subtest objects: SUCCESS (4.031s)
[446.809548] Starting dynamic subtest: mman
[450.917638] Dynamic subtest mman: SUCCESS (4.116s)
[450.925701] Starting dynamic subtest: dmabuf
[454.484571] Dynamic subtest dmabuf: SUCCESS (3.566s)
[454.494356] Starting dynamic subtest: vma
[459.663518] Dynamic subtest vma: SUCCESS (5.178s)
[459.673965] Starting dynamic subtest: coherency
[464.084996] Dynamic subtest coherency: SUCCESS (4.420s)
[464.095170] Starting dynamic subtest: gtt
[474.391098] Dynamic subtest gtt: SUCCESS (10.306s)
[474.400972] Starting dynamic subtest: gem
[482.591198] Dynamic subtest gem: SUCCESS (8.199s)
[482.603592] Starting dynamic subtest: evict
[487.520228] Dynamic subtest evict: SUCCESS (4.927s)
[487.534629] Starting dynamic subtest: hugepages
[499.119035] Dynamic subtest hugepages: SUCCESS (11.599s)
[499.129420] Starting dynamic subtest: gem_contexts
[528.925678] Dynamic subtest gem_contexts: SUCCESS (29.808s)
[528.938636] Starting dynamic subtest: client
[534.202971] Dynamic subtest client: SUCCESS (5.277s)
[534.212728] Starting dynamic subtest: gem_migrate
[537.765558] Dynamic subtest gem_migrate: SUCCESS (3.560s)
[537.775395] Starting dynamic subtest: reset
[541.402140] Dynamic subtest reset: SUCCESS (3.636s)
[541.411957] Starting dynamic subtest: memory_region
[544.943770] Dynamic subtest memory_region: SUCCESS (3.540s)
[544.953239] Starting dynamic subtest: hangcheck
[558.805957] Dynamic subtest hangcheck: SUCCESS (13.863s)
[558.815719] Starting dynamic subtest: execlists
[563.979978] Dynamic subtest execlists: SUCCESS (5.174s)
[563.990283] Starting dynamic subtest: ring_submission
[567.538481] Dynamic subtest ring_submission: SUCCESS (3.558s)
[567.547380] Starting dynamic subtest: perf
[571.187620] Dynamic subtest perf: SUCCESS (3.649s)
[571.197843] Starting dynamic subtest: slpc
[586.151057] Dynamic subtest slpc: SUCCESS (14.964s)
[586.161585] Starting dynamic subtest: guc
[590.923191] Dynamic subtest guc: SUCCESS (4.771s)
[590.932742] Starting dynamic subtest: guc_multi_lrc
[594.446047] Dynamic subtest guc_multi_lrc: SUCCESS (3.522s)
[594.461715] Starting dynamic subtest: guc_hang
[598.745865] Dynamic subtest guc_hang: SUCCESS (4.298s)
[598.755136] Starting dynamic subtest: late_gt_pm
[602.379712] Dynamic subtest late_gt_pm: SUCCESS (3.633s)
[602.382388] Subtest live: SUCCESS (247.656s)
[602.411080] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[602.411849] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[602.415200] [044/133] (417s left) syncobj_wait (invalid-reset-bad-pad)
[604.822597] Starting subtest: invalid-reset-bad-pad
[604.825562] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[604.910613] [FACT syncobj_wait (invalid-reset-bad-pad)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[604.911937] [FACT syncobj_wait (invalid-reset-bad-pad)] new: kernel.kmod_is_loaded.i915: true
[604.915975] [045/133] (415s left) api_intel_bb (lot-of-buffers)
[604.974468] Starting subtest: lot-of-buffers
[606.061639] Subtest lot-of-buffers: SUCCESS (1.089s)
[606.523466] [046/133] (413s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[606.622396] Starting subtest: 4-tiled-64bpp-rotate-270
[606.656318] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.033s)
[606.773755] [047/133] (413s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[606.874685] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[606.879588] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[606.975905] [048/133] (413s left) kms_content_protection (uevent-hdcp14)
[607.119720] Starting subtest: uevent-hdcp14
[607.125012] Subtest uevent-hdcp14: SKIP (0.000s)
[607.241756] [049/133] (412s left) kms_psr (fbc-psr-suspend)
[607.348759] Starting subtest: fbc-psr-suspend
[607.351539] Starting dynamic subtest: eDP-1
[607.357130] Dynamic subtest eDP-1: SKIP (0.000s)
[607.362474] Subtest fbc-psr-suspend: SKIP (0.001s)
[607.435496] [050/133] (412s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[607.490870] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[607.493427] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[607.599722] [051/133] (412s left) dmabuf_sync_file (export-wait-after-attach)
[607.653390] Starting subtest: export-wait-after-attach
[607.655449] Subtest export-wait-after-attach: SUCCESS (0.001s)
[607.709335] [052/133] (412s left) kms_big_fb (x-tiled-addfb-size-overflow)
[607.811569] Starting subtest: x-tiled-addfb-size-overflow
[607.814357] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[607.899120] [053/133] (412s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[607.958404] Starting subtest: etime-single-wait-for-submit-unsubmitted
[608.057711] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[608.179734] [054/133] (412s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[608.281375] Starting subtest: plane-primary-overlay-mutable-zpos
[611.735734] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.452s)
[612.920334] [055/133] (407s left) vgem_basic (dmabuf-fence)
[612.964620] Starting subtest: dmabuf-fence
[612.967413] Subtest dmabuf-fence: SUCCESS (0.000s)
[613.060106] [056/133] (407s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[613.176403] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[613.181190] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[613.278206] [057/133] (407s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[613.364920] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[613.369996] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[613.455059] [058/133] (407s left) gem_exec_schedule (u-submit-golden-slice)
[613.532265] Starting subtest: u-submit-golden-slice
[613.534719] Starting dynamic subtest: rcs0
[613.562581] Dynamic subtest rcs0: SUCCESS (0.038s)
[613.572543] Starting dynamic subtest: bcs0
[613.593940] Dynamic subtest bcs0: SUCCESS (0.030s)
[613.606294] Starting dynamic subtest: vcs0
[613.636287] Dynamic subtest vcs0: SUCCESS (0.042s)
[613.645742] Starting dynamic subtest: vcs1
[613.672596] Dynamic subtest vcs1: SUCCESS (0.036s)
[613.683000] Starting dynamic subtest: vecs0
[613.699731] Dynamic subtest vecs0: SUCCESS (0.027s)
[613.709097] Starting dynamic subtest: ccs0
[613.731077] Dynamic subtest ccs0: SUCCESS (0.030s)
[613.733900] Subtest u-submit-golden-slice: SUCCESS (0.206s)
[615.061107] [059/133] (405s left) gem_userptr_blits (coherency-sync)
[615.134699] Starting subtest: coherency-sync
[616.075562] Subtest coherency-sync: SKIP (0.893s)
[616.172147] [060/133] (404s left) kms_flip (dpms-vs-vblank-race)
[616.329965] Starting subtest: dpms-vs-vblank-race
[616.332247] Starting dynamic subtest: A-eDP1
[621.328765] Dynamic subtest A-eDP1: SUCCESS (4.997s)
[621.338378] Starting dynamic subtest: B-eDP1
[625.978006] Dynamic subtest B-eDP1: SUCCESS (4.643s)
[625.989706] Starting dynamic subtest: C-eDP1
[630.591932] Dynamic subtest C-eDP1: SUCCESS (4.611s)
[630.605128] Starting dynamic subtest: D-eDP1
[635.254452] Dynamic subtest D-eDP1: SUCCESS (4.658s)
[635.256955] Subtest dpms-vs-vblank-race: SUCCESS (18.918s)
[636.130005] [061/133] (384s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[636.238186] Starting subtest: primary-yf-tiled-reflect-x-270
[636.243461] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[636.323961] [062/133] (384s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[636.418219] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[636.420433] Starting dynamic subtest: pipe-A
[636.480627] Dynamic subtest pipe-A: SUCCESS (0.065s)
[636.491762] Starting dynamic subtest: pipe-B
[637.657293] Dynamic subtest pipe-B: SUCCESS (1.175s)
[637.668590] Starting dynamic subtest: pipe-C
[638.763478] Dynamic subtest pipe-C: SUCCESS (1.103s)
[638.774419] Starting dynamic subtest: pipe-D
[639.888491] Dynamic subtest pipe-D: SUCCESS (1.124s)
[639.891397] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.471s)
[641.044388] [063/133] (379s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[641.157507] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[641.162546] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[641.228365] [064/133] (379s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[641.293515] Starting subtest: yf-tiled-to-vebox-x-tiled
[641.298220] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[641.473932] [065/133] (379s left) sysfs_heartbeat_interval (nopreempt)
[641.541395] Starting subtest: nopreempt
[641.544610] Starting dynamic subtest: vecs0
[650.943747] Dynamic subtest vecs0: SUCCESS (9.395s)
[650.959054] Starting dynamic subtest: ccs0
[654.915425] Dynamic subtest ccs0: SUCCESS (3.970s)
[654.929272] Starting dynamic subtest: vcs0
[664.956139] Dynamic subtest vcs0: SUCCESS (10.034s)
[664.967964] Starting dynamic subtest: bcs0
[668.921468] Dynamic subtest bcs0: SUCCESS (3.964s)
[668.933565] Starting dynamic subtest: rcs0
[672.972720] Dynamic subtest rcs0: SUCCESS (4.049s)
[672.982740] Starting dynamic subtest: vcs1
[682.939451] Dynamic subtest vcs1: SUCCESS (9.960s)
[682.942634] Subtest nopreempt: SUCCESS (41.383s)
[683.020985] [066/133] (337s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[683.127306] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[690.110150] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.984s)
[690.265860] [067/133] (330s left) kms_color (ctm-blue-to-red)
[690.359478] Starting subtest: ctm-blue-to-red
[690.361629] Starting dynamic subtest: pipe-A-eDP-1
[691.057366] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.698s)
[691.068116] Starting dynamic subtest: pipe-B-eDP-1
[692.488857] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.429s)
[692.499009] Starting dynamic subtest: pipe-C-eDP-1
[693.866517] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.379s)
[693.876617] Starting dynamic subtest: pipe-D-eDP-1
[695.167981] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.301s)
[695.170621] Subtest ctm-blue-to-red: SUCCESS (4.810s)
[696.002158] [068/133] (325s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[696.106633] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[696.109459] Starting dynamic subtest: pipe-A-eDP-1
[696.133010] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[696.144570] Starting dynamic subtest: pipe-B-eDP-1
[696.167470] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[696.176613] Starting dynamic subtest: pipe-C-eDP-1
[696.199431] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[696.211227] Starting dynamic subtest: pipe-D-eDP-1
[696.234588] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[696.236963] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[698.365419] [069/133] (322s left) gem_create (create-ext-set-pat)
[698.545754] Starting subtest: create-ext-set-pat
[698.548348] Subtest create-ext-set-pat: SUCCESS (0.001s)
[698.647641] [070/133] (322s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[698.749638] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[698.754310] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[698.840152] [071/133] (322s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[698.943814] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[698.946425] Starting dynamic subtest: pipe-A-eDP-1
[698.973381] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[698.985718] Starting dynamic subtest: pipe-B-eDP-1
[699.010450] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[699.020083] Starting dynamic subtest: pipe-C-eDP-1
[699.042875] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[699.051639] Starting dynamic subtest: pipe-D-eDP-1
[699.075235] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[699.079513] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[701.245038] [072/133] (319s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[701.348478] Starting subtest: plane-all-modeset-transition-fencing
[701.353504] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[701.433145] [073/133] (319s left) gem_ctx_bad_destroy (double-destroy)
[701.484615] Starting subtest: double-destroy
[701.487693] Subtest double-destroy: SUCCESS (0.000s)
[701.560008] [074/133] (319s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[701.651612] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[701.656724] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[701.732196] [075/133] (319s left) prime_vgem (basic-fence-flip)
[701.794707] Starting subtest: basic-fence-flip
[702.127094] Subtest basic-fence-flip: SUCCESS (0.333s)
[702.239306] [076/133] (319s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[702.339993] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[702.345208] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[702.431969] [077/133] (318s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[702.529217] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[702.533954] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[702.623693] [078/133] (318s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[702.720913] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[702.724895] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[702.831589] [079/133] (318s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[702.928622] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[710.020985] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.094s)
[710.125787] [080/133] (311s left) kms_rotation_crc (sprite-rotation-90)
[710.218477] Starting subtest: sprite-rotation-90
[710.223246] Subtest sprite-rotation-90: SKIP (0.001s)
[710.292114] [081/133] (311s left) kms_plane (plane-position-hole)
[710.382360] Starting subtest: plane-position-hole
[710.918728] Starting dynamic subtest: pipe-A-plane-1
[712.257574] Dynamic subtest pipe-A-plane-1: SUCCESS (1.339s)
[712.267695] Starting dynamic subtest: pipe-A-plane-2
[713.567389] Dynamic subtest pipe-A-plane-2: SUCCESS (1.310s)
[713.577740] Starting dynamic subtest: pipe-A-plane-3
[714.906069] Dynamic subtest pipe-A-plane-3: SUCCESS (1.337s)
[714.916258] Starting dynamic subtest: pipe-A-plane-4
[716.246878] Dynamic subtest pipe-A-plane-4: SUCCESS (1.341s)
[716.258848] Starting dynamic subtest: pipe-A-plane-5
[716.274704] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[717.492915] Starting dynamic subtest: pipe-B-plane-1
[718.790434] Dynamic subtest pipe-B-plane-1: SUCCESS (1.308s)
[718.801284] Starting dynamic subtest: pipe-B-plane-2
[720.156989] Dynamic subtest pipe-B-plane-2: SUCCESS (1.365s)
[720.169014] Starting dynamic subtest: pipe-B-plane-3
[721.448880] Dynamic subtest pipe-B-plane-3: SUCCESS (1.290s)
[721.461473] Starting dynamic subtest: pipe-B-plane-4
[722.777683] Dynamic subtest pipe-B-plane-4: SUCCESS (1.330s)
[722.789700] Starting dynamic subtest: pipe-B-plane-5
[722.806976] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[722.809582] Subtest plane-position-hole: SUCCESS (12.424s)
[723.577590] [082/133] (298s left) gem_softpin (safe-alignment)
[723.633435] Starting subtest: safe-alignment
[723.660585] Subtest safe-alignment: SUCCESS (0.027s)
[724.969893] [083/133] (296s left) kms_psr (psr2-primary-mmap-cpu)
[725.067000] Starting subtest: psr2-primary-mmap-cpu
[725.069722] Starting dynamic subtest: eDP-1
[726.766455] Dynamic subtest eDP-1: SUCCESS (1.701s)
[726.769332] Subtest psr2-primary-mmap-cpu: SUCCESS (1.702s)
[727.648883] [084/133] (294s left) kms_vrr (flip-basic-fastset)
[727.751997] Starting subtest: flip-basic-fastset
[727.759573] Subtest flip-basic-fastset: SKIP (0.000s)
[727.827625] [085/133] (293s left) kms_pm_dc (dc6-dpms)
[728.933670] Starting subtest: dc6-dpms
[731.016023] Subtest dc6-dpms: SUCCESS (2.080s)
[731.108051] [086/133] (290s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[731.233475] Starting subtest: 2x-flip-vs-cursor-legacy
[731.238856] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[731.378230] [087/133] (290s left) fbdev (pan)
[731.414626] Starting subtest: pan
[731.449702] Subtest pan: SUCCESS (0.035s)
[731.523571] [088/133] (290s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[731.627311] Starting subtest: fbcpsr-indfb-scaledprimary
[737.412738] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.788s)
[737.537600] [089/133] (284s left) gem_huc_copy (huc-copy)
[737.609753] Starting subtest: huc-copy
[737.612508] Subtest huc-copy: SUCCESS (0.004s)
[737.740994] [090/133] (284s left) gem_exec_reloc (basic-wc-gtt-active)
[737.794494] Subtest basic-wc-gtt-active: SKIP (0.000s)
[737.880375] [091/133] (284s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[737.945516] Starting subtest: multi-wait-all-for-submit-unsubmitted
[738.049557] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[738.131475] [092/133] (283s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[738.223821] Starting subtest: crc-primary-suspend-y-tiled-ccs
[738.226647] Starting dynamic subtest: pipe-A-eDP-1
[738.236520] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[738.249445] Starting dynamic subtest: pipe-B-eDP-1
[738.259410] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[738.269413] Starting dynamic subtest: pipe-C-eDP-1
[738.278896] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[738.289174] Starting dynamic subtest: pipe-D-eDP-1
[738.298934] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[738.303557] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[740.459323] [093/133] (281s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[740.584621] Starting subtest: cursor-tearing-framebuffer-change
[740.587335] Starting dynamic subtest: pipe-A-eDP-1
[741.151257] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.563s)
[741.161529] Starting dynamic subtest: pipe-D-eDP-1
[742.390691] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.239s)
[742.393142] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.806s)
[743.222347] [094/133] (278s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[743.360439] Starting subtest: cursor-rapid-movement-32x32
[743.409233] Subtest cursor-rapid-movement-32x32: SKIP (0.043s)
[743.721250] [095/133] (278s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[743.815698] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[743.820501] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[743.921008] [096/133] (278s left) api_intel_allocator (standalone)
[743.979344] Starting subtest: standalone
[744.000387] Subtest standalone: SUCCESS (0.023s)
[744.113278] [097/133] (278s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[744.216230] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[752.995114] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.782s)
[753.176700] [098/133] (269s left) kms_fb_coherency (memset-crc)
[753.286616] Starting subtest: memset-crc
[753.289648] Starting dynamic subtest: mmap-offset-wc
[753.705347] Dynamic subtest mmap-offset-wc: SUCCESS (0.417s)
[754.009306] Starting dynamic subtest: mmap-offset-uc
[760.091723] Dynamic subtest mmap-offset-uc: SUCCESS (6.092s)
[760.376898] Subtest memset-crc: SUCCESS (7.089s)
[761.221514] [099/133] (261s left) perf (disabled-read-error)
[761.376725] Starting subtest: disabled-read-error
[761.391682] Subtest disabled-read-error: SUCCESS (0.017s)
[761.443771] [100/133] (260s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[761.538132] Starting subtest: fbcpsr-slowdraw
[786.744585] Subtest fbcpsr-slowdraw: SUCCESS (25.211s)
[786.869179] [101/133] (235s left) syncobj_timeline (wait-all-delayed-signal)
[786.933447] Starting subtest: wait-all-delayed-signal
[787.034371] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[787.115651] [102/133] (235s left) kms_plane_multiple (tiling-yf)
[787.218476] Starting subtest: tiling-yf
[787.223333] Subtest tiling-yf: SKIP (0.000s)
[787.292017] [103/133] (235s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[787.379579] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[787.382119] Starting dynamic subtest: pipe-A-eDP-1
[787.407210] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[787.417561] Starting dynamic subtest: pipe-B-eDP-1
[787.443737] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[787.453578] Starting dynamic subtest: pipe-C-eDP-1
[787.479507] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[787.489518] Starting dynamic subtest: pipe-D-eDP-1
[787.512929] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[787.517156] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[789.684297] [104/133] (232s left) kms_sequence (queue-busy)
[789.780288] Starting subtest: queue-busy
[789.783215] Starting dynamic subtest: pipe-A-eDP-1
[791.706721] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.927s)
[791.718597] Starting dynamic subtest: pipe-B-eDP-1
[794.295323] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.586s)
[794.312767] Starting dynamic subtest: pipe-C-eDP-1
[796.889152] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.595s)
[796.900695] Starting dynamic subtest: pipe-D-eDP-1
[799.443989] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.551s)
[799.446531] Subtest queue-busy: SUCCESS (9.664s)
[800.232737] [105/133] (222s left) gem_mmap_gtt (big-copy-xy)
[800.294739] Subtest big-copy-XY: SKIP (0.000s)
[800.357049] [106/133] (222s left) prime_vgem (shrink)
[800.425585] Starting subtest: shrink
[800.439367] Subtest shrink: SUCCESS (0.013s)
[800.550747] [107/133] (222s left) gem_eio (create)
[800.789558] Starting subtest: create
[801.122409] Subtest create: SUCCESS (0.330s)
[801.238601] [108/133] (221s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[801.342179] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[801.344248] Starting dynamic subtest: pipe-A-eDP-1
[801.403662] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[801.716890] Starting dynamic subtest: pipe-B-eDP-1
[802.528507] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.823s)
[802.813727] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.473s)
[803.711982] [109/133] (219s left) kms_fbcon_fbt (psr)
[803.771465] Starting subtest: psr
[811.145451] Subtest psr: SUCCESS (7.370s)
[811.222138] [110/133] (211s left) gem_close_race (basic-threads)
[811.281420] Starting subtest: basic-threads
[812.624348] Subtest basic-threads: SUCCESS (1.343s)
[812.825819] [111/133] (210s left) gem_exec_gttfill (engines)
[812.896110] Starting subtest: engines
[812.899018] Starting dynamic subtest: rcs0
[835.860497] Dynamic subtest rcs0: SUCCESS (22.965s)
[835.872169] Starting dynamic subtest: bcs0
[859.207757] Dynamic subtest bcs0: SUCCESS (23.345s)
[859.219562] Starting dynamic subtest: vcs0
[882.593260] Dynamic subtest vcs0: SUCCESS (23.379s)
[882.611615] Starting dynamic subtest: vcs1
[905.963329] Dynamic subtest vcs1: SUCCESS (23.365s)
[905.975055] Starting dynamic subtest: vecs0
[929.318907] Dynamic subtest vecs0: SUCCESS (23.351s)
[929.331852] Starting dynamic subtest: ccs0
[952.699667] Dynamic subtest ccs0: SUCCESS (23.376s)
[952.702547] Subtest engines: SUCCESS (139.796s)
[952.913523] [112/133] ( 70s left) gem_partial_pwrite_pread (writes-after-reads)
[953.010712] Subtest writes-after-reads: SKIP (0.000s)
[953.082532] [113/133] ( 69s left) kms_rotation_crc (sprite-rotation-180)
[953.192481] Starting subtest: sprite-rotation-180
[960.415428] Subtest sprite-rotation-180: SUCCESS (7.225s)
[961.598959] [114/133] ( 61s left) i915_drm_fdinfo (most-busy-check-all)
[961.649132] Starting subtest: most-busy-check-all
[961.651637] Starting dynamic subtest: rcs0
[961.657203] Dynamic subtest rcs0: SKIP (0.004s)
[961.668548] Starting dynamic subtest: bcs0
[961.674552] Dynamic subtest bcs0: SKIP (0.000s)
[961.684979] Starting dynamic subtest: vcs0
[961.689998] Dynamic subtest vcs0: SKIP (0.000s)
[961.699835] Starting dynamic subtest: vcs1
[961.704752] Dynamic subtest vcs1: SKIP (0.000s)
[961.714821] Starting dynamic subtest: vecs0
[961.719690] Dynamic subtest vecs0: SKIP (0.000s)
[961.731188] Starting dynamic subtest: ccs0
[961.736547] Dynamic subtest ccs0: SKIP (0.000s)
[961.741617] Subtest most-busy-check-all: SKIP (0.009s)
[961.783296] [115/133] ( 61s left) gem_exec_params (dr4-dirt)
[961.870523] Starting subtest: DR4-dirt
[961.873510] Subtest DR4-dirt: SUCCESS (0.000s)
[961.977342] [116/133] ( 61s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier)
[962.070000] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier
[962.074539] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s)
[962.144468] [117/133] ( 61s left) gem_exec_flush (basic-wb-ro-default)
[962.210128] Starting subtest: basic-wb-ro-default
[967.672626] Subtest basic-wb-ro-default: SUCCESS (5.464s)
[967.876010] [118/133] ( 55s left) gem_exec_flush (basic-wb-pro-default)
[967.944209] Starting subtest: basic-wb-pro-default
[973.436701] Subtest basic-wb-pro-default: SUCCESS (5.493s)
[973.630460] [119/133] ( 49s left) kms_cursor_crc (cursor-alpha-transparent)
[973.745475] Starting subtest: cursor-alpha-transparent
[973.748252] Starting dynamic subtest: pipe-A-eDP-1
[974.414252] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.669s)
[974.425236] Starting dynamic subtest: pipe-D-eDP-1
[975.674130] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.260s)
[975.676700] Subtest cursor-alpha-transparent: SUCCESS (1.932s)
[976.492226] [120/133] ( 46s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[976.592644] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[981.891283] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.303s)
[983.074688] [121/133] ( 40s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[983.463865] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[984.275208] [122/133] ( 39s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[984.382859] Starting subtest: x-tiled-64bpp-rotate-180
[986.012406] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.635s)
[986.180427] [123/133] ( 37s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[986.234901] Starting subtest: rel-constants-invalid-rel-gen5
[986.237539] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[986.319162] [124/133] ( 37s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[986.416361] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[986.418556] Starting dynamic subtest: pipe-A-eDP-1
[1002.907585] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.493s)
[1002.918838] Starting dynamic subtest: pipe-B-eDP-1
[1020.054504] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.148s)
[1020.057127] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.644s)
[1020.852274] [125/133] (  2s left) kms_pipe_crc_basic (nonblocking-crc)
[1020.949276] Starting subtest: nonblocking-crc
[1020.951974] Starting dynamic subtest: pipe-A-eDP-1
[1021.709328] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.760s)
[1021.721590] Starting dynamic subtest: pipe-B-eDP-1
[1023.192552] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.480s)
[1023.204425] Starting dynamic subtest: pipe-C-eDP-1
[1024.548957] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.358s)
[1024.560699] Starting dynamic subtest: pipe-D-eDP-1
[1025.892691] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.342s)
[1025.895614] Subtest nonblocking-crc: SUCCESS (4.946s)
[1026.685443] Overall timeout time exceeded, stopping.
[1026.701818] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: vgem_basic
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_madvise
results: parsing output: 4/ for test: kms_async_flips
results: parsing output: 5/ for test: perf_pmu
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_chamelium_hpd
results: parsing output: 8/ for test: perf_pmu
results: parsing output: 9/ for test: gem_ctx_persistence
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: gem_mmap_offset
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_vm_create
results: parsing output: 18/ for test: kms_hdr
results: parsing output: 19/ for test: gem_exec_balancer
results: parsing output: 20/ for test: kms_chamelium_audio
results: parsing output: 21/ for test: kms_pm_rpm
results: parsing output: 22/ for test: kms_prop_blob
results: parsing output: 23/ for test: gem_ctx_param
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: gem_reg_read
results: parsing output: 26/ for test: kms_addfb_basic
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: i915_pm_freq_api
results: parsing output: 29/ for test: kms_addfb_basic
results: parsing output: 30/ for test: i915_pm_rpm
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_dp_link_training
results: parsing output: 35/ for test: sw_sync
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_lease
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: gen9_exec_parse
results: parsing output: 41/ for test: kms_scaling_modes
results: parsing output: 42/ for test: i915_selftest
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: api_intel_bb
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_content_protection
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: dmabuf_sync_file
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_atomic
results: parsing output: 54/ for test: vgem_basic
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: gem_userptr_blits
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_rotation_crc
results: parsing output: 61/ for test: kms_plane_scaling
results: parsing output: 62/ for test: kms_flip_scaled_crc
results: parsing output: 63/ for test: gem_render_copy
results: parsing output: 64/ for test: sysfs_heartbeat_interval
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_color
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: gem_create
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_atomic_transition
results: parsing output: 72/ for test: gem_ctx_bad_destroy
results: parsing output: 73/ for test: kms_flip_scaled_crc
results: parsing output: 74/ for test: prime_vgem
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_rotation_crc
results: parsing output: 80/ for test: kms_plane
results: parsing output: 81/ for test: gem_softpin
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_vrr
results: parsing output: 84/ for test: kms_pm_dc
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: fbdev
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_huc_copy
results: parsing output: 89/ for test: gem_exec_reloc
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: api_intel_allocator
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_fb_coherency
results: parsing output: 98/ for test: perf
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_plane_multiple
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_sequence
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: prime_vgem
results: parsing output: 106/ for test: gem_eio
results: parsing output: 107/ for test: kms_atomic_transition
results: parsing output: 108/ for test: kms_fbcon_fbt
results: parsing output: 109/ for test: gem_close_race
results: parsing output: 110/ for test: gem_exec_gttfill
results: parsing output: 111/ for test: gem_partial_pwrite_pread
results: parsing output: 112/ for test: kms_rotation_crc
results: parsing output: 113/ for test: i915_drm_fdinfo
results: parsing output: 114/ for test: gem_exec_params
results: parsing output: 115/ for test: kms_plane
results: parsing output: 116/ for test: gem_exec_flush
results: parsing output: 117/ for test: gem_exec_flush
results: parsing output: 118/ for test: kms_cursor_crc
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_chamelium_edid
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_exec_params
results: parsing output: 123/ for test: kms_psr2_sf
results: parsing output: 124/ for test: kms_pipe_crc_basic
results: parsing output: 125/ for test: gem_exec_balancer
results: no output, setting notrun
results: parsing output: 126/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 127/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 129/ for test: gem_pxp
results: no output, setting notrun
results: parsing output: 130/ for test: gem_exec_schedule
results: no output, setting notrun
results: parsing output: 131/ for test: gem_exec_fence
results: no output, setting notrun
results: parsing output: 132/ for test: gem_mmap_wc
results: no output, setting notrun
Done.