[61.831885] Initializing watchdogs
[61.831954]   /dev/watchdog0
[61.853882] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[61.866156] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[61.869893] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.872801] [001/156] (960s left) api_intel_bb (blit-noreloc-keep-cache)
[61.950854] Starting subtest: blit-noreloc-keep-cache
[61.991021] Subtest blit-noreloc-keep-cache: SUCCESS (0.039s)
[62.170915] [002/156] (960s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[62.242249] Starting subtest: single-wait-for-submit-available-submitted
[62.243195] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.001s)
[62.399428] [003/156] (960s left) gem_mmap (big-bo)
[62.479193] Subtest big-bo: SKIP (0.000s)
[62.551524] [004/156] (960s left) gem_mmap_gtt (basic-small-copy-xy)
[62.625198] Subtest basic-small-copy-XY: SKIP (0.000s)
[62.687999] [005/156] (959s left) i915_drm_fdinfo (busy-check-all)
[62.758263] Starting subtest: busy-check-all
[62.759256] Starting dynamic subtest: rcs0
[62.789572] Dynamic subtest rcs0: SKIP (0.030s)
[62.798361] Starting dynamic subtest: bcs0
[62.800300] Dynamic subtest bcs0: SKIP (0.000s)
[62.808946] Starting dynamic subtest: vcs0
[62.811308] Dynamic subtest vcs0: SKIP (0.000s)
[62.819906] Starting dynamic subtest: vcs1
[62.822487] Dynamic subtest vcs1: SKIP (0.000s)
[62.830903] Starting dynamic subtest: vecs0
[62.833518] Dynamic subtest vecs0: SKIP (0.001s)
[62.842358] Starting dynamic subtest: vecs1
[62.844780] Dynamic subtest vecs1: SKIP (0.000s)
[62.853358] Starting dynamic subtest: ccs0
[62.855780] Dynamic subtest ccs0: SKIP (0.000s)
[62.858213] Subtest busy-check-all: SKIP (0.034s)
[62.899967] [006/156] (959s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[62.981164] Subtest tiled-to-untiled: SKIP (0.000s)
[63.081943] [007/156] (959s left) gem_ctx_param (get-priority-new-ctx)
[63.154490] Starting subtest: get-priority-new-ctx
[63.156435] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[63.290098] [008/156] (959s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[63.503326] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[64.641082] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.114s)
[64.866514] [009/156] (958s left) gem_exec_schedule (noreorder)
[65.075387] Starting subtest: noreorder
[65.076373] Starting dynamic subtest: rcs0
[65.167388] Dynamic subtest rcs0: SUCCESS (0.090s)
[65.180838] Starting dynamic subtest: bcs0
[65.233164] Dynamic subtest bcs0: SUCCESS (0.063s)
[65.245696] Starting dynamic subtest: vcs0
[65.291587] Dynamic subtest vcs0: SUCCESS (0.057s)
[65.304940] Starting dynamic subtest: vcs1
[65.354527] Dynamic subtest vcs1: SUCCESS (0.061s)
[65.369198] Starting dynamic subtest: vecs0
[65.418162] Dynamic subtest vecs0: SUCCESS (0.062s)
[65.450881] Starting dynamic subtest: vecs1
[65.500701] Dynamic subtest vecs1: SUCCESS (0.081s)
[65.522403] Starting dynamic subtest: ccs0
[65.576949] Dynamic subtest ccs0: SUCCESS (0.074s)
[65.578477] Subtest noreorder: SUCCESS (0.492s)
[65.810657] [010/156] (957s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-pwrite)
[66.003907] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-pwrite
[67.112065] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (1.092s)
[67.404679] [011/156] (955s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-msflip-blt)
[67.757220] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-msflip-blt
[67.759281] Subtest fbcpsrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[68.068142] [012/156] (954s left) kms_plane (plane-panning-bottom-right-suspend)
[68.253412] Starting subtest: plane-panning-bottom-right-suspend
[68.254327] Starting dynamic subtest: pipe-A
[87.882309] Dynamic subtest pipe-A: SUCCESS (4.836s)
[87.894073] Starting dynamic subtest: pipe-B
[107.830468] Dynamic subtest pipe-B: SUCCESS (4.121s)
[107.831494] Subtest plane-panning-bottom-right-suspend: SUCCESS (8.960s)
[128.118933] [013/156] (915s left) gem_userptr_blits (stress-purge)
[128.207488] Starting subtest: stress-purge
[133.612259] Subtest stress-purge: SUCCESS (5.404s)
[133.774337] [014/156] (909s left) kms_color (deep-color)
[134.026059] Starting subtest: deep-color
[137.853520] Starting dynamic subtest: pipe-A-DP-3-gamma
[143.754625] Dynamic subtest pipe-A-DP-3-gamma: SUCCESS (5.903s)
[143.768016] Starting dynamic subtest: pipe-A-DP-3-degamma
[149.626254] Dynamic subtest pipe-A-DP-3-degamma: SUCCESS (5.871s)
[149.639991] Starting dynamic subtest: pipe-A-DP-3-ctm
[155.498281] Dynamic subtest pipe-A-DP-3-ctm: SUCCESS (5.871s)
[159.282183] Starting dynamic subtest: pipe-B-DP-3-gamma
[165.117258] Dynamic subtest pipe-B-DP-3-gamma: SUCCESS (5.855s)
[165.128931] Starting dynamic subtest: pipe-B-DP-3-degamma
[170.991759] Dynamic subtest pipe-B-DP-3-degamma: SUCCESS (5.874s)
[171.006340] Starting dynamic subtest: pipe-B-DP-3-ctm
[176.883466] Dynamic subtest pipe-B-DP-3-ctm: SUCCESS (5.891s)
[180.721074] Starting dynamic subtest: pipe-C-DP-3-gamma
[186.536123] Dynamic subtest pipe-C-DP-3-gamma: SUCCESS (5.841s)
[186.549793] Starting dynamic subtest: pipe-C-DP-3-degamma
[192.415746] Dynamic subtest pipe-C-DP-3-degamma: SUCCESS (5.879s)
[192.429123] Starting dynamic subtest: pipe-C-DP-3-ctm
[198.273537] Dynamic subtest pipe-C-DP-3-ctm: SUCCESS (5.859s)
[202.081279] Starting dynamic subtest: pipe-D-DP-3-gamma
[207.914887] Dynamic subtest pipe-D-DP-3-gamma: SUCCESS (5.857s)
[207.930161] Starting dynamic subtest: pipe-D-DP-3-degamma
[213.765232] Dynamic subtest pipe-D-DP-3-degamma: SUCCESS (5.850s)
[213.778658] Starting dynamic subtest: pipe-D-DP-3-ctm
[219.631475] Dynamic subtest pipe-D-DP-3-ctm: SUCCESS (5.865s)
[219.632492] Subtest deep-color: SUCCESS (85.607s)
[219.859192] [015/156] (823s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[220.049206] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-pwrite
[220.050894] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[220.202195] [016/156] (823s left) gem_ctx_persistence (engines-persistence)
[220.284367] Starting subtest: engines-persistence
[220.285276] Starting dynamic subtest: rcs0
[221.136911] Dynamic subtest rcs0: SUCCESS (0.852s)
[221.150574] Starting dynamic subtest: bcs0
[221.897547] Dynamic subtest bcs0: SUCCESS (0.759s)
[221.912857] Starting dynamic subtest: vcs0
[222.671479] Dynamic subtest vcs0: SUCCESS (0.771s)
[222.686806] Starting dynamic subtest: vcs1
[223.443845] Dynamic subtest vcs1: SUCCESS (0.769s)
[223.459127] Starting dynamic subtest: vecs0
[224.207797] Dynamic subtest vecs0: SUCCESS (0.761s)
[224.222853] Starting dynamic subtest: vecs1
[224.969561] Dynamic subtest vecs1: SUCCESS (0.759s)
[224.984846] Starting dynamic subtest: ccs0
[225.738630] Dynamic subtest ccs0: SUCCESS (0.767s)
[225.739747] Subtest engines-persistence: SUCCESS (5.455s)
[225.905030] [017/156] (817s left) gem_ctx_persistence (idempotent)
[225.983378] Starting subtest: idempotent
[225.984693] Subtest idempotent: SUCCESS (0.000s)
[226.131804] [018/156] (817s left) syncobj_timeline (multi-wait-available-submitted)
[226.212302] Starting subtest: multi-wait-available-submitted
[226.213270] Subtest multi-wait-available-submitted: SUCCESS (0.001s)
[226.408622] [019/156] (817s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[226.595666] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[226.651974] [020/156] (816s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[226.848514] Starting subtest: 4-tiled-8bpp-rotate-0
[228.438964] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.591s)
[228.613432] [021/156] (815s left) i915_pm_rps (thresholds-park)
[228.694533] Starting subtest: thresholds-park
[228.696485] Subtest thresholds-park: SKIP (0.000s)
[228.792701] [022/156] (814s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[228.983025] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[228.984702] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[229.136895] [023/156] (814s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[229.324052] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[229.325766] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[229.490585] [024/156] (814s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[229.684725] Starting subtest: x-tiled-64bpp-rotate-90
[229.757200] Subtest x-tiled-64bpp-rotate-90: SKIP (0.072s)
[229.955518] [025/156] (813s left) gem_exec_params (invalid-fence-in-submit)
[230.033386] Starting subtest: invalid-fence-in-submit
[230.037274] Subtest invalid-fence-in-submit: SUCCESS (0.002s)
[230.197782] [026/156] (813s left) kms_cursor_crc (cursor-random-32x10)
[230.505928] Starting subtest: cursor-random-32x10
[230.566726] Subtest cursor-random-32x10: SKIP (0.059s)
[230.937094] [027/156] (813s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[231.125076] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[231.126733] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[231.261230] [028/156] (812s left) kms_psr (psr-primary-render)
[231.444989] Subtest psr-primary-render: SKIP (0.000s)
[231.500103] [029/156] (812s left) gem_mmap_gtt (big-bo-tiledy)
[231.571495] Subtest big-bo-tiledY: SKIP (0.000s)
[231.632211] [030/156] (812s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-blt)
[231.822902] Starting subtest: hdr-rgb101010-draw-blt
[232.522375] Subtest hdr-rgb101010-draw-blt: SUCCESS (0.699s)
[232.724766] [031/156] (811s left) kms_flip (bo-too-big-interruptible)
[232.914742] Starting subtest: bo-too-big-interruptible
[232.919450] Starting dynamic subtest: A-DP3
[233.264521] Dynamic subtest A-DP3: SUCCESS (0.344s)
[233.309916] Starting dynamic subtest: B-DP3
[233.529829] Dynamic subtest B-DP3: SUCCESS (0.260s)
[233.572541] Starting dynamic subtest: C-DP3
[233.795594] Dynamic subtest C-DP3: SUCCESS (0.261s)
[233.836484] Starting dynamic subtest: D-DP3
[234.060824] Dynamic subtest D-DP3: SUCCESS (0.260s)
[234.067317] Subtest bo-too-big-interruptible: SUCCESS (1.152s)
[234.478217] [032/156] (809s left) sw_sync (sync_multi_timeline_wait)
[234.524064] Starting subtest: sync_multi_timeline_wait
[234.524930] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[234.615935] [033/156] (809s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[234.818813] Starting subtest: yf-tiled-64bpp-rotate-270
[234.820631] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[235.031567] [034/156] (809s left) perf (gen12-invalid-class-instance)
[235.446298] Starting subtest: gen12-invalid-class-instance
[235.466471] Subtest gen12-invalid-class-instance: SUCCESS (0.021s)
[235.520283] [035/156] (809s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-render)
[235.709120] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-render
[235.710794] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[235.853265] [036/156] (808s left) kms_hdr (static-toggle-dpms)
[236.037114] Starting subtest: static-toggle-dpms
[236.039517] Starting dynamic subtest: pipe-A-DP-3-XRGB2101010
[241.234898] Dynamic subtest pipe-A-DP-3-XRGB2101010: SUCCESS (5.195s)
[241.292228] Starting dynamic subtest: pipe-A-DP-3-XRGB16161616F
[246.230469] Dynamic subtest pipe-A-DP-3-XRGB16161616F: SUCCESS (4.964s)
[246.259388] Subtest static-toggle-dpms: SUCCESS (10.221s)
[246.633267] [037/156] (798s left) gem_ctx_exec (basic-close-race)
[246.713688] Starting subtest: basic-close-race
[252.302664] Subtest basic-close-race: SUCCESS (5.587s)
[252.512592] [038/156] (792s left) i915_pm_rpm (gem-execbuf)
[254.551227] Starting subtest: gem-execbuf
[254.552540] Starting dynamic subtest: lmem0
[257.326865] Dynamic subtest lmem0: SUCCESS (2.776s)
[257.343589] Starting dynamic subtest: smem0
[258.620137] Dynamic subtest smem0: SUCCESS (1.291s)
[258.626612] Subtest gem-execbuf: SUCCESS (4.072s)
[258.993271] [039/156] (785s left) kms_pm_rpm (dpms-lpsp)
[260.599208] Starting subtest: dpms-lpsp
[260.601272] Subtest dpms-lpsp: SKIP (0.002s)
[260.967719] [040/156] (784s left) gem_lmem_swapping (heavy-verify-random)
[263.864716] Starting subtest: heavy-verify-random
[263.866035] Starting dynamic subtest: lmem0
[279.304919] Dynamic subtest lmem0: SUCCESS (15.442s)
[279.305836] Subtest heavy-verify-random: SUCCESS (15.443s)
[280.466295] [FACT gem_lmem_swapping (heavy-verify-random)] deleted: kernel.kmod_is_loaded.i915: true
[280.468477] [041/156] (764s left) perf_pmu (interrupts-sync)
[282.205843] Starting subtest: interrupts-sync
[283.384293] Subtest interrupts-sync: SUCCESS (1.177s)
[283.483971] [FACT perf_pmu (interrupts-sync)] new: kernel.kmod_is_loaded.i915: true
[283.484851] [FACT perf_pmu (interrupts-sync)] new: kernel.kmod_is_loaded.vgem: true
[283.486994] [042/156] (761s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[283.681862] Starting subtest: primary-yf-tiled-reflect-x-90
[283.683669] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[283.801796] [043/156] (761s left) gem_exec_reloc (basic-wc-active)
[283.889852] Subtest basic-wc-active: SKIP (0.000s)
[283.967913] [044/156] (761s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[284.168237] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[284.169916] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[284.271586] [045/156] (760s left) gem_exec_balancer (busy)
[284.365789] Starting subtest: busy
[285.293722] Subtest busy: SUCCESS (0.928s)
[285.742369] [046/156] (759s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[285.941703] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[285.943446] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[286.098067] [047/156] (759s left) kms_properties (get_properties-sanity-atomic)
[286.295848] Starting subtest: get_properties-sanity-atomic
[286.299354] Subtest get_properties-sanity-atomic: SUCCESS (0.003s)
[286.392395] [048/156] (759s left) gem_mmap_offset (isolation)
[286.474895] Starting subtest: isolation
[286.483919] Subtest isolation: SUCCESS (0.008s)
[286.641715] [049/156] (758s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-pwrite)
[286.837401] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-pwrite
[288.107746] Subtest hdr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (1.270s)
[288.267264] [050/156] (757s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-plflip-blt)
[288.461367] Starting subtest: fbchdr-2p-primscrn-shrfb-plflip-blt
[288.463210] Subtest fbchdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[288.609584] [051/156] (757s left) gem_exec_fence (syncobj-timeline-chain-engines)
[289.288164] Starting subtest: syncobj-timeline-chain-engines
[289.463871] Subtest syncobj-timeline-chain-engines: SUCCESS (0.183s)
[289.773387] [052/156] (755s left) kms_psr (psr-cursor-render)
[289.968973] Subtest psr-cursor-render: SKIP (0.000s)
[290.028167] [053/156] (755s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[290.113703] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[290.114728] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[290.278231] [054/156] (755s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[290.472491] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[290.474367] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[290.625209] [055/156] (755s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-blt)
[290.822529] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-blt
[290.824324] Subtest hdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[290.984213] [056/156] (755s left) gem_mmap_wc (bad-offset)
[291.062536] Subtest bad-offset: SKIP (0.000s)
[291.126879] [057/156] (754s left) kms_feature_discovery (display)
[291.319252] Starting subtest: display
[291.320245] Subtest display: SUCCESS (0.000s)
[291.451549] [058/156] (754s left) kms_dp_link_training (uhbr-sst)
[291.643794] Starting subtest: uhbr-sst
[291.645627] Subtest uhbr-sst: SKIP (0.000s)
[291.765634] [059/156] (754s left) intel_hwmon (hwmon-write)
[291.844941] Starting subtest: hwmon-write
[291.863964] Subtest hwmon-write: SUCCESS (0.019s)
[292.035067] [060/156] (754s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-render)
[292.242506] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-render
[292.244267] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[292.397425] [061/156] (754s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[292.479553] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[292.561669] [062/156] (753s left) i915_drm_fdinfo (virtual-busy-idle)
[292.634759] Starting subtest: virtual-busy-idle
[292.636601] Subtest virtual-busy-idle: SKIP (0.000s)
[292.821360] [063/156] (753s left) api_intel_bb (simple-bb-ctx)
[292.899909] Starting subtest: simple-bb-ctx
[292.933764] Subtest simple-bb-ctx: SUCCESS (0.034s)
[293.109710] [064/156] (753s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-fullscreen)
[293.310542] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-fullscreen
[293.312422] Subtest psrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[293.522222] [065/156] (753s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[293.737701] Starting subtest: y-tiled-64bpp-rotate-0
[293.739540] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[293.868461] [066/156] (752s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-render)
[294.066605] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-render
[294.068381] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[294.174700] [067/156] (752s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[294.364906] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[294.367386] Starting dynamic subtest: pipe-A-DP-3
[300.704497] Dynamic subtest pipe-A-DP-3: SUCCESS (6.338s)
[300.725464] Starting dynamic subtest: pipe-B-DP-3
[302.303242] Dynamic subtest pipe-B-DP-3: SUCCESS (1.594s)
[302.351392] Starting dynamic subtest: pipe-C-DP-3
[303.934279] Dynamic subtest pipe-C-DP-3: SUCCESS (1.622s)
[303.983043] Starting dynamic subtest: pipe-D-DP-3
[305.565313] Dynamic subtest pipe-D-DP-3: SUCCESS (1.622s)
[305.571694] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SUCCESS (11.202s)
[305.934286] [068/156] (741s left) gen9_exec_parse (basic-rejected-ctx-param)
[306.026880] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[306.111288] [069/156] (740s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-pwrite)
[306.309469] Starting subtest: fbcpsrhdr-rgb101010-draw-pwrite
[306.311276] Subtest fbcpsrhdr-rgb101010-draw-pwrite: SKIP (0.000s)
[306.477683] [070/156] (740s left) gem_exec_schedule (semaphore-codependency)
[306.573817] Starting subtest: semaphore-codependency
[306.615556] Subtest semaphore-codependency: SUCCESS (0.042s)
[307.071270] [071/156] (740s left) gem_userptr_blits (sync-unmap-after-close)
[307.173119] Starting subtest: sync-unmap-after-close
[307.195659] Subtest sync-unmap-after-close: SUCCESS (0.023s)
[307.390316] [072/156] (739s left) syncobj_timeline (etime-multi-wait-all-submitted)
[307.470858] Starting subtest: etime-multi-wait-all-submitted
[307.576471] Subtest etime-multi-wait-all-submitted: SUCCESS (0.105s)
[307.693425] [073/156] (739s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[307.888924] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[307.890736] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[308.024176] [074/156] (739s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[308.225351] Starting subtest: fbcpsr-indfb-scaledprimary
[308.227153] Subtest fbcpsr-indfb-scaledprimary: SKIP (0.000s)
[308.441014] [075/156] (739s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[308.633687] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[308.635558] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[308.837738] [076/156] (738s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[309.046623] Starting subtest: cursorB-vs-flipB-legacy
[309.048381] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[309.223416] [077/156] (738s left) kms_getfb (getfb-handle-closed)
[309.414737] Starting subtest: getfb-handle-closed
[309.415669] Subtest getfb-handle-closed: SUCCESS (0.000s)
[309.638619] [078/156] (738s left) perf_pmu (event-wait)
[309.712480] Starting subtest: event-wait
[309.713495] Starting dynamic subtest: rcs0
[309.715305] Dynamic subtest rcs0: SKIP (0.000s)
[309.717115] Subtest event-wait: SKIP (0.001s)
[309.918677] [079/156] (738s left) kms_content_protection (dp-mst-type-0-hdcp14)
[310.175915] Starting subtest: dp-mst-type-0-hdcp14
[310.177769] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[310.346298] [080/156] (737s left) kms_flip (2x-plain-flip-fb-recreate)
[310.538385] Starting subtest: 2x-plain-flip-fb-recreate
[310.553985] Subtest 2x-plain-flip-fb-recreate: SKIP (0.015s)
[310.683691] [081/156] (737s left) kms_frontbuffer_tracking (fbchdr-modesetfrombusy)
[310.882537] Starting subtest: fbchdr-modesetfrombusy
[311.897759] Subtest fbchdr-modesetfrombusy: SUCCESS (1.016s)
[312.092208] [082/156] (736s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-pgflip-blt)
[312.288554] Starting subtest: hdr-2p-scndscrn-indfb-pgflip-blt
[312.290382] Subtest hdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[312.422228] [083/156] (735s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[312.619497] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[312.621228] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[312.825052] [084/156] (735s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt)
[313.018447] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt
[313.020203] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[313.225142] [085/156] (735s left) kms_psr (fbc-psr-no-drrs)
[313.417735] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[313.479510] [086/156] (735s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[313.675793] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[313.677585] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[314.019795] [087/156] (734s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[314.224687] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[314.226498] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[314.388938] [088/156] (734s left) kms_plane_cursor (overlay)
[314.586631] Starting subtest: overlay
[314.588463] Starting dynamic subtest: pipe-A-DP-3-size-64
[317.875647] Dynamic subtest pipe-A-DP-3-size-64: SUCCESS (3.288s)
[317.961388] Starting dynamic subtest: pipe-A-DP-3-size-128
[321.126124] Dynamic subtest pipe-A-DP-3-size-128: SUCCESS (3.183s)
[321.221912] Starting dynamic subtest: pipe-A-DP-3-size-256
[324.441475] Dynamic subtest pipe-A-DP-3-size-256: SUCCESS (3.249s)
[324.648202] Starting dynamic subtest: pipe-B-DP-3-size-64
[327.963627] Dynamic subtest pipe-B-DP-3-size-64: SUCCESS (3.337s)
[328.029903] Starting dynamic subtest: pipe-B-DP-3-size-128
[331.281421] Dynamic subtest pipe-B-DP-3-size-128: SUCCESS (3.266s)
[331.345140] Starting dynamic subtest: pipe-B-DP-3-size-256
[334.563769] Dynamic subtest pipe-B-DP-3-size-256: SUCCESS (3.233s)
[334.733997] Starting dynamic subtest: pipe-C-DP-3-size-64
[338.061190] Dynamic subtest pipe-C-DP-3-size-64: SUCCESS (3.351s)
[338.139194] Starting dynamic subtest: pipe-C-DP-3-size-128
[341.344646] Dynamic subtest pipe-C-DP-3-size-128: SUCCESS (3.233s)
[341.409222] Starting dynamic subtest: pipe-C-DP-3-size-256
[344.594571] Dynamic subtest pipe-C-DP-3-size-256: SUCCESS (3.200s)
[344.743457] Starting dynamic subtest: pipe-D-DP-3-size-64
[348.070189] Dynamic subtest pipe-D-DP-3-size-64: SUCCESS (3.346s)
[348.133637] Starting dynamic subtest: pipe-D-DP-3-size-128
[351.319983] Dynamic subtest pipe-D-DP-3-size-128: SUCCESS (3.200s)
[351.397617] Starting dynamic subtest: pipe-D-DP-3-size-256
[354.585857] Dynamic subtest pipe-D-DP-3-size-256: SUCCESS (3.216s)
[354.732540] Subtest overlay: SUCCESS (40.145s)
[355.028132] [089/156] (693s left) sysfs_preempt_timeout (timeout)
[355.117096] Starting subtest: timeout
[355.119602] Starting dynamic subtest: vecs0
[356.970705] Dynamic subtest vecs0: SUCCESS (1.851s)
[356.985164] Starting dynamic subtest: ccs0
[358.714461] Dynamic subtest ccs0: SUCCESS (1.742s)
[358.729136] Starting dynamic subtest: vcs0
[360.372620] Dynamic subtest vcs0: SUCCESS (1.657s)
[360.388987] Starting dynamic subtest: bcs0
[362.010690] Dynamic subtest bcs0: SUCCESS (1.636s)
[362.025786] Starting dynamic subtest: vecs1
[363.653698] Dynamic subtest vecs1: SUCCESS (1.641s)
[363.668547] Starting dynamic subtest: rcs0
[365.321669] Dynamic subtest rcs0: SUCCESS (1.667s)
[365.337463] Starting dynamic subtest: vcs1
[367.007632] Dynamic subtest vcs1: SUCCESS (1.684s)
[367.008568] Subtest timeout: SUCCESS (11.891s)
[367.138156] [090/156] (681s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[367.331792] Starting subtest: basic-flip-before-cursor-atomic
[368.365276] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.032s)
[368.668391] [091/156] (680s left) gem_flink_race (flink_name)
[368.717755] Starting subtest: flink_name
[374.120315] Subtest flink_name: SUCCESS (5.401s)
[374.258380] [092/156] (674s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[374.487914] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[374.489649] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[374.587793] [093/156] (674s left) gem_spin_batch (spin-each)
[374.681594] Starting subtest: spin-each
[378.101017] Subtest spin-each: SUCCESS (3.418s)
[378.419941] [094/156] (670s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[378.613951] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[378.646006] Starting dynamic subtest: pipe-A-plane-0
[379.063600] Dynamic subtest pipe-A-plane-0: SUCCESS (0.417s)
[379.108793] Starting dynamic subtest: pipe-A-plane-3
[379.346225] Dynamic subtest pipe-A-plane-3: SUCCESS (0.278s)
[379.394251] Starting dynamic subtest: pipe-A-plane-5
[379.396359] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[379.658476] Starting dynamic subtest: pipe-B-plane-0
[379.940607] Dynamic subtest pipe-B-plane-0: SUCCESS (0.316s)
[379.964561] Starting dynamic subtest: pipe-B-plane-3
[380.208205] Dynamic subtest pipe-B-plane-3: SUCCESS (0.265s)
[380.257495] Starting dynamic subtest: pipe-B-plane-5
[380.259379] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[380.318547] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SUCCESS (1.703s)
[380.642124] [095/156] (668s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[380.739611] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[380.741787] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[381.044686] [096/156] (668s left) gem_ctx_shared (disjoint-timelines)
[381.136845] Starting subtest: disjoint-timelines
[381.185512] Subtest disjoint-timelines: SUCCESS (0.049s)
[381.492795] [097/156] (667s left) kms_lease (lease-invalid-plane)
[381.686779] Starting subtest: lease-invalid-plane
[381.687724] Starting dynamic subtest: pipe-A-DP-3
[381.688608] Dynamic subtest pipe-A-DP-3: SUCCESS (0.000s)
[381.703106] Starting dynamic subtest: pipe-B-DP-3
[381.704254] Dynamic subtest pipe-B-DP-3: SUCCESS (0.000s)
[381.718465] Starting dynamic subtest: pipe-C-DP-3
[381.719681] Dynamic subtest pipe-C-DP-3: SUCCESS (0.000s)
[381.734964] Starting dynamic subtest: pipe-D-DP-3
[381.736124] Dynamic subtest pipe-D-DP-3: SUCCESS (0.000s)
[381.737267] Subtest lease-invalid-plane: SUCCESS (0.007s)
[381.788107] [098/156] (667s left) gem_linear_blits (basic)
[382.151089] Starting subtest: basic
[382.187829] Subtest basic: SUCCESS (0.038s)
[382.402798] [099/156] (667s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[382.651276] Starting subtest: fbc-shrfb-scaledprimary
[384.127912] Subtest fbc-shrfb-scaledprimary: SUCCESS (1.476s)
[384.355853] [100/156] (665s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-onoff)
[384.547871] Starting subtest: hdr-1p-primscrn-cur-indfb-onoff
[385.123616] Subtest hdr-1p-primscrn-cur-indfb-onoff: SUCCESS (0.574s)
[385.365183] [101/156] (664s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-render)
[385.562610] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-render
[385.564380] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[385.759238] [102/156] (664s left) gem_exec_schedule (u-submit-late-slice)
[385.865117] Starting subtest: u-submit-late-slice
[385.866089] Starting dynamic subtest: rcs0
[385.945475] Dynamic subtest rcs0: SUCCESS (0.080s)
[385.961719] Starting dynamic subtest: bcs0
[385.997214] Dynamic subtest bcs0: SUCCESS (0.051s)
[386.013046] Starting dynamic subtest: vcs0
[386.048864] Dynamic subtest vcs0: SUCCESS (0.050s)
[386.065446] Starting dynamic subtest: vcs1
[386.098977] Dynamic subtest vcs1: SUCCESS (0.049s)
[386.115503] Starting dynamic subtest: vecs0
[386.151682] Dynamic subtest vecs0: SUCCESS (0.051s)
[386.167665] Starting dynamic subtest: vecs1
[386.203746] Dynamic subtest vecs1: SUCCESS (0.051s)
[386.219585] Starting dynamic subtest: ccs0
[386.254801] Dynamic subtest ccs0: SUCCESS (0.050s)
[386.255830] Subtest u-submit-late-slice: SUCCESS (0.390s)
[386.712582] [103/156] (663s left) gem_exec_params (invalid-bsd1-flag-on-render)
[386.801355] Starting subtest: invalid-bsd1-flag-on-render
[386.802315] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[386.929290] [104/156] (663s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[387.138879] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[387.140591] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[387.257752] [105/156] (662s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[387.451628] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[388.727531] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.275s)
[389.040453] [106/156] (661s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[389.233218] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[389.235749] Starting dynamic subtest: pipe-A-valid-mode
[391.173117] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.937s)
[391.174501] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (1.939s)
[391.454485] [107/156] (658s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[391.654767] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[391.655680] Starting dynamic subtest: pipe-A-DP-3
[391.664222] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[391.678466] Starting dynamic subtest: pipe-B-DP-3
[391.686778] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[391.701134] Starting dynamic subtest: pipe-C-DP-3
[391.709878] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[391.724273] Starting dynamic subtest: pipe-D-DP-3
[391.735650] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[391.737896] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[392.178527] [108/156] (658s left) kms_psr (fbc-psr2-primary-blt)
[392.375916] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[392.439921] [109/156] (657s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-blt)
[392.636286] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-blt
[392.638112] Subtest psrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[392.793220] [110/156] (657s left) syncobj_timeline (signal-point-0)
[392.873757] Starting subtest: signal-point-0
[392.874761] Subtest signal-point-0: SUCCESS (0.000s)
[393.083286] [111/156] (657s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[393.283712] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[396.421277] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (3.138s)
[396.669196] [112/156] (654s left) gem_exec_fence (invalid-fence-array)
[397.206594] Starting subtest: invalid-fence-array
[397.209558] Subtest invalid-fence-array: SUCCESS (0.002s)
[397.650060] [113/156] (653s left) kms_chamelium_hpd (hdmi-hpd)
[397.937309] Subtest hdmi-hpd: SKIP (0.000s)
[398.142136] [114/156] (652s left) kms_chamelium_frames (hdmi-frame-dump)
[398.425939] Subtest hdmi-frame-dump: SKIP (0.000s)
[398.618514] [115/156] (652s left) kms_cursor_crc (cursor-onscreen-256x85)
[399.067544] Starting subtest: cursor-onscreen-256x85
[399.072826] Starting dynamic subtest: pipe-A-DP-3
[401.656139] Dynamic subtest pipe-A-DP-3: SUCCESS (2.581s)
[401.712490] Starting dynamic subtest: pipe-D-DP-3
[404.468598] Dynamic subtest pipe-D-DP-3: SUCCESS (2.768s)
[404.469726] Subtest cursor-onscreen-256x85: SUCCESS (5.400s)
[404.828443] [116/156] (646s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[405.023632] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[405.024550] Starting dynamic subtest: pipe-A-DP-3
[405.033232] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[405.048170] Starting dynamic subtest: pipe-B-DP-3
[405.056814] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[405.071429] Starting dynamic subtest: pipe-C-DP-3
[405.080253] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[405.094936] Starting dynamic subtest: pipe-D-DP-3
[405.106224] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[405.107894] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.007s)
[405.532787] [117/156] (645s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[405.730521] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[405.732376] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[405.928938] [118/156] (645s left) syncobj_wait (wait-all-interrupted)
[406.014802] Starting subtest: wait-all-interrupted
[406.119897] Subtest wait-all-interrupted: SUCCESS (0.105s)
[406.282959] [119/156] (645s left) kms_pm_rpm (pm-tiling)
[408.593999] Starting subtest: pm-tiling
[408.596341] Subtest pm-tiling: SKIP (0.000s)
[409.041410] [120/156] (642s left) gem_render_linear_blits (basic)
[409.130758] Starting subtest: basic
[409.202919] Subtest basic: SUCCESS (0.074s)
[409.323215] [121/156] (642s left) kms_psr (fbc-pr-primary-mmap-gtt)
[409.513874] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[409.578811] [122/156] (641s left) gem_ctx_param (set-priority-invalid-size)
[409.655278] Starting subtest: set-priority-invalid-size
[409.656260] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[409.809277] [123/156] (641s left) kms_flip (2x-flip-vs-suspend)
[409.998955] Starting subtest: 2x-flip-vs-suspend
[410.002275] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[410.137063] [124/156] (641s left) kms_vblank (query-busy-hang)
[410.325841] Starting subtest: query-busy-hang
[410.328484] Starting dynamic subtest: pipe-A-DP-3
[437.139727] Dynamic subtest pipe-A-DP-3: SUCCESS (26.811s)
[437.157756] Starting dynamic subtest: pipe-D-DP-3
[462.088102] Dynamic subtest pipe-D-DP-3: SUCCESS (24.945s)
[462.088960] Subtest query-busy-hang: SUCCESS (51.762s)
[462.407959] [125/156] (589s left) kms_lease (empty-lease)
[462.604121] Starting subtest: empty-lease
[462.606594] Starting dynamic subtest: pipe-A-DP-3
[462.607473] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s)
[462.624145] Starting dynamic subtest: pipe-B-DP-3
[462.625074] Dynamic subtest pipe-B-DP-3: SUCCESS (0.002s)
[462.639577] Starting dynamic subtest: pipe-C-DP-3
[462.640529] Dynamic subtest pipe-C-DP-3: SUCCESS (0.002s)
[462.655583] Starting dynamic subtest: pipe-D-DP-3
[462.656886] Dynamic subtest pipe-D-DP-3: SUCCESS (0.002s)
[462.657967] Subtest empty-lease: SUCCESS (0.016s)
[462.800201] [126/156] (589s left) device_reset (unbind-reset-rebind)
[462.891603] Starting subtest: unbind-reset-rebind
[465.747665] Subtest unbind-reset-rebind: SUCCESS (2.856s)
[465.812908] [127/156] (586s left) kms_pm_backlight (brightness-with-dpms)
[466.004807] Subtest brightness-with-dpms: SKIP (0.000s)
[466.076061] [128/156] (585s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[466.285340] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[466.286969] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[466.411894] [129/156] (585s left) gem_ringfill (engines-basic)
[466.828283] Starting subtest: engines-basic
[466.829347] Starting dynamic subtest: rcs0
[466.909145] Dynamic subtest rcs0: SUCCESS (0.080s)
[466.926297] Starting dynamic subtest: bcs0
[466.949860] Dynamic subtest bcs0: SUCCESS (0.040s)
[466.972976] Starting dynamic subtest: vcs0
[466.993970] Dynamic subtest vcs0: SUCCESS (0.043s)
[467.015902] Starting dynamic subtest: vcs1
[467.037900] Dynamic subtest vcs1: SUCCESS (0.043s)
[467.060024] Starting dynamic subtest: vecs0
[467.080614] Dynamic subtest vecs0: SUCCESS (0.041s)
[467.102647] Starting dynamic subtest: vecs1
[467.123836] Dynamic subtest vecs1: SUCCESS (0.042s)
[467.143342] Starting dynamic subtest: ccs0
[467.166724] Dynamic subtest ccs0: SUCCESS (0.042s)
[467.167710] Subtest engines-basic: SUCCESS (0.339s)
[467.312681] [130/156] (584s left) kms_flip (flip-vs-panning)
[467.504888] Starting subtest: flip-vs-panning
[467.508694] Starting dynamic subtest: A-DP3
[475.410876] Dynamic subtest A-DP3: SUCCESS (7.901s)
[475.455951] Starting dynamic subtest: B-DP3
[483.252490] Dynamic subtest B-DP3: SUCCESS (7.836s)
[483.272725] Starting dynamic subtest: C-DP3
[491.059597] Dynamic subtest C-DP3: SUCCESS (7.806s)
[491.077936] Starting dynamic subtest: D-DP3
[498.871107] Dynamic subtest D-DP3: SUCCESS (7.809s)
[498.876373] Subtest flip-vs-panning: SUCCESS (31.372s)
[499.247632] [131/156] (552s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[499.451783] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[499.518659] [132/156] (552s left) gem_fenced_exec_thrash (2-spare-fences)
[499.604774] Subtest 2-spare-fences: SKIP (0.000s)
[499.703324] [133/156] (552s left) kms_flip (flip-vs-expired-vblank)
[499.897568] Starting subtest: flip-vs-expired-vblank
[499.902270] Starting dynamic subtest: A-DP3
[507.765558] Dynamic subtest A-DP3: SUCCESS (7.863s)
[507.791387] Starting dynamic subtest: B-DP3
[515.572623] Dynamic subtest B-DP3: SUCCESS (7.805s)
[515.589118] Starting dynamic subtest: C-DP3
[523.364047] Dynamic subtest C-DP3: SUCCESS (7.789s)
[523.383589] Starting dynamic subtest: D-DP3
[531.153889] Dynamic subtest D-DP3: SUCCESS (7.784s)
[531.163870] Subtest flip-vs-expired-vblank: SUCCESS (31.265s)
[531.585432] [134/156] (520s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[531.780661] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[531.782382] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[531.907700] [135/156] (520s left) kms_cursor_crc (cursor-sliding-512x170)
[532.405869] Starting subtest: cursor-sliding-512x170
[532.407657] Subtest cursor-sliding-512x170: SKIP (0.001s)
[532.630985] [136/156] (519s left) syncobj_eventfd (binary-wait)
[532.715718] Starting subtest: binary-wait
[532.726656] Subtest binary-wait: SUCCESS (0.011s)
[532.847255] [137/156] (519s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-blt)
[533.044524] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-blt
[533.765013] Subtest fbchdr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (0.721s)
[534.012593] [138/156] (518s left) gem_exec_create (forked)
[534.105500] Starting subtest: forked
[534.106487] Starting dynamic subtest: smem
[554.234314] Dynamic subtest smem: SUCCESS (20.128s)
[554.256498] Starting dynamic subtest: lmem0
[574.396893] Dynamic subtest lmem0: SUCCESS (20.161s)
[574.397890] Subtest forked: SUCCESS (40.292s)
[574.690685] [139/156] (478s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[574.890211] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[574.891860] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[575.091169] [140/156] (477s left) gem_readwrite (new-obj)
[575.174602] Subtest new-obj: SKIP (0.000s)
[575.261832] [141/156] (477s left) kms_psr (pr-dpms)
[575.455014] Subtest pr-dpms: SKIP (0.000s)
[575.523541] [142/156] (477s left) kms_atomic_transition (modeset-transition)
[575.716766] Starting subtest: modeset-transition
[575.717702] Starting dynamic subtest: 1x-outputs
[578.622082] Dynamic subtest 1x-outputs: SUCCESS (2.904s)
[578.626709] Subtest modeset-transition: SUCCESS (2.907s)
[578.908635] [143/156] (474s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[578.996800] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[579.104656] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[579.257001] [144/156] (473s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[579.459614] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[580.632839] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.173s)
[580.904513] [145/156] (472s left) kms_vblank (ts-continuation-idle-hang)
[581.097766] Starting subtest: ts-continuation-idle-hang
[581.098655] Starting dynamic subtest: pipe-A-DP-3
[608.161358] Dynamic subtest pipe-A-DP-3: SUCCESS (27.062s)
[608.178918] Starting dynamic subtest: pipe-D-DP-3
[633.093644] Dynamic subtest pipe-D-DP-3: SUCCESS (24.928s)
[633.094581] Subtest ts-continuation-idle-hang: SUCCESS (51.997s)
[633.390134] [146/156] (420s left) kms_cdclk (mode-transition)
[633.581776] Starting subtest: mode-transition
[633.582718] Starting dynamic subtest: pipe-A-DP-3
[633.677858] Dynamic subtest pipe-A-DP-3: SKIP (0.095s)
[633.702939] Starting dynamic subtest: pipe-B-DP-3
[633.704779] Dynamic subtest pipe-B-DP-3: SKIP (0.003s)
[633.720187] Starting dynamic subtest: pipe-C-DP-3
[633.721893] Dynamic subtest pipe-C-DP-3: SKIP (0.003s)
[633.737461] Starting dynamic subtest: pipe-D-DP-3
[633.739079] Dynamic subtest pipe-D-DP-3: SKIP (0.003s)
[633.740828] Subtest mode-transition: SKIP (0.114s)
[633.949407] [147/156] (419s left) gem_ccs (block-multicopy-inplace)
[634.041726] Starting subtest: block-multicopy-inplace
[634.044006] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy
[634.084815] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.042s)
[634.101874] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy
[634.180995] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.095s)
[634.197697] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy
[634.198648] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.015s)
[634.214086] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy
[634.295474] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.097s)
[634.312304] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy
[634.313309] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.015s)
[634.328701] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy
[634.414906] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.102s)
[634.432357] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy
[634.433277] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[634.448699] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy
[634.532889] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.101s)
[634.533814] Subtest block-multicopy-inplace: SUCCESS (0.492s)
[634.687807] [148/156] (418s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[634.885559] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[634.887295] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[635.012738] [149/156] (418s left) gem_exec_parallel (contexts)
[635.102487] Starting subtest: contexts
[635.103516] Starting dynamic subtest: rcs0
[639.657221] Dynamic subtest rcs0: SUCCESS (4.554s)
[639.672890] Starting dynamic subtest: bcs0
[644.206499] Dynamic subtest bcs0: SUCCESS (4.548s)
[644.223132] Starting dynamic subtest: vcs0
[648.685935] Dynamic subtest vcs0: SUCCESS (4.478s)
[648.701934] Starting dynamic subtest: vcs1
[653.296193] Dynamic subtest vcs1: SUCCESS (4.609s)
[653.312173] Starting dynamic subtest: vecs0
[657.253075] Dynamic subtest vecs0: SUCCESS (3.955s)
[657.269096] Starting dynamic subtest: vecs1
[661.413382] Dynamic subtest vecs1: SUCCESS (4.159s)
[661.429432] Starting dynamic subtest: ccs0
[665.645302] Dynamic subtest ccs0: SUCCESS (4.230s)
[665.646494] Subtest contexts: SUCCESS (30.541s)
[665.900224] [150/156] (387s left) gem_exec_reloc (basic-cpu-read-noreloc)
[665.987325] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[666.074783] [151/156] (387s left) prime_vgem (basic-fence-read)
[666.186697] Starting subtest: basic-fence-read
[666.205721] Subtest basic-fence-read: SKIP (0.019s)
[666.424870] [152/156] (387s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[666.624602] Starting subtest: fbc-rgb565-draw-mmap-cpu
[669.182748] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (2.557s)
[669.368089] [153/156] (384s left) kms_flip (basic-plain-flip)
[669.559615] Starting subtest: basic-plain-flip
[669.564476] Starting dynamic subtest: A-DP3
[670.417726] Dynamic subtest A-DP3: SUCCESS (0.852s)
[670.437656] Starting dynamic subtest: B-DP3
[671.211741] Dynamic subtest B-DP3: SUCCESS (0.789s)
[671.231763] Starting dynamic subtest: C-DP3
[672.002939] Dynamic subtest C-DP3: SUCCESS (0.786s)
[672.022830] Starting dynamic subtest: D-DP3
[672.793252] Dynamic subtest D-DP3: SUCCESS (0.785s)
[672.797393] Subtest basic-plain-flip: SUCCESS (3.238s)
[673.147347] [154/156] (380s left) syncobj_timeline (etime-multi-wait-submitted)
[673.232778] Starting subtest: etime-multi-wait-submitted
[673.335780] Subtest etime-multi-wait-submitted: SUCCESS (0.103s)
[673.494598] [155/156] (380s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[673.689786] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[676.673698] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (2.984s)
[676.888187] [156/156] (377s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-render)
[677.088552] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-render
[677.090298] Subtest hdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[677.239658] 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.