[60.663384] Initializing watchdogs
[60.663492]   /dev/watchdog0
[60.674285] [001/143] (960s left) gen9_exec_parse (bb-start-out)
[60.725794] Subtest bb-start-out: SKIP (0.000s)
[60.751780] [002/143] (960s left) kms_frontbuffer_tracking (basic)
[60.857457] Starting subtest: basic
[64.130233] Subtest basic: SUCCESS (3.276s)
[64.227826] [003/143] (956s left) kms_draw_crc (draw-method-mmap-wc)
[64.292394] Starting subtest: draw-method-mmap-wc
[64.294074] Starting dynamic subtest: xrgb8888-untiled
[64.527273] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[64.540695] Starting dynamic subtest: rgb565-untiled
[64.748525] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[64.762410] Starting dynamic subtest: xrgb2101010-untiled
[64.992982] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.244s)
[65.006038] Starting dynamic subtest: xrgb8888-xtiled
[65.114970] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[65.121404] Starting dynamic subtest: rgb565-xtiled
[65.236339] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[65.250246] Starting dynamic subtest: xrgb2101010-xtiled
[65.347235] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[65.359494] Starting dynamic subtest: xrgb8888-4tiled
[65.493388] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[65.506063] Starting dynamic subtest: rgb565-4tiled
[65.649359] Dynamic subtest rgb565-4tiled: SUCCESS (0.155s)
[65.662407] Starting dynamic subtest: xrgb2101010-4tiled
[65.769253] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[65.771362] Subtest draw-method-mmap-wc: SUCCESS (1.478s)
[65.840387] [004/143] (955s left) gem_exec_fair (basic-sync)
[65.909790] Subtest basic-sync: SKIP (0.000s)
[65.957530] [005/143] (955s left) sw_sync (sync_multi_consumer)
[66.026610] Starting subtest: sync_multi_consumer
[66.698978] Subtest sync_multi_consumer: SUCCESS (0.672s)
[66.756073] [006/143] (954s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[66.893892] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[66.898640] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[66.990280] [007/143] (954s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[67.144030] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[67.148773] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[67.233194] [008/143] (954s left) gem_mmap_wc (set-cache-level)
[67.313144] Subtest set-cache-level: SKIP (0.000s)
[67.335170] [009/143] (954s left) kms_ccs (pipe-a-crc-sprite-planes-basic-yf-tiled-ccs)
[67.725769] Starting subtest: pipe-A-crc-sprite-planes-basic-yf-tiled-ccs
[67.731151] Subtest pipe-A-crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.001s)
[68.592304] [010/143] (952s left) gem_userptr_blits (create-destroy-sync)
[68.669536] Starting subtest: create-destroy-sync
[73.740240] Subtest create-destroy-sync: SUCCESS (5.018s)
[73.787964] [011/143] (947s left) kms_ccs (pipe-a-ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[74.153551] Starting subtest: pipe-A-ccs-on-another-bo-4-tiled-mtl-mc-ccs
[74.177379] Subtest pipe-A-ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.022s)
[75.057147] [012/143] (946s left) gem_exec_whisper (basic-fds-all)
[75.125546] Starting subtest: basic-fds-all
[95.449694] Subtest basic-fds-all: SUCCESS (20.321s)
[95.632146] [013/143] (925s left) v3d/v3d_perfmon (get-values-valid-perfmon)
[95.729159] Subtest get-values-valid-perfmon: SKIP (0.000s)
[95.774722] [014/143] (925s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[95.853815] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[95.858410] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[95.941773] [015/143] (925s left) perf_pmu (rc6-all-gts)
[96.013652] Starting subtest: rc6-all-gts
[102.360271] Subtest rc6-all-gts: SUCCESS (6.345s)
[103.121620] [016/143] (918s left) v3d/v3d_submit_csd (bad-extension)
[103.187831] Subtest bad-extension: SKIP (0.000s)
[103.228593] [017/143] (918s left) vc4/vc4_create_bo (create-bo-4096)
[103.288640] Subtest create-bo-4096: SKIP (0.000s)
[103.335240] [018/143] (918s left) syncobj_timeline (wait-delayed-signal)
[103.401375] Starting subtest: wait-delayed-signal
[103.503396] Subtest wait-delayed-signal: SUCCESS (0.103s)
[103.575142] [019/143] (918s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[103.671997] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[103.676792] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[103.756315] [020/143] (917s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[103.831792] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[103.835857] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[103.916547] [021/143] (917s left) syncobj_timeline (invalid-wait-bad-flags)
[103.989821] Starting subtest: invalid-wait-bad-flags
[103.992448] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[104.056918] [022/143] (917s left) kms_atomic (plane-immutable-zpos)
[104.143597] Starting subtest: plane-immutable-zpos
[104.146067] Starting dynamic subtest: pipe-A-eDP-1
[104.984159] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.842s)
[104.986679] Subtest plane-immutable-zpos: SUCCESS (0.843s)
[105.939162] [023/143] (915s left) gem_eio (in-flight-internal-1us)
[106.207715] Starting subtest: in-flight-internal-1us
[107.556460] Subtest in-flight-internal-1us: SUCCESS (1.350s)
[107.686533] [024/143] (914s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[107.775237] Starting subtest: x-tiled-32bpp-rotate-270
[107.801950] Subtest x-tiled-32bpp-rotate-270: SKIP (0.026s)
[107.912624] [025/143] (913s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[107.966724] Starting subtest: fbc-psr2-primary-mmap-cpu
[107.969078] Starting dynamic subtest: eDP-1
[107.973742] Dynamic subtest eDP-1: SKIP (0.000s)
[107.978295] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[108.082839] [026/143] (913s left) gem_exec_reloc (basic-wc-read-noreloc)
[108.142314] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[108.174080] [027/143] (913s left) kms_getfb (getfb-handle-protection)
[108.218837] Starting subtest: getfb-handle-protection
[108.248060] Subtest getfb-handle-protection: SUCCESS (0.030s)
[108.347273] [028/143] (913s left) kms_content_protection (dp-mst-type-0)
[108.487286] Starting subtest: dp-mst-type-0
[108.491658] Subtest dp-mst-type-0: SKIP (0.000s)
[108.604130] [029/143] (913s left) gem_mmap_wc (bad-offset)
[108.660929] Subtest bad-offset: SKIP (0.000s)
[108.675837] [030/143] (913s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[108.719903] Starting subtest: 4-tiled-8bpp-rotate-180
[110.041757] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.322s)
[110.174675] [031/143] (911s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[110.243485] Starting subtest: y-tiled-to-vebox-y-tiled
[110.247029] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[110.426252] [032/143] (911s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu)
[110.517594] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu
[114.991649] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (4.477s)
[115.099739] [033/143] (906s left) kms_addfb_basic (basic-x-tiled-legacy)
[115.163285] Starting subtest: basic-x-tiled-legacy
[115.168232] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[115.263252] [034/143] (906s left) gem_ctx_persistence (legacy-engines-hang)
[115.338164] Starting subtest: legacy-engines-hang
[115.340914] Starting dynamic subtest: render
[115.393733] Dynamic subtest render: SUCCESS (0.055s)
[115.410156] Starting dynamic subtest: bsd1
[115.466042] Dynamic subtest bsd1: SUCCESS (0.070s)
[115.482352] Starting dynamic subtest: bsd2
[115.582737] Dynamic subtest bsd2: SUCCESS (0.116s)
[115.600191] Starting dynamic subtest: blt
[115.672137] Dynamic subtest blt: SUCCESS (0.088s)
[115.689368] Starting dynamic subtest: vebox
[115.709791] Dynamic subtest vebox: SUCCESS (0.037s)
[115.713085] Subtest legacy-engines-hang: SUCCESS (0.372s)
[115.785552] [035/143] (906s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[115.844384] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[115.948304] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s)
[116.019325] [036/143] (906s left) gem_exec_balancer (indices)
[116.094025] Starting subtest: indices
[118.421382] Subtest indices: SUCCESS (2.326s)
[118.670107] [037/143] (903s left) kms_flip (basic-flip-vs-modeset)
[118.759299] Starting subtest: basic-flip-vs-modeset
[118.761787] Starting dynamic subtest: A-eDP1
[121.512523] Dynamic subtest A-eDP1: SUCCESS (2.754s)
[121.531669] Starting dynamic subtest: B-eDP1
[123.816233] Dynamic subtest B-eDP1: SUCCESS (2.302s)
[123.831991] Starting dynamic subtest: C-eDP1
[126.134269] Dynamic subtest C-eDP1: SUCCESS (2.320s)
[126.145308] Starting dynamic subtest: D-eDP1
[128.424157] Dynamic subtest D-eDP1: SUCCESS (2.287s)
[128.429700] Subtest basic-flip-vs-modeset: SUCCESS (9.675s)
[129.331884] [038/143] (892s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[129.415051] Starting subtest: etime-single-wait-all-for-submit-submitted
[129.514546] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.101s)
[129.587255] [039/143] (892s left) gem_exec_reloc (basic-scanout)
[129.679185] Subtest basic-scanout: SKIP (0.000s)
[129.734562] [040/143] (892s left) kms_psr2_sf (fbc-overlay-plane-move-continuous-sf)
[134.966090] Starting subtest: fbc-overlay-plane-move-continuous-sf
[134.968970] Starting dynamic subtest: pipe-A-eDP-1
[135.795763] Dynamic subtest pipe-A-eDP-1: SKIP (0.824s)
[135.809645] Starting dynamic subtest: pipe-B-eDP-1
[137.029548] Dynamic subtest pipe-B-eDP-1: SKIP (1.232s)
[137.035104] Subtest fbc-overlay-plane-move-continuous-sf: SKIP (2.062s)
[138.294386] [041/143] (883s left) kms_flip (flip-vs-expired-vblank)
[138.357225] Starting subtest: flip-vs-expired-vblank
[138.359765] Starting dynamic subtest: A-eDP1
[147.160419] Dynamic subtest A-eDP1: SUCCESS (8.771s)
[147.176909] Starting dynamic subtest: B-eDP1
[155.912356] Dynamic subtest B-eDP1: SUCCESS (8.755s)
[155.920610] Starting dynamic subtest: C-eDP1
[164.650770] Dynamic subtest C-eDP1: SUCCESS (8.768s)
[164.667976] Starting dynamic subtest: D-eDP1
[173.461758] Dynamic subtest D-eDP1: SUCCESS (8.767s)
[173.464588] Subtest flip-vs-expired-vblank: SUCCESS (35.074s)
[174.708699] [042/143] (847s left) fbdev (unaligned-write)
[174.768962] Starting subtest: unaligned-write
[174.883137] Subtest unaligned-write: SUCCESS (0.113s)
[174.939408] [043/143] (847s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[175.010510] Starting subtest: plane-all-modeset-transition-fencing
[175.015467] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[175.080439] [044/143] (847s left) gem_userptr_blits (input-checking)
[175.158800] Starting subtest: input-checking
[175.163707] Subtest input-checking: SUCCESS (0.000s)
[175.270450] [045/143] (847s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[175.362401] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[180.498748] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (5.139s)
[180.618504] [046/143] (841s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[180.706897] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[180.711606] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[180.801839] [047/143] (841s left) gem_ctx_isolation (nonpriv-switch)
[180.885086] Starting subtest: nonpriv-switch
[180.887602] Starting dynamic subtest: rcs0
[181.093834] Dynamic subtest rcs0: SUCCESS (0.209s)
[181.109073] Starting dynamic subtest: bcs0
[181.353762] Dynamic subtest bcs0: SUCCESS (0.259s)
[181.371394] Starting dynamic subtest: vcs0
[181.617881] Dynamic subtest vcs0: SUCCESS (0.264s)
[181.623609] Starting dynamic subtest: vcs1
[183.707202] Dynamic subtest vcs1: SUCCESS (2.089s)
[183.715257] Starting dynamic subtest: vecs0
[185.824067] Dynamic subtest vecs0: SUCCESS (2.116s)
[185.840787] Starting dynamic subtest: ccs0
[187.758877] Dynamic subtest ccs0: SUCCESS (1.935s)
[187.761481] Subtest nonpriv-switch: SUCCESS (6.874s)
[188.002632] [048/143] (834s left) kms_psr (psr2-primary-render)
[188.070341] Starting subtest: psr2-primary-render
[188.072920] Starting dynamic subtest: eDP-1
[189.915404] Dynamic subtest eDP-1: SUCCESS (1.844s)
[189.917919] Subtest psr2-primary-render: SUCCESS (1.845s)
[190.837507] [049/143] (831s left) kms_flip (2x-blocking-wf_vblank)
[190.902503] Starting subtest: 2x-blocking-wf_vblank
[190.914879] Subtest 2x-blocking-wf_vblank: SKIP (0.013s)
[190.992297] [050/143] (831s left) kms_ccs (pipe-d-random-ccs-data-4-tiled-mtl-mc-ccs)
[191.388119] Starting subtest: pipe-D-random-ccs-data-4-tiled-mtl-mc-ccs
[192.506066] Subtest pipe-D-random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (1.117s)
[193.717936] [051/143] (828s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[193.773689] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[199.072670] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (5.303s)
[199.204262] [052/143] (823s left) gem_exec_whisper (basic-queues-forked)
[199.286462] Starting subtest: basic-queues-forked
[223.242870] Subtest basic-queues-forked: SUCCESS (23.952s)
[223.426457] [053/143] (799s left) gem_exec_params (invalid-ring2)
[223.494764] Starting subtest: invalid-ring2
[223.497563] Subtest invalid-ring2: SUCCESS (0.000s)
[223.585738] [054/143] (799s left) i915_fb_tiling
[223.690188] [055/143] (798s left) kms_ccs (pipe-c-ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[224.082700] Starting subtest: pipe-C-ccs-on-another-bo-4-tiled-mtl-rc-ccs
[224.085724] Subtest pipe-C-ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.000s)
[224.951107] [056/143] (797s left) gem_reg_read (bad-register)
[225.033623] Starting subtest: bad-register
[225.035677] Subtest bad-register: SUCCESS (0.000s)
[225.100925] [057/143] (797s left) gem_exec_reloc (basic-wc-cpu-active)
[225.170089] Subtest basic-wc-cpu-active: SKIP (0.000s)
[225.223204] [058/143] (797s left) kms_busy (basic-hang)
[225.320041] Starting subtest: basic-hang
[225.322305] Starting dynamic subtest: flip-pipe-A
[225.977652] Dynamic subtest flip-pipe-A: SUCCESS (0.656s)
[225.992595] Starting dynamic subtest: modeset-pipe-A
[229.707841] Dynamic subtest modeset-pipe-A: SUCCESS (3.728s)
[229.733418] Starting dynamic subtest: flip-pipe-D
[231.067320] Dynamic subtest flip-pipe-D: SUCCESS (1.352s)
[231.083873] Starting dynamic subtest: modeset-pipe-D
[234.793861] Dynamic subtest modeset-pipe-D: SUCCESS (3.725s)
[234.796493] Subtest basic-hang: SUCCESS (9.473s)
[235.693721] [059/143] (787s left) kms_lease (invalid-create-leases)
[235.764583] Starting subtest: invalid-create-leases
[235.766727] Subtest invalid-create-leases: SUCCESS (0.002s)
[235.826899] [060/143] (786s left) kms_ccs (pipe-c-bad-pixel-format-4-tiled-dg2-rc-ccs)
[236.243045] Starting subtest: pipe-C-bad-pixel-format-4-tiled-dg2-rc-ccs
[236.248463] Subtest pipe-C-bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[237.107331] [061/143] (785s left) kms_universal_plane (universal-plane-sanity)
[237.159727] Starting subtest: universal-plane-sanity
[237.162251] Starting dynamic subtest: pipe-A-eDP-1
[237.778697] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.621s)
[237.800472] Starting dynamic subtest: pipe-B-eDP-1
[239.097866] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.313s)
[239.115298] Starting dynamic subtest: pipe-C-eDP-1
[240.383317] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.283s)
[240.401267] Starting dynamic subtest: pipe-D-eDP-1
[241.668492] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.282s)
[241.671309] Subtest universal-plane-sanity: SUCCESS (4.511s)
[242.547072] [062/143] (780s left) kms_ccs (pipe-c-crc-sprite-planes-basic-yf-tiled-ccs)
[243.002804] Starting subtest: pipe-C-crc-sprite-planes-basic-yf-tiled-ccs
[243.008448] Subtest pipe-C-crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.001s)
[243.890602] [063/143] (779s left) kms_ccs (pipe-b-ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[244.273590] Starting subtest: pipe-B-ccs-on-another-bo-4-tiled-mtl-mc-ccs
[244.298795] Subtest pipe-B-ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.023s)
[245.130282] [064/143] (777s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[245.206493] Starting subtest: psr-rgb565-draw-blt
[250.230881] Subtest psr-rgb565-draw-blt: SUCCESS (5.027s)
[250.350130] [065/143] (772s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[250.411656] Starting subtest: plane-scaler-unity-scaling-with-rotation
[250.414463] Starting dynamic subtest: pipe-A-eDP-1
[250.883421] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.472s)
[250.903714] Starting dynamic subtest: pipe-B-eDP-1
[252.556604] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.669s)
[252.574157] Starting dynamic subtest: pipe-C-eDP-1
[254.264491] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.706s)
[254.285908] Starting dynamic subtest: pipe-D-eDP-1
[256.048341] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.780s)
[256.050934] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (5.639s)
[257.333240] [066/143] (765s left) kms_plane_lowres (tiling-x)
[257.406350] Starting subtest: tiling-x
[257.409096] Starting dynamic subtest: pipe-A-eDP-1
[257.414650] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[257.705664] Starting dynamic subtest: pipe-B-eDP-1
[257.711041] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[257.719307] Starting dynamic subtest: pipe-C-eDP-1
[257.724110] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[257.731999] Starting dynamic subtest: pipe-D-eDP-1
[257.736666] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[257.741350] Subtest tiling-x: SKIP (0.301s)
[258.606584] [067/143] (764s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[258.677384] Starting subtest: single-wait-all-for-submit-unsubmitted
[258.778293] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[258.855471] [068/143] (764s left) kms_flip (nonexisting-fb-interruptible)
[258.949090] Starting subtest: nonexisting-fb-interruptible
[258.951604] Starting dynamic subtest: A-eDP1
[260.272034] Dynamic subtest A-eDP1: SUCCESS (1.324s)
[260.289343] Starting dynamic subtest: B-eDP1
[261.519505] Dynamic subtest B-eDP1: SUCCESS (1.246s)
[261.537362] Starting dynamic subtest: C-eDP1
[262.734630] Dynamic subtest C-eDP1: SUCCESS (1.214s)
[262.750426] Starting dynamic subtest: D-eDP1
[263.950391] Dynamic subtest D-eDP1: SUCCESS (1.214s)
[263.958145] Subtest nonexisting-fb-interruptible: SUCCESS (5.013s)
[265.204197] [069/143] (757s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[265.320940] Starting subtest: flip-vs-cursor-busy-crc-atomic
[266.233326] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.914s)
[267.119233] [070/143] (755s left) kms_ccs (pipe-d-bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[267.546748] Starting subtest: pipe-D-bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[267.552548] Subtest pipe-D-bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[268.406111] [071/143] (754s left) kms_ccs (pipe-d-crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[268.823886] Starting subtest: pipe-D-crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[268.830038] Subtest pipe-D-crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[269.686387] [072/143] (753s left) kms_ccs (pipe-b-crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[270.101943] Starting subtest: pipe-B-crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[270.108041] Subtest pipe-B-crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[270.964506] [073/143] (752s left) kms_ccs (pipe-a-crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[271.341901] Starting subtest: pipe-A-crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[271.346901] Subtest pipe-A-crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[272.248708] [074/143] (750s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[272.335800] Starting subtest: basic-busy-flip-before-cursor-varying-size
[272.341633] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[272.398860] [075/143] (750s left) gem_softpin (safe-alignment)
[272.451875] Starting subtest: safe-alignment
[272.491258] Subtest safe-alignment: SUCCESS (0.040s)
[274.467102] [076/143] (748s left) vc4/vc4_purgeable_bo (mark-unpurgeable-twice)
[274.594650] Subtest mark-unpurgeable-twice: SKIP (0.000s)
[274.649878] [077/143] (748s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[274.715905] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[274.720125] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[274.808183] [078/143] (748s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[274.891408] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[274.896192] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[274.985796] [079/143] (748s left) kms_cursor_crc (cursor-onscreen-64x64)
[275.171586] Starting subtest: cursor-onscreen-64x64
[275.179361] Starting dynamic subtest: pipe-A-eDP-1
[277.649041] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.472s)
[277.686484] Starting dynamic subtest: pipe-D-eDP-1
[280.892618] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.217s)
[280.895276] Subtest cursor-onscreen-64x64: SUCCESS (5.721s)
[281.773223] [080/143] (741s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[282.131637] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[283.030406] [081/143] (740s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[283.116861] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[283.121512] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[283.202609] [082/143] (740s left) syncobj_timeline (reset-during-wait-for-submit)
[283.267477] Starting subtest: reset-during-wait-for-submit
[283.366101] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[283.442912] [083/143] (740s left) gem_ctx_exec (basic)
[283.508902] Starting subtest: basic
[283.519287] Subtest basic: SUCCESS (0.011s)
[283.624928] [084/143] (739s left) gem_render_copy_redux (flink)
[283.687498] Starting subtest: flink
[284.715061] Subtest flink: SUCCESS (1.034s)
[284.816857] [085/143] (738s left) gem_busy (close-race)
[284.862279] Starting subtest: close-race
[308.478598] Subtest close-race: SUCCESS (23.617s)
[308.841499] [086/143] (714s left) perf_pmu (busy-hang)
[308.982192] Starting subtest: busy-hang
[308.984541] Starting dynamic subtest: rcs0
[310.231603] Dynamic subtest rcs0: SUCCESS (1.251s)
[310.250984] Starting dynamic subtest: bcs0
[311.475270] Dynamic subtest bcs0: SUCCESS (1.243s)
[311.493499] Starting dynamic subtest: vcs0
[313.977711] Dynamic subtest vcs0: SUCCESS (2.501s)
[313.995994] Starting dynamic subtest: vcs1
[315.963368] Dynamic subtest vcs1: SUCCESS (1.985s)
[315.981779] Starting dynamic subtest: vecs0
[317.938724] Dynamic subtest vecs0: SUCCESS (1.974s)
[317.956901] Starting dynamic subtest: ccs0
[319.200960] Dynamic subtest ccs0: SUCCESS (1.262s)
[319.203751] Subtest busy-hang: SUCCESS (10.223s)
[319.283207] [087/143] (704s left) kms_plane_scaling (planes-scaler-unity-scaling)
[319.352658] Starting subtest: planes-scaler-unity-scaling
[319.355195] Starting dynamic subtest: pipe-A-eDP-1
[319.424169] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.072s)
[319.444419] Starting dynamic subtest: pipe-B-eDP-1
[320.637520] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.210s)
[320.658617] Starting dynamic subtest: pipe-C-eDP-1
[321.830050] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.188s)
[321.848579] Starting dynamic subtest: pipe-D-eDP-1
[323.045624] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.213s)
[323.048680] Subtest planes-scaler-unity-scaling: SUCCESS (3.696s)
[324.342822] [088/143] (699s left) kms_cursor_crc (cursor-sliding-64x64)
[324.508131] Starting subtest: cursor-sliding-64x64
[324.514050] Starting dynamic subtest: pipe-A-eDP-1
[328.403878] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.891s)
[328.444099] Starting dynamic subtest: pipe-D-eDP-1
[332.933854] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.503s)
[332.936331] Subtest cursor-sliding-64x64: SUCCESS (8.423s)
[333.814514] [089/143] (689s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[333.884955] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[333.889056] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[333.973091] [090/143] (689s left) gem_mmap (short-mmap)
[334.022865] Subtest short-mmap: SKIP (0.000s)
[334.053745] [091/143] (689s left) kms_psr2_su (page_flip-xrgb8888)
[334.092867] Subtest page_flip-XRGB8888: SKIP (0.000s)
[334.131915] [092/143] (689s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[334.214269] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[334.218299] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[334.313653] [093/143] (689s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[334.385993] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[334.390059] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[334.463870] [094/143] (689s left) i915_query (query-topology-unsupported)
[334.514578] Starting subtest: query-topology-unsupported
[334.518386] Subtest query-topology-unsupported: SKIP (0.000s)
[334.588380] [095/143] (689s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[334.696737] Starting subtest: yf-tiled-64bpp-rotate-0
[334.701255] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[334.778944] [096/143] (689s left) kms_atomic_interruptible (atomic-setmode)
[334.834629] Starting subtest: atomic-setmode
[334.836698] Starting dynamic subtest: pipe-A-eDP-1
[341.804965] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.966s)
[341.807732] Subtest atomic-setmode: SUCCESS (6.967s)
[342.709943] [097/143] (681s left) kms_ccs (pipe-b-bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[343.151242] Starting subtest: pipe-B-bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[343.153944] Subtest pipe-B-bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.000s)
[343.981647] [098/143] (679s left) gem_mmap_offset (bad-object)
[344.042671] Starting subtest: bad-object
[344.045227] Subtest bad-object: SUCCESS (0.003s)
[344.141525] [099/143] (679s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[344.225254] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[349.221869] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (4.998s)
[349.354985] [100/143] (674s left) sysfs_heartbeat_interval (nopreempt)
[349.405687] Starting subtest: nopreempt
[349.408437] Starting dynamic subtest: vecs0
[359.473148] Dynamic subtest vecs0: SUCCESS (10.063s)
[359.492199] Starting dynamic subtest: ccs0
[363.331927] Dynamic subtest ccs0: SUCCESS (3.860s)
[363.346858] Starting dynamic subtest: vcs0
[372.462980] Dynamic subtest vcs0: SUCCESS (9.127s)
[372.481773] Starting dynamic subtest: bcs0
[376.431085] Dynamic subtest bcs0: SUCCESS (3.969s)
[376.444975] Starting dynamic subtest: rcs0
[380.264064] Dynamic subtest rcs0: SUCCESS (3.831s)
[380.283646] Starting dynamic subtest: vcs1
[389.423131] Dynamic subtest vcs1: SUCCESS (9.154s)
[389.426076] Subtest nopreempt: SUCCESS (40.014s)
[389.499317] [101/143] (634s left) kms_lease (simple-lease)
[389.593898] Starting subtest: simple-lease
[389.596426] Starting dynamic subtest: pipe-A-eDP-1
[390.093051] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.496s)
[390.112197] Starting dynamic subtest: pipe-B-eDP-1
[391.653860] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.557s)
[391.672702] Starting dynamic subtest: pipe-C-eDP-1
[393.186964] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.532s)
[393.205979] Starting dynamic subtest: pipe-D-eDP-1
[394.710887] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.521s)
[394.714935] Subtest simple-lease: SUCCESS (5.119s)
[395.636806] [102/143] (628s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[395.729639] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[395.734269] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[395.820520] [103/143] (628s left) vgem_basic (dmabuf-mmap)
[395.888722] Starting subtest: dmabuf-mmap
[395.907311] Subtest dmabuf-mmap: SUCCESS (0.020s)
[395.965634] [104/143] (628s left) gem_exec_params (batch-first)
[396.033765] Starting subtest: batch-first
[396.043503] Subtest batch-first: SUCCESS (0.011s)
[396.145330] [105/143] (628s left) gem_mmap_gtt (close-race)
[396.220199] Subtest close-race: SKIP (0.000s)
[396.249343] [106/143] (627s left) kms_rmfb (rmfb-ioctl)
[396.356672] Starting subtest: rmfb-ioctl
[396.359121] Starting dynamic subtest: pipe-A-eDP-1
[396.463764] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.109s)
[396.485318] Starting dynamic subtest: pipe-B-eDP-1
[397.726427] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.259s)
[397.743199] Starting dynamic subtest: pipe-C-eDP-1
[399.006234] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.278s)
[399.021646] Starting dynamic subtest: pipe-D-eDP-1
[400.274753] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.265s)
[400.277334] Subtest rmfb-ioctl: SUCCESS (3.921s)
[401.525859] [107/143] (622s left) i915_query (hwconfig_table)
[401.589103] Starting subtest: hwconfig_table
[401.899893] Subtest hwconfig_table: SUCCESS (0.002s)
[401.928416] [108/143] (622s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[402.329255] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[403.223722] [109/143] (621s left) kms_chamelium_edid (hdmi-mode-timings)
[403.620771] Subtest hdmi-mode-timings: SKIP (0.000s)
[404.505187] [110/143] (619s left) kms_psr (psr-sprite-plane-onoff)
[404.587350] Starting subtest: psr-sprite-plane-onoff
[404.589992] Starting dynamic subtest: eDP-1
[406.480064] Dynamic subtest eDP-1: SUCCESS (1.888s)
[406.482932] Subtest psr-sprite-plane-onoff: SUCCESS (1.891s)
[407.414295] [111/143] (616s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[407.499886] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[407.502611] Starting dynamic subtest: pipe-A-default-mode
[407.799063] Dynamic subtest pipe-A-default-mode: SKIP (0.291s)
[407.804983] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.294s)
[408.691775] [112/143] (615s left) api_intel_bb (add-remove-objects)
[408.745843] Starting subtest: add-remove-objects
[408.752034] Subtest add-remove-objects: SUCCESS (0.010s)
[408.851962] [113/143] (615s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[408.951620] Starting subtest: x-tiled-32bpp-rotate-90
[408.969508] Subtest x-tiled-32bpp-rotate-90: SKIP (0.018s)
[409.070676] [114/143] (615s left) gem_exec_params (invalid-ring)
[409.112261] Starting subtest: invalid-ring
[409.114661] Subtest invalid-ring: SUCCESS (0.000s)
[409.200890] [115/143] (615s left) kms_vrr (flipline)
[409.275362] Starting subtest: flipline
[409.280149] Subtest flipline: SKIP (0.000s)
[409.340101] [116/143] (615s left) kms_fence_pin_leak
[409.465628] [117/143] (615s left) drm_fdinfo (busy)
[409.529373] Starting subtest: busy
[409.532147] Starting dynamic subtest: rcs0
[409.537194] Dynamic subtest rcs0: SKIP (0.000s)
[409.554950] Starting dynamic subtest: bcs0
[409.559362] Dynamic subtest bcs0: SKIP (0.000s)
[409.572226] Starting dynamic subtest: vcs0
[409.576858] Dynamic subtest vcs0: SKIP (0.000s)
[409.586647] Starting dynamic subtest: vcs1
[409.591252] Dynamic subtest vcs1: SKIP (0.000s)
[409.599954] Starting dynamic subtest: vecs0
[409.604532] Dynamic subtest vecs0: SKIP (0.000s)
[409.612736] Starting dynamic subtest: ccs0
[409.617224] Dynamic subtest ccs0: SKIP (0.000s)
[409.621267] Subtest busy: SKIP (0.002s)
[409.639334] [118/143] (614s left) syncobj_eventfd (invalid-bad-flags)
[409.692958] Starting subtest: invalid-bad-flags
[409.694626] Subtest invalid-bad-flags: SUCCESS (0.000s)
[409.757938] [119/143] (614s left) dumb_buffer (invalid-bpp)
[409.815137] Starting subtest: invalid-bpp
[409.816816] Subtest invalid-bpp: SUCCESS (0.000s)
[409.870238] [120/143] (614s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[409.924794] Starting subtest: yf-tiled-ccs-to-x-tiled
[409.929132] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[410.112162] [121/143] (614s left) kms_addfb_basic (size-max)
[410.190628] Starting subtest: size-max
[410.193087] Subtest size-max: SUCCESS (0.000s)
[410.274805] [122/143] (614s left) kms_psr (pr-no-drrs)
[410.339193] Starting subtest: pr-no-drrs
[410.344459] Subtest pr-no-drrs: SKIP (0.000s)
[410.437884] [123/143] (614s left) gem_create (create-ext-cpu-access-big)
[410.604807] Starting subtest: create-ext-cpu-access-big
[410.609907] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[410.680116] [124/143] (614s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[411.246966] Starting subtest: syncobj-stationary-timeline-chain-engines
[411.445079] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.198s)
[412.552841] [125/143] (612s left) kms_ccs (pipe-c-crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[412.941291] Starting subtest: pipe-C-crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[412.946557] Subtest pipe-C-crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[413.813120] [126/143] (611s left) gem_vm_create (create-ext)
[413.867199] Starting subtest: create-ext
[413.873101] Subtest create-ext: SUCCESS (0.007s)
[413.978554] [127/143] (610s left) kms_flip (flip-vs-suspend)
[414.067373] Starting subtest: flip-vs-suspend
[414.072597] Starting dynamic subtest: A-eDP1
[464.558614] Dynamic subtest A-eDP1: SUCCESS (4.705s)
[464.577470] Starting dynamic subtest: B-eDP1
[513.546998] Dynamic subtest B-eDP1: SUCCESS (4.620s)
[513.565905] Starting dynamic subtest: C-eDP1
[562.566948] Dynamic subtest C-eDP1: SUCCESS (4.645s)
[562.585221] Starting dynamic subtest: D-eDP1
[611.531463] Dynamic subtest D-eDP1: SUCCESS (4.582s)
[611.540257] Subtest flip-vs-suspend: SUCCESS (18.575s)
[612.816085] [128/143] (590s left) gem_exec_fair (basic-pace-solo)
[612.914377] Subtest basic-pace-solo: SKIP (0.000s)
[612.954285] [129/143] (590s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[613.010194] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[613.014753] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[613.075003] [130/143] (590s left) gem_partial_pwrite_pread (reads-uncached)
[613.135344] Subtest reads-uncached: SKIP (0.000s)
[613.186157] [131/143] (590s left) core_getclient
[613.308173] [132/143] (590s left) kms_ccs (pipe-d-ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[613.730237] Starting subtest: pipe-D-ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[613.732799] Subtest pipe-D-ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.000s)
[614.566365] [133/143] (589s left) kms_psr (pr-suspend)
[614.636814] Starting subtest: pr-suspend
[614.641664] Subtest pr-suspend: SKIP (0.000s)
[614.763101] [134/143] (589s left) kms_flip (modeset-vs-vblank-race-interruptible)
[614.838107] Starting subtest: modeset-vs-vblank-race-interruptible
[614.845204] Starting dynamic subtest: A-eDP1
[619.848264] Dynamic subtest A-eDP1: SUCCESS (5.003s)
[619.871374] Starting dynamic subtest: B-eDP1
[624.902284] Dynamic subtest B-eDP1: SUCCESS (5.052s)
[624.923095] Starting dynamic subtest: C-eDP1
[629.809270] Dynamic subtest C-eDP1: SUCCESS (4.905s)
[629.828704] Starting dynamic subtest: D-eDP1
[634.800655] Dynamic subtest D-eDP1: SUCCESS (4.990s)
[634.810087] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (19.972s)
[636.113676] [135/143] (567s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[636.205962] Starting subtest: fbcpsr-tiling-linear
[640.934122] Subtest fbcpsr-tiling-linear: SUCCESS (4.730s)
[641.058686] [136/143] (562s left) gem_exec_schedule (preemptive-hang)
[641.248229] Starting subtest: preemptive-hang
[641.250907] Starting dynamic subtest: rcs0
[650.642292] Dynamic subtest rcs0: SUCCESS (9.391s)
[650.649690] Starting dynamic subtest: bcs0
[659.611990] Dynamic subtest bcs0: SUCCESS (8.969s)
[659.619420] Starting dynamic subtest: vcs0
[668.630109] Dynamic subtest vcs0: SUCCESS (9.015s)
[668.651663] Starting dynamic subtest: vcs1
[677.655328] Dynamic subtest vcs1: SUCCESS (9.024s)
[677.676554] Starting dynamic subtest: vecs0
[686.615171] Dynamic subtest vecs0: SUCCESS (8.961s)
[686.623045] Starting dynamic subtest: ccs0
[695.632000] Dynamic subtest ccs0: SUCCESS (9.016s)
[695.634509] Subtest preemptive-hang: SUCCESS (54.382s)
[695.880642] [137/143] (508s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[695.947865] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[695.967975] [138/143] (508s left) i915_pm_rpm (debugfs-forcewake-user)
[697.506721] Starting subtest: debugfs-forcewake-user
[711.506390] Subtest debugfs-forcewake-user: SUCCESS (13.999s)
[711.908851] [139/143] (492s left) kms_pm_rpm (dpms-non-lpsp)
[713.549641] Starting subtest: dpms-non-lpsp
[713.555930] Subtest dpms-non-lpsp: SKIP (0.001s)
[714.253759] [140/143] (489s left) gem_ctx_shared (single-timeline)
[714.325400] Starting subtest: single-timeline
[714.345326] Subtest single-timeline: SUCCESS (0.014s)
[714.563506] [141/143] (489s left) vgem_basic (unload)
[714.616001] Starting subtest: unload
[743.617729] Subtest unload: SUCCESS (28.950s)
[743.674426] [142/143] (460s left) api_intel_bb (reset-flags)
[743.724207] Starting subtest: reset-flags
[743.733536] Subtest reset-flags: SUCCESS (0.013s)
[743.829712] [143/143] (460s left) kms_pm_rpm (pm-caching)
[745.548474] Starting subtest: pm-caching
[745.554616] Subtest pm-caching: SKIP (0.000s)
[746.136271] Closing watchdogs
Done.