[59.362244] Initializing watchdogs
[59.362290]   /dev/watchdog0
[59.377581] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[59.381526] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.383615] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.387672] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[59.494617] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[59.499117] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[59.603044] [002/133] (960s left) gem_ctx_bad_destroy (invalid-ctx)
[59.660563] Starting subtest: invalid-ctx
[59.662953] Subtest invalid-ctx: SUCCESS (0.000s)
[59.739664] [003/133] (960s left) gem_caching (writes)
[59.795042] Subtest writes: SKIP (0.000s)
[59.860302] [004/133] (960s left) kms_plane_alpha_blend (alpha-basic)
[59.925244] Starting subtest: alpha-basic
[60.224694] Starting dynamic subtest: pipe-A-eDP-1
[62.197154] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.983s)
[62.227284] Starting dynamic subtest: pipe-D-eDP-1
[64.890458] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.680s)
[64.892760] Subtest alpha-basic: SUCCESS (4.990s)
[65.693741] [005/133] (954s left) gem_userptr_blits (set-cache-level)
[65.750948] Starting subtest: set-cache-level
[65.755273] Subtest set-cache-level: SKIP (0.000s)
[65.878432] [006/133] (954s left) drm_read (empty-nonblock)
[66.020671] Starting subtest: empty-nonblock
[66.023117] Subtest empty-nonblock: SUCCESS (0.000s)
[66.132176] [007/133] (953s left) i915_query (query-regions-sanity-check)
[66.186583] Starting subtest: query-regions-sanity-check
[66.195153] Subtest query-regions-sanity-check: SUCCESS (0.009s)
[66.298976] [008/133] (953s left) gem_exec_balancer (bonded-sync)
[66.354956] Starting subtest: bonded-sync
[66.359161] Subtest bonded-sync: SKIP (0.000s)
[66.631867] [009/133] (953s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[66.704075] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[66.706206] Starting dynamic subtest: pipe-A-eDP-1
[67.909676] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.210s)
[67.917070] Starting dynamic subtest: pipe-B-eDP-1
[70.186236] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.280s)
[70.195948] Starting dynamic subtest: pipe-C-eDP-1
[72.516414] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.332s)
[72.524207] Starting dynamic subtest: pipe-D-eDP-1
[74.854155] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.339s)
[74.856492] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.165s)
[75.995132] [010/133] (944s left) syncobj_timeline (invalid-query-illegal-handle)
[76.062775] Starting subtest: invalid-query-illegal-handle
[76.065041] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[76.163466] [011/133] (944s left) kms_feature_discovery (display-4x)
[76.245381] Starting subtest: display-4x
[76.249809] Subtest display-4x: SKIP (0.000s)
[76.315671] [012/133] (943s left) kms_prop_blob (invalid-set-prop-any)
[76.361981] Starting subtest: invalid-set-prop-any
[76.364396] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[76.480172] [013/133] (943s left) gem_mmap_gtt (basic)
[76.535755] Subtest basic: SKIP (0.000s)
[76.594828] [014/133] (943s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[76.675773] Starting subtest: blocking-absolute-wf_vblank-interruptible
[76.678072] Starting dynamic subtest: A-eDP1
[85.360273] Dynamic subtest A-eDP1: SUCCESS (8.686s)
[85.368773] Starting dynamic subtest: B-eDP1
[94.087573] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[94.097342] Starting dynamic subtest: C-eDP1
[102.810685] Dynamic subtest C-eDP1: SUCCESS (8.722s)
[102.820440] Starting dynamic subtest: D-eDP1
[111.538317] Dynamic subtest D-eDP1: SUCCESS (8.728s)
[111.543249] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.871s)
[112.739596] [015/133] (907s left) gem_userptr_blits (create-destroy-sync)
[112.805799] Starting subtest: create-destroy-sync
[117.815048] Subtest create-destroy-sync: SUCCESS (5.012s)
[117.927590] [016/133] (902s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[118.005531] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[124.974673] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.971s)
[125.119045] [017/133] (895s left) perf_pmu (rc6)
[125.161939] Starting subtest: rc6
[125.163896] Starting dynamic subtest: gt0
[131.521113] Dynamic subtest gt0: SUCCESS (6.359s)
[131.532758] Starting dynamic subtest: runtime-pm-gt0
[139.283361] Dynamic subtest runtime-pm-gt0: SUCCESS (7.761s)
[139.294709] Starting dynamic subtest: runtime-pm-long-gt0
[151.784453] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.499s)
[151.798802] Starting dynamic subtest: other-idle-gt0
[158.127594] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[158.138683] Starting dynamic subtest: gt1
[164.467600] Dynamic subtest gt1: SUCCESS (6.338s)
[164.478292] Starting dynamic subtest: runtime-pm-gt1
[171.915584] Dynamic subtest runtime-pm-gt1: SUCCESS (7.446s)
[171.926091] Starting dynamic subtest: runtime-pm-long-gt1
[184.380543] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.462s)
[184.391817] Starting dynamic subtest: other-idle-gt1
[190.722574] Dynamic subtest other-idle-gt1: SUCCESS (6.340s)
[190.725570] Subtest rc6: SUCCESS (65.557s)
[191.852707] [018/133] (828s left) kms_frontbuffer_tracking (fbc-stridechange)
[191.929952] Starting subtest: fbc-stridechange
[195.182724] Subtest fbc-stridechange: SUCCESS (3.255s)
[196.291757] [019/133] (824s left) i915_drm_fdinfo (memory-info-shared)
[196.331587] Starting subtest: memory-info-shared
[196.334053] Starting dynamic subtest: smem0
[196.378442] Dynamic subtest smem0: SUCCESS (0.049s)
[196.381265] Subtest memory-info-shared: SUCCESS (0.049s)
[196.426484] [020/133] (824s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[196.528940] Starting subtest: cursorB-vs-flipB-atomic
[196.533337] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[196.647391] [021/133] (823s left) gem_eio (reset-stress)
[196.839171] Starting subtest: reset-stress
[196.841518] Starting dynamic subtest: render
[201.014152] Dynamic subtest render: SUCCESS (4.173s)
[201.029352] Starting dynamic subtest: bsd1
[218.680368] Dynamic subtest bsd1: SUCCESS (17.664s)
[218.695771] Starting dynamic subtest: bsd2
[236.689702] Dynamic subtest bsd2: SUCCESS (18.008s)
[236.705321] Starting dynamic subtest: blt
[236.709255] Dynamic subtest blt: SKIP (0.000s)
[236.717643] Starting dynamic subtest: vebox
[254.679386] Dynamic subtest vebox: SUCCESS (17.989s)
[254.681302] Subtest reset-stress: SUCCESS (57.837s)
[256.270101] [FACT gem_eio (reset-stress)] new: kernel.kmod_is_loaded.vgem: true
[256.273647] [022/133] (764s left) kms_plane (pixel-format-4-tiled-modifier)
[256.356514] Starting subtest: pixel-format-4-tiled-modifier
[256.381838] Starting dynamic subtest: pipe-A-plane-0
[257.059360] Dynamic subtest pipe-A-plane-0: SUCCESS (0.678s)
[257.068111] Starting dynamic subtest: pipe-A-plane-3
[257.470190] Dynamic subtest pipe-A-plane-3: SUCCESS (0.411s)
[257.479884] Starting dynamic subtest: pipe-A-plane-5
[257.483330] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[258.581970] Starting dynamic subtest: pipe-B-plane-0
[259.207280] Dynamic subtest pipe-B-plane-0: SUCCESS (0.633s)
[259.216785] Starting dynamic subtest: pipe-B-plane-3
[259.640132] Dynamic subtest pipe-B-plane-3: SUCCESS (0.432s)
[259.649148] Starting dynamic subtest: pipe-B-plane-5
[259.652485] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[259.953313] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.597s)
[260.728055] [023/133] (759s left) perf (gen12-mi-rpc)
[260.819291] Starting subtest: gen12-mi-rpc
[260.821404] Starting dynamic subtest: rcs0
[260.837645] Dynamic subtest rcs0: SUCCESS (0.018s)
[260.839542] Subtest gen12-mi-rpc: SUCCESS (0.019s)
[260.895072] [024/133] (759s left) perf_pmu (interrupts-sync)
[260.942893] Starting subtest: interrupts-sync
[262.002757] Subtest interrupts-sync: SUCCESS (1.061s)
[262.086475] [025/133] (758s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[262.156306] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[262.158681] Starting dynamic subtest: pipe-A-eDP-1
[262.167963] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[262.182383] Starting dynamic subtest: pipe-B-eDP-1
[262.191586] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[262.202656] Starting dynamic subtest: pipe-C-eDP-1
[262.211578] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[262.221048] Starting dynamic subtest: pipe-D-eDP-1
[262.229813] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[262.234093] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[264.381123] [026/133] (756s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[264.462180] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[265.297338] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.836s)
[265.447547] [027/133] (755s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[265.740626] Starting subtest: cursor-rapid-movement-max-size
[265.747136] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[265.839768] [028/133] (755s left) gem_softpin (overlap)
[265.907047] Starting subtest: overlap
[266.790078] Subtest overlap: SUCCESS (0.881s)
[266.883884] [029/133] (754s left) gem_exec_reloc (basic-gtt-wc)
[266.942316] Subtest basic-gtt-wc: SKIP (0.000s)
[267.010183] [030/133] (753s left) gem_mmap_wc (write-gtt-read-wc)
[267.071802] Subtest write-gtt-read-wc: SKIP (0.000s)
[267.135890] [031/133] (753s left) tools_test (sysfs_l3_parity)
[267.194370] Starting subtest: sysfs_l3_parity
[267.243755] Subtest sysfs_l3_parity: SKIP (0.065s)
[267.280632] [032/133] (753s left) kms_big_fb (linear-8bpp-rotate-0)
[267.360420] Starting subtest: linear-8bpp-rotate-0
[268.560924] Subtest linear-8bpp-rotate-0: SUCCESS (1.201s)
[268.649917] [033/133] (752s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[268.725717] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[268.730309] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[268.792233] [034/133] (752s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[268.862646] Starting subtest: psr-rgb565-draw-mmap-cpu
[275.606342] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.744s)
[275.709409] [035/133] (745s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[275.795549] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[275.799735] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[275.873752] [036/133] (745s left) i915_pm_freq_api (freq-reset-multiple)
[275.928711] Starting subtest: freq-reset-multiple
[275.931183] Starting dynamic subtest: gt0
[285.624032] Dynamic subtest gt0: SUCCESS (9.693s)
[285.633459] Starting dynamic subtest: gt1
[293.247214] Dynamic subtest gt1: SUCCESS (7.618s)
[293.249476] Subtest freq-reset-multiple: SUCCESS (17.313s)
[293.301327] [037/133] (727s left) syncobj_basic (bad-pad-handle-to-fd)
[293.356712] Starting subtest: bad-pad-handle-to-fd
[293.358590] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[293.432604] [038/133] (727s left) gem_exec_whisper (basic-fds-forked-all)
[293.505217] Starting subtest: basic-fds-forked-all
[316.478183] Subtest basic-fds-forked-all: SUCCESS (22.970s)
[316.643365] [039/133] (704s left) prime_vgem (sync)
[316.714594] Starting subtest: sync
[316.716948] Starting dynamic subtest: rcs0
[316.786695] Dynamic subtest rcs0: SUCCESS (0.072s)
[316.796760] Starting dynamic subtest: bcs0
[316.863654] Dynamic subtest bcs0: SUCCESS (0.076s)
[316.873448] Starting dynamic subtest: vcs0
[316.912714] Dynamic subtest vcs0: SUCCESS (0.048s)
[316.922852] Starting dynamic subtest: vcs1
[316.960152] Dynamic subtest vcs1: SUCCESS (0.046s)
[316.969334] Starting dynamic subtest: vecs0
[317.006381] Dynamic subtest vecs0: SUCCESS (0.045s)
[317.016121] Starting dynamic subtest: ccs0
[317.051489] Dynamic subtest ccs0: SUCCESS (0.045s)
[317.053769] Subtest sync: SUCCESS (0.337s)
[317.145657] [040/133] (704s left) sw_sync (alloc_fence)
[317.180319] Starting subtest: alloc_fence
[317.182708] Subtest alloc_fence: SUCCESS (0.000s)
[317.221813] [041/133] (704s left) gem_exec_schedule (preempt-queue)
[317.288741] Subtest preempt-queue: SKIP (0.000s)
[317.554575] [042/133] (703s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[317.637085] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[317.641634] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[317.707810] [043/133] (703s left) gem_ctx_param (invalid-get-engines)
[317.764197] Starting subtest: invalid-get-engines
[317.766467] Subtest invalid-get-engines: SUCCESS (0.001s)
[317.840395] [044/133] (703s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[317.928476] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[317.931052] Starting dynamic subtest: pipe-A
[317.956543] Dynamic subtest pipe-A: SKIP (0.025s)
[317.967160] Starting dynamic subtest: pipe-B
[317.987855] Dynamic subtest pipe-B: SKIP (0.030s)
[317.997463] Starting dynamic subtest: pipe-C
[318.019466] Dynamic subtest pipe-C: SKIP (0.029s)
[318.028958] Starting dynamic subtest: pipe-D
[318.048446] Dynamic subtest pipe-D: SKIP (0.029s)
[318.052813] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.116s)
[318.138635] [045/133] (703s left) kms_psr (fbc-pr-sprite-plane-onoff)
[318.216228] Starting subtest: fbc-pr-sprite-plane-onoff
[318.220203] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[318.263919] [046/133] (703s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[318.343018] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[318.347476] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[318.422879] [047/133] (703s left) gem_exec_parallel (fds)
[318.476290] Starting subtest: fds
[318.478767] Starting dynamic subtest: rcs0
[321.642744] Dynamic subtest rcs0: SUCCESS (3.164s)
[321.652800] Starting dynamic subtest: bcs0
[325.584557] Dynamic subtest bcs0: SUCCESS (3.940s)
[325.600370] Starting dynamic subtest: vcs0
[329.548503] Dynamic subtest vcs0: SUCCESS (3.962s)
[329.563676] Starting dynamic subtest: vcs1
[333.470831] Dynamic subtest vcs1: SUCCESS (3.919s)
[333.481672] Starting dynamic subtest: vecs0
[337.724465] Dynamic subtest vecs0: SUCCESS (4.252s)
[337.736932] Starting dynamic subtest: ccs0
[341.576565] Dynamic subtest ccs0: SUCCESS (3.850s)
[341.579187] Subtest fds: SUCCESS (23.099s)
[341.784729] [048/133] (679s left) kms_content_protection (legacy)
[341.920664] Starting subtest: legacy
[341.924914] Subtest legacy: SKIP (0.000s)
[342.013653] [049/133] (679s left) gem_userptr_blits (usage-restrictions)
[342.082797] Starting subtest: usage-restrictions
[342.084816] Subtest usage-restrictions: SUCCESS (0.000s)
[342.181307] [050/133] (679s left) kms_plane (pixel-format-y-tiled-modifier)
[342.247848] Starting subtest: pixel-format-y-tiled-modifier
[342.252245] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[342.296448] [051/133] (679s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[342.366969] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[342.371206] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[342.435871] [052/133] (679s left) gem_exec_fence (submit)
[342.606560] Starting subtest: submit
[342.611338] Subtest submit: SKIP (0.000s)
[344.314890] [053/133] (677s left) syncobj_timeline (device-signal-unordered)
[344.362849] Starting subtest: device-signal-unordered
[344.365130] Subtest device-signal-unordered: SUCCESS (0.001s)
[344.444714] [054/133] (677s left) kms_joiner (invalid-modeset-ultra-joiner)
[344.525226] Starting subtest: invalid-modeset-ultra-joiner
[344.529174] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[344.566140] [055/133] (677s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[344.647108] Starting subtest: psr-farfromfence-mmap-gtt
[344.651129] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[344.737901] [056/133] (677s left) kms_pm_backlight (fade)
[344.811775] Starting subtest: fade
[344.865414] Starting dynamic subtest: eDP-1
[347.839894] Dynamic subtest eDP-1: SUCCESS (2.976s)
[347.842251] Subtest fade: SUCCESS (3.028s)
[348.622929] [057/133] (673s left) kms_atomic_transition (plane-all-modeset-transition)
[348.690970] Starting subtest: plane-all-modeset-transition
[348.695292] Subtest plane-all-modeset-transition: SKIP (0.000s)
[348.738500] [058/133] (673s left) syncobj_basic (bad-handle-to-fd)
[348.786324] Starting subtest: bad-handle-to-fd
[348.788675] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[348.860112] [059/133] (673s left) gem_pxp (create-protected-buffer)
[348.978224] Starting subtest: create-protected-buffer
[348.980575] Subtest create-protected-buffer: SUCCESS (0.000s)
[349.061349] [060/133] (673s left) kms_cursor_legacy (torture-bo)
[349.183492] Starting subtest: torture-bo
[349.185711] Starting dynamic subtest: pipe-A
[355.521429] Dynamic subtest pipe-A: SUCCESS (6.336s)
[355.538116] Starting dynamic subtest: pipe-B
[361.383609] Dynamic subtest pipe-B: SUCCESS (5.857s)
[361.395663] Starting dynamic subtest: pipe-C
[368.289792] Dynamic subtest pipe-C: SUCCESS (6.905s)
[368.307917] Starting dynamic subtest: pipe-D
[375.857387] Dynamic subtest pipe-D: SUCCESS (7.565s)
[375.868962] Starting dynamic subtest: all-pipes
[382.461455] Dynamic subtest all-pipes: SUCCESS (6.602s)
[382.463908] Subtest torture-bo: SUCCESS (33.276s)
[382.596699] [061/133] (639s left) kms_prime (basic-crc-vgem)
[382.667968] Starting subtest: basic-crc-vgem
[382.670407] Starting dynamic subtest: second-to-first
[383.584202] Dynamic subtest second-to-first: SUCCESS (0.920s)
[383.586121] Subtest basic-crc-vgem: SUCCESS (0.921s)
[383.633008] [062/133] (638s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[384.030328] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[384.840897] [063/133] (637s left) syncobj_timeline (reset-signaled)
[384.910747] Starting subtest: reset-signaled
[384.913236] Subtest reset-signaled: SUCCESS (0.000s)
[384.983434] [064/133] (637s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[385.065422] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[385.069765] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[385.142320] [065/133] (637s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[385.216329] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[385.218515] Starting dynamic subtest: pipe-A-eDP-1
[391.132019] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.916s)
[391.145849] Starting dynamic subtest: pipe-B-eDP-1
[397.771869] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.638s)
[397.774115] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.557s)
[398.633793] [066/133] (623s left) kms_cursor_crc (cursor-onscreen-32x10)
[398.772734] Starting subtest: cursor-onscreen-32x10
[398.816479] Subtest cursor-onscreen-32x10: SKIP (0.039s)
[399.076397] [067/133] (623s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[399.152238] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[399.156245] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[399.226482] [068/133] (623s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[399.302120] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[399.306621] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[399.393038] [069/133] (623s left) gem_partial_pwrite_pread (reads-uncached)
[399.446346] Subtest reads-uncached: SKIP (0.000s)
[399.520247] [070/133] (623s left) kms_flip (2x-flip-vs-suspend-interruptible)
[399.597196] Starting subtest: 2x-flip-vs-suspend-interruptible
[399.600879] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.002s)
[399.653068] [071/133] (623s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[399.731178] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[407.093182] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.366s)
[407.207447] [072/133] (615s left) kms_psr (fbc-psr2-sprite-plane-move)
[407.285368] Starting subtest: fbc-psr2-sprite-plane-move
[407.287375] Starting dynamic subtest: eDP-1
[407.291587] Dynamic subtest eDP-1: SKIP (0.000s)
[407.295823] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[407.356270] [073/133] (615s left) perf (short-reads)
[407.424139] Starting subtest: short-reads
[407.437519] Subtest short-reads: SUCCESS (0.014s)
[407.487840] [074/133] (615s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[407.560319] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[407.564689] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[407.627243] [075/133] (615s left) kms_color_pipeline (plane-lut1d)
[407.695445] Starting subtest: plane-lut1d
[407.831083] Starting dynamic subtest: pipe-A-plane-0
[407.975196] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[407.985361] Starting dynamic subtest: pipe-A-plane-1
[408.107835] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[408.117379] Starting dynamic subtest: pipe-A-plane-2
[408.252320] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[409.465474] Starting dynamic subtest: pipe-B-plane-0
[409.615802] Dynamic subtest pipe-B-plane-0: SUCCESS (0.156s)
[409.625593] Starting dynamic subtest: pipe-B-plane-1
[409.757597] Dynamic subtest pipe-B-plane-1: SUCCESS (0.142s)
[409.767258] Starting dynamic subtest: pipe-B-plane-2
[409.891032] Dynamic subtest pipe-B-plane-2: SUCCESS (0.132s)
[411.087912] Starting dynamic subtest: pipe-C-plane-0
[411.219930] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[411.230193] Starting dynamic subtest: pipe-C-plane-1
[411.375096] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[411.385399] Starting dynamic subtest: pipe-C-plane-2
[411.520031] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[412.712610] Starting dynamic subtest: pipe-D-plane-0
[412.848909] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[412.859247] Starting dynamic subtest: pipe-D-plane-1
[412.993372] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[413.003725] Starting dynamic subtest: pipe-D-plane-2
[413.137913] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[413.442256] Subtest plane-lut1d: SUCCESS (5.745s)
[414.271719] [076/133] (608s left) gem_ctx_sseu (invalid-sseu)
[414.320754] Subtest invalid-sseu: SKIP (0.000s)
[414.396554] [077/133] (608s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[414.471033] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[414.473346] Starting dynamic subtest: pipe-A-eDP-1
[414.493036] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[414.503657] Starting dynamic subtest: pipe-B-eDP-1
[414.522236] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[414.531679] Starting dynamic subtest: pipe-C-eDP-1
[414.550605] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[414.561888] Starting dynamic subtest: pipe-D-eDP-1
[414.581276] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[414.583422] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[416.735642] [078/133] (606s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[416.806270] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[416.808328] Starting dynamic subtest: pipe-A-eDP-1
[416.829929] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[416.841120] Starting dynamic subtest: pipe-B-eDP-1
[416.861986] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[416.871719] Starting dynamic subtest: pipe-C-eDP-1
[416.892889] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[416.902330] Starting dynamic subtest: pipe-D-eDP-1
[416.924276] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[416.928269] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[419.087520] [079/133] (603s left) gem_ctx_persistence (heartbeat-stop)
[419.141484] Starting subtest: heartbeat-stop
[419.146279] Subtest heartbeat-stop: SKIP (0.000s)
[419.222883] [080/133] (603s left) kms_async_flips (async-flip-hang)
[419.310233] Starting subtest: async-flip-hang
[419.689068] Starting dynamic subtest: pipe-A-eDP-1
[434.715622] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.024s)
[435.094309] Starting dynamic subtest: pipe-B-eDP-1
[450.711520] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.622s)
[451.089327] Starting dynamic subtest: pipe-C-eDP-1
[466.712705] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.628s)
[467.096852] Starting dynamic subtest: pipe-D-eDP-1
[482.708423] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.615s)
[482.710392] Subtest async-flip-hang: SUCCESS (63.395s)
[483.917724] [081/133] (539s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[483.997873] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[484.001753] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[484.073243] [082/133] (539s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[484.148145] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[484.150403] Starting dynamic subtest: pipe-A-eDP-1
[485.486550] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.337s)
[485.767999] Starting dynamic subtest: pipe-B-eDP-1
[486.813450] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.054s)
[487.087832] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.941s)
[487.906552] [083/133] (535s left) gem_exec_gttfill (basic)
[487.968291] Starting subtest: basic
[490.664252] Subtest basic: SUCCESS (2.695s)
[490.834585] [084/133] (532s left) kms_flip (2x-flip-vs-expired-vblank)
[490.951625] Starting subtest: 2x-flip-vs-expired-vblank
[490.958694] Subtest 2x-flip-vs-expired-vblank: SKIP (0.007s)
[491.020200] [085/133] (532s left) api_intel_bb (intel-bb-blit-none)
[491.071165] Starting subtest: intel-bb-blit-none
[495.510025] Subtest intel-bb-blit-none: SUCCESS (4.439s)
[495.613280] [086/133] (527s left) kms_flip (flip-vs-panning-interruptible)
[495.698048] Starting subtest: flip-vs-panning-interruptible
[495.700355] Starting dynamic subtest: A-eDP1
[504.434226] Dynamic subtest A-eDP1: SUCCESS (8.735s)
[504.446391] Starting dynamic subtest: B-eDP1
[513.169675] Dynamic subtest B-eDP1: SUCCESS (8.732s)
[513.180633] Starting dynamic subtest: C-eDP1
[521.898847] Dynamic subtest C-eDP1: SUCCESS (8.727s)
[521.911040] Starting dynamic subtest: D-eDP1
[530.610854] Dynamic subtest D-eDP1: SUCCESS (8.709s)
[530.615518] Subtest flip-vs-panning-interruptible: SUCCESS (34.917s)
[531.754038] [087/133] (491s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[531.827056] Starting subtest: multiplane-rotation-cropping-top
[549.441666] Subtest multiplane-rotation-cropping-top: SUCCESS (17.615s)
[549.535045] [088/133] (473s left) kms_cursor_edge_walk (64x64-left-edge)
[549.607314] Starting subtest: 64x64-left-edge
[549.609224] Starting dynamic subtest: pipe-A-eDP-1
[553.027731] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.419s)
[553.037764] Starting dynamic subtest: pipe-D-eDP-1
[556.141608] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.111s)
[556.143522] Subtest 64x64-left-edge: SUCCESS (6.533s)
[556.936075] [089/133] (466s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[557.019771] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[557.024184] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[557.068230] [090/133] (466s left) syncobj_timeline (etime-single-wait-submitted)
[557.123834] Starting subtest: etime-single-wait-submitted
[557.224928] Subtest etime-single-wait-submitted: SUCCESS (0.100s)
[557.277976] [091/133] (466s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[557.345652] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[557.347902] Starting dynamic subtest: pipe-A-eDP-1
[557.370909] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[557.383674] Starting dynamic subtest: pipe-B-eDP-1
[557.405892] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[557.415575] Starting dynamic subtest: pipe-C-eDP-1
[557.438537] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[557.448482] Starting dynamic subtest: pipe-D-eDP-1
[557.470608] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[557.474717] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[559.594618] [092/133] (463s left) gem_pwrite_snooped
[559.737557] [093/133] (463s left) dmabuf_sync_file (import-multiple-read-write)
[559.778174] Starting subtest: import-multiple-read-write
[559.782606] Subtest import-multiple-read-write: SUCCESS (0.005s)
[559.820446] [094/133] (463s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[559.900312] Starting subtest: fbcpsr-modesetfrombusy
[566.064745] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.170s)
[566.158682] [095/133] (457s left) gem_softpin (safe-alignment)
[566.217266] Starting subtest: safe-alignment
[566.237706] Subtest safe-alignment: SUCCESS (0.020s)
[568.274941] [096/133] (455s left) gem_exec_suspend (basic)
[568.344601] Starting subtest: basic
[568.347026] Starting dynamic subtest: smem
[570.238480] Dynamic subtest smem: SUCCESS (1.891s)
[570.241304] Subtest basic: SUCCESS (1.894s)
[570.399565] [097/133] (453s left) syncobj_timeline (single-wait-all-available-signaled)
[570.449913] Starting subtest: single-wait-all-available-signaled
[570.452124] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[570.523266] [098/133] (453s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[570.609750] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[577.508845] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.901s)
[577.608786] [099/133] (446s left) kms_joiner (basic-force-ultra-joiner)
[577.699647] Starting subtest: basic-force-ultra-joiner
[577.703824] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[577.749371] [100/133] (446s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[577.830910] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[585.349053] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.523s)
[585.462697] [101/133] (438s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[585.538649] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[585.540952] Starting dynamic subtest: pipe-A-eDP-1
[585.623381] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[585.634789] Starting dynamic subtest: pipe-B-eDP-1
[586.779334] Dynamic subtest pipe-B-eDP-1: SKIP (1.153s)
[586.783695] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.243s)
[587.946293] [102/133] (436s left) kms_psr (psr2-suspend)
[588.022862] Starting subtest: psr2-suspend
[588.025249] Starting dynamic subtest: eDP-1
[606.074375] Dynamic subtest eDP-1: SUCCESS (3.759s)
[606.076743] Subtest psr2-suspend: SUCCESS (3.760s)
[606.929618] [103/133] (417s left) gem_exec_balancer (semaphore)
[607.009916] Starting subtest: semaphore
[608.518502] Subtest semaphore: SUCCESS (1.530s)
[608.789541] [104/133] (415s left) kms_chamelium_edid (dp-mode-timings)
[609.155920] Subtest dp-mode-timings: SKIP (0.000s)
[609.935748] [105/133] (414s left) gem_exercise_blt (fast-copy-emit)
[609.996854] Starting subtest: fast-copy-emit
[609.999319] Starting dynamic subtest: linear-smem-smem-emit
[610.020998] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.025s)
[610.031688] Starting dynamic subtest: xmajor-smem-smem-emit
[610.037445] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.016s)
[610.047974] Starting dynamic subtest: tile4-smem-smem-emit
[610.054910] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s)
[610.065150] Starting dynamic subtest: tile64-smem-smem-emit
[610.070236] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.015s)
[610.073168] Subtest fast-copy-emit: SUCCESS (0.076s)
[610.165465] [106/133] (413s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[610.254125] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[610.258520] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[610.332653] [107/133] (413s left) gem_exec_params (invalid-fence-in-submit)
[610.397478] Starting subtest: invalid-fence-in-submit
[610.402388] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[610.487383] [108/133] (413s left) kms_vblank (query-forked-hang)
[610.568267] Starting subtest: query-forked-hang
[610.570503] Starting dynamic subtest: pipe-A-eDP-1
[624.319384] Dynamic subtest pipe-A-eDP-1: SUCCESS (13.823s)
[624.335781] Starting dynamic subtest: pipe-D-eDP-1
[639.310755] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.002s)
[639.312758] Subtest query-forked-hang: SUCCESS (28.829s)
[640.121787] [109/133] (384s left) kms_psr (pr-cursor-plane-move)
[640.211549] Starting subtest: pr-cursor-plane-move
[640.216115] Subtest pr-cursor-plane-move: SKIP (0.000s)
[640.262436] [110/133] (384s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[640.342300] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[640.344718] Starting dynamic subtest: pipe-A-eDP-1
[640.852682] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.481s)
[640.866134] Starting dynamic subtest: pipe-B-eDP-1
[642.223260] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.369s)
[642.236072] Starting dynamic subtest: pipe-C-eDP-1
[643.639187] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.414s)
[643.651971] Starting dynamic subtest: pipe-D-eDP-1
[644.950420] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.311s)
[644.952310] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.580s)
[646.122918] [111/133] (378s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[646.252350] Starting subtest: basic-flip-after-cursor-atomic
[647.230646] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.981s)
[648.059666] [112/133] (376s left) gem_mmap_gtt (zero-extend)
[648.113903] Subtest zero-extend: SKIP (0.000s)
[648.198661] [113/133] (376s left) kms_rmfb (rmfb-ioctl)
[648.281981] Starting subtest: rmfb-ioctl
[648.284268] Starting dynamic subtest: pipe-A-eDP-1
[648.387014] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s)
[648.400341] Starting dynamic subtest: pipe-B-eDP-1
[649.531525] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.142s)
[649.543279] Starting dynamic subtest: pipe-C-eDP-1
[650.661015] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.128s)
[650.672120] Starting dynamic subtest: pipe-D-eDP-1
[651.791452] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[651.793805] Subtest rmfb-ioctl: SUCCESS (3.511s)
[652.997845] [114/133] (371s left) kms_selftest (drm_dp_mst_helper)
[653.038974] Starting subtest: drm_dp_mst_helper
[653.114821] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[653.215028] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.099s)
[653.225944] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[653.312258] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.097s)
[653.323272] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[653.433802] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.121s)
[653.436020] Subtest drm_dp_mst_helper: SUCCESS (0.395s)
[653.576252] [115/133] (370s left) sysfs_heartbeat_interval (invalid)
[653.637667] Starting subtest: invalid
[653.639877] Starting dynamic subtest: vecs0
[653.641996] Dynamic subtest vecs0: SUCCESS (0.000s)
[653.652746] Starting dynamic subtest: ccs0
[653.654842] Dynamic subtest ccs0: SUCCESS (0.000s)
[653.665312] Starting dynamic subtest: vcs0
[653.667405] Dynamic subtest vcs0: SUCCESS (0.000s)
[653.677944] Starting dynamic subtest: bcs0
[653.680171] Dynamic subtest bcs0: SUCCESS (0.000s)
[653.692661] Starting dynamic subtest: rcs0
[653.694560] Dynamic subtest rcs0: SUCCESS (0.000s)
[653.704664] Starting dynamic subtest: vcs1
[653.706600] Dynamic subtest vcs1: SUCCESS (0.000s)
[653.708501] Subtest invalid: SUCCESS (0.005s)
[653.747925] [116/133] (370s left) gem_exec_reloc (basic-cpu-read)
[653.808263] Subtest basic-cpu-read: SKIP (0.000s)
[653.898920] [117/133] (370s left) gem_exec_schedule (semaphore-codependency)
[653.959991] Starting subtest: semaphore-codependency
[653.966415] Subtest semaphore-codependency: SUCCESS (0.012s)
[654.280900] [118/133] (370s left) i915_pm_rpm (debugfs-forcewake-user)
[655.776278] Starting subtest: debugfs-forcewake-user
[667.150784] Subtest debugfs-forcewake-user: SUCCESS (11.380s)
[667.498631] [119/133] (357s left) fbdev (pan)
[667.534454] Starting subtest: pan
[667.560880] Subtest pan: SUCCESS (0.030s)
[667.612426] [120/133] (357s left) prime_vgem (basic-read)
[667.683291] Starting subtest: basic-read
[667.690931] Subtest basic-read: SKIP (0.005s)
[667.772244] [121/133] (357s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[667.868956] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[679.056353] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.189s)
[679.823101] [122/133] (345s left) kms_async_flips (test-cursor)
[679.913736] Starting subtest: test-cursor
[680.290019] Starting dynamic subtest: pipe-A-eDP-1
[681.042661] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.753s)
[681.416266] Starting dynamic subtest: pipe-B-eDP-1
[682.176454] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.769s)
[682.578487] Starting dynamic subtest: pipe-C-eDP-1
[683.314230] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.747s)
[683.697756] Starting dynamic subtest: pipe-D-eDP-1
[684.440518] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.752s)
[684.442856] Subtest test-cursor: SUCCESS (4.529s)
[685.596029] [123/133] (339s left) gem_render_copy (y-tiled-to-vebox-linear)
[685.654610] Starting subtest: y-tiled-to-vebox-linear
[685.658887] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[685.817059] [124/133] (339s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[685.900175] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[689.871493] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (3.977s)
[690.987299] [125/133] (333s left) gem_mmap_gtt (cpuset-big-copy-odd)
[691.044554] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[691.108620] [126/133] (333s left) gen9_exec_parse (batch-invalid-length)
[691.172622] Subtest batch-invalid-length: SKIP (0.000s)
[691.245702] [127/133] (333s left) api_intel_bb (blit-noreloc-keep-cache)
[691.301124] Starting subtest: blit-noreloc-keep-cache
[691.308921] Subtest blit-noreloc-keep-cache: SUCCESS (0.010s)
[691.418378] [128/133] (333s left) kms_addfb_basic (unused-handle)
[691.490775] Starting subtest: unused-handle
[691.492760] Subtest unused-handle: SUCCESS (0.000s)
[691.588436] [129/133] (333s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[691.695247] Starting subtest: verify-pxp-execution-after-suspend-resume
[698.757277] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.064s)
[698.870877] [130/133] (326s left) perf_pmu (invalid-open)
[698.918970] Starting subtest: invalid-open
[698.921252] Subtest invalid-open: SUCCESS (0.000s)
[699.007014] [131/133] (326s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[699.084392] Starting subtest: psr-shrfb-scaledprimary
[704.851635] Subtest psr-shrfb-scaledprimary: SUCCESS (5.770s)
[704.945775] [132/133] (320s left) gem_cs_tlb (engines)
[704.995676] Starting subtest: engines
[704.998050] Starting dynamic subtest: rcs0
[707.152267] Dynamic subtest rcs0: SUCCESS (2.151s)
[707.164076] Starting dynamic subtest: bcs0
[709.303148] Dynamic subtest bcs0: SUCCESS (2.151s)
[709.317251] Starting dynamic subtest: vcs0
[711.456641] Dynamic subtest vcs0: SUCCESS (2.153s)
[711.469453] Starting dynamic subtest: vcs1
[713.612327] Dynamic subtest vcs1: SUCCESS (2.153s)
[713.626087] Starting dynamic subtest: vecs0
[715.766601] Dynamic subtest vecs0: SUCCESS (2.153s)
[715.780464] Starting dynamic subtest: ccs0
[717.920876] Dynamic subtest ccs0: SUCCESS (2.153s)
[717.922883] Subtest engines: SUCCESS (12.922s)
[718.009819] [133/133] (307s left) kms_big_fb (4-tiled-addfb)
[718.093122] Starting subtest: 4-tiled-addfb
[718.095397] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[718.157812] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_ctx_bad_destroy
results: parsing output: 2/ for test: gem_caching
results: parsing output: 3/ for test: kms_plane_alpha_blend
results: parsing output: 4/ for test: gem_userptr_blits
results: parsing output: 5/ for test: drm_read
results: parsing output: 6/ for test: i915_query
results: parsing output: 7/ for test: gem_exec_balancer
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_feature_discovery
results: parsing output: 11/ for test: kms_prop_blob
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: gem_userptr_blits
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: i915_drm_fdinfo
results: parsing output: 19/ for test: kms_cursor_legacy
results: parsing output: 20/ for test: gem_eio
results: parsing output: 21/ for test: kms_plane
results: parsing output: 22/ for test: perf
results: parsing output: 23/ for test: perf_pmu
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: gem_softpin
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: gem_mmap_wc
results: parsing output: 30/ for test: tools_test
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: i915_pm_freq_api
results: parsing output: 36/ for test: syncobj_basic
results: parsing output: 37/ for test: gem_exec_whisper
results: parsing output: 38/ for test: prime_vgem
results: parsing output: 39/ for test: sw_sync
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: gem_ctx_param
results: parsing output: 43/ for test: kms_plane_scaling
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_plane
results: parsing output: 46/ for test: gem_exec_parallel
results: parsing output: 47/ for test: kms_content_protection
results: parsing output: 48/ for test: gem_userptr_blits
results: parsing output: 49/ for test: kms_plane
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_joiner
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_pm_backlight
results: parsing output: 56/ for test: kms_atomic_transition
results: parsing output: 57/ for test: syncobj_basic
results: parsing output: 58/ for test: gem_pxp
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: kms_prime
results: parsing output: 61/ for test: kms_chamelium_hpd
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_psr2_sf
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_partial_pwrite_pread
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: perf
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_color_pipeline
results: parsing output: 75/ for test: gem_ctx_sseu
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: gem_ctx_persistence
results: parsing output: 79/ for test: kms_async_flips
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_atomic_transition
results: parsing output: 82/ for test: gem_exec_gttfill
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: api_intel_bb
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: kms_rotation_crc
results: parsing output: 87/ for test: kms_cursor_edge_walk
results: parsing output: 88/ for test: kms_flip_scaled_crc
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: gem_pwrite_snooped
results: parsing output: 92/ for test: dmabuf_sync_file
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_softpin
results: parsing output: 95/ for test: gem_exec_suspend
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_joiner
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_psr2_sf
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: gem_exec_balancer
results: parsing output: 103/ for test: kms_chamelium_edid
results: parsing output: 104/ for test: gem_exercise_blt
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: gem_exec_params
results: parsing output: 107/ for test: kms_vblank
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: kms_rmfb
results: parsing output: 113/ for test: kms_selftest
results: parsing output: 114/ for test: sysfs_heartbeat_interval
results: parsing output: 115/ for test: gem_exec_reloc
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: i915_pm_rpm
results: parsing output: 118/ for test: fbdev
results: parsing output: 119/ for test: prime_vgem
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: kms_async_flips
results: parsing output: 122/ for test: gem_render_copy
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_mmap_gtt
results: parsing output: 125/ for test: gen9_exec_parse
results: parsing output: 126/ for test: api_intel_bb
results: parsing output: 127/ for test: kms_addfb_basic
results: parsing output: 128/ for test: gem_pxp
results: parsing output: 129/ for test: perf_pmu
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_cs_tlb
results: parsing output: 132/ for test: kms_big_fb
Done.