[64.763157] Initializing watchdogs
[64.763205]   /dev/watchdog0
[64.777520] [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]
[64.782153] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[64.784625] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.788145] [001/132] (960s left) gem_ctx_persistence (legacy-engines-hostile)
[64.880905] Starting subtest: legacy-engines-hostile
[64.883370] Starting dynamic subtest: render
[65.036718] Dynamic subtest render: SUCCESS (0.155s)
[65.047146] Starting dynamic subtest: bsd1
[65.130647] Dynamic subtest bsd1: SUCCESS (0.092s)
[65.141071] Starting dynamic subtest: bsd2
[65.247779] Dynamic subtest bsd2: SUCCESS (0.115s)
[65.258381] Starting dynamic subtest: blt
[65.362240] Dynamic subtest blt: SUCCESS (0.113s)
[65.371190] Starting dynamic subtest: vebox
[65.470711] Dynamic subtest vebox: SUCCESS (0.106s)
[65.473345] Subtest legacy-engines-hostile: SUCCESS (0.590s)
[65.549950] [002/132] (959s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[65.648329] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[65.651936] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[65.717478] [003/132] (959s left) gem_exec_params (no-bsd)
[65.764304] Starting subtest: no-bsd
[65.766123] Subtest no-bsd: SUCCESS (0.002s)
[66.996579] [004/132] (958s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[67.274415] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[67.279480] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.001s)
[67.553534] [005/132] (957s left) i915_drm_fdinfo (busy-hang)
[67.630602] Starting subtest: busy-hang
[67.632594] Starting dynamic subtest: rcs0
[67.674704] Dynamic subtest rcs0: SKIP (0.044s)
[67.684636] Starting dynamic subtest: bcs0
[67.688876] Dynamic subtest bcs0: SKIP (0.001s)
[67.696632] Starting dynamic subtest: vcs0
[67.700785] Dynamic subtest vcs0: SKIP (0.001s)
[67.708530] Starting dynamic subtest: vcs1
[67.713798] Dynamic subtest vcs1: SKIP (0.000s)
[67.721296] Starting dynamic subtest: vecs0
[67.725900] Dynamic subtest vecs0: SKIP (0.000s)
[67.733289] Starting dynamic subtest: ccs0
[67.737882] Dynamic subtest ccs0: SKIP (0.001s)
[67.742456] Subtest busy-hang: SKIP (0.049s)
[67.793164] [006/132] (957s left) gem_lmem_swapping (verify-ccs)
[67.851760] Subtest verify-ccs: SKIP (0.000s)
[67.906415] [007/132] (957s left) kms_flip (flip-vs-fences)
[68.033910] Starting subtest: flip-vs-fences
[68.038130] Subtest flip-vs-fences: SKIP (0.000s)
[68.250746] [008/132] (957s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[68.380240] Starting subtest: cursorB-vs-flipA-legacy
[68.384982] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[68.525617] [009/132] (957s left) gem_madvise (dontneed-after-mmap)
[68.561397] Starting subtest: dontneed-after-mmap
[68.582247] Subtest dontneed-after-mmap: SUCCESS (0.022s)
[68.677976] [010/132] (957s left) gem_basic (create-fd-close)
[68.734091] Starting subtest: create-fd-close
[68.738295] Subtest create-fd-close: SUCCESS (0.000s)
[68.825429] [011/132] (956s left) kms_lease (lease-invalid-plane)
[68.919508] Starting subtest: lease-invalid-plane
[68.921849] Starting dynamic subtest: pipe-A-eDP-1
[68.923823] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[68.932257] Starting dynamic subtest: pipe-B-eDP-1
[68.934584] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[68.941908] Starting dynamic subtest: pipe-C-eDP-1
[68.944340] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[68.952907] Starting dynamic subtest: pipe-D-eDP-1
[68.955036] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[68.956951] Subtest lease-invalid-plane: SUCCESS (0.003s)
[68.992194] [012/132] (956s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[69.094985] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[69.099272] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[69.200153] [013/132] (956s left) gem_exec_reloc (basic-wc-gtt)
[69.259964] Subtest basic-wc-gtt: SKIP (0.000s)
[69.325697] [014/132] (956s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[69.415503] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[69.417435] Starting dynamic subtest: pipe-A-eDP-1
[69.528053] Dynamic subtest pipe-A-eDP-1: SKIP (0.114s)
[69.537121] Starting dynamic subtest: pipe-B-eDP-1
[70.628362] Dynamic subtest pipe-B-eDP-1: SKIP (1.098s)
[70.632619] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.214s)
[71.819921] [015/132] (954s left) gem_mmap_offset (isolation)
[71.876900] Starting subtest: isolation
[71.894065] Subtest isolation: SUCCESS (0.008s)
[71.994097] [016/132] (953s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[72.085218] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[72.087502] Starting dynamic subtest: pipe-A-eDP-1
[72.110336] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[72.119267] Starting dynamic subtest: pipe-B-eDP-1
[72.140293] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[72.147645] Starting dynamic subtest: pipe-C-eDP-1
[72.169233] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[72.177246] Starting dynamic subtest: pipe-D-eDP-1
[72.198813] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[72.202935] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[74.319855] [017/132] (951s left) kms_setmode (invalid-clone-exclusive-crtc)
[74.372699] Starting subtest: invalid-clone-exclusive-crtc
[74.378927] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[74.465476] [018/132] (951s left) core_auth (basic-auth)
[74.522731] Starting subtest: basic-auth
[74.524994] Subtest basic-auth: SUCCESS (0.001s)
[74.630324] [019/132] (951s left) gem_lmem_evict (dontneed-evict-race)
[74.673611] Subtest dontneed-evict-race: SKIP (0.000s)
[74.719921] [020/132] (951s left) gem_mmap_gtt (basic-read-write)
[74.770314] Subtest basic-read-write: SKIP (0.000s)
[74.828877] [021/132] (951s left) gem_exec_fence (syncobj-wait)
[75.263956] Starting subtest: syncobj-wait
[76.917066] Subtest syncobj-wait: SUCCESS (1.651s)
[77.253153] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true
[77.256157] [022/132] (948s left) gem_spin_batch (engines)
[77.311526] Starting subtest: engines
[77.313862] Starting dynamic subtest: rcs0
[80.557961] Dynamic subtest rcs0: SUCCESS (3.240s)
[80.567783] Starting dynamic subtest: bcs0
[83.794110] Dynamic subtest bcs0: SUCCESS (3.235s)
[83.806600] Starting dynamic subtest: vcs0
[87.028939] Dynamic subtest vcs0: SUCCESS (3.234s)
[87.038236] Starting dynamic subtest: vcs1
[90.269087] Dynamic subtest vcs1: SUCCESS (3.237s)
[90.276901] Starting dynamic subtest: vecs0
[93.504144] Dynamic subtest vecs0: SUCCESS (3.235s)
[93.511933] Starting dynamic subtest: ccs0
[96.741849] Dynamic subtest ccs0: SUCCESS (3.236s)
[96.744701] Subtest engines: SUCCESS (19.424s)
[96.965705] [023/132] (929s left) gem_ctx_param (get-priority-new-ctx)
[97.018862] Starting subtest: get-priority-new-ctx
[97.021418] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[97.122308] [024/132] (929s left) kms_psr (pr-cursor-plane-move)
[97.224904] Starting subtest: pr-cursor-plane-move
[97.229037] Subtest pr-cursor-plane-move: SKIP (0.000s)
[97.294721] [025/132] (929s left) gem_exec_reloc (basic-range)
[97.362704] Subtest basic-range: SKIP (0.000s)
[97.443564] [026/132] (928s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[97.536523] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[97.540621] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[97.609912] [027/132] (928s left) kms_plane (plane-panning-bottom-right-suspend)
[97.694325] Starting subtest: plane-panning-bottom-right-suspend
[97.696618] Starting dynamic subtest: pipe-A
[115.738246] Dynamic subtest pipe-A: SUCCESS (3.198s)
[115.747860] Starting dynamic subtest: pipe-B
[134.739378] Dynamic subtest pipe-B: SUCCESS (3.502s)
[134.741761] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.704s)
[135.577692] [028/132] (890s left) kms_plane_scaling (planes-downscale-factor-0-5)
[135.690521] Starting subtest: planes-downscale-factor-0-5
[135.692895] Starting dynamic subtest: pipe-A
[135.713605] Dynamic subtest pipe-A: SKIP (0.020s)
[135.723324] Starting dynamic subtest: pipe-B
[135.747049] Dynamic subtest pipe-B: SKIP (0.032s)
[135.755790] Starting dynamic subtest: pipe-C
[135.784389] Dynamic subtest pipe-C: SKIP (0.037s)
[135.792545] Starting dynamic subtest: pipe-D
[135.816135] Dynamic subtest pipe-D: SKIP (0.033s)
[135.819810] Subtest planes-downscale-factor-0-5: SKIP (0.122s)
[135.900865] [029/132] (890s left) syncobj_timeline (reset-signaled)
[135.954220] Starting subtest: reset-signaled
[135.956675] Subtest reset-signaled: SUCCESS (0.001s)
[136.052760] [030/132] (890s left) gem_ctx_exec (basic-norecovery)
[136.115657] Starting subtest: basic-norecovery
[136.391849] Subtest basic-norecovery: SUCCESS (0.273s)
[136.537643] [031/132] (890s left) prime_mmap_coherency (read)
[136.591512] Starting subtest: read
[141.991099] Subtest read: SUCCESS (5.374s)
[142.115939] [032/132] (884s left) gem_exec_await (wide-contexts)
[142.362461] Starting subtest: wide-contexts
[166.241043] Subtest wide-contexts: SUCCESS (23.851s)
[166.434394] [033/132] (860s left) kms_flip (modeset-vs-vblank-race)
[166.589602] Starting subtest: modeset-vs-vblank-race
[166.591652] Starting dynamic subtest: A-eDP1
[171.337135] Dynamic subtest A-eDP1: SUCCESS (4.754s)
[171.348803] Starting dynamic subtest: B-eDP1
[176.067091] Dynamic subtest B-eDP1: SUCCESS (4.731s)
[176.077868] Starting dynamic subtest: C-eDP1
[180.797133] Dynamic subtest C-eDP1: SUCCESS (4.730s)
[180.808649] Starting dynamic subtest: D-eDP1
[185.362106] Dynamic subtest D-eDP1: SUCCESS (4.564s)
[185.366798] Subtest modeset-vs-vblank-race: SUCCESS (18.789s)
[186.528179] [034/132] (840s left) kms_frontbuffer_tracking (psr-2p-rte)
[186.639834] Starting subtest: psr-2p-rte
[186.644052] Subtest psr-2p-rte: SKIP (0.000s)
[186.742306] [035/132] (840s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[186.864159] Starting subtest: basic-busy-flip-before-cursor-varying-size
[186.868568] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[187.023740] [036/132] (839s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[187.135858] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[187.140391] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[187.244382] [037/132] (839s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[187.348083] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[187.352531] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[187.443579] [038/132] (839s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[187.531891] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[188.654181] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.122s)
[188.778731] [039/132] (838s left) kms_content_protection (atomic)
[188.934570] Starting subtest: atomic
[188.938050] Subtest atomic: SKIP (0.000s)
[189.064524] [040/132] (837s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[189.121871] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[189.177753] [041/132] (837s left) kms_addfb_basic (bo-too-small)
[189.260867] Starting subtest: bo-too-small
[189.262480] Subtest bo-too-small: SUCCESS (0.000s)
[189.355647] [042/132] (837s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[189.421201] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[189.423283] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[189.517558] [043/132] (837s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[189.629271] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[189.632774] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[189.746779] [044/132] (837s left) kms_pm_rpm (i2c)
[191.366488] Starting subtest: i2c
[196.950872] Subtest i2c: SUCCESS (5.583s)
[197.044185] [045/132] (830s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[197.140370] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[197.144781] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[198.271644] [046/132] (828s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[198.339069] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[198.439852] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.101s)
[198.517109] [047/132] (828s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[198.586534] Starting subtest: invalid-bsd2-flag-on-vebox
[198.588530] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.001s)
[198.693013] [048/132] (828s left) i915_pm_rps (basic-api)
[198.750729] Starting subtest: basic-api
[198.755126] Subtest basic-api: SKIP (0.001s)
[198.847557] [049/132] (828s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[198.949305] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[207.715977] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.768s)
[207.835905] [050/132] (819s left) i915_fb_tiling (basic-x-tiling)
[207.903256] Subtest basic-x-tiling: SKIP (0.000s)
[207.969792] [051/132] (819s left) kms_dsc (dsc-with-bpc-formats)
[208.081987] Starting subtest: dsc-with-bpc-formats
[208.191298] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[208.234322] [052/132] (819s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[208.300680] Starting subtest: yf-tiled-to-vebox-yf-tiled
[208.305266] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[208.485249] [053/132] (819s left) api_intel_allocator (two-level-inception)
[208.552892] Starting subtest: two-level-inception
[213.955137] Subtest two-level-inception: SUCCESS (5.401s)
[214.088239] [054/132] (813s left) syncobj_timeline (single-wait-available-signaled)
[214.158316] Starting subtest: single-wait-available-signaled
[214.160657] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[214.285118] [055/132] (813s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[214.348234] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[214.350595] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[214.467148] [056/132] (813s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[214.573752] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[214.575976] Starting dynamic subtest: pipe-A-eDP-1
[225.559701] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.985s)
[225.573217] Starting dynamic subtest: pipe-B-eDP-1
[237.265426] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.707s)
[237.267620] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.695s)
[238.108821] [057/132] (789s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[238.166611] Starting subtest: invalid-multi-wait-unsubmitted
[238.168531] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[238.265938] [058/132] (789s left) kms_flip (plain-flip-interruptible)
[238.366319] Starting subtest: plain-flip-interruptible
[238.368641] Starting dynamic subtest: A-eDP1
[240.016868] Dynamic subtest A-eDP1: SUCCESS (1.649s)
[240.027548] Starting dynamic subtest: B-eDP1
[241.641856] Dynamic subtest B-eDP1: SUCCESS (1.623s)
[241.653504] Starting dynamic subtest: C-eDP1
[243.261409] Dynamic subtest C-eDP1: SUCCESS (1.617s)
[243.272090] Starting dynamic subtest: D-eDP1
[244.903634] Dynamic subtest D-eDP1: SUCCESS (1.640s)
[244.908693] Subtest plain-flip-interruptible: SUCCESS (6.544s)
[246.067900] [059/132] (781s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[246.171554] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[246.176041] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[246.257546] [060/132] (781s left) kms_rmfb (close-fd)
[246.344601] Starting subtest: close-fd
[246.346879] Starting dynamic subtest: pipe-A-eDP-1
[246.456153] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s)
[246.467930] Starting dynamic subtest: pipe-B-eDP-1
[247.634389] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.178s)
[247.643927] Starting dynamic subtest: pipe-C-eDP-1
[248.765177] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.131s)
[248.774818] Starting dynamic subtest: pipe-D-eDP-1
[249.907379] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.139s)
[249.909716] Subtest close-fd: SUCCESS (3.562s)
[251.130946] [061/132] (776s left) gem_exec_balancer (bonded-semaphore)
[251.195762] Starting subtest: bonded-semaphore
[251.200548] Subtest bonded-semaphore: SKIP (0.000s)
[251.500672] [062/132] (776s left) sysfs_timeslice_duration (idempotent)
[251.562641] Starting subtest: idempotent
[251.564875] Starting dynamic subtest: vecs0
[251.567148] Dynamic subtest vecs0: SUCCESS (0.000s)
[251.577674] Starting dynamic subtest: ccs0
[251.579574] Dynamic subtest ccs0: SUCCESS (0.000s)
[251.588441] Starting dynamic subtest: vcs0
[251.590313] Dynamic subtest vcs0: SUCCESS (0.000s)
[251.599109] Starting dynamic subtest: bcs0
[251.601032] Dynamic subtest bcs0: SUCCESS (0.000s)
[251.610144] Starting dynamic subtest: rcs0
[251.612426] Dynamic subtest rcs0: SUCCESS (0.000s)
[251.621622] Starting dynamic subtest: vcs1
[251.623604] Dynamic subtest vcs1: SUCCESS (0.000s)
[251.625504] Subtest idempotent: SUCCESS (0.006s)
[251.676535] [063/132] (776s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[251.779638] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[251.783962] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[251.886212] [064/132] (776s left) kms_psr (psr2-sprite-mmap-gtt)
[251.973942] Starting subtest: psr2-sprite-mmap-gtt
[251.976051] Starting dynamic subtest: eDP-1
[253.424088] Dynamic subtest eDP-1: SKIP (1.446s)
[253.429086] Subtest psr2-sprite-mmap-gtt: SKIP (1.448s)
[253.568644] [065/132] (774s left) kms_addfb_basic (unused-offsets)
[253.624304] Starting subtest: unused-offsets
[253.626517] Subtest unused-offsets: SUCCESS (0.000s)
[253.760540] [066/132] (774s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[253.848916] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[253.851157] Starting dynamic subtest: pipe-A-eDP-1
[259.719041] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.875s)
[259.728925] Starting dynamic subtest: pipe-B-eDP-1
[266.287789] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.565s)
[266.289699] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.443s)
[267.162200] [067/132] (760s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[267.262084] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[267.266417] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[267.336358] [068/132] (760s left) perf_pmu (busy-check-all)
[267.386376] Starting subtest: busy-check-all
[267.388288] Starting dynamic subtest: rcs0
[267.950984] Dynamic subtest rcs0: SUCCESS (0.566s)
[267.965913] Starting dynamic subtest: bcs0
[268.503864] Dynamic subtest bcs0: SUCCESS (0.550s)
[268.516552] Starting dynamic subtest: vcs0
[270.212607] Dynamic subtest vcs0: SUCCESS (1.705s)
[270.225510] Starting dynamic subtest: vcs1
[272.261187] Dynamic subtest vcs1: SUCCESS (2.046s)
[272.273640] Starting dynamic subtest: vecs0
[274.244737] Dynamic subtest vecs0: SUCCESS (1.980s)
[274.257108] Starting dynamic subtest: ccs0
[274.798387] Dynamic subtest ccs0: SUCCESS (0.552s)
[274.800810] Subtest busy-check-all: SUCCESS (7.415s)
[274.919583] [069/132] (753s left) gem_exec_reloc (basic-write-wc-noreloc)
[274.990000] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[275.057847] [070/132] (753s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[275.166895] Starting subtest: y-tiled-8bpp-rotate-90
[275.171379] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[275.275730] [071/132] (753s left) kms_cursor_legacy (forked-move)
[275.392861] Starting subtest: forked-move
[275.395182] Starting dynamic subtest: pipe-A
[280.857580] Dynamic subtest pipe-A: SUCCESS (5.460s)
[280.878153] Starting dynamic subtest: pipe-B
[286.323812] Dynamic subtest pipe-B: SUCCESS (5.463s)
[286.335923] Starting dynamic subtest: pipe-C
[291.790062] Dynamic subtest pipe-C: SUCCESS (5.463s)
[291.802189] Starting dynamic subtest: pipe-D
[297.249160] Dynamic subtest pipe-D: SUCCESS (5.456s)
[297.260529] Starting dynamic subtest: all-pipes
[302.766282] Dynamic subtest all-pipes: SUCCESS (5.514s)
[302.768700] Subtest forked-move: SUCCESS (27.368s)
[302.918972] [072/132] (725s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[303.030185] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[303.032416] Starting dynamic subtest: pipe-A-eDP-1
[303.088070] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[303.102157] Starting dynamic subtest: pipe-B-eDP-1
[303.158962] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[303.174490] Starting dynamic subtest: pipe-C-eDP-1
[303.229786] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[303.242932] Starting dynamic subtest: pipe-D-eDP-1
[303.300192] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[303.308497] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[305.324864] [073/132] (723s left) i915_pm_sseu (full-enable)
[305.384397] Subtest full-enable: SKIP (0.000s)
[305.494559] [074/132] (722s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[305.594762] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[305.598634] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[305.685810] [075/132] (722s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[305.743300] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[305.849218] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[305.927805] [076/132] (722s left) gen7_exec_parse (basic-allowed)
[305.994375] Subtest basic-allowed: SKIP (0.000s)
[306.075952] [077/132] (722s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[306.173701] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[306.178080] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[306.274229] [078/132] (722s left) kms_joiner (basic-ultra-joiner)
[306.369461] Starting subtest: basic-ultra-joiner
[306.374034] Subtest basic-ultra-joiner: SKIP (0.000s)
[306.446785] [079/132] (722s left) kms_big_fb (linear-16bpp-rotate-180)
[306.552728] Starting subtest: linear-16bpp-rotate-180
[307.921606] Subtest linear-16bpp-rotate-180: SUCCESS (1.368s)
[308.044474] [080/132] (720s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[308.142137] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[308.145571] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[308.232611] [081/132] (720s left) api_intel_bb (object-noreloc-keep-cache-simple)
[308.284824] Starting subtest: object-noreloc-keep-cache-simple
[308.286971] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s)
[308.399627] [082/132] (720s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[308.505418] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[308.508810] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[308.591786] [083/132] (720s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[308.706379] Starting subtest: basic-flip-before-cursor-legacy
[309.624050] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.917s)
[310.468477] [084/132] (718s left) syncobj_wait (single-wait-all-for-submit-signaled)
[310.534070] Starting subtest: single-wait-all-for-submit-signaled
[310.535977] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[310.625830] [085/132] (718s left) kms_psr (fbc-psr2-primary-render)
[310.719484] Starting subtest: fbc-psr2-primary-render
[310.721767] Starting dynamic subtest: eDP-1
[310.726138] Dynamic subtest eDP-1: SKIP (0.000s)
[310.730552] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[310.794409] [086/132] (718s left) gem_exec_reloc (basic-cpu-active)
[310.843134] Subtest basic-cpu-active: SKIP (0.000s)
[310.912228] [087/132] (718s left) gem_close_race (multigpu-basic-process)
[310.980403] Starting subtest: multigpu-basic-process
[310.984516] Subtest multigpu-basic-process: SKIP (0.000s)
[311.206623] [088/132] (717s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[311.312102] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[311.316555] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[311.437549] [089/132] (717s left) kms_async_flips (async-flip-suspend-resume)
[311.528907] Starting subtest: async-flip-suspend-resume
[311.899465] Starting dynamic subtest: pipe-A-eDP-1
[329.346600] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.883s)
[329.727902] Starting dynamic subtest: pipe-B-eDP-1
[347.359192] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.865s)
[347.745943] Starting dynamic subtest: pipe-C-eDP-1
[365.374690] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.865s)
[365.742373] Starting dynamic subtest: pipe-D-eDP-1
[383.395749] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.932s)
[383.398395] Subtest async-flip-suspend-resume: SUCCESS (13.026s)
[384.570908] [090/132] (644s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[384.681597] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[384.686619] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[384.792127] [091/132] (644s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[384.898845] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[385.963433] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.058s)
[386.079292] [092/132] (643s left) kms_chamelium_color (ctm-red-to-blue)
[386.182401] Subtest ctm-red-to-blue: SKIP (0.000s)
[386.229791] [093/132] (643s left) gem_pwrite (basic-exhaustion)
[386.287029] Subtest basic-exhaustion: SKIP (0.000s)
[386.346915] [094/132] (642s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[386.897138] Starting subtest: syncobj-timeline-invalid-wait
[386.904277] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[388.082484] [095/132] (641s left) gem_mmap_gtt (big-bo-tiledx)
[388.139221] Subtest big-bo-tiledX: SKIP (0.000s)
[388.196766] [096/132] (641s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[388.298437] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[388.300906] Starting dynamic subtest: pipe-A-default-mode
[391.052308] Dynamic subtest pipe-A-default-mode: SUCCESS (2.745s)
[391.055282] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.746s)
[391.912913] [097/132] (637s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[392.006913] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[401.669158] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.649s)
[401.802796] [098/132] (627s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[401.909266] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[401.915107] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[402.031235] [099/132] (627s left) gem_caching (read-writes)
[402.108912] Subtest read-writes: SKIP (0.000s)
[402.182594] [100/132] (627s left) perf_pmu (semaphore-wait-idle)
[402.222805] Starting subtest: semaphore-wait-idle
[402.225042] Starting dynamic subtest: rcs0
[402.736741] Dynamic subtest rcs0: SUCCESS (0.514s)
[402.750420] Starting dynamic subtest: bcs0
[403.250908] Dynamic subtest bcs0: SUCCESS (0.511s)
[403.262982] Starting dynamic subtest: vcs0
[403.770133] Dynamic subtest vcs0: SUCCESS (0.515s)
[403.782025] Starting dynamic subtest: vcs1
[404.283743] Dynamic subtest vcs1: SUCCESS (0.510s)
[404.295420] Starting dynamic subtest: vecs0
[404.797666] Dynamic subtest vecs0: SUCCESS (0.511s)
[404.808651] Starting dynamic subtest: ccs0
[405.316218] Dynamic subtest ccs0: SUCCESS (0.514s)
[405.319321] Subtest semaphore-wait-idle: SUCCESS (3.093s)
[405.437438] [101/132] (624s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[405.543593] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[405.548208] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[405.631818] [102/132] (623s left) kms_setmode (invalid-clone-single-crtc)
[405.696620] Starting subtest: invalid-clone-single-crtc
[405.704130] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[405.797454] [103/132] (623s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[405.896319] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[405.901541] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[405.970771] [104/132] (623s left) core_setmaster (master-drop-set-shared-fd)
[406.055826] Starting subtest: master-drop-set-shared-fd
[406.062329] Subtest master-drop-set-shared-fd: SUCCESS (0.011s)
[406.103919] [105/132] (623s left) gem_exec_store (pages)
[406.174925] Starting subtest: pages
[406.177186] Starting dynamic subtest: rcs0
[406.260443] Dynamic subtest rcs0: SUCCESS (0.088s)
[406.270669] Starting dynamic subtest: bcs0
[406.327331] Dynamic subtest bcs0: SUCCESS (0.066s)
[406.337445] Starting dynamic subtest: vcs0
[406.391140] Dynamic subtest vcs0: SUCCESS (0.063s)
[406.401813] Starting dynamic subtest: vcs1
[406.469887] Dynamic subtest vcs1: SUCCESS (0.078s)
[406.482222] Starting dynamic subtest: vecs0
[406.540860] Dynamic subtest vecs0: SUCCESS (0.070s)
[406.553190] Starting dynamic subtest: ccs0
[406.616412] Dynamic subtest ccs0: SUCCESS (0.074s)
[406.619178] Subtest pages: SUCCESS (0.445s)
[406.802938] [106/132] (622s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[406.910101] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[414.221470] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.310s)
[414.338161] [107/132] (615s left) gem_exec_schedule (preemptive-hang)
[414.516408] Starting subtest: preemptive-hang
[414.519065] Starting dynamic subtest: rcs0
[424.150989] Dynamic subtest rcs0: SUCCESS (9.636s)
[424.162154] Starting dynamic subtest: bcs0
[433.169384] Dynamic subtest bcs0: SUCCESS (9.017s)
[433.179716] Starting dynamic subtest: vcs0
[442.143415] Dynamic subtest vcs0: SUCCESS (8.970s)
[442.155693] Starting dynamic subtest: vcs1
[451.152312] Dynamic subtest vcs1: SUCCESS (9.003s)
[451.163703] Starting dynamic subtest: vecs0
[460.110183] Dynamic subtest vecs0: SUCCESS (8.956s)
[460.122710] Starting dynamic subtest: ccs0
[469.139799] Dynamic subtest ccs0: SUCCESS (9.025s)
[469.142277] Subtest preemptive-hang: SUCCESS (54.616s)
[469.375264] [108/132] (560s left) gem_ctx_sseu (invalid-sseu)
[469.439985] Subtest invalid-sseu: SKIP (0.000s)
[469.506935] [109/132] (560s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[469.612284] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[476.180403] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.571s)
[476.287363] [110/132] (553s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[476.470408] Starting subtest: cursor-rapid-movement-32x10
[476.517948] Subtest cursor-rapid-movement-32x10: SKIP (0.043s)
[476.779229] [111/132] (553s left) kms_color (ctm-red-to-blue)
[476.879239] Starting subtest: ctm-red-to-blue
[476.881624] Starting dynamic subtest: pipe-A-eDP-1
[477.593389] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.712s)
[477.604127] Starting dynamic subtest: pipe-B-eDP-1
[479.026288] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.435s)
[479.037651] Starting dynamic subtest: pipe-C-eDP-1
[480.425852] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.397s)
[480.436625] Starting dynamic subtest: pipe-D-eDP-1
[481.754703] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[481.756869] Subtest ctm-red-to-blue: SUCCESS (4.876s)
[482.561780] [112/132] (547s left) kms_chamelium_color (ctm-limited-range)
[482.656247] Subtest ctm-limited-range: SKIP (0.000s)
[482.705592] [113/132] (547s left) gem_busy (extended)
[482.883306] Starting subtest: extended
[482.886209] Starting dynamic subtest: rcs0
[482.959779] Dynamic subtest rcs0: SUCCESS (0.076s)
[482.977024] Starting dynamic subtest: bcs0
[483.004826] Dynamic subtest bcs0: SUCCESS (0.042s)
[483.022404] Starting dynamic subtest: vcs0
[485.032727] Dynamic subtest vcs0: SUCCESS (2.025s)
[485.046429] Starting dynamic subtest: vcs1
[487.016555] Dynamic subtest vcs1: SUCCESS (1.981s)
[487.030443] Starting dynamic subtest: vecs0
[489.000700] Dynamic subtest vecs0: SUCCESS (1.982s)
[489.014323] Starting dynamic subtest: ccs0
[489.048367] Dynamic subtest ccs0: SUCCESS (0.046s)
[489.051133] Subtest extended: SUCCESS (6.168s)
[489.286605] [114/132] (540s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[489.678553] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[490.479062] [115/132] (539s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[490.573792] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[490.576250] Starting dynamic subtest: pipe-A-eDP-1
[490.600055] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[490.611999] Starting dynamic subtest: pipe-B-eDP-1
[490.637667] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[490.647590] Starting dynamic subtest: pipe-C-eDP-1
[490.672251] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[490.681986] Starting dynamic subtest: pipe-D-eDP-1
[490.708061] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[490.713109] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[492.854435] [116/132] (537s left) kms_psr (psr-dpms)
[492.954014] Starting subtest: psr-dpms
[492.956532] Starting dynamic subtest: eDP-1
[495.990744] Dynamic subtest eDP-1: SUCCESS (3.037s)
[495.993278] Subtest psr-dpms: SUCCESS (3.038s)
[496.856721] [117/132] (533s left) kms_rotation_crc (sprite-rotation-90)
[496.963140] Starting subtest: sprite-rotation-90
[496.968419] Subtest sprite-rotation-90: SKIP (0.001s)
[497.041544] [118/132] (533s left) kms_plane_alpha_blend (constant-alpha-mid)
[497.143834] Starting subtest: constant-alpha-mid
[497.472942] Starting dynamic subtest: pipe-A-eDP-1
[498.370091] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.897s)
[498.380284] Starting dynamic subtest: pipe-D-eDP-1
[499.854303] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.480s)
[499.856323] Subtest constant-alpha-mid: SUCCESS (2.711s)
[500.732127] [119/132] (529s left) kms_addfb_basic (bad-pitch-32)
[500.782527] Starting subtest: bad-pitch-32
[500.785048] Subtest bad-pitch-32: SUCCESS (0.000s)
[500.913333] [120/132] (529s left) gem_pxp (reject-modify-context-protection-on)
[501.034394] Starting subtest: reject-modify-context-protection-on
[501.037395] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[501.141133] [121/132] (529s left) kms_psr (fbc-psr-basic)
[501.228407] Starting subtest: fbc-psr-basic
[501.231028] Starting dynamic subtest: eDP-1
[501.235632] Dynamic subtest eDP-1: SKIP (0.000s)
[501.240005] Subtest fbc-psr-basic: SKIP (0.001s)
[501.307227] [122/132] (529s left) gen7_exec_parse (load-register-reg)
[501.367138] Subtest load-register-reg: SKIP (0.000s)
[501.443071] [123/132] (529s left) kms_atomic (plane-overlay-legacy)
[501.539574] Starting subtest: plane-overlay-legacy
[501.541906] Starting dynamic subtest: pipe-A-eDP-1
[501.956289] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.415s)
[501.959058] Subtest plane-overlay-legacy: SUCCESS (0.417s)
[502.747108] [124/132] (527s left) gem_exec_params (invalid-bsd1-flag-on-render)
[502.814549] Starting subtest: invalid-bsd1-flag-on-render
[502.816793] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[502.918702] [125/132] (527s left) gem_exec_balancer (sequential)
[502.987683] Starting subtest: sequential
[506.076427] Subtest sequential: SUCCESS (3.089s)
[506.370151] [126/132] (524s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[506.493787] Starting subtest: flip-vs-cursor-legacy
[513.655426] Subtest flip-vs-cursor-legacy: SUCCESS (7.161s)
[514.477289] [127/132] (516s left) kms_cursor_crc (cursor-onscreen-128x128)
[514.715422] Starting subtest: cursor-onscreen-128x128
[514.718018] Starting dynamic subtest: pipe-A-eDP-1
[516.836013] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.119s)
[516.866947] Starting dynamic subtest: pipe-D-eDP-1
[519.747114] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.888s)
[519.750091] Subtest cursor-onscreen-128x128: SUCCESS (5.033s)
[520.551873] [128/132] (510s left) kms_pm_backlight (fade-with-dpms)
[520.652694] Starting subtest: fade-with-dpms
[522.816115] Starting dynamic subtest: eDP-1
[525.321572] Dynamic subtest eDP-1: SUCCESS (2.506s)
[525.324242] Subtest fade-with-dpms: SUCCESS (4.669s)
[526.125279] [129/132] (504s left) perf_pmu (semaphore-busy)
[526.180417] Starting subtest: semaphore-busy
[526.183076] Starting dynamic subtest: rcs0
[527.820403] Dynamic subtest rcs0: SUCCESS (1.636s)
[527.833199] Starting dynamic subtest: bcs0
[529.453027] Dynamic subtest bcs0: SUCCESS (1.629s)
[529.466246] Starting dynamic subtest: vcs0
[533.540418] Dynamic subtest vcs0: SUCCESS (4.083s)
[533.551429] Starting dynamic subtest: vcs1
[539.491378] Dynamic subtest vcs1: SUCCESS (5.947s)
[539.504681] Starting dynamic subtest: vecs0
[545.507236] Dynamic subtest vecs0: SUCCESS (6.011s)
[545.520657] Starting dynamic subtest: ccs0
[548.584168] Dynamic subtest ccs0: SUCCESS (3.073s)
[548.587176] Subtest semaphore-busy: SUCCESS (22.398s)
[548.702664] [130/132] (482s left) kms_vblank (invalid)
[548.810235] Starting subtest: invalid
[548.813065] Starting dynamic subtest: pipe-A-eDP-1
[549.211668] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.399s)
[549.214128] Subtest invalid: SUCCESS (0.401s)
[550.049984] [131/132] (480s left) kms_vblank (ts-continuation-suspend)
[550.156712] Starting subtest: ts-continuation-suspend
[550.159071] Starting dynamic subtest: pipe-A-eDP-1
[566.632266] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.518s)
[566.648428] Starting dynamic subtest: pipe-D-eDP-1
[583.666511] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.212s)
[583.669573] Subtest ts-continuation-suspend: SUCCESS (3.733s)
[584.476324] [132/132] (446s left) gem_exec_schedule (timeslicing)
[584.561278] Starting subtest: timeslicing
[584.564302] Starting dynamic subtest: rcs0
[584.570956] Dynamic subtest rcs0: SUCCESS (0.021s)
[584.582227] Starting dynamic subtest: bcs0
[584.590225] Dynamic subtest bcs0: SUCCESS (0.021s)
[584.603332] Starting dynamic subtest: vcs0
[584.612331] Dynamic subtest vcs0: SUCCESS (0.021s)
[584.622726] Starting dynamic subtest: vcs1
[584.632692] Dynamic subtest vcs1: SUCCESS (0.020s)
[584.643213] Starting dynamic subtest: vecs0
[584.653826] Dynamic subtest vecs0: SUCCESS (0.020s)
[584.664121] Starting dynamic subtest: ccs0
[584.673690] Dynamic subtest ccs0: SUCCESS (0.020s)
[584.676634] Subtest timeslicing: SUCCESS (0.127s)
[585.834397] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_persistence
results: parsing output: 1/ for test: kms_plane
results: parsing output: 2/ for test: gem_exec_params
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: i915_drm_fdinfo
results: parsing output: 5/ for test: gem_lmem_swapping
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: gem_madvise
results: parsing output: 9/ for test: gem_basic
results: parsing output: 10/ for test: kms_lease
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_exec_reloc
results: parsing output: 13/ for test: kms_psr2_sf
results: parsing output: 14/ for test: gem_mmap_offset
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_setmode
results: parsing output: 17/ for test: core_auth
results: parsing output: 18/ for test: gem_lmem_evict
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: gem_exec_fence
results: parsing output: 21/ for test: gem_spin_batch
results: parsing output: 22/ for test: gem_ctx_param
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: gem_exec_reloc
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: kms_plane
results: parsing output: 27/ for test: kms_plane_scaling
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: gem_ctx_exec
results: parsing output: 30/ for test: prime_mmap_coherency
results: parsing output: 31/ for test: gem_exec_await
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_content_protection
results: parsing output: 39/ for test: kms_pipe_b_c_ivb
results: parsing output: 40/ for test: kms_addfb_basic
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_pm_rpm
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: gem_exec_params
results: parsing output: 47/ for test: i915_pm_rps
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: i915_fb_tiling
results: parsing output: 50/ for test: kms_dsc
results: parsing output: 51/ for test: gem_render_copy
results: parsing output: 52/ for test: api_intel_allocator
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_psr2_sf
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_rmfb
results: parsing output: 60/ for test: gem_exec_balancer
results: parsing output: 61/ for test: sysfs_timeslice_duration
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_addfb_basic
results: parsing output: 65/ for test: kms_psr2_sf
results: parsing output: 66/ for test: kms_plane
results: parsing output: 67/ for test: perf_pmu
results: parsing output: 68/ for test: gem_exec_reloc
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: i915_pm_sseu
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: gen7_exec_parse
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_joiner
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: api_intel_bb
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: gem_exec_reloc
results: parsing output: 86/ for test: gem_close_race
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_async_flips
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_chamelium_color
results: parsing output: 92/ for test: gem_pwrite
results: parsing output: 93/ for test: gem_exec_fence
results: parsing output: 94/ for test: gem_mmap_gtt
results: parsing output: 95/ for test: kms_flip_scaled_crc
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_caching
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_setmode
results: parsing output: 102/ for test: kms_flip_scaled_crc
results: parsing output: 103/ for test: core_setmaster
results: parsing output: 104/ for test: gem_exec_store
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_exec_schedule
results: parsing output: 107/ for test: gem_ctx_sseu
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: kms_color
results: parsing output: 111/ for test: kms_chamelium_color
results: parsing output: 112/ for test: gem_busy
results: parsing output: 113/ for test: kms_chamelium_hpd
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_rotation_crc
results: parsing output: 117/ for test: kms_plane_alpha_blend
results: parsing output: 118/ for test: kms_addfb_basic
results: parsing output: 119/ for test: gem_pxp
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: gen7_exec_parse
results: parsing output: 122/ for test: kms_atomic
results: parsing output: 123/ for test: gem_exec_params
results: parsing output: 124/ for test: gem_exec_balancer
results: parsing output: 125/ for test: kms_cursor_legacy
results: parsing output: 126/ for test: kms_cursor_crc
results: parsing output: 127/ for test: kms_pm_backlight
results: parsing output: 128/ for test: perf_pmu
results: parsing output: 129/ for test: kms_vblank
results: parsing output: 130/ for test: kms_vblank
results: parsing output: 131/ for test: gem_exec_schedule
Done.