[59.908041] Initializing watchdogs
[59.908085]   /dev/watchdog0
[59.921230] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.925776] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.927843] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.931021] [001/132] (960s left) gem_ctx_freq (sysfs)
[60.036046] Starting subtest: sysfs
[60.038479] Starting dynamic subtest: gt0
[65.568273] Dynamic subtest gt0: SUCCESS (5.553s)
[65.578234] Starting dynamic subtest: gt1
[106.900106] Dynamic subtest gt1: SUCCESS (41.341s)
[106.902685] Subtest sysfs: SUCCESS (46.896s)
[107.045649] [002/132] (913s left) prime_self_import (basic-llseek-bad)
[107.077268] Starting subtest: basic-llseek-bad
[107.100701] Subtest basic-llseek-bad: SUCCESS (0.023s)
[107.248219] [003/132] (913s left) core_setmaster (master-drop-set-shared-fd)
[107.350816] Starting subtest: master-drop-set-shared-fd
[107.370151] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[107.404215] [004/132] (913s left) syncobj_wait (multi-wait-all-submitted-signaled)
[107.473654] Starting subtest: multi-wait-all-submitted-signaled
[107.576753] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.101s)
[107.681118] [005/132] (912s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[107.782264] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[107.784433] Starting dynamic subtest: pipe-A-default-mode
[108.993194] Dynamic subtest pipe-A-default-mode: SKIP (1.206s)
[108.997375] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.207s)
[109.172499] [006/132] (911s left) gem_mmap_gtt (basic-write)
[109.228088] Subtest basic-write: SKIP (0.000s)
[109.298735] [007/132] (911s left) kms_psr (pr-cursor-mmap-gtt)
[109.397081] Starting subtest: pr-cursor-mmap-gtt
[109.401571] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[109.492873] [008/132] (911s left) i915_pm_rpm (gem-mmap-type)
[111.042865] Starting subtest: gem-mmap-type
[111.045106] Starting dynamic subtest: wb-smem0
[114.901946] Dynamic subtest wb-smem0: SUCCESS (3.861s)
[114.912584] Starting dynamic subtest: wc-smem0
[118.070853] Dynamic subtest wc-smem0: SUCCESS (3.168s)
[118.079741] Starting dynamic subtest: uc-smem0
[121.558479] Dynamic subtest uc-smem0: SUCCESS (3.487s)
[121.560832] Subtest gem-mmap-type: SUCCESS (10.517s)
[121.664076] [009/132] (899s left) perf_pmu (rc6-suspend)
[121.708766] Starting subtest: rc6-suspend
[144.055716] Subtest rc6-suspend: SUCCESS (11.219s)
[144.933945] [010/132] (875s left) kms_plane_multiple (2x-tiling-x)
[145.046387] Starting subtest: 2x-tiling-x
[145.050478] Subtest 2x-tiling-x: SKIP (0.000s)
[145.136892] [011/132] (875s left) kms_getfb (getfb2-handle-protection)
[145.219585] Starting subtest: getfb2-handle-protection
[145.240787] Subtest getfb2-handle-protection: SUCCESS (0.022s)
[145.363277] [012/132] (875s left) gem_exec_params (dr1-dirt)
[145.426891] Starting subtest: DR1-dirt
[145.428885] Subtest DR1-dirt: SUCCESS (0.000s)
[145.560367] [013/132] (875s left) gem_mmap_wc (write-prefaulted)
[145.616406] Subtest write-prefaulted: SKIP (0.000s)
[145.678743] [014/132] (875s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[147.195098] Starting subtest: dpms-mode-unset-lpsp
[151.250303] Subtest dpms-mode-unset-lpsp: SUCCESS (4.109s)
[151.653541] [015/132] (869s left) perf (non-zero-reason)
[151.779173] Starting subtest: non-zero-reason
[151.781476] Starting dynamic subtest: 0-rcs0
[156.995150] Dynamic subtest 0-rcs0: SUCCESS (5.251s)
[157.006075] Starting dynamic subtest: 1-vecs0
[160.823072] Dynamic subtest 1-vecs0: SUCCESS (3.843s)
[160.825717] Subtest non-zero-reason: SUCCESS (9.095s)
[160.874127] [016/132] (860s left) gem_ctx_persistence (userptr)
[160.925022] Starting subtest: userptr
[161.133086] Subtest userptr: SUCCESS (0.207s)
[161.234207] [017/132] (859s left) gem_busy (close-race)
[161.314315] Starting subtest: close-race
[187.108550] Subtest close-race: SUCCESS (25.805s)
[187.507634] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[187.512069] [018/132] (833s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[187.662579] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[191.963449] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.307s)
[193.174162] [019/132] (827s left) perf (disabled-read-error)
[193.317265] Starting subtest: disabled-read-error
[193.328612] Subtest disabled-read-error: SUCCESS (0.012s)
[193.375619] [020/132] (827s left) kms_pm_backlight (fade)
[193.469353] Starting subtest: fade
[193.547875] Starting dynamic subtest: eDP-1
[196.230173] Dynamic subtest eDP-1: SUCCESS (2.682s)
[196.232576] Subtest fade: SUCCESS (2.763s)
[197.090264] [021/132] (824s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[197.200577] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[197.204797] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[197.340285] [022/132] (823s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[197.446450] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[197.448728] Starting dynamic subtest: pipe-A-eDP-1
[197.468325] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[197.479504] Starting dynamic subtest: pipe-B-eDP-1
[197.500732] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[197.515082] Starting dynamic subtest: pipe-C-eDP-1
[197.534874] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[197.544912] Starting dynamic subtest: pipe-D-eDP-1
[197.565467] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[197.567808] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[199.658823] [023/132] (821s left) i915_drm_fdinfo (memory-info-shared)
[199.702872] Starting subtest: memory-info-shared
[199.705108] Starting dynamic subtest: smem0
[199.779948] Dynamic subtest smem0: SUCCESS (0.078s)
[199.782522] Subtest memory-info-shared: SUCCESS (0.079s)
[199.874739] [024/132] (821s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[199.979004] Starting subtest: multiplane-rotation-cropping-bottom
[217.344219] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.371s)
[217.495274] [025/132] (803s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[217.596842] Starting subtest: fbc-psr-cursor-mmap-cpu
[217.598611] Starting dynamic subtest: eDP-1
[217.602335] Dynamic subtest eDP-1: SKIP (0.000s)
[217.605886] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[217.690840] [026/132] (803s left) kms_plane_alpha_blend (alpha-opaque-fb)
[217.787378] Starting subtest: alpha-opaque-fb
[218.072602] Starting dynamic subtest: pipe-A-eDP-1
[218.739201] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.665s)
[218.748708] Starting dynamic subtest: pipe-D-eDP-1
[220.043082] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.301s)
[220.045418] Subtest alpha-opaque-fb: SUCCESS (2.255s)
[220.909031] [027/132] (800s left) kms_chamelium_color (ctm-limited-range)
[221.001759] Subtest ctm-limited-range: SKIP (0.000s)
[221.045441] [028/132] (800s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[221.109709] Starting subtest: multi-wait-for-submit-submitted-signaled
[221.112366] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[221.229034] [029/132] (800s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[221.330028] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[228.138653] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.813s)
[228.312805] [030/132] (793s left) syncobj_eventfd (invalid-bad-flags)
[228.378221] Starting subtest: invalid-bad-flags
[228.380392] Subtest invalid-bad-flags: SUCCESS (0.000s)
[228.518949] [031/132] (793s left) kms_pm_rpm (system-suspend-idle)
[230.256233] Starting subtest: system-suspend-idle
[250.086864] Subtest system-suspend-idle: SUCCESS (4.382s)
[250.472592] [032/132] (771s left) kms_dsc (dsc-with-output-formats-with-bpc)
[250.575840] Starting subtest: dsc-with-output-formats-with-bpc
[250.631978] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[250.676382] [033/132] (771s left) gem_tiled_wc
[250.797899] [034/132] (770s left) gem_mmap_gtt (fault-concurrent-y)
[250.862966] Subtest fault-concurrent-Y: SKIP (0.000s)
[250.929694] [035/132] (770s left) kms_async_flips (invalid-async-flip)
[251.022844] Starting subtest: invalid-async-flip
[251.394850] Starting dynamic subtest: pipe-A-eDP-1
[252.208858] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.837s)
[252.559267] Starting dynamic subtest: pipe-B-eDP-1
[253.330857] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.796s)
[253.689909] Starting dynamic subtest: pipe-C-eDP-1
[254.443890] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.775s)
[254.800572] Starting dynamic subtest: pipe-D-eDP-1
[255.560599] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.779s)
[255.562855] Subtest invalid-async-flip: SUCCESS (4.640s)
[256.716561] [036/132] (765s left) gem_exec_basic (basic)
[256.775357] Starting subtest: basic
[256.777674] Starting dynamic subtest: rcs0-smem
[256.780052] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[256.790416] Starting dynamic subtest: bcs0-smem
[256.792237] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[256.800335] Starting dynamic subtest: vcs0-smem
[256.802420] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[256.810201] Starting dynamic subtest: vcs1-smem
[256.812289] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[256.820023] Starting dynamic subtest: vecs0-smem
[256.822082] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[256.829919] Starting dynamic subtest: ccs0-smem
[256.831988] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[256.834108] Subtest basic: SUCCESS (0.014s)
[258.724089] [037/132] (763s left) kms_psr (fbc-pr-suspend)
[258.803578] Starting subtest: fbc-pr-suspend
[258.807953] Subtest fbc-pr-suspend: SKIP (0.000s)
[258.898947] [038/132] (763s left) gem_sync (basic-store-all)
[258.965737] Starting subtest: basic-store-all
[262.591186] Subtest basic-store-all: SUCCESS (3.663s)
[262.801596] [039/132] (759s left) gem_partial_pwrite_pread (reads-snoop)
[262.856437] Subtest reads-snoop: SKIP (0.000s)
[262.950293] [040/132] (759s left) gem_pxp (verify-pxp-stale-ctx-execution)
[263.071364] Starting subtest: verify-pxp-stale-ctx-execution
[264.130671] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.068s)
[264.288929] [041/132] (757s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[264.397113] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[271.585308] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.214s)
[271.744638] [042/132] (750s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[271.860281] Starting subtest: y-tiled-addfb-size-offset-overflow
[271.864555] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[271.982535] [043/132] (750s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[272.073503] Starting subtest: bad-pixel-format-y-tiled-ccs
[272.075593] Starting dynamic subtest: pipe-A-eDP-1
[272.097205] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[272.107635] Starting dynamic subtest: pipe-B-eDP-1
[272.128023] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[272.136188] Starting dynamic subtest: pipe-C-eDP-1
[272.157769] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[272.165842] Starting dynamic subtest: pipe-D-eDP-1
[272.187869] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[272.191906] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[274.322688] [044/132] (747s left) kms_color_pipeline (plane-lut3d-green-only)
[274.424842] Starting subtest: plane-lut3d-green-only
[274.441899] Starting dynamic subtest: pipe-A-eDP-1
[274.446223] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[275.483711] Starting dynamic subtest: pipe-B-eDP-1
[275.488026] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[276.519077] Starting dynamic subtest: pipe-C-eDP-1
[276.523424] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[277.554320] Starting dynamic subtest: pipe-D-eDP-1
[277.558896] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[277.854035] Subtest plane-lut3d-green-only: SKIP (3.431s)
[278.760224] [045/132] (743s left) perf_pmu (rc6)
[278.813179] Starting subtest: rc6
[278.815367] Starting dynamic subtest: gt0
[285.188919] Dynamic subtest gt0: SUCCESS (6.375s)
[285.200448] Starting dynamic subtest: runtime-pm-gt0
[292.908892] Dynamic subtest runtime-pm-gt0: SUCCESS (7.714s)
[292.921358] Starting dynamic subtest: runtime-pm-long-gt0
[305.358185] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.446s)
[305.369997] Starting dynamic subtest: other-idle-gt0
[311.701105] Dynamic subtest other-idle-gt0: SUCCESS (6.342s)
[311.710739] Starting dynamic subtest: gt1
[318.041908] Dynamic subtest gt1: SUCCESS (6.339s)
[318.050849] Starting dynamic subtest: runtime-pm-gt1
[325.478852] Dynamic subtest runtime-pm-gt1: SUCCESS (7.437s)
[325.490691] Starting dynamic subtest: runtime-pm-long-gt1
[337.912716] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.435s)
[337.922420] Starting dynamic subtest: other-idle-gt1
[344.254604] Dynamic subtest other-idle-gt1: SUCCESS (6.342s)
[344.257089] Subtest rc6: SUCCESS (65.448s)
[345.382254] [046/132] (676s left) gem_exec_fence (syncobj-timeline-export)
[345.953684] Starting subtest: syncobj-timeline-export
[345.959631] Subtest syncobj-timeline-export: SUCCESS (0.007s)
[347.782227] [047/132] (674s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[348.188372] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[349.007654] [048/132] (673s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[349.117008] Starting subtest: fbc-rgb101010-draw-pwrite
[354.477426] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.362s)
[355.603712] [049/132] (666s left) gem_softpin (invalid)
[355.666481] Starting subtest: invalid
[355.674985] Subtest invalid: SUCCESS (0.007s)
[355.806508] [050/132] (666s left) i915_getparams_basic (basic-subslice-total)
[355.875112] Starting subtest: basic-subslice-total
[355.879013] Subtest basic-subslice-total: SUCCESS (0.000s)
[355.949542] [051/132] (666s left) kms_content_protection (dp-mst-lic-type-1)
[356.092425] Starting subtest: dp-mst-lic-type-1
[356.096799] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[356.225806] [052/132] (666s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[356.314691] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[356.316974] Starting dynamic subtest: pipe-A-eDP-1
[357.127222] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.806s)
[357.135796] Starting dynamic subtest: pipe-B-eDP-1
[358.673757] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.541s)
[358.684523] Starting dynamic subtest: pipe-C-eDP-1
[360.167623] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.494s)
[360.177865] Starting dynamic subtest: pipe-D-eDP-1
[361.746890] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.578s)
[361.749109] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.423s)
[362.933128] [053/132] (659s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[363.053323] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[363.057692] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[363.131496] [054/132] (659s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[363.229103] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[363.231344] Starting dynamic subtest: pipe-A-eDP-1
[363.251776] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[363.262296] Starting dynamic subtest: pipe-B-eDP-1
[363.281686] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s)
[363.290729] Starting dynamic subtest: pipe-C-eDP-1
[363.310829] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[363.320039] Starting dynamic subtest: pipe-D-eDP-1
[363.340018] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[363.342338] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.090s)
[365.516670] [055/132] (657s left) gem_barrier_race (remote-request)
[365.585871] Starting subtest: remote-request
[365.588329] Starting dynamic subtest: rcs0
[370.748375] Dynamic subtest rcs0: SUCCESS (5.164s)
[370.750398] Subtest remote-request: SUCCESS (5.165s)
[370.846971] [056/132] (651s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[370.957388] Starting subtest: extended-modeset-hang-oldfb-with-reset
[370.959273] Starting dynamic subtest: pipe-A
[382.518385] Dynamic subtest pipe-A: SUCCESS (11.561s)
[382.528856] Starting dynamic subtest: pipe-D
[394.809213] Dynamic subtest pipe-D: SUCCESS (12.287s)
[394.811162] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.853s)
[395.583283] [057/132] (627s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[395.733161] Starting subtest: cursorA-vs-flipB-toggle
[395.737703] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[395.852469] [058/132] (626s left) syncobj_basic (bad-flags-fd-to-handle)
[395.914076] Starting subtest: bad-flags-fd-to-handle
[395.916398] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[396.006292] [059/132] (626s left) gem_media_fill (media-fill)
[396.070297] Subtest media-fill: SKIP (0.000s)
[396.165781] [060/132] (626s left) kms_big_fb (linear-64bpp-rotate-270)
[396.269116] Starting subtest: linear-64bpp-rotate-270
[396.287689] Subtest linear-64bpp-rotate-270: SKIP (0.018s)
[396.391886] [061/132] (626s left) gem_watchdog (default-virtual)
[396.472942] Starting subtest: default-virtual
[402.751000] Subtest default-virtual: SUCCESS (6.286s)
[402.862366] [062/132] (620s left) gem_tiled_blits (normal)
[402.922481] Subtest normal: SKIP (0.000s)
[403.018045] [063/132] (619s left) syncobj_timeline (wait-for-submit-complex)
[403.061287] Starting subtest: wait-for-submit-complex
[403.120917] Subtest wait-for-submit-complex: SUCCESS (0.061s)
[403.178583] [064/132] (619s left) gem_exec_whisper (basic-contexts-priority-all)
[403.252400] Starting subtest: basic-contexts-priority-all
[427.639546] Subtest basic-contexts-priority-all: SUCCESS (24.387s)
[427.802310] [065/132] (595s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[428.207728] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[429.006011] [066/132] (594s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[429.072554] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[429.183222] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.109s)
[429.236063] [067/132] (593s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[429.336327] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[429.345599] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[429.411485] [068/132] (593s left) gem_ringfill (legacy-basic)
[434.661453] Starting subtest: legacy-basic
[434.663885] Starting dynamic subtest: default
[434.749375] Dynamic subtest default: SUCCESS (0.087s)
[434.761385] Starting dynamic subtest: render
[434.791734] Dynamic subtest render: SUCCESS (0.040s)
[434.802600] Starting dynamic subtest: bsd
[434.834682] Dynamic subtest bsd: SUCCESS (0.041s)
[434.845357] Starting dynamic subtest: bsd1
[434.874882] Dynamic subtest bsd1: SUCCESS (0.038s)
[434.887173] Starting dynamic subtest: bsd2
[434.917508] Dynamic subtest bsd2: SUCCESS (0.040s)
[434.929594] Starting dynamic subtest: blt
[434.965761] Dynamic subtest blt: SUCCESS (0.046s)
[434.975246] Starting dynamic subtest: vebox
[435.009670] Dynamic subtest vebox: SUCCESS (0.041s)
[435.012214] Subtest legacy-basic: SUCCESS (0.351s)
[435.065139] [069/132] (588s left) gem_pread (snoop)
[435.122511] Subtest snoop: SKIP (0.000s)
[435.228321] [070/132] (588s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[435.343049] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[435.347221] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[435.412604] [071/132] (587s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[435.522635] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[435.527026] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[435.603563] [072/132] (587s left) gem_eio (context-create)
[435.826990] Starting subtest: context-create
[436.137352] Subtest context-create: SUCCESS (0.311s)
[436.250849] [073/132] (587s left) gem_close_race (multigpu-basic-threads)
[436.317630] Starting subtest: multigpu-basic-threads
[436.321911] Subtest multigpu-basic-threads: SKIP (0.000s)
[436.545580] [074/132] (586s left) kms_psr (psr2-dpms)
[436.637350] Starting subtest: psr2-dpms
[436.639903] Starting dynamic subtest: eDP-1
[439.528427] Dynamic subtest eDP-1: SUCCESS (2.894s)
[439.530854] Subtest psr2-dpms: SUCCESS (2.895s)
[440.384845] [075/132] (583s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[440.474237] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[440.478710] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[440.557111] [076/132] (582s left) gem_lmem_swapping (heavy-verify-multi)
[440.606356] Subtest heavy-verify-multi: SKIP (0.000s)
[440.642489] [077/132] (582s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[440.738346] Starting subtest: plane-all-modeset-transition-internal-panels
[440.740241] Starting dynamic subtest: pipe-A-eDP-1
[442.039680] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.301s)
[442.317432] Starting dynamic subtest: pipe-B-eDP-1
[443.366035] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.060s)
[443.634525] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.896s)
[444.448441] [078/132] (579s left) gem_spin_batch (resubmit)
[444.503455] Starting subtest: resubmit
[444.506042] Starting dynamic subtest: rcs0
[444.512398] Dynamic subtest rcs0: SUCCESS (0.006s)
[444.529225] Starting dynamic subtest: bcs0
[444.531535] Dynamic subtest bcs0: SUCCESS (0.002s)
[444.542880] Starting dynamic subtest: vcs0
[444.545048] Dynamic subtest vcs0: SUCCESS (0.002s)
[444.554497] Starting dynamic subtest: vcs1
[444.556699] Dynamic subtest vcs1: SUCCESS (0.002s)
[444.565437] Starting dynamic subtest: vecs0
[444.567658] Dynamic subtest vecs0: SUCCESS (0.002s)
[444.576412] Starting dynamic subtest: ccs0
[444.578689] Dynamic subtest ccs0: SUCCESS (0.003s)
[444.581381] Subtest resubmit: SUCCESS (0.021s)
[444.736024] [079/132] (578s left) kms_vblank (query-idle-hang)
[444.834724] Starting subtest: query-idle-hang
[444.836630] Starting dynamic subtest: pipe-A-eDP-1
[472.428657] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.600s)
[472.444029] Starting dynamic subtest: pipe-D-eDP-1
[487.457513] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.022s)
[487.459890] Subtest query-idle-hang: SUCCESS (42.627s)
[488.316266] [080/132] (535s left) perf_pmu (interrupts)
[488.367028] Starting subtest: interrupts
[489.478423] Subtest interrupts: SUCCESS (1.112s)
[489.599665] [081/132] (534s left) gem_exec_reloc (basic-wc-gtt-active)
[489.668129] Subtest basic-wc-gtt-active: SKIP (0.000s)
[489.756139] [082/132] (533s left) gem_exec_reloc (basic-gtt-cpu)
[489.816857] Subtest basic-gtt-cpu: SKIP (0.000s)
[489.908970] [083/132] (533s left) sysfs_timeslice_duration (timeout)
[489.966423] Starting subtest: timeout
[489.968848] Starting dynamic subtest: vecs0
[499.696741] Dynamic subtest vecs0: SUCCESS (9.724s)
[499.709252] Starting dynamic subtest: ccs0
[500.917386] Dynamic subtest ccs0: SUCCESS (1.221s)
[500.929926] Starting dynamic subtest: vcs0
[510.715838] Dynamic subtest vcs0: SUCCESS (9.792s)
[510.733792] Starting dynamic subtest: bcs0
[511.306446] Dynamic subtest bcs0: SUCCESS (0.590s)
[511.321918] Starting dynamic subtest: rcs0
[512.479866] Dynamic subtest rcs0: SUCCESS (1.170s)
[512.492302] Starting dynamic subtest: vcs1
[521.709455] Dynamic subtest vcs1: SUCCESS (9.224s)
[521.712350] Subtest timeout: SUCCESS (31.734s)
[521.764279] [084/132] (502s left) core_auth (getclient-master-drop)
[521.805901] Starting subtest: getclient-master-drop
[521.833573] Subtest getclient-master-drop: SUCCESS (0.027s)
[521.925130] [085/132] (501s left) gem_exec_schedule (preempt-other)
[521.998638] Starting subtest: preempt-other
[522.001132] Starting dynamic subtest: rcs0
[522.114869] Dynamic subtest rcs0: SUCCESS (0.122s)
[522.127036] Starting dynamic subtest: bcs0
[522.230610] Dynamic subtest bcs0: SUCCESS (0.114s)
[522.243694] Starting dynamic subtest: vcs0
[522.344602] Dynamic subtest vcs0: SUCCESS (0.115s)
[522.355626] Starting dynamic subtest: vcs1
[522.466661] Dynamic subtest vcs1: SUCCESS (0.119s)
[522.479370] Starting dynamic subtest: vecs0
[522.581902] Dynamic subtest vecs0: SUCCESS (0.115s)
[522.595228] Starting dynamic subtest: ccs0
[522.694325] Dynamic subtest ccs0: SUCCESS (0.112s)
[522.697417] Subtest preempt-other: SUCCESS (0.703s)
[523.725333] [086/132] (500s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[523.830515] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[523.835007] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[523.890819] [087/132] (500s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[523.984265] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[530.712525] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.730s)
[530.839180] [088/132] (493s left) kms_lease (setcrtc-implicit-plane)
[530.936384] Starting subtest: setcrtc-implicit-plane
[530.938657] Starting dynamic subtest: pipe-A-eDP-1
[531.415591] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.476s)
[531.429113] Starting dynamic subtest: pipe-B-eDP-1
[532.519271] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.104s)
[532.529793] Starting dynamic subtest: pipe-C-eDP-1
[533.633671] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.114s)
[533.643912] Starting dynamic subtest: pipe-D-eDP-1
[534.775224] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.139s)
[534.777110] Subtest setcrtc-implicit-plane: SUCCESS (3.839s)
[535.590997] [089/132] (488s left) kms_flip (2x-flip-vs-rmfb)
[535.687621] Starting subtest: 2x-flip-vs-rmfb
[535.695988] Subtest 2x-flip-vs-rmfb: SKIP (0.010s)
[535.794687] [090/132] (488s left) kms_vblank (wait-idle-hang)
[535.901482] Starting subtest: wait-idle-hang
[535.904025] Starting dynamic subtest: pipe-A-eDP-1
[562.394261] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.494s)
[562.410554] Starting dynamic subtest: pipe-D-eDP-1
[577.447764] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.051s)
[577.450208] Subtest wait-idle-hang: SUCCESS (41.549s)
[578.247684] [091/132] (445s left) gem_exec_params (cliprects_ptr-dirt)
[578.301178] Starting subtest: cliprects_ptr-dirt
[578.303583] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[578.385163] [092/132] (445s left) kms_cursor_legacy (forked-move)
[578.518477] Starting subtest: forked-move
[578.520663] Starting dynamic subtest: pipe-A
[583.994285] Dynamic subtest pipe-A: SUCCESS (5.474s)
[584.009641] Starting dynamic subtest: pipe-B
[589.456499] Dynamic subtest pipe-B: SUCCESS (5.461s)
[589.470968] Starting dynamic subtest: pipe-C
[594.914240] Dynamic subtest pipe-C: SUCCESS (5.456s)
[594.926195] Starting dynamic subtest: pipe-D
[600.373745] Dynamic subtest pipe-D: SUCCESS (5.458s)
[600.386131] Starting dynamic subtest: all-pipes
[605.868844] Dynamic subtest all-pipes: SUCCESS (5.493s)
[605.871400] Subtest forked-move: SUCCESS (27.352s)
[605.993339] [093/132] (418s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[606.119762] Starting subtest: cursorB-vs-flipA-legacy
[606.124393] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[606.255690] [094/132] (417s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[606.415898] Starting subtest: cursor-rapid-movement-32x10
[606.461828] Subtest cursor-rapid-movement-32x10: SKIP (0.041s)
[606.721206] [095/132] (417s left) kms_invalid_mode (uint-max-clock)
[606.819327] Starting subtest: uint-max-clock
[606.821604] Starting dynamic subtest: pipe-A-eDP-1
[607.104180] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[607.114297] Starting dynamic subtest: pipe-B-eDP-1
[607.116192] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[607.125916] Starting dynamic subtest: pipe-C-eDP-1
[607.128142] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[607.136907] Starting dynamic subtest: pipe-D-eDP-1
[607.139043] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[607.141130] Subtest uint-max-clock: SUCCESS (0.289s)
[607.881171] [096/132] (416s left) api_intel_allocator (simple-allocator)
[607.949994] Starting subtest: simple-allocator
[607.952541] Starting dynamic subtest: basic
[607.954594] Dynamic subtest basic: SUCCESS (0.004s)
[607.972621] Starting dynamic subtest: parallel-one
[608.141154] Dynamic subtest parallel-one: SUCCESS (0.188s)
[608.158632] Starting dynamic subtest: print
[608.160931] Dynamic subtest print: SUCCESS (0.000s)
[608.170088] Starting dynamic subtest: reuse
[608.172002] Dynamic subtest reuse: SUCCESS (0.000s)
[608.180894] Starting dynamic subtest: reserve
[608.182798] Dynamic subtest reserve: SUCCESS (0.000s)
[608.191758] Starting dynamic subtest: fork-reopen-allocator
[608.193720] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[608.195599] Subtest simple-allocator: SUCCESS (0.211s)
[608.253434] [097/132] (416s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[608.367106] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[608.371205] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[608.459185] [098/132] (415s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[608.514832] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[608.517180] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[608.623032] [099/132] (415s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[608.714432] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[608.718868] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[608.806759] [100/132] (415s left) kms_plane_scaling (planes-scaler-unity-scaling)
[608.904506] Starting subtest: planes-scaler-unity-scaling
[608.906755] Starting dynamic subtest: pipe-A
[608.965442] Dynamic subtest pipe-A: SUCCESS (0.063s)
[608.977014] Starting dynamic subtest: pipe-B
[610.118836] Dynamic subtest pipe-B: SUCCESS (1.151s)
[610.131145] Starting dynamic subtest: pipe-C
[611.220580] Dynamic subtest pipe-C: SUCCESS (1.101s)
[611.230985] Starting dynamic subtest: pipe-D
[612.347977] Dynamic subtest pipe-D: SUCCESS (1.127s)
[612.350256] Subtest planes-scaler-unity-scaling: SUCCESS (3.447s)
[613.490780] [101/132] (411s left) kms_psr (psr-primary-mmap-gtt)
[613.577683] Starting subtest: psr-primary-mmap-gtt
[613.580121] Starting dynamic subtest: eDP-1
[615.003023] Dynamic subtest eDP-1: SKIP (1.422s)
[615.007743] Subtest psr-primary-mmap-gtt: SKIP (1.425s)
[615.122928] [102/132] (409s left) kms_flip (flip-vs-suspend-interruptible)
[615.226990] Starting subtest: flip-vs-suspend-interruptible
[615.229239] Starting dynamic subtest: A-eDP1
[664.894963] Dynamic subtest A-eDP1: SUCCESS (4.521s)
[664.905980] Starting dynamic subtest: B-eDP1
[713.872266] Dynamic subtest B-eDP1: SUCCESS (4.548s)
[713.882470] Starting dynamic subtest: C-eDP1
[762.890673] Dynamic subtest C-eDP1: SUCCESS (4.513s)
[762.906565] Starting dynamic subtest: D-eDP1
[811.885127] Dynamic subtest D-eDP1: SUCCESS (4.577s)
[811.887695] Subtest flip-vs-suspend-interruptible: SUCCESS (18.168s)
[813.104656] [103/132] (211s left) kms_flip (flip-vs-blocking-wf-vblank)
[813.212664] Starting subtest: flip-vs-blocking-wf-vblank
[813.215018] Starting dynamic subtest: A-eDP1
[833.902060] Dynamic subtest A-eDP1: SUCCESS (20.892s)
[833.916796] Starting dynamic subtest: B-eDP1
[842.821516] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[842.834205] Starting dynamic subtest: C-eDP1
[851.746719] Dynamic subtest C-eDP1: SUCCESS (8.916s)
[851.757883] Starting dynamic subtest: D-eDP1
[860.665758] Dynamic subtest D-eDP1: SUCCESS (8.919s)
[860.668121] Subtest flip-vs-blocking-wf-vblank: SUCCESS (47.667s)
[861.879036] [104/132] (162s left) i915_suspend (fence-restore-untiled)
[861.937756] Starting subtest: fence-restore-untiled
[861.942183] Subtest fence-restore-untiled: SKIP (0.000s)
[862.021805] [105/132] (162s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[862.080170] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[862.187025] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s)
[862.241983] [106/132] (162s left) gem_exec_balancer (bonded-dual)
[862.305936] Starting subtest: bonded-dual
[862.310507] Subtest bonded-dual: SKIP (0.000s)
[862.586836] [107/132] (162s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[867.669362] Starting subtest: pr-plane-move-sf-dmg-area
[867.673979] Subtest pr-plane-move-sf-dmg-area: SKIP (0.002s)
[868.504920] [108/132] (156s left) gem_exec_params (mmapped)
[868.555513] Starting subtest: mmapped
[868.558247] Subtest mmapped: SUCCESS (0.003s)
[868.687426] [109/132] (156s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[868.744530] Starting subtest: invalid-multi-wait-unsubmitted
[868.746732] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[868.814503] [110/132] (156s left) kms_flip (dpms-off-confusion)
[868.904908] Starting subtest: dpms-off-confusion
[868.907216] Starting dynamic subtest: A-eDP1
[877.548278] Dynamic subtest A-eDP1: SUCCESS (8.648s)
[877.562914] Starting dynamic subtest: B-eDP1
[886.195402] Dynamic subtest B-eDP1: SUCCESS (8.648s)
[886.209325] Starting dynamic subtest: C-eDP1
[894.916982] Dynamic subtest C-eDP1: SUCCESS (8.722s)
[894.927796] Starting dynamic subtest: D-eDP1
[903.539821] Dynamic subtest D-eDP1: SUCCESS (8.625s)
[903.542293] Subtest dpms-off-confusion: SUCCESS (34.652s)
[904.691554] [111/132] (120s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[904.792950] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[904.796803] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[904.888536] [112/132] (120s left) kms_addfb_basic (legacy-format)
[904.947784] Starting subtest: legacy-format
[904.974000] Subtest legacy-format: SUCCESS (0.024s)
[905.119335] [113/132] (119s left) syncobj_wait (multi-wait-for-submit-signaled)
[905.191664] Starting subtest: multi-wait-for-submit-signaled
[905.193913] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[905.298599] [114/132] (119s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[905.415815] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[906.284284] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.870s)
[906.432737] [115/132] (118s left) kms_cursor_crc (cursor-onscreen-512x170)
[906.700378] Starting subtest: cursor-onscreen-512x170
[906.704893] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[906.835921] [116/132] (118s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[911.895668] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[911.898263] Starting dynamic subtest: pipe-A-eDP-1
[912.674510] Dynamic subtest pipe-A-eDP-1: SKIP (0.776s)
[912.684264] Starting dynamic subtest: pipe-B-eDP-1
[913.800162] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s)
[913.804753] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.903s)
[914.969002] [117/132] (110s left) syncobj_timeline (invalid-signal-bad-pad)
[915.022688] Starting subtest: invalid-signal-bad-pad
[915.024849] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[915.112427] [118/132] (110s left) kms_cursor_legacy (single-move)
[915.231999] Starting subtest: single-move
[915.234252] Starting dynamic subtest: pipe-A
[920.614622] Dynamic subtest pipe-A: SUCCESS (5.378s)
[920.627510] Starting dynamic subtest: pipe-B
[925.999107] Dynamic subtest pipe-B: SUCCESS (5.380s)
[926.011222] Starting dynamic subtest: pipe-C
[931.383209] Dynamic subtest pipe-C: SUCCESS (5.380s)
[931.395223] Starting dynamic subtest: pipe-D
[936.765374] Dynamic subtest pipe-D: SUCCESS (5.379s)
[936.777693] Starting dynamic subtest: all-pipes
[942.154179] Dynamic subtest all-pipes: SUCCESS (5.386s)
[942.156590] Subtest single-move: SUCCESS (26.916s)
[942.274842] [119/132] ( 82s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[942.380476] Starting subtest: flip-vs-dpms-off-vs-modeset
[942.382804] Starting dynamic subtest: A-eDP1
[946.029020] Dynamic subtest A-eDP1: SUCCESS (3.648s)
[946.039802] Starting dynamic subtest: B-eDP1
[949.229949] Dynamic subtest B-eDP1: SUCCESS (3.199s)
[949.241392] Starting dynamic subtest: C-eDP1
[952.329886] Dynamic subtest C-eDP1: SUCCESS (3.099s)
[952.340526] Starting dynamic subtest: D-eDP1
[955.452497] Dynamic subtest D-eDP1: SUCCESS (3.120s)
[955.454376] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.074s)
[956.229291] [120/132] ( 69s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[956.343849] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[963.064951] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.724s)
[963.163361] [121/132] ( 62s left) gem_exec_schedule (u-semaphore-resolve)
[963.243742] Starting subtest: u-semaphore-resolve
[963.273517] Subtest u-semaphore-resolve: SUCCESS (0.036s)
[963.598732] [122/132] ( 61s left) gem_exec_reloc (basic-wc-cpu)
[963.660706] Subtest basic-wc-cpu: SKIP (0.000s)
[963.751565] [123/132] ( 61s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[963.805879] Starting subtest: multi-wait-all-for-submit-available-signaled
[963.808245] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[963.890072] [124/132] ( 61s left) kms_big_fb (x-tiled-addfb)
[963.990316] Starting subtest: x-tiled-addfb
[963.992628] Subtest x-tiled-addfb: SUCCESS (0.000s)
[964.064850] [125/132] ( 61s left) kms_flip_tiling (flip-change-tiling)
[964.159582] Starting subtest: flip-change-tiling
[964.161957] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[964.324414] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.165s)
[964.337390] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[964.458996] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[964.471493] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[964.592044] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[964.610158] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[964.747694] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.153s)
[964.760399] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[964.878968] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.131s)
[964.891890] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[965.012585] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.131s)
[965.025797] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[965.146675] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[965.159442] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[965.257564] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[965.270058] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[965.392229] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[965.404857] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[965.524509] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.131s)
[965.537665] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[965.667739] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[965.680856] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[965.812175] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[965.824994] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[965.946664] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[965.959440] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[966.080708] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[966.093451] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[966.190983] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[966.201456] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[966.363724] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.170s)
[966.376155] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[966.506300] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[966.518914] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[966.650723] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[966.662921] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[966.784497] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.131s)
[966.796999] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[966.918368] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.131s)
[966.931110] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[967.051588] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.131s)
[967.064773] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[967.173719] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s)
[967.186440] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[967.317559] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s)
[967.330182] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[967.462132] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[967.480238] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[967.617452] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.153s)
[967.628800] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[967.761586] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[967.777706] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[967.906068] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[967.918473] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[968.050683] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s)
[968.063115] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[968.173354] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s)
[968.186225] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[968.317669] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.142s)
[968.330746] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[968.461337] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[968.476133] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[968.605971] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[968.619673] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[968.751390] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[968.763796] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[968.894576] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s)
[968.910353] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[969.039586] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s)
[969.051349] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[969.161731] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.120s)
[969.214408] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[970.469901] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.262s)
[970.482085] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[970.604377] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[970.617129] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[970.737984] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[970.750364] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[970.880916] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[970.893712] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[971.024895] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[971.039896] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[971.180025] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.153s)
[971.192050] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[971.325669] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.142s)
[971.338313] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[971.436993] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[971.449347] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[971.570725] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[971.583588] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[971.702933] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.131s)
[971.715578] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[971.846688] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[971.859046] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[971.991082] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[972.003446] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[972.125259] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[972.137332] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[972.260113] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[972.272574] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[972.370066] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[972.382574] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[972.514084] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[972.527194] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[972.646918] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.131s)
[972.659055] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[972.780370] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.131s)
[972.792958] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[972.913485] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.131s)
[972.926363] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[973.047670] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.131s)
[973.060316] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[973.192035] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.141s)
[973.205096] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[973.313461] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s)
[973.324694] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[973.457365] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.142s)
[973.468966] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[973.601706] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s)
[973.613989] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[973.746240] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.144s)
[973.758116] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[973.890793] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[973.902207] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[974.023772] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.131s)
[974.038203] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[974.168405] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s)
[974.181886] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[974.290624] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s)
[974.302751] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[974.435208] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s)
[974.448214] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[974.568145] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.131s)
[974.582611] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[974.712475] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[974.726686] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[974.856965] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[974.871856] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[975.001574] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s)
[975.016318] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[975.146183] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s)
[975.160479] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[975.268667] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.119s)
[975.321020] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[976.510118] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.196s)
[976.522828] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[976.610849] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[976.623914] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[976.710664] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[976.723475] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[976.810629] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.098s)
[976.823559] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[976.920722] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.110s)
[976.932326] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[977.021134] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.099s)
[977.033392] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[977.121368] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[977.133844] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[977.221856] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[977.234231] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[977.321344] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[977.333859] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[977.476232] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.152s)
[977.489105] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[977.585573] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[977.597808] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[977.685818] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.098s)
[977.697797] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[977.786240] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[977.800832] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[977.886315] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[977.899271] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[977.986183] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[977.997765] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[978.097510] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[978.109375] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[978.196744] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.098s)
[978.207432] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[978.296666] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.099s)
[978.307475] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[978.396654] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.099s)
[978.408724] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[978.496671] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[978.509219] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[978.596746] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.099s)
[978.609125] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[978.707961] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.110s)
[978.720052] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[978.818804] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s)
[978.829007] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[978.929702] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.109s)
[978.939896] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[979.029557] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.098s)
[979.041043] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[979.140949] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s)
[979.151276] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[979.240426] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.099s)
[979.252138] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[979.351857] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.110s)
[979.362489] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[979.462832] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.109s)
[979.475332] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[979.585434] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.120s)
[979.598283] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[979.685064] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.098s)
[979.702110] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[979.795819] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[979.808242] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[979.907301] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[979.919498] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[980.018554] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.109s)
[980.030986] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[980.129481] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.109s)
[980.141959] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[980.251742] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.119s)
[980.292911] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[981.540839] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.254s)
[981.553954] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[981.640157] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[981.651433] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[981.740666] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[981.753136] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[981.873969] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.131s)
[981.886382] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[982.022883] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.147s)
[982.034714] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[982.133881] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s)
[982.146245] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[982.234525] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[982.246436] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[982.334308] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[982.346523] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[982.434290] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[982.446388] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[982.545218] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[982.557503] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[982.655390] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[982.667093] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[982.766861] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s)
[982.778564] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[982.867281] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[982.884505] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[982.978524] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.110s)
[982.991033] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[983.078311] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[983.094390] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[983.189587] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.110s)
[983.202450] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[983.299912] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[983.311775] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[983.399729] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.098s)
[983.411742] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[983.500224] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.098s)
[983.512804] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[983.600672] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[983.613431] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[983.700657] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.098s)
[983.713307] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[983.811460] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s)
[983.824357] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[983.922164] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s)
[983.934553] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[984.033405] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.109s)
[984.044787] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[984.144300] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s)
[984.156230] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[984.244204] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.098s)
[984.254582] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[984.343923] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.099s)
[984.356093] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[984.455269] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s)
[984.469076] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[984.577703] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.119s)
[984.591732] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[984.688714] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s)
[984.700982] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[984.788611] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.098s)
[984.802829] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[984.900329] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[984.910777] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[985.010892] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[985.022852] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[985.121683] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.109s)
[985.136006] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[985.233104] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.109s)
[985.245722] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[985.344464] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s)
[985.377325] Subtest flip-change-tiling: SUCCESS (21.224s)
[986.620039] [126/132] ( 38s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[986.727518] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[991.356887] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.634s)
[992.528929] [127/132] ( 33s left) kms_panel_fitting (legacy)
[992.645510] Starting subtest: legacy
[992.647723] Starting dynamic subtest: pipe-A-eDP-1
[993.175726] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.532s)
[993.204021] Starting dynamic subtest: pipe-B-eDP-1
[994.688750] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.493s)
[994.718814] Starting dynamic subtest: pipe-C-eDP-1
[996.198497] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.489s)
[996.224534] Starting dynamic subtest: pipe-D-eDP-1
[997.749612] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.531s)
[997.751853] Subtest legacy: SUCCESS (5.106s)
[998.927654] [128/132] ( 26s left) kms_big_fb (4-tiled-addfb-size-overflow)
[999.033138] Starting subtest: 4-tiled-addfb-size-overflow
[999.035614] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[999.128521] [129/132] ( 26s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[999.225919] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[1003.689993] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.469s)
[1004.836096] [130/132] ( 20s left) gem_flink_basic (basic)
[1004.901595] Starting subtest: basic
[1004.903474] Subtest basic: SUCCESS (0.000s)
[1004.996575] [131/132] ( 20s left) gen7_exec_parse (chained-batch)
[1005.056689] Subtest chained-batch: SKIP (0.000s)
[1005.143869] [132/132] ( 20s left) kms_addfb_basic (bad-pitch-32)
[1005.198772] Starting subtest: bad-pitch-32
[1005.200605] Subtest bad-pitch-32: SUCCESS (0.000s)
[1005.301667] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_freq
results: parsing output: 1/ for test: prime_self_import
results: parsing output: 2/ for test: core_setmaster
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: kms_flip_scaled_crc
results: parsing output: 5/ for test: gem_mmap_gtt
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: i915_pm_rpm
results: parsing output: 8/ for test: perf_pmu
results: parsing output: 9/ for test: kms_plane_multiple
results: parsing output: 10/ for test: kms_getfb
results: parsing output: 11/ for test: gem_exec_params
results: parsing output: 12/ for test: gem_mmap_wc
results: parsing output: 13/ for test: kms_pm_rpm
results: parsing output: 14/ for test: perf
results: parsing output: 15/ for test: gem_ctx_persistence
results: parsing output: 16/ for test: gem_busy
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: perf
results: parsing output: 19/ for test: kms_pm_backlight
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: i915_drm_fdinfo
results: parsing output: 23/ for test: kms_rotation_crc
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_plane_alpha_blend
results: parsing output: 26/ for test: kms_chamelium_color
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: syncobj_eventfd
results: parsing output: 30/ for test: kms_pm_rpm
results: parsing output: 31/ for test: kms_dsc
results: parsing output: 32/ for test: gem_tiled_wc
results: parsing output: 33/ for test: gem_mmap_gtt
results: parsing output: 34/ for test: kms_async_flips
results: parsing output: 35/ for test: gem_exec_basic
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: gem_sync
results: parsing output: 38/ for test: gem_partial_pwrite_pread
results: parsing output: 39/ for test: gem_pxp
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_color_pipeline
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: gem_exec_fence
results: parsing output: 46/ for test: kms_chamelium_hpd
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_softpin
results: parsing output: 49/ for test: i915_getparams_basic
results: parsing output: 50/ for test: kms_content_protection
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: gem_barrier_race
results: parsing output: 55/ for test: kms_busy
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: syncobj_basic
results: parsing output: 58/ for test: gem_media_fill
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_watchdog
results: parsing output: 61/ for test: gem_tiled_blits
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: gem_exec_whisper
results: parsing output: 64/ for test: kms_chamelium_edid
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_ringfill
results: parsing output: 68/ for test: gem_pread
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: gem_eio
results: parsing output: 72/ for test: gem_close_race
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_lmem_swapping
results: parsing output: 76/ for test: kms_atomic_transition
results: parsing output: 77/ for test: gem_spin_batch
results: parsing output: 78/ for test: kms_vblank
results: parsing output: 79/ for test: perf_pmu
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: sysfs_timeslice_duration
results: parsing output: 83/ for test: core_auth
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_lease
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: kms_vblank
results: parsing output: 90/ for test: gem_exec_params
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: kms_invalid_mode
results: parsing output: 95/ for test: api_intel_allocator
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_plane_scaling
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: i915_suspend
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: gem_exec_balancer
results: parsing output: 106/ for test: kms_psr2_sf
results: parsing output: 107/ for test: gem_exec_params
results: parsing output: 108/ for test: syncobj_wait
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_addfb_basic
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_cursor_crc
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_exec_schedule
results: parsing output: 121/ for test: gem_exec_reloc
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_flip_tiling
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_panel_fitting
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_flink_basic
results: parsing output: 130/ for test: gen7_exec_parse
results: parsing output: 131/ for test: kms_addfb_basic
Done.