[59.910164] Initializing watchdogs
[59.910264]   /dev/watchdog0
[59.925340] [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]
[59.929720] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.931982] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.935154] [001/134] (960s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[60.059757] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[60.062063] Starting dynamic subtest: pipe-A
[60.149722] Dynamic subtest pipe-A: SUCCESS (0.091s)
[60.158612] Starting dynamic subtest: pipe-B
[61.264513] Dynamic subtest pipe-B: SUCCESS (1.112s)
[61.274203] Starting dynamic subtest: pipe-C
[62.386303] Dynamic subtest pipe-C: SUCCESS (1.119s)
[62.394642] Starting dynamic subtest: pipe-D
[63.516080] Dynamic subtest pipe-D: SUCCESS (1.127s)
[63.518372] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.451s)
[64.685311] [002/134] (955s left) gem_userptr_blits (forbidden-operations)
[64.752409] Starting subtest: forbidden-operations
[64.756988] Subtest forbidden-operations: SKIP (0.000s)
[64.925284] [003/134] (955s left) gem_mmap_gtt (big-bo)
[64.984536] Subtest big-bo: SKIP (0.000s)
[65.046698] [004/134] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[65.147931] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[72.709177] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.558s)
[72.900580] [005/134] (947s left) kms_fence_pin_leak
[73.096391] [006/134] (947s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[73.190288] Starting subtest: x-tiled-16bpp-rotate-180
[74.481030] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.292s)
[74.658670] [007/134] (946s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[74.715775] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[74.771053] [008/134] (945s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[74.861911] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[74.874921] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[75.007648] [009/134] (945s left) perf_pmu (busy-check-all)
[75.054161] Starting subtest: busy-check-all
[75.056163] Starting dynamic subtest: rcs0
[75.629082] Dynamic subtest rcs0: SUCCESS (0.574s)
[75.640790] Starting dynamic subtest: bcs0
[76.179651] Dynamic subtest bcs0: SUCCESS (0.550s)
[76.190148] Starting dynamic subtest: vcs0
[77.910569] Dynamic subtest vcs0: SUCCESS (1.728s)
[77.921495] Starting dynamic subtest: vcs1
[79.893078] Dynamic subtest vcs1: SUCCESS (1.981s)
[79.904044] Starting dynamic subtest: vecs0
[81.941209] Dynamic subtest vecs0: SUCCESS (2.047s)
[81.952198] Starting dynamic subtest: ccs0
[82.496071] Dynamic subtest ccs0: SUCCESS (0.555s)
[82.498547] Subtest busy-check-all: SUCCESS (7.442s)
[82.632662] [010/134] (938s left) gem_mmap_wc (coherency)
[82.693960] Subtest coherency: SKIP (0.000s)
[82.769679] [011/134] (938s left) kms_big_fb (yf-tiled-addfb)
[82.871962] Starting subtest: yf-tiled-addfb
[82.876225] Subtest yf-tiled-addfb: SKIP (0.000s)
[83.006127] [012/134] (937s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[83.113566] Starting subtest: extended-modeset-hang-oldfb-with-reset
[83.115885] Starting dynamic subtest: pipe-A
[94.687279] Dynamic subtest pipe-A: SUCCESS (11.571s)
[94.696062] Starting dynamic subtest: pipe-D
[106.970927] Dynamic subtest pipe-D: SUCCESS (12.283s)
[106.973570] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.857s)
[107.773924] [013/134] (913s left) kms_plane_alpha_blend (constant-alpha-min)
[107.890282] Starting subtest: constant-alpha-min
[108.172076] Starting dynamic subtest: pipe-A-eDP-1
[108.883818] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s)
[108.893194] Starting dynamic subtest: pipe-D-eDP-1
[110.338439] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.455s)
[110.340792] Subtest constant-alpha-min: SUCCESS (2.451s)
[111.156036] [014/134] (909s left) sysfs_timeslice_duration (duration)
[111.229851] Starting subtest: duration
[111.232258] Starting dynamic subtest: vecs0
[124.849986] Dynamic subtest vecs0: SUCCESS (13.620s)
[124.861202] Starting dynamic subtest: ccs0
[138.012843] Dynamic subtest ccs0: SUCCESS (13.164s)
[138.023070] Starting dynamic subtest: vcs0
[151.795547] Dynamic subtest vcs0: SUCCESS (13.778s)
[151.807867] Starting dynamic subtest: bcs0
[164.955696] Dynamic subtest bcs0: SUCCESS (13.157s)
[164.966140] Starting dynamic subtest: rcs0
[178.121403] Dynamic subtest rcs0: SUCCESS (13.167s)
[178.132201] Starting dynamic subtest: vcs1
[191.795323] Dynamic subtest vcs1: SUCCESS (13.671s)
[191.797958] Subtest duration: SUCCESS (80.565s)
[191.891936] [015/134] (829s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[191.999458] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[195.712556] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.718s)
[196.868897] [016/134] (824s left) kms_cursor_crc (cursor-onscreen-64x64)
[197.056276] Starting subtest: cursor-onscreen-64x64
[197.061334] Starting dynamic subtest: pipe-A-eDP-1
[199.183388] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.122s)
[199.213044] Starting dynamic subtest: pipe-D-eDP-1
[201.941840] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.735s)
[201.944397] Subtest cursor-onscreen-64x64: SUCCESS (4.883s)
[202.833126] [017/134] (818s left) kms_color (ctm-red-to-blue)
[202.929047] Starting subtest: ctm-red-to-blue
[202.930951] Starting dynamic subtest: pipe-A-eDP-1
[203.660925] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.731s)
[203.670984] Starting dynamic subtest: pipe-B-eDP-1
[205.151194] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.491s)
[205.159654] Starting dynamic subtest: pipe-C-eDP-1
[206.488713] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.337s)
[206.498632] Starting dynamic subtest: pipe-D-eDP-1
[207.826118] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.338s)
[207.828516] Subtest ctm-red-to-blue: SUCCESS (4.899s)
[208.658028] [018/134] (812s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[208.731906] Subtest writes-after-reads-uncached: SKIP (0.000s)
[208.803286] [019/134] (812s left) dumb_buffer (invalid-bpp)
[208.857991] Starting subtest: invalid-bpp
[208.860276] Subtest invalid-bpp: SUCCESS (0.000s)
[208.978107] [020/134] (812s left) gem_mmap_gtt (ptrace)
[209.040647] Subtest ptrace: SKIP (0.000s)
[209.093928] [021/134] (812s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[209.214252] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[209.218796] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[209.381753] [022/134] (811s left) gem_lmem_swapping (verify)
[209.430457] Subtest verify: SKIP (0.000s)
[209.473918] [023/134] (811s left) gem_spin_batch (resubmit-new)
[209.547069] Starting subtest: resubmit-new
[209.549424] Starting dynamic subtest: rcs0
[209.554306] Dynamic subtest rcs0: SUCCESS (0.007s)
[209.564886] Starting dynamic subtest: bcs0
[209.566684] Dynamic subtest bcs0: SUCCESS (0.004s)
[209.574453] Starting dynamic subtest: vcs0
[209.576507] Dynamic subtest vcs0: SUCCESS (0.005s)
[209.584571] Starting dynamic subtest: vcs1
[209.586456] Dynamic subtest vcs1: SUCCESS (0.004s)
[209.594337] Starting dynamic subtest: vecs0
[209.596142] Dynamic subtest vecs0: SUCCESS (0.004s)
[209.603500] Starting dynamic subtest: ccs0
[209.605285] Dynamic subtest ccs0: SUCCESS (0.003s)
[209.607069] Subtest resubmit-new: SUCCESS (0.029s)
[210.963834] [024/134] (810s left) kms_cursor_crc (cursor-random-512x512)
[211.246712] Starting subtest: cursor-random-512x512
[211.250375] Subtest cursor-random-512x512: SKIP (0.001s)
[211.438475] [025/134] (809s left) kms_properties (plane-properties-legacy)
[211.529909] Starting subtest: plane-properties-legacy
[211.532126] Starting dynamic subtest: pipe-A-eDP-1
[212.078801] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.546s)
[212.088111] Starting dynamic subtest: pipe-B-eDP-1
[213.315733] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.237s)
[213.325180] Starting dynamic subtest: pipe-C-eDP-1
[214.555035] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.236s)
[214.564521] Starting dynamic subtest: pipe-D-eDP-1
[215.790953] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[215.793260] Subtest plane-properties-legacy: SUCCESS (4.261s)
[216.611655] [026/134] (804s left) kms_vrr (flipline)
[216.724835] Starting subtest: flipline
[216.730950] Subtest flipline: SKIP (0.000s)
[216.817968] [027/134] (804s left) gem_exec_params (secure-non-master)
[216.889789] Starting subtest: secure-non-master
[216.894412] Subtest secure-non-master: SKIP (0.000s)
[217.024280] [028/134] (804s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[217.289186] Starting subtest: parallel-dmabuf-import-out-fence
[218.440171] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.153s)
[218.585235] [029/134] (802s left) kms_pm_dc (dc5-dpms-negative)
[219.698075] Starting subtest: dc5-dpms-negative
[219.702709] Subtest dc5-dpms-negative: SKIP (0.000s)
[219.791148] [030/134] (801s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[219.901187] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[219.905316] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[220.035440] [031/134] (801s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[220.139929] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[226.944244] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.807s)
[227.091422] [032/134] (794s left) kms_frontbuffer_tracking (psr-argb161616f-draw-mmap-cpu)
[227.205387] Starting subtest: psr-argb161616f-draw-mmap-cpu
[227.209656] Subtest psr-argb161616f-draw-mmap-cpu: SKIP (0.000s)
[227.332389] [033/134] (794s left) gem_exec_whisper (basic-fds-all)
[227.397266] Starting subtest: basic-fds-all
[239.862650] Subtest basic-fds-all: SUCCESS (12.460s)
[240.064798] [034/134] (781s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[240.173815] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[240.178137] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[240.298334] [035/134] (781s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[240.399690] Starting subtest: psr-rgb565-draw-render
[247.449113] Subtest psr-rgb565-draw-render: SUCCESS (7.052s)
[247.596795] [036/134] (774s left) gem_render_copy_redux (flink)
[247.663805] Starting subtest: flink
[248.465273] Subtest flink: SUCCESS (0.802s)
[248.616209] [037/134] (773s left) gem_mmap_wc (bad-offset)
[248.669648] Subtest bad-offset: SKIP (0.000s)
[248.734853] [038/134] (773s left) gem_pxp (reject-modify-context-protection-off-2)
[248.856808] Starting subtest: reject-modify-context-protection-off-2
[248.859199] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[248.981828] [039/134] (772s left) kms_3d (basic)
[249.040202] Starting subtest: basic
[250.993724] Subtest basic: SUCCESS (1.954s)
[251.496688] [040/134] (770s left) gem_ctx_persistence (smoketest)
[251.565425] Starting subtest: smoketest
[291.826555] Subtest smoketest: SUCCESS (40.261s)
[291.929374] [041/134] (730s left) kms_psr (fbc-pr-suspend)
[292.038060] Starting subtest: fbc-pr-suspend
[292.042173] Subtest fbc-pr-suspend: SKIP (0.000s)
[292.130369] [042/134] (729s left) syncobj_timeline (multi-wait-for-submit-signaled)
[292.186942] Starting subtest: multi-wait-for-submit-signaled
[292.189241] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[292.326299] [043/134] (729s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[292.422978] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[292.425280] Starting dynamic subtest: pipe-A-default-mode
[295.115726] Dynamic subtest pipe-A-default-mode: SUCCESS (2.690s)
[295.118150] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.693s)
[295.952113] [044/134] (726s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[296.060209] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[296.062479] Starting dynamic subtest: pipe-A-default-mode
[298.835981] Dynamic subtest pipe-A-default-mode: SUCCESS (2.775s)
[298.838154] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.776s)
[299.655853] [045/134] (722s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[299.763111] Starting subtest: psr-rgb565-draw-mmap-cpu
[306.492316] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.732s)
[306.641062] [046/134] (715s left) vgem_basic (mmap)
[306.768340] Starting subtest: mmap
[306.774370] Subtest mmap: SUCCESS (0.008s)
[306.845247] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[306.848491] [047/134] (715s left) gem_userptr_blits (sync-unmap-after-close)
[306.923216] Starting subtest: sync-unmap-after-close
[306.929017] Subtest sync-unmap-after-close: SUCCESS (0.009s)
[307.093764] [048/134] (715s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[307.487919] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[308.303340] [049/134] (713s left) kms_frontbuffer_tracking (basic)
[308.405550] Starting subtest: basic
[311.688695] Subtest basic: SUCCESS (3.287s)
[311.849488] [050/134] (710s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[311.952464] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[319.013340] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.062s)
[319.139540] [051/134] (703s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[319.244590] Starting subtest: fbc-rgb101010-draw-blt
[323.786827] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.544s)
[324.959953] [052/134] (697s left) kms_lease (lease-unleased-connector)
[325.059661] Starting subtest: lease-unleased-connector
[325.061831] Starting dynamic subtest: pipe-A-eDP-1
[325.066493] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[325.077640] Starting dynamic subtest: pipe-B-eDP-1
[325.079560] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[325.092650] Starting dynamic subtest: pipe-C-eDP-1
[325.094881] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[325.103637] Starting dynamic subtest: pipe-D-eDP-1
[325.105729] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[325.107831] Subtest lease-unleased-connector: SUCCESS (0.036s)
[325.238637] [053/134] (697s left) gem_tiled_partial_pwrite_pread (reads)
[325.301524] Subtest reads: SKIP (0.000s)
[325.392595] [054/134] (697s left) kms_dp_link_training (uhbr-sst)
[325.493979] Starting subtest: uhbr-sst
[325.502096] Subtest uhbr-sst: SKIP (0.000s)
[325.590196] [055/134] (696s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[325.650527] Starting subtest: etime-multi-wait-all-submitted-signaled
[325.751542] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.102s)
[325.855558] [056/134] (696s left) kms_invalid_mode (overflow-vrefresh)
[325.948428] Starting subtest: overflow-vrefresh
[325.950284] Starting dynamic subtest: pipe-A-eDP-1
[326.234709] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[326.245302] Starting dynamic subtest: pipe-B-eDP-1
[326.247178] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[326.255638] Starting dynamic subtest: pipe-C-eDP-1
[326.258040] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[326.266544] Starting dynamic subtest: pipe-D-eDP-1
[326.268941] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[326.271295] Subtest overflow-vrefresh: SUCCESS (0.292s)
[327.051749] [057/134] (695s left) kms_pm_rpm (i2c)
[329.086093] Starting subtest: i2c
[334.101633] Subtest i2c: SUCCESS (5.018s)
[334.199374] [058/134] (688s left) gem_exec_balancer (busy)
[334.267495] Starting subtest: busy
[335.938658] Subtest busy: SUCCESS (1.669s)
[336.291109] [059/134] (686s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[341.383670] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[341.388277] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.003s)
[342.243866] [060/134] (680s left) gen9_exec_parse (batch-without-end)
[342.318640] Subtest batch-without-end: SKIP (0.000s)
[342.395740] [061/134] (680s left) gem_ctx_shared (exec-shared-gtt)
[342.455268] Starting subtest: exec-shared-gtt
[342.457440] Starting dynamic subtest: rcs0
[342.459610] Dynamic subtest rcs0: SUCCESS (0.007s)
[342.470423] Starting dynamic subtest: bcs0
[342.472289] Dynamic subtest bcs0: SUCCESS (0.005s)
[342.481438] Starting dynamic subtest: vcs0
[342.483549] Dynamic subtest vcs0: SUCCESS (0.007s)
[342.492167] Starting dynamic subtest: vcs1
[342.493961] Dynamic subtest vcs1: SUCCESS (0.006s)
[342.502177] Starting dynamic subtest: vecs0
[342.504057] Dynamic subtest vecs0: SUCCESS (0.006s)
[342.512237] Starting dynamic subtest: ccs0
[342.514072] Dynamic subtest ccs0: SUCCESS (0.005s)
[342.515861] Subtest exec-shared-gtt: SUCCESS (0.039s)
[342.710100] [062/134] (680s left) perf (invalid-oa-metric-set-id)
[342.846289] Starting subtest: invalid-oa-metric-set-id
[342.858163] Subtest invalid-oa-metric-set-id: SUCCESS (0.012s)
[342.897595] [063/134] (679s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[342.958394] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[342.960270] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[343.082339] [064/134] (679s left) gem_tiled_pread_pwrite
[343.189947] [065/134] (679s left) i915_pm_rps (thresholds-park)
[343.241791] Starting subtest: thresholds-park
[343.245891] Subtest thresholds-park: SKIP (0.001s)
[343.358741] [066/134] (679s left) gem_ctx_engines (invalid-engines)
[343.423236] Starting subtest: invalid-engines
[343.431253] Subtest invalid-engines: SUCCESS (0.008s)
[343.685783] [067/134] (679s left) vgem_basic (create)
[343.724489] Starting subtest: create
[343.726647] Subtest create: SUCCESS (0.000s)
[343.804611] [068/134] (679s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[343.902227] Starting subtest: fbc-psr2-sprite-mmap-cpu
[343.904144] Starting dynamic subtest: eDP-1
[343.908257] Dynamic subtest eDP-1: SKIP (0.000s)
[343.912352] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[344.000461] [069/134] (679s left) gem_mmap_gtt (big-copy-odd)
[344.073203] Subtest big-copy-odd: SKIP (0.000s)
[344.146463] [070/134] (678s left) gem_exec_reloc (basic-gtt-cpu-active)
[344.203806] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[344.277500] [071/134] (678s left) prime_busy (before-wait)
[344.339478] Starting subtest: before-wait
[344.344256] Starting dynamic subtest: rcs0
[344.387125] Dynamic subtest rcs0: SUCCESS (0.044s)
[344.398643] Starting dynamic subtest: bcs0
[344.427212] Dynamic subtest bcs0: SUCCESS (0.039s)
[344.436227] Starting dynamic subtest: vcs0
[344.467117] Dynamic subtest vcs0: SUCCESS (0.039s)
[344.476142] Starting dynamic subtest: vcs1
[344.507209] Dynamic subtest vcs1: SUCCESS (0.039s)
[344.516263] Starting dynamic subtest: vecs0
[344.547922] Dynamic subtest vecs0: SUCCESS (0.040s)
[344.556710] Starting dynamic subtest: ccs0
[344.587888] Dynamic subtest ccs0: SUCCESS (0.039s)
[344.697392] Subtest before-wait: SUCCESS (0.356s)
[344.800398] [072/134] (678s left) gem_exec_fence (keep-in-fence)
[344.986447] Starting subtest: keep-in-fence
[344.988399] Starting dynamic subtest: rcs0
[345.038180] Dynamic subtest rcs0: SUCCESS (0.054s)
[345.049838] Starting dynamic subtest: bcs0
[345.093260] Dynamic subtest bcs0: SUCCESS (0.052s)
[345.105331] Starting dynamic subtest: vcs0
[346.902078] Dynamic subtest vcs0: SUCCESS (1.805s)
[346.914063] Starting dynamic subtest: vcs1
[348.885301] Dynamic subtest vcs1: SUCCESS (1.981s)
[348.897268] Starting dynamic subtest: vecs0
[350.993175] Dynamic subtest vecs0: SUCCESS (2.045s)
[351.004314] Starting dynamic subtest: ccs0
[351.166657] Dynamic subtest ccs0: SUCCESS (0.232s)
[351.169357] Subtest keep-in-fence: SUCCESS (6.184s)
[353.045880] [073/134] (670s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[353.145578] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[356.859763] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.717s)
[358.055608] [074/134] (665s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[358.159239] Starting subtest: 4-tiled-8bpp-rotate-270
[358.183028] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.021s)
[358.328215] [075/134] (665s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[363.408125] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[363.410403] Starting dynamic subtest: pipe-A-eDP-1
[364.207555] Dynamic subtest pipe-A-eDP-1: SKIP (0.794s)
[364.217640] Starting dynamic subtest: pipe-B-eDP-1
[365.338322] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s)
[365.342547] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.928s)
[366.553319] [076/134] (656s left) gem_ccs (block-multicopy-inplace)
[366.619464] Starting subtest: block-multicopy-inplace
[366.624235] Subtest block-multicopy-inplace: SKIP (0.000s)
[366.749179] [077/134] (656s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[366.851599] Starting subtest: x-tiled-addfb-size-offset-overflow
[366.853935] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[366.982781] [078/134] (656s left) kms_atomic (crtc-invalid-params)
[367.086537] Starting subtest: crtc-invalid-params
[367.088814] Starting dynamic subtest: pipe-A-eDP-1
[367.443577] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.357s)
[367.445487] Subtest crtc-invalid-params: SUCCESS (0.358s)
[368.279039] [079/134] (655s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[368.378230] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[368.380096] Starting dynamic subtest: pipe-A-eDP-1
[368.405686] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.027s)
[368.417113] Starting dynamic subtest: pipe-B-eDP-1
[368.436863] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[368.446059] Starting dynamic subtest: pipe-C-eDP-1
[368.466143] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[368.475520] Starting dynamic subtest: pipe-D-eDP-1
[368.496038] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.025s)
[368.498517] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.101s)
[370.751896] [080/134] (652s left) gem_lmem_swapping (heavy-verify-multi)
[370.789902] Subtest heavy-verify-multi: SKIP (0.000s)
[370.836019] [081/134] (652s left) kms_chamelium_frames (hdmi-crc-fast)
[371.227248] Subtest hdmi-crc-fast: SKIP (0.000s)
[372.031539] [082/134] (651s left) kms_vblank (query-forked-busy-hang)
[372.141170] Starting subtest: query-forked-busy-hang
[372.143061] Starting dynamic subtest: pipe-A-eDP-1
[398.741802] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.599s)
[398.756845] Starting dynamic subtest: pipe-D-eDP-1
[424.667978] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.924s)
[424.670387] Subtest query-forked-busy-hang: SUCCESS (52.528s)
[425.524520] [083/134] (598s left) kms_big_fb (linear-16bpp-rotate-90)
[425.623096] Starting subtest: linear-16bpp-rotate-90
[425.643696] Subtest linear-16bpp-rotate-90: SKIP (0.020s)
[425.811404] [084/134] (597s left) gem_flink_race (flink_close)
[425.849189] Starting subtest: flink_close
[430.968685] Subtest flink_close: SUCCESS (5.112s)
[431.071173] [085/134] (592s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[431.198572] Starting subtest: fbcpsr-modesetfrombusy
[437.490759] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.296s)
[437.653532] [086/134] (586s left) gem_exec_schedule (thriceslice)
[437.732337] Starting subtest: thriceslice
[437.734073] Starting dynamic subtest: rcs0
[437.753964] Dynamic subtest rcs0: SUCCESS (0.029s)
[437.765220] Starting dynamic subtest: bcs0
[437.782569] Dynamic subtest bcs0: SUCCESS (0.028s)
[437.791506] Starting dynamic subtest: vcs0
[437.834663] Dynamic subtest vcs0: SUCCESS (0.051s)
[437.845598] Starting dynamic subtest: vcs1
[437.864710] Dynamic subtest vcs1: SUCCESS (0.028s)
[437.873534] Starting dynamic subtest: vecs0
[437.893059] Dynamic subtest vecs0: SUCCESS (0.027s)
[437.901827] Starting dynamic subtest: ccs0
[437.921697] Dynamic subtest ccs0: SUCCESS (0.028s)
[437.923557] Subtest thriceslice: SUCCESS (0.198s)
[438.246379] [087/134] (585s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[438.347462] Starting subtest: flip-vs-dpms-off-vs-modeset
[438.349409] Starting dynamic subtest: A-eDP1
[441.989087] Dynamic subtest A-eDP1: SUCCESS (3.641s)
[441.999370] Starting dynamic subtest: B-eDP1
[445.179603] Dynamic subtest B-eDP1: SUCCESS (3.189s)
[445.194029] Starting dynamic subtest: C-eDP1
[448.372834] Dynamic subtest C-eDP1: SUCCESS (3.192s)
[448.382980] Starting dynamic subtest: D-eDP1
[451.484067] Dynamic subtest D-eDP1: SUCCESS (3.111s)
[451.486414] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.141s)
[452.299804] [088/134] (571s left) i915_pm_rps (min-max-config-idle)
[452.369112] Starting subtest: min-max-config-idle
[452.373304] Subtest min-max-config-idle: SKIP (0.000s)
[452.496973] [089/134] (571s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[452.599204] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[459.180558] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.585s)
[459.353260] [090/134] (564s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[464.373838] Starting subtest: psr2-overlay-plane-move-continuous-sf
[464.376192] Starting dynamic subtest: pipe-A-eDP-1
[471.071256] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.696s)
[471.081261] Starting dynamic subtest: pipe-B-eDP-1
[477.714429] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.642s)
[477.716835] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.343s)
[478.608849] [091/134] (545s left) kms_concurrent (multi-plane-atomic-lowres)
[478.725190] Starting subtest: multi-plane-atomic-lowres
[478.727383] Starting dynamic subtest: pipe-A-eDP-1
[479.228749] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.502s)
[479.231102] Subtest multi-plane-atomic-lowres: SUCCESS (0.503s)
[480.043860] [092/134] (544s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[480.149065] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[480.153208] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[480.295315] [093/134] (543s left) api_intel_allocator (reopen)
[480.352715] Starting subtest: reopen
[480.355131] Subtest reopen: SUCCESS (0.003s)
[480.512990] [094/134] (543s left) kms_flip (dpms-vs-vblank-race)
[480.612263] Starting subtest: dpms-vs-vblank-race
[480.614649] Starting dynamic subtest: A-eDP1
[485.630661] Dynamic subtest A-eDP1: SUCCESS (5.015s)
[485.640826] Starting dynamic subtest: B-eDP1
[489.234981] Dynamic subtest B-eDP1: SUCCESS (3.604s)
[489.244892] Starting dynamic subtest: C-eDP1
[493.866860] Dynamic subtest C-eDP1: SUCCESS (4.628s)
[493.877218] Starting dynamic subtest: D-eDP1
[498.481185] Dynamic subtest D-eDP1: SUCCESS (4.615s)
[498.483860] Subtest dpms-vs-vblank-race: SUCCESS (17.871s)
[499.382764] [095/134] (524s left) syncobj_timeline (single-wait-all-available-signaled)
[499.450653] Starting subtest: single-wait-all-available-signaled
[499.452867] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[499.590452] [096/134] (524s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[499.688977] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[499.691131] Starting dynamic subtest: pipe-A-eDP-1
[501.005089] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.315s)
[501.299836] Starting dynamic subtest: pipe-B-eDP-1
[502.332852] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.041s)
[502.616692] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.926s)
[503.475963] [097/134] (520s left) gem_exec_params (rs-invalid)
[503.552223] Starting subtest: rs-invalid
[503.554520] Subtest rs-invalid: SUCCESS (0.003s)
[503.711058] [098/134] (520s left) kms_scaling_modes (scaling-mode-full-aspect)
[503.806462] Starting subtest: scaling-mode-full-aspect
[503.808807] Starting dynamic subtest: pipe-A-eDP-1
[503.898477] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[503.908872] Starting dynamic subtest: pipe-B-eDP-1
[505.084818] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.185s)
[505.097235] Starting dynamic subtest: pipe-C-eDP-1
[506.294851] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.207s)
[506.307127] Starting dynamic subtest: pipe-D-eDP-1
[507.425072] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[507.427307] Subtest scaling-mode-full-aspect: SUCCESS (3.622s)
[508.604605] [099/134] (515s left) kms_plane (plane-panning-top-left)
[508.701131] Starting subtest: plane-panning-top-left
[508.703512] Starting dynamic subtest: pipe-A
[510.337077] Dynamic subtest pipe-A: SUCCESS (1.636s)
[510.347130] Starting dynamic subtest: pipe-B
[512.742172] Dynamic subtest pipe-B: SUCCESS (2.403s)
[512.744566] Subtest plane-panning-top-left: SUCCESS (4.043s)
[513.633404] [100/134] (510s left) kms_psr (psr2-sprite-mmap-cpu)
[513.743333] Starting subtest: psr2-sprite-mmap-cpu
[513.745665] Starting dynamic subtest: eDP-1
[515.495136] Dynamic subtest eDP-1: SUCCESS (1.753s)
[515.497459] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.754s)
[516.386457] [101/134] (508s left) gem_exec_params (rel-constants-invalid-ring)
[516.446627] Starting subtest: rel-constants-invalid-ring
[516.449048] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[516.576567] [102/134] (507s left) i915_query (query-garbage)
[516.633716] Starting subtest: query-garbage
[516.635710] Subtest query-garbage: SUCCESS (0.000s)
[516.764769] [103/134] (507s left) kms_psr (psr-cursor-mmap-cpu)
[516.862029] Starting subtest: psr-cursor-mmap-cpu
[516.864360] Starting dynamic subtest: eDP-1
[518.546702] Dynamic subtest eDP-1: SUCCESS (1.685s)
[518.549102] Subtest psr-cursor-mmap-cpu: SUCCESS (1.686s)
[519.458931] [104/134] (505s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[519.568056] Starting subtest: y-tiled-16bpp-rotate-90
[519.572355] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[519.681231] [105/134] (504s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[519.786127] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[519.790770] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[520.974239] [106/134] (503s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[521.111524] Starting subtest: flip-vs-cursor-legacy
[528.228367] Subtest flip-vs-cursor-legacy: SUCCESS (7.116s)
[529.101875] [107/134] (495s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-blt)
[529.200595] Starting subtest: fbcpsr-argb161616f-draw-blt
[529.205066] Subtest fbcpsr-argb161616f-draw-blt: SKIP (0.000s)
[529.325135] [108/134] (495s left) kms_flip (flip-vs-fences)
[529.429573] Starting subtest: flip-vs-fences
[529.433859] Subtest flip-vs-fences: SKIP (0.000s)
[529.575885] [109/134] (495s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[529.645079] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[529.726250] [110/134] (495s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[529.813144] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[529.815497] Starting dynamic subtest: pipe-A-eDP-1
[530.716625] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.896s)
[530.726932] Starting dynamic subtest: pipe-B-eDP-1
[532.368224] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.648s)
[532.383831] Starting dynamic subtest: pipe-C-eDP-1
[533.911307] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.544s)
[533.921155] Starting dynamic subtest: pipe-D-eDP-1
[535.491229] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.578s)
[535.493331] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.672s)
[536.732030] [111/134] (488s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[536.837757] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[536.841883] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[536.969028] [112/134] (487s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[537.073152] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[537.075235] Starting dynamic subtest: pipe-A-eDP-1
[537.821344] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.741s)
[537.835748] Starting dynamic subtest: pipe-B-eDP-1
[539.635189] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.812s)
[539.646131] Starting dynamic subtest: pipe-C-eDP-1
[541.462036] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.825s)
[541.473192] Starting dynamic subtest: pipe-D-eDP-1
[543.301214] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.838s)
[543.303400] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.221s)
[544.467535] [113/134] (480s left) i915_drm_fdinfo (memory-info-shared)
[544.508260] Starting subtest: memory-info-shared
[544.510684] Starting dynamic subtest: smem0
[544.577059] Dynamic subtest smem0: SUCCESS (0.071s)
[544.579559] Subtest memory-info-shared: SUCCESS (0.072s)
[544.672498] [114/134] (480s left) gem_exec_flush (basic-wb-set-default)
[544.746547] Starting subtest: basic-wb-set-default
[550.232679] Subtest basic-wb-set-default: SUCCESS (5.460s)
[550.414244] [115/134] (474s left) sysfs_timeslice_duration (timeout)
[550.470958] Starting subtest: timeout
[550.473833] Starting dynamic subtest: vecs0
[559.910437] Dynamic subtest vecs0: SUCCESS (9.435s)
[559.923343] Starting dynamic subtest: ccs0
[561.306115] Dynamic subtest ccs0: SUCCESS (1.394s)
[561.319041] Starting dynamic subtest: vcs0
[570.920254] Dynamic subtest vcs0: SUCCESS (9.609s)
[570.931291] Starting dynamic subtest: bcs0
[571.613904] Dynamic subtest bcs0: SUCCESS (0.693s)
[571.625913] Starting dynamic subtest: rcs0
[572.963083] Dynamic subtest rcs0: SUCCESS (1.347s)
[572.974546] Starting dynamic subtest: vcs1
[582.948950] Dynamic subtest vcs1: SUCCESS (9.981s)
[582.951450] Subtest timeout: SUCCESS (32.473s)
[583.046820] [116/134] (442s left) sriov_basic (enable-vfs-bind-unbind-each)
[583.102999] Starting subtest: enable-vfs-bind-unbind-each
[583.105345] Starting dynamic subtest: numvfs-1
[583.185800] Dynamic subtest numvfs-1: FAIL (0.027s)
[583.195531] Starting dynamic subtest: numvfs-2
[583.266799] Dynamic subtest numvfs-2: FAIL (0.004s)
[583.276682] Starting dynamic subtest: numvfs-3
[583.347246] Dynamic subtest numvfs-3: FAIL (0.004s)
[583.357393] Starting dynamic subtest: numvfs-4
[583.428650] Dynamic subtest numvfs-4: FAIL (0.004s)
[583.439994] Starting dynamic subtest: numvfs-5
[583.512789] Dynamic subtest numvfs-5: FAIL (0.004s)
[583.521991] Starting dynamic subtest: numvfs-6
[583.592959] Dynamic subtest numvfs-6: FAIL (0.004s)
[583.602209] Starting dynamic subtest: numvfs-7
[583.675983] Dynamic subtest numvfs-7: FAIL (0.004s)
[583.687109] Starting dynamic subtest: numvfs-random
[583.760839] Dynamic subtest numvfs-random: FAIL (0.003s)
[583.762975] Subtest enable-vfs-bind-unbind-each: FAIL (0.059s)
[583.805124] [117/134] (441s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[583.904044] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[583.908674] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[585.096368] [118/134] (440s left) kms_getfb (getfb-handle-not-fb)
[585.188365] Starting subtest: getfb-handle-not-fb
[585.190285] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[585.336152] [119/134] (439s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[585.402849] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[585.407316] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[585.609546] [120/134] (439s left) gem_workarounds (reset-context)
[585.676719] Starting subtest: reset-context
[585.842705] Subtest reset-context: SUCCESS (0.165s)
[585.995801] [121/134] (439s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[586.082450] Starting subtest: psr-farfromfence-mmap-gtt
[586.086480] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[586.224631] [122/134] (439s left) gem_wait (write-busy)
[586.297119] Starting subtest: write-busy
[586.299522] Starting dynamic subtest: all-engines
[586.890612] Dynamic subtest all-engines: SUCCESS (0.593s)
[586.902200] Starting dynamic subtest: rcs0
[587.448325] Dynamic subtest rcs0: SUCCESS (0.556s)
[587.462906] Starting dynamic subtest: bcs0
[587.999694] Dynamic subtest bcs0: SUCCESS (0.549s)
[588.016232] Starting dynamic subtest: vcs0
[589.908257] Dynamic subtest vcs0: SUCCESS (1.905s)
[589.925412] Starting dynamic subtest: vcs1
[591.893094] Dynamic subtest vcs1: SUCCESS (1.981s)
[591.908871] Starting dynamic subtest: vecs0
[593.876629] Dynamic subtest vecs0: SUCCESS (1.980s)
[593.893901] Starting dynamic subtest: ccs0
[594.429902] Dynamic subtest ccs0: SUCCESS (0.552s)
[594.432342] Subtest write-busy: SUCCESS (8.134s)
[594.653110] [123/134] (430s left) i915_hangman (detector)
[594.732429] Starting subtest: detector
[594.734389] Starting dynamic subtest: rcs0
[605.876059] Dynamic subtest rcs0: SUCCESS (11.142s)
[605.891427] Starting dynamic subtest: bcs0
[617.844238] Dynamic subtest bcs0: SUCCESS (11.964s)
[617.856368] Starting dynamic subtest: vcs0
[629.811035] Dynamic subtest vcs0: SUCCESS (11.963s)
[629.825719] Starting dynamic subtest: vcs1
[641.843088] Dynamic subtest vcs1: SUCCESS (12.028s)
[641.855579] Starting dynamic subtest: vecs0
[653.811286] Dynamic subtest vecs0: SUCCESS (11.964s)
[653.825697] Starting dynamic subtest: ccs0
[664.883308] Dynamic subtest ccs0: SUCCESS (11.068s)
[664.885865] Subtest detector: SUCCESS (70.147s)
[664.999870] [124/134] (360s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[665.106096] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[665.110105] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[665.234111] [125/134] (360s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[665.350629] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[665.355141] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[665.527391] [126/134] (359s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[665.589222] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[665.660848] [127/134] (359s left) gem_exec_schedule (noreorder-corked)
[665.839737] Starting subtest: noreorder-corked
[665.841976] Starting dynamic subtest: rcs0
[667.006867] Dynamic subtest rcs0: SUCCESS (1.169s)
[667.018675] Starting dynamic subtest: vcs0
[668.907528] Dynamic subtest vcs0: SUCCESS (1.896s)
[668.920031] Starting dynamic subtest: vcs1
[670.947068] Dynamic subtest vcs1: SUCCESS (2.037s)
[670.958083] Starting dynamic subtest: vecs0
[672.927911] Dynamic subtest vecs0: SUCCESS (1.978s)
[672.945986] Starting dynamic subtest: ccs0
[674.110913] Dynamic subtest ccs0: SUCCESS (1.181s)
[674.113705] Subtest noreorder-corked: SUCCESS (8.275s)
[674.320225] [128/134] (351s left) kms_psr (pr-cursor-mmap-cpu)
[674.442055] Starting subtest: pr-cursor-mmap-cpu
[674.446498] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[674.537526] [129/134] (351s left) perf (invalid-oa-format-id)
[674.636570] Starting subtest: invalid-oa-format-id
[674.646157] Subtest invalid-oa-format-id: SUCCESS (0.007s)
[674.689458] [130/134] (350s left) gem_eio (in-flight-internal-immediate)
[674.883181] Starting subtest: in-flight-internal-immediate
[675.921706] Subtest in-flight-internal-immediate: SUCCESS (1.038s)
[676.097421] [131/134] (349s left) kms_cursor_edge_walk (256x256-top-edge)
[676.180860] Starting subtest: 256x256-top-edge
[676.183164] Starting dynamic subtest: pipe-A-eDP-1
[679.628642] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.446s)
[679.638532] Starting dynamic subtest: pipe-D-eDP-1
[682.746464] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[682.748795] Subtest 256x256-top-edge: SUCCESS (6.566s)
[683.584391] [132/134] (342s left) gem_ctx_persistence (engines-persistence)
[683.651715] Starting subtest: engines-persistence
[683.654507] Starting dynamic subtest: rcs0
[684.457054] Dynamic subtest rcs0: SUCCESS (0.805s)
[684.469830] Starting dynamic subtest: bcs0
[685.290029] Dynamic subtest bcs0: SUCCESS (0.830s)
[685.302818] Starting dynamic subtest: vcs0
[686.133497] Dynamic subtest vcs0: SUCCESS (0.842s)
[686.144785] Starting dynamic subtest: vcs1
[686.962296] Dynamic subtest vcs1: SUCCESS (0.826s)
[686.976302] Starting dynamic subtest: vecs0
[687.782298] Dynamic subtest vecs0: SUCCESS (0.817s)
[687.797280] Starting dynamic subtest: ccs0
[688.638374] Dynamic subtest ccs0: SUCCESS (0.853s)
[688.641291] Subtest engines-persistence: SUCCESS (4.988s)
[688.744208] [133/134] (337s left) api_intel_bb (render-ccs)
[688.807050] Starting subtest: render-ccs
[689.170361] Subtest render-ccs: SUCCESS (0.362s)
[689.324729] [134/134] (336s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[689.431795] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[689.436380] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[689.557595] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_scaling
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_fence_pin_leak
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: gem_mmap_wc
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: perf_pmu
results: parsing output: 9/ for test: gem_mmap_wc
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_busy
results: parsing output: 12/ for test: kms_plane_alpha_blend
results: parsing output: 13/ for test: sysfs_timeslice_duration
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: kms_color
results: parsing output: 17/ for test: gem_partial_pwrite_pread
results: parsing output: 18/ for test: dumb_buffer
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: gem_lmem_swapping
results: parsing output: 22/ for test: gem_spin_batch
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_properties
results: parsing output: 25/ for test: kms_vrr
results: parsing output: 26/ for test: gem_exec_params
results: parsing output: 27/ for test: gem_exec_balancer
results: parsing output: 28/ for test: kms_pm_dc
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_whisper
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_render_copy_redux
results: parsing output: 36/ for test: gem_mmap_wc
results: parsing output: 37/ for test: gem_pxp
results: parsing output: 38/ for test: kms_3d
results: parsing output: 39/ for test: gem_ctx_persistence
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: vgem_basic
results: parsing output: 46/ for test: gem_userptr_blits
results: parsing output: 47/ for test: kms_chamelium_hpd
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_lease
results: parsing output: 52/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 53/ for test: kms_dp_link_training
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_invalid_mode
results: parsing output: 56/ for test: kms_pm_rpm
results: parsing output: 57/ for test: gem_exec_balancer
results: parsing output: 58/ for test: kms_psr2_sf
results: parsing output: 59/ for test: gen9_exec_parse
results: parsing output: 60/ for test: gem_ctx_shared
results: parsing output: 61/ for test: perf
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: gem_tiled_pread_pwrite
results: parsing output: 64/ for test: i915_pm_rps
results: parsing output: 65/ for test: gem_ctx_engines
results: parsing output: 66/ for test: vgem_basic
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: prime_busy
results: parsing output: 71/ for test: gem_exec_fence
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: gem_ccs
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_atomic
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: gem_lmem_swapping
results: parsing output: 80/ for test: kms_chamelium_frames
results: parsing output: 81/ for test: kms_vblank
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: gem_flink_race
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: i915_pm_rps
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_concurrent
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: api_intel_allocator
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_atomic_transition
results: parsing output: 96/ for test: gem_exec_params
results: parsing output: 97/ for test: kms_scaling_modes
results: parsing output: 98/ for test: kms_plane
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: gem_exec_params
results: parsing output: 101/ for test: i915_query
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: gem_exec_reloc
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: i915_drm_fdinfo
results: parsing output: 113/ for test: gem_exec_flush
results: parsing output: 114/ for test: sysfs_timeslice_duration
results: parsing output: 115/ for test: sriov_basic
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: kms_getfb
results: parsing output: 118/ for test: gem_render_copy
results: parsing output: 119/ for test: gem_workarounds
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_wait
results: parsing output: 122/ for test: i915_hangman
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: perf
results: parsing output: 129/ for test: gem_eio
results: parsing output: 130/ for test: kms_cursor_edge_walk
results: parsing output: 131/ for test: gem_ctx_persistence
results: parsing output: 132/ for test: api_intel_bb
results: parsing output: 133/ for test: kms_frontbuffer_tracking
Done.