[66.249950] Initializing watchdogs
[66.250024]   /dev/watchdog0
[66.270937] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[66.281679] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[66.285234] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[66.287984] [001/156] (960s left) api_intel_bb (blit-noreloc-keep-cache)
[66.364551] Starting subtest: blit-noreloc-keep-cache
[66.403704] Subtest blit-noreloc-keep-cache: SUCCESS (0.040s)
[66.572487] [002/156] (960s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[66.642202] Starting subtest: single-wait-for-submit-available-submitted
[66.643158] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.001s)
[66.854188] [003/156] (960s left) gem_mmap (big-bo)
[67.155212] Subtest big-bo: SKIP (0.000s)
[67.468339] [004/156] (959s left) gem_mmap_gtt (basic-small-copy-xy)
[67.665510] Subtest basic-small-copy-XY: SKIP (0.000s)
[67.841650] [005/156] (959s left) i915_drm_fdinfo (busy-check-all)
[67.924379] Starting subtest: busy-check-all
[67.925323] Starting dynamic subtest: rcs0
[67.957482] Dynamic subtest rcs0: SKIP (0.033s)
[67.966666] Starting dynamic subtest: bcs0
[67.968909] Dynamic subtest bcs0: SKIP (0.001s)
[67.977378] Starting dynamic subtest: vcs0
[67.980554] Dynamic subtest vcs0: SKIP (0.000s)
[67.988998] Starting dynamic subtest: vcs1
[67.991209] Dynamic subtest vcs1: SKIP (0.000s)
[67.999592] Starting dynamic subtest: vecs0
[68.001876] Dynamic subtest vecs0: SKIP (0.000s)
[68.010340] Starting dynamic subtest: vecs1
[68.012812] Dynamic subtest vecs1: SKIP (0.000s)
[68.021214] Starting dynamic subtest: ccs0
[68.023616] Dynamic subtest ccs0: SKIP (0.000s)
[68.025841] Subtest busy-check-all: SKIP (0.037s)
[68.096017] [006/156] (959s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[68.203082] Subtest tiled-to-untiled: SKIP (0.000s)
[68.321497] [007/156] (958s left) gem_ctx_param (get-priority-new-ctx)
[68.397388] Starting subtest: get-priority-new-ctx
[68.399273] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[68.537386] [008/156] (958s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[68.733380] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[69.844797] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.123s)
[70.057390] [009/156] (957s left) gem_exec_schedule (noreorder)
[70.266878] Starting subtest: noreorder
[70.268224] Starting dynamic subtest: rcs0
[70.385359] Dynamic subtest rcs0: SUCCESS (0.121s)
[70.396580] Starting dynamic subtest: bcs0
[70.444420] Dynamic subtest bcs0: SUCCESS (0.059s)
[70.458546] Starting dynamic subtest: vcs0
[70.499908] Dynamic subtest vcs0: SUCCESS (0.055s)
[70.512275] Starting dynamic subtest: vcs1
[70.558589] Dynamic subtest vcs1: SUCCESS (0.059s)
[70.573062] Starting dynamic subtest: vecs0
[70.622392] Dynamic subtest vecs0: SUCCESS (0.064s)
[70.636996] Starting dynamic subtest: vecs1
[70.692201] Dynamic subtest vecs1: SUCCESS (0.069s)
[70.728650] Starting dynamic subtest: ccs0
[70.778599] Dynamic subtest ccs0: SUCCESS (0.087s)
[70.779912] Subtest noreorder: SUCCESS (0.518s)
[71.065191] [010/156] (956s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-pwrite)
[71.250929] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-pwrite
[72.200382] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (0.958s)
[72.344208] [011/156] (955s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-msflip-blt)
[72.533509] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-msflip-blt
[72.535277] Subtest fbcpsrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[72.696539] [012/156] (954s left) kms_plane (plane-panning-bottom-right-suspend)
[72.877980] Starting subtest: plane-panning-bottom-right-suspend
[72.878975] Starting dynamic subtest: pipe-A
[92.876732] Dynamic subtest pipe-A: SUCCESS (4.737s)
[92.887760] Starting dynamic subtest: pipe-B
[112.806167] Dynamic subtest pipe-B: SUCCESS (4.031s)
[112.807071] Subtest plane-panning-bottom-right-suspend: SUCCESS (8.770s)
[131.132290] [013/156] (914s left) gem_userptr_blits (stress-purge)
[131.219925] Starting subtest: stress-purge
[136.622847] Subtest stress-purge: SUCCESS (5.392s)
[136.768015] [014/156] (908s left) kms_color (deep-color)
[137.009742] Starting subtest: deep-color
[140.647355] Starting dynamic subtest: pipe-A-DP-3-gamma
[146.559800] Dynamic subtest pipe-A-DP-3-gamma: SUCCESS (5.908s)
[146.573702] Starting dynamic subtest: pipe-A-DP-3-degamma
[152.430278] Dynamic subtest pipe-A-DP-3-degamma: SUCCESS (5.868s)
[152.443842] Starting dynamic subtest: pipe-A-DP-3-ctm
[158.314113] Dynamic subtest pipe-A-DP-3-ctm: SUCCESS (5.881s)
[161.927356] Starting dynamic subtest: pipe-B-DP-3-gamma
[167.745340] Dynamic subtest pipe-B-DP-3-gamma: SUCCESS (5.857s)
[167.759011] Starting dynamic subtest: pipe-B-DP-3-degamma
[173.598421] Dynamic subtest pipe-B-DP-3-degamma: SUCCESS (5.855s)
[173.612438] Starting dynamic subtest: pipe-B-DP-3-ctm
[179.469023] Dynamic subtest pipe-B-DP-3-ctm: SUCCESS (5.871s)
[183.176762] Starting dynamic subtest: pipe-C-DP-3-gamma
[189.047161] Dynamic subtest pipe-C-DP-3-gamma: SUCCESS (5.892s)
[189.061006] Starting dynamic subtest: pipe-C-DP-3-degamma
[194.888609] Dynamic subtest pipe-C-DP-3-degamma: SUCCESS (5.841s)
[194.902473] Starting dynamic subtest: pipe-C-DP-3-ctm
[200.746260] Dynamic subtest pipe-C-DP-3-ctm: SUCCESS (5.856s)
[204.416686] Starting dynamic subtest: pipe-D-DP-3-gamma
[210.271698] Dynamic subtest pipe-D-DP-3-gamma: SUCCESS (5.891s)
[210.285940] Starting dynamic subtest: pipe-D-DP-3-degamma
[216.118947] Dynamic subtest pipe-D-DP-3-degamma: SUCCESS (5.845s)
[216.132322] Starting dynamic subtest: pipe-D-DP-3-ctm
[221.980233] Dynamic subtest pipe-D-DP-3-ctm: SUCCESS (5.861s)
[221.981202] Subtest deep-color: SUCCESS (84.959s)
[222.300518] [015/156] (823s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[222.494706] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-pwrite
[222.496558] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[222.628036] [016/156] (823s left) gem_ctx_persistence (engines-persistence)
[222.708962] Starting subtest: engines-persistence
[222.710271] Starting dynamic subtest: rcs0
[223.511502] Dynamic subtest rcs0: SUCCESS (0.803s)
[223.525835] Starting dynamic subtest: bcs0
[224.276295] Dynamic subtest bcs0: SUCCESS (0.763s)
[224.291342] Starting dynamic subtest: vcs0
[225.037014] Dynamic subtest vcs0: SUCCESS (0.758s)
[225.051596] Starting dynamic subtest: vcs1
[225.808109] Dynamic subtest vcs1: SUCCESS (0.768s)
[225.823351] Starting dynamic subtest: vecs0
[226.573111] Dynamic subtest vecs0: SUCCESS (0.762s)
[226.588788] Starting dynamic subtest: vecs1
[227.343298] Dynamic subtest vecs1: SUCCESS (0.767s)
[227.358524] Starting dynamic subtest: ccs0
[228.112247] Dynamic subtest ccs0: SUCCESS (0.767s)
[228.113259] Subtest engines-persistence: SUCCESS (5.405s)
[228.276797] [017/156] (817s left) gem_ctx_persistence (idempotent)
[228.355148] Starting subtest: idempotent
[228.356091] Subtest idempotent: SUCCESS (0.000s)
[228.477257] [018/156] (817s left) syncobj_timeline (multi-wait-available-submitted)
[228.561778] Starting subtest: multi-wait-available-submitted
[228.562716] Subtest multi-wait-available-submitted: SUCCESS (0.001s)
[228.742258] [019/156] (817s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[228.926002] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[228.980100] [020/156] (817s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[229.175044] Starting subtest: 4-tiled-8bpp-rotate-0
[230.788889] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.613s)
[231.053528] [021/156] (815s left) i915_pm_rps (thresholds-park)
[231.137142] Starting subtest: thresholds-park
[231.138997] Subtest thresholds-park: SKIP (0.000s)
[231.310029] [022/156] (815s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[231.495812] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[231.497605] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[231.628320] [023/156] (814s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[231.813690] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[231.815350] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[231.939205] [024/156] (814s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[232.132249] Starting subtest: x-tiled-64bpp-rotate-90
[232.187954] Subtest x-tiled-64bpp-rotate-90: SKIP (0.055s)
[232.373973] [025/156] (814s left) gem_exec_params (invalid-fence-in-submit)
[232.449933] Starting subtest: invalid-fence-in-submit
[232.453261] Subtest invalid-fence-in-submit: SUCCESS (0.002s)
[232.639193] [026/156] (813s left) kms_cursor_crc (cursor-random-32x10)
[232.943393] Starting subtest: cursor-random-32x10
[232.996925] Subtest cursor-random-32x10: SKIP (0.052s)
[233.457370] [027/156] (813s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[233.649714] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[233.651437] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[233.768530] [028/156] (812s left) kms_psr (psr-primary-render)
[233.950281] Subtest psr-primary-render: SKIP (0.000s)
[234.013623] [029/156] (812s left) gem_mmap_gtt (big-bo-tiledy)
[234.085975] Subtest big-bo-tiledY: SKIP (0.000s)
[234.147206] [030/156] (812s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-blt)
[234.337541] Starting subtest: hdr-rgb101010-draw-blt
[235.013743] Subtest hdr-rgb101010-draw-blt: SUCCESS (0.676s)
[235.168295] [031/156] (811s left) kms_flip (bo-too-big-interruptible)
[235.356219] Starting subtest: bo-too-big-interruptible
[235.360951] Starting dynamic subtest: A-DP3
[235.690956] Dynamic subtest A-DP3: SUCCESS (0.329s)
[235.737186] Starting dynamic subtest: B-DP3
[235.957950] Dynamic subtest B-DP3: SUCCESS (0.262s)
[236.005442] Starting dynamic subtest: C-DP3
[236.227908] Dynamic subtest C-DP3: SUCCESS (0.265s)
[236.270245] Starting dynamic subtest: D-DP3
[236.519026] Dynamic subtest D-DP3: SUCCESS (0.287s)
[236.528203] Subtest bo-too-big-interruptible: SUCCESS (1.171s)
[236.987893] [032/156] (809s left) sw_sync (sync_multi_timeline_wait)
[237.034176] Starting subtest: sync_multi_timeline_wait
[237.035049] Subtest sync_multi_timeline_wait: SUCCESS (0.001s)
[237.111974] [033/156] (809s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[237.308707] Starting subtest: yf-tiled-64bpp-rotate-270
[237.310567] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[237.430925] [034/156] (809s left) perf (gen12-invalid-class-instance)
[237.813961] Starting subtest: gen12-invalid-class-instance
[237.834962] Subtest gen12-invalid-class-instance: SUCCESS (0.021s)
[237.895211] [035/156] (809s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-render)
[238.082694] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-render
[238.084463] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[238.265549] [036/156] (808s left) kms_hdr (static-toggle-dpms)
[238.447205] Starting subtest: static-toggle-dpms
[238.448168] Starting dynamic subtest: pipe-A-DP-3-XRGB2101010
[243.418369] Dynamic subtest pipe-A-DP-3-XRGB2101010: SUCCESS (4.971s)
[243.463353] Starting dynamic subtest: pipe-A-DP-3-XRGB16161616F
[248.227353] Dynamic subtest pipe-A-DP-3-XRGB16161616F: SUCCESS (4.792s)
[248.254148] Subtest static-toggle-dpms: SUCCESS (9.808s)
[248.642688] [037/156] (798s left) gem_ctx_exec (basic-close-race)
[248.717759] Starting subtest: basic-close-race
[254.360264] Subtest basic-close-race: SUCCESS (5.642s)
[254.549761] [038/156] (792s left) i915_pm_rpm (gem-execbuf)
[256.270667] Starting subtest: gem-execbuf
[256.271658] Starting dynamic subtest: lmem0
[257.814277] Dynamic subtest lmem0: SUCCESS (1.543s)
[257.829260] Starting dynamic subtest: smem0
[260.645713] Dynamic subtest smem0: SUCCESS (2.829s)
[260.652329] Subtest gem-execbuf: SUCCESS (4.378s)
[261.064886] [039/156] (786s left) kms_pm_rpm (dpms-lpsp)
[263.183271] Starting subtest: dpms-lpsp
[263.185489] Subtest dpms-lpsp: SKIP (0.000s)
[263.557403] [040/156] (784s left) gem_lmem_swapping (heavy-verify-random)
[266.394205] Starting subtest: heavy-verify-random
[266.395349] Starting dynamic subtest: lmem0
[281.292777] Dynamic subtest lmem0: SUCCESS (14.897s)
[281.293658] Subtest heavy-verify-random: SUCCESS (14.898s)
[283.139597] [FACT gem_lmem_swapping (heavy-verify-random)] deleted: kernel.kmod_is_loaded.i915: true
[283.141526] [041/156] (764s left) perf_pmu (interrupts-sync)
[284.799283] Starting subtest: interrupts-sync
[285.948312] Subtest interrupts-sync: SUCCESS (1.147s)
[286.039383] [FACT perf_pmu (interrupts-sync)] new: kernel.kmod_is_loaded.i915: true
[286.040011] [FACT perf_pmu (interrupts-sync)] new: kernel.kmod_is_loaded.vgem: true
[286.042393] [042/156] (761s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[286.234756] Starting subtest: primary-yf-tiled-reflect-x-90
[286.236574] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[286.328581] [043/156] (761s left) gem_exec_reloc (basic-wc-active)
[286.415672] Subtest basic-wc-active: SKIP (0.000s)
[286.489688] [044/156] (761s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[286.686785] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[286.688584] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[286.804657] [045/156] (761s left) gem_exec_balancer (busy)
[286.900218] Starting subtest: busy
[287.832998] Subtest busy: SUCCESS (0.933s)
[288.252682] [046/156] (759s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[288.448955] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[288.450700] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[288.615726] [047/156] (759s left) kms_properties (get_properties-sanity-atomic)
[288.805760] Starting subtest: get_properties-sanity-atomic
[288.809236] Subtest get_properties-sanity-atomic: SUCCESS (0.004s)
[288.918024] [048/156] (759s left) gem_mmap_offset (isolation)
[289.001542] Starting subtest: isolation
[289.009032] Subtest isolation: SUCCESS (0.007s)
[289.176243] [049/156] (758s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-pwrite)
[289.369856] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-pwrite
[290.615249] Subtest hdr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (1.246s)
[290.724611] [050/156] (757s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-plflip-blt)
[290.922743] Starting subtest: fbchdr-2p-primscrn-shrfb-plflip-blt
[290.924480] Subtest fbchdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[291.069198] [051/156] (757s left) gem_exec_fence (syncobj-timeline-chain-engines)
[291.707923] Starting subtest: syncobj-timeline-chain-engines
[291.875691] Subtest syncobj-timeline-chain-engines: SUCCESS (0.168s)
[292.207238] [052/156] (756s left) kms_psr (psr-cursor-render)
[292.397247] Subtest psr-cursor-render: SKIP (0.000s)
[292.455001] [053/156] (755s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[292.535305] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[292.536218] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[292.707189] [054/156] (755s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[292.906181] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[292.907930] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[293.025207] [055/156] (755s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-blt)
[293.219056] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-blt
[293.220768] Subtest hdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[293.346955] [056/156] (755s left) gem_mmap_wc (bad-offset)
[293.426031] Subtest bad-offset: SKIP (0.000s)
[293.506268] [057/156] (755s left) kms_feature_discovery (display)
[293.699196] Starting subtest: display
[293.700079] Subtest display: SUCCESS (0.000s)
[293.797481] [058/156] (754s left) kms_dp_link_training (uhbr-sst)
[293.988797] Starting subtest: uhbr-sst
[293.990516] Subtest uhbr-sst: SKIP (0.000s)
[294.108715] [059/156] (754s left) intel_hwmon (hwmon-write)
[294.190570] Starting subtest: hwmon-write
[294.209257] Subtest hwmon-write: SUCCESS (0.019s)
[294.309392] [060/156] (754s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-render)
[294.504068] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-render
[294.505857] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[294.657865] [061/156] (754s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[294.735045] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[294.807342] [062/156] (754s left) i915_drm_fdinfo (virtual-busy-idle)
[294.880983] Starting subtest: virtual-busy-idle
[294.882904] Subtest virtual-busy-idle: SKIP (0.000s)
[294.977854] [063/156] (754s left) api_intel_bb (simple-bb-ctx)
[295.057301] Starting subtest: simple-bb-ctx
[295.094360] Subtest simple-bb-ctx: SUCCESS (0.037s)
[295.268651] [064/156] (753s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-fullscreen)
[295.466325] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-fullscreen
[295.468005] Subtest psrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[295.597676] [065/156] (753s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[295.800969] Starting subtest: y-tiled-64bpp-rotate-0
[295.802903] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[295.928081] [066/156] (753s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-render)
[296.128876] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-render
[296.130565] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[296.297233] [067/156] (753s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[296.493715] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[296.496195] Starting dynamic subtest: pipe-A-DP-3
[302.925058] Dynamic subtest pipe-A-DP-3: SUCCESS (6.429s)
[302.943569] Starting dynamic subtest: pipe-B-DP-3
[304.507061] Dynamic subtest pipe-B-DP-3: SUCCESS (1.578s)
[304.557040] Starting dynamic subtest: pipe-C-DP-3
[306.137758] Dynamic subtest pipe-C-DP-3: SUCCESS (1.620s)
[306.187258] Starting dynamic subtest: pipe-D-DP-3
[307.767720] Dynamic subtest pipe-D-DP-3: SUCCESS (1.621s)
[307.774404] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SUCCESS (11.275s)
[308.170531] [068/156] (741s left) gen9_exec_parse (basic-rejected-ctx-param)
[308.257073] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[308.353262] [069/156] (741s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-pwrite)
[308.548271] Starting subtest: fbcpsrhdr-rgb101010-draw-pwrite
[308.550005] Subtest fbcpsrhdr-rgb101010-draw-pwrite: SKIP (0.000s)
[308.696166] [070/156] (740s left) gem_exec_schedule (semaphore-codependency)
[308.793269] Starting subtest: semaphore-codependency
[308.835741] Subtest semaphore-codependency: SUCCESS (0.042s)
[309.271205] [071/156] (740s left) gem_userptr_blits (sync-unmap-after-close)
[309.364152] Starting subtest: sync-unmap-after-close
[309.383740] Subtest sync-unmap-after-close: SUCCESS (0.020s)
[309.554106] [072/156] (740s left) syncobj_timeline (etime-multi-wait-all-submitted)
[309.637225] Starting subtest: etime-multi-wait-all-submitted
[309.739363] Subtest etime-multi-wait-all-submitted: SUCCESS (0.102s)
[309.888485] [073/156] (739s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[310.087788] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[310.089581] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[310.307519] [074/156] (739s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[310.502805] Starting subtest: fbcpsr-indfb-scaledprimary
[310.504556] Subtest fbcpsr-indfb-scaledprimary: SKIP (0.000s)
[310.640428] [075/156] (739s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[310.838097] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[310.839879] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[310.971222] [076/156] (739s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[311.165059] Starting subtest: cursorB-vs-flipB-legacy
[311.166927] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[311.333967] [077/156] (738s left) kms_getfb (getfb-handle-closed)
[311.527201] Starting subtest: getfb-handle-closed
[311.528198] Subtest getfb-handle-closed: SUCCESS (0.000s)
[311.756671] [078/156] (738s left) perf_pmu (event-wait)
[311.831560] Starting subtest: event-wait
[311.832566] Starting dynamic subtest: rcs0
[311.834308] Dynamic subtest rcs0: SKIP (0.000s)
[311.836026] Subtest event-wait: SKIP (0.001s)
[312.038667] [079/156] (738s left) kms_content_protection (dp-mst-type-0-hdcp14)
[312.295264] Starting subtest: dp-mst-type-0-hdcp14
[312.297136] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[312.473935] [080/156] (737s left) kms_flip (2x-plain-flip-fb-recreate)
[312.665989] Starting subtest: 2x-plain-flip-fb-recreate
[312.680925] Subtest 2x-plain-flip-fb-recreate: SKIP (0.014s)
[312.786205] [081/156] (737s left) kms_frontbuffer_tracking (fbchdr-modesetfrombusy)
[312.981304] Starting subtest: fbchdr-modesetfrombusy
[313.948740] Subtest fbchdr-modesetfrombusy: SUCCESS (0.968s)
[314.139743] [082/156] (736s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-pgflip-blt)
[314.335044] Starting subtest: hdr-2p-scndscrn-indfb-pgflip-blt
[314.336786] Subtest hdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[314.544691] [083/156] (736s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[314.745048] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[314.746778] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[314.899227] [084/156] (735s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt)
[315.097843] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt
[315.099585] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[315.252281] [085/156] (735s left) kms_psr (fbc-psr-no-drrs)
[315.442308] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[315.515300] [086/156] (735s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[315.707205] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[315.709009] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[316.111512] [087/156] (734s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[316.316019] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[316.317932] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[316.502290] [088/156] (734s left) kms_plane_cursor (overlay)
[316.698722] Starting subtest: overlay
[316.700665] Starting dynamic subtest: pipe-A-DP-3-size-64
[319.938896] Dynamic subtest pipe-A-DP-3-size-64: SUCCESS (3.238s)
[320.023420] Starting dynamic subtest: pipe-A-DP-3-size-128
[323.173726] Dynamic subtest pipe-A-DP-3-size-128: SUCCESS (3.165s)
[323.267691] Starting dynamic subtest: pipe-A-DP-3-size-256
[326.490954] Dynamic subtest pipe-A-DP-3-size-256: SUCCESS (3.249s)
[326.656714] Starting dynamic subtest: pipe-B-DP-3-size-64
[329.980892] Dynamic subtest pipe-B-DP-3-size-64: SUCCESS (3.342s)
[330.054281] Starting dynamic subtest: pipe-B-DP-3-size-128
[333.181274] Dynamic subtest pipe-B-DP-3-size-128: SUCCESS (3.150s)
[333.245039] Starting dynamic subtest: pipe-B-DP-3-size-256
[336.381814] Dynamic subtest pipe-B-DP-3-size-256: SUCCESS (3.150s)
[336.525470] Starting dynamic subtest: pipe-C-DP-3-size-64
[339.811545] Dynamic subtest pipe-C-DP-3-size-64: SUCCESS (3.302s)
[339.889106] Starting dynamic subtest: pipe-C-DP-3-size-128
[343.112149] Dynamic subtest pipe-C-DP-3-size-128: SUCCESS (3.250s)
[343.177295] Starting dynamic subtest: pipe-C-DP-3-size-256
[346.362720] Dynamic subtest pipe-C-DP-3-size-256: SUCCESS (3.200s)
[346.503832] Starting dynamic subtest: pipe-D-DP-3-size-64
[349.805330] Dynamic subtest pipe-D-DP-3-size-64: SUCCESS (3.315s)
[349.869128] Starting dynamic subtest: pipe-D-DP-3-size-128
[353.038860] Dynamic subtest pipe-D-DP-3-size-128: SUCCESS (3.183s)
[353.101233] Starting dynamic subtest: pipe-D-DP-3-size-256
[356.221495] Dynamic subtest pipe-D-DP-3-size-256: SUCCESS (3.133s)
[356.346360] Subtest overlay: SUCCESS (39.643s)
[356.607542] [089/156] (694s left) sysfs_preempt_timeout (timeout)
[356.694986] Starting subtest: timeout
[356.697309] Starting dynamic subtest: vecs0
[358.467938] Dynamic subtest vecs0: SUCCESS (1.771s)
[358.483196] Starting dynamic subtest: ccs0
[360.265911] Dynamic subtest ccs0: SUCCESS (1.797s)
[360.280526] Starting dynamic subtest: vcs0
[361.942029] Dynamic subtest vcs0: SUCCESS (1.675s)
[361.956565] Starting dynamic subtest: bcs0
[363.615122] Dynamic subtest bcs0: SUCCESS (1.672s)
[363.629318] Starting dynamic subtest: vecs1
[365.258104] Dynamic subtest vecs1: SUCCESS (1.642s)
[365.272746] Starting dynamic subtest: rcs0
[366.879891] Dynamic subtest rcs0: SUCCESS (1.621s)
[366.894357] Starting dynamic subtest: vcs1
[368.478936] Dynamic subtest vcs1: SUCCESS (1.598s)
[368.480118] Subtest timeout: SUCCESS (11.785s)
[368.624475] [090/156] (682s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[368.817197] Starting subtest: basic-flip-before-cursor-atomic
[369.859273] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.041s)
[370.181856] [091/156] (681s left) gem_flink_race (flink_name)
[370.231813] Starting subtest: flink_name
[375.634439] Subtest flink_name: SUCCESS (5.401s)
[375.849792] [092/156] (675s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[376.055252] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[376.057118] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[376.176693] [093/156] (675s left) gem_spin_batch (spin-each)
[376.272588] Starting subtest: spin-each
[379.683568] Subtest spin-each: SUCCESS (3.410s)
[379.998196] [094/156] (671s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[380.195227] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[380.223917] Starting dynamic subtest: pipe-A-plane-0
[380.656802] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[380.692574] Starting dynamic subtest: pipe-A-plane-3
[380.939878] Dynamic subtest pipe-A-plane-3: SUCCESS (0.281s)
[380.958489] Starting dynamic subtest: pipe-A-plane-5
[380.960304] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[381.242290] Starting dynamic subtest: pipe-B-plane-0
[381.534755] Dynamic subtest pipe-B-plane-0: SUCCESS (0.332s)
[381.571971] Starting dynamic subtest: pipe-B-plane-3
[381.801962] Dynamic subtest pipe-B-plane-3: SUCCESS (0.265s)
[381.853767] Starting dynamic subtest: pipe-B-plane-5
[381.855814] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[381.924911] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SUCCESS (1.730s)
[382.236510] [095/156] (669s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[382.323951] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[382.325953] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[382.582263] [096/156] (669s left) gem_ctx_shared (disjoint-timelines)
[382.675387] Starting subtest: disjoint-timelines
[382.720202] Subtest disjoint-timelines: SUCCESS (0.045s)
[382.965046] [097/156] (668s left) kms_lease (lease-invalid-plane)
[383.156753] Starting subtest: lease-invalid-plane
[383.159191] Starting dynamic subtest: pipe-A-DP-3
[383.160060] Dynamic subtest pipe-A-DP-3: SUCCESS (0.000s)
[383.174999] Starting dynamic subtest: pipe-B-DP-3
[383.176070] Dynamic subtest pipe-B-DP-3: SUCCESS (0.000s)
[383.190715] Starting dynamic subtest: pipe-C-DP-3
[383.191977] Dynamic subtest pipe-C-DP-3: SUCCESS (0.000s)
[383.206559] Starting dynamic subtest: pipe-D-DP-3
[383.207707] Dynamic subtest pipe-D-DP-3: SUCCESS (0.000s)
[383.208986] Subtest lease-invalid-plane: SUCCESS (0.006s)
[383.262691] [098/156] (668s left) gem_linear_blits (basic)
[383.609140] Starting subtest: basic
[383.648157] Subtest basic: SUCCESS (0.039s)
[383.836683] [099/156] (668s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[384.090078] Starting subtest: fbc-shrfb-scaledprimary
[385.580214] Subtest fbc-shrfb-scaledprimary: SUCCESS (1.490s)
[385.860008] [100/156] (666s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-onoff)
[386.056904] Starting subtest: hdr-1p-primscrn-cur-indfb-onoff
[386.604933] Subtest hdr-1p-primscrn-cur-indfb-onoff: SUCCESS (0.549s)
[386.850167] [101/156] (665s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-render)
[387.047842] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-render
[387.049523] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[387.187719] [102/156] (665s left) gem_exec_schedule (u-submit-late-slice)
[387.306268] Starting subtest: u-submit-late-slice
[387.307230] Starting dynamic subtest: rcs0
[387.388520] Dynamic subtest rcs0: SUCCESS (0.081s)
[387.406562] Starting dynamic subtest: bcs0
[387.440054] Dynamic subtest bcs0: SUCCESS (0.051s)
[387.456457] Starting dynamic subtest: vcs0
[387.492497] Dynamic subtest vcs0: SUCCESS (0.051s)
[387.509689] Starting dynamic subtest: vcs1
[387.543989] Dynamic subtest vcs1: SUCCESS (0.050s)
[387.560808] Starting dynamic subtest: vecs0
[387.596325] Dynamic subtest vecs0: SUCCESS (0.051s)
[387.612854] Starting dynamic subtest: vecs1
[387.647647] Dynamic subtest vecs1: SUCCESS (0.050s)
[387.663850] Starting dynamic subtest: ccs0
[387.700964] Dynamic subtest ccs0: SUCCESS (0.052s)
[387.701994] Subtest u-submit-late-slice: SUCCESS (0.395s)
[388.201672] [103/156] (664s left) gem_exec_params (invalid-bsd1-flag-on-render)
[388.288659] Starting subtest: invalid-bsd1-flag-on-render
[388.289585] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[388.454853] [104/156] (664s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[388.654556] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[388.656221] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[388.804805] [105/156] (663s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[388.994236] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[390.253973] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.259s)
[390.558974] [106/156] (662s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[390.752107] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[390.753012] Starting dynamic subtest: pipe-A-valid-mode
[392.755235] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.001s)
[392.756544] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.004s)
[393.063440] [107/156] (659s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[393.256214] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[393.257125] Starting dynamic subtest: pipe-A-DP-3
[393.265678] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[393.280244] Starting dynamic subtest: pipe-B-DP-3
[393.288860] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[393.302970] Starting dynamic subtest: pipe-C-DP-3
[393.311715] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[393.325859] Starting dynamic subtest: pipe-D-DP-3
[393.336800] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[393.338936] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[393.800894] [108/156] (659s left) kms_psr (fbc-psr2-primary-blt)
[393.996179] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[394.062005] [109/156] (658s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-blt)
[394.259907] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-blt
[394.261651] Subtest psrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[394.411767] [110/156] (658s left) syncobj_timeline (signal-point-0)
[394.493239] Starting subtest: signal-point-0
[394.494200] Subtest signal-point-0: SUCCESS (0.000s)
[394.705948] [111/156] (658s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[394.901068] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[398.015834] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (3.115s)
[398.260368] [112/156] (654s left) gem_exec_fence (invalid-fence-array)
[398.777033] Starting subtest: invalid-fence-array
[398.779355] Subtest invalid-fence-array: SUCCESS (0.002s)
[399.185102] [113/156] (654s left) kms_chamelium_hpd (hdmi-hpd)
[399.459729] Subtest hdmi-hpd: SKIP (0.000s)
[399.664194] [114/156] (653s left) kms_chamelium_frames (hdmi-frame-dump)
[399.953147] Subtest hdmi-frame-dump: SKIP (0.000s)
[400.146374] [115/156] (653s left) kms_cursor_crc (cursor-onscreen-256x85)
[400.593099] Starting subtest: cursor-onscreen-256x85
[400.596960] Starting dynamic subtest: pipe-A-DP-3
[403.213515] Dynamic subtest pipe-A-DP-3: SUCCESS (2.616s)
[403.253895] Starting dynamic subtest: pipe-D-DP-3
[405.935431] Dynamic subtest pipe-D-DP-3: SUCCESS (2.695s)
[405.936490] Subtest cursor-onscreen-256x85: SUCCESS (5.343s)
[406.303139] [116/156] (647s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[406.491255] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[406.492198] Starting dynamic subtest: pipe-A-DP-3
[406.500858] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[406.515529] Starting dynamic subtest: pipe-B-DP-3
[406.524190] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[406.538583] Starting dynamic subtest: pipe-C-DP-3
[406.547555] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[406.562277] Starting dynamic subtest: pipe-D-DP-3
[406.573851] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[406.575915] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.007s)
[407.042694] [117/156] (646s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[407.237824] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[407.239652] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[407.442665] [118/156] (646s left) syncobj_wait (wait-all-interrupted)
[407.529130] Starting subtest: wait-all-interrupted
[407.636401] Subtest wait-all-interrupted: SUCCESS (0.106s)
[407.745450] [119/156] (645s left) kms_pm_rpm (pm-tiling)
[409.258290] Starting subtest: pm-tiling
[409.262060] Subtest pm-tiling: SKIP (0.000s)
[409.717301] [120/156] (644s left) gem_render_linear_blits (basic)
[409.805220] Starting subtest: basic
[409.878067] Subtest basic: SUCCESS (0.074s)
[409.971675] [121/156] (643s left) kms_psr (fbc-pr-primary-mmap-gtt)
[410.165532] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[410.221856] [122/156] (643s left) gem_ctx_param (set-priority-invalid-size)
[410.302154] Starting subtest: set-priority-invalid-size
[410.303116] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[410.395184] [123/156] (643s left) kms_flip (2x-flip-vs-suspend)
[410.594105] Starting subtest: 2x-flip-vs-suspend
[410.597328] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[410.754907] [124/156] (643s left) kms_vblank (query-busy-hang)
[410.946056] Starting subtest: query-busy-hang
[410.946973] Starting dynamic subtest: pipe-A-DP-3
[437.786122] Dynamic subtest pipe-A-DP-3: SUCCESS (26.837s)
[437.815343] Starting dynamic subtest: pipe-D-DP-3
[462.728743] Dynamic subtest pipe-D-DP-3: SUCCESS (24.935s)
[462.729684] Subtest query-busy-hang: SUCCESS (51.780s)
[463.024818] [125/156] (591s left) kms_lease (empty-lease)
[463.212544] Starting subtest: empty-lease
[463.215066] Starting dynamic subtest: pipe-A-DP-3
[463.215940] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s)
[463.232990] Starting dynamic subtest: pipe-B-DP-3
[463.234150] Dynamic subtest pipe-B-DP-3: SUCCESS (0.002s)
[463.250047] Starting dynamic subtest: pipe-C-DP-3
[463.250990] Dynamic subtest pipe-C-DP-3: SUCCESS (0.002s)
[463.265745] Starting dynamic subtest: pipe-D-DP-3
[463.266808] Dynamic subtest pipe-D-DP-3: SUCCESS (0.002s)
[463.267739] Subtest empty-lease: SUCCESS (0.015s)
[463.354103] [126/156] (590s left) device_reset (unbind-reset-rebind)
[463.447847] Starting subtest: unbind-reset-rebind
[466.310124] Subtest unbind-reset-rebind: SUCCESS (2.862s)
[466.373442] [127/156] (587s left) kms_pm_backlight (brightness-with-dpms)
[466.569427] Subtest brightness-with-dpms: SKIP (0.000s)
[466.637268] [128/156] (587s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[466.838012] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[466.839743] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[466.989045] [129/156] (587s left) gem_ringfill (engines-basic)
[467.389596] Starting subtest: engines-basic
[467.391123] Starting dynamic subtest: rcs0
[467.473988] Dynamic subtest rcs0: SUCCESS (0.083s)
[467.496801] Starting dynamic subtest: bcs0
[467.517385] Dynamic subtest bcs0: SUCCESS (0.042s)
[467.541459] Starting dynamic subtest: vcs0
[467.560180] Dynamic subtest vcs0: SUCCESS (0.041s)
[467.581621] Starting dynamic subtest: vcs1
[467.602367] Dynamic subtest vcs1: SUCCESS (0.041s)
[467.622211] Starting dynamic subtest: vecs0
[467.643921] Dynamic subtest vecs0: SUCCESS (0.040s)
[467.662956] Starting dynamic subtest: vecs1
[467.686425] Dynamic subtest vecs1: SUCCESS (0.041s)
[467.704793] Starting dynamic subtest: ccs0
[467.730146] Dynamic subtest ccs0: SUCCESS (0.042s)
[467.731352] Subtest engines-basic: SUCCESS (0.342s)
[467.846108] [130/156] (586s left) kms_flip (flip-vs-panning)
[468.033891] Starting subtest: flip-vs-panning
[468.038693] Starting dynamic subtest: A-DP3
[475.923544] Dynamic subtest A-DP3: SUCCESS (7.883s)
[475.976405] Starting dynamic subtest: B-DP3
[483.756896] Dynamic subtest B-DP3: SUCCESS (7.825s)
[483.807470] Starting dynamic subtest: C-DP3
[491.593950] Dynamic subtest C-DP3: SUCCESS (7.829s)
[491.644720] Starting dynamic subtest: D-DP3
[499.434016] Dynamic subtest D-DP3: SUCCESS (7.832s)
[499.443261] Subtest flip-vs-panning: SUCCESS (31.405s)
[499.820393] [131/156] (554s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[500.015242] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[500.080199] [132/156] (554s left) gem_fenced_exec_thrash (2-spare-fences)
[500.167481] Subtest 2-spare-fences: SKIP (0.000s)
[500.245653] [133/156] (554s left) kms_flip (flip-vs-expired-vblank)
[500.434961] Starting subtest: flip-vs-expired-vblank
[500.439753] Starting dynamic subtest: A-DP3
[508.321552] Dynamic subtest A-DP3: SUCCESS (7.881s)
[508.349733] Starting dynamic subtest: B-DP3
[516.117589] Dynamic subtest B-DP3: SUCCESS (7.793s)
[516.135253] Starting dynamic subtest: C-DP3
[523.904695] Dynamic subtest C-DP3: SUCCESS (7.785s)
[523.922472] Starting dynamic subtest: D-DP3
[531.694495] Dynamic subtest D-DP3: SUCCESS (7.788s)
[531.696846] Subtest flip-vs-expired-vblank: SUCCESS (31.258s)
[532.029852] [134/156] (522s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[532.224895] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[532.226661] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[532.379242] [135/156] (522s left) kms_cursor_crc (cursor-sliding-512x170)
[532.874122] Starting subtest: cursor-sliding-512x170
[532.875978] Subtest cursor-sliding-512x170: SKIP (0.001s)
[533.137056] [136/156] (521s left) syncobj_eventfd (binary-wait)
[533.217192] Starting subtest: binary-wait
[533.227991] Subtest binary-wait: SUCCESS (0.011s)
[533.354139] [137/156] (521s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-blt)
[533.550361] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-blt
[534.234454] Subtest fbchdr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (0.684s)
[534.480591] [138/156] (520s left) gem_exec_create (forked)
[534.571967] Starting subtest: forked
[534.572946] Starting dynamic subtest: smem
[554.710659] Dynamic subtest smem: SUCCESS (20.136s)
[554.737677] Starting dynamic subtest: lmem0
[574.863954] Dynamic subtest lmem0: SUCCESS (20.150s)
[574.864958] Subtest forked: SUCCESS (40.288s)
[575.130905] [139/156] (480s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[575.327329] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[575.328956] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[575.485709] [140/156] (479s left) gem_readwrite (new-obj)
[575.570943] Subtest new-obj: SKIP (0.000s)
[575.652050] [141/156] (479s left) kms_psr (pr-dpms)
[575.844289] Subtest pr-dpms: SKIP (0.000s)
[575.917152] [142/156] (479s left) kms_atomic_transition (modeset-transition)
[576.108124] Starting subtest: modeset-transition
[576.109042] Starting dynamic subtest: 1x-outputs
[579.018928] Dynamic subtest 1x-outputs: SUCCESS (2.909s)
[579.023504] Subtest modeset-transition: SUCCESS (2.912s)
[579.263165] [143/156] (476s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[579.343228] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[579.452722] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[579.599153] [144/156] (475s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[579.799281] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[580.908213] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.109s)
[581.139949] [145/156] (474s left) kms_vblank (ts-continuation-idle-hang)
[581.331739] Starting subtest: ts-continuation-idle-hang
[581.334275] Starting dynamic subtest: pipe-A-DP-3
[607.772173] Dynamic subtest pipe-A-DP-3: SUCCESS (26.435s)
[607.789138] Starting dynamic subtest: pipe-D-DP-3
[632.715058] Dynamic subtest pipe-D-DP-3: SUCCESS (24.941s)
[632.716033] Subtest ts-continuation-idle-hang: SUCCESS (51.382s)
[632.993145] [146/156] (422s left) kms_cdclk (mode-transition)
[633.182299] Starting subtest: mode-transition
[633.183219] Starting dynamic subtest: pipe-A-DP-3
[633.262065] Dynamic subtest pipe-A-DP-3: SKIP (0.078s)
[633.279705] Starting dynamic subtest: pipe-B-DP-3
[633.281619] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[633.297234] Starting dynamic subtest: pipe-C-DP-3
[633.299054] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[633.315260] Starting dynamic subtest: pipe-D-DP-3
[633.317359] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[633.318969] Subtest mode-transition: SKIP (0.091s)
[633.521658] [147/156] (422s left) gem_ccs (block-multicopy-inplace)
[633.608797] Starting subtest: block-multicopy-inplace
[633.609733] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy
[633.654799] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.045s)
[633.671433] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy
[633.748269] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.092s)
[633.765283] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy
[633.766206] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.013s)
[633.781405] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy
[633.859963] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.096s)
[633.877150] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy
[633.878066] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[633.893942] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy
[633.975213] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.099s)
[633.992295] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy
[633.993202] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[634.008831] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy
[634.091339] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.100s)
[634.092265] Subtest block-multicopy-inplace: SUCCESS (0.483s)
[634.284644] [148/156] (421s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[634.479982] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[634.481723] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[634.626639] [149/156] (421s left) gem_exec_parallel (contexts)
[634.724200] Starting subtest: contexts
[634.725115] Starting dynamic subtest: rcs0
[639.512533] Dynamic subtest rcs0: SUCCESS (4.789s)
[639.528236] Starting dynamic subtest: bcs0
[644.112618] Dynamic subtest bcs0: SUCCESS (4.599s)
[644.128974] Starting dynamic subtest: vcs0
[648.504660] Dynamic subtest vcs0: SUCCESS (4.391s)
[648.520466] Starting dynamic subtest: vcs1
[653.121818] Dynamic subtest vcs1: SUCCESS (4.616s)
[653.137635] Starting dynamic subtest: vecs0
[657.501628] Dynamic subtest vecs0: SUCCESS (4.379s)
[657.518162] Starting dynamic subtest: vecs1
[662.212628] Dynamic subtest vecs1: SUCCESS (4.710s)
[662.228965] Starting dynamic subtest: ccs0
[666.888623] Dynamic subtest ccs0: SUCCESS (4.675s)
[666.889606] Subtest contexts: SUCCESS (32.168s)
[667.176675] [150/156] (388s left) gem_exec_reloc (basic-cpu-read-noreloc)
[667.261214] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[667.394224] [151/156] (388s left) prime_vgem (basic-fence-read)
[667.496111] Starting subtest: basic-fence-read
[667.514470] Subtest basic-fence-read: SKIP (0.019s)
[667.656627] [152/156] (388s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[667.856645] Starting subtest: fbc-rgb565-draw-mmap-cpu
[670.378939] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (2.528s)
[670.561333] [153/156] (385s left) kms_flip (basic-plain-flip)
[670.748203] Starting subtest: basic-plain-flip
[670.753001] Starting dynamic subtest: A-DP3
[671.601467] Dynamic subtest A-DP3: SUCCESS (0.847s)
[671.649066] Starting dynamic subtest: B-DP3
[672.426834] Dynamic subtest B-DP3: SUCCESS (0.820s)
[672.444660] Starting dynamic subtest: C-DP3
[673.214132] Dynamic subtest C-DP3: SUCCESS (0.785s)
[673.234067] Starting dynamic subtest: D-DP3
[674.000308] Dynamic subtest D-DP3: SUCCESS (0.781s)
[674.009702] Subtest basic-plain-flip: SUCCESS (3.261s)
[674.357919] [154/156] (381s left) syncobj_timeline (etime-multi-wait-submitted)
[674.436202] Starting subtest: etime-multi-wait-submitted
[674.539550] Subtest etime-multi-wait-submitted: SUCCESS (0.103s)
[674.697375] [155/156] (381s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[674.890010] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[677.913523] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (3.024s)
[678.072236] [156/156] (378s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-render)
[678.266989] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-render
[678.268759] Subtest hdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[678.413174] Closing watchdogs
results: parsing output: 0/ for test: api_intel_bb
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: gem_mmap
results: parsing output: 3/ for test: gem_mmap_gtt
results: parsing output: 4/ for test: i915_drm_fdinfo
results: parsing output: 5/ for test: gem_set_tiling_vs_blt
results: parsing output: 6/ for test: gem_ctx_param
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: gem_exec_schedule
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_plane
results: parsing output: 12/ for test: gem_userptr_blits
results: parsing output: 13/ for test: kms_color
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_ctx_persistence
results: parsing output: 16/ for test: gem_ctx_persistence
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: i915_pm_rps
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: gem_exec_params
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: gem_mmap_gtt
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: sw_sync
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: perf
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_hdr
results: parsing output: 36/ for test: gem_ctx_exec
results: parsing output: 37/ for test: i915_pm_rpm
results: parsing output: 38/ for test: kms_pm_rpm
results: parsing output: 39/ for test: gem_lmem_swapping
results: parsing output: 40/ for test: perf_pmu
results: parsing output: 41/ for test: kms_rotation_crc
results: parsing output: 42/ for test: gem_exec_reloc
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_exec_balancer
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_properties
results: parsing output: 47/ for test: gem_mmap_offset
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_exec_fence
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_mmap_wc
results: parsing output: 56/ for test: kms_feature_discovery
results: parsing output: 57/ for test: kms_dp_link_training
results: parsing output: 58/ for test: intel_hwmon
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_mmap_gtt
results: parsing output: 61/ for test: i915_drm_fdinfo
results: parsing output: 62/ for test: api_intel_bb
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: gen9_exec_parse
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: gem_userptr_blits
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: kms_getfb
results: parsing output: 77/ for test: perf_pmu
results: parsing output: 78/ for test: kms_content_protection
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_plane_cursor
results: parsing output: 88/ for test: sysfs_preempt_timeout
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: gem_flink_race
results: parsing output: 91/ for test: kms_plane
results: parsing output: 92/ for test: gem_spin_batch
results: parsing output: 93/ for test: kms_plane
results: parsing output: 94/ for test: gem_render_copy
results: parsing output: 95/ for test: gem_ctx_shared
results: parsing output: 96/ for test: kms_lease
results: parsing output: 97/ for test: gem_linear_blits
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_exec_schedule
results: parsing output: 102/ for test: gem_exec_params
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: kms_flip_scaled_crc
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_exec_fence
results: parsing output: 112/ for test: kms_chamelium_hpd
results: parsing output: 113/ for test: kms_chamelium_frames
results: parsing output: 114/ for test: kms_cursor_crc
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: kms_pm_rpm
results: parsing output: 119/ for test: gem_render_linear_blits
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: gem_ctx_param
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: kms_vblank
results: parsing output: 124/ for test: kms_lease
results: parsing output: 125/ for test: device_reset
results: parsing output: 126/ for test: kms_pm_backlight
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_ringfill
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_psr2_sf
results: parsing output: 131/ for test: gem_fenced_exec_thrash
results: parsing output: 132/ for test: kms_flip
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_cursor_crc
results: parsing output: 135/ for test: syncobj_eventfd
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: gem_exec_create
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: gem_readwrite
results: parsing output: 140/ for test: kms_psr
results: parsing output: 141/ for test: kms_atomic_transition
results: parsing output: 142/ for test: syncobj_wait
results: parsing output: 143/ for test: kms_big_fb
results: parsing output: 144/ for test: kms_vblank
results: parsing output: 145/ for test: kms_cdclk
results: parsing output: 146/ for test: gem_ccs
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: gem_exec_parallel
results: parsing output: 149/ for test: gem_exec_reloc
results: parsing output: 150/ for test: prime_vgem
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: kms_flip
results: parsing output: 153/ for test: syncobj_timeline
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.