[56.363444] Initializing watchdogs
[56.363492]   /dev/watchdog0
[56.379881] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.384353] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.386443] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.388606] [001/131] (960s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[61.467837] Starting subtest: pr-primary-plane-update-sf-dmg-area
[61.471159] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.002s)
[62.313327] [002/131] (954s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[62.364889] Starting subtest: invalid-multi-wait-unsubmitted
[62.365909] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[62.444577] [003/131] (954s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[62.545843] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[62.546791] Starting dynamic subtest: pipe-A
[63.053999] Dynamic subtest pipe-A: SUCCESS (0.505s)
[63.063778] Starting dynamic subtest: pipe-B
[64.579511] Dynamic subtest pipe-B: SUCCESS (1.516s)
[64.586629] Starting dynamic subtest: pipe-C
[66.119765] Dynamic subtest pipe-C: SUCCESS (1.533s)
[66.127066] Starting dynamic subtest: pipe-D
[67.649279] Dynamic subtest pipe-D: SUCCESS (1.523s)
[67.650448] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (5.078s)
[68.839504] [004/131] (948s left) sw_sync (alloc_fence_invalid_timeline)
[68.871397] Starting subtest: alloc_fence_invalid_timeline
[68.872538] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[68.920453] [005/131] (948s left) kms_frontbuffer_tracking (fbc-1p-rte)
[68.999257] Starting subtest: fbc-1p-rte
[74.462250] Subtest fbc-1p-rte: SUCCESS (5.453s)
[75.647207] [006/131] (941s left) syncobj_timeline (wait-for-submit-delayed-submit)
[75.698381] Starting subtest: wait-for-submit-delayed-submit
[75.804423] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[75.866289] [007/131] (941s left) kms_pm_lpsp (screens-disabled)
[76.955140] Starting subtest: screens-disabled
[76.957168] Subtest screens-disabled: SKIP (0.000s)
[77.017099] [008/131] (940s left) kms_chamelium_edid (hdmi-edid-stress-resolution-4k)
[77.398294] Subtest hdmi-edid-stress-resolution-4k: SKIP (0.000s)
[78.239451] [009/131] (938s left) kms_async_flips (alternate-sync-async-flip-atomic)
[78.328832] Starting subtest: alternate-sync-async-flip-atomic
[78.700080] Starting dynamic subtest: pipe-A-eDP-1
[81.458173] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.756s)
[81.823182] Starting dynamic subtest: pipe-B-eDP-1
[84.580159] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.760s)
[84.968394] Starting dynamic subtest: pipe-C-eDP-1
[87.709028] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.744s)
[88.070926] Starting dynamic subtest: pipe-D-eDP-1
[90.834358] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s)
[90.835683] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.498s)
[91.990834] [010/131] (925s left) kms_plane (pixel-format-source-clamping)
[92.082968] Starting subtest: pixel-format-source-clamping
[92.120722] Starting dynamic subtest: pipe-A-plane-0
[96.688239] Dynamic subtest pipe-A-plane-0: SUCCESS (4.566s)
[96.694069] Starting dynamic subtest: pipe-A-plane-3
[98.866684] Dynamic subtest pipe-A-plane-3: SUCCESS (2.177s)
[98.872654] Starting dynamic subtest: pipe-A-plane-5
[98.873507] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s)
[99.990385] Starting dynamic subtest: pipe-B-plane-0
[104.542065] Dynamic subtest pipe-B-plane-0: SUCCESS (4.555s)
[104.548863] Starting dynamic subtest: pipe-B-plane-3
[106.698287] Dynamic subtest pipe-B-plane-3: SUCCESS (2.155s)
[106.704449] Starting dynamic subtest: pipe-B-plane-5
[106.705386] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s)
[107.006989] Subtest pixel-format-source-clamping: SUCCESS (14.919s)
[107.849449] [011/131] (909s left) kms_flip (2x-plain-flip-fb-recreate)
[107.947391] Starting subtest: 2x-plain-flip-fb-recreate
[107.958765] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[108.036636] [012/131] (909s left) kms_cursor_crc (cursor-onscreen-32x32)
[108.177609] Starting subtest: cursor-onscreen-32x32
[108.213159] Subtest cursor-onscreen-32x32: SKIP (0.033s)
[108.478715] [013/131] (908s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[108.589300] Starting subtest: cursorA-vs-flipA-varying-size
[119.749923] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.159s)
[120.576588] [014/131] (896s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[120.682066] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[120.683916] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[120.793786] [015/131] (896s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[120.898337] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[128.118479] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.219s)
[128.222110] [016/131] (889s left) perf_pmu (invalid-init)
[128.258886] Starting subtest: invalid-init
[128.259946] Subtest invalid-init: SUCCESS (0.000s)
[128.355838] [017/131] (888s left) prime_vgem (fence-wait)
[128.501828] Starting subtest: fence-wait
[128.503035] Starting dynamic subtest: rcs0
[129.553786] Dynamic subtest rcs0: SUCCESS (1.048s)
[129.560579] Starting dynamic subtest: bcs0
[130.617520] Dynamic subtest bcs0: SUCCESS (1.064s)
[130.625471] Starting dynamic subtest: vcs0
[131.663120] Dynamic subtest vcs0: SUCCESS (1.043s)
[131.671208] Starting dynamic subtest: vcs1
[132.705763] Dynamic subtest vcs1: SUCCESS (1.040s)
[132.713347] Starting dynamic subtest: vecs0
[133.748719] Dynamic subtest vecs0: SUCCESS (1.041s)
[133.755537] Starting dynamic subtest: ccs0
[134.791929] Dynamic subtest ccs0: SUCCESS (1.042s)
[134.793344] Subtest fence-wait: SUCCESS (6.288s)
[134.925672] [FACT prime_vgem (fence-wait)] new: kernel.kmod_is_loaded.vgem: true
[134.927720] [018/131] (882s left) gem_create (hog-create)
[134.973938] Starting subtest: hog-create
[134.975072] Starting dynamic subtest: smem0
[167.844941] Dynamic subtest smem0: SUCCESS (32.867s)
[167.846181] Subtest hog-create: SUCCESS (32.868s)
[168.018852] [019/131] (849s left) sw_sync (sync_merge_same)
[168.045581] Starting subtest: sync_merge_same
[168.046570] Subtest sync_merge_same: SUCCESS (0.000s)
[168.096137] [020/131] (849s left) perf (blocking-parameterized)
[168.201415] Starting subtest: blocking-parameterized
[188.240351] Subtest blocking-parameterized: SUCCESS (20.036s)
[188.281331] [021/131] (829s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[188.380481] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[195.625707] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.246s)
[195.753177] [022/131] (821s left) gem_mmap_gtt (isolation)
[195.813768] Subtest isolation: SKIP (0.000s)
[195.878823] [023/131] (821s left) gem_exec_schedule (submit-late-slice)
[195.941253] Starting subtest: submit-late-slice
[195.942463] Starting dynamic subtest: rcs0
[195.978051] Dynamic subtest rcs0: SUCCESS (0.037s)
[195.986343] Starting dynamic subtest: bcs0
[196.011270] Dynamic subtest bcs0: SUCCESS (0.032s)
[196.017620] Starting dynamic subtest: vcs0
[196.042841] Dynamic subtest vcs0: SUCCESS (0.031s)
[196.049416] Starting dynamic subtest: vcs1
[196.071882] Dynamic subtest vcs1: SUCCESS (0.028s)
[196.078491] Starting dynamic subtest: vecs0
[196.100355] Dynamic subtest vecs0: SUCCESS (0.028s)
[196.106559] Starting dynamic subtest: ccs0
[196.135890] Dynamic subtest ccs0: SUCCESS (0.035s)
[196.137049] Subtest submit-late-slice: SUCCESS (0.195s)
[197.975545] [024/131] (819s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-blt)
[198.060076] Starting subtest: psr-1p-offscren-pri-indfb-draw-blt
[204.943791] Subtest psr-1p-offscren-pri-indfb-draw-blt: SUCCESS (6.883s)
[205.093926] [025/131] (812s left) gem_watchdog (default-virtual)
[205.156220] Starting subtest: default-virtual
[211.444630] Subtest default-virtual: SUCCESS (6.286s)
[211.543945] [026/131] (806s left) kms_getfb (getfb2-accept-nv12)
[211.643022] Starting subtest: getfb2-accept-nv12
[211.643910] Subtest getfb2-accept-nv12: SUCCESS (0.002s)
[211.734757] [027/131] (805s left) gem_mmap (big-bo)
[211.787657] Subtest big-bo: SKIP (0.000s)
[211.849199] [028/131] (805s left) gem_mmap_offset (partial-remap)
[211.902795] Starting subtest: partial-remap
[211.903758] Starting dynamic subtest: smem0
[211.909617] Dynamic subtest smem0: SUCCESS (0.006s)
[211.910584] Subtest partial-remap: SUCCESS (0.006s)
[212.034449] [029/131] (805s left) gem_softpin (allocator-fork)
[212.082531] Starting subtest: allocator-fork
[214.294220] Subtest allocator-fork: SUCCESS (2.209s)
[214.437471] [030/131] (803s left) kms_vblank (query-idle)
[214.534888] Starting subtest: query-idle
[214.535989] Starting dynamic subtest: pipe-A-eDP-1
[216.287228] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.751s)
[216.297913] Starting dynamic subtest: pipe-D-eDP-1
[218.683909] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.393s)
[218.685410] Subtest query-idle: SUCCESS (4.148s)
[219.499454] [031/131] (798s left) perf_pmu (busy-idle-no-semaphores)
[219.532267] Starting subtest: busy-idle-no-semaphores
[219.533114] Starting dynamic subtest: rcs0
[220.200396] Dynamic subtest rcs0: SUCCESS (0.666s)
[220.210516] Starting dynamic subtest: bcs0
[220.854813] Dynamic subtest bcs0: SUCCESS (0.650s)
[220.864183] Starting dynamic subtest: vcs0
[221.506763] Dynamic subtest vcs0: SUCCESS (0.650s)
[221.516089] Starting dynamic subtest: vcs1
[223.551060] Dynamic subtest vcs1: SUCCESS (2.042s)
[223.560474] Starting dynamic subtest: vecs0
[225.534042] Dynamic subtest vecs0: SUCCESS (1.980s)
[225.541925] Starting dynamic subtest: ccs0
[227.520551] Dynamic subtest ccs0: SUCCESS (1.985s)
[227.521910] Subtest busy-idle-no-semaphores: SUCCESS (7.985s)
[227.627113] [032/131] (790s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[227.730522] Starting subtest: 4-tiled-8bpp-rotate-90
[227.753543] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.021s)
[227.867399] [033/131] (789s left) gem_pxp (reject-modify-context-protection-off-1)
[227.990761] Starting subtest: reject-modify-context-protection-off-1
[227.992671] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[228.090199] [034/131] (789s left) gen9_exec_parse (bb-start-param)
[228.148379] Subtest bb-start-param: SKIP (0.000s)
[228.238344] [035/131] (789s left) gem_linear_blits (normal)
[228.525715] Starting subtest: normal
[232.328408] Subtest normal: SUCCESS (3.803s)
[232.498620] [036/131] (785s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[232.614082] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[232.615166] Starting dynamic subtest: pipe-A-eDP-1
[232.624488] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[232.633122] Starting dynamic subtest: pipe-B-eDP-1
[232.641756] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[232.648560] Starting dynamic subtest: pipe-C-eDP-1
[232.657045] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[232.663543] Starting dynamic subtest: pipe-D-eDP-1
[232.672059] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[232.673676] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[234.749374] [037/131] (783s left) kms_joiner (basic-ultra-joiner)
[234.850321] Starting subtest: basic-ultra-joiner
[234.852068] Subtest basic-ultra-joiner: SKIP (0.000s)
[234.910566] [038/131] (783s left) gem_exec_schedule (independent)
[234.974051] Starting subtest: independent
[234.975091] Starting dynamic subtest: rcs0
[236.888329] Dynamic subtest rcs0: SUCCESS (1.911s)
[236.897878] Starting dynamic subtest: vcs0
[238.904330] Dynamic subtest vcs0: SUCCESS (2.014s)
[238.914302] Starting dynamic subtest: vcs1
[240.964819] Dynamic subtest vcs1: SUCCESS (2.058s)
[240.973640] Starting dynamic subtest: vecs0
[242.927307] Dynamic subtest vecs0: SUCCESS (1.960s)
[242.937166] Starting dynamic subtest: ccs0
[244.887450] Dynamic subtest ccs0: SUCCESS (1.958s)
[244.889285] Subtest independent: SUCCESS (9.910s)
[245.181895] [039/131] (772s left) gem_softpin (evict-snoop)
[245.242085] Starting subtest: evict-snoop
[245.244242] Subtest evict-snoop: SKIP (0.000s)
[245.377469] [040/131] (772s left) kms_draw_crc (draw-method-blt)
[245.466147] Starting subtest: draw-method-blt
[245.467033] Starting dynamic subtest: xrgb8888-untiled
[245.684646] Dynamic subtest xrgb8888-untiled: SUCCESS (0.219s)
[245.692402] Starting dynamic subtest: rgb565-untiled
[245.884476] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[245.891424] Starting dynamic subtest: xrgb2101010-untiled
[246.073525] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.188s)
[246.080671] Starting dynamic subtest: xbgr16161616f-untiled
[246.296578] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[246.303556] Starting dynamic subtest: xrgb8888-xtiled
[246.395704] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.099s)
[246.404066] Starting dynamic subtest: rgb565-xtiled
[246.517996] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[246.526800] Starting dynamic subtest: xrgb2101010-xtiled
[246.628888] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[246.636233] Starting dynamic subtest: xbgr16161616f-xtiled
[246.728854] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.099s)
[246.736080] Starting dynamic subtest: xrgb8888-4tiled
[246.828990] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.099s)
[246.836050] Starting dynamic subtest: rgb565-4tiled
[246.929016] Dynamic subtest rgb565-4tiled: SUCCESS (0.099s)
[246.937810] Starting dynamic subtest: xrgb2101010-4tiled
[247.040121] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.109s)
[247.048152] Starting dynamic subtest: xbgr16161616f-4tiled
[247.151197] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.110s)
[247.152020] Subtest draw-method-blt: SUCCESS (1.686s)
[247.273992] [041/131] (770s left) gem_fence_thrash (bo-write-verify-x)
[247.302929] Starting subtest: bo-write-verify-x
[247.318938] Subtest bo-write-verify-x: SKIP (0.015s)
[247.371408] [042/131] (770s left) gem_fence_thrash (bo-copy)
[247.397395] Starting subtest: bo-copy
[247.411049] Subtest bo-copy: SKIP (0.014s)
[247.480818] [043/131] (770s left) syncobj_timeline (multi-wait-submitted-signaled)
[247.529572] Starting subtest: multi-wait-submitted-signaled
[247.530647] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[247.636530] [044/131] (770s left) kms_feature_discovery (psr2)
[247.734787] Starting subtest: psr2
[247.735784] Subtest psr2: SUCCESS (0.000s)
[247.798614] [045/131] (770s left) kms_addfb_basic (bo-too-small)
[247.879690] Starting subtest: bo-too-small
[247.880696] Subtest bo-too-small: SUCCESS (0.000s)
[247.994549] [046/131] (770s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[248.094861] Starting subtest: fbc-psr-sprite-mmap-gtt
[248.095806] Starting dynamic subtest: eDP-1
[248.097565] Dynamic subtest eDP-1: SKIP (0.000s)
[248.099206] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[248.164229] [047/131] (770s left) syncobj_wait (multi-wait-submitted-signaled)
[248.217926] Starting subtest: multi-wait-submitted-signaled
[248.219112] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[248.325164] [048/131] (769s left) gem_userptr_blits (process-exit-busy)
[248.388488] Starting subtest: process-exit-busy
[248.404907] Subtest process-exit-busy: SUCCESS (0.016s)
[248.537354] [049/131] (769s left) kms_chamelium_frames (hdmi-frame-dump)
[248.914549] Subtest hdmi-frame-dump: SKIP (0.000s)
[249.757770] [050/131] (768s left) syncobj_timeline (wait-all-delayed-signal)
[249.810551] Starting subtest: wait-all-delayed-signal
[249.915596] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[249.982280] [051/131] (768s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[250.069284] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[250.071513] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[250.189042] [052/131] (768s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[255.252453] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[255.253469] Starting dynamic subtest: pipe-A-eDP-1
[256.025954] Dynamic subtest pipe-A-eDP-1: SKIP (0.773s)
[256.034699] Starting dynamic subtest: pipe-B-eDP-1
[257.148055] Dynamic subtest pipe-B-eDP-1: SKIP (1.120s)
[257.149872] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.896s)
[258.318393] [053/131] (760s left) api_intel_bb (simple-bb)
[258.385978] Starting subtest: simple-bb
[258.390401] Subtest simple-bb: SUCCESS (0.005s)
[258.524357] [054/131] (759s left) i915_query (query-garbage)
[258.576243] Starting subtest: query-garbage
[258.577293] Subtest query-garbage: SUCCESS (0.000s)
[258.679802] [055/131] (759s left) i915_module_load (reload-no-display)
[258.709982] Starting subtest: reload-no-display
[264.958132] Subtest reload-no-display: SUCCESS (6.248s)
[264.982830] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[264.983540] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[264.985291] [056/131] (753s left) i915_pm_rpm (system-suspend-devices)
[268.043290] Starting subtest: system-suspend-devices
[275.719894] Subtest system-suspend-devices: SUCCESS (7.675s)
[281.090168] [FACT i915_pm_rpm (system-suspend-devices)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[281.092033] [FACT i915_pm_rpm (system-suspend-devices)] new: kernel.kmod_is_loaded.i915: true
[281.097084] [057/131] (742s left) kms_setmode (invalid-clone-single-crtc)
[281.155337] Starting subtest: invalid-clone-single-crtc
[281.157962] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[281.253438] [058/131] (742s left) gem_exec_capture (capture)
[281.316802] Starting subtest: capture
[281.318344] Starting dynamic subtest: rcs0-smem
[282.120425] Dynamic subtest rcs0-smem: SUCCESS (0.803s)
[282.128043] Starting dynamic subtest: bcs0-smem
[283.152609] Dynamic subtest bcs0-smem: SUCCESS (1.032s)
[283.159961] Starting dynamic subtest: vcs0-smem
[283.948187] Dynamic subtest vcs0-smem: SUCCESS (0.796s)
[283.955974] Starting dynamic subtest: vcs1-smem
[284.743305] Dynamic subtest vcs1-smem: SUCCESS (0.794s)
[284.750697] Starting dynamic subtest: vecs0-smem
[286.085591] Dynamic subtest vecs0-smem: FAIL (1.320s)
[286.093451] Starting dynamic subtest: ccs0-smem
[287.379723] Dynamic subtest ccs0-smem: SUCCESS (1.314s)
[287.380780] Subtest capture: FAIL (6.061s)
[287.505731] [059/131] (736s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[287.598199] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[287.600114] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[287.709950] [060/131] (735s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[287.895517] Starting subtest: cursor-rapid-movement-64x21
[287.937543] Subtest cursor-rapid-movement-64x21: SKIP (0.040s)
[288.174010] [061/131] (735s left) syncobj_wait (wait-for-submit-delayed-submit)
[288.229744] Starting subtest: wait-for-submit-delayed-submit
[288.335505] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[288.411373] [062/131] (735s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[288.471410] Starting subtest: yf-tiled-ccs-to-y-tiled
[288.473320] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[288.648583] [063/131] (735s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[288.757755] Starting subtest: short-flip-before-cursor-toggle
[289.675926] Subtest short-flip-before-cursor-toggle: SUCCESS (0.917s)
[290.485443] [064/131] (733s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[290.579813] Starting subtest: nonblocking-crc-frame-sequence
[290.580852] Starting dynamic subtest: pipe-A-eDP-1
[291.324854] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.743s)
[291.332768] Starting dynamic subtest: pipe-B-eDP-1
[292.665397] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.340s)
[292.672835] Starting dynamic subtest: pipe-C-eDP-1
[294.078039] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.410s)
[294.085089] Starting dynamic subtest: pipe-D-eDP-1
[295.398070] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.318s)
[295.399281] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.817s)
[296.179961] [065/131] (727s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[296.262845] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[296.263932] Starting dynamic subtest: pipe-A-eDP-1
[296.272250] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[296.279588] Starting dynamic subtest: pipe-B-eDP-1
[296.287686] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[296.294957] Starting dynamic subtest: pipe-C-eDP-1
[296.303840] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[296.310948] Starting dynamic subtest: pipe-D-eDP-1
[296.319510] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[296.321162] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[298.417860] [066/131] (725s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[298.527387] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[298.529369] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[298.636278] [067/131] (725s left) gem_mmap_gtt (basic-write-read-distinct)
[298.695839] Subtest basic-write-read-distinct: SKIP (0.000s)
[298.760783] [068/131] (725s left) kms_flip (plain-flip-fb-recreate)
[298.860636] Starting subtest: plain-flip-fb-recreate
[298.863970] Starting dynamic subtest: A-eDP1
[307.707590] Dynamic subtest A-eDP1: SUCCESS (8.845s)
[307.720068] Starting dynamic subtest: B-eDP1
[316.636076] Dynamic subtest B-eDP1: SUCCESS (8.927s)
[316.645766] Starting dynamic subtest: C-eDP1
[325.554817] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[325.563579] Starting dynamic subtest: D-eDP1
[334.378836] Dynamic subtest D-eDP1: SUCCESS (8.822s)
[334.381312] Subtest plain-flip-fb-recreate: SUCCESS (35.520s)
[335.548262] [069/131] (688s left) api_intel_allocator (simple-allocator)
[335.605255] Starting subtest: simple-allocator
[335.606241] Starting dynamic subtest: basic
[335.607755] Dynamic subtest basic: SUCCESS (0.004s)
[335.618306] Starting dynamic subtest: parallel-one
[335.785853] Dynamic subtest parallel-one: SUCCESS (0.175s)
[335.796152] Starting dynamic subtest: print
[335.796982] Dynamic subtest print: SUCCESS (0.000s)
[335.806959] Starting dynamic subtest: reuse
[335.807877] Dynamic subtest reuse: SUCCESS (0.000s)
[335.814905] Starting dynamic subtest: reserve
[335.815794] Dynamic subtest reserve: SUCCESS (0.000s)
[335.822872] Starting dynamic subtest: fork-reopen-allocator
[335.823767] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[335.824628] Subtest simple-allocator: SUCCESS (0.194s)
[335.917405] [070/131] (688s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[336.017910] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[336.995399] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.978s)
[337.122907] [071/131] (686s left) kms_big_fb (linear-8bpp-rotate-180)
[337.221400] Starting subtest: linear-8bpp-rotate-180
[338.455347] Subtest linear-8bpp-rotate-180: SUCCESS (1.235s)
[338.641344] [072/131] (685s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[338.738663] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[338.740589] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[338.847106] [073/131] (685s left) kms_atomic_interruptible (legacy-setmode)
[338.929121] Starting subtest: legacy-setmode
[338.930237] Starting dynamic subtest: pipe-A-eDP-1
[345.777606] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.848s)
[345.778474] Subtest legacy-setmode: SUCCESS (6.849s)
[346.559603] [074/131] (677s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-render)
[346.655923] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-render
[350.882061] Subtest fbc-1p-offscren-pri-shrfb-draw-render: SUCCESS (4.227s)
[352.072665] [075/131] (672s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[352.176323] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[358.790189] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.614s)
[358.950536] [076/131] (665s left) gem_exec_async (concurrent-writes)
[359.019066] Starting subtest: concurrent-writes
[359.020205] Starting dynamic subtest: rcs0
[359.035900] Dynamic subtest rcs0: SUCCESS (0.017s)
[359.045843] Starting dynamic subtest: bcs0
[359.046816] Dynamic subtest bcs0: SUCCESS (0.005s)
[359.054979] Starting dynamic subtest: vcs0
[359.056072] Dynamic subtest vcs0: SUCCESS (0.005s)
[359.063448] Starting dynamic subtest: vcs1
[359.064395] Dynamic subtest vcs1: SUCCESS (0.006s)
[359.071665] Starting dynamic subtest: vecs0
[359.072573] Dynamic subtest vecs0: SUCCESS (0.006s)
[359.079713] Starting dynamic subtest: ccs0
[359.080694] Dynamic subtest ccs0: SUCCESS (0.005s)
[359.081610] Subtest concurrent-writes: SUCCESS (0.048s)
[359.292837] [077/131] (664s left) gem_create (create-massive)
[359.345681] Starting subtest: create-massive
[359.346819] Subtest create-massive: SUCCESS (0.000s)
[359.521263] [078/131] (664s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[359.613392] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[359.615036] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[359.695142] [079/131] (664s left) gem_close_race (basic-threads)
[359.751086] Starting subtest: basic-threads
[361.110865] Subtest basic-threads: SUCCESS (1.360s)
[361.285453] [080/131] (663s left) kms_cursor_crc (cursor-alpha-opaque)
[361.370942] Starting subtest: cursor-alpha-opaque
[361.371987] Starting dynamic subtest: pipe-A-eDP-1
[362.014034] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.640s)
[362.022174] Starting dynamic subtest: pipe-D-eDP-1
[363.344179] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[363.345122] Subtest cursor-alpha-opaque: SUCCESS (1.973s)
[364.199700] [081/131] (660s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[364.298187] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[364.299895] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[364.405091] [082/131] (660s left) kms_flip (flip-vs-rmfb-interruptible)
[364.487992] Starting subtest: flip-vs-rmfb-interruptible
[364.490554] Starting dynamic subtest: A-eDP1
[373.190770] Dynamic subtest A-eDP1: SUCCESS (8.699s)
[373.199366] Starting dynamic subtest: B-eDP1
[381.811962] Dynamic subtest B-eDP1: SUCCESS (8.620s)
[381.821133] Starting dynamic subtest: C-eDP1
[390.432221] Dynamic subtest C-eDP1: SUCCESS (8.619s)
[390.442063] Starting dynamic subtest: D-eDP1
[399.059272] Dynamic subtest D-eDP1: SUCCESS (8.624s)
[399.062211] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.572s)
[400.221898] [083/131] (624s left) gem_spin_batch (legacy)
[400.294473] Starting subtest: legacy
[400.295583] Starting dynamic subtest: default
[403.538473] Dynamic subtest default: SUCCESS (3.239s)
[403.547095] Starting dynamic subtest: render
[406.780382] Dynamic subtest render: SUCCESS (3.237s)
[406.798410] Starting dynamic subtest: bsd
[410.018742] Dynamic subtest bsd: SUCCESS (3.236s)
[410.028886] Starting dynamic subtest: bsd1
[413.255328] Dynamic subtest bsd1: SUCCESS (3.234s)
[413.264043] Starting dynamic subtest: bsd2
[416.494309] Dynamic subtest bsd2: SUCCESS (3.236s)
[416.503482] Starting dynamic subtest: blt
[419.732188] Dynamic subtest blt: SUCCESS (3.234s)
[419.740866] Starting dynamic subtest: vebox
[422.971561] Dynamic subtest vebox: SUCCESS (3.236s)
[422.972591] Subtest legacy: SUCCESS (22.672s)
[425.014032] [084/131] (599s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[425.115294] Starting subtest: psr-rgb565-draw-pwrite
[432.033548] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.917s)
[432.140170] [085/131] (592s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[432.240686] Starting subtest: multiplane-rotation-cropping-top
[439.489480] Subtest multiplane-rotation-cropping-top: SUCCESS (7.248s)
[439.610725] [086/131] (584s left) kms_psr (psr-cursor-render)
[439.713481] Starting subtest: psr-cursor-render
[439.714682] Starting dynamic subtest: eDP-1
[441.404928] Dynamic subtest eDP-1: SUCCESS (1.690s)
[441.405804] Subtest psr-cursor-render: SUCCESS (1.691s)
[442.263836] [087/131] (582s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[442.362206] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[442.364508] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[442.462129] [088/131] (582s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[442.557402] Starting subtest: yf-tiled-8bpp-rotate-90
[442.559276] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[442.654989] [089/131] (581s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[442.744086] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[442.745952] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[442.834458] [090/131] (581s left) gem_exec_balancer (semaphore)
[442.899157] Starting subtest: semaphore
[444.906241] Subtest semaphore: SUCCESS (2.006s)
[445.217794] [091/131] (579s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[445.268082] Starting subtest: etime-multi-wait-all-available-unsubmitted
[445.378356] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.107s)
[445.453229] [092/131] (579s left) kms_color (legacy-gamma)
[445.539801] Starting subtest: legacy-gamma
[445.540751] Starting dynamic subtest: pipe-A-eDP-1
[446.251247] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[446.260788] Starting dynamic subtest: pipe-B-eDP-1
[447.655670] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.404s)
[447.663438] Starting dynamic subtest: pipe-C-eDP-1
[449.054573] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.399s)
[449.062998] Starting dynamic subtest: pipe-D-eDP-1
[450.382813] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[450.383827] Subtest legacy-gamma: SUCCESS (4.842s)
[451.164883] [093/131] (573s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[451.280967] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[451.282675] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[451.408844] [094/131] (573s left) gem_exec_nop (basic-parallel)
[451.469290] Starting subtest: basic-parallel
[467.864396] Subtest basic-parallel: SUCCESS (16.394s)
[468.093395] [095/131] (556s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[468.144285] Starting subtest: invalid-multi-wait-unsubmitted
[468.145450] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[468.246929] [096/131] (556s left) gem_mmap_gtt (basic-small-copy-odd)
[468.303829] Subtest basic-small-copy-odd: SKIP (0.000s)
[468.351465] [097/131] (556s left) kms_psr (fbc-psr2-primary-render)
[468.449176] Starting subtest: fbc-psr2-primary-render
[468.450106] Starting dynamic subtest: eDP-1
[468.451813] Dynamic subtest eDP-1: SKIP (0.000s)
[468.453512] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[468.533815] [098/131] (556s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[468.629848] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[468.632982] Starting dynamic subtest: pipe-A-default-mode
[468.915613] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[468.917492] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.284s)
[469.696367] [099/131] (555s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[469.781512] Starting subtest: bad-aux-stride-yf-tiled-ccs
[469.782488] Starting dynamic subtest: pipe-A-eDP-1
[469.791194] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[469.801688] Starting dynamic subtest: pipe-B-eDP-1
[469.810754] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[469.818790] Starting dynamic subtest: pipe-C-eDP-1
[469.827055] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[469.834523] Starting dynamic subtest: pipe-D-eDP-1
[469.842653] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[469.844327] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.004s)
[471.947959] [100/131] (553s left) gem_ctx_persistence (engines-hostile-preempt)
[471.989879] Starting subtest: engines-hostile-preempt
[471.990798] Starting dynamic subtest: rcs0
[472.100452] Dynamic subtest rcs0: SUCCESS (0.109s)
[472.111283] Starting dynamic subtest: bcs0
[472.162823] Dynamic subtest bcs0: SUCCESS (0.061s)
[472.174080] Starting dynamic subtest: vcs0
[473.964055] Dynamic subtest vcs0: SUCCESS (1.797s)
[473.974997] Starting dynamic subtest: vcs1
[475.954299] Dynamic subtest vcs1: SUCCESS (1.990s)
[475.965040] Starting dynamic subtest: vecs0
[477.940887] Dynamic subtest vecs0: SUCCESS (1.983s)
[477.950851] Starting dynamic subtest: ccs0
[478.015433] Dynamic subtest ccs0: SUCCESS (0.075s)
[478.016545] Subtest engines-hostile-preempt: SUCCESS (6.026s)
[478.091966] [101/131] (546s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[478.194068] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[478.195965] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[478.301884] [102/131] (546s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[478.351393] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[478.458212] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[478.541071] [103/131] (546s left) kms_vblank (ts-continuation-idle-hang)
[478.627801] Starting subtest: ts-continuation-idle-hang
[478.630336] Starting dynamic subtest: pipe-A-eDP-1
[504.647309] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.014s)
[504.657780] Starting dynamic subtest: pipe-D-eDP-1
[529.678502] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.027s)
[529.679904] Subtest ts-continuation-idle-hang: SUCCESS (51.047s)
[530.488310] [104/131] (494s left) kms_plane_scaling (planes-upscale-factor-0-25)
[530.581796] Starting subtest: planes-upscale-factor-0-25
[530.582805] Starting dynamic subtest: pipe-A
[530.647068] Dynamic subtest pipe-A: SUCCESS (0.065s)
[530.656939] Starting dynamic subtest: pipe-B
[531.818439] Dynamic subtest pipe-B: SUCCESS (1.171s)
[531.829424] Starting dynamic subtest: pipe-C
[532.918077] Dynamic subtest pipe-C: SUCCESS (1.098s)
[532.928258] Starting dynamic subtest: pipe-D
[534.038193] Dynamic subtest pipe-D: SUCCESS (1.119s)
[534.039090] Subtest planes-upscale-factor-0-25: SUCCESS (3.457s)
[535.191356] [105/131] (489s left) api_intel_allocator (open-vm)
[535.236615] Starting subtest: open-vm
[535.239054] Subtest open-vm: SUCCESS (0.004s)
[535.390182] [106/131] (489s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[535.484693] Starting subtest: fbc-indfb-scaledprimary
[540.605399] Subtest fbc-indfb-scaledprimary: SUCCESS (5.119s)
[541.779726] [107/131] (483s left) i915_drm_fdinfo (virtual-idle)
[541.813020] Starting subtest: virtual-idle
[544.903093] Subtest virtual-idle: SUCCESS (3.087s)
[544.971100] [108/131] (480s left) kms_big_fb (x-tiled-addfb)
[545.074448] Starting subtest: x-tiled-addfb
[545.075373] Subtest x-tiled-addfb: SUCCESS (0.000s)
[545.169168] [109/131] (480s left) kms_psr (fbc-pr-cursor-plane-onoff)
[545.262628] Starting subtest: fbc-pr-cursor-plane-onoff
[545.264631] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[545.330016] [110/131] (480s left) gem_lmem_swapping (verify)
[545.363527] Subtest verify: SKIP (0.000s)
[545.402907] [111/131] (479s left) kms_chamelium_audio (dp-audio-edid)
[545.784194] Subtest dp-audio-edid: SKIP (0.000s)
[546.567239] [112/131] (478s left) drm_read (short-buffer-wakeup)
[546.717114] Starting subtest: short-buffer-wakeup
[578.936900] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[579.075427] [113/131] (446s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[579.167088] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[579.169062] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[579.245183] [114/131] (446s left) kms_psr (psr2-cursor-plane-move)
[579.345260] Starting subtest: psr2-cursor-plane-move
[579.346309] Starting dynamic subtest: eDP-1
[581.060362] Dynamic subtest eDP-1: SUCCESS (1.714s)
[581.061448] Subtest psr2-cursor-plane-move: SUCCESS (1.715s)
[581.834045] [115/131] (443s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[581.933665] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[581.935462] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[582.031125] [116/131] (443s left) prime_self_import (basic-llseek-size)
[582.058855] Starting subtest: basic-llseek-size
[582.077162] Subtest basic-llseek-size: SUCCESS (0.019s)
[582.181768] [117/131] (443s left) kms_lease (page-flip-implicit-plane)
[582.269077] Starting subtest: page-flip-implicit-plane
[582.270177] Starting dynamic subtest: pipe-A-eDP-1
[582.759633] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.489s)
[582.768218] Starting dynamic subtest: pipe-B-eDP-1
[583.870761] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.109s)
[583.878456] Starting dynamic subtest: pipe-C-eDP-1
[584.986812] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[585.000743] Starting dynamic subtest: pipe-D-eDP-1
[586.115751] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[586.116885] Subtest page-flip-implicit-plane: SUCCESS (3.846s)
[586.945835] [118/131] (438s left) gem_exec_store (dword)
[587.008471] Starting subtest: dword
[587.009556] Starting dynamic subtest: rcs0
[587.115311] Dynamic subtest rcs0: SUCCESS (0.106s)
[587.126748] Starting dynamic subtest: bcs0
[587.158292] Dynamic subtest bcs0: SUCCESS (0.042s)
[587.170787] Starting dynamic subtest: vcs0
[587.202383] Dynamic subtest vcs0: SUCCESS (0.042s)
[587.213857] Starting dynamic subtest: vcs1
[587.246272] Dynamic subtest vcs1: SUCCESS (0.041s)
[587.256235] Starting dynamic subtest: vecs0
[587.290437] Dynamic subtest vecs0: SUCCESS (0.043s)
[587.300175] Starting dynamic subtest: ccs0
[587.334436] Dynamic subtest ccs0: SUCCESS (0.042s)
[587.335465] Subtest dword: SUCCESS (0.327s)
[587.512193] [119/131] (438s left) gem_ctx_shared (exec-single-timeline)
[587.565726] Starting subtest: exec-single-timeline
[587.566835] Starting dynamic subtest: rcs0
[588.594666] Dynamic subtest rcs0: SUCCESS (1.026s)
[588.605653] Starting dynamic subtest: bcs0
[589.683534] Dynamic subtest bcs0: SUCCESS (1.087s)
[589.694819] Starting dynamic subtest: vcs0
[590.769625] Dynamic subtest vcs0: SUCCESS (1.086s)
[590.788807] Starting dynamic subtest: vcs1
[591.859791] Dynamic subtest vcs1: SUCCESS (1.085s)
[591.870728] Starting dynamic subtest: vecs0
[592.947980] Dynamic subtest vecs0: SUCCESS (1.086s)
[592.959046] Starting dynamic subtest: ccs0
[594.035792] Dynamic subtest ccs0: SUCCESS (1.085s)
[594.037367] Subtest exec-single-timeline: SUCCESS (6.468s)
[594.267935] [120/131] (431s left) gem_exec_whisper (basic-normal-all)
[594.324118] Starting subtest: basic-normal-all
[597.380710] Subtest basic-normal-all: SUCCESS (3.055s)
[597.558826] [121/131] (428s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[597.618052] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[597.619159] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[597.711724] [122/131] (428s left) kms_pwrite_crc
[599.267482] [123/131] (426s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[599.363333] Starting subtest: y-tiled-32bpp-rotate-90
[599.364955] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[599.471589] [124/131] (426s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[601.109095] Starting subtest: modeset-lpsp-stress-no-wait
[610.944167] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.835s)
[611.016911] [125/131] (414s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[611.113048] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[611.114133] Starting dynamic subtest: pipe-A-eDP-1
[611.118240] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[611.126589] Starting dynamic subtest: pipe-B-eDP-1
[611.130804] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[611.138948] Starting dynamic subtest: pipe-C-eDP-1
[611.143039] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[611.150680] Starting dynamic subtest: pipe-D-eDP-1
[611.154527] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[611.156495] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[613.251704] [126/131] (412s left) gem_exec_params (invalid-fence-in-submit)
[613.301470] Starting subtest: invalid-fence-in-submit
[613.306804] Subtest invalid-fence-in-submit: SUCCESS (0.004s)
[613.422634] [127/131] (412s left) vgem_basic (sysfs)
[613.465241] Starting subtest: sysfs
[613.466137] Subtest sysfs: SUCCESS (0.000s)
[613.515938] [128/131] (412s left) syncobj_wait (multi-wait-for-submit-signaled)
[613.569667] Starting subtest: multi-wait-for-submit-signaled
[613.570686] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[613.667368] [129/131] (412s left) i915_selftest (mock)
[615.558835] Starting subtest: mock
[615.560247] Starting dynamic subtest: sanitycheck
[616.153025] Dynamic subtest sanitycheck: SUCCESS (0.594s)
[616.161512] Starting dynamic subtest: shmem
[616.718782] Dynamic subtest shmem: SUCCESS (0.564s)
[616.726820] Starting dynamic subtest: fence
[624.067836] Dynamic subtest fence: SUCCESS (7.346s)
[624.076531] Starting dynamic subtest: scatterlist
[625.674812] Dynamic subtest scatterlist: SUCCESS (1.605s)
[625.683524] Starting dynamic subtest: syncmap
[628.842656] Dynamic subtest syncmap: SUCCESS (3.166s)
[628.851332] Starting dynamic subtest: uncore
[629.426840] Dynamic subtest uncore: SUCCESS (0.583s)
[629.435442] Starting dynamic subtest: ring
[630.052234] Dynamic subtest ring: SUCCESS (0.624s)
[630.061068] Starting dynamic subtest: engine
[630.689988] Dynamic subtest engine: SUCCESS (0.636s)
[630.699883] Starting dynamic subtest: timelines
[634.522685] Dynamic subtest timelines: SUCCESS (3.830s)
[634.530733] Starting dynamic subtest: requests
[637.904881] Dynamic subtest requests: SUCCESS (3.380s)
[637.913543] Starting dynamic subtest: objects
[638.649835] Dynamic subtest objects: SUCCESS (0.743s)
[638.658618] Starting dynamic subtest: phys
[639.351659] Dynamic subtest phys: SUCCESS (0.700s)
[639.359819] Starting dynamic subtest: dmabuf
[640.038859] Dynamic subtest dmabuf: SUCCESS (0.685s)
[640.047067] Starting dynamic subtest: vma
[645.584584] Dynamic subtest vma: SUCCESS (5.544s)
[645.592115] Starting dynamic subtest: evict
[646.907444] Dynamic subtest evict: SUCCESS (1.321s)
[646.915572] Starting dynamic subtest: gtt
[650.169765] Dynamic subtest gtt: SUCCESS (3.260s)
[650.177914] Starting dynamic subtest: hugepages
[651.006308] Dynamic subtest hugepages: SUCCESS (0.835s)
[651.013402] Starting dynamic subtest: memory_region
[655.055620] Dynamic subtest memory_region: SUCCESS (4.047s)
[655.056892] Subtest mock: SUCCESS (39.495s)
[655.082295] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[655.082992] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[655.084794] [130/131] (370s left) kms_addfb_basic (addfb25-modifier-no-flag)
[656.493789] Starting subtest: addfb25-modifier-no-flag
[656.494715] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[656.550885] [FACT kms_addfb_basic (addfb25-modifier-no-flag)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[656.552680] [FACT kms_addfb_basic (addfb25-modifier-no-flag)] new: kernel.kmod_is_loaded.i915: true
[656.555262] [131/131] (369s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[656.647275] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[656.649298] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[656.745559] Closing watchdogs
results: parsing output: 0/ for test: kms_psr2_sf
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: kms_plane_scaling
results: parsing output: 3/ for test: sw_sync
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_pm_lpsp
results: parsing output: 7/ for test: kms_chamelium_edid
results: parsing output: 8/ for test: kms_async_flips
results: parsing output: 9/ for test: kms_plane
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: kms_cursor_crc
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: perf_pmu
results: parsing output: 16/ for test: prime_vgem
results: parsing output: 17/ for test: gem_create
results: parsing output: 18/ for test: sw_sync
results: parsing output: 19/ for test: perf
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_mmap_gtt
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_watchdog
results: parsing output: 25/ for test: kms_getfb
results: parsing output: 26/ for test: gem_mmap
results: parsing output: 27/ for test: gem_mmap_offset
results: parsing output: 28/ for test: gem_softpin
results: parsing output: 29/ for test: kms_vblank
results: parsing output: 30/ for test: perf_pmu
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: gem_pxp
results: parsing output: 33/ for test: gen9_exec_parse
results: parsing output: 34/ for test: gem_linear_blits
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: kms_joiner
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: gem_softpin
results: parsing output: 39/ for test: kms_draw_crc
results: parsing output: 40/ for test: gem_fence_thrash
results: parsing output: 41/ for test: gem_fence_thrash
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_feature_discovery
results: parsing output: 44/ for test: kms_addfb_basic
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: gem_userptr_blits
results: parsing output: 48/ for test: kms_chamelium_frames
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_psr2_sf
results: parsing output: 52/ for test: api_intel_bb
results: parsing output: 53/ for test: i915_query
results: parsing output: 54/ for test: i915_module_load
results: parsing output: 55/ for test: i915_pm_rpm
results: parsing output: 56/ for test: kms_setmode
results: parsing output: 57/ for test: gem_exec_capture
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_cursor_crc
results: parsing output: 60/ for test: syncobj_wait
results: parsing output: 61/ for test: gem_render_copy
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: kms_pipe_crc_basic
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_mmap_gtt
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: api_intel_allocator
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_atomic_interruptible
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_exec_async
results: parsing output: 76/ for test: gem_create
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_close_race
results: parsing output: 79/ for test: kms_cursor_crc
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: gem_spin_batch
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_rotation_crc
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_exec_balancer
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_color
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: gem_exec_nop
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: gem_mmap_gtt
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: gem_ctx_persistence
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: kms_vblank
results: parsing output: 103/ for test: kms_plane_scaling
results: parsing output: 104/ for test: api_intel_allocator
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: i915_drm_fdinfo
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: gem_lmem_swapping
results: parsing output: 110/ for test: kms_chamelium_audio
results: parsing output: 111/ for test: drm_read
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: prime_self_import
results: parsing output: 116/ for test: kms_lease
results: parsing output: 117/ for test: gem_exec_store
results: parsing output: 118/ for test: gem_ctx_shared
results: parsing output: 119/ for test: gem_exec_whisper
results: parsing output: 120/ for test: syncobj_wait
results: parsing output: 121/ for test: kms_pwrite_crc
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_pm_rpm
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: gem_exec_params
results: parsing output: 126/ for test: vgem_basic
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: i915_selftest
results: parsing output: 129/ for test: kms_addfb_basic
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.