[38.078951] Initializing watchdogs
[38.078978]   /dev/watchdog0
[38.086388] [001/130] (960s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[38.185815] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[38.188248] Starting dynamic subtest: pipe-A-eDP-1
[38.210927] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[38.218039] Starting dynamic subtest: pipe-B-eDP-1
[38.240104] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[38.245423] Starting dynamic subtest: pipe-C-eDP-1
[38.267339] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[38.272466] Starting dynamic subtest: pipe-D-eDP-1
[38.294976] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[38.299536] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.002s)
[38.312691] [002/130] (960s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[38.398819] Starting subtest: coverage-vs-premult-vs-constant
[38.668699] Starting dynamic subtest: pipe-A-eDP-1
[39.207273] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.538s)
[39.214905] Starting dynamic subtest: pipe-D-eDP-1
[40.534469] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[40.537593] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.132s)
[41.421108] [003/130] (957s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[41.521863] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[41.526332] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[41.588237] [004/130] (957s left) api_intel_allocator (reserve-simple)
[41.638812] Starting subtest: reserve-simple
[41.644216] Subtest reserve-simple: SUCCESS (0.004s)
[41.711812] [005/130] (956s left) kms_cursor_crc (cursor-offscreen-256x256)
[41.902199] Starting subtest: cursor-offscreen-256x256
[41.904807] Starting dynamic subtest: pipe-A-eDP-1
[43.818645] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.917s)
[43.839920] Starting dynamic subtest: pipe-D-eDP-1
[46.462170] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.627s)
[46.464680] Subtest cursor-offscreen-256x256: SUCCESS (4.561s)
[47.319611] [006/130] (951s left) gem_exec_flush (basic-uc-prw-default)
[47.371137] Starting subtest: basic-uc-prw-default
[52.802296] Subtest basic-uc-prw-default: SUCCESS (5.421s)
[52.955016] [007/130] (945s left) gem_mmap_wc (write-prefaulted)
[53.002572] Subtest write-prefaulted: SKIP (0.000s)
[53.036062] [008/130] (945s left) kms_invalid_mode (bad-hsync-end)
[53.132050] Starting subtest: bad-hsync-end
[53.134301] Starting dynamic subtest: pipe-A-eDP-1
[53.412257] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.281s)
[53.418194] Starting dynamic subtest: pipe-B-eDP-1
[53.420256] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[53.424863] Starting dynamic subtest: pipe-C-eDP-1
[53.426876] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[53.431649] Starting dynamic subtest: pipe-D-eDP-1
[53.434084] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[53.436984] Subtest bad-hsync-end: SUCCESS (0.284s)
[54.281189] [009/130] (944s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[54.384175] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[55.339167] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (0.955s)
[55.443118] [010/130] (943s left) gem_mmap_gtt (cpuset-big-copy-odd)
[55.496700] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[55.530540] [011/130] (943s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[55.579915] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[55.619168] [012/130] (943s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[55.709474] Starting subtest: fb-8bpc-vs-panel-6bpc
[55.711392] Starting dynamic subtest: pipe-A-eDP-1
[57.165046] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.453s)
[57.167320] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.454s)
[58.056319] [013/130] (940s left) kms_setmode (clone-exclusive-crtc)
[58.106740] Starting subtest: clone-exclusive-crtc
[58.114461] Subtest clone-exclusive-crtc: SKIP (0.001s)
[58.167553] [014/130] (940s left) i915_pm_rpm (system-suspend)
[59.483371] Starting subtest: system-suspend
[81.552628] Subtest system-suspend: SUCCESS (7.813s)
[82.343056] [015/130] (930s left) syncobj_wait (single-wait-submitted)
[82.389444] Starting subtest: single-wait-submitted
[82.497350] Subtest single-wait-submitted: SUCCESS (0.106s)
[82.546819] [016/130] (930s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[82.661759] Starting subtest: basic-flip-after-cursor-varying-size
[83.577363] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.915s)
[84.471580] [017/130] (928s left) kms_pm_rpm (legacy-planes)
[86.786334] Starting subtest: legacy-planes
[86.789852] Starting dynamic subtest: plane-41
[110.755800] Dynamic subtest plane-41: SUCCESS (23.967s)
[110.764804] Starting dynamic subtest: plane-50
[135.174382] Dynamic subtest plane-50: SUCCESS (24.417s)
[135.180775] Starting dynamic subtest: plane-59
[159.859675] Dynamic subtest plane-59: SUCCESS (24.682s)
[159.868733] Starting dynamic subtest: plane-68
[184.384453] Dynamic subtest plane-68: SUCCESS (24.524s)
[184.387432] Subtest legacy-planes: SUCCESS (97.593s)
[185.201251] [018/130] (827s left) gem_partial_pwrite_pread (write)
[185.261142] Subtest write: SKIP (0.000s)
[185.304432] [019/130] (827s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[185.400929] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[185.405131] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[185.466595] [020/130] (827s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[185.557694] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[190.057313] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (4.503s)
[190.169834] [021/130] (822s left) kms_psr (pr-sprite-render)
[190.273117] Starting subtest: pr-sprite-render
[190.277641] Subtest pr-sprite-render: SKIP (0.000s)
[190.320935] [022/130] (822s left) kms_chamelium_audio (dp-audio)
[190.698683] Subtest dp-audio: SKIP (0.000s)
[191.588150] [023/130] (821s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[191.680222] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[191.682866] Starting dynamic subtest: pipe-A-eDP-1
[191.746535] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[191.754365] Starting dynamic subtest: pipe-B-eDP-1
[191.812542] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[191.820078] Starting dynamic subtest: pipe-C-eDP-1
[191.878032] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[191.886174] Starting dynamic subtest: pipe-D-eDP-1
[191.945169] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[191.949497] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.005s)
[191.963995] [024/130] (821s left) gem_exec_whisper (basic-normal-all)
[192.021711] Starting subtest: basic-normal-all
[194.168635] Subtest basic-normal-all: SUCCESS (2.145s)
[194.324670] [025/130] (818s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[194.385134] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[194.387765] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[194.441954] [026/130] (818s left) gem_exec_flush (basic-uc-set-default)
[194.497334] Starting subtest: basic-uc-set-default
[199.929641] Subtest basic-uc-set-default: SUCCESS (5.428s)
[200.086534] [027/130] (813s left) kms_atomic (plane-invalid-params-fence)
[200.179066] Starting subtest: plane-invalid-params-fence
[200.181443] Starting dynamic subtest: pipe-A-eDP-1
[200.530911] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.351s)
[200.533347] Subtest plane-invalid-params-fence: SUCCESS (0.351s)
[201.396306] [028/130] (811s left) sriov_basic (enable-vfs-autoprobe-off)
[201.446622] Subtest enable-vfs-autoprobe-off: SKIP (0.000s)
[201.485190] [029/130] (811s left) gem_exec_schedule (semaphore-codependency)
[201.546695] Starting subtest: semaphore-codependency
[201.548975] Subtest semaphore-codependency: SUCCESS (0.011s)
[201.875783] [030/130] (811s left) gem_ctx_shared (detached-shared-gtt)
[201.927803] Starting subtest: detached-shared-gtt
[204.081643] Subtest detached-shared-gtt: SUCCESS (2.152s)
[204.417267] [031/130] (808s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[204.508138] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[204.510343] Starting dynamic subtest: pipe-A-default-mode
[205.701205] Dynamic subtest pipe-A-default-mode: SKIP (1.188s)
[205.706144] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.189s)
[205.808041] [032/130] (807s left) gem_mmap_gtt (basic-small-copy-xy)
[205.859855] Subtest basic-small-copy-XY: SKIP (0.000s)
[205.902642] [033/130] (807s left) gem_ctx_shared (q-smoketest-all)
[205.948325] Starting subtest: Q-smoketest-all
[238.306116] Subtest Q-smoketest-all: SUCCESS (32.306s)
[239.740122] [034/130] (773s left) kms_cursor_crc (cursor-sliding-32x32)
[239.859155] Starting subtest: cursor-sliding-32x32
[239.895972] Subtest cursor-sliding-32x32: SKIP (0.031s)
[240.129933] [035/130] (773s left) kms_chamelium_frames (dp-crc-fast)
[240.503305] Subtest dp-crc-fast: SKIP (0.000s)
[241.382480] [036/130] (771s left) gem_ctx_bad_destroy (invalid-pad)
[241.427989] Starting subtest: invalid-pad
[241.430881] Subtest invalid-pad: SUCCESS (0.000s)
[241.467130] [037/130] (771s left) perf_pmu (multi-client)
[241.498504] Starting subtest: multi-client
[241.500900] Starting dynamic subtest: rcs0
[242.530245] Dynamic subtest rcs0: SUCCESS (1.030s)
[242.540257] Starting dynamic subtest: bcs0
[243.577379] Dynamic subtest bcs0: SUCCESS (1.046s)
[243.588545] Starting dynamic subtest: vcs0
[244.624838] Dynamic subtest vcs0: SUCCESS (1.047s)
[244.634759] Starting dynamic subtest: vcs1
[246.669430] Dynamic subtest vcs1: SUCCESS (2.044s)
[246.678990] Starting dynamic subtest: vecs0
[248.652149] Dynamic subtest vecs0: SUCCESS (1.982s)
[248.663033] Starting dynamic subtest: ccs0
[250.635126] Dynamic subtest ccs0: SUCCESS (1.982s)
[250.637911] Subtest multi-client: SUCCESS (9.136s)
[250.727150] [038/130] (762s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[250.836693] Starting subtest: extended-modeset-hang-newfb-with-reset
[250.838895] Starting dynamic subtest: pipe-A
[265.326574] Dynamic subtest pipe-A: SUCCESS (14.488s)
[265.337130] Starting dynamic subtest: pipe-D
[281.714266] Dynamic subtest pipe-D: SUCCESS (16.385s)
[281.716729] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (30.876s)
[282.617867] [039/130] (730s left) kms_properties (connector-properties-atomic)
[282.712107] Starting subtest: connector-properties-atomic
[282.714529] Starting dynamic subtest: pipe-A-eDP-1
[291.225922] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.512s)
[291.232626] Starting dynamic subtest: pipe-None-DP-1
[291.237401] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[291.243299] Starting dynamic subtest: pipe-None-HDMI-A-1
[291.247613] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[291.254100] Starting dynamic subtest: pipe-None-DP-2
[291.258434] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[291.264249] Starting dynamic subtest: pipe-None-HDMI-A-2
[291.268665] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[291.274560] Starting dynamic subtest: pipe-None-DP-3
[291.279028] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[291.284779] Starting dynamic subtest: pipe-None-DP-4
[291.289118] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[291.291398] Subtest connector-properties-atomic: SUCCESS (8.519s)
[292.085541] [040/130] (721s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[292.183128] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[292.185653] Starting dynamic subtest: pipe-A
[292.195238] Dynamic subtest pipe-A: SKIP (0.004s)
[292.203574] Starting dynamic subtest: pipe-B
[292.212774] Dynamic subtest pipe-B: SKIP (0.016s)
[292.219112] Starting dynamic subtest: pipe-C
[292.228668] Dynamic subtest pipe-C: SKIP (0.015s)
[292.236338] Starting dynamic subtest: pipe-D
[292.243546] Dynamic subtest pipe-D: SKIP (0.013s)
[292.247077] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.048s)
[292.297880] [041/130] (721s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[292.389097] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[292.391416] Starting dynamic subtest: pipe-A-default-mode
[292.676188] Dynamic subtest pipe-A-default-mode: SKIP (0.281s)
[292.681431] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.282s)
[293.557673] [042/130] (719s left) gem_exec_fair (basic-none)
[293.627484] Subtest basic-none: SKIP (0.000s)
[293.656147] [043/130] (719s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[293.745357] Starting subtest: y-tiled-8bpp-rotate-270
[293.749796] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[293.804777] [044/130] (719s left) kms_chamelium_hpd (dp-hpd-fast)
[294.178059] Subtest dp-hpd-fast: SKIP (0.000s)
[295.076170] [045/130] (718s left) gem_ringfill (basic-all)
[300.633494] Starting subtest: basic-all
[301.796475] Subtest basic-all: SUCCESS (1.164s)
[301.895941] [046/130] (711s left) gen7_exec_parse (oacontrol-tracking)
[301.963326] Subtest oacontrol-tracking: SKIP (0.000s)
[302.000336] [047/130] (711s left) i915_query (query-regions-sanity-check)
[302.050652] Starting subtest: query-regions-sanity-check
[302.060343] Subtest query-regions-sanity-check: SUCCESS (0.010s)
[302.157785] [048/130] (711s left) gem_close_race (basic-process)
[302.208271] Starting subtest: basic-process
[302.271429] Subtest basic-process: SUCCESS (0.062s)
[302.431709] [049/130] (711s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[302.531181] Starting subtest: psr-rgb101010-draw-render
[307.426811] Subtest psr-rgb101010-draw-render: SUCCESS (4.899s)
[307.544027] [050/130] (706s left) kms_lease (setcrtc-implicit-plane)
[307.629152] Starting subtest: setcrtc-implicit-plane
[307.631534] Starting dynamic subtest: pipe-A-eDP-1
[308.060541] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.429s)
[308.069727] Starting dynamic subtest: pipe-B-eDP-1
[309.228351] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.167s)
[309.239760] Starting dynamic subtest: pipe-C-eDP-1
[310.438340] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.208s)
[310.445529] Starting dynamic subtest: pipe-D-eDP-1
[311.656369] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.217s)
[311.658810] Subtest setcrtc-implicit-plane: SUCCESS (4.025s)
[312.569343] [051/130] (701s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[312.665774] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[312.670095] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[312.735470] [052/130] (700s left) gem_ctx_engines (invalid-engines)
[312.793515] Starting subtest: invalid-engines
[312.800299] Subtest invalid-engines: SUCCESS (0.007s)
[313.015252] [053/130] (700s left) i915_hangman (engine-engine-error)
[313.070242] Starting subtest: engine-engine-error
[313.072610] Starting dynamic subtest: rcs0
[314.610966] Dynamic subtest rcs0: SUCCESS (1.539s)
[314.618437] Starting dynamic subtest: bcs0
[316.594798] Dynamic subtest bcs0: SUCCESS (1.983s)
[316.603816] Starting dynamic subtest: vcs0
[318.578913] Dynamic subtest vcs0: SUCCESS (1.983s)
[318.586069] Starting dynamic subtest: vcs1
[320.562994] Dynamic subtest vcs1: SUCCESS (1.983s)
[320.573154] Starting dynamic subtest: vecs0
[322.610964] Dynamic subtest vecs0: SUCCESS (2.047s)
[322.620691] Starting dynamic subtest: ccs0
[324.595853] Dynamic subtest ccs0: SUCCESS (1.983s)
[324.598890] Subtest engine-engine-error: SUCCESS (11.524s)
[324.650880] [054/130] (688s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[324.755340] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[324.760013] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[324.827309] [055/130] (688s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[324.877522] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[324.985486] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[325.038036] [056/130] (688s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[325.079321] Starting subtest: multi-wait-available-unsubmitted-signaled
[325.082085] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[325.152597] [057/130] (688s left) gem_mmap_gtt (basic-read-write-distinct)
[325.200777] Subtest basic-read-write-distinct: SKIP (0.000s)
[325.224304] [058/130] (688s left) kms_fbcon_fbt (psr)
[325.266335] Starting subtest: psr
[330.726806] Subtest psr: SUCCESS (5.456s)
[330.775290] [059/130] (682s left) kms_psr (fbc-psr-primary-blt)
[330.858499] Starting subtest: fbc-psr-primary-blt
[330.861324] Starting dynamic subtest: eDP-1
[330.866701] Dynamic subtest eDP-1: SKIP (0.000s)
[330.872093] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[330.908230] [060/130] (682s left) gem_mmap_wc (write-read)
[330.955606] Subtest write-read: SKIP (0.000s)
[330.994922] [061/130] (682s left) gem_ctx_param (set-priority-not-supported)
[331.044057] Starting subtest: set-priority-not-supported
[331.048627] Subtest set-priority-not-supported: SKIP (0.000s)
[331.084348] [062/130] (682s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[331.190316] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[331.194842] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[331.264071] [063/130] (682s left) kms_color (ctm-blue-to-red)
[331.347045] Starting subtest: ctm-blue-to-red
[331.349390] Starting dynamic subtest: pipe-A-eDP-1
[331.990976] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.640s)
[331.998534] Starting dynamic subtest: pipe-B-eDP-1
[333.404378] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.413s)
[333.413709] Starting dynamic subtest: pipe-C-eDP-1
[334.743017] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.338s)
[334.751257] Starting dynamic subtest: pipe-D-eDP-1
[336.088696] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.345s)
[336.091334] Subtest ctm-blue-to-red: SUCCESS (4.740s)
[336.951489] [064/130] (676s left) syncobj_timeline (wait-any-interrupted)
[337.001408] Starting subtest: wait-any-interrupted
[337.104920] Subtest wait-any-interrupted: SUCCESS (0.103s)
[337.161428] [065/130] (676s left) perf (non-zero-reason)
[337.299118] Starting subtest: non-zero-reason
[337.301610] Starting dynamic subtest: 0-rcs0
[342.902918] Dynamic subtest 0-rcs0: SUCCESS (5.602s)
[342.913525] Starting dynamic subtest: 1-vcs0
[346.901712] Dynamic subtest 1-vcs0: SUCCESS (3.998s)
[346.904742] Subtest non-zero-reason: SUCCESS (9.601s)
[346.928969] [066/130] (666s left) kms_psr (fbc-psr2-primary-blt)
[347.013172] Starting subtest: fbc-psr2-primary-blt
[347.015435] Starting dynamic subtest: eDP-1
[347.019521] Dynamic subtest eDP-1: SKIP (0.000s)
[347.023620] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[347.064164] [067/130] (666s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[347.110933] Starting subtest: x-tiled-to-vebox-yf-tiled
[347.115181] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[347.266696] [068/130] (666s left) gem_mmap_gtt (basic-write-read-distinct)
[347.318905] Subtest basic-write-read-distinct: SKIP (0.000s)
[347.355689] [069/130] (666s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[347.400691] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[347.504896] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[347.557760] [070/130] (666s left) gem_exec_schedule (in-order)
[347.621869] Starting subtest: in-order
[347.624118] Starting dynamic subtest: rcs0
[347.709508] Dynamic subtest rcs0: SUCCESS (0.097s)
[347.719396] Starting dynamic subtest: vcs0
[347.780303] Dynamic subtest vcs0: SUCCESS (0.071s)
[347.789852] Starting dynamic subtest: vcs1
[347.851372] Dynamic subtest vcs1: SUCCESS (0.070s)
[347.859095] Starting dynamic subtest: vecs0
[347.923423] Dynamic subtest vecs0: SUCCESS (0.072s)
[347.931242] Starting dynamic subtest: ccs0
[348.005347] Dynamic subtest ccs0: SUCCESS (0.081s)
[348.008157] Subtest in-order: SUCCESS (0.392s)
[349.717067] [071/130] (664s left) gem_eio (wait-1us)
[349.916372] Starting subtest: wait-1us
[350.269766] Subtest wait-1us: SUCCESS (0.354s)
[350.394467] [072/130] (663s left) kms_universal_plane (cursor-fb-leak)
[350.481055] Starting subtest: cursor-fb-leak
[350.483407] Starting dynamic subtest: pipe-A-eDP-1
[350.779426] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s)
[350.787084] Starting dynamic subtest: pipe-B-eDP-1
[352.141743] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.360s)
[352.150486] Starting dynamic subtest: pipe-C-eDP-1
[353.485089] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.343s)
[353.491705] Starting dynamic subtest: pipe-D-eDP-1
[354.896945] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.407s)
[354.900033] Subtest cursor-fb-leak: SUCCESS (4.412s)
[356.150015] [073/130] (657s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[356.244344] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[360.824322] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.584s)
[360.915362] [074/130] (653s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[361.008118] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[361.010438] Starting dynamic subtest: pipe-A
[361.077926] Dynamic subtest pipe-A: SUCCESS (0.069s)
[361.085338] Starting dynamic subtest: pipe-B
[362.315514] Dynamic subtest pipe-B: SUCCESS (1.237s)
[362.324527] Starting dynamic subtest: pipe-C
[363.507537] Dynamic subtest pipe-C: SUCCESS (1.192s)
[363.516123] Starting dynamic subtest: pipe-D
[364.725143] Dynamic subtest pipe-D: SUCCESS (1.217s)
[364.727479] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.717s)
[365.944405] [075/130] (648s left) kms_draw_crc (draw-method-blt)
[366.038114] Starting subtest: draw-method-blt
[366.040323] Starting dynamic subtest: xrgb8888-untiled
[366.234330] Dynamic subtest xrgb8888-untiled: SUCCESS (0.198s)
[366.241752] Starting dynamic subtest: rgb565-untiled
[366.423236] Dynamic subtest rgb565-untiled: SUCCESS (0.188s)
[366.430546] Starting dynamic subtest: xrgb2101010-untiled
[366.601001] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.177s)
[366.608213] Starting dynamic subtest: xrgb8888-xtiled
[366.701167] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.099s)
[366.712072] Starting dynamic subtest: rgb565-xtiled
[366.790205] Dynamic subtest rgb565-xtiled: SUCCESS (0.089s)
[366.798298] Starting dynamic subtest: xrgb2101010-xtiled
[366.878565] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.089s)
[366.886301] Starting dynamic subtest: xrgb8888-4tiled
[366.978817] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.100s)
[366.985665] Starting dynamic subtest: rgb565-4tiled
[367.067313] Dynamic subtest rgb565-4tiled: SUCCESS (0.089s)
[367.075605] Starting dynamic subtest: xrgb2101010-4tiled
[367.156537] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.088s)
[367.158868] Subtest draw-method-blt: SUCCESS (1.121s)
[367.258893] [076/130] (646s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[367.350001] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[367.353846] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[367.421312] [077/130] (646s left) api_intel_bb (reset-bb)
[367.468104] Starting subtest: reset-bb
[367.469926] Subtest reset-bb: SUCCESS (0.004s)
[367.574459] [078/130] (646s left) gem_userptr_blits (set-cache-level)
[367.631856] Starting subtest: set-cache-level
[367.635627] Subtest set-cache-level: SKIP (0.000s)
[367.738741] [079/130] (646s left) kms_frontbuffer_tracking (basic)
[367.831058] Starting subtest: basic
[370.445240] Subtest basic: SUCCESS (2.616s)
[370.504459] [080/130] (643s left) gem_exec_store (cachelines)
[370.551717] Starting subtest: cachelines
[370.553723] Starting dynamic subtest: rcs0
[370.608935] Dynamic subtest rcs0: SUCCESS (0.057s)
[370.617689] Starting dynamic subtest: bcs0
[370.675077] Dynamic subtest bcs0: SUCCESS (0.065s)
[370.683970] Starting dynamic subtest: vcs0
[370.732119] Dynamic subtest vcs0: SUCCESS (0.056s)
[370.739429] Starting dynamic subtest: vcs1
[370.785000] Dynamic subtest vcs1: SUCCESS (0.052s)
[370.792074] Starting dynamic subtest: vecs0
[370.843681] Dynamic subtest vecs0: SUCCESS (0.058s)
[370.851165] Starting dynamic subtest: ccs0
[370.897207] Dynamic subtest ccs0: SUCCESS (0.052s)
[370.899925] Subtest cachelines: SUCCESS (0.346s)
[371.057527] [081/130] (642s left) gem_ctx_persistence (heartbeat-many)
[371.119692] Starting subtest: heartbeat-many
[371.125222] Subtest heartbeat-many: SKIP (0.000s)
[371.200749] [082/130] (642s left) syncobj_wait (wait-all-snapshot)
[371.244030] Starting subtest: wait-all-snapshot
[371.324384] Subtest wait-all-snapshot: SUCCESS (0.082s)
[371.378671] [083/130] (642s left) gem_tiled_fence_blits (basic)
[371.437502] Subtest basic: SKIP (0.000s)
[371.475183] [084/130] (642s left) sysfs_preempt_timeout (invalid)
[371.527584] Starting subtest: invalid
[371.530245] Starting dynamic subtest: vecs0
[371.533057] Dynamic subtest vecs0: SUCCESS (0.000s)
[371.542350] Starting dynamic subtest: ccs0
[371.545003] Dynamic subtest ccs0: SUCCESS (0.000s)
[371.552331] Starting dynamic subtest: vcs0
[371.554463] Dynamic subtest vcs0: SUCCESS (0.000s)
[371.560907] Starting dynamic subtest: bcs0
[371.563367] Dynamic subtest bcs0: SUCCESS (0.000s)
[371.570126] Starting dynamic subtest: rcs0
[371.572525] Dynamic subtest rcs0: SUCCESS (0.000s)
[371.578847] Starting dynamic subtest: vcs1
[371.581040] Dynamic subtest vcs1: SUCCESS (0.000s)
[371.583198] Subtest invalid: SUCCESS (0.002s)
[371.596598] [085/130] (642s left) gem_exec_params (larger-than-life-batch)
[371.652652] Starting subtest: larger-than-life-batch
[373.122298] Subtest larger-than-life-batch: SUCCESS (1.470s)
[374.640205] [086/130] (639s left) kms_vrr (flip-suspend)
[374.762417] Starting subtest: flip-suspend
[374.769851] Subtest flip-suspend: SKIP (0.000s)
[374.812764] [087/130] (639s left) kms_addfb_basic (basic)
[374.863901] Starting subtest: basic
[374.865996] Subtest basic: SUCCESS (0.000s)
[374.971492] [088/130] (639s left) kms_psr (psr2-suspend)
[375.068185] Starting subtest: psr2-suspend
[375.070732] Starting dynamic subtest: eDP-1
[392.912980] Dynamic subtest eDP-1: SUCCESS (2.893s)
[392.915905] Subtest psr2-suspend: SUCCESS (2.893s)
[393.824265] [089/130] (635s left) syncobj_timeline (invalid-query-bad-pad)
[393.877497] Starting subtest: invalid-query-bad-pad
[393.880355] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[393.951141] [090/130] (635s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[394.008244] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[394.054724] [091/130] (635s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[394.146827] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[394.150858] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[394.213503] [092/130] (634s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[399.341644] Starting subtest: psr2-overlay-plane-move-continuous-sf
[399.344262] Starting dynamic subtest: pipe-A-eDP-1
[406.111541] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.766s)
[406.120155] Starting dynamic subtest: pipe-B-eDP-1
[412.899396] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.784s)
[412.901624] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.553s)
[413.797123] [093/130] (615s left) kms_flip (flip-vs-fences)
[413.899396] Starting subtest: flip-vs-fences
[413.904524] Subtest flip-vs-fences: SKIP (0.000s)
[413.968821] [094/130] (615s left) kms_lease (lease-invalid-connector)
[414.044814] Starting subtest: lease-invalid-connector
[414.047049] Starting dynamic subtest: pipe-A-eDP-1
[414.049629] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[414.056674] Starting dynamic subtest: pipe-B-eDP-1
[414.058601] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[414.065481] Starting dynamic subtest: pipe-C-eDP-1
[414.067705] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[414.074622] Starting dynamic subtest: pipe-D-eDP-1
[414.076539] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[414.078474] Subtest lease-invalid-connector: SUCCESS (0.003s)
[414.097024] [095/130] (615s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[414.197082] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[414.201781] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[414.262758] [096/130] (614s left) kms_flip (flip-vs-panning-interruptible)
[414.345964] Starting subtest: flip-vs-panning-interruptible
[414.350787] Starting dynamic subtest: A-eDP1
[423.154626] Dynamic subtest A-eDP1: SUCCESS (8.804s)
[423.163621] Starting dynamic subtest: B-eDP1
[431.919430] Dynamic subtest B-eDP1: SUCCESS (8.763s)
[431.930011] Starting dynamic subtest: C-eDP1
[440.678878] Dynamic subtest C-eDP1: SUCCESS (8.758s)
[440.689165] Starting dynamic subtest: D-eDP1
[449.444931] Dynamic subtest D-eDP1: SUCCESS (8.764s)
[449.449741] Subtest flip-vs-panning-interruptible: SUCCESS (35.099s)
[450.654962] [097/130] (578s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[450.697026] Starting subtest: invalid-multi-wait-unsubmitted
[450.699423] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[450.775263] [098/130] (578s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[450.876522] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[450.880631] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[450.946783] [099/130] (578s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[451.036335] Starting subtest: invalidate-primary-flip-overlay
[461.639417] Subtest invalidate-primary-flip-overlay: SUCCESS (10.598s)
[461.724713] [100/130] (567s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[461.834471] Starting subtest: cursorB-vs-flipA-toggle
[461.838434] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[461.923907] [101/130] (567s left) gem_exec_balancer (hang)
[462.139514] Starting subtest: hang
[463.604073] Subtest hang: SUCCESS (1.464s)
[463.700784] [102/130] (565s left) kms_psr (fbc-pr-primary-page-flip)
[463.783767] Starting subtest: fbc-pr-primary-page-flip
[463.788085] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[463.832562] [103/130] (565s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[463.918554] Starting subtest: 4-tiled-8bpp-rotate-270
[463.938350] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.019s)
[464.054644] [104/130] (565s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[464.144754] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[464.149006] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[464.211538] [105/130] (565s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[464.296675] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[469.071712] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (4.778s)
[469.173459] [106/130] (560s left) gem_mmap_gtt (cpuset-big-copy-xy)
[469.228701] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[469.269085] [107/130] (560s left) sw_sync (alloc_fence)
[469.296626] Starting subtest: alloc_fence
[469.299252] Subtest alloc_fence: SUCCESS (0.000s)
[469.326349] [108/130] (560s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[469.368133] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[469.480657] [109/130] (559s left) gem_exec_create (forked)
[469.536362] Starting subtest: forked
[469.538622] Starting dynamic subtest: smem
[491.579521] Dynamic subtest smem: SUCCESS (22.038s)
[491.582188] Subtest forked: SUCCESS (22.038s)
[491.745548] [110/130] (537s left) kms_flip (2x-busy-flip)
[491.829661] Starting subtest: 2x-busy-flip
[491.844769] Subtest 2x-busy-flip: SKIP (0.015s)
[491.897258] [111/130] (537s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[491.991439] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[491.995900] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[492.055145] [112/130] (537s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[492.217971] Starting subtest: cursor-rapid-movement-128x42
[492.252166] Subtest cursor-rapid-movement-128x42: SKIP (0.028s)
[492.428521] [113/130] (537s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[492.517949] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[492.520328] Starting dynamic subtest: pipe-A-default-mode
[492.805110] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[492.810286] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.284s)
[493.665790] [114/130] (535s left) gem_partial_pwrite_pread (reads)
[493.726050] Subtest reads: SKIP (0.000s)
[493.773449] [115/130] (535s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[493.873892] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[493.878118] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[493.940294] [116/130] (535s left) drm_fdinfo (busy-idle)
[493.974414] Starting subtest: busy-idle
[493.976713] Starting dynamic subtest: rcs0
[493.981550] Dynamic subtest rcs0: SKIP (0.000s)
[493.991076] Starting dynamic subtest: bcs0
[493.995077] Dynamic subtest bcs0: SKIP (0.000s)
[494.001510] Starting dynamic subtest: vcs0
[494.006316] Dynamic subtest vcs0: SKIP (0.000s)
[494.015589] Starting dynamic subtest: vcs1
[494.020153] Dynamic subtest vcs1: SKIP (0.000s)
[494.027032] Starting dynamic subtest: vecs0
[494.031607] Dynamic subtest vecs0: SKIP (0.000s)
[494.038511] Starting dynamic subtest: ccs0
[494.043003] Dynamic subtest ccs0: SKIP (0.000s)
[494.047292] Subtest busy-idle: SKIP (0.002s)
[494.061720] [117/130] (535s left) gem_mmap_gtt (basic-write-read)
[494.122075] Subtest basic-write-read: SKIP (0.000s)
[494.158347] [118/130] (535s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[499.286631] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[499.292092] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.002s)
[500.191717] [119/130] (529s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[500.287593] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[500.291719] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[500.352357] [120/130] (529s left) gem_exec_reloc (basic-cpu-wc-active)
[500.395504] Subtest basic-cpu-wc-active: SKIP (0.000s)
[500.444054] [121/130] (529s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[500.542973] Starting subtest: x-tiled-16bpp-rotate-270
[500.560395] Subtest x-tiled-16bpp-rotate-270: SKIP (0.017s)
[500.651254] [122/130] (529s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[500.722687] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[500.725032] Starting dynamic subtest: pipe-A-eDP-1
[500.747547] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[500.756959] Starting dynamic subtest: pipe-B-eDP-1
[500.778666] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[500.786144] Starting dynamic subtest: pipe-C-eDP-1
[500.808586] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[500.815454] Starting dynamic subtest: pipe-D-eDP-1
[500.837686] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[500.842132] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[500.856947] [123/130] (528s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[500.919008] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[500.956163] [124/130] (528s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[502.761489] Starting subtest: modeset-non-lpsp-stress-no-wait
[503.197201] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.433s)
[503.473855] [125/130] (526s left) fbdev (eof)
[503.504617] Starting subtest: eof
[503.506818] Subtest eof: SUCCESS (0.000s)
[503.536795] [126/130] (526s left) gem_close_race (multigpu-basic-threads)
[503.592764] Starting subtest: multigpu-basic-threads
[503.598094] Subtest multigpu-basic-threads: SKIP (0.000s)
[503.793371] [127/130] (525s left) gem_exec_fence (long-history)
[504.200402] Starting subtest: long-history
[511.375104] Subtest long-history: SUCCESS (7.176s)
[511.984086] [128/130] (517s left) kms_big_fb (yf-tiled-addfb)
[512.085695] Starting subtest: yf-tiled-addfb
[512.090155] Subtest yf-tiled-addfb: SKIP (0.000s)
[512.150390] [129/130] (517s left) kms_setmode (invalid-clone-exclusive-crtc)
[512.202519] Starting subtest: invalid-clone-exclusive-crtc
[512.208557] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[512.267785] [130/130] (517s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[512.319791] Starting subtest: y-tiled-to-vebox-yf-tiled
[512.325349] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[512.479595] Closing watchdogs
Done.