[58.877226] Initializing watchdogs
[58.877277]   /dev/watchdog0
[58.891578] [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]
[58.896225] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.899158] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.902650] [001/132] (960s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[58.979975] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[59.084306] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[59.155831] [002/132] (960s left) gem_reg_read (timestamp-monotonic)
[59.204754] Starting subtest: timestamp-monotonic
[63.615681] Subtest timestamp-monotonic: SUCCESS (4.435s)
[63.689488] [003/132] (955s left) kms_async_flips (test-cursor)
[63.787836] Starting subtest: test-cursor
[64.166852] Starting dynamic subtest: pipe-A-eDP-1
[64.912675] Dynamic subtest pipe-A-eDP-1: SKIP (0.745s)
[65.292760] Starting dynamic subtest: pipe-B-eDP-1
[66.050804] Dynamic subtest pipe-B-eDP-1: SKIP (0.763s)
[66.418699] Starting dynamic subtest: pipe-C-eDP-1
[67.170291] Dynamic subtest pipe-C-eDP-1: SKIP (0.756s)
[67.537421] Starting dynamic subtest: pipe-D-eDP-1
[68.298154] Dynamic subtest pipe-D-eDP-1: SKIP (0.766s)
[68.302622] Subtest test-cursor: SKIP (4.523s)
[69.501336] [004/132] (950s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[69.607304] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[70.727279] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.123s)
[70.875737] [005/132] (948s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[70.922143] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[71.028903] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.105s)
[71.097518] [006/132] (948s left) gem_lmem_swapping (heavy-verify-random-ccs)
[71.145197] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[71.185223] [007/132] (948s left) gem_lmem_swapping (verify)
[71.228024] Subtest verify: SKIP (0.000s)
[71.264310] [008/132] (948s left) kms_cursor_edge_walk (256x256-top-bottom)
[71.360236] Starting subtest: 256x256-top-bottom
[71.362597] Starting dynamic subtest: pipe-A-eDP-1
[74.840639] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.485s)
[74.849854] Starting dynamic subtest: pipe-D-eDP-1
[77.964255] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[77.966826] Subtest 256x256-top-bottom: SUCCESS (6.612s)
[78.768852] [009/132] (940s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[78.841551] Starting subtest: multi-wait-all-for-submit-signaled
[78.843709] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[78.945697] [010/132] (940s left) kms_async_flips (async-flip-suspend-resume)
[79.040583] Starting subtest: async-flip-suspend-resume
[79.431353] Starting dynamic subtest: pipe-A-eDP-1
[97.190961] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.947s)
[97.560542] Starting dynamic subtest: pipe-B-eDP-1
[115.177585] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.965s)
[115.562829] Starting dynamic subtest: pipe-C-eDP-1
[133.201385] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.940s)
[133.567556] Starting dynamic subtest: pipe-D-eDP-1
[151.193076] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.942s)
[151.195321] Subtest async-flip-suspend-resume: SUCCESS (13.312s)
[152.341587] [011/132] (867s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[152.445231] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[159.055090] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.766s)
[159.195433] [012/132] (860s left) kms_flip (wf_vblank-ts-check)
[159.307177] Starting subtest: wf_vblank-ts-check
[159.309381] Starting dynamic subtest: A-eDP1
[180.073249] Dynamic subtest A-eDP1: SUCCESS (20.872s)
[180.083750] Starting dynamic subtest: B-eDP1
[189.012597] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[189.023664] Starting dynamic subtest: C-eDP1
[197.945033] Dynamic subtest C-eDP1: SUCCESS (8.925s)
[197.955814] Starting dynamic subtest: D-eDP1
[206.877027] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[206.881879] Subtest wf_vblank-ts-check: SUCCESS (47.673s)
[208.109697] [013/132] (811s left) kms_lease (lease-revoke)
[208.210224] Starting subtest: lease-revoke
[208.212482] Starting dynamic subtest: pipe-A-eDP-1
[208.242296] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.031s)
[208.250754] Starting dynamic subtest: pipe-B-eDP-1
[208.269140] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.028s)
[208.277719] Starting dynamic subtest: pipe-C-eDP-1
[208.297358] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[208.307408] Starting dynamic subtest: pipe-D-eDP-1
[208.328947] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.028s)
[208.330998] Subtest lease-revoke: SUCCESS (0.119s)
[208.494183] [014/132] (811s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[208.587975] Starting subtest: random-ccs-data-yf-tiled-ccs
[208.590188] Starting dynamic subtest: pipe-A-eDP-1
[208.614817] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[208.627240] Starting dynamic subtest: pipe-B-eDP-1
[208.650818] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[208.658745] Starting dynamic subtest: pipe-C-eDP-1
[208.682337] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[208.690006] Starting dynamic subtest: pipe-D-eDP-1
[208.713376] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[208.717752] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s)
[210.872148] [015/132] (809s left) gem_wait (write-wait)
[210.944996] Starting subtest: write-wait
[210.947330] Starting dynamic subtest: all-engines
[212.070939] Dynamic subtest all-engines: SUCCESS (1.126s)
[212.088450] Starting dynamic subtest: rcs0
[213.126977] Dynamic subtest rcs0: SUCCESS (1.053s)
[213.142872] Starting dynamic subtest: bcs0
[214.184274] Dynamic subtest bcs0: SUCCESS (1.056s)
[214.200179] Starting dynamic subtest: vcs0
[215.239477] Dynamic subtest vcs0: SUCCESS (1.054s)
[215.254933] Starting dynamic subtest: vcs1
[216.293236] Dynamic subtest vcs1: SUCCESS (1.052s)
[216.308986] Starting dynamic subtest: vecs0
[217.346240] Dynamic subtest vecs0: SUCCESS (1.052s)
[217.361147] Starting dynamic subtest: ccs0
[218.402650] Dynamic subtest ccs0: SUCCESS (1.055s)
[218.405380] Subtest write-wait: SUCCESS (7.459s)
[218.615000] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true
[218.618914] [016/132] (801s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[218.677425] Starting subtest: y-tiled-ccs-to-yf-tiled
[218.681538] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[218.879076] [017/132] (801s left) syncobj_wait (wait-for-submit-snapshot)
[218.932135] Starting subtest: wait-for-submit-snapshot
[219.013120] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[219.107747] [018/132] (801s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[219.225529] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[219.229597] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[219.323730] [019/132] (800s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[219.430192] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[219.434465] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[219.520545] [020/132] (800s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[219.621472] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[219.625978] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[219.728262] [021/132] (800s left) kms_color_pipeline (plane-lut1d-lut1d)
[219.819495] Starting subtest: plane-lut1d-lut1d
[219.965084] Starting dynamic subtest: pipe-A-plane-0
[220.289951] Dynamic subtest pipe-A-plane-0: FAIL (0.187s)
[220.300765] Starting dynamic subtest: pipe-A-plane-1
[220.500113] Dynamic subtest pipe-A-plane-1: FAIL (0.176s)
[220.511142] Starting dynamic subtest: pipe-A-plane-2
[220.717946] Dynamic subtest pipe-A-plane-2: FAIL (0.177s)
[221.680825] Starting dynamic subtest: pipe-B-plane-0
[222.128328] Dynamic subtest pipe-B-plane-0: FAIL (0.174s)
[222.137967] Starting dynamic subtest: pipe-B-plane-1
[222.452278] Dynamic subtest pipe-B-plane-1: FAIL (0.166s)
[222.462080] Starting dynamic subtest: pipe-B-plane-2
[222.763845] Dynamic subtest pipe-B-plane-2: FAIL (0.177s)
[223.420004] Starting dynamic subtest: pipe-C-plane-0
[223.951293] Dynamic subtest pipe-C-plane-0: FAIL (0.170s)
[223.961150] Starting dynamic subtest: pipe-C-plane-1
[224.348152] Dynamic subtest pipe-C-plane-1: FAIL (0.196s)
[224.356597] Starting dynamic subtest: pipe-C-plane-2
[224.708573] Dynamic subtest pipe-C-plane-2: FAIL (0.617s)
[225.653379] Starting dynamic subtest: pipe-D-plane-0
[226.259638] Dynamic subtest pipe-D-plane-0: FAIL (0.152s)
[226.268895] Starting dynamic subtest: pipe-D-plane-1
[226.712198] Dynamic subtest pipe-D-plane-1: FAIL (0.628s)
[226.720375] Starting dynamic subtest: pipe-D-plane-2
[227.153601] Dynamic subtest pipe-D-plane-2: FAIL (0.557s)
[227.285479] Subtest plane-lut1d-lut1d: FAIL (7.468s)
[228.099329] [022/132] (792s left) gem_exec_whisper (basic-contexts-forked)
[228.179138] Starting subtest: basic-contexts-forked
[251.704483] Subtest basic-contexts-forked: SUCCESS (23.524s)
[251.893122] [023/132] (768s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[251.953199] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[252.060295] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[252.138394] [024/132] (768s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[252.223974] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[252.228172] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[252.295674] [025/132] (768s left) kms_universal_plane (universal-plane-pageflip-windowed)
[252.388189] Starting subtest: universal-plane-pageflip-windowed
[252.390460] Starting dynamic subtest: pipe-A-eDP-1
[252.987868] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.598s)
[252.996774] Starting dynamic subtest: pipe-B-eDP-1
[254.224691] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.235s)
[254.238874] Starting dynamic subtest: pipe-C-eDP-1
[255.439439] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.211s)
[255.449155] Starting dynamic subtest: pipe-D-eDP-1
[256.674175] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[256.676553] Subtest universal-plane-pageflip-windowed: SUCCESS (4.280s)
[257.533848] [026/132] (762s left) prime_vgem (basic-fence-mmap)
[257.634355] Starting subtest: basic-fence-mmap
[257.639122] Subtest basic-fence-mmap: SKIP (0.000s)
[257.743794] [027/132] (762s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[257.945876] Starting subtest: cursor-rapid-movement-64x21
[258.000392] Subtest cursor-rapid-movement-64x21: SKIP (0.050s)
[258.222639] [028/132] (762s left) kms_flip (2x-flip-vs-expired-vblank)
[258.310398] Starting subtest: 2x-flip-vs-expired-vblank
[258.322043] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[258.401983] [029/132] (762s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[258.499668] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[258.503147] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[258.567172] [030/132] (762s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[258.651292] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[258.653276] Starting dynamic subtest: pipe-A-eDP-1
[258.701473] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[258.710042] Starting dynamic subtest: pipe-B-eDP-1
[258.755022] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[258.763874] Starting dynamic subtest: pipe-C-eDP-1
[258.809723] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[258.818961] Starting dynamic subtest: pipe-D-eDP-1
[258.867126] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[258.870690] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[260.894589] [031/132] (759s left) core_auth (getclient-simple)
[260.933562] Starting subtest: getclient-simple
[260.953806] Subtest getclient-simple: SUCCESS (0.022s)
[261.056963] [032/132] (759s left) kms_flip (2x-dpms-vs-vblank-race)
[261.146243] Starting subtest: 2x-dpms-vs-vblank-race
[261.155240] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[261.236947] [033/132] (759s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[261.332530] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[261.334778] Starting dynamic subtest: pipe-A-eDP-1
[268.093270] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.760s)
[268.114939] Starting dynamic subtest: pipe-B-eDP-1
[275.031662] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.936s)
[275.033885] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.701s)
[275.897452] [034/132] (744s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[276.000533] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[276.004678] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[276.085500] [035/132] (744s left) gem_pread (self)
[276.142647] Subtest self: SKIP (0.000s)
[276.207011] [036/132] (744s left) kms_psr (fbc-psr2-no-drrs)
[276.308221] Starting subtest: fbc-psr2-no-drrs
[276.310525] Starting dynamic subtest: eDP-1
[276.314606] Dynamic subtest eDP-1: SKIP (0.000s)
[276.318744] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[276.379465] [037/132] (744s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[276.481552] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[276.485597] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[276.580064] [038/132] (744s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[276.686101] Starting subtest: 4-tiled-addfb-size-offset-overflow
[276.688389] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[276.786019] [039/132] (744s left) gem_softpin (allocator-nopin)
[276.848246] Starting subtest: allocator-nopin
[276.955822] Subtest allocator-nopin: SUCCESS (0.105s)
[277.073982] [040/132] (743s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[277.166969] Starting subtest: coverage-vs-premult-vs-constant
[277.457722] Starting dynamic subtest: pipe-A-eDP-1
[278.058534] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.597s)
[278.067955] Starting dynamic subtest: pipe-D-eDP-1
[279.422295] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.365s)
[279.424656] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.256s)
[280.268455] [041/132] (740s left) perf (whitelisted-registers-userspace-config)
[280.401801] Starting subtest: whitelisted-registers-userspace-config
[280.404121] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[280.448910] [042/132] (740s left) syncobj_wait (reset-unsignaled)
[280.499953] Starting subtest: reset-unsignaled
[280.502367] Subtest reset-unsignaled: SUCCESS (0.000s)
[280.599161] [043/132] (740s left) syncobj_timeline (single-wait-available-signaled)
[280.651154] Starting subtest: single-wait-available-signaled
[280.653202] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[280.763969] [044/132] (740s left) gem_pread (snoop)
[280.825068] Subtest snoop: SKIP (0.000s)
[280.892080] [045/132] (740s left) i915_pm_rps (thresholds-idle-park)
[280.972762] Starting subtest: thresholds-idle-park
[280.977744] Subtest thresholds-idle-park: SKIP (0.001s)
[281.082428] [046/132] (740s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[281.186404] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[281.190878] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[281.285675] [047/132] (740s left) perf (sysctl-defaults)
[281.370960] Starting subtest: sysctl-defaults
[281.373524] Subtest sysctl-defaults: SUCCESS (0.000s)
[281.439955] [048/132] (739s left) gem_ctx_persistence (hang)
[281.491293] Starting subtest: hang
[281.495605] Subtest hang: SKIP (0.000s)
[281.598808] [049/132] (739s left) kms_hdr (invalid-metadata-sizes)
[281.695431] Starting subtest: invalid-metadata-sizes
[281.700702] Subtest invalid-metadata-sizes: SKIP (0.000s)
[281.813336] [050/132] (739s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[281.926176] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[281.960405] Starting dynamic subtest: pipe-A-plane-0
[282.626608] Dynamic subtest pipe-A-plane-0: SUCCESS (0.666s)
[282.638252] Starting dynamic subtest: pipe-A-plane-3
[283.070884] Dynamic subtest pipe-A-plane-3: SUCCESS (0.444s)
[284.150980] Starting dynamic subtest: pipe-B-plane-0
[284.776747] Dynamic subtest pipe-B-plane-0: SUCCESS (0.633s)
[284.785946] Starting dynamic subtest: pipe-B-plane-3
[285.220983] Dynamic subtest pipe-B-plane-3: SUCCESS (0.444s)
[285.531507] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.602s)
[286.324563] [051/132] (735s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[286.423006] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[286.425239] Starting dynamic subtest: pipe-A-eDP-1
[286.446614] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[286.456657] Starting dynamic subtest: pipe-B-eDP-1
[286.477041] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[286.485225] Starting dynamic subtest: pipe-C-eDP-1
[286.505878] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[286.513872] Starting dynamic subtest: pipe-D-eDP-1
[286.535488] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[286.539853] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[288.683291] [052/132] (732s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[288.780929] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[288.785428] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[289.902867] [053/132] (731s left) kms_invalid_mode (bad-htotal)
[289.990296] Starting subtest: bad-htotal
[289.992608] Starting dynamic subtest: pipe-A-eDP-1
[290.283014] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[290.292316] Starting dynamic subtest: pipe-B-eDP-1
[290.294578] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[290.303039] Starting dynamic subtest: pipe-C-eDP-1
[290.305190] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[290.313720] Starting dynamic subtest: pipe-D-eDP-1
[290.316090] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[290.318345] Subtest bad-htotal: SUCCESS (0.299s)
[291.132192] [054/132] (730s left) kms_psr (psr-dpms)
[291.231283] Starting subtest: psr-dpms
[291.233587] Starting dynamic subtest: eDP-1
[294.173048] Dynamic subtest eDP-1: SUCCESS (2.940s)
[294.175396] Subtest psr-dpms: SUCCESS (2.941s)
[295.041164] [055/132] (726s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[295.147144] Starting subtest: extended-pageflip-modeset-hang-oldfb
[295.149323] Starting dynamic subtest: pipe-A
[303.039449] Dynamic subtest pipe-A: SUCCESS (7.892s)
[303.048642] Starting dynamic subtest: pipe-D
[311.659820] Dynamic subtest pipe-D: SUCCESS (8.619s)
[311.662153] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.516s)
[312.497536] [056/132] (709s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[312.591383] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[312.595708] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[312.719834] [057/132] (709s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[312.814067] Starting subtest: plane-all-modeset-transition-internal-panels
[312.816210] Starting dynamic subtest: pipe-A-eDP-1
[314.144407] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.330s)
[314.423710] Starting dynamic subtest: pipe-B-eDP-1
[315.478438] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.064s)
[315.746120] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.930s)
[316.613799] [058/132] (705s left) gem_exec_params (invalid-batch-start-offset)
[316.678162] Starting subtest: invalid-batch-start-offset
[316.683322] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[316.801754] [059/132] (705s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[316.912049] Starting subtest: y-tiled-32bpp-rotate-270
[316.916566] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[317.006794] [060/132] (704s left) gem_exec_schedule (pi-shared-iova)
[317.189599] Starting subtest: pi-shared-iova
[317.191707] Starting dynamic subtest: rcs0
[317.265558] Dynamic subtest rcs0: SUCCESS (0.079s)
[317.277543] Starting dynamic subtest: vcs0
[317.325536] Dynamic subtest vcs0: SUCCESS (0.058s)
[317.336954] Starting dynamic subtest: vcs1
[317.384422] Dynamic subtest vcs1: SUCCESS (0.058s)
[317.394723] Starting dynamic subtest: vecs0
[317.439517] Dynamic subtest vecs0: SUCCESS (0.055s)
[317.450078] Starting dynamic subtest: ccs0
[317.502898] Dynamic subtest ccs0: SUCCESS (0.063s)
[317.505276] Subtest pi-shared-iova: SUCCESS (0.318s)
[319.163365] [061/132] (702s left) syncobj_wait (single-wait-for-submit-signaled)
[319.221109] Starting subtest: single-wait-for-submit-signaled
[319.222991] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[319.318909] [062/132] (702s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[319.417220] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[319.421192] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[319.512732] [063/132] (702s left) kms_frontbuffer_tracking (fbc-suspend)
[319.612603] Starting subtest: fbc-suspend
[357.556924] Subtest fbc-suspend: SUCCESS (7.429s)
[358.723132] [064/132] (663s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[358.778566] Starting subtest: multi-wait-all-for-submit-available-submitted
[358.780849] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[358.870186] [065/132] (663s left) gem_exec_balancer (bonded-dual)
[358.940959] Starting subtest: bonded-dual
[358.945466] Subtest bonded-dual: SKIP (0.000s)
[359.230101] [066/132] (662s left) kms_vblank (wait-forked-busy-hang)
[359.321209] Starting subtest: wait-forked-busy-hang
[359.323454] Starting dynamic subtest: pipe-A-eDP-1
[386.434876] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.286s)
[386.449007] Starting dynamic subtest: pipe-D-eDP-1
[411.465505] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.015s)
[411.467649] Subtest wait-forked-busy-hang: SUCCESS (52.305s)
[412.304618] [067/132] (609s left) kms_draw_crc (draw-method-render)
[412.425076] Starting subtest: draw-method-render
[412.427048] Starting dynamic subtest: xrgb8888-untiled
[412.702677] Dynamic subtest xrgb8888-untiled: SUCCESS (0.278s)
[412.712140] Starting dynamic subtest: rgb565-untiled
[412.957698] Dynamic subtest rgb565-untiled: SUCCESS (0.255s)
[412.966972] Starting dynamic subtest: xrgb2101010-untiled
[413.190804] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.233s)
[413.200492] Starting dynamic subtest: xbgr16161616f-untiled
[413.434899] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.242s)
[413.445230] Starting dynamic subtest: xrgb8888-xtiled
[413.579346] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s)
[413.590782] Starting dynamic subtest: rgb565-xtiled
[413.701519] Dynamic subtest rgb565-xtiled: SUCCESS (0.120s)
[413.712584] Starting dynamic subtest: xrgb2101010-xtiled
[413.823905] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[413.834748] Starting dynamic subtest: xbgr16161616f-xtiled
[413.957077] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[413.966309] Starting dynamic subtest: xrgb8888-4tiled
[414.079256] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[414.088971] Starting dynamic subtest: rgb565-4tiled
[414.190580] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[414.201415] Starting dynamic subtest: xrgb2101010-4tiled
[414.313029] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[414.322547] Starting dynamic subtest: xbgr16161616f-4tiled
[414.446159] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.132s)
[414.448107] Subtest draw-method-render: SUCCESS (2.024s)
[414.553334] [068/132] (607s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[414.655943] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[414.657918] Starting dynamic subtest: pipe-A-default-mode
[417.384424] Dynamic subtest pipe-A-default-mode: SUCCESS (2.727s)
[417.386806] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.729s)
[418.207068] [069/132] (604s left) kms_dp_linktrain_fallback (dp-fallback)
[418.301578] Starting subtest: dp-fallback
[418.308475] Subtest dp-fallback: SKIP (0.001s)
[418.392528] [070/132] (603s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[418.507180] Starting subtest: fbc-rgb101010-draw-render
[423.115815] Subtest fbc-rgb101010-draw-render: SUCCESS (4.611s)
[424.307839] [071/132] (598s left) kms_big_fb (linear-64bpp-rotate-90)
[424.413068] Starting subtest: linear-64bpp-rotate-90
[424.431950] Subtest linear-64bpp-rotate-90: SKIP (0.019s)
[424.538159] [072/132] (597s left) gem_softpin (softpin)
[424.606522] Starting subtest: softpin
[456.891491] Subtest softpin: SUCCESS (32.282s)
[456.997253] [073/132] (565s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[457.098758] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[457.100690] Starting dynamic subtest: pipe-A-eDP-1
[473.392976] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.430s)
[473.403206] Starting dynamic subtest: pipe-B-eDP-1
[490.349609] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.438s)
[490.359825] Starting dynamic subtest: pipe-C-eDP-1
[507.344843] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.452s)
[507.354953] Starting dynamic subtest: pipe-D-eDP-1
[524.318503] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.374s)
[524.321269] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.699s)
[525.448626] [074/132] (497s left) gem_exec_suspend (basic-s4-devices)
[525.514740] Starting subtest: basic-S4-devices
[525.517610] Starting dynamic subtest: smem
[537.418490] Dynamic subtest smem: SUCCESS (12.102s)
[537.421617] Subtest basic-S4-devices: SUCCESS (12.104s)
[542.615437] [075/132] (484s left) kms_plane_scaling (intel-max-src-size)
[542.748812] Starting subtest: intel-max-src-size
[542.756337] Subtest intel-max-src-size: SKIP (0.000s)
[542.847023] [076/132] (484s left) kms_vrr (seamless-rr-switch-virtual)
[542.931385] Starting subtest: seamless-rr-switch-virtual
[542.938789] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[543.006349] [077/132] (484s left) gem_bad_reloc (negative-reloc)
[543.073606] Subtest negative-reloc: SKIP (0.000s)
[543.144427] [078/132] (484s left) kms_force_connector_basic (force-load-detect)
[543.232602] Starting subtest: force-load-detect
[543.238107] Subtest force-load-detect: SKIP (0.000s)
[543.352095] [079/132] (484s left) kms_setmode (basic-clone-single-crtc)
[543.405836] Starting subtest: basic-clone-single-crtc
[543.413573] Subtest basic-clone-single-crtc: SKIP (0.000s)
[543.508277] [080/132] (484s left) syncobj_timeline (signal)
[543.566963] Starting subtest: signal
[543.569426] Subtest signal: SUCCESS (0.000s)
[543.688549] [081/132] (484s left) kms_pm_dc (dc5-retention-flops)
[544.781506] Starting subtest: dc5-retention-flops
[544.786549] Subtest dc5-retention-flops: SKIP (0.000s)
[544.856038] [082/132] (483s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[544.958053] Starting subtest: primary-yf-tiled-reflect-x-180
[545.019132] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.060s)
[545.123055] [083/132] (482s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[545.227484] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[546.295569] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.068s)
[546.409905] [084/132] (481s left) kms_cursor_crc (cursor-offscreen-32x10)
[546.574794] Starting subtest: cursor-offscreen-32x10
[546.619338] Subtest cursor-offscreen-32x10: SKIP (0.043s)
[546.897972] [085/132] (481s left) kms_psr (fbc-psr-sprite-plane-move)
[546.990279] Starting subtest: fbc-psr-sprite-plane-move
[546.992540] Starting dynamic subtest: eDP-1
[546.997586] Dynamic subtest eDP-1: SKIP (0.000s)
[547.002319] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[547.063987] [086/132] (481s left) kms_content_protection (content-type-change)
[547.200170] Starting subtest: content-type-change
[547.205190] Subtest content-type-change: SKIP (0.000s)
[547.322664] [087/132] (480s left) kms_psr (pr-sprite-mmap-gtt)
[547.412398] Starting subtest: pr-sprite-mmap-gtt
[547.416518] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[547.485916] [088/132] (480s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[547.582197] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[552.089779] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.512s)
[553.286468] [089/132] (474s left) gem_exec_reloc (basic-gtt-read-active)
[553.350497] Subtest basic-gtt-read-active: SKIP (0.000s)
[553.422379] [090/132] (474s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[553.524015] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[553.528698] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[553.625788] [091/132] (474s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[553.721556] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[553.724391] Starting dynamic subtest: pipe-A-eDP-1
[553.795456] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[553.805539] Starting dynamic subtest: pipe-B-eDP-1
[554.948942] Dynamic subtest pipe-B-eDP-1: SKIP (1.150s)
[554.953791] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.231s)
[556.135100] [092/132] (472s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[556.239727] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[560.710979] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.478s)
[561.840444] [093/132] (466s left) kms_setmode (invalid-clone-exclusive-crtc)
[561.898412] Starting subtest: invalid-clone-exclusive-crtc
[561.906606] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[561.995202] [094/132] (466s left) api_intel_allocator (open-vm)
[562.058790] Starting subtest: open-vm
[562.061670] Subtest open-vm: SUCCESS (0.004s)
[562.179571] [095/132] (466s left) i915_pm_freq_api (freq-reset)
[562.246584] Starting subtest: freq-reset
[562.249392] Starting dynamic subtest: gt0
[562.449184] Dynamic subtest gt0: SUCCESS (0.199s)
[562.460801] Starting dynamic subtest: gt1
[562.620751] Dynamic subtest gt1: SUCCESS (0.173s)
[562.623597] Subtest freq-reset: SUCCESS (0.374s)
[562.697291] [096/132] (465s left) gen9_exec_parse (cmd-crossing-page)
[562.772515] Subtest cmd-crossing-page: SKIP (0.000s)
[562.843155] [097/132] (465s left) gem_pxp (hw-rejects-pxp-context)
[562.964483] Starting subtest: hw-rejects-pxp-context
[562.970641] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[563.082176] [098/132] (465s left) drm_mm (drm_mm)
[563.122840] Starting subtest: drm_mm
[563.166025] Starting dynamic subtest: drm_test_mm_init
[563.250837] Dynamic subtest drm_test_mm_init: SUCCESS (0.085s)
[563.261701] Starting dynamic subtest: drm_test_mm_debug
[563.333711] Dynamic subtest drm_test_mm_debug: SUCCESS (0.082s)
[563.345784] Starting dynamic subtest: drm_test_mm_align32
[563.425974] Dynamic subtest drm_test_mm_align32: SUCCESS (0.091s)
[563.437449] Starting dynamic subtest: drm_test_mm_align64
[563.516101] Dynamic subtest drm_test_mm_align64: SUCCESS (0.090s)
[563.526686] Starting dynamic subtest: drm_test_mm_lowest
[563.609407] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.091s)
[563.621825] Starting dynamic subtest: drm_test_mm_highest
[563.701634] Dynamic subtest drm_test_mm_highest: SUCCESS (0.092s)
[563.704356] Subtest drm_mm: SUCCESS (0.580s)
[563.860848] [099/132] (464s left) gem_exec_fence (invalid-fence-array)
[564.284818] Starting subtest: invalid-fence-array
[564.287879] Subtest invalid-fence-array: SUCCESS (0.003s)
[565.529463] [100/132] (463s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[565.644637] Starting subtest: yf-tiled-64bpp-rotate-270
[565.649541] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[565.731662] [101/132] (462s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[565.831110] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[572.925143] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.100s)
[573.041363] [102/132] (455s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[573.100557] Starting subtest: multi-wait-for-submit-submitted-signaled
[573.103600] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[573.190368] [103/132] (455s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[573.290820] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[577.617598] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.333s)
[578.751324] [104/132] (450s left) gem_close_race (multigpu-basic-threads)
[578.831466] Starting subtest: multigpu-basic-threads
[578.836847] Subtest multigpu-basic-threads: SKIP (0.000s)
[579.053610] [105/132] (449s left) gem_eio (hibernate)
[579.295552] Starting subtest: hibernate
[594.033261] Subtest hibernate: SUCCESS (14.741s)
[603.180938] [106/132] (434s left) gem_exec_flush (basic-uc-pro-default)
[603.256797] Starting subtest: basic-uc-pro-default
[608.717799] Subtest basic-uc-pro-default: SUCCESS (5.463s)
[608.907708] [107/132] (429s left) gen9_exec_parse (shadow-peek)
[608.973033] Subtest shadow-peek: SKIP (0.000s)
[609.042989] [108/132] (428s left) gem_exec_balancer (sliced)
[609.104890] Starting subtest: sliced
[609.114283] Subtest sliced: SKIP (0.000s)
[609.404517] [109/132] (428s left) kms_psr (psr2-sprite-plane-move)
[609.511465] Starting subtest: psr2-sprite-plane-move
[609.514033] Starting dynamic subtest: eDP-1
[611.324398] Dynamic subtest eDP-1: SUCCESS (1.811s)
[611.326785] Subtest psr2-sprite-plane-move: SUCCESS (1.812s)
[612.152283] [110/132] (425s left) gem_userptr_blits (unsync-unmap-after-close)
[612.219473] Subtest unsync-unmap-after-close: SKIP (0.000s)
[612.354599] [111/132] (425s left) sysfs_heartbeat_interval (mixed)
[612.421199] Starting subtest: mixed
[612.423666] Starting dynamic subtest: vecs0
[617.617522] Dynamic subtest vecs0: SUCCESS (5.197s)
[617.629456] Starting dynamic subtest: ccs0
[622.839798] Dynamic subtest ccs0: SUCCESS (5.222s)
[622.852600] Starting dynamic subtest: vcs0
[628.070517] Dynamic subtest vcs0: SUCCESS (5.231s)
[628.081941] Starting dynamic subtest: bcs0
[633.302087] Dynamic subtest bcs0: SUCCESS (5.231s)
[633.314380] Starting dynamic subtest: rcs0
[638.516975] Dynamic subtest rcs0: SUCCESS (5.216s)
[638.528485] Starting dynamic subtest: vcs1
[643.707560] Dynamic subtest vcs1: SUCCESS (5.192s)
[643.710039] Subtest mixed: SUCCESS (31.298s)
[643.783181] [112/132] (394s left) i915_pm_rc6_residency (rc6-idle)
[643.843822] Starting subtest: rc6-idle
[643.868201] Starting dynamic subtest: gt0-rcs0
[668.217999] Dynamic subtest gt0-rcs0: SUCCESS (24.359s)
[668.229703] Starting dynamic subtest: gt0-bcs0
[692.496867] Dynamic subtest gt0-bcs0: SUCCESS (24.286s)
[692.518242] Starting dynamic subtest: gt0-ccs0
[716.840606] Dynamic subtest gt0-ccs0: SUCCESS (24.351s)
[716.852021] Starting dynamic subtest: gt1-vcs0
[723.014054] Dynamic subtest gt1-vcs0: SUCCESS (6.171s)
[723.027627] Starting dynamic subtest: gt1-vecs0
[729.191217] Dynamic subtest gt1-vecs0: SUCCESS (6.172s)
[729.194282] Subtest rc6-idle: SUCCESS (85.377s)
[729.273490] [113/132] (308s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[729.372294] Starting subtest: flip-vs-dpms-on-nop-interruptible
[729.374811] Starting dynamic subtest: A-eDP1
[731.190316] Dynamic subtest A-eDP1: SUCCESS (1.818s)
[731.202648] Starting dynamic subtest: B-eDP1
[733.022615] Dynamic subtest B-eDP1: SUCCESS (1.831s)
[733.034375] Starting dynamic subtest: C-eDP1
[734.840691] Dynamic subtest C-eDP1: SUCCESS (1.816s)
[734.851791] Starting dynamic subtest: D-eDP1
[736.674646] Dynamic subtest D-eDP1: SUCCESS (1.833s)
[736.677261] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.309s)
[737.873659] [114/132] (300s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[737.968823] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[737.971587] Starting dynamic subtest: pipe-A
[737.988792] Dynamic subtest pipe-A: SKIP (0.017s)
[738.000264] Starting dynamic subtest: pipe-B
[738.023786] Dynamic subtest pipe-B: SKIP (0.033s)
[738.033830] Starting dynamic subtest: pipe-C
[738.055103] Dynamic subtest pipe-C: SKIP (0.032s)
[738.065438] Starting dynamic subtest: pipe-D
[738.093208] Dynamic subtest pipe-D: SKIP (0.035s)
[738.098422] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.120s)
[738.190724] [115/132] (300s left) prime_mmap (test_aperture_limit)
[738.245813] Starting subtest: test_aperture_limit
[738.248190] Starting dynamic subtest: test_aperture_limit-smem
[738.256044] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s)
[738.261025] Subtest test_aperture_limit: SKIP (0.008s)
[738.389451] [116/132] (300s left) gem_shrink (reclaim)
[738.459530] Starting subtest: reclaim
[740.833124] Subtest reclaim: SUCCESS (2.366s)
[740.994119] [117/132] (297s left) gem_eio (create-ext)
[741.204479] Starting subtest: create-ext
[741.507263] Subtest create-ext: SUCCESS (0.302s)
[741.625270] [118/132] (296s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[741.728647] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[748.527532] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.806s)
[748.665580] [119/132] (289s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[749.046868] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[749.863951] [120/132] (288s left) gem_mmap_offset (partial-unmap)
[749.914640] Starting subtest: partial-unmap
[749.917370] Starting dynamic subtest: smem0
[750.406073] Dynamic subtest smem0: SUCCESS (0.492s)
[750.408804] Subtest partial-unmap: SUCCESS (0.493s)
[750.532033] [121/132] (288s left) gem_mmap_gtt (basic)
[750.593664] Subtest basic: SKIP (0.000s)
[750.657451] [122/132] (288s left) gem_exec_reloc (basic-write-cpu-noreloc)
[750.720575] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[750.819858] [123/132] (287s left) kms_flip (plain-flip-interruptible)
[750.911524] Starting subtest: plain-flip-interruptible
[750.914161] Starting dynamic subtest: A-eDP1
[752.581339] Dynamic subtest A-eDP1: SUCCESS (1.669s)
[752.593807] Starting dynamic subtest: B-eDP1
[754.214418] Dynamic subtest B-eDP1: SUCCESS (1.631s)
[754.227819] Starting dynamic subtest: C-eDP1
[755.833566] Dynamic subtest C-eDP1: SUCCESS (1.617s)
[755.847923] Starting dynamic subtest: D-eDP1
[757.468322] Dynamic subtest D-eDP1: SUCCESS (1.632s)
[757.474531] Subtest plain-flip-interruptible: SUCCESS (6.564s)
[758.640301] [124/132] (280s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[758.696605] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[758.796934] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[758.875487] [125/132] (279s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[759.270801] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[760.043608] [126/132] (278s left) gem_ctx_param (invalid-set-ringsize)
[760.101427] Starting subtest: invalid-set-ringsize
[760.104091] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[760.176492] [127/132] (278s left) perf_pmu (init-busy)
[760.220620] Starting subtest: init-busy
[760.223592] Starting dynamic subtest: rcs0
[760.226779] Dynamic subtest rcs0: SUCCESS (0.001s)
[760.239584] Starting dynamic subtest: bcs0
[760.241824] Dynamic subtest bcs0: SUCCESS (0.000s)
[760.251600] Starting dynamic subtest: vcs0
[760.253743] Dynamic subtest vcs0: SUCCESS (0.001s)
[760.263802] Starting dynamic subtest: vcs1
[760.266457] Dynamic subtest vcs1: SUCCESS (0.001s)
[760.276519] Starting dynamic subtest: vecs0
[760.278647] Dynamic subtest vecs0: SUCCESS (0.001s)
[760.288269] Starting dynamic subtest: ccs0
[760.290566] Dynamic subtest ccs0: SUCCESS (0.000s)
[760.292803] Subtest init-busy: SUCCESS (0.007s)
[760.335155] [128/132] (278s left) gem_userptr_blits (relocations)
[760.396192] Starting subtest: relocations
[760.400341] Subtest relocations: SKIP (0.001s)
[760.534189] [129/132] (278s left) gem_mmap_gtt (hang)
[760.588078] Subtest hang: SKIP (0.000s)
[760.644415] [130/132] (278s left) prime_vgem (busy)
[760.713324] Starting subtest: busy
[760.715712] Starting dynamic subtest: rcs0
[760.771612] Dynamic subtest rcs0: SUCCESS (0.059s)
[760.782770] Starting dynamic subtest: bcs0
[760.823619] Dynamic subtest bcs0: SUCCESS (0.050s)
[760.836276] Starting dynamic subtest: vcs0
[760.871138] Dynamic subtest vcs0: SUCCESS (0.044s)
[760.881508] Starting dynamic subtest: vcs1
[760.919352] Dynamic subtest vcs1: SUCCESS (0.047s)
[760.929633] Starting dynamic subtest: vecs0
[760.967714] Dynamic subtest vecs0: SUCCESS (0.047s)
[760.977971] Starting dynamic subtest: ccs0
[761.014263] Dynamic subtest ccs0: SUCCESS (0.046s)
[761.016222] Subtest busy: SUCCESS (0.302s)
[761.124455] [131/132] (277s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[761.218423] Starting subtest: psr-rgb565-draw-mmap-wc
[768.068504] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.855s)
[768.170554] [132/132] (270s left) gem_exec_schedule (u-semaphore-resolve)
[768.246955] Starting subtest: u-semaphore-resolve
[768.271988] Subtest u-semaphore-resolve: SUCCESS (0.037s)
[768.606221] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: gem_reg_read
results: parsing output: 2/ for test: kms_async_flips
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: gem_lmem_swapping
results: parsing output: 6/ for test: gem_lmem_swapping
results: parsing output: 7/ for test: kms_cursor_edge_walk
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: kms_async_flips
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: kms_lease
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: gem_wait
results: parsing output: 15/ for test: gem_render_copy
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_color_pipeline
results: parsing output: 21/ for test: gem_exec_whisper
results: parsing output: 22/ for test: syncobj_wait
results: parsing output: 23/ for test: kms_plane
results: parsing output: 24/ for test: kms_universal_plane
results: parsing output: 25/ for test: prime_vgem
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: core_auth
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: kms_psr2_sf
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_pread
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: gem_softpin
results: parsing output: 39/ for test: kms_plane_alpha_blend
results: parsing output: 40/ for test: perf
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: gem_pread
results: parsing output: 44/ for test: i915_pm_rps
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: perf
results: parsing output: 47/ for test: gem_ctx_persistence
results: parsing output: 48/ for test: kms_hdr
results: parsing output: 49/ for test: kms_plane
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_invalid_mode
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: kms_busy
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_atomic_transition
results: parsing output: 57/ for test: gem_exec_params
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: gem_exec_schedule
results: parsing output: 60/ for test: syncobj_wait
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: gem_exec_balancer
results: parsing output: 65/ for test: kms_vblank
results: parsing output: 66/ for test: kms_draw_crc
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: kms_dp_linktrain_fallback
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: gem_softpin
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: gem_exec_suspend
results: parsing output: 74/ for test: kms_plane_scaling
results: parsing output: 75/ for test: kms_vrr
results: parsing output: 76/ for test: gem_bad_reloc
results: parsing output: 77/ for test: kms_force_connector_basic
results: parsing output: 78/ for test: kms_setmode
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_pm_dc
results: parsing output: 81/ for test: kms_rotation_crc
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_content_protection
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_exec_reloc
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_psr2_sf
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_setmode
results: parsing output: 93/ for test: api_intel_allocator
results: parsing output: 94/ for test: i915_pm_freq_api
results: parsing output: 95/ for test: gen9_exec_parse
results: parsing output: 96/ for test: gem_pxp
results: parsing output: 97/ for test: drm_mm
results: parsing output: 98/ for test: gem_exec_fence
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_close_race
results: parsing output: 104/ for test: gem_eio
results: parsing output: 105/ for test: gem_exec_flush
results: parsing output: 106/ for test: gen9_exec_parse
results: parsing output: 107/ for test: gem_exec_balancer
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: gem_userptr_blits
results: parsing output: 110/ for test: sysfs_heartbeat_interval
results: parsing output: 111/ for test: i915_pm_rc6_residency
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: kms_plane_scaling
results: parsing output: 114/ for test: prime_mmap
results: parsing output: 115/ for test: gem_shrink
results: parsing output: 116/ for test: gem_eio
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_chamelium_hpd
results: parsing output: 119/ for test: gem_mmap_offset
results: parsing output: 120/ for test: gem_mmap_gtt
results: parsing output: 121/ for test: gem_exec_reloc
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_chamelium_frames
results: parsing output: 125/ for test: gem_ctx_param
results: parsing output: 126/ for test: perf_pmu
results: parsing output: 127/ for test: gem_userptr_blits
results: parsing output: 128/ for test: gem_mmap_gtt
results: parsing output: 129/ for test: prime_vgem
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_exec_schedule
Done.