[65.865283] Initializing watchdogs [65.865352] /dev/watchdog0 [65.886786] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [65.898044] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [65.901876] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [65.904687] [001/154] (960s left) kms_frontbuffer_tracking (fbc-tiling-linear) [67.432477] Starting subtest: fbc-tiling-linear [69.782470] Subtest fbc-tiling-linear: SUCCESS (2.354s) [70.029488] [002/154] (956s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [70.103055] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [70.178497] [003/154] (956s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [71.692525] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc [71.694363] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [71.911065] [004/154] (954s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [73.428932] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt [73.431144] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [73.608217] [005/154] (953s left) kms_force_connector_basic (prune-stale-modes) [73.784034] Starting subtest: prune-stale-modes [73.916223] Subtest prune-stale-modes: SUCCESS (0.132s) [74.847917] [006/154] (952s left) perf_pmu (most-busy-check-all) [74.920210] Starting subtest: most-busy-check-all [74.921199] Starting dynamic subtest: rcs0 [75.510907] Dynamic subtest rcs0: SUCCESS (0.591s) [75.523014] Starting dynamic subtest: bcs0 [76.068407] Dynamic subtest bcs0: SUCCESS (0.557s) [76.078572] Starting dynamic subtest: vcs0 [76.619671] Dynamic subtest vcs0: SUCCESS (0.551s) [76.630719] Starting dynamic subtest: vcs1 [77.171496] Dynamic subtest vcs1: SUCCESS (0.552s) [77.180763] Starting dynamic subtest: vecs0 [77.724500] Dynamic subtest vecs0: SUCCESS (0.553s) [77.733755] Starting dynamic subtest: vecs1 [78.274604] Dynamic subtest vecs1: SUCCESS (0.550s) [78.284193] Starting dynamic subtest: ccs0 [78.825885] Dynamic subtest ccs0: SUCCESS (0.551s) [78.826791] Subtest most-busy-check-all: SUCCESS (3.907s) [78.985467] [007/154] (947s left) gem_ccs (large-ctrl-surf-copy) [79.063582] Starting subtest: large-ctrl-surf-copy [79.718861] Subtest large-ctrl-surf-copy: SUCCESS (0.655s) [79.877376] [008/154] (947s left) kms_plane_alpha_blend (coverage-7efc) [81.385267] Starting subtest: coverage-7efc [81.641921] Starting dynamic subtest: pipe-A-HDMI-A-1 [82.084847] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.442s) [82.115566] Starting dynamic subtest: pipe-D-HDMI-A-1 [82.698289] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.591s) [82.699258] Subtest coverage-7efc: SUCCESS (1.312s) [82.889148] [009/154] (944s left) gem_mmap_gtt (fault-concurrent) [82.967045] Subtest fault-concurrent: SKIP (0.000s) [83.030788] [010/154] (944s left) api_intel_allocator (gem-pool) [83.101949] Starting subtest: gem-pool [83.136492] Subtest gem-pool: SUCCESS (0.035s) [83.321022] [011/154] (943s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-fullscreen) [84.835743] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-fullscreen [84.837738] Subtest fbchdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [85.011512] [012/154] (942s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier) [86.525187] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier [86.555462] Starting dynamic subtest: pipe-A-plane-0 [87.123457] Dynamic subtest pipe-A-plane-0: SUCCESS (0.567s) [87.160187] Starting dynamic subtest: pipe-A-plane-3 [87.472750] Dynamic subtest pipe-A-plane-3: SUCCESS (0.349s) [87.509883] Starting dynamic subtest: pipe-A-plane-5 [87.512569] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [87.658254] Starting dynamic subtest: pipe-B-plane-0 [88.044642] Dynamic subtest pipe-B-plane-0: SUCCESS (0.400s) [88.056179] Starting dynamic subtest: pipe-B-plane-3 [88.411389] Dynamic subtest pipe-B-plane-3: SUCCESS (0.366s) [88.428876] Starting dynamic subtest: pipe-B-plane-5 [88.431661] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [88.471532] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SUCCESS (1.945s) [88.688835] [013/154] (938s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs) [90.201999] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs [90.202985] Starting dynamic subtest: pipe-A-HDMI-A-1 [90.211985] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [90.221814] Starting dynamic subtest: pipe-B-HDMI-A-1 [90.230765] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [90.240436] Starting dynamic subtest: pipe-C-HDMI-A-1 [90.249206] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [90.258807] Starting dynamic subtest: pipe-D-HDMI-A-1 [90.270049] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s) [90.271951] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s) [90.522552] [014/154] (936s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs) [92.030296] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs [92.031243] Starting dynamic subtest: pipe-A-HDMI-A-1 [92.040151] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [92.049981] Starting dynamic subtest: pipe-B-HDMI-A-1 [92.059225] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [92.068885] Starting dynamic subtest: pipe-C-HDMI-A-1 [92.077290] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [92.086509] Starting dynamic subtest: pipe-D-HDMI-A-1 [92.095334] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [92.097236] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s) [92.332441] [015/154] (935s left) kms_frontbuffer_tracking (hdr-rgb565-draw-blt) [93.849058] Starting subtest: hdr-rgb565-draw-blt [93.851159] Subtest hdr-rgb565-draw-blt: SKIP (0.000s) [93.996526] [016/154] (933s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [94.092463] Starting subtest: x-tiled-to-vebox-y-tiled [94.094566] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [94.339490] [017/154] (933s left) sysfs_heartbeat_interval (invalid) [94.417563] Starting subtest: invalid [94.418521] Starting dynamic subtest: vecs0 [94.419454] Dynamic subtest vecs0: SUCCESS (0.000s) [94.429284] Starting dynamic subtest: ccs0 [94.430418] Dynamic subtest ccs0: SUCCESS (0.000s) [94.440112] Starting dynamic subtest: vcs0 [94.441375] Dynamic subtest vcs0: SUCCESS (0.000s) [94.450890] Starting dynamic subtest: bcs0 [94.452213] Dynamic subtest bcs0: SUCCESS (0.000s) [94.462064] Starting dynamic subtest: vecs1 [94.463348] Dynamic subtest vecs1: SUCCESS (0.000s) [94.472782] Starting dynamic subtest: rcs0 [94.473993] Dynamic subtest rcs0: SUCCESS (0.000s) [94.483641] Starting dynamic subtest: vcs1 [94.484840] Dynamic subtest vcs1: SUCCESS (0.000s) [94.486026] Subtest invalid: SUCCESS (0.005s) [94.533281] [018/154] (933s left) kms_frontbuffer_tracking (fbc-stridechange) [96.050532] Starting subtest: fbc-stridechange [97.992101] Subtest fbc-stridechange: SUCCESS (1.940s) [98.225685] [019/154] (929s left) gem_ctx_param (basic-default) [98.299547] Starting subtest: basic-default [98.300472] Subtest basic-default: SUCCESS (0.000s) [98.390439] [020/154] (929s left) kms_psr (fbc-pr-primary-mmap-gtt) [99.899443] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s) [99.966142] [021/154] (927s left) i915_pm_freq_mult (media-freq) [100.050568] Starting subtest: media-freq [100.051555] Starting dynamic subtest: gt0 [100.557465] Dynamic subtest gt0: SUCCESS (0.506s) [100.558629] Subtest media-freq: SUCCESS (0.507s) [100.694518] [022/154] (927s left) prime_busy (before-wait) [100.769972] Starting subtest: before-wait [100.774233] Starting dynamic subtest: rcs0 [100.829116] Dynamic subtest rcs0: SUCCESS (0.055s) [100.839408] Starting dynamic subtest: bcs0 [100.878380] Dynamic subtest bcs0: SUCCESS (0.049s) [100.892487] Starting dynamic subtest: vcs0 [100.920174] Dynamic subtest vcs0: SUCCESS (0.041s) [100.943608] Starting dynamic subtest: vcs1 [100.963746] Dynamic subtest vcs1: SUCCESS (0.043s) [100.986406] Starting dynamic subtest: vecs0 [101.004721] Dynamic subtest vecs0: SUCCESS (0.041s) [101.020824] Starting dynamic subtest: vecs1 [101.045523] Dynamic subtest vecs1: SUCCESS (0.040s) [101.061832] Starting dynamic subtest: ccs0 [101.086357] Dynamic subtest ccs0: SUCCESS (0.040s) [101.195065] Subtest before-wait: SUCCESS (0.425s) [101.369458] [023/154] (926s left) gem_exec_gttfill (engines) [101.450387] Starting subtest: engines [101.451384] Starting dynamic subtest: rcs0 [127.486388] Dynamic subtest rcs0: SUCCESS (26.036s) [127.496913] Starting dynamic subtest: bcs0 [153.730953] Dynamic subtest bcs0: SUCCESS (26.244s) [153.741429] Starting dynamic subtest: vcs0 [179.865446] Dynamic subtest vcs0: SUCCESS (26.133s) [179.875831] Starting dynamic subtest: vcs1 [206.043398] Dynamic subtest vcs1: SUCCESS (26.177s) [206.053704] Starting dynamic subtest: vecs0 [232.248453] Dynamic subtest vecs0: SUCCESS (26.204s) [232.258849] Starting dynamic subtest: vecs1 [258.405404] Dynamic subtest vecs1: SUCCESS (26.156s) [258.415816] Starting dynamic subtest: ccs0 [284.602928] Dynamic subtest ccs0: SUCCESS (26.196s) [284.603903] Subtest engines: SUCCESS (183.149s) [284.864656] [024/154] (743s left) syncobj_timeline (etime-multi-wait-all-submitted) [284.981041] Starting subtest: etime-multi-wait-all-submitted [285.082244] Subtest etime-multi-wait-all-submitted: SUCCESS (0.102s) [285.175528] [025/154] (742s left) gem_ctx_param (get-priority-new-ctx) [285.264484] Starting subtest: get-priority-new-ctx [285.266401] Subtest get-priority-new-ctx: SUCCESS (0.001s) [285.413946] [026/154] (742s left) kms_big_fb (linear-32bpp-rotate-90) [286.939306] Starting subtest: linear-32bpp-rotate-90 [287.000097] Subtest linear-32bpp-rotate-90: SKIP (0.060s) [287.179165] [027/154] (741s left) gem_lmem_swapping (heavy-verify-multi-ccs) [291.798744] Starting subtest: heavy-verify-multi-ccs [291.799804] Starting dynamic subtest: lmem0 [300.528223] Dynamic subtest lmem0: SUCCESS (8.729s) [300.529227] Subtest heavy-verify-multi-ccs: SUCCESS (8.729s) [301.683390] [FACT gem_lmem_swapping (heavy-verify-multi-ccs)] deleted: kernel.kmod_is_loaded.i915: true [301.684955] [028/154] (726s left) gem_ctx_shared (disjoint-timelines) [305.276255] Starting subtest: disjoint-timelines [305.349360] Subtest disjoint-timelines: SUCCESS (0.074s) [305.566991] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.i915: true [305.567893] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true [305.569784] [029/154] (722s left) kms_psr (fbc-psr2-cursor-plane-move) [307.089393] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s) [307.145341] [030/154] (721s left) gem_bad_reloc (negative-reloc-bltcopy) [307.239393] Subtest negative-reloc-bltcopy: SKIP (0.000s) [307.328827] [031/154] (721s left) kms_chamelium_hpd (hdmi-hpd) [308.895444] Subtest hdmi-hpd: SKIP (0.000s) [309.025837] [032/154] (719s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf) [310.557414] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [310.626167] [033/154] (717s left) gem_eio (wait-10ms) [310.872991] Starting subtest: wait-10ms [311.359242] Subtest wait-10ms: SUCCESS (0.486s) [312.995404] [034/154] (715s left) kms_content_protection (legacy-hdcp14) [314.587225] Starting subtest: legacy-hdcp14 [314.590065] Subtest legacy-hdcp14: SKIP (0.002s) [314.816252] [035/154] (714s left) syncobj_wait (reset-signaled) [314.897146] Starting subtest: reset-signaled [314.898172] Subtest reset-signaled: SUCCESS (0.000s) [315.045916] [036/154] (713s left) gem_ctx_isolation (dirty-switch) [315.137290] Starting subtest: dirty-switch [315.138617] Starting dynamic subtest: rcs0 [315.800171] Dynamic subtest rcs0: SUCCESS (0.664s) [315.812119] Starting dynamic subtest: bcs0 [316.450635] Dynamic subtest bcs0: SUCCESS (0.650s) [316.462373] Starting dynamic subtest: vcs0 [317.102543] Dynamic subtest vcs0: SUCCESS (0.652s) [317.113876] Starting dynamic subtest: vcs1 [317.764142] Dynamic subtest vcs1: SUCCESS (0.661s) [317.775450] Starting dynamic subtest: vecs0 [318.408086] Dynamic subtest vecs0: SUCCESS (0.644s) [318.419626] Starting dynamic subtest: vecs1 [319.057227] Dynamic subtest vecs1: SUCCESS (0.649s) [319.069175] Starting dynamic subtest: ccs0 [319.715994] Dynamic subtest ccs0: SUCCESS (0.658s) [319.717292] Subtest dirty-switch: SUCCESS (4.580s) [319.966916] [037/154] (708s left) gem_flink_basic (bad-open) [320.048313] Starting subtest: bad-open [320.049241] Subtest bad-open: SUCCESS (0.000s) [320.195204] [038/154] (708s left) gem_caching (writes) [320.285805] Starting subtest: writes [324.577578] Subtest writes: SUCCESS (4.292s) [324.761085] [039/154] (704s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers) [326.275399] Starting subtest: plane-scaler-unity-scaling-with-modifiers [326.276397] Starting dynamic subtest: pipe-A [326.846547] Dynamic subtest pipe-A: SUCCESS (0.571s) [326.873082] Starting dynamic subtest: pipe-B [327.454442] Dynamic subtest pipe-B: SUCCESS (0.607s) [327.473839] Starting dynamic subtest: pipe-C [328.030298] Dynamic subtest pipe-C: SUCCESS (0.575s) [328.048512] Starting dynamic subtest: pipe-D [328.605932] Dynamic subtest pipe-D: SUCCESS (0.575s) [328.607250] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (2.331s) [328.918379] [040/154] (700s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [329.003201] Starting subtest: single-wait-all-for-submit-available-submitted [329.004234] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [329.116227] [041/154] (700s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-render) [330.641991] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-render [330.643952] Subtest fbchdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [330.855824] [042/154] (698s left) kms_pm_rpm (system-suspend-idle) [335.031768] Starting subtest: system-suspend-idle [356.426403] Subtest system-suspend-idle: SUCCESS (6.647s) [361.468434] [043/154] (671s left) kms_atomic_transition (modeset-transition) [362.956123] Starting subtest: modeset-transition [362.957048] Starting dynamic subtest: 1x-outputs [364.974996] Dynamic subtest 1x-outputs: SUCCESS (2.056s) [364.977076] Subtest modeset-transition: SUCCESS (2.059s) [365.180162] [044/154] (668s left) kms_frontbuffer_tracking (pipe-fbc-rte) [366.685561] Starting subtest: pipe-fbc-rte [366.691525] Subtest pipe-fbc-rte: SKIP (0.000s) [366.877494] [045/154] (666s left) gem_spin_batch (resubmit-all) [366.966497] Starting subtest: resubmit-all [366.967463] Starting dynamic subtest: rcs0 [367.001149] Dynamic subtest rcs0: SUCCESS (0.035s) [367.014961] Starting dynamic subtest: bcs0 [367.015955] Dynamic subtest bcs0: SUCCESS (0.003s) [367.029686] Starting dynamic subtest: vcs0 [367.030692] Dynamic subtest vcs0: SUCCESS (0.003s) [367.043588] Starting dynamic subtest: vcs1 [367.044749] Dynamic subtest vcs1: SUCCESS (0.002s) [367.057341] Starting dynamic subtest: vecs0 [367.058582] Dynamic subtest vecs0: SUCCESS (0.003s) [367.071408] Starting dynamic subtest: vecs1 [367.072480] Dynamic subtest vecs1: SUCCESS (0.003s) [367.085203] Starting dynamic subtest: ccs0 [367.086455] Dynamic subtest ccs0: SUCCESS (0.002s) [367.087690] Subtest resubmit-all: SUCCESS (0.055s) [367.314621] [046/154] (666s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff) [368.830484] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff [368.832340] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [368.998049] [047/154] (664s left) syncobj_basic (illegal-fd-to-handle) [369.084071] Starting subtest: illegal-fd-to-handle [369.085006] Subtest illegal-fd-to-handle: SUCCESS (0.000s) [369.220607] [048/154] (664s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite) [370.731834] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite [370.733633] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [370.959155] [049/154] (663s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180) [372.478371] Starting subtest: linear-max-hw-stride-32bpp-rotate-180 [373.791518] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.320s) [374.013033] [050/154] (660s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted) [374.094352] Starting subtest: etime-single-wait-all-for-submit-unsubmitted [374.207879] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s) [374.361824] [051/154] (659s left) api_intel_bb (misplaced-blitter) [374.444200] Starting subtest: misplaced-blitter [374.478585] Subtest misplaced-blitter: SUCCESS (0.035s) [374.644637] [052/154] (659s left) kms_atomic_interruptible (universal-setplane-cursor) [376.154152] Starting subtest: universal-setplane-cursor [376.155124] Starting dynamic subtest: pipe-A-HDMI-A-1 [382.354781] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.218s) [382.355860] Subtest universal-setplane-cursor: SUCCESS (6.219s) [382.568161] [053/154] (651s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [384.103791] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [384.105627] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [384.269860] [054/154] (650s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [385.800909] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc [385.803050] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [385.973723] [055/154] (648s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling) [387.490947] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling [387.493128] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s) [387.685503] [056/154] (646s left) gem_pxp (create-protected-buffer) [390.299526] Starting subtest: create-protected-buffer [390.301332] Subtest create-protected-buffer: SKIP (0.000s) [390.394226] [057/154] (644s left) gen9_exec_parse (allowed-single) [390.486497] Subtest allowed-single: SKIP (0.000s) [390.569506] [058/154] (644s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu) [392.097614] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu [392.099410] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [392.239561] [059/154] (642s left) gem_exec_balancer (bonded-semaphore) [392.351221] Starting subtest: bonded-semaphore [392.353540] Subtest bonded-semaphore: SKIP (0.000s) [392.841987] [060/154] (642s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping) [394.365621] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping [394.367438] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s) [394.485427] [061/154] (640s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc) [396.034692] Starting subtest: fbc-rgb565-draw-mmap-wc [396.036517] Subtest fbc-rgb565-draw-mmap-wc: SKIP (0.000s) [396.248513] [062/154] (638s left) kms_pwrite_crc (basic) [397.773136] Starting subtest: basic [398.361709] Subtest basic: SUCCESS (0.589s) [398.596100] [063/154] (636s left) gem_flink_basic (bad-flink) [398.677271] Starting subtest: bad-flink [398.678208] Subtest bad-flink: SUCCESS (0.000s) [398.882758] [064/154] (636s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-move) [400.408903] Starting subtest: hdr-2p-primscrn-spr-indfb-move [400.410773] Subtest hdr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [400.551202] [065/154] (634s left) gem_ctx_persistence (legacy-engines-persistence) [400.653408] Starting subtest: legacy-engines-persistence [400.654409] Starting dynamic subtest: render [401.510709] Dynamic subtest render: SUCCESS (0.856s) [401.530117] Starting dynamic subtest: bsd1 [402.264293] Dynamic subtest bsd1: SUCCESS (0.751s) [402.281566] Starting dynamic subtest: bsd2 [403.026143] Dynamic subtest bsd2: SUCCESS (0.757s) [403.042818] Starting dynamic subtest: blt [403.794463] Dynamic subtest blt: SUCCESS (0.765s) [403.810763] Starting dynamic subtest: vebox [404.572261] Dynamic subtest vebox: SUCCESS (0.775s) [404.574177] Subtest legacy-engines-persistence: SUCCESS (3.920s) [404.725858] [066/154] (630s left) gen7_exec_parse (basic-allowed) [404.815029] Subtest basic-allowed: SKIP (0.000s) [404.883935] [067/154] (630s left) gem_exec_schedule (reorder-wide) [405.093445] Subtest reorder-wide: SKIP (0.000s) [405.352741] [068/154] (630s left) kms_frontbuffer_tracking (psrhdr-slowdraw) [406.876854] Starting subtest: psrhdr-slowdraw [406.878751] Subtest psrhdr-slowdraw: SKIP (0.000s) [407.029677] [069/154] (628s left) perf (non-zero-reason) [407.437880] Starting subtest: non-zero-reason [407.438768] Starting dynamic subtest: 0-rcs0 [410.518103] Dynamic subtest 0-rcs0: FAIL (2.759s) [410.519821] Subtest non-zero-reason: FAIL (2.759s) [410.601116] [070/154] (625s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-pwrite) [412.123156] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-pwrite [412.124945] Subtest fbchdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [412.297243] [071/154] (623s left) i915_drm_fdinfo (all-busy-check-all) [412.371672] Starting subtest: all-busy-check-all [412.402411] Subtest all-busy-check-all: SKIP (0.030s) [412.548997] [072/154] (623s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt) [414.098204] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt [414.100151] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [414.269678] [073/154] (621s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [415.789171] Starting subtest: compare-crc-sanitycheck-nv12 [415.790202] Starting dynamic subtest: pipe-A-HDMI-A-1 [416.473292] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.683s) [416.488963] Starting dynamic subtest: pipe-B-HDMI-A-1 [417.059372] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.584s) [417.073978] Starting dynamic subtest: pipe-C-HDMI-A-1 [417.616827] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.556s) [417.632360] Starting dynamic subtest: pipe-D-HDMI-A-1 [418.187973] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.569s) [418.188927] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.400s) [418.394153] [074/154] (617s left) gem_exec_reloc (basic-write-gtt) [418.482866] Subtest basic-write-gtt: SKIP (0.000s) [418.566030] [075/154] (617s left) kms_cursor_crc (cursor-rapid-movement-max-size) [420.414199] Starting subtest: cursor-rapid-movement-max-size [420.416691] Subtest cursor-rapid-movement-max-size: SKIP (0.000s) [420.615710] [076/154] (615s left) kms_color_pipeline (plane-lut1d) [422.131743] Starting subtest: plane-lut1d [422.333699] Starting dynamic subtest: pipe-A-plane-0 [422.582465] Dynamic subtest pipe-A-plane-0: SUCCESS (0.249s) [422.625373] Starting dynamic subtest: pipe-A-plane-1 [422.782515] Dynamic subtest pipe-A-plane-1: SUCCESS (0.197s) [422.826866] Starting dynamic subtest: pipe-A-plane-2 [422.999167] Dynamic subtest pipe-A-plane-2: SUCCESS (0.213s) [423.338083] Starting dynamic subtest: pipe-B-plane-0 [423.498361] Dynamic subtest pipe-B-plane-0: SUCCESS (0.199s) [423.541514] Starting dynamic subtest: pipe-B-plane-1 [423.698247] Dynamic subtest pipe-B-plane-1: SUCCESS (0.196s) [423.719320] Starting dynamic subtest: pipe-B-plane-2 [423.864938] Dynamic subtest pipe-B-plane-2: SUCCESS (0.163s) [424.187824] Starting dynamic subtest: pipe-C-plane-0 [424.349742] Dynamic subtest pipe-C-plane-0: SUCCESS (0.198s) [424.389741] Starting dynamic subtest: pipe-C-plane-1 [424.549673] Dynamic subtest pipe-C-plane-1: SUCCESS (0.196s) [424.589029] Starting dynamic subtest: pipe-C-plane-2 [424.766369] Dynamic subtest pipe-C-plane-2: SUCCESS (0.213s) [425.094591] Starting dynamic subtest: pipe-D-plane-0 [425.274367] Dynamic subtest pipe-D-plane-0: SUCCESS (0.215s) [425.312440] Starting dynamic subtest: pipe-D-plane-1 [425.491267] Dynamic subtest pipe-D-plane-1: SUCCESS (0.213s) [425.532263] Starting dynamic subtest: pipe-D-plane-2 [425.706341] Dynamic subtest pipe-D-plane-2: SUCCESS (0.211s) [425.730437] Subtest plane-lut1d: SUCCESS (3.599s) [426.010105] [077/154] (610s left) kms_big_fb (yf-tiled-16bpp-rotate-180) [427.541425] Starting subtest: yf-tiled-16bpp-rotate-180 [427.543396] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s) [427.774286] [078/154] (608s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0) [429.305030] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0 [430.571325] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.266s) [430.781917] [079/154] (605s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt) [432.303983] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt [432.305890] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [432.480463] [080/154] (604s left) gem_exec_reloc (basic-wc-read) [432.570603] Subtest basic-wc-read: SKIP (0.000s) [432.663616] [081/154] (604s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle) [434.188264] Starting subtest: short-busy-flip-before-cursor-toggle [434.190148] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s) [434.311814] [082/154] (602s left) kms_flip (2x-plain-flip-fb-recreate-interruptible) [435.859162] Starting subtest: 2x-plain-flip-fb-recreate-interruptible [435.874731] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.016s) [436.058292] [083/154] (600s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [437.586132] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu [437.587916] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [437.753179] [084/154] (599s left) kms_draw_crc (draw-method-render) [439.279180] Starting subtest: draw-method-render [439.280119] Starting dynamic subtest: xrgb8888-untiled [439.684499] Dynamic subtest xrgb8888-untiled: SUCCESS (0.404s) [439.728846] Starting dynamic subtest: rgb565-untiled [440.034266] Dynamic subtest rgb565-untiled: SUCCESS (0.346s) [440.081251] Starting dynamic subtest: xrgb2101010-untiled [440.367601] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.330s) [440.406897] Starting dynamic subtest: xbgr16161616f-untiled [440.734171] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.363s) [440.779237] Starting dynamic subtest: xrgb8888-xtiled [440.934290] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.197s) [440.981564] Starting dynamic subtest: rgb565-xtiled [441.117653] Dynamic subtest rgb565-xtiled: SUCCESS (0.179s) [441.164839] Starting dynamic subtest: xrgb2101010-xtiled [441.300614] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.178s) [441.342373] Starting dynamic subtest: xbgr16161616f-xtiled [441.482818] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.179s) [441.498844] Starting dynamic subtest: xrgb8888-4tiled [441.650498] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.166s) [441.697686] Starting dynamic subtest: rgb565-4tiled [441.834159] Dynamic subtest rgb565-4tiled: SUCCESS (0.180s) [441.881455] Starting dynamic subtest: xrgb2101010-4tiled [442.017331] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.179s) [442.062205] Starting dynamic subtest: xbgr16161616f-4tiled [442.200187] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.179s) [442.202289] Subtest draw-method-render: SUCCESS (2.923s) [442.370785] [085/154] (594s left) kms_cursor_crc (cursor-sliding-256x85) [444.143354] Starting subtest: cursor-sliding-256x85 [444.148311] Starting dynamic subtest: pipe-A-HDMI-A-1 [448.454404] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.308s) [448.499335] Starting dynamic subtest: pipe-D-HDMI-A-1 [452.449472] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (3.970s) [452.450455] Subtest cursor-sliding-256x85: SUCCESS (8.308s) [452.743565] [086/154] (584s left) kms_cursor_crc (cursor-onscreen-256x256) [454.493623] Starting subtest: cursor-onscreen-256x256 [454.498483] Starting dynamic subtest: pipe-A-HDMI-A-1 [457.240439] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.741s) [457.281879] Starting dynamic subtest: pipe-D-HDMI-A-1 [459.987447] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.717s) [459.988365] Subtest cursor-onscreen-256x256: SUCCESS (5.491s) [460.323354] [087/154] (577s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render) [461.847994] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render [461.849793] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [462.023052] [088/154] (575s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [463.555069] Starting subtest: fbcpsr-slowdraw [463.557056] Subtest fbcpsr-slowdraw: SKIP (0.000s) [463.728445] [089/154] (573s left) kms_lease (cursor-implicit-plane) [465.245942] Starting subtest: cursor-implicit-plane [465.248286] Starting dynamic subtest: pipe-A-HDMI-A-1 [465.612464] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.364s) [465.627327] Starting dynamic subtest: pipe-B-HDMI-A-1 [465.827207] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.214s) [465.844239] Starting dynamic subtest: pipe-C-HDMI-A-1 [466.063456] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.233s) [466.077945] Starting dynamic subtest: pipe-D-HDMI-A-1 [466.317819] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.253s) [466.318781] Subtest cursor-implicit-plane: SUCCESS (1.071s) [466.549026] [090/154] (571s left) syncobj_wait (invalid-reset-zero-handles) [466.626389] Starting subtest: invalid-reset-zero-handles [466.627359] Subtest invalid-reset-zero-handles: SUCCESS (0.000s) [466.775314] [091/154] (570s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [468.302194] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [468.303945] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [468.525194] [092/154] (569s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [470.055227] Starting subtest: yf-tiled-64bpp-rotate-90 [470.057221] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [470.205807] [093/154] (567s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc) [471.737917] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc [471.739964] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [471.894562] [094/154] (566s left) gem_exec_fence (long-history) [472.462146] Starting subtest: long-history [478.801210] Subtest long-history: SUCCESS (6.338s) [479.773114] [095/154] (558s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt) [481.297234] Starting subtest: psr-1p-primscrn-indfb-msflip-blt [481.298912] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [481.474893] [096/154] (556s left) kms_ccs (bad-rotation-90-yf-tiled-ccs) [483.005258] Starting subtest: bad-rotation-90-yf-tiled-ccs [483.006196] Starting dynamic subtest: pipe-A-HDMI-A-1 [483.014690] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [483.028482] Starting dynamic subtest: pipe-B-HDMI-A-1 [483.037104] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [483.050658] Starting dynamic subtest: pipe-C-HDMI-A-1 [483.060052] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [483.073418] Starting dynamic subtest: pipe-D-HDMI-A-1 [483.084122] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [483.086535] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.007s) [483.350771] [097/154] (554s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic) [484.867370] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic [486.830276] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.962s) [487.034758] [098/154] (551s left) kms_chamelium_audio (dp-audio-edid) [488.605162] Subtest dp-audio-edid: SKIP (0.000s) [488.733094] [099/154] (549s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [490.261292] Starting subtest: addfb25-yf-tiled-legacy [490.262349] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [490.424701] [100/154] (548s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-pgflip-blt) [491.954220] Starting subtest: hdr-1p-primscrn-indfb-pgflip-blt [491.956166] Subtest hdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [492.132704] [101/154] (546s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff) [493.663435] Starting subtest: psr-2p-primscrn-cur-indfb-onoff [493.665257] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [493.862859] [102/154] (544s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [495.385064] Starting subtest: fbc-2p-pri-indfb-multidraw [495.386951] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [495.560543] [103/154] (543s left) kms_sequence (queue-busy) [497.084551] Starting subtest: queue-busy [497.087051] Starting dynamic subtest: pipe-A-HDMI-A-1 [499.627649] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.542s) [499.643616] Starting dynamic subtest: pipe-B-HDMI-A-1 [502.040909] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.411s) [502.055561] Starting dynamic subtest: pipe-C-HDMI-A-1 [504.456002] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.414s) [504.470756] Starting dynamic subtest: pipe-D-HDMI-A-1 [506.874912] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.417s) [506.875899] Subtest queue-busy: SUCCESS (9.791s) [507.153150] [104/154] (531s left) kms_plane_scaling (plane-upscale-20x20-with-rotation) [508.670353] Starting subtest: plane-upscale-20x20-with-rotation [508.671250] Starting dynamic subtest: pipe-A [509.047088] Dynamic subtest pipe-A: SUCCESS (0.377s) [509.066943] Starting dynamic subtest: pipe-B [509.454916] Dynamic subtest pipe-B: SUCCESS (0.406s) [509.477130] Starting dynamic subtest: pipe-C [509.863410] Dynamic subtest pipe-C: SUCCESS (0.407s) [509.899634] Starting dynamic subtest: pipe-D [510.289221] Dynamic subtest pipe-D: SUCCESS (0.423s) [510.290406] Subtest plane-upscale-20x20-with-rotation: SUCCESS (1.621s) [510.560449] [105/154] (528s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-pwrite) [512.089147] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-pwrite [512.090853] Subtest psrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [512.286943] [106/154] (526s left) gem_exec_reloc (basic-write-wc) [512.380405] Subtest basic-write-wc: SKIP (0.000s) [512.466645] [107/154] (526s left) syncobj_timeline (reset-signaled) [512.546441] Starting subtest: reset-signaled [512.547378] Subtest reset-signaled: SUCCESS (0.000s) [512.705942] [108/154] (526s left) kms_psr (pr-cursor-plane-move) [514.220903] Subtest pr-cursor-plane-move: SKIP (0.000s) [514.279878] [109/154] (525s left) syncobj_wait (invalid-wait-illegal-handle) [514.356547] Starting subtest: invalid-wait-illegal-handle [514.357523] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [514.531407] [110/154] (524s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [516.060323] Starting subtest: extended-pageflip-modeset-hang-oldfb [516.061263] Starting dynamic subtest: pipe-A [523.869474] Dynamic subtest pipe-A: SUCCESS (7.809s) [523.886260] Starting dynamic subtest: pipe-D [531.639798] Dynamic subtest pipe-D: SUCCESS (7.767s) [531.640709] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (15.583s) [531.853136] [111/154] (507s left) kms_psr (psr2-primary-blt) [533.371726] Subtest psr2-primary-blt: SKIP (0.000s) [533.438827] [112/154] (506s left) gem_softpin (evict-snoop-interruptible) [533.534781] Starting subtest: evict-snoop-interruptible [533.536608] Subtest evict-snoop-interruptible: SKIP (0.000s) [533.697469] [113/154] (506s left) kms_force_connector_basic (force-load-detect) [533.878113] Starting subtest: force-load-detect [533.879848] Subtest force-load-detect: SKIP (0.000s) [534.832414] [114/154] (504s left) kms_chamelium_edid (hdmi-mode-timings) [536.396892] Subtest hdmi-mode-timings: SKIP (0.000s) [536.534353] [115/154] (503s left) syncobj_timeline (invalid-signal-zero-handles) [536.623457] Starting subtest: invalid-signal-zero-handles [536.624411] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [536.772859] [116/154] (503s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt) [538.297124] Starting subtest: fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt [538.299039] Subtest fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [538.475482] [117/154] (501s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [540.001294] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt [540.002993] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [540.158797] [118/154] (500s left) gem_mmap_gtt (fault-concurrent-x) [540.245330] Subtest fault-concurrent-X: SKIP (0.000s) [540.329955] [119/154] (499s left) gem_render_copy (y-tiled-to-vebox-y-tiled) [540.424143] Starting subtest: y-tiled-to-vebox-y-tiled [540.426128] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s) [540.685826] [120/154] (499s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-plflip-blt) [542.207522] Starting subtest: psrhdr-2p-scndscrn-shrfb-plflip-blt [542.209233] Subtest psrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [542.344877] [121/154] (498s left) vgem_basic (debugfs) [542.413356] Starting subtest: debugfs [542.414248] Subtest debugfs: SUCCESS (0.000s) [542.507191] [122/154] (497s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [544.027364] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [544.028308] Starting dynamic subtest: pipe-A-valid-mode [545.594579] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.567s) [545.595515] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.569s) [545.821247] [123/154] (494s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [547.345138] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [547.346870] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [547.574836] [124/154] (493s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [549.098432] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [549.100341] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [549.267629] [125/154] (491s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt) [550.794897] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt [550.796799] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [550.957600] [126/154] (489s left) kms_vblank (wait-forked-hang) [552.482382] Starting subtest: wait-forked-hang [552.483260] Starting dynamic subtest: pipe-A-HDMI-A-1 [579.246157] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (26.769s) [579.262235] Starting dynamic subtest: pipe-D-HDMI-A-1 [604.255911] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (24.999s) [604.256888] Subtest wait-forked-hang: SUCCESS (51.775s) [604.415556] [127/154] (436s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [605.940258] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling [605.941207] Starting dynamic subtest: pipe-A-valid-mode [609.652717] Dynamic subtest pipe-A-valid-mode: SUCCESS (3.711s) [609.653635] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SUCCESS (3.713s) [609.888956] [128/154] (431s left) gem_ctx_exec (basic-invalid-context) [609.974221] Starting subtest: basic-invalid-context [609.978448] Subtest basic-invalid-context: SUCCESS (0.004s) [610.142874] [129/154] (430s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt) [611.669997] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt [611.671843] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [611.840913] [130/154] (429s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [613.368311] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s) [613.441545] [131/154] (427s left) gem_ppgtt (blt-vs-render-ctxn) [613.538744] Starting subtest: blt-vs-render-ctxN [646.400451] Subtest blt-vs-render-ctxN: SUCCESS (32.858s) [646.632573] [132/154] (394s left) gem_exec_reloc (basic-gtt-cpu-noreloc) [646.756160] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s) [646.840404] [133/154] (394s left) gem_softpin (invalid) [646.926211] Starting subtest: invalid [646.939539] Subtest invalid: SUCCESS (0.013s) [647.105342] [134/154] (394s left) gem_exec_capture (capture) [647.202390] Starting subtest: capture [647.203374] Starting dynamic subtest: rcs0-smem [648.162447] Dynamic subtest rcs0-smem: SUCCESS (0.960s) [648.178320] Starting dynamic subtest: rcs0-lmem0 [649.601418] Dynamic subtest rcs0-lmem0: SUCCESS (1.438s) [649.616214] Starting dynamic subtest: bcs0-smem [650.512434] Dynamic subtest bcs0-smem: SUCCESS (0.909s) [650.527084] Starting dynamic subtest: bcs0-lmem0 [651.918465] Dynamic subtest bcs0-lmem0: SUCCESS (1.406s) [651.933204] Starting dynamic subtest: vcs0-smem [652.996421] Dynamic subtest vcs0-smem: SUCCESS (1.076s) [653.011076] Starting dynamic subtest: vcs0-lmem0 [653.910417] Dynamic subtest vcs0-lmem0: SUCCESS (0.913s) [653.924821] Starting dynamic subtest: vcs1-smem [654.982793] Dynamic subtest vcs1-smem: SUCCESS (1.071s) [654.997611] Starting dynamic subtest: vcs1-lmem0 [655.879394] Dynamic subtest vcs1-lmem0: SUCCESS (0.896s) [655.893879] Starting dynamic subtest: vecs0-smem [656.995595] Dynamic subtest vecs0-smem: FAIL (1.096s) [657.009765] Starting dynamic subtest: vecs0-lmem0 [658.319492] Dynamic subtest vecs0-lmem0: FAIL (1.321s) [658.333442] Starting dynamic subtest: vecs1-smem [659.726964] Dynamic subtest vecs1-smem: FAIL (1.406s) [659.741115] Starting dynamic subtest: vecs1-lmem0 [660.747720] Dynamic subtest vecs1-lmem0: FAIL (1.020s) [660.761702] Starting dynamic subtest: ccs0-smem [662.144433] Dynamic subtest ccs0-smem: SUCCESS (1.417s) [662.159111] Starting dynamic subtest: ccs0-lmem0 [663.569433] Dynamic subtest ccs0-lmem0: SUCCESS (1.424s) [663.570380] Subtest capture: FAIL (16.369s) [663.700377] [135/154] (377s left) gem_tiled_blits (basic) [663.787845] Subtest basic: SKIP (0.000s) [663.873726] [136/154] (377s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [665.400124] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [665.402122] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [665.555929] [137/154] (376s left) gem_mmap_offset (partial-remap) [665.645601] Starting subtest: partial-remap [665.646478] Starting dynamic subtest: lmem0 [665.648990] Dynamic subtest lmem0: SUCCESS (0.004s) [665.663984] Starting dynamic subtest: smem0 [665.666108] Dynamic subtest smem0: SUCCESS (0.004s) [665.667142] Subtest partial-remap: SUCCESS (0.010s) [665.860695] [138/154] (375s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-blt) [667.385220] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-blt [667.386922] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s) [667.580647] [139/154] (374s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-blt) [669.104866] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-blt [669.107204] Subtest hdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [669.246515] [140/154] (372s left) i915_power (sanity) [669.342376] Starting subtest: sanity [673.407451] Subtest sanity: SUCCESS (4.064s) [673.598280] [141/154] (368s left) gem_exec_schedule (preempt-queue) [673.701421] Subtest preempt-queue: SKIP (0.000s) [674.108583] [142/154] (368s left) kms_cursor_legacy (cursorb-vs-flipa-legacy) [675.627347] Starting subtest: cursorB-vs-flipA-legacy [675.629199] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s) [675.847720] [143/154] (366s left) i915_pm_rps (reset) [675.935218] Starting subtest: reset [680.740336] Subtest reset: SUCCESS (4.805s) [680.906532] [144/154] (361s left) kms_psr (fbc-psr-cursor-plane-onoff) [682.427033] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s) [682.489300] [145/154] (359s left) kms_setmode (clone-exclusive-crtc) [682.575698] Starting subtest: clone-exclusive-crtc [682.578270] Subtest clone-exclusive-crtc: SKIP (0.000s) [682.776752] [146/154] (359s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu) [684.301311] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu [684.303137] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [684.493251] [147/154] (358s left) kms_flip (flip-vs-rmfb) [686.013490] Starting subtest: flip-vs-rmfb [686.016911] Starting dynamic subtest: A-HDMI-A1 [693.810630] Dynamic subtest A-HDMI-A1: SUCCESS (7.794s) [693.859552] Starting dynamic subtest: B-HDMI-A1 [701.575851] Dynamic subtest B-HDMI-A1: SUCCESS (7.760s) [701.617355] Starting dynamic subtest: C-HDMI-A1 [709.326352] Dynamic subtest C-HDMI-A1: SUCCESS (7.748s) [709.353685] Starting dynamic subtest: D-HDMI-A1 [717.078222] Dynamic subtest D-HDMI-A1: SUCCESS (7.750s) [717.087739] Subtest flip-vs-rmfb: SUCCESS (31.078s) [717.444270] [148/154] (325s left) gem_exec_whisper (basic-contexts-all) [717.536392] Starting subtest: basic-contexts-all [739.552398] Subtest basic-contexts-all: SUCCESS (22.017s) [739.802005] [149/154] (303s left) dmabuf_sync_file (export-basic) [739.867319] Starting subtest: export-basic [739.868243] Subtest export-basic: SUCCESS (0.001s) [739.957115] [150/154] (302s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu) [741.481024] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu [741.482965] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [741.711872] [151/154] (301s left) gem_sync (basic-each) [741.803471] Starting subtest: basic-each [744.532373] Subtest basic-each: SUCCESS (2.729s) [744.799949] [152/154] (298s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc) [746.324367] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc [746.325335] Starting dynamic subtest: pipe-A-HDMI-A-1 [746.900998] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.573s) [746.916137] Starting dynamic subtest: pipe-B-HDMI-A-1 [747.491917] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.589s) [747.507082] Starting dynamic subtest: pipe-C-HDMI-A-1 [748.100903] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.607s) [748.116218] Starting dynamic subtest: pipe-D-HDMI-A-1 [748.709128] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.606s) [748.710449] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SUCCESS (2.383s) [748.911923] [153/154] (294s left) syncobj_wait (multi-wait-for-submit-submitted) [748.993350] Starting subtest: multi-wait-for-submit-submitted [749.098410] Subtest multi-wait-for-submit-submitted: SUCCESS (0.104s) [749.240351] [154/154] (294s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt) [750.763203] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt [750.764907] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [750.936906] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_pipe_b_c_ivb results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_force_connector_basic results: parsing output: 5/ for test: perf_pmu results: parsing output: 6/ for test: gem_ccs results: parsing output: 7/ for test: kms_plane_alpha_blend results: parsing output: 8/ for test: gem_mmap_gtt results: parsing output: 9/ for test: api_intel_allocator results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: kms_plane results: parsing output: 12/ for test: kms_ccs results: parsing output: 13/ for test: kms_ccs results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: gem_render_copy results: parsing output: 16/ for test: sysfs_heartbeat_interval results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: gem_ctx_param results: parsing output: 19/ for test: kms_psr results: parsing output: 20/ for test: i915_pm_freq_mult results: parsing output: 21/ for test: prime_busy results: parsing output: 22/ for test: gem_exec_gttfill results: parsing output: 23/ for test: syncobj_timeline results: parsing output: 24/ for test: gem_ctx_param results: parsing output: 25/ for test: kms_big_fb results: parsing output: 26/ for test: gem_lmem_swapping results: parsing output: 27/ for test: gem_ctx_shared results: parsing output: 28/ for test: kms_psr results: parsing output: 29/ for test: gem_bad_reloc results: parsing output: 30/ for test: kms_chamelium_hpd results: parsing output: 31/ for test: kms_psr2_sf results: parsing output: 32/ for test: gem_eio results: parsing output: 33/ for test: kms_content_protection results: parsing output: 34/ for test: syncobj_wait results: parsing output: 35/ for test: gem_ctx_isolation results: parsing output: 36/ for test: gem_flink_basic results: parsing output: 37/ for test: gem_caching results: parsing output: 38/ for test: kms_plane_scaling results: parsing output: 39/ for test: syncobj_timeline results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_pm_rpm results: parsing output: 42/ for test: kms_atomic_transition results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: gem_spin_batch results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: syncobj_basic results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: kms_big_fb results: parsing output: 49/ for test: syncobj_timeline results: parsing output: 50/ for test: api_intel_bb results: parsing output: 51/ for test: kms_atomic_interruptible results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_flip_scaled_crc results: parsing output: 55/ for test: gem_pxp results: parsing output: 56/ for test: gen9_exec_parse results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: gem_exec_balancer results: parsing output: 59/ for test: kms_plane results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_pwrite_crc results: parsing output: 62/ for test: gem_flink_basic results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: gem_ctx_persistence results: parsing output: 65/ for test: gen7_exec_parse results: parsing output: 66/ for test: gem_exec_schedule results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: perf results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: i915_drm_fdinfo results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_pipe_crc_basic results: parsing output: 73/ for test: gem_exec_reloc results: parsing output: 74/ for test: kms_cursor_crc results: parsing output: 75/ for test: kms_color_pipeline results: parsing output: 76/ for test: kms_big_fb results: parsing output: 77/ for test: kms_big_fb results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: gem_exec_reloc results: parsing output: 80/ for test: kms_cursor_legacy results: parsing output: 81/ for test: kms_flip results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: kms_draw_crc results: parsing output: 84/ for test: kms_cursor_crc results: parsing output: 85/ for test: kms_cursor_crc results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_lease results: parsing output: 89/ for test: syncobj_wait results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: kms_big_fb results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: gem_exec_fence results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_ccs results: parsing output: 96/ for test: kms_cursor_legacy results: parsing output: 97/ for test: kms_chamelium_audio results: parsing output: 98/ for test: kms_addfb_basic results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_sequence results: parsing output: 103/ for test: kms_plane_scaling results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: gem_exec_reloc results: parsing output: 106/ for test: syncobj_timeline results: parsing output: 107/ for test: kms_psr results: parsing output: 108/ for test: syncobj_wait results: parsing output: 109/ for test: kms_busy results: parsing output: 110/ for test: kms_psr results: parsing output: 111/ for test: gem_softpin results: parsing output: 112/ for test: kms_force_connector_basic results: parsing output: 113/ for test: kms_chamelium_edid results: parsing output: 114/ for test: syncobj_timeline results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: gem_mmap_gtt results: parsing output: 118/ for test: gem_render_copy results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: vgem_basic results: parsing output: 121/ for test: kms_flip_scaled_crc results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_vblank results: parsing output: 126/ for test: kms_flip_scaled_crc results: parsing output: 127/ for test: gem_ctx_exec results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_psr2_sf results: parsing output: 130/ for test: gem_ppgtt results: parsing output: 131/ for test: gem_exec_reloc results: parsing output: 132/ for test: gem_softpin results: parsing output: 133/ for test: gem_exec_capture results: parsing output: 134/ for test: gem_tiled_blits results: parsing output: 135/ for test: kms_frontbuffer_tracking results: parsing output: 136/ for test: gem_mmap_offset results: parsing output: 137/ for test: kms_frontbuffer_tracking results: parsing output: 138/ for test: kms_frontbuffer_tracking results: parsing output: 139/ for test: i915_power results: parsing output: 140/ for test: gem_exec_schedule results: parsing output: 141/ for test: kms_cursor_legacy results: parsing output: 142/ for test: i915_pm_rps results: parsing output: 143/ for test: kms_psr results: parsing output: 144/ for test: kms_setmode results: parsing output: 145/ for test: kms_frontbuffer_tracking results: parsing output: 146/ for test: kms_flip results: parsing output: 147/ for test: gem_exec_whisper results: parsing output: 148/ for test: dmabuf_sync_file results: parsing output: 149/ for test: kms_frontbuffer_tracking results: parsing output: 150/ for test: gem_sync results: parsing output: 151/ for test: kms_ccs results: parsing output: 152/ for test: syncobj_wait results: parsing output: 153/ for test: kms_frontbuffer_tracking Done.