[69.862482] Initializing watchdogs
[69.862565]   /dev/watchdog0
[69.893339] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[69.908171] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[69.913332] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[69.916443] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[71.431734] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[71.434934] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[71.835282] [002/133] (958s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[73.350541] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[73.424171] [003/133] (957s left) gem_mmap (short-mmap)
[73.473602] Subtest short-mmap: SKIP (0.000s)
[73.540967] [004/133] (957s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[75.032454] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s)
[75.108788] [005/133] (955s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[76.614863] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[76.618197] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[76.780530] [006/133] (954s left) kms_frontbuffer_tracking (psr-slowdraw)
[78.276930] Starting subtest: psr-slowdraw
[78.279671] Subtest psr-slowdraw: SKIP (0.000s)
[78.450680] [007/133] (952s left) syncobj_wait (single-wait-for-submit-submitted)
[78.501733] Starting subtest: single-wait-for-submit-submitted
[78.610849] Subtest single-wait-for-submit-submitted: SUCCESS (0.106s)
[78.777406] [008/133] (952s left) kms_color (ctm-0-75)
[80.265925] Starting subtest: ctm-0-75
[80.267646] Starting dynamic subtest: pipe-A-HDMI-A-4
[82.304090] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.038s)
[82.312697] Starting dynamic subtest: pipe-B-HDMI-A-4
[84.169899] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (1.864s)
[84.178850] Starting dynamic subtest: pipe-C-HDMI-A-4
[86.085653] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (1.913s)
[86.095158] Starting dynamic subtest: pipe-D-HDMI-A-4
[87.955828] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (1.870s)
[87.957383] Subtest ctm-0-75: SUCCESS (7.686s)
[88.175725] [009/133] (942s left) i915_pm_freq_api (freq-reset)
[88.238757] Starting subtest: freq-reset
[88.240501] Starting dynamic subtest: gt0
[88.496183] Dynamic subtest gt0: SUCCESS (0.256s)
[88.498269] Subtest freq-reset: SUCCESS (0.257s)
[88.614288] [010/133] (942s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[89.173949] Starting subtest: syncobj-timeline-multiple-ext-nodes
[89.175441] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[89.498253] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[89.501074] [011/133] (941s left) kms_force_connector_basic (prune-stale-modes)
[89.631344] Starting subtest: prune-stale-modes
[89.653586] Subtest prune-stale-modes: SUCCESS (0.022s)
[91.313654] [012/133] (940s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[92.812177] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[92.814819] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[92.997485] [013/133] (938s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[94.514558] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[94.517826] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[94.701782] [014/133] (936s left) prime_self_import (basic-with_one_bo)
[94.747115] Starting subtest: basic-with_one_bo
[94.760521] Subtest basic-with_one_bo: SUCCESS (0.005s)
[94.916597] [015/133] (936s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[94.964453] Starting subtest: multi-wait-all-for-submit-available-signaled
[94.965913] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[95.104163] [016/133] (936s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[95.153875] Starting subtest: rel-constants-invalid-rel-gen5
[95.155475] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[95.319564] [017/133] (936s left) i915_pm_rps (reset)
[95.374213] Starting subtest: reset
[100.089328] Subtest reset: SUCCESS (4.713s)
[100.280740] [018/133] (931s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[101.778706] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[101.781590] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[101.883409] [019/133] (930s left) gem_mmap_wc (invalid-flags)
[101.935489] Subtest invalid-flags: SKIP (0.000s)
[102.010457] [020/133] (930s left) kms_joiner (basic-force-ultra-joiner)
[103.501258] Starting subtest: basic-force-ultra-joiner
[103.504520] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[103.612405] [021/133] (928s left) kms_lease (atomic-implicit-crtc)
[105.143074] Starting subtest: atomic-implicit-crtc
[105.144482] Starting dynamic subtest: pipe-A-HDMI-A-4
[105.151366] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.001s)
[105.161334] Starting dynamic subtest: pipe-B-HDMI-A-4
[105.168425] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.009s)
[105.178163] Starting dynamic subtest: pipe-C-HDMI-A-4
[105.185264] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.009s)
[105.194575] Starting dynamic subtest: pipe-D-HDMI-A-4
[105.201846] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.009s)
[105.203350] Subtest atomic-implicit-crtc: SUCCESS (0.034s)
[105.381421] [022/133] (926s left) gem_render_copy (y-tiled)
[105.435166] Starting subtest: y-tiled
[105.436721] Starting dynamic subtest: smem
[105.523380] Dynamic subtest smem: SUCCESS (0.088s)
[105.533123] Starting dynamic subtest: lmem0
[106.289911] Dynamic subtest lmem0: SUCCESS (0.762s)
[106.291831] Subtest y-tiled: SUCCESS (0.851s)
[106.553844] [023/133] (925s left) kms_feature_discovery (display-1x)
[108.039943] Starting subtest: display-1x
[108.041723] Subtest display-1x: SUCCESS (0.000s)
[108.169189] [024/133] (924s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[109.694335] Starting subtest: yf-tiled-64bpp-rotate-0
[109.697317] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[109.857694] [025/133] (922s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[111.352965] Starting subtest: fbc-indfb-scaledprimary
[115.005247] Subtest fbc-indfb-scaledprimary: SUCCESS (3.652s)
[115.253469] [026/133] (917s left) kms_busy (extended-modeset-hang-newfb)
[116.746567] Starting subtest: extended-modeset-hang-newfb
[116.748167] Starting dynamic subtest: pipe-A
[132.330725] Dynamic subtest pipe-A: SUCCESS (15.580s)
[132.342580] Starting dynamic subtest: pipe-D
[147.856485] Dynamic subtest pipe-D: SUCCESS (15.520s)
[147.857880] Subtest extended-modeset-hang-newfb: SUCCESS (31.107s)
[148.035495] [027/133] (884s left) kms_prop_blob (blob-prop-lifetime)
[148.082644] Starting subtest: blob-prop-lifetime
[148.084208] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[148.187452] [028/133] (884s left) gem_pxp (reject-modify-context-protection-off-1)
[150.755775] Starting subtest: reject-modify-context-protection-off-1
[150.759348] Subtest reject-modify-context-protection-off-1: SKIP (0.000s)
[150.877503] [029/133] (881s left) perf (invalid-open-flags)
[151.001922] Starting subtest: invalid-open-flags
[151.003627] Subtest invalid-open-flags: SUCCESS (0.000s)
[151.083300] [030/133] (881s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[152.590418] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[153.169329] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.580s)
[153.418505] [031/133] (879s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[154.912172] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[157.803849] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (2.894s)
[158.088621] [032/133] (875s left) core_setmaster (master-drop-set-user)
[158.219267] Starting subtest: master-drop-set-user
[158.240980] Subtest master-drop-set-user: SUCCESS (0.022s)
[158.309377] [033/133] (874s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[158.363120] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[158.365104] Starting dynamic subtest: smem
[158.454336] Dynamic subtest smem: SUCCESS (0.091s)
[158.464211] Starting dynamic subtest: lmem0
[159.387142] Dynamic subtest lmem0: SUCCESS (0.929s)
[159.388699] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SUCCESS (1.022s)
[159.650290] [034/133] (873s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[159.702731] Subtest writes-after-reads-snoop: SKIP (0.000s)
[159.799104] [035/133] (873s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[161.289911] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[161.293480] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[161.509248] [036/133] (871s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[163.015354] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[163.018867] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[163.198276] [037/133] (870s left) gem_userptr_blits (dmabuf-unsync)
[163.257146] Subtest dmabuf-unsync: SKIP (0.000s)
[163.443941] [038/133] (870s left) kms_psr (psr2-sprite-blt)
[164.931405] Subtest psr2-sprite-blt: SKIP (0.000s)
[165.011538] [039/133] (868s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[166.497399] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[166.535150] Starting dynamic subtest: pipe-A-plane-0
[167.102587] Dynamic subtest pipe-A-plane-0: SUCCESS (0.567s)
[167.138365] Starting dynamic subtest: pipe-A-plane-3
[167.435144] Dynamic subtest pipe-A-plane-3: SUCCESS (0.331s)
[167.448221] Starting dynamic subtest: pipe-A-plane-5
[167.801718] Dynamic subtest pipe-A-plane-5: SUCCESS (0.365s)
[167.990821] Starting dynamic subtest: pipe-B-plane-0
[168.356832] Dynamic subtest pipe-B-plane-0: SUCCESS (0.384s)
[168.397658] Starting dynamic subtest: pipe-B-plane-3
[168.689644] Dynamic subtest pipe-B-plane-3: SUCCESS (0.330s)
[168.731112] Starting dynamic subtest: pipe-B-plane-5
[169.071920] Dynamic subtest pipe-B-plane-5: SUCCESS (0.381s)
[169.128746] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SUCCESS (2.631s)
[169.307928] [040/133] (864s left) perf_pmu (enable-race)
[169.358980] Starting subtest: enable-race
[169.360629] Starting dynamic subtest: rcs0
[182.110637] Dynamic subtest rcs0: SUCCESS (12.752s)
[182.120937] Starting dynamic subtest: bcs0
[194.861626] Dynamic subtest bcs0: SUCCESS (12.750s)
[194.871884] Starting dynamic subtest: vcs0
[207.610590] Dynamic subtest vcs0: SUCCESS (12.748s)
[207.621044] Starting dynamic subtest: vcs1
[220.358677] Dynamic subtest vcs1: SUCCESS (12.747s)
[220.369051] Starting dynamic subtest: vecs0
[233.109698] Dynamic subtest vecs0: SUCCESS (12.750s)
[233.111370] Subtest enable-race: SUCCESS (63.750s)
[233.273943] [041/133] (800s left) kms_pm_rpm (drm-resources-equal)
[237.030324] Starting subtest: drm-resources-equal
[241.929532] Subtest drm-resources-equal: SUCCESS (4.903s)
[242.109900] [042/133] (791s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[243.599141] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[243.756968] [043/133] (790s left) prime_vgem (busy)
[243.846221] Starting subtest: busy
[243.848009] Starting dynamic subtest: rcs0
[243.925778] Dynamic subtest rcs0: SUCCESS (0.079s)
[243.936064] Starting dynamic subtest: bcs0
[243.971580] Dynamic subtest bcs0: SUCCESS (0.045s)
[243.982152] Starting dynamic subtest: vcs0
[244.014695] Dynamic subtest vcs0: SUCCESS (0.042s)
[244.030741] Starting dynamic subtest: vcs1
[244.058403] Dynamic subtest vcs1: SUCCESS (0.043s)
[244.080110] Starting dynamic subtest: vecs0
[244.103555] Dynamic subtest vecs0: SUCCESS (0.044s)
[244.105572] Subtest busy: SUCCESS (0.258s)
[244.278092] [044/133] (789s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[245.763570] Starting subtest: nonblocking-crc-frame-sequence
[245.765177] Starting dynamic subtest: pipe-A-HDMI-A-4
[246.500238] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.733s)
[246.510893] Starting dynamic subtest: pipe-B-HDMI-A-4
[247.080009] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.579s)
[247.090743] Starting dynamic subtest: pipe-C-HDMI-A-4
[247.662848] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.580s)
[247.673530] Starting dynamic subtest: pipe-D-HDMI-A-4
[248.286104] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.622s)
[248.287503] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.522s)
[248.473611] [045/133] (785s left) kms_psr (fbc-pr-cursor-plane-move)
[249.964426] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[250.033614] [046/133] (784s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[251.520128] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[251.788846] Starting dynamic subtest: pipe-A-HDMI-A-4
[254.104551] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.312s)
[254.292407] Starting dynamic subtest: pipe-B-HDMI-A-4
[256.338227] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.051s)
[256.505324] Starting dynamic subtest: pipe-C-HDMI-A-4
[258.557569] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.057s)
[258.733153] Starting dynamic subtest: pipe-D-HDMI-A-4
[260.792587] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.064s)
[260.795272] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (9.271s)
[261.146254] [047/133] (773s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[261.199725] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[261.304463] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.104s)
[261.466586] [048/133] (773s left) kms_vrr (max-min)
[262.951617] Starting subtest: max-min
[262.956211] Subtest max-min: SKIP (0.000s)
[263.156114] [049/133] (771s left) gem_spin_batch (spin-each)
[263.214644] Starting subtest: spin-each
[266.522361] Subtest spin-each: SUCCESS (3.305s)
[266.853942] [050/133] (767s left) kms_chamelium_color (ctm-0-50)
[268.343905] Subtest ctm-0-50: SKIP (0.000s)
[268.425645] [051/133] (766s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[269.913996] Starting subtest: basic-flip-after-cursor-legacy
[270.889940] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.975s)
[271.073936] [052/133] (763s left) gem_pwrite (basic-exhaustion)
[271.121767] Subtest basic-exhaustion: SKIP (0.000s)
[271.215254] [053/133] (763s left) kms_pm_rpm (modeset-non-lpsp)
[275.037899] Starting subtest: modeset-non-lpsp
[276.199333] Subtest modeset-non-lpsp: SUCCESS (1.166s)
[277.056117] [054/133] (757s left) i915_selftest (live)
[277.976184] Starting subtest: live
[277.977926] Starting dynamic subtest: sanitycheck
[279.379307] Dynamic subtest sanitycheck: SUCCESS (1.403s)
[279.387827] Starting dynamic subtest: uncore
[280.793282] Dynamic subtest uncore: SUCCESS (1.413s)
[280.801688] Starting dynamic subtest: workarounds
[284.078585] Dynamic subtest workarounds: SUCCESS (3.285s)
[284.087474] Starting dynamic subtest: gt_engines
[286.058395] Dynamic subtest gt_engines: SUCCESS (1.979s)
[286.067104] Starting dynamic subtest: gt_timelines
[352.459557] Dynamic subtest gt_timelines: SUCCESS (66.404s)
[352.468683] Starting dynamic subtest: gt_contexts
[353.886251] Dynamic subtest gt_contexts: SUCCESS (1.429s)
[353.895043] Starting dynamic subtest: gt_lrc
[359.881902] Dynamic subtest gt_lrc: SUCCESS (5.991s)
[359.890684] Starting dynamic subtest: gt_mocs
[362.159317] Dynamic subtest gt_mocs: SUCCESS (2.277s)
[362.167792] Starting dynamic subtest: gt_pm
[366.174515] Dynamic subtest gt_pm: SUCCESS (4.014s)
[366.182946] Starting dynamic subtest: gt_heartbeat
[367.585865] Dynamic subtest gt_heartbeat: SUCCESS (1.410s)
[367.595103] Starting dynamic subtest: gt_tlb
[381.375499] Dynamic subtest gt_tlb: SUCCESS (13.789s)
[381.383988] Starting dynamic subtest: requests
[391.827861] Dynamic subtest requests: SUCCESS (10.451s)
[391.836140] Starting dynamic subtest: migrate
[396.385257] Dynamic subtest migrate: SUCCESS (4.556s)
[396.393689] Starting dynamic subtest: active
[397.780536] Dynamic subtest active: SUCCESS (1.394s)
[397.789220] Starting dynamic subtest: objects
[400.088204] Dynamic subtest objects: SUCCESS (2.310s)
[400.097075] Starting dynamic subtest: mman
[403.598242] Dynamic subtest mman: SUCCESS (3.506s)
[403.606994] Starting dynamic subtest: dmabuf
[405.074309] Dynamic subtest dmabuf: SUCCESS (1.475s)
[405.082886] Starting dynamic subtest: vma
[406.469844] Dynamic subtest vma: SUCCESS (1.394s)
[406.478638] Starting dynamic subtest: coherency
[416.438502] Dynamic subtest coherency: SUCCESS (9.968s)
[416.448189] Starting dynamic subtest: gtt
[425.459788] Dynamic subtest gtt: SUCCESS (9.020s)
[425.468191] Starting dynamic subtest: gem
[427.025535] Dynamic subtest gem: SUCCESS (1.564s)
[427.034339] Starting dynamic subtest: evict
[438.699864] Dynamic subtest evict: SUCCESS (11.672s)
[438.708783] Starting dynamic subtest: hugepages
[455.839490] Dynamic subtest hugepages: SUCCESS (17.138s)
[455.848104] Starting dynamic subtest: gem_contexts
[484.053192] Dynamic subtest gem_contexts: SUCCESS (28.211s)
[484.061751] Starting dynamic subtest: client
[485.513685] Dynamic subtest client: SUCCESS (1.459s)
[485.522995] Starting dynamic subtest: gem_migrate
[488.122775] Dynamic subtest gem_migrate: SUCCESS (2.608s)
[488.131303] Starting dynamic subtest: reset
[489.562663] Dynamic subtest reset: SUCCESS (1.418s)
[489.588285] Starting dynamic subtest: memory_region
[492.595799] Dynamic subtest memory_region: SUCCESS (3.051s)
[492.605205] Starting dynamic subtest: hangcheck
[521.864791] Dynamic subtest hangcheck: SUCCESS (29.267s)
[521.873830] Starting dynamic subtest: execlists
[523.270573] Dynamic subtest execlists: SUCCESS (1.404s)
[523.279378] Starting dynamic subtest: ring_submission
[524.688223] Dynamic subtest ring_submission: SUCCESS (1.416s)
[524.697242] Starting dynamic subtest: perf
[526.180480] Dynamic subtest perf: SUCCESS (1.490s)
[526.189724] Starting dynamic subtest: slpc
[532.079434] Dynamic subtest slpc: SUCCESS (5.900s)
[532.089231] Starting dynamic subtest: guc
[535.531376] Dynamic subtest guc: SUCCESS (3.448s)
[535.540365] Starting dynamic subtest: guc_multi_lrc
[536.935600] Dynamic subtest guc_multi_lrc: SUCCESS (1.403s)
[536.944931] Starting dynamic subtest: guc_hang
[539.109903] Dynamic subtest guc_hang: SUCCESS (2.173s)
[539.119019] Starting dynamic subtest: late_gt_pm
[540.531242] Dynamic subtest late_gt_pm: SUCCESS (1.421s)
[540.532756] Subtest live: SUCCESS (262.557s)
[540.576040] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[540.577445] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[540.580468] [055/133] (494s left) sysfs_preempt_timeout (timeout)
[543.925233] Starting subtest: timeout
[543.926695] Starting dynamic subtest: vecs0
[545.179348] Dynamic subtest vecs0: SUCCESS (1.256s)
[545.189369] Starting dynamic subtest: vcs0
[546.450984] Dynamic subtest vcs0: SUCCESS (1.270s)
[546.471922] Starting dynamic subtest: bcs0
[547.785086] Dynamic subtest bcs0: SUCCESS (1.327s)
[547.795162] Starting dynamic subtest: rcs0
[549.126331] Dynamic subtest rcs0: SUCCESS (1.339s)
[549.136523] Starting dynamic subtest: vcs1
[550.491802] Dynamic subtest vcs1: SUCCESS (1.364s)
[550.493468] Subtest timeout: SUCCESS (6.570s)
[550.589718] [FACT sysfs_preempt_timeout (timeout)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[550.593099] [FACT sysfs_preempt_timeout (timeout)] new: kernel.kmod_is_loaded.i915: true
[550.597216] [056/133] (484s left) kms_psr (fbc-psr2-primary-render)
[552.089837] Subtest fbc-psr2-primary-render: SKIP (0.000s)
[552.172016] [057/133] (483s left) gem_exec_fence (basic-busy)
[552.393473] Starting subtest: basic-busy
[552.395349] Starting dynamic subtest: rcs0
[552.491239] Dynamic subtest rcs0: SUCCESS (0.096s)
[552.517149] Starting dynamic subtest: bcs0
[552.551738] Dynamic subtest bcs0: SUCCESS (0.057s)
[552.595251] Starting dynamic subtest: vcs0
[552.617020] Dynamic subtest vcs0: SUCCESS (0.059s)
[552.636369] Starting dynamic subtest: vcs1
[552.672063] Dynamic subtest vcs1: SUCCESS (0.053s)
[552.707169] Starting dynamic subtest: vecs0
[552.731980] Dynamic subtest vecs0: SUCCESS (0.057s)
[552.734026] Subtest basic-busy: SUCCESS (0.340s)
[553.362546] [058/133] (481s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[554.851900] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[554.894120] Starting dynamic subtest: pipe-A-plane-0
[556.027384] Dynamic subtest pipe-A-plane-0: SUCCESS (1.133s)
[556.042798] Starting dynamic subtest: pipe-A-plane-3
[556.876333] Dynamic subtest pipe-A-plane-3: SUCCESS (0.845s)
[556.887120] Starting dynamic subtest: pipe-A-plane-5
[557.543821] Dynamic subtest pipe-A-plane-5: SUCCESS (0.665s)
[557.708506] Starting dynamic subtest: pipe-B-plane-0
[558.632805] Dynamic subtest pipe-B-plane-0: SUCCESS (0.933s)
[558.674636] Starting dynamic subtest: pipe-B-plane-3
[559.415892] Dynamic subtest pipe-B-plane-3: SUCCESS (0.779s)
[559.461410] Starting dynamic subtest: pipe-B-plane-5
[560.116443] Dynamic subtest pipe-B-plane-5: SUCCESS (0.696s)
[560.203527] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (5.354s)
[560.424718] [059/133] (474s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[561.917983] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[561.920766] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[562.064524] [060/133] (473s left) syncobj_timeline (single-wait-available-signaled)
[562.122189] Starting subtest: single-wait-available-signaled
[562.123747] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[562.253298] [061/133] (473s left) gem_exec_schedule (preempt-engines)
[562.335705] Starting subtest: preempt-engines
[562.337315] Starting dynamic subtest: rcs0
[564.618247] Dynamic subtest rcs0: SUCCESS (2.278s)
[564.656426] Starting dynamic subtest: bcs0
[566.859052] Dynamic subtest bcs0: SUCCESS (2.234s)
[566.896588] Starting dynamic subtest: vcs0
[569.151494] Dynamic subtest vcs0: SUCCESS (2.285s)
[569.187410] Starting dynamic subtest: vcs1
[571.435952] Dynamic subtest vcs1: SUCCESS (2.277s)
[571.472820] Starting dynamic subtest: vecs0
[573.706605] Dynamic subtest vecs0: SUCCESS (2.263s)
[573.709415] Subtest preempt-engines: SUCCESS (11.372s)
[574.151970] [062/133] (461s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[574.202043] Starting subtest: multi-wait-all-for-submit-unsubmitted
[574.301907] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[574.406974] [063/133] (461s left) perf (non-system-wide-paranoid)
[574.539194] Starting subtest: non-system-wide-paranoid
[574.585039] Subtest non-system-wide-paranoid: SUCCESS (0.046s)
[574.662846] [064/133] (461s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[576.236842] Starting subtest: cursor-rapid-movement-32x32
[576.292718] Subtest cursor-rapid-movement-32x32: SKIP (0.053s)
[576.719715] [065/133] (459s left) gem_exec_reloc (basic-range)
[576.774245] Subtest basic-range: SKIP (0.000s)
[576.892087] [066/133] (459s left) gen7_exec_parse (basic-offset)
[576.945100] Subtest basic-offset: SKIP (0.000s)
[577.019209] [067/133] (459s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[578.515130] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[578.518836] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[578.670818] [068/133] (457s left) gem_exec_schedule (timeslicing)
[578.736776] Starting subtest: timeslicing
[578.738467] Starting dynamic subtest: rcs0
[578.756881] Dynamic subtest rcs0: SUCCESS (0.020s)
[578.769191] Starting dynamic subtest: bcs0
[578.778896] Dynamic subtest bcs0: SUCCESS (0.020s)
[578.789535] Starting dynamic subtest: vcs0
[578.802259] Dynamic subtest vcs0: SUCCESS (0.022s)
[578.812634] Starting dynamic subtest: vcs1
[578.824934] Dynamic subtest vcs1: SUCCESS (0.021s)
[578.835246] Starting dynamic subtest: vecs0
[578.845629] Dynamic subtest vecs0: SUCCESS (0.019s)
[578.846943] Subtest timeslicing: SUCCESS (0.110s)
[579.248394] [069/133] (457s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[580.752393] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[580.754104] Starting dynamic subtest: pipe-A-HDMI-A-4
[580.804575] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s)
[580.814759] Starting dynamic subtest: pipe-B-HDMI-A-4
[580.852685] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s)
[580.862955] Starting dynamic subtest: pipe-C-HDMI-A-4
[580.903884] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s)
[580.914091] Starting dynamic subtest: pipe-D-HDMI-A-4
[580.959022] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s)
[580.962147] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.021s)
[581.034219] [070/133] (455s left) gem_ctx_shared (q-independent)
[581.094374] Starting subtest: Q-independent
[581.095726] Starting dynamic subtest: rcs0
[581.249097] Dynamic subtest rcs0: SUCCESS (0.151s)
[581.259328] Starting dynamic subtest: bcs0
[581.339514] Dynamic subtest bcs0: SUCCESS (0.092s)
[581.351835] Starting dynamic subtest: vcs0
[581.433582] Dynamic subtest vcs0: SUCCESS (0.093s)
[581.443888] Starting dynamic subtest: vcs1
[581.538902] Dynamic subtest vcs1: SUCCESS (0.104s)
[581.551189] Starting dynamic subtest: vecs0
[581.645449] Dynamic subtest vecs0: SUCCESS (0.105s)
[581.646783] Subtest Q-independent: SUCCESS (0.552s)
[581.941811] [071/133] (454s left) gem_mmap_offset (blt-coherency)
[581.988126] Starting subtest: blt-coherency
[582.010540] Subtest blt-coherency: SUCCESS (0.023s)
[582.201175] [072/133] (454s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[583.690161] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[583.691649] Starting dynamic subtest: pipe-A-HDMI-A-4
[583.705858] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[583.716519] Starting dynamic subtest: pipe-B-HDMI-A-4
[583.731389] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[583.741528] Starting dynamic subtest: pipe-C-HDMI-A-4
[583.756411] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[583.766612] Starting dynamic subtest: pipe-D-HDMI-A-4
[583.781886] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[583.785078] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.014s)
[583.948659] [073/133] (452s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[585.437328] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[585.438851] Starting dynamic subtest: pipe-A-HDMI-A-4
[585.454187] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[585.464699] Starting dynamic subtest: pipe-B-HDMI-A-4
[585.479982] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[585.490163] Starting dynamic subtest: pipe-C-HDMI-A-4
[585.505745] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[585.516115] Starting dynamic subtest: pipe-D-HDMI-A-4
[585.532727] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[585.535985] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.011s)
[585.692603] [074/133] (450s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[587.181711] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[587.183259] Starting dynamic subtest: pipe-A-HDMI-A-4
[587.189579] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[587.200261] Starting dynamic subtest: pipe-B-HDMI-A-4
[587.206727] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[587.217318] Starting dynamic subtest: pipe-C-HDMI-A-4
[587.223937] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[587.234341] Starting dynamic subtest: pipe-D-HDMI-A-4
[587.241087] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[587.244331] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.011s)
[587.438642] [075/133] (449s left) kms_flip (flip-vs-panning-vs-hang)
[588.925633] Starting subtest: flip-vs-panning-vs-hang
[588.929852] Starting dynamic subtest: A-HDMI-A4
[640.475733] Dynamic subtest A-HDMI-A4: SUCCESS (51.548s)
[640.488526] Starting dynamic subtest: D-HDMI-A4
[690.441150] Dynamic subtest D-HDMI-A4: SUCCESS (49.964s)
[690.442835] Subtest flip-vs-panning-vs-hang: SUCCESS (101.519s)
[690.683134] [076/133] (346s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[692.175176] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[692.178267] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[692.321301] [077/133] (344s left) kms_hdr (invalid-metadata-sizes)
[693.829289] Starting subtest: invalid-metadata-sizes
[693.835750] Subtest invalid-metadata-sizes: SKIP (0.001s)
[694.023657] [078/133] (343s left) kms_async_flips (invalid-async-flip)
[695.596100] Starting subtest: invalid-async-flip
[695.865980] Starting dynamic subtest: pipe-A-HDMI-A-4
[696.274603] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.409s)
[696.456324] Starting dynamic subtest: pipe-B-HDMI-A-4
[696.554692] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.107s)
[696.730972] Starting dynamic subtest: pipe-C-HDMI-A-4
[696.835310] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.113s)
[697.020535] Starting dynamic subtest: pipe-D-HDMI-A-4
[697.122739] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.111s)
[697.124163] Subtest invalid-async-flip: SUCCESS (1.528s)
[697.477497] [079/133] (339s left) kms_rotation_crc (primary-rotation-90)
[698.965667] Starting subtest: primary-rotation-90
[709.506851] Subtest primary-rotation-90: SUCCESS (10.540s)
[709.727587] [080/133] (327s left) kms_cursor_edge_walk (256x256-top-edge)
[711.217629] Starting subtest: 256x256-top-edge
[711.219223] Starting dynamic subtest: pipe-A-HDMI-A-4
[714.527347] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.309s)
[714.540360] Starting dynamic subtest: pipe-D-HDMI-A-4
[717.747427] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.216s)
[717.749032] Subtest 256x256-top-edge: SUCCESS (6.531s)
[717.925996] [081/133] (319s left) gem_exec_flush (basic-wb-ro-default)
[717.980917] Subtest basic-wb-ro-default: SKIP (0.000s)
[718.105415] [082/133] (319s left) kms_psr (psr2-basic)
[719.630379] Subtest psr2-basic: SKIP (0.000s)
[719.704044] [083/133] (317s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[721.194376] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[721.195844] Starting dynamic subtest: pipe-A-valid-mode
[722.034846] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.839s)
[722.036261] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (0.842s)
[722.218128] [084/133] (315s left) gem_workarounds (suspend-resume-fd)
[722.293713] Starting subtest: suspend-resume-fd
[743.472618] Subtest suspend-resume-fd: SUCCESS (10.290s)
[749.644846] [085/133] (293s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[751.168457] Starting subtest: y-tiled-8bpp-rotate-90
[751.274088] Subtest y-tiled-8bpp-rotate-90: SKIP (0.103s)
[751.416308] [086/133] (292s left) kms_pipe_crc_basic (bad-source)
[752.906995] Starting subtest: bad-source
[752.908546] Subtest bad-source: SUCCESS (0.000s)
[753.021599] [087/133] (290s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[754.524814] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[754.527901] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[754.683848] [088/133] (289s left) gem_lmem_swapping (verify-random-ccs)
[758.966954] Starting subtest: verify-random-ccs
[758.969574] Starting dynamic subtest: lmem0
[758.974235] Dynamic subtest lmem0: SKIP (0.000s)
[758.976852] Subtest verify-random-ccs: SKIP (0.002s)
[762.803879] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[762.805019] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[762.808142] [089/133] (281s left) kms_flip (wf_vblank-ts-check-interruptible)
[767.600075] Starting subtest: wf_vblank-ts-check-interruptible
[767.614132] Starting dynamic subtest: A-HDMI-A4
[775.632953] Dynamic subtest A-HDMI-A4: SUCCESS (8.023s)
[775.648999] Starting dynamic subtest: B-HDMI-A4
[783.580904] Dynamic subtest B-HDMI-A4: SUCCESS (7.943s)
[783.595057] Starting dynamic subtest: C-HDMI-A4
[791.533636] Dynamic subtest C-HDMI-A4: SUCCESS (7.951s)
[791.548037] Starting dynamic subtest: D-HDMI-A4
[799.486373] Dynamic subtest D-HDMI-A4: SUCCESS (7.951s)
[799.487840] Subtest wf_vblank-ts-check-interruptible: SUCCESS (31.887s)
[799.738624] [FACT kms_flip (wf_vblank-ts-check-interruptible)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[799.741915] [FACT kms_flip (wf_vblank-ts-check-interruptible)] new: kernel.kmod_is_loaded.i915: true
[799.746159] [090/133] (244s left) gem_partial_pwrite_pread (writes-after-reads)
[799.805067] Subtest writes-after-reads: SKIP (0.000s)
[799.913494] [091/133] (244s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[801.409098] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[801.412448] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[801.552353] [092/133] (242s left) gem_exec_params (invalid-batch-start-offset)
[801.612307] Starting subtest: invalid-batch-start-offset
[801.616483] Subtest invalid-batch-start-offset: SUCCESS (0.003s)
[801.797575] [093/133] (242s left) gem_lmem_swapping (basic)
[806.020072] Starting subtest: basic
[806.022060] Starting dynamic subtest: lmem0
[829.445246] Dynamic subtest lmem0: SUCCESS (23.421s)
[829.446639] Subtest basic: SUCCESS (23.423s)
[830.866652] [FACT gem_lmem_swapping (basic)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[830.868046] [FACT gem_lmem_swapping (basic)] deleted: kernel.kmod_is_loaded.i915: true
[830.871030] [094/133] (213s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[835.608164] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[835.611419] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[835.814937] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[835.818863] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[835.826524] [095/133] (208s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[837.335315] Starting subtest: 4-tiled-64bpp-rotate-180
[837.339749] Subtest 4-tiled-64bpp-rotate-180: SKIP (0.000s)
[837.525596] [096/133] (207s left) kms_sequence (queue-busy)
[839.011425] Starting subtest: queue-busy
[839.015937] Starting dynamic subtest: pipe-A-HDMI-A-4
[841.638115] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.623s)
[841.653604] Starting dynamic subtest: pipe-B-HDMI-A-4
[844.053073] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.413s)
[844.067868] Starting dynamic subtest: pipe-C-HDMI-A-4
[846.490553] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.435s)
[846.504997] Starting dynamic subtest: pipe-D-HDMI-A-4
[848.917803] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.424s)
[848.919071] Subtest queue-busy: SUCCESS (9.906s)
[849.095254] [097/133] (195s left) gem_pread (uncached)
[849.155326] Subtest uncached: SKIP (0.000s)
[849.270608] [098/133] (195s left) kms_cursor_legacy (single-move)
[850.792831] Starting subtest: single-move
[850.794421] Starting dynamic subtest: pipe-A
[856.179273] Dynamic subtest pipe-A: SUCCESS (5.384s)
[856.191094] Starting dynamic subtest: pipe-B
[861.562634] Dynamic subtest pipe-B: SUCCESS (5.382s)
[861.574207] Starting dynamic subtest: pipe-C
[866.945824] Dynamic subtest pipe-C: SUCCESS (5.382s)
[866.957408] Starting dynamic subtest: pipe-D
[872.328923] Dynamic subtest pipe-D: SUCCESS (5.381s)
[872.340395] Starting dynamic subtest: all-pipes
[877.713402] Dynamic subtest all-pipes: SUCCESS (5.383s)
[877.714946] Subtest single-move: SUCCESS (26.919s)
[877.829491] [099/133] (166s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[879.324314] Starting subtest: psr-rgb565-draw-mmap-cpu
[879.327103] Subtest psr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[879.569936] [100/133] (165s left) api_intel_bb (object-noreloc-purge-cache-simple)
[879.619306] Starting subtest: object-noreloc-purge-cache-simple
[879.640600] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.023s)
[879.850228] [101/133] (165s left) kms_scaling_modes (scaling-mode-center)
[881.336474] Starting subtest: scaling-mode-center
[881.345075] Subtest scaling-mode-center: SKIP (0.002s)
[881.450467] [102/133] (163s left) gem_busy (extended)
[881.707691] Starting subtest: extended
[881.709229] Starting dynamic subtest: rcs0
[881.784906] Dynamic subtest rcs0: SUCCESS (0.076s)
[881.810193] Starting dynamic subtest: bcs0
[881.830069] Dynamic subtest bcs0: SUCCESS (0.042s)
[881.855653] Starting dynamic subtest: vcs0
[881.875965] Dynamic subtest vcs0: SUCCESS (0.043s)
[881.897917] Starting dynamic subtest: vcs1
[881.920459] Dynamic subtest vcs1: SUCCESS (0.042s)
[881.942447] Starting dynamic subtest: vecs0
[881.964985] Dynamic subtest vecs0: SUCCESS (0.042s)
[881.966700] Subtest extended: SUCCESS (0.258s)
[882.345648] [103/133] (162s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[883.888210] Starting subtest: dp-mst-lic-type-0-hdcp14
[883.891455] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[884.140290] [104/133] (161s left) gem_exec_nop (basic-parallel)
[884.228725] Starting subtest: basic-parallel
[887.962010] Subtest basic-parallel: SUCCESS (3.733s)
[888.279707] [105/133] (157s left) kms_cursor_crc (cursor-offscreen-256x85)
[890.056158] Starting subtest: cursor-offscreen-256x85
[890.064212] Starting dynamic subtest: pipe-A-HDMI-A-4
[892.586479] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.522s)
[892.622129] Starting dynamic subtest: pipe-D-HDMI-A-4
[895.004370] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.391s)
[895.006056] Subtest cursor-offscreen-256x85: SUCCESS (4.947s)
[895.312686] [106/133] (150s left) kms_chamelium_frames (hdmi-frame-dump)
[896.851706] Subtest hdmi-frame-dump: SKIP (0.000s)
[896.974033] [107/133] (148s left) kms_vblank (wait-forked-busy-hang)
[898.462532] Starting subtest: wait-forked-busy-hang
[898.463979] Starting dynamic subtest: pipe-A-HDMI-A-4
[925.362760] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (26.899s)
[925.379803] Starting dynamic subtest: pipe-D-HDMI-A-4
[950.360643] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (24.992s)
[950.361951] Subtest wait-forked-busy-hang: SUCCESS (51.900s)
[950.567457] [108/133] ( 95s left) gem_exec_balancer (nohangcheck)
[950.944631] Starting subtest: nohangcheck
[953.044334] Subtest nohangcheck: SUCCESS (2.096s)
[953.239151] [109/133] ( 92s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[954.727438] Starting subtest: cursorA-vs-flipB-toggle
[954.730380] Subtest cursorA-vs-flipB-toggle: SKIP (0.002s)
[954.837069] [110/133] ( 90s left) gem_exec_params (rsvd2-dirt)
[954.892422] Starting subtest: rsvd2-dirt
[954.895475] Subtest rsvd2-dirt: SKIP (0.000s)
[955.098339] [111/133] ( 90s left) i915_drm_fdinfo (busy-check-all)
[955.165250] Starting subtest: busy-check-all
[955.166860] Starting dynamic subtest: rcs0
[955.184551] Dynamic subtest rcs0: SKIP (0.017s)
[955.197085] Starting dynamic subtest: bcs0
[955.200244] Dynamic subtest bcs0: SKIP (0.001s)
[955.212489] Starting dynamic subtest: vcs0
[955.215805] Dynamic subtest vcs0: SKIP (0.001s)
[955.227643] Starting dynamic subtest: vcs1
[955.231202] Dynamic subtest vcs1: SKIP (0.001s)
[955.244425] Starting dynamic subtest: vecs0
[955.247985] Dynamic subtest vecs0: SKIP (0.001s)
[955.252367] Subtest busy-check-all: SKIP (0.026s)
[955.349154] [112/133] ( 90s left) gem_mmap_wc (copy)
[955.439565] Subtest copy: SKIP (0.000s)
[955.521722] [113/133] ( 90s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[957.008166] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[957.009579] Starting dynamic subtest: pipe-A
[957.115339] Dynamic subtest pipe-A: SUCCESS (0.108s)
[957.127706] Starting dynamic subtest: pipe-B
[957.257781] Dynamic subtest pipe-B: SUCCESS (0.141s)
[957.270051] Starting dynamic subtest: pipe-C
[957.398236] Dynamic subtest pipe-C: SUCCESS (0.139s)
[957.410558] Starting dynamic subtest: pipe-D
[957.539327] Dynamic subtest pipe-D: SUCCESS (0.140s)
[957.540782] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (0.534s)
[957.745914] [114/133] ( 88s left) gem_ctx_param (invalid-get-engines)
[957.794934] Starting subtest: invalid-get-engines
[957.796566] Subtest invalid-get-engines: SUCCESS (0.001s)
[957.935303] [115/133] ( 88s left) gem_mmap_wc (read)
[957.985398] Subtest read: SKIP (0.000s)
[958.059770] [116/133] ( 88s left) gem_userptr_blits (mmap-offset-banned)
[958.134653] Starting subtest: mmap-offset-banned
[958.136333] Starting dynamic subtest: fixed
[958.138193] Dynamic subtest fixed: SUCCESS (0.000s)
[958.139872] Subtest mmap-offset-banned: SUCCESS (0.002s)
[958.353999] [117/133] ( 88s left) gem_fence_thrash (bo-write-verify-x)
[958.400746] Starting subtest: bo-write-verify-x
[958.406155] Subtest bo-write-verify-x: SKIP (0.002s)
[958.492745] [118/133] ( 88s left) drm_read (fault-buffer)
[960.048138] Starting subtest: fault-buffer
[960.049845] Subtest fault-buffer: SUCCESS (0.001s)
[960.297485] [119/133] ( 86s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[961.839547] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[961.960537] [120/133] ( 84s left) gem_userptr_blits (unsync-overlap)
[962.017956] Subtest unsync-overlap: SKIP (0.000s)
[962.270167] [121/133] ( 84s left) kms_big_fb (linear-64bpp-rotate-90)
[963.776479] Starting subtest: linear-64bpp-rotate-90
[963.861981] Subtest linear-64bpp-rotate-90: SKIP (0.072s)
[964.019272] [122/133] ( 82s left) syncobj_wait (wait-all-for-submit-complex)
[964.069260] Starting subtest: wait-all-for-submit-complex
[964.288011] Subtest wait-all-for-submit-complex: SUCCESS (0.217s)
[964.424220] [123/133] ( 82s left) api_intel_allocator (execbuf-with-allocator)
[964.472146] Starting subtest: execbuf-with-allocator
[964.491693] Subtest execbuf-with-allocator: SUCCESS (0.021s)
[964.723773] [124/133] ( 82s left) gem_flink_race (flink_close)
[964.769955] Starting subtest: flink_close
[969.804918] Subtest flink_close: SUCCESS (5.036s)
[969.937358] [125/133] ( 77s left) gem_ctx_persistence (legacy-engines-mixed)
[970.009926] Starting subtest: legacy-engines-mixed
[970.011531] Starting dynamic subtest: render
[970.079243] Dynamic subtest render: SUCCESS (0.068s)
[970.097260] Starting dynamic subtest: bsd1
[970.130709] Dynamic subtest bsd1: SUCCESS (0.049s)
[970.167251] Starting dynamic subtest: bsd2
[970.198343] Dynamic subtest bsd2: SUCCESS (0.064s)
[970.226103] Starting dynamic subtest: blt
[970.255335] Dynamic subtest blt: SUCCESS (0.054s)
[970.282020] Starting dynamic subtest: vebox
[970.311385] Dynamic subtest vebox: SUCCESS (0.053s)
[970.313347] Subtest legacy-engines-mixed: SUCCESS (0.303s)
[970.511869] [126/133] ( 76s left) gem_cs_tlb (engines)
[970.564996] Starting subtest: engines
[970.566271] Starting dynamic subtest: rcs0
[972.725019] Dynamic subtest rcs0: SUCCESS (2.155s)
[972.737191] Starting dynamic subtest: bcs0
[974.879807] Dynamic subtest bcs0: SUCCESS (2.154s)
[974.892355] Starting dynamic subtest: vcs0
[977.034752] Dynamic subtest vcs0: SUCCESS (2.154s)
[977.047035] Starting dynamic subtest: vcs1
[979.190306] Dynamic subtest vcs1: SUCCESS (2.155s)
[979.202441] Starting dynamic subtest: vecs0
[981.345577] Dynamic subtest vecs0: SUCCESS (2.153s)
[981.347376] Subtest engines: SUCCESS (10.777s)
[981.526507] [127/133] ( 65s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[983.025159] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[983.028703] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[983.210857] [128/133] ( 64s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[984.698451] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[984.701859] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[984.816110] [129/133] ( 62s left) sw_sync (alloc_fence_invalid_timeline)
[984.869661] Starting subtest: alloc_fence_invalid_timeline
[984.871560] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[984.959950] [130/133] ( 62s left) vgem_basic (dmabuf-fence-before)
[985.011561] Starting subtest: dmabuf-fence-before
[985.013505] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[985.115545] [131/133] ( 62s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[985.164487] Starting subtest: etime-multi-wait-for-submit-submitted
[985.271509] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.107s)
[985.454254] [132/133] ( 62s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[985.502583] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[985.504139] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[985.670405] [133/133] ( 62s left) gem_exec_whisper (basic-forked)
[985.741619] Starting subtest: basic-forked
[988.329859] Subtest basic-forked: SUCCESS (2.589s)
[988.600782] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_psr2_sf
results: parsing output: 2/ for test: gem_mmap
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: kms_color
results: parsing output: 8/ for test: i915_pm_freq_api
results: parsing output: 9/ for test: gem_exec_fence
results: parsing output: 10/ for test: kms_force_connector_basic
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: prime_self_import
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: gem_exec_params
results: parsing output: 16/ for test: i915_pm_rps
results: parsing output: 17/ for test: kms_flip_scaled_crc
results: parsing output: 18/ for test: gem_mmap_wc
results: parsing output: 19/ for test: kms_joiner
results: parsing output: 20/ for test: kms_lease
results: parsing output: 21/ for test: gem_render_copy
results: parsing output: 22/ for test: kms_feature_discovery
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_busy
results: parsing output: 26/ for test: kms_prop_blob
results: parsing output: 27/ for test: gem_pxp
results: parsing output: 28/ for test: perf
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: core_setmaster
results: parsing output: 32/ for test: gem_render_copy
results: parsing output: 33/ for test: gem_partial_pwrite_pread
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: kms_plane
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: kms_pm_rpm
results: parsing output: 41/ for test: kms_addfb_basic
results: parsing output: 42/ for test: prime_vgem
results: parsing output: 43/ for test: kms_pipe_crc_basic
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_async_flips
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: kms_vrr
results: parsing output: 48/ for test: gem_spin_batch
results: parsing output: 49/ for test: kms_chamelium_color
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: gem_pwrite
results: parsing output: 52/ for test: kms_pm_rpm
results: parsing output: 53/ for test: i915_selftest
results: parsing output: 54/ for test: sysfs_preempt_timeout
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: gem_exec_fence
results: parsing output: 57/ for test: kms_plane
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: perf
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: gen7_exec_parse
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: gem_ctx_shared
results: parsing output: 70/ for test: gem_mmap_offset
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_hdr
results: parsing output: 77/ for test: kms_async_flips
results: parsing output: 78/ for test: kms_rotation_crc
results: parsing output: 79/ for test: kms_cursor_edge_walk
results: parsing output: 80/ for test: gem_exec_flush
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_flip_scaled_crc
results: parsing output: 83/ for test: gem_workarounds
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_pipe_crc_basic
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_lmem_swapping
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: gem_partial_pwrite_pread
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_exec_params
results: parsing output: 92/ for test: gem_lmem_swapping
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_sequence
results: parsing output: 96/ for test: gem_pread
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: api_intel_bb
results: parsing output: 100/ for test: kms_scaling_modes
results: parsing output: 101/ for test: gem_busy
results: parsing output: 102/ for test: kms_content_protection
results: parsing output: 103/ for test: gem_exec_nop
results: parsing output: 104/ for test: kms_cursor_crc
results: parsing output: 105/ for test: kms_chamelium_frames
results: parsing output: 106/ for test: kms_vblank
results: parsing output: 107/ for test: gem_exec_balancer
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: gem_exec_params
results: parsing output: 110/ for test: i915_drm_fdinfo
results: parsing output: 111/ for test: gem_mmap_wc
results: parsing output: 112/ for test: kms_plane_scaling
results: parsing output: 113/ for test: gem_ctx_param
results: parsing output: 114/ for test: gem_mmap_wc
results: parsing output: 115/ for test: gem_userptr_blits
results: parsing output: 116/ for test: gem_fence_thrash
results: parsing output: 117/ for test: drm_read
results: parsing output: 118/ for test: kms_chamelium_hpd
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: api_intel_allocator
results: parsing output: 123/ for test: gem_flink_race
results: parsing output: 124/ for test: gem_ctx_persistence
results: parsing output: 125/ for test: gem_cs_tlb
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_plane
results: parsing output: 128/ for test: sw_sync
results: parsing output: 129/ for test: vgem_basic
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: syncobj_timeline
results: parsing output: 132/ for test: gem_exec_whisper
Done.