[58.637420] Initializing watchdogs
[58.637493]   /dev/watchdog0
[58.653689] [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]
[58.658255] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.662765] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.666489] [001/133] (960s left) kms_busy (basic-hang)
[58.794845] Starting subtest: basic-hang
[58.797271] Starting dynamic subtest: flip-pipe-A
[59.454589] Dynamic subtest flip-pipe-A: SUCCESS (0.658s)
[59.464372] Starting dynamic subtest: modeset-pipe-A
[63.076822] Dynamic subtest modeset-pipe-A: SUCCESS (3.621s)
[63.085842] Starting dynamic subtest: flip-pipe-D
[64.268588] Dynamic subtest flip-pipe-D: SUCCESS (1.192s)
[64.277995] Starting dynamic subtest: modeset-pipe-D
[67.703646] Dynamic subtest modeset-pipe-D: SUCCESS (3.436s)
[67.706239] Subtest basic-hang: SUCCESS (8.912s)
[68.505167] [002/133] (950s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[68.598170] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[68.600410] Starting dynamic subtest: pipe-A-eDP-1
[102.475028] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.799s)
[102.484053] Starting dynamic subtest: pipe-B-eDP-1
[137.430189] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.528s)
[137.439662] Starting dynamic subtest: pipe-C-eDP-1
[172.396072] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.528s)
[172.406060] Starting dynamic subtest: pipe-D-eDP-1
[207.406377] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.446s)
[207.409027] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (17.304s)
[217.643158] [003/133] (810s left) kms_draw_crc (draw-method-mmap-wc)
[217.761986] Starting subtest: draw-method-mmap-wc
[217.764851] Starting dynamic subtest: xrgb8888-untiled
[217.995907] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[218.006004] Starting dynamic subtest: rgb565-untiled
[218.216933] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[218.225340] Starting dynamic subtest: xrgb2101010-untiled
[218.437508] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[218.446135] Starting dynamic subtest: xbgr16161616f-untiled
[218.659423] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[218.667624] Starting dynamic subtest: xrgb8888-xtiled
[218.781682] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[218.791571] Starting dynamic subtest: rgb565-xtiled
[218.915131] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[218.923739] Starting dynamic subtest: xrgb2101010-xtiled
[219.026511] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[219.035263] Starting dynamic subtest: xbgr16161616f-xtiled
[219.159641] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[219.168289] Starting dynamic subtest: xrgb8888-4tiled
[219.315285] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[219.323627] Starting dynamic subtest: rgb565-4tiled
[219.448741] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[219.456951] Starting dynamic subtest: xrgb2101010-4tiled
[219.604017] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.155s)
[219.612551] Starting dynamic subtest: xbgr16161616f-4tiled
[219.782158] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s)
[219.784588] Subtest draw-method-mmap-wc: SUCCESS (2.022s)
[219.879193] [004/133] (808s left) gem_exec_suspend (basic-s3-devices)
[219.944129] Starting subtest: basic-S3-devices
[219.946386] Starting dynamic subtest: smem
[230.391266] Dynamic subtest smem: SUCCESS (10.442s)
[230.394280] Subtest basic-S3-devices: SUCCESS (10.444s)
[235.640226] [005/133] (797s left) api_intel_bb (lot-of-buffers)
[235.703901] Starting subtest: lot-of-buffers
[236.741847] Subtest lot-of-buffers: SUCCESS (1.039s)
[237.603997] [006/133] (795s left) kms_chamelium_frames (hdmi-crc-single)
[237.987382] Subtest hdmi-crc-single: SKIP (0.000s)
[238.801727] [007/133] (794s left) kms_sequence (get-forked)
[238.888148] Starting subtest: get-forked
[238.890672] Starting dynamic subtest: pipe-A-eDP-1
[240.772990] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.881s)
[240.783198] Starting dynamic subtest: pipe-B-eDP-1
[243.388784] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.615s)
[243.399232] Starting dynamic subtest: pipe-C-eDP-1
[245.881775] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.492s)
[245.891359] Starting dynamic subtest: pipe-D-eDP-1
[248.410207] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.528s)
[248.412742] Subtest get-forked: SUCCESS (9.520s)
[249.259964] [008/133] (784s left) prime_busy (after-wait)
[249.323184] Starting subtest: after-wait
[249.328946] Starting dynamic subtest: rcs0
[249.363848] Dynamic subtest rcs0: SUCCESS (0.037s)
[249.373158] Starting dynamic subtest: bcs0
[249.410141] Dynamic subtest bcs0: SUCCESS (0.046s)
[249.419405] Starting dynamic subtest: vcs0
[249.452481] Dynamic subtest vcs0: SUCCESS (0.041s)
[249.461176] Starting dynamic subtest: vcs1
[249.494172] Dynamic subtest vcs1: SUCCESS (0.041s)
[249.502937] Starting dynamic subtest: vecs0
[249.535668] Dynamic subtest vecs0: SUCCESS (0.041s)
[249.548131] Starting dynamic subtest: ccs0
[249.580662] Dynamic subtest ccs0: SUCCESS (0.045s)
[249.689995] Subtest after-wait: SUCCESS (0.365s)
[249.776377] [009/133] (783s left) gem_exec_fence (syncobj-timeline-signal)
[250.385401] Starting subtest: syncobj-timeline-signal
[250.390128] Subtest syncobj-timeline-signal: SUCCESS (0.009s)
[251.519557] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[251.522942] [010/133] (782s left) kms_cursor_crc (cursor-onscreen-64x21)
[251.725535] Starting subtest: cursor-onscreen-64x21
[251.779530] Subtest cursor-onscreen-64x21: SKIP (0.050s)
[252.028172] [011/133] (781s left) gem_ctx_shared (exec-single-timeline)
[252.085032] Starting subtest: exec-single-timeline
[252.087781] Starting dynamic subtest: rcs0
[253.140379] Dynamic subtest rcs0: SUCCESS (1.053s)
[253.151691] Starting dynamic subtest: bcs0
[254.228160] Dynamic subtest bcs0: SUCCESS (1.087s)
[254.239871] Starting dynamic subtest: vcs0
[255.316715] Dynamic subtest vcs0: SUCCESS (1.084s)
[255.329389] Starting dynamic subtest: vcs1
[256.404306] Dynamic subtest vcs1: SUCCESS (1.085s)
[256.417155] Starting dynamic subtest: vecs0
[257.492865] Dynamic subtest vecs0: SUCCESS (1.086s)
[257.503892] Starting dynamic subtest: ccs0
[258.581402] Dynamic subtest ccs0: SUCCESS (1.086s)
[258.584117] Subtest exec-single-timeline: SUCCESS (6.496s)
[258.789053] [012/133] (774s left) gem_spin_batch (user-each)
[258.853848] Starting subtest: user-each
[262.232268] Subtest user-each: SUCCESS (3.378s)
[262.486298] [013/133] (771s left) gem_flink_basic (basic)
[262.537595] Starting subtest: basic
[262.540124] Subtest basic: SUCCESS (0.000s)
[262.647565] [014/133] (771s left) api_intel_bb (bb-with-allocator)
[262.709822] Starting subtest: bb-with-allocator
[262.717626] Subtest bb-with-allocator: SUCCESS (0.011s)
[262.804585] [015/133] (771s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[262.900860] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[262.903514] Starting dynamic subtest: pipe-A-eDP-1
[262.928899] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[262.937942] Starting dynamic subtest: pipe-B-eDP-1
[262.962879] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[262.972944] Starting dynamic subtest: pipe-C-eDP-1
[262.999891] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[263.009930] Starting dynamic subtest: pipe-D-eDP-1
[263.035515] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[263.040351] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[265.219663] [016/133] (768s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[265.318482] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[265.321197] Starting dynamic subtest: pipe-A-eDP-1
[265.417638] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[265.428887] Starting dynamic subtest: pipe-B-eDP-1
[266.589865] Dynamic subtest pipe-B-eDP-1: SKIP (1.172s)
[266.595138] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.275s)
[267.783050] [017/133] (766s left) kms_chamelium_color (ctm-0-25)
[267.874147] Subtest ctm-0-25: SKIP (0.000s)
[267.924552] [018/133] (766s left) gem_reg_read (bad-register)
[267.980954] Starting subtest: bad-register
[267.983524] Subtest bad-register: SUCCESS (0.000s)
[268.085296] [019/133] (765s left) i915_drm_fdinfo (virtual-busy-idle)
[268.124170] Starting subtest: virtual-busy-idle
[268.129854] Subtest virtual-busy-idle: SKIP (0.000s)
[268.205992] [020/133] (765s left) syncobj_timeline (host-signal-points)
[268.267007] Starting subtest: host-signal-points
[268.269926] Subtest host-signal-points: SUCCESS (0.004s)
[268.384237] [021/133] (765s left) kms_cursor_legacy (single-bo)
[268.506069] Starting subtest: single-bo
[268.508856] Starting dynamic subtest: pipe-A
[273.943463] Dynamic subtest pipe-A: SUCCESS (5.381s)
[273.954373] Starting dynamic subtest: pipe-B
[279.323765] Dynamic subtest pipe-B: SUCCESS (5.380s)
[279.334387] Starting dynamic subtest: pipe-C
[284.704773] Dynamic subtest pipe-C: SUCCESS (5.380s)
[284.716403] Starting dynamic subtest: pipe-D
[290.085545] Dynamic subtest pipe-D: SUCCESS (5.379s)
[290.096321] Starting dynamic subtest: all-pipes
[295.475178] Dynamic subtest all-pipes: SUCCESS (5.387s)
[295.477767] Subtest single-bo: SUCCESS (26.916s)
[295.568994] [022/133] (738s left) i915_drm_fdinfo (virtual-busy-hang)
[295.614974] Starting subtest: virtual-busy-hang
[295.621022] Subtest virtual-busy-hang: SKIP (0.000s)
[295.679905] [023/133] (738s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[295.777124] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[295.779877] Starting dynamic subtest: pipe-A-default-mode
[298.536690] Dynamic subtest pipe-A-default-mode: SUCCESS (2.757s)
[298.538971] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.759s)
[299.363449] [024/133] (734s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[299.457044] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[299.461921] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[299.551578] [025/133] (734s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[299.642741] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[299.647557] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[299.738242] [026/133] (734s left) syncobj_timeline (invalid-wait-illegal-handle)
[299.786839] Starting subtest: invalid-wait-illegal-handle
[299.788953] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[299.891559] [027/133] (734s left) kms_pm_rpm (basic-pci-d3-state)
[301.623115] Starting subtest: basic-pci-d3-state
[303.090874] Subtest basic-pci-d3-state: SUCCESS (1.472s)
[303.193583] [028/133] (731s left) dumb_buffer (create-clear)
[303.250499] Starting subtest: create-clear
[336.791387] Subtest create-clear: SUCCESS (33.487s)
[336.838685] [029/133] (697s left) gem_render_copy (linear-to-vebox-yf-tiled)
[336.902938] Starting subtest: linear-to-vebox-yf-tiled
[336.909153] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[337.112437] [030/133] (697s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[337.237844] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[354.544010] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.306s)
[355.350242] [031/133] (679s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[355.452119] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[355.457004] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[355.551620] [032/133] (679s left) gem_mmap_gtt (pf-nonblock)
[355.609577] Subtest pf-nonblock: SKIP (0.000s)
[355.670934] [033/133] (678s left) syncobj_wait (wait-all-for-submit-snapshot)
[355.734150] Starting subtest: wait-all-for-submit-snapshot
[355.814855] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[355.895023] [034/133] (678s left) gem_exec_params (dr1-dirt)
[355.949247] Starting subtest: DR1-dirt
[355.951951] Subtest DR1-dirt: SUCCESS (0.000s)
[356.046348] [035/133] (678s left) gen9_exec_parse (cmd-crossing-page)
[356.107000] Subtest cmd-crossing-page: SKIP (0.000s)
[356.189834] [036/133] (678s left) kms_psr (psr2-suspend)
[356.276781] Starting subtest: psr2-suspend
[356.278675] Starting dynamic subtest: eDP-1
[374.618483] Dynamic subtest eDP-1: SUCCESS (3.287s)
[374.620405] Subtest psr2-suspend: SUCCESS (3.288s)
[384.492456] [037/133] (659s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[384.603307] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[384.607619] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[384.698416] [038/133] (659s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[384.787516] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[392.125338] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.335s)
[393.325474] [039/133] (650s left) gem_mmap_wc (write-read-distinct)
[393.380685] Subtest write-read-distinct: SKIP (0.000s)
[393.450623] [040/133] (650s left) kms_psr (pr-primary-page-flip)
[393.542939] Starting subtest: pr-primary-page-flip
[393.547515] Subtest pr-primary-page-flip: SKIP (0.000s)
[393.615627] [041/133] (650s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[393.721317] Starting subtest: fbc-2p-pri-indfb-multidraw
[393.725289] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[393.820872] [042/133] (650s left) gem_exec_reloc (basic-write-gtt-active)
[393.881374] Subtest basic-write-gtt-active: SKIP (0.000s)
[393.957711] [043/133] (650s left) gem_ctx_exec (basic)
[394.012652] Starting subtest: basic
[394.017605] Subtest basic: SUCCESS (0.008s)
[394.122407] [044/133] (650s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[394.223676] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[394.228143] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[394.315507] [045/133] (649s left) kms_flip (nonexisting-fb-interruptible)
[394.402339] Starting subtest: nonexisting-fb-interruptible
[394.404259] Starting dynamic subtest: A-eDP1
[395.521707] Dynamic subtest A-eDP1: SUCCESS (1.118s)
[395.534486] Starting dynamic subtest: B-eDP1
[396.653332] Dynamic subtest B-eDP1: SUCCESS (1.130s)
[396.666665] Starting dynamic subtest: C-eDP1
[397.784371] Dynamic subtest C-eDP1: SUCCESS (1.130s)
[397.798171] Starting dynamic subtest: D-eDP1
[398.920071] Dynamic subtest D-eDP1: SUCCESS (1.134s)
[398.925175] Subtest nonexisting-fb-interruptible: SUCCESS (4.521s)
[400.084785] [046/133] (644s left) gem_mmap_gtt (cpuset-big-copy-odd)
[400.138551] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[400.209909] [047/133] (644s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[400.308040] Starting subtest: x-tiled-32bpp-rotate-270
[400.328726] Subtest x-tiled-32bpp-rotate-270: SKIP (0.020s)
[400.444780] [048/133] (643s left) perf (polling)
[400.590016] Starting subtest: polling
[400.591867] Starting dynamic subtest: 0-rcs0
[410.676371] Dynamic subtest 0-rcs0: SUCCESS (10.031s)
[410.687610] Starting dynamic subtest: 1-vcs1
[420.695584] Dynamic subtest 1-vcs1: SUCCESS (10.020s)
[420.697906] Subtest polling: SUCCESS (20.055s)
[420.738814] [049/133] (623s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[420.837032] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[427.729692] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.899s)
[427.834079] [050/133] (616s left) kms_setmode (basic)
[427.894808] Starting subtest: basic
[428.225664] Starting dynamic subtest: pipe-A-eDP-1
[430.288234] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.058s)
[430.639708] Starting dynamic subtest: pipe-B-eDP-1
[432.721669] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.084s)
[433.035506] Subtest basic: SUCCESS (5.139s)
[433.865061] [051/133] (610s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[433.958081] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[433.960333] Starting dynamic subtest: pipe-A-eDP-1
[433.981995] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[433.992487] Starting dynamic subtest: pipe-B-eDP-1
[434.011795] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[434.020552] Starting dynamic subtest: pipe-C-eDP-1
[434.041436] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[434.049942] Starting dynamic subtest: pipe-D-eDP-1
[434.071121] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[434.075412] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[436.226352] [052/133] (608s left) perf (invalid-oa-metric-set-id)
[436.326723] Starting subtest: invalid-oa-metric-set-id
[436.341747] Subtest invalid-oa-metric-set-id: SUCCESS (0.012s)
[436.382274] [053/133] (608s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[436.444657] Starting subtest: basic-batch-kernel-default-cmd
[436.448724] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[436.636243] [054/133] (607s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[437.178321] Starting subtest: syncobj-timeline-invalid-flags
[437.180790] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[438.547098] [055/133] (606s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[438.651715] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[438.656033] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[438.737063] [056/133] (605s left) fbdev (eof)
[438.801255] Starting subtest: eof
[438.803548] Subtest eof: SUCCESS (0.000s)
[438.873259] [057/133] (605s left) i915_pm_rc6_residency (rc6-fence)
[438.923579] Starting subtest: rc6-fence
[438.937602] Starting dynamic subtest: gt0
[451.278120] Dynamic subtest gt0: SUCCESS (12.322s)
[451.289024] Starting dynamic subtest: gt1
[466.500905] Dynamic subtest gt1: SUCCESS (15.233s)
[466.503753] Subtest rc6-fence: SUCCESS (27.576s)
[466.580603] [058/133] (578s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[466.659662] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[466.768983] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.108s)
[466.863178] [059/133] (577s left) perf_pmu (busy-accuracy-2)
[466.909109] Starting subtest: busy-accuracy-2
[466.911035] Starting dynamic subtest: rcs0
[470.018166] Dynamic subtest rcs0: SUCCESS (3.056s)
[470.029135] Starting dynamic subtest: bcs0
[473.077095] Dynamic subtest bcs0: SUCCESS (3.057s)
[473.088641] Starting dynamic subtest: vcs0
[476.125726] Dynamic subtest vcs0: SUCCESS (3.047s)
[476.137530] Starting dynamic subtest: vcs1
[479.172201] Dynamic subtest vcs1: SUCCESS (3.044s)
[479.181476] Starting dynamic subtest: vecs0
[482.218156] Dynamic subtest vecs0: SUCCESS (3.043s)
[482.229504] Starting dynamic subtest: ccs0
[485.276432] Dynamic subtest ccs0: SUCCESS (3.054s)
[485.278478] Subtest busy-accuracy-2: SUCCESS (18.317s)
[485.351466] [060/133] (559s left) kms_color (ctm-green-to-red)
[485.455827] Starting subtest: ctm-green-to-red
[485.457689] Starting dynamic subtest: pipe-A-eDP-1
[486.144030] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.688s)
[486.155162] Starting dynamic subtest: pipe-B-eDP-1
[487.556617] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.410s)
[487.570988] Starting dynamic subtest: pipe-C-eDP-1
[488.907518] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.351s)
[488.916930] Starting dynamic subtest: pipe-D-eDP-1
[490.193148] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.287s)
[490.195535] Subtest ctm-green-to-red: SUCCESS (4.739s)
[491.038224] [061/133] (553s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[491.140276] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[491.144534] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[491.208234] [062/133] (553s left) gem_ctx_persistence (legacy-engines-mixed-process)
[491.266271] Starting subtest: legacy-engines-mixed-process
[491.268475] Starting dynamic subtest: render
[492.432366] Dynamic subtest render: SUCCESS (1.165s)
[492.444751] Starting dynamic subtest: bsd1
[494.487847] Dynamic subtest bsd1: SUCCESS (2.053s)
[494.499608] Starting dynamic subtest: bsd2
[496.436193] Dynamic subtest bsd2: SUCCESS (1.946s)
[496.447730] Starting dynamic subtest: blt
[498.430910] Dynamic subtest blt: SUCCESS (1.993s)
[498.442360] Starting dynamic subtest: vebox
[500.495359] Dynamic subtest vebox: SUCCESS (2.060s)
[500.497790] Subtest legacy-engines-mixed-process: SUCCESS (9.226s)
[500.574831] [063/133] (544s left) gem_eio (hibernate)
[500.812122] Starting subtest: hibernate
[515.380300] Subtest hibernate: SUCCESS (14.567s)
[525.598591] [064/133] (529s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[525.725880] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[532.301819] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.581s)
[532.428259] [065/133] (522s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[532.527114] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[539.504784] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.978s)
[539.671787] [066/133] (515s left) kms_psr (fbc-psr2-cursor-blt)
[539.773031] Starting subtest: fbc-psr2-cursor-blt
[539.775189] Starting dynamic subtest: eDP-1
[539.779016] Dynamic subtest eDP-1: SKIP (0.000s)
[539.782981] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[539.864058] [067/133] (515s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[539.964520] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[539.968691] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[540.064821] [068/133] (515s left) perf (low-oa-exponent-permissions)
[540.159619] Starting subtest: low-oa-exponent-permissions
[540.193131] Subtest low-oa-exponent-permissions: SUCCESS (0.033s)
[540.241012] [069/133] (515s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[540.339225] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[540.343094] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[540.438463] [070/133] (514s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[540.539861] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[540.543365] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[540.658905] [071/133] (514s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[540.758048] Starting subtest: plane-all-modeset-transition-fencing
[540.761686] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[540.843614] [072/133] (514s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[540.944301] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[540.946258] Starting dynamic subtest: pipe-A-eDP-1
[557.421567] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.478s)
[557.432802] Starting dynamic subtest: pipe-B-eDP-1
[574.644823] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.222s)
[574.647250] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.703s)
[575.447995] [073/133] (480s left) kms_plane_scaling (invalid-parameters)
[575.549904] Starting subtest: invalid-parameters
[575.552352] Starting dynamic subtest: less-than-1-height-src
[575.564243] Dynamic subtest less-than-1-height-src: SUCCESS (0.014s)
[575.575271] Starting dynamic subtest: less-than-1-width-src
[575.577629] Dynamic subtest less-than-1-width-src: SUCCESS (0.013s)
[575.579981] Subtest invalid-parameters: SUCCESS (0.029s)
[575.687908] [074/133] (479s left) perf_pmu (all-busy-idle-check-all)
[575.734308] Starting subtest: all-busy-idle-check-all
[577.478560] Subtest all-busy-idle-check-all: SUCCESS (1.744s)
[577.591203] [075/133] (477s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[577.680228] Starting subtest: plane-primary-overlay-mutable-zpos
[581.093282] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.412s)
[582.290747] [076/133] (473s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[582.387634] Starting subtest: invalidate-primary-flip-overlay
[593.362055] Subtest invalidate-primary-flip-overlay: SUCCESS (10.976s)
[593.480415] [077/133] (462s left) perf (gen8-unprivileged-single-ctx-counters)
[593.573715] Starting subtest: gen8-unprivileged-single-ctx-counters
[593.577661] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[593.623426] [078/133] (462s left) gem_exec_balancer (fairslice)
[593.682416] Starting subtest: fairslice
[596.651008] Subtest fairslice: SUCCESS (2.967s)
[596.974050] [079/133] (458s left) gem_ctx_isolation (clean)
[597.035176] Starting subtest: clean
[597.037439] Starting dynamic subtest: rcs0
[597.065917] Dynamic subtest rcs0: SUCCESS (0.033s)
[597.078247] Starting dynamic subtest: bcs0
[597.133565] Dynamic subtest bcs0: SUCCESS (0.067s)
[597.145812] Starting dynamic subtest: vcs0
[597.190720] Dynamic subtest vcs0: SUCCESS (0.055s)
[597.202881] Starting dynamic subtest: vcs1
[598.500857] Dynamic subtest vcs1: SUCCESS (1.310s)
[598.511112] Starting dynamic subtest: vecs0
[600.478975] Dynamic subtest vecs0: SUCCESS (1.977s)
[600.489535] Starting dynamic subtest: ccs0
[602.440076] Dynamic subtest ccs0: SUCCESS (1.960s)
[602.442381] Subtest clean: SUCCESS (5.408s)
[602.678467] [080/133] (453s left) gem_mmap (bad-object)
[602.749289] Subtest bad-object: SKIP (0.000s)
[602.808528] [081/133] (453s left) gem_exec_whisper (basic-forked-all)
[602.861777] Starting subtest: basic-forked-all
[618.441004] Subtest basic-forked-all: SUCCESS (15.573s)
[618.630877] [082/133] (437s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[618.736705] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[618.741084] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[619.910305] [083/133] (436s left) kms_joiner (basic-force-ultra-joiner)
[620.016029] Starting subtest: basic-force-ultra-joiner
[620.020083] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[620.094777] [084/133] (435s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[620.195912] Starting subtest: fbcpsr-rgb565-draw-pwrite
[627.205383] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.013s)
[627.318140] [085/133] (428s left) kms_cursor_edge_walk (256x256-top-bottom)
[627.410913] Starting subtest: 256x256-top-bottom
[627.413753] Starting dynamic subtest: pipe-A-eDP-1
[630.900870] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.489s)
[630.911462] Starting dynamic subtest: pipe-D-eDP-1
[634.036877] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.134s)
[634.039261] Subtest 256x256-top-bottom: SUCCESS (6.626s)
[634.836986] [086/133] (421s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[634.944359] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[635.601972] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.659s)
[635.754007] [087/133] (420s left) kms_flip (nonexisting-fb)
[635.853550] Starting subtest: nonexisting-fb
[635.855935] Starting dynamic subtest: A-eDP1
[637.016153] Dynamic subtest A-eDP1: SUCCESS (1.164s)
[637.027181] Starting dynamic subtest: B-eDP1
[638.148155] Dynamic subtest B-eDP1: SUCCESS (1.130s)
[638.159214] Starting dynamic subtest: C-eDP1
[639.281077] Dynamic subtest C-eDP1: SUCCESS (1.132s)
[639.294322] Starting dynamic subtest: D-eDP1
[640.418260] Dynamic subtest D-eDP1: SUCCESS (1.134s)
[640.420575] Subtest nonexisting-fb: SUCCESS (4.570s)
[641.592355] [088/133] (414s left) kms_cursor_crc (cursor-random-128x42)
[641.825964] Starting subtest: cursor-random-128x42
[641.877306] Subtest cursor-random-128x42: SKIP (0.046s)
[642.093060] [089/133] (414s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[642.180484] Starting subtest: stress-xrgb8888-xtiled
[648.102417] Subtest stress-xrgb8888-xtiled: SUCCESS (5.922s)
[648.165727] [090/133] (408s left) kms_lease (possible-crtcs-filtering)
[648.253184] Starting subtest: possible-crtcs-filtering
[648.256990] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[648.357294] [091/133] (407s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[648.453237] Starting subtest: psr-shrfb-scaledprimary
[654.263999] Subtest psr-shrfb-scaledprimary: SUCCESS (5.813s)
[654.379342] [092/133] (401s left) perf (invalid-create-userspace-config)
[654.474416] Starting subtest: invalid-create-userspace-config
[654.476668] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[654.521563] [093/133] (401s left) kms_getfb (getfb2-into-addfb2)
[654.606071] Starting subtest: getfb2-into-addfb2
[654.608229] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[654.714854] [094/133] (401s left) gem_exec_params (invalid-ring)
[654.778300] Starting subtest: invalid-ring
[654.780703] Subtest invalid-ring: SUCCESS (0.000s)
[654.913034] [095/133] (401s left) kms_content_protection (dp-mst-lic-type-1)
[655.066930] Starting subtest: dp-mst-lic-type-1
[655.071226] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[655.199169] [096/133] (401s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[655.300034] Starting subtest: yf-tiled-8bpp-rotate-270
[655.303481] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[655.406184] [097/133] (401s left) gem_exec_schedule (preempt-queue-contexts-chain)
[655.469203] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[655.763904] [098/133] (400s left) kms_plane_scaling (planes-upscale-20x20)
[655.859480] Starting subtest: planes-upscale-20x20
[655.861767] Starting dynamic subtest: pipe-A
[655.919446] Dynamic subtest pipe-A: SUCCESS (0.062s)
[655.936739] Starting dynamic subtest: pipe-B
[657.024420] Dynamic subtest pipe-B: SUCCESS (1.104s)
[657.037012] Starting dynamic subtest: pipe-C
[658.137518] Dynamic subtest pipe-C: SUCCESS (1.112s)
[658.148783] Starting dynamic subtest: pipe-D
[659.264169] Dynamic subtest pipe-D: SUCCESS (1.126s)
[659.266332] Subtest planes-upscale-20x20: SUCCESS (3.407s)
[660.458902] [099/133] (396s left) kms_flip (plain-flip-ts-check-interruptible)
[660.555354] Starting subtest: plain-flip-ts-check-interruptible
[660.557636] Starting dynamic subtest: A-eDP1
[669.451809] Dynamic subtest A-eDP1: SUCCESS (8.861s)
[669.464892] Starting dynamic subtest: B-eDP1
[678.289019] Dynamic subtest B-eDP1: SUCCESS (8.834s)
[678.302806] Starting dynamic subtest: C-eDP1
[687.123585] Dynamic subtest C-eDP1: SUCCESS (8.819s)
[687.137730] Starting dynamic subtest: D-eDP1
[695.959503] Dynamic subtest D-eDP1: SUCCESS (8.833s)
[695.962208] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.361s)
[697.100993] [100/133] (359s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[697.197487] Starting subtest: y-tiled-8bpp-rotate-270
[697.201582] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[697.301780] [101/133] (359s left) kms_psr (fbc-psr-primary-render)
[697.406830] Starting subtest: fbc-psr-primary-render
[697.409064] Starting dynamic subtest: eDP-1
[697.413146] Dynamic subtest eDP-1: SKIP (0.000s)
[697.417332] Subtest fbc-psr-primary-render: SKIP (0.001s)
[697.495837] [102/133] (359s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[697.596042] Starting subtest: pixel-format-linear-modifier-source-clamping
[697.622661] Starting dynamic subtest: pipe-A-plane-0
[701.288515] Dynamic subtest pipe-A-plane-0: SUCCESS (3.666s)
[701.299695] Starting dynamic subtest: pipe-A-plane-3
[702.955323] Dynamic subtest pipe-A-plane-3: SUCCESS (1.666s)
[704.101113] Starting dynamic subtest: pipe-B-plane-0
[707.658838] Dynamic subtest pipe-B-plane-0: SUCCESS (3.566s)
[707.671228] Starting dynamic subtest: pipe-B-plane-3
[709.492111] Dynamic subtest pipe-B-plane-3: SUCCESS (1.833s)
[709.803675] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (12.206s)
[710.676637] [103/133] (346s left) perf_pmu (multi-client)
[710.724828] Starting subtest: multi-client
[710.727297] Starting dynamic subtest: rcs0
[711.775067] Dynamic subtest rcs0: SUCCESS (1.050s)
[711.787977] Starting dynamic subtest: bcs0
[712.825508] Dynamic subtest bcs0: SUCCESS (1.048s)
[712.837822] Starting dynamic subtest: vcs0
[713.877178] Dynamic subtest vcs0: SUCCESS (1.049s)
[713.890816] Starting dynamic subtest: vcs1
[715.516342] Dynamic subtest vcs1: SUCCESS (1.636s)
[715.528450] Starting dynamic subtest: vecs0
[717.501466] Dynamic subtest vecs0: SUCCESS (1.982s)
[717.512880] Starting dynamic subtest: ccs0
[719.485495] Dynamic subtest ccs0: SUCCESS (1.982s)
[719.488565] Subtest multi-client: SUCCESS (8.762s)
[719.619794] [104/133] (337s left) gem_softpin (evict-snoop)
[719.683413] Starting subtest: evict-snoop
[719.688119] Subtest evict-snoop: SKIP (0.000s)
[719.805773] [105/133] (337s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[719.904148] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[719.913444] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[720.000703] [106/133] (336s left) syncobj_timeline (transfer-timeline-point)
[720.063300] Starting subtest: transfer-timeline-point
[720.065562] Subtest transfer-timeline-point: SUCCESS (0.001s)
[720.182329] [107/133] (336s left) gem_pwrite (basic-self)
[720.249551] Subtest basic-self: SKIP (0.000s)
[720.319173] [108/133] (336s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[720.379283] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[720.383807] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[720.564092] [109/133] (336s left) gem_ctx_param (non-root-set)
[720.615968] Starting subtest: non-root-set
[720.635095] Subtest non-root-set: SUCCESS (0.019s)
[720.749133] [110/133] (336s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[720.844754] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[720.849204] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[720.933412] [111/133] (336s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[721.343044] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[722.202648] [112/133] (335s left) gem_exec_reloc (basic-write-wc-active)
[722.261905] Subtest basic-write-wc-active: SKIP (0.000s)
[722.332226] [113/133] (334s left) syncobj_timeline (reset-multiple-signaled)
[722.402902] Starting subtest: reset-multiple-signaled
[722.405360] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[722.509847] [114/133] (334s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[722.636923] Starting subtest: basic-busy-flip-before-cursor-atomic
[722.641677] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[722.795000] [115/133] (334s left) kms_plane_lowres (tiling-yf)
[722.893156] Starting subtest: tiling-yf
[722.897679] Subtest tiling-yf: SKIP (0.000s)
[722.972399] [116/133] (334s left) gem_exec_balancer (sliced)
[723.046998] Starting subtest: sliced
[723.051599] Subtest sliced: SKIP (0.000s)
[723.352921] [117/133] (334s left) gem_mmap_wc (write-cpu-read-wc)
[723.408248] Subtest write-cpu-read-wc: SKIP (0.000s)
[723.477602] [118/133] (334s left) kms_fence_pin_leak
[723.651147] [119/133] (333s left) kms_async_flips (async-flip-hang)
[723.732975] Starting subtest: async-flip-hang
[724.126642] Starting dynamic subtest: pipe-A-eDP-1
[739.939811] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.810s)
[740.324978] Starting dynamic subtest: pipe-B-eDP-1
[755.942001] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.620s)
[756.321784] Starting dynamic subtest: pipe-C-eDP-1
[772.006816] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.682s)
[772.376349] Starting dynamic subtest: pipe-D-eDP-1
[787.998989] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.628s)
[788.001575] Subtest async-flip-hang: SUCCESS (64.262s)
[789.206443] [120/133] (268s left) gem_userptr_blits (mmap-offset-banned)
[789.287736] Starting subtest: mmap-offset-banned
[789.289723] Starting dynamic subtest: wb
[789.291627] Dynamic subtest wb: SUCCESS (0.000s)
[789.304312] Starting dynamic subtest: wc
[789.306440] Dynamic subtest wc: SUCCESS (0.000s)
[789.316675] Starting dynamic subtest: uc
[789.318933] Dynamic subtest uc: SUCCESS (0.000s)
[789.321066] Subtest mmap-offset-banned: SUCCESS (0.002s)
[789.403031] [121/133] (268s left) gem_ctx_engines (none)
[789.474002] Starting subtest: none
[789.476335] Subtest none: SUCCESS (0.001s)
[789.685248] [122/133] (268s left) kms_pm_rpm (pm-tiling)
[791.620749] Starting subtest: pm-tiling
[791.625484] Subtest pm-tiling: SKIP (0.000s)
[792.012062] [123/133] (265s left) kms_frontbuffer_tracking (fbc-suspend)
[792.109223] Starting subtest: fbc-suspend
[830.691350] Subtest fbc-suspend: SUCCESS (8.208s)
[837.957237] [124/133] (225s left) sysfs_timeslice_duration (idempotent)
[838.036162] Starting subtest: idempotent
[838.038467] Starting dynamic subtest: vecs0
[838.040591] Dynamic subtest vecs0: SUCCESS (0.000s)
[838.054634] Starting dynamic subtest: ccs0
[838.056764] Dynamic subtest ccs0: SUCCESS (0.000s)
[838.066873] Starting dynamic subtest: vcs0
[838.069000] Dynamic subtest vcs0: SUCCESS (0.000s)
[838.079108] Starting dynamic subtest: bcs0
[838.081000] Dynamic subtest bcs0: SUCCESS (0.000s)
[838.091047] Starting dynamic subtest: rcs0
[838.093276] Dynamic subtest rcs0: SUCCESS (0.000s)
[838.103296] Starting dynamic subtest: vcs1
[838.105211] Dynamic subtest vcs1: SUCCESS (0.000s)
[838.107104] Subtest idempotent: SUCCESS (0.006s)
[838.151329] [125/133] (225s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[838.271068] Starting subtest: yf-tiled-32bpp-rotate-270
[838.275378] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[838.386323] [126/133] (225s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[838.482052] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[838.486524] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[838.556061] [127/133] (225s left) i915_pm_rps (thresholds-idle)
[838.633193] Starting subtest: thresholds-idle
[838.641815] Subtest thresholds-idle: SKIP (0.001s)
[838.743859] [128/133] (225s left) kms_big_fb (linear-32bpp-rotate-180)
[838.847044] Starting subtest: linear-32bpp-rotate-180
[840.457536] Subtest linear-32bpp-rotate-180: SUCCESS (1.613s)
[840.582174] [129/133] (223s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[840.688549] Starting subtest: fbc-indfb-scaledprimary
[843.623842] Subtest fbc-indfb-scaledprimary: SUCCESS (2.938s)
[844.774831] [130/133] (219s left) kms_vblank (wait-forked-hang)
[844.859110] Starting subtest: wait-forked-hang
[844.861107] Starting dynamic subtest: pipe-A-eDP-1
[871.651185] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.795s)
[871.666454] Starting dynamic subtest: pipe-D-eDP-1
[886.584159] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.931s)
[886.586483] Subtest wait-forked-hang: SUCCESS (41.731s)
[887.426915] [131/133] (176s left) gem_lmem_swapping (massive-random)
[887.536421] Subtest massive-random: SKIP (0.000s)
[887.585920] [132/133] (176s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[887.706401] Starting subtest: cursorB-vs-flipB-toggle
[887.710880] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[887.851924] [133/133] (176s left) gem_exec_schedule (preempt-engines)
[887.917847] Starting subtest: preempt-engines
[887.920073] Starting dynamic subtest: rcs0
[890.180690] Dynamic subtest rcs0: SUCCESS (2.268s)
[890.195521] Starting dynamic subtest: bcs0
[892.521498] Dynamic subtest bcs0: SUCCESS (2.277s)
[892.531631] Starting dynamic subtest: vcs0
[894.777370] Dynamic subtest vcs0: SUCCESS (2.263s)
[894.787589] Starting dynamic subtest: vcs1
[897.061769] Dynamic subtest vcs1: SUCCESS (2.282s)
[897.071954] Starting dynamic subtest: vecs0
[899.384381] Dynamic subtest vecs0: SUCCESS (2.321s)
[899.397413] Starting dynamic subtest: ccs0
[901.698555] Dynamic subtest ccs0: SUCCESS (2.312s)
[901.701017] Subtest preempt-engines: SUCCESS (13.736s)
[901.944093] Closing watchdogs
results: parsing output: 0/ for test: kms_busy
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_draw_crc
results: parsing output: 3/ for test: gem_exec_suspend
results: parsing output: 4/ for test: api_intel_bb
results: parsing output: 5/ for test: kms_chamelium_frames
results: parsing output: 6/ for test: kms_sequence
results: parsing output: 7/ for test: prime_busy
results: parsing output: 8/ for test: gem_exec_fence
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: gem_ctx_shared
results: parsing output: 11/ for test: gem_spin_batch
results: parsing output: 12/ for test: gem_flink_basic
results: parsing output: 13/ for test: api_intel_bb
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: kms_chamelium_color
results: parsing output: 17/ for test: gem_reg_read
results: parsing output: 18/ for test: i915_drm_fdinfo
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: i915_drm_fdinfo
results: parsing output: 22/ for test: kms_flip_scaled_crc
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_pm_rpm
results: parsing output: 27/ for test: dumb_buffer
results: parsing output: 28/ for test: gem_render_copy
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: gem_exec_params
results: parsing output: 34/ for test: gen9_exec_parse
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_mmap_wc
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_exec_reloc
results: parsing output: 42/ for test: gem_ctx_exec
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: gem_mmap_gtt
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: perf
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_setmode
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: perf
results: parsing output: 52/ for test: gem_exec_flush
results: parsing output: 53/ for test: gem_exec_fence
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: fbdev
results: parsing output: 56/ for test: i915_pm_rc6_residency
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: perf_pmu
results: parsing output: 59/ for test: kms_color
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: gem_ctx_persistence
results: parsing output: 62/ for test: gem_eio
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: perf
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_atomic_transition
results: parsing output: 71/ for test: kms_psr2_sf
results: parsing output: 72/ for test: kms_plane_scaling
results: parsing output: 73/ for test: perf_pmu
results: parsing output: 74/ for test: kms_atomic
results: parsing output: 75/ for test: kms_psr_stress_test
results: parsing output: 76/ for test: perf
results: parsing output: 77/ for test: gem_exec_balancer
results: parsing output: 78/ for test: gem_ctx_isolation
results: parsing output: 79/ for test: gem_mmap
results: parsing output: 80/ for test: gem_exec_whisper
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: kms_joiner
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_cursor_edge_walk
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: kms_cursor_crc
results: parsing output: 88/ for test: kms_pipe_stress
results: parsing output: 89/ for test: kms_lease
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: perf
results: parsing output: 92/ for test: kms_getfb
results: parsing output: 93/ for test: gem_exec_params
results: parsing output: 94/ for test: kms_content_protection
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: kms_plane_scaling
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_plane
results: parsing output: 102/ for test: perf_pmu
results: parsing output: 103/ for test: gem_softpin
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: gem_pwrite
results: parsing output: 107/ for test: gem_render_copy
results: parsing output: 108/ for test: gem_ctx_param
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_chamelium_hpd
results: parsing output: 111/ for test: gem_exec_reloc
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_cursor_legacy
results: parsing output: 114/ for test: kms_plane_lowres
results: parsing output: 115/ for test: gem_exec_balancer
results: parsing output: 116/ for test: gem_mmap_wc
results: parsing output: 117/ for test: kms_fence_pin_leak
results: parsing output: 118/ for test: kms_async_flips
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: gem_ctx_engines
results: parsing output: 121/ for test: kms_pm_rpm
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: sysfs_timeslice_duration
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_flip_scaled_crc
results: parsing output: 126/ for test: i915_pm_rps
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_vblank
results: parsing output: 130/ for test: gem_lmem_swapping
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: gem_exec_schedule
Done.