[55.161427] Initializing watchdogs
[55.161475]   /dev/watchdog0
[55.176482] [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]
[55.181352] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.183847] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.186497] [001/132] (960s left) gem_sync (basic-store-each)
[55.247813] Starting subtest: basic-store-each
[57.831840] Subtest basic-store-each: SUCCESS (2.573s)
[58.020394] [002/132] (957s left) syncobj_timeline (invalid-wait-illegal-handle)
[58.073474] Starting subtest: invalid-wait-illegal-handle
[58.074650] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[58.179810] [003/132] (957s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[58.273221] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[58.274747] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[58.357157] [004/132] (957s left) gem_userptr_blits (mmap-offset-banned)
[58.425665] Starting subtest: mmap-offset-banned
[58.426757] Starting dynamic subtest: wb
[58.427673] Dynamic subtest wb: SUCCESS (0.000s)
[58.435090] Starting dynamic subtest: wc
[58.435942] Dynamic subtest wc: SUCCESS (0.000s)
[58.441351] Starting dynamic subtest: uc
[58.442175] Dynamic subtest uc: SUCCESS (0.000s)
[58.442899] Subtest mmap-offset-banned: SUCCESS (0.001s)
[58.536675] [005/132] (957s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[58.582614] Starting subtest: single-wait-for-submit-available-submitted
[58.583617] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[58.688886] [006/132] (957s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[58.769171] Starting subtest: plane-upscale-factor-0-25-with-rotation
[58.770116] Starting dynamic subtest: pipe-A
[59.007697] Dynamic subtest pipe-A: SUCCESS (0.238s)
[59.014372] Starting dynamic subtest: pipe-B
[60.348360] Dynamic subtest pipe-B: SUCCESS (1.336s)
[60.355107] Starting dynamic subtest: pipe-C
[61.681142] Dynamic subtest pipe-C: SUCCESS (1.329s)
[61.688531] Starting dynamic subtest: pipe-D
[63.015445] Dynamic subtest pipe-D: SUCCESS (1.331s)
[63.016477] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.236s)
[64.189556] [007/132] (951s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[64.276180] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[64.277095] Starting dynamic subtest: pipe-A-eDP-1
[64.285105] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[64.292673] Starting dynamic subtest: pipe-B-eDP-1
[64.300468] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[64.306197] Starting dynamic subtest: pipe-C-eDP-1
[64.314578] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[64.320206] Starting dynamic subtest: pipe-D-eDP-1
[64.327760] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[64.328616] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[66.489151] [008/132] (949s left) perf_pmu (busy-check-all)
[66.527357] Starting subtest: busy-check-all
[66.528289] Starting dynamic subtest: rcs0
[67.259476] Dynamic subtest rcs0: SUCCESS (0.722s)
[67.268496] Starting dynamic subtest: bcs0
[67.804220] Dynamic subtest bcs0: SUCCESS (0.552s)
[67.813948] Starting dynamic subtest: vcs0
[68.894218] Dynamic subtest vcs0: SUCCESS (1.079s)
[68.903596] Starting dynamic subtest: vcs1
[70.943234] Dynamic subtest vcs1: SUCCESS (2.045s)
[70.950703] Starting dynamic subtest: vecs0
[72.927482] Dynamic subtest vecs0: SUCCESS (1.982s)
[72.936473] Starting dynamic subtest: ccs0
[73.474993] Dynamic subtest ccs0: SUCCESS (0.555s)
[73.476079] Subtest busy-check-all: SUCCESS (6.943s)
[73.584807] [009/132] (942s left) kms_flip (dpms-off-confusion-interruptible)
[73.677368] Starting subtest: dpms-off-confusion-interruptible
[73.679413] Starting dynamic subtest: A-eDP1
[82.406963] Dynamic subtest A-eDP1: SUCCESS (8.724s)
[82.415617] Starting dynamic subtest: B-eDP1
[91.062664] Dynamic subtest B-eDP1: SUCCESS (8.626s)
[91.070535] Starting dynamic subtest: C-eDP1
[99.708234] Dynamic subtest C-eDP1: SUCCESS (8.632s)
[99.714622] Starting dynamic subtest: D-eDP1
[108.322854] Dynamic subtest D-eDP1: SUCCESS (8.613s)
[108.323843] Subtest dpms-off-confusion-interruptible: SUCCESS (34.606s)
[109.449952] [010/132] (906s left) gem_exec_fence (basic-await)
[109.624310] Starting subtest: basic-await
[109.625254] Starting dynamic subtest: rcs0
[109.697891] Dynamic subtest rcs0: SUCCESS (0.078s)
[109.707513] Starting dynamic subtest: bcs0
[109.769828] Dynamic subtest bcs0: SUCCESS (0.071s)
[109.779422] Starting dynamic subtest: vcs0
[109.843388] Dynamic subtest vcs0: SUCCESS (0.073s)
[109.852555] Starting dynamic subtest: vcs1
[109.919699] Dynamic subtest vcs1: SUCCESS (0.076s)
[109.928236] Starting dynamic subtest: vecs0
[109.992798] Dynamic subtest vecs0: SUCCESS (0.072s)
[110.001957] Starting dynamic subtest: ccs0
[110.065553] Dynamic subtest ccs0: SUCCESS (0.072s)
[110.067077] Subtest basic-await: SUCCESS (0.447s)
[111.965798] [FACT gem_exec_fence (basic-await)] new: kernel.kmod_is_loaded.vgem: true
[111.967793] [011/132] (904s left) syncobj_wait (invalid-reset-one-illegal-handle)
[112.025201] Starting subtest: invalid-reset-one-illegal-handle
[112.026152] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[112.134219] [012/132] (903s left) kms_chamelium_audio (hdmi-audio-edid)
[112.524141] Subtest hdmi-audio-edid: SKIP (0.000s)
[113.380417] [013/132] (902s left) gem_ctx_sseu (invalid-args)
[113.454308] Subtest invalid-args: SKIP (0.000s)
[113.518299] [014/132] (902s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[113.607495] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[120.954847] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.348s)
[121.075254] [015/132] (895s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[121.171968] Starting subtest: fbc-indfb-scaledprimary
[124.200653] Subtest fbc-indfb-scaledprimary: SUCCESS (3.029s)
[125.313273] [016/132] (890s left) kms_addfb_basic (legacy-format)
[125.365950] Starting subtest: legacy-format
[125.389194] Subtest legacy-format: SUCCESS (0.020s)
[125.521208] [017/132] (890s left) gem_mmap_wc (write-cpu-read-wc)
[125.574228] Subtest write-cpu-read-wc: SKIP (0.000s)
[125.626295] [018/132] (890s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[125.716487] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[125.718203] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[125.811230] [019/132] (890s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[125.858491] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[125.859456] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[125.951841] [020/132] (890s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[125.992022] Starting subtest: multi-wait-for-submit-available-signaled
[125.992919] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[126.083489] [021/132] (890s left) kms_pm_rpm (dpms-non-lpsp)
[128.021123] Starting subtest: dpms-non-lpsp
[128.023063] Subtest dpms-non-lpsp: SKIP (0.001s)
[128.398944] [022/132] (888s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[128.488154] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[134.867574] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.379s)
[135.979290] [023/132] (880s left) core_auth (many-magics)
[136.031464] Starting subtest: many-magics
[137.014307] Subtest many-magics: SUCCESS (0.980s)
[137.169456] [024/132] (879s left) kms_chamelium_frames (hdmi-crc-single)
[137.541904] Subtest hdmi-crc-single: SKIP (0.000s)
[138.376351] [025/132] (878s left) gem_exec_schedule (submit-late-slice)
[138.429192] Starting subtest: submit-late-slice
[138.430246] Starting dynamic subtest: rcs0
[138.464522] Dynamic subtest rcs0: SUCCESS (0.035s)
[138.473719] Starting dynamic subtest: bcs0
[138.494682] Dynamic subtest bcs0: SUCCESS (0.030s)
[138.501562] Starting dynamic subtest: vcs0
[138.533391] Dynamic subtest vcs0: SUCCESS (0.038s)
[138.545299] Starting dynamic subtest: vcs1
[138.566610] Dynamic subtest vcs1: SUCCESS (0.033s)
[138.576254] Starting dynamic subtest: vecs0
[138.597356] Dynamic subtest vecs0: SUCCESS (0.030s)
[138.603838] Starting dynamic subtest: ccs0
[138.626754] Dynamic subtest ccs0: SUCCESS (0.029s)
[138.627602] Subtest submit-late-slice: SUCCESS (0.198s)
[139.999990] [026/132] (876s left) kms_psr (psr2-cursor-plane-onoff)
[140.085884] Starting subtest: psr2-cursor-plane-onoff
[140.086783] Starting dynamic subtest: eDP-1
[141.791982] Dynamic subtest eDP-1: SUCCESS (1.705s)
[141.792878] Subtest psr2-cursor-plane-onoff: SUCCESS (1.706s)
[142.660651] [027/132] (873s left) kms_cursor_crc (cursor-onscreen-256x256)
[142.891394] Starting subtest: cursor-onscreen-256x256
[142.895725] Starting dynamic subtest: pipe-A-eDP-1
[145.027531] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.131s)
[145.057095] Starting dynamic subtest: pipe-D-eDP-1
[147.846567] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.795s)
[147.847513] Subtest cursor-onscreen-256x256: SUCCESS (4.954s)
[148.717954] [028/132] (867s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[148.823992] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[148.825689] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[148.918493] [029/132] (867s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[148.983230] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[149.057545] [030/132] (867s left) i915_drm_fdinfo (most-busy-idle-check-all)
[149.093834] Starting subtest: most-busy-idle-check-all
[149.094752] Starting dynamic subtest: rcs0
[149.098686] Dynamic subtest rcs0: SKIP (0.004s)
[149.105253] Starting dynamic subtest: bcs0
[149.106739] Dynamic subtest bcs0: SKIP (0.000s)
[149.113142] Starting dynamic subtest: vcs0
[149.114593] Dynamic subtest vcs0: SKIP (0.000s)
[149.120921] Starting dynamic subtest: vcs1
[149.122572] Dynamic subtest vcs1: SKIP (0.000s)
[149.128963] Starting dynamic subtest: vecs0
[149.130451] Dynamic subtest vecs0: SKIP (0.000s)
[149.136788] Starting dynamic subtest: ccs0
[149.138322] Dynamic subtest ccs0: SKIP (0.000s)
[149.139761] Subtest most-busy-idle-check-all: SKIP (0.008s)
[149.167511] [031/132] (867s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[149.312423] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[149.313902] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[149.428821] [032/132] (867s left) prime_busy (before)
[149.488837] Starting subtest: before
[149.492025] Starting dynamic subtest: rcs0
[149.528916] Dynamic subtest rcs0: SUCCESS (0.037s)
[149.536206] Starting dynamic subtest: bcs0
[149.567396] Dynamic subtest bcs0: SUCCESS (0.038s)
[149.575788] Starting dynamic subtest: vcs0
[149.608873] Dynamic subtest vcs0: SUCCESS (0.041s)
[149.616119] Starting dynamic subtest: vcs1
[149.649231] Dynamic subtest vcs1: SUCCESS (0.040s)
[149.656780] Starting dynamic subtest: vecs0
[149.690722] Dynamic subtest vecs0: SUCCESS (0.041s)
[149.699141] Starting dynamic subtest: ccs0
[149.730787] Dynamic subtest ccs0: SUCCESS (0.039s)
[149.837838] Subtest before: SUCCESS (0.348s)
[149.906213] [033/132] (866s left) sw_sync (sync_multi_consumer_producer)
[149.934223] Starting subtest: sync_multi_consumer_producer
[150.227169] Subtest sync_multi_consumer_producer: SUCCESS (0.285s)
[150.272713] [034/132] (866s left) kms_cursor_crc (cursor-random-512x170)
[150.542783] Starting subtest: cursor-random-512x170
[150.544582] Subtest cursor-random-512x170: SKIP (0.001s)
[150.681782] [035/132] (866s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[150.799193] Starting subtest: 2x-flip-vs-cursor-atomic
[150.801886] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[150.953262] [036/132] (865s left) template (b)
[151.006418] Starting subtest: B
[151.007425] Subtest B: SUCCESS (0.000s)
[151.106165] [037/132] (865s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[151.197383] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[151.834327] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.637s)
[151.972597] [038/132] (864s left) gem_lmem_swapping (heavy-verify-random)
[152.013318] Subtest heavy-verify-random: SKIP (0.000s)
[152.053361] [039/132] (864s left) gem_exec_params (dr4-dirt)
[152.107643] Starting subtest: DR4-dirt
[152.108926] Subtest DR4-dirt: SUCCESS (0.000s)
[152.237193] [040/132] (864s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[152.323626] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[152.325485] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[152.419209] [041/132] (864s left) i915_hangman (gt-engine-error)
[152.473282] Starting subtest: gt-engine-error
[152.474208] Starting dynamic subtest: rcs0
[153.918574] Dynamic subtest rcs0: SUCCESS (1.436s)
[153.927894] Starting dynamic subtest: bcs0
[155.836495] Dynamic subtest bcs0: SUCCESS (1.916s)
[155.845140] Starting dynamic subtest: vcs0
[157.885303] Dynamic subtest vcs0: SUCCESS (2.046s)
[157.892849] Starting dynamic subtest: vcs1
[159.869074] Dynamic subtest vcs1: SUCCESS (1.981s)
[159.877755] Starting dynamic subtest: vecs0
[161.917289] Dynamic subtest vecs0: SUCCESS (2.046s)
[161.926787] Starting dynamic subtest: ccs0
[163.901423] Dynamic subtest ccs0: SUCCESS (1.981s)
[163.902912] Subtest gt-engine-error: SUCCESS (11.420s)
[163.973328] [042/132] (853s left) kms_draw_crc (draw-method-mmap-wc)
[164.061279] Starting subtest: draw-method-mmap-wc
[164.062159] Starting dynamic subtest: xrgb8888-untiled
[164.305535] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[164.312772] Starting dynamic subtest: rgb565-untiled
[164.527709] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[164.536645] Starting dynamic subtest: xrgb2101010-untiled
[164.750349] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[164.759381] Starting dynamic subtest: xbgr16161616f-untiled
[164.972571] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[164.981329] Starting dynamic subtest: xrgb8888-xtiled
[165.105492] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[165.113717] Starting dynamic subtest: rgb565-xtiled
[165.238838] Dynamic subtest rgb565-xtiled: SUCCESS (0.131s)
[165.246998] Starting dynamic subtest: xrgb2101010-xtiled
[165.361321] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[165.368470] Starting dynamic subtest: xbgr16161616f-xtiled
[165.494489] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[165.501266] Starting dynamic subtest: xrgb8888-4tiled
[165.661244] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.166s)
[165.668155] Starting dynamic subtest: rgb565-4tiled
[165.838715] Dynamic subtest rgb565-4tiled: SUCCESS (0.177s)
[165.845572] Starting dynamic subtest: xrgb2101010-4tiled
[165.994497] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.155s)
[166.005993] Starting dynamic subtest: xbgr16161616f-4tiled
[166.183343] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.187s)
[166.184184] Subtest draw-method-mmap-wc: SUCCESS (2.123s)
[166.296598] [043/132] (850s left) gem_exec_params (invalid-fence-in)
[166.346668] Starting subtest: invalid-fence-in
[166.347722] Subtest invalid-fence-in: SUCCESS (0.000s)
[166.442927] [044/132] (850s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[166.554635] Starting subtest: x-tiled-64bpp-rotate-180
[168.122789] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.568s)
[168.282779] [045/132] (848s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[168.373383] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[175.033268] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.659s)
[175.154481] [046/132] (842s left) kms_lease (lease-uevent)
[175.240394] Starting subtest: lease-uevent
[176.259656] Subtest lease-uevent: SUCCESS (1.019s)
[176.354605] [047/132] (840s left) kms_plane_alpha_blend (alpha-opaque-fb)
[176.452566] Starting subtest: alpha-opaque-fb
[176.734976] Starting dynamic subtest: pipe-A-eDP-1
[177.412728] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.677s)
[177.420163] Starting dynamic subtest: pipe-D-eDP-1
[178.814580] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.401s)
[178.815497] Subtest alpha-opaque-fb: SUCCESS (2.363s)
[179.617771] [048/132] (837s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[179.705975] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[179.706928] Starting dynamic subtest: pipe-A-eDP-1
[213.059139] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.774s)
[213.067784] Starting dynamic subtest: pipe-B-eDP-1
[247.999296] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.510s)
[248.008004] Starting dynamic subtest: pipe-C-eDP-1
[282.967693] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.487s)
[282.978084] Starting dynamic subtest: pipe-D-eDP-1
[317.971587] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.408s)
[317.972877] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (17.185s)
[325.233172] [049/132] (698s left) kms_vblank (query-busy)
[325.330188] Starting subtest: query-busy
[325.331153] Starting dynamic subtest: pipe-A-eDP-1
[327.250515] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s)
[327.259888] Starting dynamic subtest: pipe-D-eDP-1
[329.838584] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.550s)
[329.839564] Subtest query-busy: SUCCESS (4.438s)
[330.643324] [050/132] (692s left) gem_mmap_offset (mmap-boundaries)
[330.690497] Starting subtest: mmap-boundaries
[330.691693] Starting dynamic subtest: smem0
[330.981800] Dynamic subtest smem0: SUCCESS (0.280s)
[330.983042] Subtest mmap-boundaries: SUCCESS (0.281s)
[331.071330] [051/132] (692s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[331.154541] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[331.155471] Starting dynamic subtest: pipe-A-default-mode
[333.894442] Dynamic subtest pipe-A-default-mode: SUCCESS (2.716s)
[333.895504] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.718s)
[334.762983] [052/132] (688s left) gem_ctx_persistence (userptr)
[334.827239] Starting subtest: userptr
[335.019536] Subtest userptr: SUCCESS (0.191s)
[335.099341] [053/132] (688s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[335.191254] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[335.193845] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[335.259235] [054/132] (688s left) gem_exec_balancer (hog)
[335.319583] Starting subtest: hog
[335.321705] Subtest hog: SKIP (0.000s)
[335.601377] [055/132] (687s left) kms_psr (fbc-psr2-cursor-render)
[335.691305] Starting subtest: fbc-psr2-cursor-render
[335.692604] Starting dynamic subtest: eDP-1
[335.694617] Dynamic subtest eDP-1: SKIP (0.000s)
[335.696435] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[335.772762] [056/132] (687s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[335.859413] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[335.861572] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[335.941217] [057/132] (687s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[336.061313] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[345.445479] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.352s)
[346.233420] [058/132] (677s left) api_intel_bb (offset-control)
[346.295205] Starting subtest: offset-control
[346.304317] Subtest offset-control: SUCCESS (0.010s)
[346.413356] [059/132] (677s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[346.805768] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[347.651120] [060/132] (676s left) kms_content_protection (legacy-hdcp14)
[347.792462] Starting subtest: legacy-hdcp14
[347.794500] Subtest legacy-hdcp14: SKIP (0.000s)
[347.895633] [061/132] (675s left) gem_ctx_persistence (engines-persistence)
[347.946752] Starting subtest: engines-persistence
[347.948170] Starting dynamic subtest: rcs0
[348.754943] Dynamic subtest rcs0: SUCCESS (0.806s)
[348.767756] Starting dynamic subtest: bcs0
[349.511991] Dynamic subtest bcs0: SUCCESS (0.754s)
[349.524363] Starting dynamic subtest: vcs0
[350.284268] Dynamic subtest vcs0: SUCCESS (0.769s)
[350.296275] Starting dynamic subtest: vcs1
[351.055172] Dynamic subtest vcs1: SUCCESS (0.768s)
[351.067261] Starting dynamic subtest: vecs0
[351.800908] Dynamic subtest vecs0: SUCCESS (0.740s)
[351.810869] Starting dynamic subtest: ccs0
[352.568554] Dynamic subtest ccs0: SUCCESS (0.767s)
[352.570259] Subtest engines-persistence: SUCCESS (4.617s)
[352.678275] [062/132] (671s left) kms_big_fb (y-tiled-addfb-size-overflow)
[352.784926] Starting subtest: y-tiled-addfb-size-overflow
[352.787430] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[352.890025] [063/132] (670s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[352.971413] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[360.736711] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.763s)
[360.865247] [064/132] (663s left) gem_partial_pwrite_pread (write)
[360.919356] Subtest write: SKIP (0.000s)
[360.983810] [065/132] (662s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[361.069782] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[361.071299] Starting dynamic subtest: pipe-A-eDP-1
[361.082398] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[361.094949] Starting dynamic subtest: pipe-B-eDP-1
[361.107600] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[361.116415] Starting dynamic subtest: pipe-C-eDP-1
[361.125329] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[361.132762] Starting dynamic subtest: pipe-D-eDP-1
[361.142740] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[361.144433] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.005s)
[363.210428] [066/132] (660s left) gem_exec_store (basic)
[363.269810] Starting subtest: basic
[363.365293] Subtest basic: SUCCESS (0.097s)
[363.550258] [067/132] (660s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[363.652629] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[363.654831] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[363.754290] [068/132] (660s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[363.808981] Starting subtest: x-tiled-to-vebox-yf-tiled
[363.811600] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[363.987334] [069/132] (660s left) vgem_basic (busy-fence)
[364.021655] Starting subtest: busy-fence
[364.022743] Subtest busy-fence: SUCCESS (0.000s)
[364.073354] [070/132] (660s left) gem_ctx_param (invalid-size-get)
[364.128261] Starting subtest: invalid-size-get
[364.130006] Subtest invalid-size-get: SUCCESS (0.001s)
[364.209165] [071/132] (659s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[364.296402] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[364.297486] Starting dynamic subtest: pipe-A-eDP-1
[364.305744] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[364.323643] Starting dynamic subtest: pipe-B-eDP-1
[364.337433] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[364.347236] Starting dynamic subtest: pipe-C-eDP-1
[364.355818] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[364.362894] Starting dynamic subtest: pipe-D-eDP-1
[364.371831] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[364.372923] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[366.488370] [072/132] (657s left) gem_spin_batch (resubmit-new-all)
[366.545489] Starting subtest: resubmit-new-all
[366.546756] Starting dynamic subtest: rcs0
[366.563052] Dynamic subtest rcs0: SUCCESS (0.017s)
[366.571873] Starting dynamic subtest: bcs0
[366.574830] Dynamic subtest bcs0: SUCCESS (0.010s)
[366.582747] Starting dynamic subtest: vcs0
[366.584019] Dynamic subtest vcs0: SUCCESS (0.009s)
[366.591689] Starting dynamic subtest: vcs1
[366.595621] Dynamic subtest vcs1: SUCCESS (0.008s)
[366.603074] Starting dynamic subtest: vecs0
[366.604658] Dynamic subtest vecs0: SUCCESS (0.008s)
[366.612010] Starting dynamic subtest: ccs0
[366.613640] Dynamic subtest ccs0: SUCCESS (0.008s)
[366.614898] Subtest resubmit-new-all: SUCCESS (0.067s)
[368.051814] [073/132] (656s left) kms_flip (nonexisting-fb)
[368.140538] Starting subtest: nonexisting-fb
[368.144549] Starting dynamic subtest: A-eDP1
[369.280993] Dynamic subtest A-eDP1: SUCCESS (1.138s)
[369.290793] Starting dynamic subtest: B-eDP1
[370.414335] Dynamic subtest B-eDP1: SUCCESS (1.130s)
[370.424036] Starting dynamic subtest: C-eDP1
[371.547394] Dynamic subtest C-eDP1: SUCCESS (1.130s)
[371.556620] Starting dynamic subtest: D-eDP1
[372.682943] Dynamic subtest D-eDP1: SUCCESS (1.134s)
[372.687769] Subtest nonexisting-fb: SUCCESS (4.545s)
[373.847815] [074/132] (650s left) gem_exec_fence (submit-chain)
[374.025276] Starting subtest: submit-chain
[374.042347] Subtest submit-chain: SUCCESS (0.024s)
[376.029857] [075/132] (648s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[376.123603] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[376.125886] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[376.194050] [076/132] (648s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[376.291752] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[376.293743] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[376.382831] [077/132] (647s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[376.481327] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[376.483293] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[376.595545] [078/132] (647s left) kms_vblank (wait-forked-hang)
[376.684808] Starting subtest: wait-forked-hang
[376.685883] Starting dynamic subtest: pipe-A-eDP-1
[402.787496] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.089s)
[402.797915] Starting dynamic subtest: pipe-D-eDP-1
[417.798634] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.005s)
[417.799500] Subtest wait-forked-hang: SUCCESS (41.098s)
[418.637385] [079/132] (605s left) i915_suspend (forcewake)
[418.680534] Starting subtest: forcewake
[450.812528] Subtest forcewake: SUCCESS (3.056s)
[458.915054] [080/132] (573s left) kms_cursor_crc (cursor-sliding-max-size)
[459.289388] Starting subtest: cursor-sliding-max-size
[459.291821] Subtest cursor-sliding-max-size: SKIP (0.000s)
[459.409595] [081/132] (573s left) gem_exec_params (cliprects-invalid)
[459.464400] Starting subtest: cliprects-invalid
[459.465779] Subtest cliprects-invalid: SUCCESS (0.000s)
[459.563447] [082/132] (572s left) gem_userptr_blits (forbidden-operations)
[459.609538] Starting subtest: forbidden-operations
[459.611100] Subtest forbidden-operations: SKIP (0.000s)
[459.721486] [083/132] (572s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[459.803301] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[459.805109] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[459.892161] [084/132] (572s left) gem_exec_reloc (basic-wc-read-noreloc)
[459.944346] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[460.006494] [085/132] (572s left) kms_psr (fbc-pr-cursor-render)
[460.094918] Starting subtest: fbc-pr-cursor-render
[460.096922] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[460.172985] [086/132] (572s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[460.228101] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[460.292543] [087/132] (572s left) gem_exec_reloc (basic-range)
[460.354189] Subtest basic-range: SKIP (0.000s)
[460.424445] [088/132] (572s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[460.518310] Starting subtest: psr-rgb565-draw-mmap-cpu
[467.469213] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.869s)
[467.575304] [089/132] (565s left) kms_rotation_crc (primary-rotation-90)
[467.664488] Starting subtest: primary-rotation-90
[467.666237] Subtest primary-rotation-90: SKIP (0.001s)
[467.731768] [090/132] (565s left) tools_test (tools_test)
[467.766330] Starting subtest: tools_test
[467.834936] Subtest tools_test: SUCCESS (0.073s)
[467.896619] [091/132] (564s left) kms_addfb_basic (bad-pitch-1024)
[467.937999] Starting subtest: bad-pitch-1024
[467.938932] Subtest bad-pitch-1024: SUCCESS (0.000s)
[468.061747] [092/132] (564s left) gem_exec_reloc (basic-cpu)
[468.114510] Subtest basic-cpu: SKIP (0.000s)
[468.182604] [093/132] (564s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[468.282070] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[469.135649] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.848s)
[469.291328] [094/132] (563s left) gen9_exec_parse (bb-start-cmd)
[469.349079] Subtest bb-start-cmd: SKIP (0.000s)
[469.413104] [095/132] (563s left) gem_mmap_gtt (big-copy)
[469.456752] Subtest big-copy: SKIP (0.000s)
[469.499393] [096/132] (563s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[469.585269] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[469.587069] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[469.653132] [097/132] (563s left) kms_psr (fbc-psr-no-drrs)
[469.733655] Starting subtest: fbc-psr-no-drrs
[469.734926] Starting dynamic subtest: eDP-1
[469.737526] Dynamic subtest eDP-1: SKIP (0.000s)
[469.740137] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[469.801264] [098/132] (563s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[469.886703] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[469.889289] Starting dynamic subtest: A-eDP1
[478.800243] Dynamic subtest A-eDP1: SUCCESS (8.880s)
[478.811477] Starting dynamic subtest: B-eDP1
[487.747170] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[487.761483] Starting dynamic subtest: C-eDP1
[496.709288] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[496.720445] Starting dynamic subtest: D-eDP1
[505.644325] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[505.645477] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.678s)
[506.833064] [099/132] (526s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[506.924886] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[506.926675] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[507.022574] [100/132] (526s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[507.111714] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[507.113217] Starting dynamic subtest: pipe-A-eDP-1
[507.122063] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[507.132705] Starting dynamic subtest: pipe-B-eDP-1
[507.142045] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[507.149771] Starting dynamic subtest: pipe-C-eDP-1
[507.158138] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[507.165681] Starting dynamic subtest: pipe-D-eDP-1
[507.173765] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[507.174605] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[509.421262] [101/132] (523s left) gem_ctx_create (basic)
[509.480390] Starting subtest: basic
[509.481644] Subtest basic: SUCCESS (0.000s)
[509.657303] [102/132] (523s left) gem_exec_schedule (preempt-other-chain)
[509.719432] Starting subtest: preempt-other-chain
[509.720557] Starting dynamic subtest: rcs0
[509.807047] Dynamic subtest rcs0: SUCCESS (0.086s)
[509.819097] Starting dynamic subtest: bcs0
[509.892300] Dynamic subtest bcs0: SUCCESS (0.084s)
[509.904714] Starting dynamic subtest: vcs0
[509.980044] Dynamic subtest vcs0: SUCCESS (0.087s)
[509.992471] Starting dynamic subtest: vcs1
[510.061500] Dynamic subtest vcs1: SUCCESS (0.081s)
[510.073446] Starting dynamic subtest: vecs0
[510.147844] Dynamic subtest vecs0: SUCCESS (0.085s)
[510.156590] Starting dynamic subtest: ccs0
[510.235468] Dynamic subtest ccs0: SUCCESS (0.087s)
[510.236756] Subtest preempt-other-chain: SUCCESS (0.516s)
[511.153844] [103/132] (522s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[511.252508] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[515.035923] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.783s)
[516.231652] [104/132] (517s left) perf_pmu (rc6-suspend)
[516.272389] Starting subtest: rc6-suspend
[538.951641] Subtest rc6-suspend: SUCCESS (7.933s)
[542.354628] [105/132] (494s left) api_intel_allocator (alloc-simple)
[542.412836] Starting subtest: alloc-simple
[542.417514] Subtest alloc-simple: SUCCESS (0.006s)
[542.530585] [106/132] (493s left) gem_barrier_race (remote-request)
[542.584702] Starting subtest: remote-request
[542.585598] Starting dynamic subtest: rcs0
[547.803578] Dynamic subtest rcs0: SUCCESS (5.133s)
[547.805519] Subtest remote-request: SUCCESS (5.143s)
[547.970550] [107/132] (488s left) gem_pipe_control_store_loop (reused-buffer)
[548.017264] Starting subtest: reused-buffer
[550.239329] Subtest reused-buffer: SUCCESS (2.155s)
[550.311592] [108/132] (486s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[550.413117] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[551.500928] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.080s)
[551.620155] [109/132] (484s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[551.714006] Starting subtest: multiplane-rotation-cropping-top
[569.256262] Subtest multiplane-rotation-cropping-top: SUCCESS (17.493s)
[569.357480] [110/132] (467s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[569.459533] Starting subtest: fbc-rgb565-draw-mmap-gtt
[569.461309] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[569.552545] [111/132] (467s left) gem_reg_read (timestamp-monotonic)
[569.607788] Starting subtest: timestamp-monotonic
[573.861213] Subtest timestamp-monotonic: SUCCESS (4.240s)
[573.918616] [112/132] (462s left) gem_softpin (evict-snoop)
[573.973787] Starting subtest: evict-snoop
[573.975734] Subtest evict-snoop: SKIP (0.000s)
[574.119705] [113/132] (462s left) gem_ringfill (basic-all)
[579.837601] Starting subtest: basic-all
[580.994059] Subtest basic-all: SUCCESS (1.155s)
[581.103630] [114/132] (455s left) kms_cursor_legacy (torture-bo)
[581.216111] Starting subtest: torture-bo
[581.216967] Starting dynamic subtest: pipe-A
[587.017761] Dynamic subtest pipe-A: SUCCESS (5.790s)
[587.027107] Starting dynamic subtest: pipe-B
[593.470341] Dynamic subtest pipe-B: SUCCESS (6.459s)
[593.486896] Starting dynamic subtest: pipe-C
[599.924444] Dynamic subtest pipe-C: SUCCESS (6.450s)
[599.939834] Starting dynamic subtest: pipe-D
[606.272173] Dynamic subtest pipe-D: SUCCESS (6.343s)
[606.283617] Starting dynamic subtest: all-pipes
[612.956278] Dynamic subtest all-pipes: SUCCESS (6.679s)
[612.957288] Subtest torture-bo: SUCCESS (31.733s)
[613.122791] [115/132] (423s left) kms_plane (planar-pixel-format-settings)
[613.218242] Starting subtest: planar-pixel-format-settings
[613.291746] Subtest planar-pixel-format-settings: SUCCESS (0.073s)
[613.432571] [116/132] (423s left) gem_exec_gttfill (engines)
[613.496377] Starting subtest: engines
[613.497411] Starting dynamic subtest: rcs0
[636.530720] Dynamic subtest rcs0: SUCCESS (23.024s)
[636.542847] Starting dynamic subtest: bcs0
[659.868845] Dynamic subtest bcs0: SUCCESS (23.339s)
[659.880627] Starting dynamic subtest: vcs0
[683.236271] Dynamic subtest vcs0: SUCCESS (23.364s)
[683.248686] Starting dynamic subtest: vcs1
[706.559752] Dynamic subtest vcs1: SUCCESS (23.316s)
[706.572166] Starting dynamic subtest: vecs0
[729.867899] Dynamic subtest vecs0: SUCCESS (23.300s)
[729.880078] Starting dynamic subtest: ccs0
[753.188806] Dynamic subtest ccs0: SUCCESS (23.312s)
[753.192420] Subtest engines: SUCCESS (139.671s)
[753.376535] [117/132] (283s left) i915_pm_rps (reset)
[753.487562] Starting subtest: reset
[761.988933] Subtest reset: SUCCESS (8.491s)
[762.114153] [118/132] (274s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[762.173112] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[762.278206] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.104s)
[762.352254] [119/132] (274s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[762.456159] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[769.030601] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.574s)
[769.127140] [120/132] (267s left) kms_plane_multiple (2x-tiling-x)
[769.227219] Starting subtest: 2x-tiling-x
[769.228945] Subtest 2x-tiling-x: SKIP (0.000s)
[769.297322] [121/132] (267s left) core_getversion (all-cards)
[769.334050] Starting subtest: all-cards
[769.344397] Subtest all-cards: SUCCESS (0.012s)
[769.384925] [122/132] (267s left) kms_invalid_mode (bad-vtotal)
[769.475465] Starting subtest: bad-vtotal
[769.476606] Starting dynamic subtest: pipe-A-eDP-1
[769.761480] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[769.770327] Starting dynamic subtest: pipe-B-eDP-1
[769.771257] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[769.779325] Starting dynamic subtest: pipe-C-eDP-1
[769.780180] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[769.788035] Starting dynamic subtest: pipe-D-eDP-1
[769.788844] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[769.789701] Subtest bad-vtotal: SUCCESS (0.291s)
[770.592478] [123/132] (266s left) kms_flip (modeset-vs-vblank-race-interruptible)
[770.691949] Starting subtest: modeset-vs-vblank-race-interruptible
[770.694285] Starting dynamic subtest: A-eDP1
[775.430304] Dynamic subtest A-eDP1: SUCCESS (4.738s)
[775.441804] Starting dynamic subtest: B-eDP1
[780.046805] Dynamic subtest B-eDP1: SUCCESS (4.614s)
[780.059318] Starting dynamic subtest: C-eDP1
[784.566916] Dynamic subtest C-eDP1: SUCCESS (4.518s)
[784.579100] Starting dynamic subtest: D-eDP1
[789.200129] Dynamic subtest D-eDP1: SUCCESS (4.632s)
[789.202746] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.515s)
[790.360125] [124/132] (246s left) gem_mmap_gtt (basic-read-write)
[790.420547] Subtest basic-read-write: SKIP (0.000s)
[790.480405] [125/132] (246s left) gem_create (create-ext-placement-all)
[790.654352] Starting subtest: create-ext-placement-all
[790.655341] Subtest create-ext-placement-all: SUCCESS (0.000s)
[790.754637] [126/132] (246s left) kms_color (ctm-red-to-blue)
[790.839122] Starting subtest: ctm-red-to-blue
[790.839970] Starting dynamic subtest: pipe-A-eDP-1
[791.571759] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.732s)
[791.580485] Starting dynamic subtest: pipe-B-eDP-1
[792.975463] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.403s)
[792.983931] Starting dynamic subtest: pipe-C-eDP-1
[794.355433] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.379s)
[794.364038] Starting dynamic subtest: pipe-D-eDP-1
[795.679417] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[795.680342] Subtest ctm-red-to-blue: SUCCESS (4.842s)
[796.478606] [127/132] (240s left) gem_lmem_swapping (verify-random-ccs)
[796.514672] Subtest verify-random-ccs: SKIP (0.000s)
[796.554837] [128/132] (240s left) kms_psr (pr-primary-mmap-gtt)
[796.645149] Starting subtest: pr-primary-mmap-gtt
[796.646798] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[796.728337] [129/132] (240s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[796.851280] Starting subtest: short-flip-after-cursor-toggle
[797.776366] Subtest short-flip-after-cursor-toggle: SUCCESS (0.925s)
[798.606792] [130/132] (238s left) gem_mmap_wc (bad-offset)
[798.655058] Subtest bad-offset: SKIP (0.000s)
[798.709250] [131/132] (238s left) kms_async_flips (test-cursor)
[798.792318] Starting subtest: test-cursor
[799.166804] Starting dynamic subtest: pipe-A-eDP-1
[799.915124] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.748s)
[800.314391] Starting dynamic subtest: pipe-B-eDP-1
[801.047790] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.744s)
[801.434438] Starting dynamic subtest: pipe-C-eDP-1
[802.179405] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.754s)
[802.551082] Starting dynamic subtest: pipe-D-eDP-1
[803.309239] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.766s)
[803.310072] Subtest test-cursor: SUCCESS (4.519s)
[804.483219] [132/132] (232s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[804.576605] Starting subtest: fbcpsr-modesetfrombusy
[810.757973] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.182s)
[810.883956] Closing watchdogs
results: parsing output: 0/ for test: gem_sync
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: kms_psr2_sf
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: perf_pmu
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: gem_exec_fence
results: parsing output: 10/ for test: syncobj_wait
results: parsing output: 11/ for test: kms_chamelium_audio
results: parsing output: 12/ for test: gem_ctx_sseu
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_addfb_basic
results: parsing output: 16/ for test: gem_mmap_wc
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_pm_rpm
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: core_auth
results: parsing output: 23/ for test: kms_chamelium_frames
results: parsing output: 24/ for test: gem_exec_schedule
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: i915_drm_fdinfo
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: prime_busy
results: parsing output: 32/ for test: sw_sync
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: template
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: gem_lmem_swapping
results: parsing output: 38/ for test: gem_exec_params
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: i915_hangman
results: parsing output: 41/ for test: kms_draw_crc
results: parsing output: 42/ for test: gem_exec_params
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_lease
results: parsing output: 46/ for test: kms_plane_alpha_blend
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: kms_vblank
results: parsing output: 49/ for test: gem_mmap_offset
results: parsing output: 50/ for test: kms_flip_scaled_crc
results: parsing output: 51/ for test: gem_ctx_persistence
results: parsing output: 52/ for test: kms_psr2_sf
results: parsing output: 53/ for test: gem_exec_balancer
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: api_intel_bb
results: parsing output: 58/ for test: kms_chamelium_hpd
results: parsing output: 59/ for test: kms_content_protection
results: parsing output: 60/ for test: gem_ctx_persistence
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_partial_pwrite_pread
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: gem_exec_store
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_render_copy
results: parsing output: 68/ for test: vgem_basic
results: parsing output: 69/ for test: gem_ctx_param
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: gem_spin_batch
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: gem_exec_fence
results: parsing output: 74/ for test: kms_plane
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_vblank
results: parsing output: 78/ for test: i915_suspend
results: parsing output: 79/ for test: kms_cursor_crc
results: parsing output: 80/ for test: gem_exec_params
results: parsing output: 81/ for test: gem_userptr_blits
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_pipe_b_c_ivb
results: parsing output: 86/ for test: gem_exec_reloc
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_rotation_crc
results: parsing output: 89/ for test: tools_test
results: parsing output: 90/ for test: kms_addfb_basic
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: gen9_exec_parse
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_psr
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: gem_ctx_create
results: parsing output: 101/ for test: gem_exec_schedule
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: perf_pmu
results: parsing output: 104/ for test: api_intel_allocator
results: parsing output: 105/ for test: gem_barrier_race
results: parsing output: 106/ for test: gem_pipe_control_store_loop
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_rotation_crc
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_reg_read
results: parsing output: 111/ for test: gem_softpin
results: parsing output: 112/ for test: gem_ringfill
results: parsing output: 113/ for test: kms_cursor_legacy
results: parsing output: 114/ for test: kms_plane
results: parsing output: 115/ for test: gem_exec_gttfill
results: parsing output: 116/ for test: i915_pm_rps
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_plane_multiple
results: parsing output: 120/ for test: core_getversion
results: parsing output: 121/ for test: kms_invalid_mode
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: gem_mmap_gtt
results: parsing output: 124/ for test: gem_create
results: parsing output: 125/ for test: kms_color
results: parsing output: 126/ for test: gem_lmem_swapping
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: gem_mmap_wc
results: parsing output: 130/ for test: kms_async_flips
results: parsing output: 131/ for test: kms_frontbuffer_tracking
Done.