[61.307161] Initializing watchdogs
[61.307203]   /dev/watchdog0
[61.321519] [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]
[61.325653] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.328892] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.332486] [001/156] (960s left) prime_busy (hang-wait)
[61.408781] Starting subtest: hang-wait
[61.411151] Starting dynamic subtest: rcs0
[87.779424] Dynamic subtest rcs0: SUCCESS (26.459s)
[87.787434] Starting dynamic subtest: bcs0
[94.937604] Dynamic subtest bcs0: SUCCESS (7.154s)
[94.946291] Starting dynamic subtest: vcs0
[101.912935] Dynamic subtest vcs0: SUCCESS (6.972s)
[101.921606] Starting dynamic subtest: vcs1
[108.881981] Dynamic subtest vcs1: SUCCESS (6.967s)
[108.889593] Starting dynamic subtest: vecs0
[115.920358] Dynamic subtest vecs0: SUCCESS (7.039s)
[115.930535] Starting dynamic subtest: ccs0
[129.829359] Dynamic subtest ccs0: SUCCESS (13.903s)
[129.831767] Subtest hang-wait: SUCCESS (68.503s)
[129.962813] [002/156] (891s left) kms_pipe_crc_basic (hang-read-crc)
[130.072716] Starting subtest: hang-read-crc
[130.075054] Starting dynamic subtest: pipe-A-eDP-1
[132.575471] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.503s)
[132.584164] Starting dynamic subtest: pipe-B-eDP-1
[135.439426] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.862s)
[135.448814] Starting dynamic subtest: pipe-C-eDP-1
[138.156206] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.717s)
[138.166711] Starting dynamic subtest: pipe-D-eDP-1
[140.842364] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.686s)
[140.844723] Subtest hang-read-crc: SUCCESS (10.771s)
[141.660768] [003/156] (880s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[141.763968] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[148.564841] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.807s)
[148.698119] [004/156] (873s left) gem_userptr_blits (process-exit)
[148.767256] Starting subtest: process-exit
[148.774409] Subtest process-exit: SUCCESS (0.011s)
[148.911525] [005/156] (873s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[149.014510] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[149.019128] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[149.099239] [006/156] (872s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[149.207566] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[149.211810] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[149.304335] [007/156] (872s left) kms_getfb (getfb-handle-protection)
[149.401914] Starting subtest: getfb-handle-protection
[149.423277] Subtest getfb-handle-protection: SUCCESS (0.022s)
[149.524999] [008/156] (872s left) kms_cursor_crc (cursor-onscreen-128x128)
[149.741287] Starting subtest: cursor-onscreen-128x128
[149.743235] Starting dynamic subtest: pipe-A-eDP-1
[151.871731] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.127s)
[151.904791] Starting dynamic subtest: pipe-D-eDP-1
[154.696348] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.797s)
[154.698580] Subtest cursor-onscreen-128x128: SUCCESS (4.955s)
[155.597968] [009/156] (866s left) perf_pmu (event-wait)
[155.637294] Starting subtest: event-wait
[155.639639] Starting dynamic subtest: rcs0
[155.644157] Dynamic subtest rcs0: SKIP (0.000s)
[155.648525] Subtest event-wait: SKIP (0.000s)
[155.738037] [010/156] (866s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[155.829624] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[161.246922] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.423s)
[162.387061] [011/156] (859s left) api_intel_allocator (fork-simple-stress-signal)
[162.440072] Starting subtest: fork-simple-stress-signal
[167.842279] Subtest fork-simple-stress-signal: SUCCESS (5.403s)
[167.964853] [012/156] (854s left) i915_hangman (engine-error-state-capture)
[168.038777] Starting subtest: engine-error-state-capture
[168.041228] Starting dynamic subtest: rcs0
[171.302525] Dynamic subtest rcs0: SUCCESS (3.262s)
[171.312619] Starting dynamic subtest: bcs0
[177.253732] Dynamic subtest bcs0: SUCCESS (5.950s)
[177.266040] Starting dynamic subtest: vcs0
[183.203399] Dynamic subtest vcs0: SUCCESS (5.948s)
[183.214251] Starting dynamic subtest: vcs1
[188.196628] Dynamic subtest vcs1: SUCCESS (4.992s)
[188.207806] Starting dynamic subtest: vecs0
[193.188365] Dynamic subtest vecs0: SUCCESS (4.990s)
[193.199893] Starting dynamic subtest: ccs0
[198.245049] Dynamic subtest ccs0: SUCCESS (5.055s)
[198.247799] Subtest engine-error-state-capture: SUCCESS (30.205s)
[198.358727] [013/156] (823s left) syncobj_wait (signal)
[198.410552] Starting subtest: signal
[198.412819] Subtest signal: SUCCESS (0.000s)
[198.527026] [014/156] (823s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-pwrite)
[198.626722] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-pwrite
[198.631279] Subtest hdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[198.727246] [015/156] (823s left) gem_exec_reloc (basic-write-wc-active)
[198.795582] Subtest basic-write-wc-active: SKIP (0.000s)
[198.855148] [016/156] (823s left) gem_exec_reloc (basic-concurrent16)
[198.910079] Subtest basic-concurrent16: SKIP (0.000s)
[198.966078] [017/156] (823s left) kms_atomic (plane-overlay-legacy)
[199.053336] Starting subtest: plane-overlay-legacy
[199.058369] Starting dynamic subtest: pipe-A-eDP-1
[199.463383] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.411s)
[199.465276] Subtest plane-overlay-legacy: SUCCESS (0.412s)
[200.315674] [018/156] (822s left) syncobj_timeline (multi-wait-all-signaled)
[200.377679] Starting subtest: multi-wait-all-signaled
[200.380094] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[200.489517] [019/156] (822s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[201.049395] Starting subtest: syncobj-stationary-timeline-chain-engines
[201.189301] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.140s)
[202.418660] [FACT gem_exec_fence (syncobj-stationary-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[202.421612] [020/156] (820s left) api_intel_bb (intel-bb-blit-x)
[202.469724] Starting subtest: intel-bb-blit-x
[206.111050] Subtest intel-bb-blit-x: SUCCESS (3.641s)
[206.216914] [021/156] (816s left) prime_vgem (basic-write)
[206.281276] Starting subtest: basic-write
[206.288377] Subtest basic-write: SKIP (0.006s)
[206.385966] [022/156] (816s left) vgem_basic (unload)
[206.419836] Starting subtest: unload
[235.434539] Subtest unload: SUCCESS (29.013s)
[235.529847] [023/156] (787s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[235.645274] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[242.180884] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.540s)
[242.294317] [024/156] (780s left) gem_exec_whisper (basic-contexts-forked)
[242.352746] Starting subtest: basic-contexts-forked
[265.709770] Subtest basic-contexts-forked: SUCCESS (23.351s)
[265.887319] [025/156] (756s left) gem_basic (create-close)
[265.936965] Starting subtest: create-close
[265.940878] Subtest create-close: SUCCESS (0.000s)
[266.040040] [026/156] (756s left) kms_pm_rpm (basic-pci-d3-state)
[267.583717] Starting subtest: basic-pci-d3-state
[269.075029] Subtest basic-pci-d3-state: SUCCESS (1.494s)
[269.185924] [027/156] (753s left) gem_eio (unwedge-stress)
[269.403618] Starting subtest: unwedge-stress
[269.406059] Starting dynamic subtest: render
[274.144996] Dynamic subtest render: SUCCESS (4.739s)
[274.160202] Starting dynamic subtest: bsd1
[291.762864] Dynamic subtest bsd1: SUCCESS (17.616s)
[291.779585] Starting dynamic subtest: bsd2
[309.793711] Dynamic subtest bsd2: SUCCESS (18.028s)
[309.809619] Starting dynamic subtest: blt
[309.813781] Dynamic subtest blt: SKIP (0.000s)
[309.822891] Starting dynamic subtest: vebox
[331.760062] Dynamic subtest vebox: SUCCESS (21.965s)
[331.762344] Subtest unwedge-stress: SUCCESS (62.352s)
[333.355777] [028/156] (689s left) gem_render_copy_redux (interruptible)
[333.421040] Starting subtest: interruptible
[333.797376] Subtest interruptible: SUCCESS (0.377s)
[333.908262] [029/156] (689s left) kms_content_protection (type1)
[334.047240] Starting subtest: type1
[334.051470] Subtest type1: SKIP (0.000s)
[334.192472] [030/156] (688s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[334.294595] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[334.299088] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[334.369798] [031/156] (688s left) kms_chamelium_hpd (dp-hpd-fast)
[334.750504] Subtest dp-hpd-fast: SKIP (0.000s)
[335.545122] [032/156] (687s left) gem_exec_schedule (submit-early-slice)
[335.614325] Starting subtest: submit-early-slice
[335.616538] Starting dynamic subtest: rcs0
[335.656680] Dynamic subtest rcs0: SUCCESS (0.047s)
[335.670751] Starting dynamic subtest: bcs0
[335.702068] Dynamic subtest bcs0: SUCCESS (0.044s)
[335.713440] Starting dynamic subtest: vcs0
[335.742667] Dynamic subtest vcs0: SUCCESS (0.040s)
[335.753781] Starting dynamic subtest: vcs1
[335.785308] Dynamic subtest vcs1: SUCCESS (0.042s)
[335.794811] Starting dynamic subtest: vecs0
[335.821957] Dynamic subtest vecs0: SUCCESS (0.036s)
[335.833034] Starting dynamic subtest: ccs0
[335.865168] Dynamic subtest ccs0: SUCCESS (0.042s)
[335.867764] Subtest submit-early-slice: SUCCESS (0.257s)
[337.364597] [033/156] (685s left) kms_vrr (flip-basic-fastset)
[337.459625] Starting subtest: flip-basic-fastset
[337.466213] Subtest flip-basic-fastset: SKIP (0.000s)
[337.543733] [034/156] (685s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[337.635757] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[337.637995] Starting dynamic subtest: pipe-A-eDP-1
[337.785151] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.141s)
[337.798501] Starting dynamic subtest: pipe-B-eDP-1
[337.818554] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[337.830420] Starting dynamic subtest: pipe-C-eDP-1
[337.850134] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[337.859284] Starting dynamic subtest: pipe-D-eDP-1
[337.878655] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[337.880587] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.179s)
[340.117714] [035/156] (683s left) gem_set_tiling_vs_pwrite
[340.236832] [036/156] (682s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[340.344828] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[340.349195] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[340.458371] [037/156] (682s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[340.556390] Starting subtest: pr-plane-move-sf-dmg-area
[340.560686] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[340.626365] [038/156] (682s left) kms_frontbuffer_tracking (psrhdr-2p-rte)
[340.722651] Starting subtest: psrhdr-2p-rte
[340.727227] Subtest psrhdr-2p-rte: SKIP (0.000s)
[340.830305] [039/156] (682s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[340.937620] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[340.941829] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[341.026952] [040/156] (682s left) gem_exec_parallel (fds)
[341.074808] Starting subtest: fds
[341.076943] Starting dynamic subtest: rcs0
[344.155343] Dynamic subtest rcs0: SUCCESS (3.078s)
[344.165757] Starting dynamic subtest: bcs0
[348.000991] Dynamic subtest bcs0: SUCCESS (3.845s)
[348.016052] Starting dynamic subtest: vcs0
[351.613641] Dynamic subtest vcs0: SUCCESS (3.611s)
[351.625268] Starting dynamic subtest: vcs1
[355.625236] Dynamic subtest vcs1: SUCCESS (4.011s)
[355.637933] Starting dynamic subtest: vecs0
[359.599064] Dynamic subtest vecs0: SUCCESS (3.972s)
[359.611820] Starting dynamic subtest: ccs0
[363.615058] Dynamic subtest ccs0: SUCCESS (4.013s)
[363.617503] Subtest fds: SUCCESS (22.537s)
[363.823522] [041/156] (659s left) gem_lmem_swapping (basic)
[363.881050] Subtest basic: SKIP (0.000s)
[363.926034] [042/156] (659s left) gem_ctx_shared (detached-shared-gtt)
[363.976324] Starting subtest: detached-shared-gtt
[366.131461] Subtest detached-shared-gtt: SUCCESS (2.153s)
[366.437612] [043/156] (657s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[366.540601] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[366.544791] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[366.621337] [044/156] (656s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[366.671778] Starting subtest: yf-tiled-ccs-to-x-tiled
[366.676299] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[366.869702] [045/156] (656s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[366.966969] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[366.970851] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[367.043671] [046/156] (656s left) gem_exec_reloc (basic-wc-gtt)
[367.096581] Subtest basic-wc-gtt: SKIP (0.000s)
[367.174819] [047/156] (656s left) kms_prop_blob (blob-prop-core)
[367.231188] Starting subtest: blob-prop-core
[367.233134] Subtest blob-prop-core: SUCCESS (0.000s)
[367.325738] [048/156] (656s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[367.382263] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[367.489551] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.107s)
[367.565626] [049/156] (656s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[367.650075] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[367.652338] Starting dynamic subtest: pipe-A-eDP-1
[367.674977] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[367.685748] Starting dynamic subtest: pipe-B-eDP-1
[367.706660] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[367.715743] Starting dynamic subtest: pipe-C-eDP-1
[367.736714] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[367.746095] Starting dynamic subtest: pipe-D-eDP-1
[367.767512] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[367.771821] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[369.970290] [050/156] (653s left) gem_pread (uncached)
[370.032584] Subtest uncached: SKIP (0.000s)
[370.091723] [051/156] (653s left) kms_atomic_transition (plane-all-modeset-transition)
[370.180429] Starting subtest: plane-all-modeset-transition
[370.184875] Subtest plane-all-modeset-transition: SKIP (0.000s)
[370.267580] [052/156] (653s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[370.358087] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[370.362233] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[370.447782] [053/156] (653s left) kms_plane_alpha_blend (alpha-opaque-fb)
[370.544093] Starting subtest: alpha-opaque-fb
[370.843266] Starting dynamic subtest: pipe-A-eDP-1
[371.564889] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.722s)
[371.575604] Starting dynamic subtest: pipe-D-eDP-1
[372.927647] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.359s)
[372.930089] Subtest alpha-opaque-fb: SUCCESS (2.384s)
[373.729416] [054/156] (650s left) syncobj_wait (single-wait-signaled)
[373.786807] Starting subtest: single-wait-signaled
[373.789077] Subtest single-wait-signaled: SUCCESS (0.000s)
[373.900560] [055/156] (650s left) gem_mmap_wc (read-write-distinct)
[373.945607] Subtest read-write-distinct: SKIP (0.000s)
[374.010095] [056/156] (650s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[374.110049] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[374.112353] Starting dynamic subtest: pipe-A-default-mode
[375.285071] Dynamic subtest pipe-A-default-mode: SKIP (1.172s)
[375.289154] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.173s)
[375.421340] [057/156] (648s left) gem_tiled_pread_basic (basic)
[375.484730] Subtest basic: SKIP (0.000s)
[375.549483] [058/156] (648s left) kms_async_flips (async-flip-hang)
[375.642308] Starting subtest: async-flip-hang
[376.018323] Starting dynamic subtest: pipe-A-eDP-1
[391.776267] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.756s)
[392.160328] Starting dynamic subtest: pipe-B-eDP-1
[407.777703] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.626s)
[408.172558] Starting dynamic subtest: pipe-C-eDP-1
[423.773308] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.607s)
[424.160502] Starting dynamic subtest: pipe-D-eDP-1
[439.774440] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.618s)
[439.777117] Subtest async-flip-hang: SUCCESS (64.127s)
[441.011128] [059/156] (583s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[441.118413] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[441.122756] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[441.223418] [060/156] (582s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-move)
[441.326110] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-move
[441.330376] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[441.433725] [061/156] (582s left) gem_mmap (pf-nonblock)
[441.494318] Subtest pf-nonblock: SKIP (0.000s)
[441.551089] [062/156] (582s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[441.675021] Starting subtest: cursorA-vs-flipA-legacy
[452.801597] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.126s)
[453.639125] [063/156] (570s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[453.708578] Starting subtest: yf-tiled-to-vebox-x-tiled
[453.713277] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[453.888943] [064/156] (570s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[453.990200] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc
[453.994236] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[454.092711] [065/156] (570s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[454.186732] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[454.190842] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[454.288366] [066/156] (570s left) i915_pm_rps (waitboost)
[454.352128] Starting subtest: waitboost
[460.449858] Subtest waitboost: SUCCESS (6.100s)
[460.569801] [067/156] (563s left) gem_exec_fence (basic-await)
[460.744748] Starting subtest: basic-await
[460.747175] Starting dynamic subtest: rcs0
[460.824569] Dynamic subtest rcs0: SUCCESS (0.079s)
[460.840054] Starting dynamic subtest: bcs0
[460.897467] Dynamic subtest bcs0: SUCCESS (0.072s)
[460.909298] Starting dynamic subtest: vcs0
[460.973428] Dynamic subtest vcs0: SUCCESS (0.074s)
[460.987122] Starting dynamic subtest: vcs1
[461.047373] Dynamic subtest vcs1: SUCCESS (0.073s)
[461.060198] Starting dynamic subtest: vecs0
[461.120757] Dynamic subtest vecs0: SUCCESS (0.072s)
[461.133397] Starting dynamic subtest: ccs0
[461.195469] Dynamic subtest ccs0: SUCCESS (0.072s)
[461.197961] Subtest basic-await: SUCCESS (0.452s)
[463.364042] [068/156] (561s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-render)
[463.457358] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-render
[463.461302] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[463.568674] [069/156] (561s left) i915_query (query-topology-kernel-writes)
[463.622407] Starting subtest: query-topology-kernel-writes
[463.624461] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[463.727534] [070/156] (560s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-blt)
[463.836984] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-blt
[463.841447] Subtest hdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[463.936680] [071/156] (560s left) kms_frontbuffer_tracking (fbchdr-suspend)
[464.036866] Starting subtest: fbchdr-suspend
[464.041209] Subtest fbchdr-suspend: SKIP (0.000s)
[464.143444] [072/156] (560s left) kms_flip (2x-flip-vs-expired-vblank)
[464.239298] Starting subtest: 2x-flip-vs-expired-vblank
[464.248443] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[464.339394] [073/156] (560s left) kms_draw_crc (draw-method-mmap-wc)
[464.421517] Starting subtest: draw-method-mmap-wc
[464.423552] Starting dynamic subtest: xrgb8888-untiled
[464.666874] Dynamic subtest xrgb8888-untiled: SUCCESS (0.246s)
[464.676779] Starting dynamic subtest: rgb565-untiled
[464.900552] Dynamic subtest rgb565-untiled: SUCCESS (0.232s)
[464.911946] Starting dynamic subtest: xrgb2101010-untiled
[465.123495] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[465.138676] Starting dynamic subtest: xbgr16161616f-untiled
[465.345144] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[465.357777] Starting dynamic subtest: xrgb8888-xtiled
[465.489153] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.142s)
[465.498706] Starting dynamic subtest: rgb565-xtiled
[465.612117] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[465.621873] Starting dynamic subtest: xrgb2101010-xtiled
[465.744994] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.132s)
[465.755569] Starting dynamic subtest: xbgr16161616f-xtiled
[465.878069] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[465.888535] Starting dynamic subtest: xrgb8888-4tiled
[466.045186] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.166s)
[466.056728] Starting dynamic subtest: rgb565-4tiled
[466.189341] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[466.198545] Starting dynamic subtest: xrgb2101010-4tiled
[466.345151] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.155s)
[466.355564] Starting dynamic subtest: xbgr16161616f-4tiled
[466.522793] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.176s)
[466.524700] Subtest draw-method-mmap-wc: SUCCESS (2.102s)
[466.621524] [074/156] (558s left) kms_lease (atomic-implicit-crtc)
[466.710950] Starting subtest: atomic-implicit-crtc
[466.712798] Starting dynamic subtest: pipe-A-eDP-1
[466.722129] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[466.731964] Starting dynamic subtest: pipe-B-eDP-1
[466.741172] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[466.750863] Starting dynamic subtest: pipe-C-eDP-1
[466.759352] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[466.768641] Starting dynamic subtest: pipe-D-eDP-1
[466.777299] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[466.778827] Subtest atomic-implicit-crtc: SUCCESS (0.036s)
[466.853508] [075/156] (557s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[466.981478] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[466.985437] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[467.126187] [076/156] (557s left) kms_color (ctm-green-to-red)
[467.215112] Starting subtest: ctm-green-to-red
[467.216904] Starting dynamic subtest: pipe-A-eDP-1
[467.903501] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.686s)
[467.914155] Starting dynamic subtest: pipe-B-eDP-1
[469.387404] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.484s)
[469.398430] Starting dynamic subtest: pipe-C-eDP-1
[470.688494] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.302s)
[470.698632] Starting dynamic subtest: pipe-D-eDP-1
[472.073927] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.384s)
[472.076517] Subtest ctm-green-to-red: SUCCESS (4.859s)
[472.886144] [077/156] (552s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[472.981619] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[476.680369] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.702s)
[477.890983] [078/156] (547s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[477.982597] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[477.986981] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[478.091189] [079/156] (546s left) kms_cursor_edge_walk (256x256-top-bottom)
[478.180591] Starting subtest: 256x256-top-bottom
[478.183095] Starting dynamic subtest: pipe-A-eDP-1
[481.659756] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.475s)
[481.670127] Starting dynamic subtest: pipe-D-eDP-1
[484.869804] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.213s)
[484.872166] Subtest 256x256-top-bottom: SUCCESS (6.691s)
[485.680668] [080/156] (539s left) syncobj_timeline (etime-single-wait-submitted)
[485.729694] Starting subtest: etime-single-wait-submitted
[485.834883] Subtest etime-single-wait-submitted: SUCCESS (0.103s)
[485.912840] [081/156] (539s left) gem_mmap_gtt (fault-concurrent-x)
[485.958561] Subtest fault-concurrent-X: SKIP (0.000s)
[486.017749] [082/156] (539s left) kms_psr (fbc-psr2-dpms)
[486.105446] Starting subtest: fbc-psr2-dpms
[486.107685] Starting dynamic subtest: eDP-1
[486.111674] Dynamic subtest eDP-1: SKIP (0.000s)
[486.115713] Subtest fbc-psr2-dpms: SKIP (0.001s)
[486.175467] [083/156] (538s left) kms_plane (plane-position-hole)
[486.259884] Starting subtest: plane-position-hole
[486.791851] Starting dynamic subtest: pipe-A-plane-1
[488.082415] Dynamic subtest pipe-A-plane-1: SUCCESS (1.290s)
[488.093292] Starting dynamic subtest: pipe-A-plane-2
[489.384316] Dynamic subtest pipe-A-plane-2: SUCCESS (1.303s)
[489.394908] Starting dynamic subtest: pipe-A-plane-3
[490.729184] Dynamic subtest pipe-A-plane-3: SUCCESS (1.342s)
[490.741825] Starting dynamic subtest: pipe-A-plane-4
[492.053432] Dynamic subtest pipe-A-plane-4: SUCCESS (1.326s)
[492.064968] Starting dynamic subtest: pipe-A-plane-5
[492.080468] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[493.310043] Starting dynamic subtest: pipe-B-plane-1
[494.636260] Dynamic subtest pipe-B-plane-1: SUCCESS (1.332s)
[494.646803] Starting dynamic subtest: pipe-B-plane-2
[495.980929] Dynamic subtest pipe-B-plane-2: SUCCESS (1.347s)
[495.990940] Starting dynamic subtest: pipe-B-plane-3
[497.284749] Dynamic subtest pipe-B-plane-3: SUCCESS (1.302s)
[497.294728] Starting dynamic subtest: pipe-B-plane-4
[498.585236] Dynamic subtest pipe-B-plane-4: SUCCESS (1.300s)
[498.595551] Starting dynamic subtest: pipe-B-plane-5
[498.612219] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[498.614080] Subtest plane-position-hole: SUCCESS (12.351s)
[499.393097] [084/156] (525s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[499.497546] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[500.321477] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.826s)
[500.475381] [085/156] (524s left) gem_exec_schedule (noreorder-priority)
[500.664859] Starting subtest: noreorder-priority
[500.667374] Starting dynamic subtest: rcs0
[501.814702] Dynamic subtest rcs0: SUCCESS (1.153s)
[501.825698] Starting dynamic subtest: vcs0
[503.300975] Dynamic subtest vcs0: SUCCESS (1.482s)
[503.313669] Starting dynamic subtest: vcs1
[505.277085] Dynamic subtest vcs1: SUCCESS (1.974s)
[505.290062] Starting dynamic subtest: vecs0
[507.275872] Dynamic subtest vecs0: SUCCESS (1.997s)
[507.286479] Starting dynamic subtest: ccs0
[508.412876] Dynamic subtest ccs0: SUCCESS (1.135s)
[508.415642] Subtest noreorder-priority: SUCCESS (7.751s)
[508.594996] [086/156] (516s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-render)
[508.690881] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-render
[508.695374] Subtest psrhdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[508.796541] [087/156] (516s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[508.903238] Starting subtest: 4-tiled-32bpp-rotate-90
[508.923937] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.020s)
[509.049364] [088/156] (516s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite)
[509.138160] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite
[509.142387] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[509.215326] [089/156] (516s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[509.306813] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[509.309057] Starting dynamic subtest: pipe-A-eDP-1
[510.514095] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.209s)
[510.524852] Starting dynamic subtest: pipe-B-eDP-1
[512.787174] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.271s)
[512.797879] Starting dynamic subtest: pipe-C-eDP-1
[515.123860] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.335s)
[515.134674] Starting dynamic subtest: pipe-D-eDP-1
[517.449155] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.324s)
[517.451503] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.145s)
[518.608632] [090/156] (506s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-blt)
[518.716395] Starting subtest: fbcpsrhdr-rgb101010-draw-blt
[518.720677] Subtest fbcpsrhdr-rgb101010-draw-blt: SKIP (0.000s)
[518.836224] [091/156] (506s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[518.940609] Starting subtest: y-tiled-64bpp-rotate-270
[518.945065] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[519.059367] [092/156] (506s left) prime_mmap (test_dup)
[519.112176] Starting subtest: test_dup
[519.114379] Starting dynamic subtest: test_dup-smem
[519.140590] Dynamic subtest test_dup-smem: SUCCESS (0.030s)
[519.142933] Subtest test_dup: SUCCESS (0.031s)
[519.215193] [093/156] (506s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[519.299826] Starting subtest: primary-y-tiled-reflect-x-270
[519.304197] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[519.373437] [094/156] (506s left) kms_plane_scaling (planes-downscale-factor-0-75)
[519.453082] Starting subtest: planes-downscale-factor-0-75
[519.455380] Starting dynamic subtest: pipe-A
[519.475553] Dynamic subtest pipe-A: SKIP (0.019s)
[519.486108] Starting dynamic subtest: pipe-B
[519.508982] Dynamic subtest pipe-B: SKIP (0.033s)
[519.519325] Starting dynamic subtest: pipe-C
[519.541999] Dynamic subtest pipe-C: SKIP (0.033s)
[519.551517] Starting dynamic subtest: pipe-D
[519.575202] Dynamic subtest pipe-D: SKIP (0.033s)
[519.578624] Subtest planes-downscale-factor-0-75: SKIP (0.121s)
[519.671736] [095/156] (506s left) i915_pm_rc6_residency (rc6-idle)
[519.717646] Starting subtest: rc6-idle
[519.735642] Starting dynamic subtest: gt0-rcs0
[544.032023] Dynamic subtest gt0-rcs0: SUCCESS (24.295s)
[544.042779] Starting dynamic subtest: gt0-bcs0
[568.379696] Dynamic subtest gt0-bcs0: SUCCESS (24.345s)
[568.389717] Starting dynamic subtest: gt0-ccs0
[592.790637] Dynamic subtest gt0-ccs0: SUCCESS (24.408s)
[592.800230] Starting dynamic subtest: gt1-vcs0
[598.965222] Dynamic subtest gt1-vcs0: SUCCESS (6.171s)
[598.975715] Starting dynamic subtest: gt1-vecs0
[605.138657] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[605.141359] Subtest rc6-idle: SUCCESS (85.420s)
[605.222561] [096/156] (420s left) kms_addfb_basic (tile-pitch-mismatch)
[605.289610] Starting subtest: tile-pitch-mismatch
[605.294387] Subtest tile-pitch-mismatch: SKIP (0.000s)
[605.420571] [097/156] (420s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-render)
[605.510680] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-render
[605.515201] Subtest psrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[605.620486] [098/156] (420s left) kms_pm_dc (dc5-dpms-negative)
[606.716060] Starting subtest: dc5-dpms-negative
[606.720503] Subtest dc5-dpms-negative: SKIP (0.000s)
[606.787585] [099/156] (419s left) kms_big_fb (linear-16bpp-rotate-180)
[606.883404] Starting subtest: linear-16bpp-rotate-180
[608.373597] Subtest linear-16bpp-rotate-180: SUCCESS (1.489s)
[608.481239] [100/156] (417s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-plflip-blt)
[608.573870] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-plflip-blt
[608.577665] Subtest fbcpsrhdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[608.670248] [101/156] (417s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[608.758889] Starting subtest: fbc-rgb101010-draw-render
[611.312062] Subtest fbc-rgb101010-draw-render: SUCCESS (2.558s)
[612.516469] [102/156] (413s left) dmabuf_sync_file (export-wait-after-attach)
[612.561208] Starting subtest: export-wait-after-attach
[612.563297] Subtest export-wait-after-attach: SUCCESS (0.001s)
[612.614354] [103/156] (413s left) sw_sync (sync_busy_fork)
[612.648999] Starting subtest: sync_busy_fork
[613.658086] Subtest sync_busy_fork: SUCCESS (1.012s)
[613.716534] [104/156] (412s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[613.813312] Starting subtest: x-tiled-32bpp-rotate-0
[615.303806] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.490s)
[615.436939] [105/156] (410s left) gem_ctx_exec (basic-close-race)
[615.496859] Starting subtest: basic-close-race
[621.479866] Subtest basic-close-race: SUCCESS (5.981s)
[621.611735] [106/156] (404s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[621.698981] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[621.725740] Starting dynamic subtest: pipe-A-plane-0
[622.014383] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[622.024982] Starting dynamic subtest: pipe-A-plane-3
[622.248907] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[623.384772] Starting dynamic subtest: pipe-B-plane-0
[623.695778] Dynamic subtest pipe-B-plane-0: SUCCESS (0.322s)
[623.706371] Starting dynamic subtest: pipe-B-plane-3
[623.929082] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[624.240193] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.540s)
[625.064149] [107/156] (401s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[625.171662] Starting subtest: fbc-rgb565-draw-render
[629.338476] Subtest fbc-rgb565-draw-render: SUCCESS (4.173s)
[630.553970] [108/156] (395s left) gen9_exec_parse (bb-start-out)
[630.608246] Subtest bb-start-out: SKIP (0.000s)
[630.685445] [109/156] (395s left) gem_exec_reloc (basic-write-read)
[630.753827] Subtest basic-write-read: SKIP (0.000s)
[630.831859] [110/156] (395s left) gem_ctx_isolation (dirty-switch)
[630.897748] Starting subtest: dirty-switch
[630.900231] Starting dynamic subtest: rcs0
[631.083752] Dynamic subtest rcs0: SUCCESS (0.185s)
[631.093730] Starting dynamic subtest: bcs0
[631.281275] Dynamic subtest bcs0: SUCCESS (0.196s)
[631.291668] Starting dynamic subtest: vcs0
[631.515510] Dynamic subtest vcs0: SUCCESS (0.233s)
[631.527933] Starting dynamic subtest: vcs1
[633.490450] Dynamic subtest vcs1: SUCCESS (1.974s)
[633.501302] Starting dynamic subtest: vecs0
[635.540186] Dynamic subtest vecs0: SUCCESS (2.049s)
[635.551857] Starting dynamic subtest: ccs0
[637.542283] Dynamic subtest ccs0: SUCCESS (2.000s)
[637.544604] Subtest dirty-switch: SUCCESS (6.645s)
[637.766943] [111/156] (388s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[637.878932] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[637.883460] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[637.982333] [112/156] (388s left) i915_drm_fdinfo (virtual-busy-hang)
[638.020611] Starting subtest: virtual-busy-hang
[638.024965] Subtest virtual-busy-hang: SKIP (0.000s)
[638.090279] [113/156] (388s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[638.185584] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[638.187838] Starting dynamic subtest: pipe-A-eDP-1
[638.274612] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[638.285127] Starting dynamic subtest: pipe-B-eDP-1
[639.422083] Dynamic subtest pipe-B-eDP-1: SKIP (1.146s)
[639.426528] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.237s)
[640.625821] [114/156] (385s left) gem_ppgtt (flink-and-close-vma-leak)
[640.681963] Starting subtest: flink-and-close-vma-leak
[640.722920] Subtest flink-and-close-vma-leak: SUCCESS (0.041s)
[640.828309] [115/156] (385s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-pgflip-blt)
[640.919056] Starting subtest: fbchdr-2p-primscrn-shrfb-pgflip-blt
[640.922978] Subtest fbchdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[641.028427] [116/156] (385s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-move)
[641.128164] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-move
[641.132296] Subtest psrhdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[641.222149] [117/156] (385s left) kms_cursor_crc (cursor-random-256x85)
[641.488288] Starting subtest: cursor-random-256x85
[641.535735] Subtest cursor-random-256x85: SKIP (0.044s)
[641.703918] [118/156] (384s left) kms_psr (fbc-psr-cursor-plane-onoff)
[641.786089] Starting subtest: fbc-psr-cursor-plane-onoff
[641.787905] Starting dynamic subtest: eDP-1
[641.791211] Dynamic subtest eDP-1: SKIP (0.000s)
[641.794491] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[641.862201] [119/156] (384s left) kms_psr (psr-cursor-mmap-cpu)
[641.947166] Starting subtest: psr-cursor-mmap-cpu
[641.948951] Starting dynamic subtest: eDP-1
[643.703946] Dynamic subtest eDP-1: SUCCESS (1.755s)
[643.706242] Subtest psr-cursor-mmap-cpu: SUCCESS (1.757s)
[644.590848] [120/156] (382s left) gem_userptr_blits (sd-probe)
[644.651971] Starting subtest: sd-probe
[644.654281] Subtest sd-probe: SUCCESS (0.000s)
[644.783719] [121/156] (381s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[644.872757] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[651.766873] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.899s)
[651.915935] [122/156] (374s left) kms_frontbuffer_tracking (fbchdr-1p-rte)
[652.017598] Starting subtest: fbchdr-1p-rte
[652.021941] Subtest fbchdr-1p-rte: SKIP (0.000s)
[652.130689] [123/156] (374s left) syncobj_basic (bad-pad-fd-to-handle)
[652.176600] Starting subtest: bad-pad-fd-to-handle
[652.178936] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[652.268491] [124/156] (374s left) kms_chamelium_color (gamma)
[652.365546] Subtest gamma: SKIP (0.000s)
[652.409914] [125/156] (374s left) gem_exec_balancer (busy)
[652.468277] Starting subtest: busy
[654.290770] Subtest busy: SUCCESS (1.821s)
[654.626844] [126/156] (372s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[654.678046] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[654.680065] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[654.768903] [127/156] (372s left) syncobj_timeline (wait-for-submit-complex)
[654.820006] Starting subtest: wait-for-submit-complex
[654.884770] Subtest wait-for-submit-complex: SUCCESS (0.063s)
[654.978499] [128/156] (372s left) gem_ctx_shared (single-timeline)
[655.038229] Starting subtest: single-timeline
[655.065558] Subtest single-timeline: SUCCESS (0.025s)
[655.312516] [129/156] (371s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[655.415190] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[655.419098] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[655.515137] [130/156] (371s left) gem_mmap_offset (partial-unmap)
[655.571413] Starting subtest: partial-unmap
[655.573362] Starting dynamic subtest: smem0
[656.058991] Dynamic subtest smem0: SUCCESS (0.487s)
[656.061617] Subtest partial-unmap: SUCCESS (0.488s)
[656.188323] [131/156] (370s left) kms_flip (2x-flip-vs-dpms)
[656.278700] Starting subtest: 2x-flip-vs-dpms
[656.287314] Subtest 2x-flip-vs-dpms: SKIP (0.010s)
[656.366388] [132/156] (370s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[656.460739] Starting subtest: yf-tiled-8bpp-rotate-180
[656.465230] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[656.559808] [133/156] (370s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-onoff)
[656.656497] Starting subtest: hdr-1p-primscrn-cur-indfb-onoff
[656.660648] Subtest hdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[656.770473] [134/156] (370s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[656.878484] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[656.882711] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[656.977560] [135/156] (370s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[657.081180] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[657.084588] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[657.167354] [136/156] (370s left) kms_feature_discovery (display-1x)
[657.255483] Starting subtest: display-1x
[657.257417] Subtest display-1x: SUCCESS (0.000s)
[657.331291] [137/156] (370s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[657.413119] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[657.415024] Starting dynamic subtest: pipe-A-default-mode
[660.196618] Dynamic subtest pipe-A-default-mode: SUCCESS (2.783s)
[660.198993] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.785s)
[661.027718] [138/156] (366s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[661.120563] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[661.124792] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[661.224195] [139/156] (366s left) kms_vblank (query-forked-busy-hang)
[661.311642] Starting subtest: query-forked-busy-hang
[661.313979] Starting dynamic subtest: pipe-A-eDP-1
[688.071935] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.757s)
[688.086820] Starting dynamic subtest: pipe-D-eDP-1
[703.051236] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.978s)
[703.053712] Subtest query-forked-busy-hang: SUCCESS (41.740s)
[703.885841] [140/156] (323s left) kms_frontbuffer_tracking (basic)
[703.978491] Starting subtest: basic
[707.299503] Subtest basic: SUCCESS (3.326s)
[707.403936] [141/156] (320s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-move)
[707.493084] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-move
[707.496457] Subtest fbchdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[707.580577] [142/156] (320s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[707.673178] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[707.676542] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[707.781645] [143/156] (319s left) kms_scaling_modes (scaling-mode-none)
[707.874159] Starting subtest: scaling-mode-none
[707.875989] Starting dynamic subtest: pipe-A-eDP-1
[707.969486] Dynamic subtest pipe-A-eDP-1: SKIP (0.094s)
[707.981208] Starting dynamic subtest: pipe-B-eDP-1
[708.008203] Dynamic subtest pipe-B-eDP-1: SKIP (0.036s)
[708.020619] Starting dynamic subtest: pipe-C-eDP-1
[708.045188] Dynamic subtest pipe-C-eDP-1: SKIP (0.035s)
[708.056211] Starting dynamic subtest: pipe-D-eDP-1
[708.083324] Dynamic subtest pipe-D-eDP-1: SKIP (0.037s)
[708.087119] Subtest scaling-mode-none: SKIP (0.209s)
[708.208590] [144/156] (319s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-pwrite)
[708.304762] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-pwrite
[708.308226] Subtest fbchdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[708.418605] [145/156] (319s left) perf_pmu (multi-client)
[708.456375] Starting subtest: multi-client
[708.458321] Starting dynamic subtest: rcs0
[709.520675] Dynamic subtest rcs0: SUCCESS (1.062s)
[709.532911] Starting dynamic subtest: bcs0
[710.572117] Dynamic subtest bcs0: SUCCESS (1.048s)
[710.583535] Starting dynamic subtest: vcs0
[711.626819] Dynamic subtest vcs0: SUCCESS (1.051s)
[711.639912] Starting dynamic subtest: vcs1
[713.341199] Dynamic subtest vcs1: SUCCESS (1.711s)
[713.353097] Starting dynamic subtest: vecs0
[715.327629] Dynamic subtest vecs0: SUCCESS (1.984s)
[715.339058] Starting dynamic subtest: ccs0
[717.314364] Dynamic subtest ccs0: SUCCESS (1.984s)
[717.317265] Subtest multi-client: SUCCESS (8.857s)
[717.432873] [146/156] (310s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[717.544818] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[717.547056] Starting dynamic subtest: pipe-A-eDP-1
[718.432603] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.878s)
[718.445590] Starting dynamic subtest: pipe-B-eDP-1
[720.116374] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.683s)
[720.128163] Starting dynamic subtest: pipe-C-eDP-1
[721.607873] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.490s)
[721.619882] Starting dynamic subtest: pipe-D-eDP-1
[723.136861] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.529s)
[723.138698] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.586s)
[724.306866] [147/156] (303s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[724.416955] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[724.421418] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[724.493606] [148/156] (303s left) gem_softpin (evict-active-interruptible)
[724.550645] Starting subtest: evict-active-interruptible
[724.558730] Subtest evict-active-interruptible: SUCCESS (0.008s)
[724.685230] [149/156] (303s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[724.776606] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[724.778945] Starting dynamic subtest: pipe-A-eDP-1
[725.319168] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.516s)
[725.331810] Starting dynamic subtest: pipe-B-eDP-1
[726.771602] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.448s)
[726.782338] Starting dynamic subtest: pipe-C-eDP-1
[728.185932] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.415s)
[728.198263] Starting dynamic subtest: pipe-D-eDP-1
[729.556677] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.370s)
[729.558970] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.754s)
[730.757407] [150/156] (297s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-pwrite)
[730.859194] Starting subtest: fbchdr-rgb101010-draw-pwrite
[730.863151] Subtest fbchdr-rgb101010-draw-pwrite: SKIP (0.000s)
[730.964402] [151/156] (297s left) kms_flip (busy-flip)
[731.056657] Starting subtest: busy-flip
[731.058987] Starting dynamic subtest: A-eDP1
[732.763452] Dynamic subtest A-eDP1: SUCCESS (1.708s)
[732.776577] Starting dynamic subtest: B-eDP1
[734.504122] Dynamic subtest B-eDP1: SUCCESS (1.738s)
[734.516446] Starting dynamic subtest: C-eDP1
[736.234734] Dynamic subtest C-eDP1: SUCCESS (1.729s)
[736.246415] Starting dynamic subtest: D-eDP1
[737.891927] Dynamic subtest D-eDP1: SUCCESS (1.656s)
[737.897124] Subtest busy-flip: SUCCESS (6.842s)
[739.068221] [152/156] (288s left) kms_psr (fbc-pr-cursor-plane-move)
[739.163223] Starting subtest: fbc-pr-cursor-plane-move
[739.167812] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[739.249392] [153/156] (288s left) gem_unref_active_buffers
[739.423828] [154/156] (288s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-pwrite)
[739.520521] Starting subtest: hdr-rgb101010-draw-pwrite
[739.525038] Subtest hdr-rgb101010-draw-pwrite: SKIP (0.000s)
[739.629663] [155/156] (288s left) fbdev (unaligned-write)
[739.666761] Starting subtest: unaligned-write
[739.766923] Subtest unaligned-write: SUCCESS (0.099s)
[739.835190] [156/156] (288s left) kms_psr (psr2-cursor-plane-onoff)
[739.926072] Starting subtest: psr2-cursor-plane-onoff
[739.928308] Starting dynamic subtest: eDP-1
[741.646796] Dynamic subtest eDP-1: SUCCESS (1.720s)
[741.648821] Subtest psr2-cursor-plane-onoff: SUCCESS (1.721s)
[742.534847] Closing watchdogs
results: parsing output: 0/ for test: prime_busy
results: parsing output: 1/ for test: kms_pipe_crc_basic
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_getfb
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: perf_pmu
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: api_intel_allocator
results: parsing output: 11/ for test: i915_hangman
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_exec_reloc
results: parsing output: 15/ for test: gem_exec_reloc
results: parsing output: 16/ for test: kms_atomic
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: gem_exec_fence
results: parsing output: 19/ for test: api_intel_bb
results: parsing output: 20/ for test: prime_vgem
results: parsing output: 21/ for test: vgem_basic
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_exec_whisper
results: parsing output: 24/ for test: gem_basic
results: parsing output: 25/ for test: kms_pm_rpm
results: parsing output: 26/ for test: gem_eio
results: parsing output: 27/ for test: gem_render_copy_redux
results: parsing output: 28/ for test: kms_content_protection
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_chamelium_hpd
results: parsing output: 31/ for test: gem_exec_schedule
results: parsing output: 32/ for test: kms_vrr
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exec_parallel
results: parsing output: 40/ for test: gem_lmem_swapping
results: parsing output: 41/ for test: gem_ctx_shared
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_render_copy
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_exec_reloc
results: parsing output: 46/ for test: kms_prop_blob
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: gem_pread
results: parsing output: 50/ for test: kms_atomic_transition
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_plane_alpha_blend
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: gem_mmap_wc
results: parsing output: 55/ for test: kms_flip_scaled_crc
results: parsing output: 56/ for test: gem_tiled_pread_basic
results: parsing output: 57/ for test: kms_async_flips
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_mmap
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: gem_render_copy
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: i915_pm_rps
results: parsing output: 66/ for test: gem_exec_fence
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: i915_query
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: kms_draw_crc
results: parsing output: 73/ for test: kms_lease
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: kms_color
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_cursor_edge_walk
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: gem_mmap_gtt
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_plane
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: prime_mmap
results: parsing output: 92/ for test: kms_rotation_crc
results: parsing output: 93/ for test: kms_plane_scaling
results: parsing output: 94/ for test: i915_pm_rc6_residency
results: parsing output: 95/ for test: kms_addfb_basic
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_pm_dc
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: dmabuf_sync_file
results: parsing output: 102/ for test: sw_sync
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: gem_ctx_exec
results: parsing output: 105/ for test: kms_plane
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gen9_exec_parse
results: parsing output: 108/ for test: gem_exec_reloc
results: parsing output: 109/ for test: gem_ctx_isolation
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: i915_drm_fdinfo
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: gem_ppgtt
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_cursor_crc
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: syncobj_basic
results: parsing output: 123/ for test: kms_chamelium_color
results: parsing output: 124/ for test: gem_exec_balancer
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: gem_ctx_shared
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_mmap_offset
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_feature_discovery
results: parsing output: 136/ for test: kms_flip_scaled_crc
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_vblank
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_scaling_modes
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: perf_pmu
results: parsing output: 145/ for test: kms_ccs
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: gem_softpin
results: parsing output: 148/ for test: kms_ccs
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_flip
results: parsing output: 151/ for test: kms_psr
results: parsing output: 152/ for test: gem_unref_active_buffers
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: fbdev
results: parsing output: 155/ for test: kms_psr
Done.