[65.960890] Initializing watchdogs [65.960958] /dev/watchdog0 [65.983948] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [65.995153] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [65.999224] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [66.002058] [001/156] (960s left) kms_frontbuffer_tracking (fbc-tiling-linear) [67.527500] Starting subtest: fbc-tiling-linear [69.811947] Subtest fbc-tiling-linear: SUCCESS (2.286s) [70.010640] [002/156] (956s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [70.085055] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [70.151945] [003/156] (956s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [71.667279] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc [71.669152] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [71.793252] [004/156] (954s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [73.334977] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt [73.336830] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [73.454062] [005/156] (953s left) kms_force_connector_basic (prune-stale-modes) [73.623756] Starting subtest: prune-stale-modes [73.647671] Subtest prune-stale-modes: SUCCESS (0.024s) [75.272935] [006/156] (951s left) perf_pmu (most-busy-check-all) [75.348180] Starting subtest: most-busy-check-all [75.349108] Starting dynamic subtest: rcs0 [75.950478] Dynamic subtest rcs0: SUCCESS (0.602s) [75.963365] Starting dynamic subtest: bcs0 [76.507506] Dynamic subtest bcs0: SUCCESS (0.556s) [76.520248] Starting dynamic subtest: vcs0 [77.059376] Dynamic subtest vcs0: SUCCESS (0.551s) [77.073210] Starting dynamic subtest: vcs1 [77.613289] Dynamic subtest vcs1: SUCCESS (0.554s) [77.624760] Starting dynamic subtest: vecs0 [78.166726] Dynamic subtest vecs0: SUCCESS (0.552s) [78.180304] Starting dynamic subtest: vecs1 [78.721035] Dynamic subtest vecs1: SUCCESS (0.554s) [78.730985] Starting dynamic subtest: ccs0 [79.274543] Dynamic subtest ccs0: SUCCESS (0.552s) [79.276276] Subtest most-busy-check-all: SUCCESS (3.927s) [79.443209] [007/156] (947s left) gem_ccs (large-ctrl-surf-copy) [79.529060] Starting subtest: large-ctrl-surf-copy [80.194265] Subtest large-ctrl-surf-copy: SUCCESS (0.665s) [80.353792] [008/156] (946s left) kms_plane_alpha_blend (coverage-7efc) [81.858154] Starting subtest: coverage-7efc [82.122415] Starting dynamic subtest: pipe-A-HDMI-A-3 [82.582160] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.460s) [82.613250] Starting dynamic subtest: pipe-D-HDMI-A-3 [83.207338] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.603s) [83.208266] Subtest coverage-7efc: SUCCESS (1.349s) [83.430429] [009/156] (943s left) gem_mmap_gtt (fault-concurrent) [83.500165] Subtest fault-concurrent: SKIP (0.000s) [83.570298] [010/156] (943s left) api_intel_allocator (gem-pool) [83.646022] Starting subtest: gem-pool [83.682352] Subtest gem-pool: SUCCESS (0.037s) [83.853922] [011/156] (943s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-fullscreen) [85.366997] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-fullscreen [85.368791] Subtest fbchdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [85.542964] [012/156] (941s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier) [87.063234] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier [87.094312] Starting dynamic subtest: pipe-A-plane-0 [87.644881] Dynamic subtest pipe-A-plane-0: SUCCESS (0.550s) [87.678907] Starting dynamic subtest: pipe-A-plane-3 [87.994748] Dynamic subtest pipe-A-plane-3: SUCCESS (0.349s) [88.028901] Starting dynamic subtest: pipe-A-plane-5 [88.031495] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [88.175916] Starting dynamic subtest: pipe-B-plane-0 [88.565943] Dynamic subtest pipe-B-plane-0: SUCCESS (0.400s) [88.600079] Starting dynamic subtest: pipe-B-plane-3 [88.915111] Dynamic subtest pipe-B-plane-3: SUCCESS (0.349s) [88.926064] Starting dynamic subtest: pipe-B-plane-5 [88.928268] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [88.971160] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SUCCESS (1.908s) [89.183518] [013/156] (938s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs) [90.698216] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs [90.699202] Starting dynamic subtest: pipe-A-HDMI-A-3 [90.708184] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s) [90.718735] Starting dynamic subtest: pipe-B-HDMI-A-3 [90.727412] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s) [90.737479] Starting dynamic subtest: pipe-C-HDMI-A-3 [90.745911] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s) [90.756350] Starting dynamic subtest: pipe-D-HDMI-A-3 [90.765869] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s) [90.767531] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s) [91.020855] [014/156] (936s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs) [92.528381] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs [92.529258] Starting dynamic subtest: pipe-A-HDMI-A-3 [92.537992] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [92.548565] Starting dynamic subtest: pipe-B-HDMI-A-3 [92.557943] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [92.568048] Starting dynamic subtest: pipe-C-HDMI-A-3 [92.586571] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [92.596541] Starting dynamic subtest: pipe-D-HDMI-A-3 [92.606074] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [92.608174] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s) [92.856918] [015/156] (934s left) kms_frontbuffer_tracking (hdr-rgb565-draw-blt) [94.367976] Starting subtest: hdr-rgb565-draw-blt [94.369889] Subtest hdr-rgb565-draw-blt: SKIP (0.000s) [94.569114] [016/156] (932s left) kms_pm_rpm (legacy-planes-dpms) [98.039903] Starting subtest: legacy-planes-dpms [98.041661] Starting dynamic subtest: plane-65 [105.059048] Dynamic subtest plane-65: SUCCESS (7.021s) [105.093445] Starting dynamic subtest: plane-95 [112.255667] Dynamic subtest plane-95: SUCCESS (7.195s) [112.296611] Starting dynamic subtest: plane-125 [120.035141] Dynamic subtest plane-125: SUCCESS (7.778s) [120.068228] Starting dynamic subtest: plane-135 [127.104374] Dynamic subtest plane-135: SUCCESS (7.068s) [127.105868] Subtest legacy-planes-dpms: SUCCESS (29.067s) [128.104449] [017/156] (899s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [128.207623] Starting subtest: x-tiled-to-vebox-y-tiled [128.209721] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [128.491220] [018/156] (899s left) sysfs_heartbeat_interval (invalid) [128.566868] Starting subtest: invalid [128.567825] Starting dynamic subtest: vecs0 [128.568736] Dynamic subtest vecs0: SUCCESS (0.000s) [128.580255] Starting dynamic subtest: ccs0 [128.581193] Dynamic subtest ccs0: SUCCESS (0.000s) [128.591598] Starting dynamic subtest: vcs0 [128.592613] Dynamic subtest vcs0: SUCCESS (0.000s) [128.602845] Starting dynamic subtest: bcs0 [128.603977] Dynamic subtest bcs0: SUCCESS (0.001s) [128.614065] Starting dynamic subtest: vecs1 [128.615341] Dynamic subtest vecs1: SUCCESS (0.000s) [128.625647] Starting dynamic subtest: rcs0 [128.626798] Dynamic subtest rcs0: SUCCESS (0.000s) [128.636818] Starting dynamic subtest: vcs1 [128.637974] Dynamic subtest vcs1: SUCCESS (0.000s) [128.639179] Subtest invalid: SUCCESS (0.006s) [128.681507] [019/156] (899s left) kms_frontbuffer_tracking (fbc-stridechange) [130.193650] Starting subtest: fbc-stridechange [132.166456] Subtest fbc-stridechange: SUCCESS (1.974s) [132.354080] [020/156] (895s left) gem_ctx_param (basic-default) [132.423411] Starting subtest: basic-default [132.424250] Subtest basic-default: SUCCESS (0.000s) [132.591609] [021/156] (895s left) kms_psr (fbc-pr-primary-mmap-gtt) [134.104856] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s) [134.157149] [022/156] (893s left) i915_pm_freq_mult (media-freq) [134.230133] Starting subtest: media-freq [134.231082] Starting dynamic subtest: gt0 [134.734476] Dynamic subtest gt0: SUCCESS (0.505s) [134.735655] Subtest media-freq: SUCCESS (0.506s) [134.875456] [023/156] (893s left) prime_busy (before-wait) [134.950159] Starting subtest: before-wait [134.955202] Starting dynamic subtest: rcs0 [135.000838] Dynamic subtest rcs0: SUCCESS (0.046s) [135.011199] Starting dynamic subtest: bcs0 [135.050057] Dynamic subtest bcs0: SUCCESS (0.049s) [135.064543] Starting dynamic subtest: vcs0 [135.092743] Dynamic subtest vcs0: SUCCESS (0.042s) [135.118083] Starting dynamic subtest: vcs1 [135.135490] Dynamic subtest vcs1: SUCCESS (0.042s) [135.159945] Starting dynamic subtest: vecs0 [135.177043] Dynamic subtest vecs0: SUCCESS (0.041s) [135.194370] Starting dynamic subtest: vecs1 [135.218030] Dynamic subtest vecs1: SUCCESS (0.040s) [135.235231] Starting dynamic subtest: ccs0 [135.259299] Dynamic subtest ccs0: SUCCESS (0.041s) [135.366977] Subtest before-wait: SUCCESS (0.417s) [135.537987] [024/156] (892s left) gem_exec_gttfill (engines) [135.625224] Starting subtest: engines [135.626187] Starting dynamic subtest: rcs0 [161.860498] Dynamic subtest rcs0: SUCCESS (26.234s) [161.871655] Starting dynamic subtest: bcs0 [188.103128] Dynamic subtest bcs0: SUCCESS (26.234s) [188.114904] Starting dynamic subtest: vcs0 [214.314120] Dynamic subtest vcs0: SUCCESS (26.214s) [214.325437] Starting dynamic subtest: vcs1 [240.502522] Dynamic subtest vcs1: SUCCESS (26.191s) [240.513829] Starting dynamic subtest: vecs0 [266.676412] Dynamic subtest vecs0: SUCCESS (26.173s) [266.687501] Starting dynamic subtest: vecs1 [292.874539] Dynamic subtest vecs1: SUCCESS (26.197s) [292.885893] Starting dynamic subtest: ccs0 [319.093504] Dynamic subtest ccs0: SUCCESS (26.218s) [319.094469] Subtest engines: SUCCESS (183.466s) [319.403610] [025/156] (708s left) syncobj_timeline (etime-multi-wait-all-submitted) [319.503723] Starting subtest: etime-multi-wait-all-submitted [319.611159] Subtest etime-multi-wait-all-submitted: SUCCESS (0.107s) [319.701740] [026/156] (708s left) gem_ctx_param (get-priority-new-ctx) [319.774431] Starting subtest: get-priority-new-ctx [319.776437] Subtest get-priority-new-ctx: SUCCESS (0.001s) [319.895258] [027/156] (708s left) kms_big_fb (linear-32bpp-rotate-90) [321.421498] Starting subtest: linear-32bpp-rotate-90 [321.490834] Subtest linear-32bpp-rotate-90: SKIP (0.069s) [321.680113] [028/156] (706s left) gem_lmem_swapping (heavy-verify-multi-ccs) [326.244186] Starting subtest: heavy-verify-multi-ccs [326.245278] Starting dynamic subtest: lmem0 [335.675962] Dynamic subtest lmem0: SUCCESS (9.432s) [335.676922] Subtest heavy-verify-multi-ccs: SUCCESS (9.433s) [336.923839] [FACT gem_lmem_swapping (heavy-verify-multi-ccs)] deleted: kernel.kmod_is_loaded.i915: true [336.925853] [029/156] (691s left) gem_ctx_shared (disjoint-timelines) [340.467826] Starting subtest: disjoint-timelines [340.555757] Subtest disjoint-timelines: SUCCESS (0.090s) [340.869923] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.i915: true [340.870539] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true [340.873157] [030/156] (687s left) kms_psr (fbc-psr2-cursor-plane-move) [342.395397] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s) [342.454572] [031/156] (686s left) gem_bad_reloc (negative-reloc-bltcopy) [342.543779] Subtest negative-reloc-bltcopy: SKIP (0.000s) [342.622051] [032/156] (685s left) kms_chamelium_hpd (hdmi-hpd) [344.204333] Subtest hdmi-hpd: SKIP (0.000s) [344.337645] [033/156] (684s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf) [345.881162] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [345.935727] [034/156] (682s left) gem_eio (wait-10ms) [346.251194] Starting subtest: wait-10ms [346.887232] Subtest wait-10ms: SUCCESS (0.636s) [348.434715] [035/156] (680s left) kms_content_protection (legacy-hdcp14) [350.048351] Starting subtest: legacy-hdcp14 [350.052561] Subtest legacy-hdcp14: SKIP (0.002s) [350.268658] [036/156] (678s left) syncobj_wait (reset-signaled) [350.353460] Starting subtest: reset-signaled [350.354430] Subtest reset-signaled: SUCCESS (0.000s) [350.515580] [037/156] (678s left) gem_ctx_isolation (dirty-switch) [350.606180] Starting subtest: dirty-switch [350.607172] Starting dynamic subtest: rcs0 [351.244964] Dynamic subtest rcs0: SUCCESS (0.640s) [351.257739] Starting dynamic subtest: bcs0 [351.906683] Dynamic subtest bcs0: SUCCESS (0.661s) [351.919331] Starting dynamic subtest: vcs0 [352.566770] Dynamic subtest vcs0: SUCCESS (0.659s) [352.579238] Starting dynamic subtest: vcs1 [353.222645] Dynamic subtest vcs1: SUCCESS (0.655s) [353.235817] Starting dynamic subtest: vecs0 [353.867378] Dynamic subtest vecs0: SUCCESS (0.644s) [353.880202] Starting dynamic subtest: vecs1 [354.523477] Dynamic subtest vecs1: SUCCESS (0.655s) [354.536204] Starting dynamic subtest: ccs0 [355.170259] Dynamic subtest ccs0: SUCCESS (0.647s) [355.171327] Subtest dirty-switch: SUCCESS (4.565s) [355.433661] [038/156] (673s left) gem_flink_basic (bad-open) [355.513144] Starting subtest: bad-open [355.513999] Subtest bad-open: SUCCESS (0.000s) [355.644740] [039/156] (673s left) gem_caching (writes) [355.731916] Starting subtest: writes [360.085471] Subtest writes: SUCCESS (4.354s) [360.212227] [040/156] (668s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers) [361.745519] Starting subtest: plane-scaler-unity-scaling-with-modifiers [361.746437] Starting dynamic subtest: pipe-A [362.339624] Dynamic subtest pipe-A: SUCCESS (0.595s) [362.369520] Starting dynamic subtest: pipe-B [362.932019] Dynamic subtest pipe-B: SUCCESS (0.591s) [362.958474] Starting dynamic subtest: pipe-C [363.523988] Dynamic subtest pipe-C: SUCCESS (0.591s) [363.550023] Starting dynamic subtest: pipe-D [364.116550] Dynamic subtest pipe-D: SUCCESS (0.592s) [364.117615] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (2.372s) [364.341110] [041/156] (664s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [364.427184] Starting subtest: single-wait-all-for-submit-available-submitted [364.428157] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [364.573013] [042/156] (664s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-render) [366.096367] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-render [366.098151] Subtest fbchdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [366.324684] [043/156] (663s left) kms_pm_rpm (system-suspend-idle) [370.008031] Starting subtest: system-suspend-idle [390.429092] Subtest system-suspend-idle: SUCCESS (6.604s) [395.465293] [044/156] (637s left) kms_atomic_transition (modeset-transition) [396.986601] Starting subtest: modeset-transition [396.987554] Starting dynamic subtest: 1x-outputs [399.018042] Dynamic subtest 1x-outputs: SUCCESS (2.032s) [399.019793] Subtest modeset-transition: SUCCESS (2.034s) [399.278830] [045/156] (634s left) kms_frontbuffer_tracking (pipe-fbc-rte) [400.800112] Starting subtest: pipe-fbc-rte [400.805679] Subtest pipe-fbc-rte: SKIP (0.000s) [400.932934] [046/156] (632s left) gem_spin_batch (resubmit-all) [401.046492] Starting subtest: resubmit-all [401.047456] Starting dynamic subtest: rcs0 [401.084968] Dynamic subtest rcs0: SUCCESS (0.038s) [401.099734] Starting dynamic subtest: bcs0 [401.100656] Dynamic subtest bcs0: SUCCESS (0.003s) [401.115524] Starting dynamic subtest: vcs0 [401.116720] Dynamic subtest vcs0: SUCCESS (0.003s) [401.130326] Starting dynamic subtest: vcs1 [401.131345] Dynamic subtest vcs1: SUCCESS (0.002s) [401.145269] Starting dynamic subtest: vecs0 [401.146295] Dynamic subtest vecs0: SUCCESS (0.003s) [401.159978] Starting dynamic subtest: vecs1 [401.161086] Dynamic subtest vecs1: SUCCESS (0.002s) [401.174873] Starting dynamic subtest: ccs0 [401.175971] Dynamic subtest ccs0: SUCCESS (0.003s) [401.177047] Subtest resubmit-all: SUCCESS (0.059s) [401.406914] [047/156] (632s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff) [402.933124] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff [402.934866] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [403.065485] [048/156] (630s left) syncobj_basic (illegal-fd-to-handle) [403.164990] Starting subtest: illegal-fd-to-handle [403.165930] Subtest illegal-fd-to-handle: SUCCESS (0.000s) [403.318045] [049/156] (630s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite) [404.837259] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite [404.838969] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [404.962563] [050/156] (628s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180) [406.510178] Starting subtest: linear-max-hw-stride-32bpp-rotate-180 [407.841368] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.331s) [408.019586] [051/156] (625s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted) [408.099358] Starting subtest: etime-single-wait-all-for-submit-unsubmitted [408.205388] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s) [408.315601] [052/156] (625s left) api_intel_bb (misplaced-blitter) [408.396058] Starting subtest: misplaced-blitter [408.432874] Subtest misplaced-blitter: SUCCESS (0.037s) [408.591093] [053/156] (625s left) kms_atomic_interruptible (universal-setplane-cursor) [410.108328] Starting subtest: universal-setplane-cursor [410.109203] Starting dynamic subtest: pipe-A-HDMI-A-3 [416.306101] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (6.197s) [416.306995] Subtest universal-setplane-cursor: SUCCESS (6.199s) [416.506232] [054/156] (617s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [418.035906] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [418.037727] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [418.248616] [055/156] (616s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [419.776204] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc [419.777919] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [420.010408] [056/156] (614s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling) [421.524861] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling [421.526683] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s) [421.618737] [057/156] (612s left) gem_pxp (create-protected-buffer) [424.240042] Starting subtest: create-protected-buffer [424.241919] Subtest create-protected-buffer: SKIP (0.000s) [424.339070] [058/156] (610s left) gem_fence_thrash (bo-write-verify-threaded-x) [424.389640] Starting subtest: bo-write-verify-threaded-x [424.420749] Subtest bo-write-verify-threaded-x: SKIP (0.031s) [424.496839] [059/156] (610s left) gen9_exec_parse (allowed-single) [424.589182] Subtest allowed-single: SKIP (0.000s) [424.646495] [060/156] (609s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu) [426.171310] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu [426.173012] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [426.375482] [061/156] (608s left) gem_exec_balancer (bonded-semaphore) [426.470071] Starting subtest: bonded-semaphore [426.472142] Subtest bonded-semaphore: SKIP (0.000s) [426.867883] [062/156] (607s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping) [428.385706] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping [428.387623] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s) [428.559804] [063/156] (606s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc) [430.105526] Starting subtest: fbc-rgb565-draw-mmap-wc [430.107189] Subtest fbc-rgb565-draw-mmap-wc: SKIP (0.000s) [430.292080] [064/156] (604s left) kms_pwrite_crc (basic) [431.815641] Starting subtest: basic [432.406403] Subtest basic: SUCCESS (0.590s) [432.689451] [065/156] (602s left) gem_flink_basic (bad-flink) [432.770123] Starting subtest: bad-flink [432.771192] Subtest bad-flink: SUCCESS (0.000s) [432.891477] [066/156] (602s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-move) [434.411575] Starting subtest: hdr-2p-primscrn-spr-indfb-move [434.413266] Subtest hdr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [434.574867] [067/156] (600s left) gem_ctx_persistence (legacy-engines-persistence) [434.688134] Starting subtest: legacy-engines-persistence [434.688995] Starting dynamic subtest: render [435.516522] Dynamic subtest render: SUCCESS (0.827s) [435.533939] Starting dynamic subtest: bsd1 [436.279894] Dynamic subtest bsd1: SUCCESS (0.760s) [436.297514] Starting dynamic subtest: bsd2 [437.038081] Dynamic subtest bsd2: SUCCESS (0.754s) [437.055892] Starting dynamic subtest: blt [437.809738] Dynamic subtest blt: SUCCESS (0.767s) [437.827460] Starting dynamic subtest: vebox [438.581772] Dynamic subtest vebox: SUCCESS (0.768s) [438.583379] Subtest legacy-engines-persistence: SUCCESS (3.894s) [438.738493] [068/156] (596s left) gen7_exec_parse (basic-allowed) [438.827164] Subtest basic-allowed: SKIP (0.000s) [438.913292] [069/156] (596s left) gem_exec_schedule (reorder-wide) [439.126184] Subtest reorder-wide: SKIP (0.000s) [439.336271] [070/156] (596s left) kms_frontbuffer_tracking (psrhdr-slowdraw) [440.860462] Starting subtest: psrhdr-slowdraw [440.862232] Subtest psrhdr-slowdraw: SKIP (0.000s) [441.095541] [071/156] (594s left) perf (non-zero-reason) [441.479215] Starting subtest: non-zero-reason [441.480162] Starting dynamic subtest: 0-rcs0 [444.520518] Dynamic subtest 0-rcs0: FAIL (2.757s) [444.521913] Subtest non-zero-reason: FAIL (2.758s) [444.597507] [072/156] (591s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-pwrite) [446.121624] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-pwrite [446.123410] Subtest fbchdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [446.261456] [073/156] (589s left) i915_drm_fdinfo (all-busy-check-all) [446.360229] Starting subtest: all-busy-check-all [446.391144] Subtest all-busy-check-all: SKIP (0.030s) [446.483576] [074/156] (589s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt) [448.033803] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt [448.035487] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [448.179290] [075/156] (587s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [449.720176] Starting subtest: compare-crc-sanitycheck-nv12 [449.722901] Starting dynamic subtest: pipe-A-HDMI-A-3 [450.422875] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.701s) [450.438961] Starting dynamic subtest: pipe-B-HDMI-A-3 [451.005160] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.580s) [451.021996] Starting dynamic subtest: pipe-C-HDMI-A-3 [451.565902] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.558s) [451.581073] Starting dynamic subtest: pipe-D-HDMI-A-3 [452.150504] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.582s) [452.151419] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.430s) [452.362997] [076/156] (583s left) gem_exec_reloc (basic-write-gtt) [452.450171] Subtest basic-write-gtt: SKIP (0.000s) [452.528876] [077/156] (583s left) kms_cursor_crc (cursor-rapid-movement-max-size) [454.380651] Starting subtest: cursor-rapid-movement-max-size [454.383507] Subtest cursor-rapid-movement-max-size: SKIP (0.000s) [454.556547] [078/156] (581s left) kms_color_pipeline (plane-lut1d) [456.075692] Starting subtest: plane-lut1d [456.265063] Starting dynamic subtest: pipe-A-plane-0 [456.497911] Dynamic subtest pipe-A-plane-0: SUCCESS (0.233s) [456.541936] Starting dynamic subtest: pipe-A-plane-1 [456.696732] Dynamic subtest pipe-A-plane-1: SUCCESS (0.197s) [456.711456] Starting dynamic subtest: pipe-A-plane-2 [456.864249] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s) [457.168966] Starting dynamic subtest: pipe-B-plane-0 [457.315343] Dynamic subtest pipe-B-plane-0: SUCCESS (0.182s) [457.353182] Starting dynamic subtest: pipe-B-plane-1 [457.498934] Dynamic subtest pipe-B-plane-1: SUCCESS (0.180s) [457.539128] Starting dynamic subtest: pipe-B-plane-2 [457.697975] Dynamic subtest pipe-B-plane-2: SUCCESS (0.195s) [458.002538] Starting dynamic subtest: pipe-C-plane-0 [458.156004] Dynamic subtest pipe-C-plane-0: SUCCESS (0.199s) [458.197762] Starting dynamic subtest: pipe-C-plane-1 [458.354948] Dynamic subtest pipe-C-plane-1: SUCCESS (0.195s) [458.370161] Starting dynamic subtest: pipe-C-plane-2 [458.539368] Dynamic subtest pipe-C-plane-2: SUCCESS (0.183s) [458.851171] Starting dynamic subtest: pipe-D-plane-0 [459.021432] Dynamic subtest pipe-D-plane-0: SUCCESS (0.183s) [459.062678] Starting dynamic subtest: pipe-D-plane-1 [459.220284] Dynamic subtest pipe-D-plane-1: SUCCESS (0.195s) [459.234968] Starting dynamic subtest: pipe-D-plane-2 [459.388018] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s) [459.444044] Subtest plane-lut1d: SUCCESS (3.369s) [459.694498] [079/156] (576s left) kms_big_fb (yf-tiled-16bpp-rotate-180) [461.223231] Starting subtest: yf-tiled-16bpp-rotate-180 [461.225152] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s) [461.449443] [080/156] (574s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0) [462.974969] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0 [464.246351] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.259s) [464.449501] [081/156] (571s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt) [465.972640] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt [465.974498] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [466.221606] [082/156] (570s left) gem_exec_reloc (basic-wc-read) [466.310272] Subtest basic-wc-read: SKIP (0.000s) [466.409879] [083/156] (570s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle) [467.928942] Starting subtest: short-busy-flip-before-cursor-toggle [467.930821] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s) [468.025014] [084/156] (568s left) kms_flip (2x-plain-flip-fb-recreate-interruptible) [469.561899] Starting subtest: 2x-plain-flip-fb-recreate-interruptible [469.575604] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.013s) [469.678632] [085/156] (567s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [471.210703] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu [471.212594] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [471.466748] [086/156] (565s left) kms_draw_crc (draw-method-render) [472.981869] Starting subtest: draw-method-render [472.982823] Starting dynamic subtest: xrgb8888-untiled [473.384764] Dynamic subtest xrgb8888-untiled: SUCCESS (0.402s) [473.428134] Starting dynamic subtest: rgb565-untiled [473.734911] Dynamic subtest rgb565-untiled: SUCCESS (0.347s) [473.779416] Starting dynamic subtest: xrgb2101010-untiled [474.050869] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.313s) [474.071769] Starting dynamic subtest: xbgr16161616f-untiled [474.366909] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.314s) [474.382533] Starting dynamic subtest: xrgb8888-xtiled [474.534854] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.166s) [474.581052] Starting dynamic subtest: rgb565-xtiled [474.716995] Dynamic subtest rgb565-xtiled: SUCCESS (0.179s) [474.735260] Starting dynamic subtest: xrgb2101010-xtiled [474.867789] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.149s) [474.912077] Starting dynamic subtest: xbgr16161616f-xtiled [475.050190] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.180s) [475.068106] Starting dynamic subtest: xrgb8888-4tiled [475.218180] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.166s) [475.264863] Starting dynamic subtest: rgb565-4tiled [475.401200] Dynamic subtest rgb565-4tiled: SUCCESS (0.179s) [475.446188] Starting dynamic subtest: xrgb2101010-4tiled [475.567351] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.163s) [475.613554] Starting dynamic subtest: xbgr16161616f-4tiled [475.750770] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.181s) [475.752349] Subtest draw-method-render: SUCCESS (2.771s) [475.951572] [087/156] (561s left) kms_cursor_crc (cursor-sliding-256x85) [477.726020] Starting subtest: cursor-sliding-256x85 [477.731999] Starting dynamic subtest: pipe-A-HDMI-A-3 [482.175365] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.444s) [482.215510] Starting dynamic subtest: pipe-D-HDMI-A-3 [486.435452] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.233s) [486.436317] Subtest cursor-sliding-256x85: SUCCESS (8.709s) [486.739579] [088/156] (550s left) kms_cursor_crc (cursor-onscreen-256x256) [488.491284] Starting subtest: cursor-onscreen-256x256 [488.496955] Starting dynamic subtest: pipe-A-HDMI-A-3 [491.230837] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.734s) [491.268686] Starting dynamic subtest: pipe-D-HDMI-A-3 [493.904262] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.649s) [493.905158] Subtest cursor-onscreen-256x256: SUCCESS (5.412s) [494.235054] [089/156] (542s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render) [495.756690] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render [495.758611] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [495.972118] [090/156] (541s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [497.500802] Starting subtest: fbcpsr-slowdraw [497.502618] Subtest fbcpsr-slowdraw: SKIP (0.000s) [497.724370] [091/156] (539s left) kms_lease (cursor-implicit-plane) [499.246915] Starting subtest: cursor-implicit-plane [499.247844] Starting dynamic subtest: pipe-A-HDMI-A-3 [499.617640] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.368s) [499.676849] Starting dynamic subtest: pipe-B-HDMI-A-3 [499.891893] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.267s) [499.913093] Starting dynamic subtest: pipe-C-HDMI-A-3 [500.114903] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.222s) [500.133538] Starting dynamic subtest: pipe-D-HDMI-A-3 [500.340258] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.223s) [500.341180] Subtest cursor-implicit-plane: SUCCESS (1.095s) [500.565151] [092/156] (536s left) syncobj_wait (invalid-reset-zero-handles) [500.648131] Starting subtest: invalid-reset-zero-handles [500.649073] Subtest invalid-reset-zero-handles: SUCCESS (0.000s) [500.805085] [093/156] (536s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [502.325606] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [502.327270] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [502.559557] [094/156] (535s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [504.093071] Starting subtest: yf-tiled-64bpp-rotate-90 [504.094869] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [504.245057] [095/156] (533s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc) [505.781961] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc [505.783745] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [505.930971] [096/156] (531s left) gem_exec_fence (long-history) [506.521904] Starting subtest: long-history [512.879196] Subtest long-history: SUCCESS (6.357s) [513.831627] [097/156] (524s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt) [515.352898] Starting subtest: psr-1p-primscrn-indfb-msflip-blt [515.354683] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [515.482947] [098/156] (522s left) kms_ccs (bad-rotation-90-yf-tiled-ccs) [517.043873] Starting subtest: bad-rotation-90-yf-tiled-ccs [517.044870] Starting dynamic subtest: pipe-A-HDMI-A-3 [517.053806] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [517.068947] Starting dynamic subtest: pipe-B-HDMI-A-3 [517.078622] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [517.093304] Starting dynamic subtest: pipe-C-HDMI-A-3 [517.104308] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [517.119434] Starting dynamic subtest: pipe-D-HDMI-A-3 [517.130157] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [517.132070] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.007s) [517.368589] [099/156] (520s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic) [518.886947] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic [520.889128] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (2.002s) [521.120588] [100/156] (517s left) kms_chamelium_audio (dp-audio-edid) [522.702173] Subtest dp-audio-edid: SKIP (0.000s) [522.839864] [101/156] (515s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [524.361922] Starting subtest: addfb25-yf-tiled-legacy [524.362908] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [524.542397] [102/156] (513s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-pgflip-blt) [526.076090] Starting subtest: hdr-1p-primscrn-indfb-pgflip-blt [526.077848] Subtest hdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [526.229261] [103/156] (512s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff) [527.769736] Starting subtest: psr-2p-primscrn-cur-indfb-onoff [527.771611] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [527.893185] [104/156] (510s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [529.419851] Starting subtest: fbc-2p-pri-indfb-multidraw [529.421691] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [529.596508] [105/156] (509s left) kms_sequence (queue-busy) [531.139870] Starting subtest: queue-busy [531.140828] Starting dynamic subtest: pipe-A-HDMI-A-3 [533.692656] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.551s) [533.707991] Starting dynamic subtest: pipe-B-HDMI-A-3 [536.104426] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.410s) [536.119365] Starting dynamic subtest: pipe-C-HDMI-A-3 [538.518567] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.413s) [538.534423] Starting dynamic subtest: pipe-D-HDMI-A-3 [540.936814] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.417s) [540.937919] Subtest queue-busy: SUCCESS (9.797s) [541.136984] [106/156] (497s left) kms_plane_scaling (plane-upscale-20x20-with-rotation) [542.654914] Starting subtest: plane-upscale-20x20-with-rotation [542.655847] Starting dynamic subtest: pipe-A [543.083646] Dynamic subtest pipe-A: SUCCESS (0.429s) [543.140403] Starting dynamic subtest: pipe-B [543.543200] Dynamic subtest pipe-B: SUCCESS (0.456s) [543.576757] Starting dynamic subtest: pipe-C [543.968233] Dynamic subtest pipe-C: SUCCESS (0.423s) [544.000197] Starting dynamic subtest: pipe-D [544.392608] Dynamic subtest pipe-D: SUCCESS (0.422s) [544.393684] Subtest plane-upscale-20x20-with-rotation: SUCCESS (1.740s) [544.635916] [107/156] (494s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-pwrite) [546.160834] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-pwrite [546.162609] Subtest psrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [546.291733] [108/156] (492s left) gem_exec_reloc (basic-write-wc) [546.402249] Subtest basic-write-wc: SKIP (0.000s) [546.482229] [109/156] (492s left) syncobj_timeline (reset-signaled) [546.562115] Starting subtest: reset-signaled [546.563023] Subtest reset-signaled: SUCCESS (0.000s) [546.726598] [110/156] (492s left) kms_psr (pr-cursor-plane-move) [548.243309] Subtest pr-cursor-plane-move: SKIP (0.000s) [548.315291] [111/156] (490s left) syncobj_wait (invalid-wait-illegal-handle) [548.399214] Starting subtest: invalid-wait-illegal-handle [548.400193] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [548.592175] [112/156] (490s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [550.118905] Starting subtest: extended-pageflip-modeset-hang-oldfb [550.119857] Starting dynamic subtest: pipe-A [557.923200] Dynamic subtest pipe-A: SUCCESS (7.804s) [557.940159] Starting dynamic subtest: pipe-D [565.689774] Dynamic subtest pipe-D: SUCCESS (7.762s) [565.690735] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (15.573s) [565.930597] [113/156] (473s left) kms_psr (psr2-primary-blt) [567.448582] Subtest psr2-primary-blt: SKIP (0.000s) [567.525076] [114/156] (471s left) gem_softpin (evict-snoop-interruptible) [567.618401] Starting subtest: evict-snoop-interruptible [567.620163] Subtest evict-snoop-interruptible: SKIP (0.000s) [567.723716] [115/156] (471s left) kms_force_connector_basic (force-load-detect) [567.885660] Starting subtest: force-load-detect [567.887561] Subtest force-load-detect: SKIP (0.000s) [568.818069] [116/156] (470s left) kms_chamelium_edid (hdmi-mode-timings) [570.388597] Subtest hdmi-mode-timings: SKIP (0.000s) [570.536281] [117/156] (468s left) syncobj_timeline (invalid-signal-zero-handles) [570.623134] Starting subtest: invalid-signal-zero-handles [570.624115] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [570.776918] [118/156] (468s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt) [572.297698] Starting subtest: fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt [572.299498] Subtest fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [572.433758] [119/156] (467s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [573.978085] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt [573.979791] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [574.122487] [120/156] (465s left) gem_mmap_gtt (fault-concurrent-x) [574.225970] Subtest fault-concurrent-X: SKIP (0.000s) [574.305653] [121/156] (465s left) gem_render_copy (y-tiled-to-vebox-y-tiled) [574.392488] Starting subtest: y-tiled-to-vebox-y-tiled [574.394871] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s) [574.634799] [122/156] (465s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-plflip-blt) [576.160675] Starting subtest: psrhdr-2p-scndscrn-shrfb-plflip-blt [576.162606] Subtest psrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [576.361317] [123/156] (463s left) vgem_basic (debugfs) [576.423191] Starting subtest: debugfs [576.424092] Subtest debugfs: SUCCESS (0.000s) [576.570595] [124/156] (463s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [578.086893] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [578.087851] Starting dynamic subtest: pipe-A-valid-mode [579.684946] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.597s) [579.685893] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.598s) [579.898030] [125/156] (460s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [581.420135] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [581.421914] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [581.574310] [126/156] (458s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [583.114874] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [583.116658] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [583.269575] [127/156] (457s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt) [584.817156] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt [584.818887] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [584.955895] [128/156] (455s left) kms_vblank (wait-forked-hang) [586.492987] Starting subtest: wait-forked-hang [586.493931] Starting dynamic subtest: pipe-A-HDMI-A-3 [613.320887] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (26.827s) [613.337366] Starting dynamic subtest: pipe-D-HDMI-A-3 [638.375855] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (25.050s) [638.376822] Subtest wait-forked-hang: SUCCESS (51.883s) [638.572190] [129/156] (401s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [640.088923] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling [640.089869] Starting dynamic subtest: pipe-A-valid-mode [644.240605] Dynamic subtest pipe-A-valid-mode: SUCCESS (4.150s) [644.241607] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SUCCESS (4.152s) [644.451165] [130/156] (396s left) gem_ctx_exec (basic-invalid-context) [644.532988] Starting subtest: basic-invalid-context [644.537298] Subtest basic-invalid-context: SUCCESS (0.004s) [644.703147] [131/156] (395s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt) [646.225992] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt [646.227782] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [646.362159] [132/156] (394s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [647.907470] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s) [647.968028] [133/156] (392s left) gem_ppgtt (blt-vs-render-ctxn) [648.055459] Starting subtest: blt-vs-render-ctxN [681.011110] Subtest blt-vs-render-ctxN: SUCCESS (32.954s) [681.176252] [134/156] (359s left) gem_exec_reloc (basic-gtt-cpu-noreloc) [681.291952] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s) [681.402993] [135/156] (359s left) gem_softpin (invalid) [681.490300] Starting subtest: invalid [681.502975] Subtest invalid: SUCCESS (0.013s) [681.677069] [136/156] (359s left) gem_exec_capture (capture) [681.765155] Starting subtest: capture [681.766087] Starting dynamic subtest: rcs0-smem [682.716158] Dynamic subtest rcs0-smem: SUCCESS (0.951s) [682.733035] Starting dynamic subtest: rcs0-lmem0 [683.638175] Dynamic subtest rcs0-lmem0: SUCCESS (0.921s) [683.653467] Starting dynamic subtest: bcs0-smem [685.052182] Dynamic subtest bcs0-smem: SUCCESS (1.413s) [685.067252] Starting dynamic subtest: bcs0-lmem0 [686.048046] Dynamic subtest bcs0-lmem0: SUCCESS (0.995s) [686.063066] Starting dynamic subtest: vcs0-smem [686.958062] Dynamic subtest vcs0-smem: SUCCESS (0.908s) [686.973060] Starting dynamic subtest: vcs0-lmem0 [688.034102] Dynamic subtest vcs0-lmem0: SUCCESS (1.075s) [688.049225] Starting dynamic subtest: vcs1-smem [688.943050] Dynamic subtest vcs1-smem: SUCCESS (0.907s) [688.958080] Starting dynamic subtest: vcs1-lmem0 [690.080139] Dynamic subtest vcs1-lmem0: SUCCESS (1.136s) [690.095251] Starting dynamic subtest: vecs0-smem [691.028662] Dynamic subtest vecs0-smem: FAIL (0.927s) [691.043431] Starting dynamic subtest: vecs0-lmem0 [692.025474] Dynamic subtest vecs0-lmem0: FAIL (0.995s) [692.040085] Starting dynamic subtest: vecs1-smem [693.441201] Dynamic subtest vecs1-smem: FAIL (1.413s) [693.455893] Starting dynamic subtest: vecs1-lmem0 [694.441550] Dynamic subtest vecs1-lmem0: FAIL (0.998s) [694.456152] Starting dynamic subtest: ccs0-smem [695.837180] Dynamic subtest ccs0-smem: SUCCESS (1.418s) [695.852266] Starting dynamic subtest: ccs0-lmem0 [696.758123] Dynamic subtest ccs0-lmem0: SUCCESS (0.920s) [696.759116] Subtest capture: FAIL (14.994s) [696.899090] [137/156] (344s left) gem_tiled_blits (basic) [696.987226] Subtest basic: SKIP (0.000s) [697.073573] [138/156] (344s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [698.609229] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [698.611005] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [698.822071] [139/156] (342s left) gem_mmap_offset (partial-remap) [698.903055] Starting subtest: partial-remap [698.904002] Starting dynamic subtest: lmem0 [698.908907] Dynamic subtest lmem0: SUCCESS (0.005s) [698.924706] Starting dynamic subtest: smem0 [698.926728] Dynamic subtest smem0: SUCCESS (0.004s) [698.927764] Subtest partial-remap: SUCCESS (0.011s) [699.118703] [140/156] (342s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-blt) [700.641650] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-blt [700.643502] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s) [700.791460] [141/156] (340s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-blt) [702.342828] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-blt [702.344633] Subtest hdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [702.488551] [142/156] (339s left) i915_power (sanity) [702.596105] Starting subtest: sanity [706.660206] Subtest sanity: SUCCESS (4.062s) [706.808598] [143/156] (334s left) gem_exec_schedule (preempt-queue) [706.910817] Subtest preempt-queue: SKIP (0.000s) [707.277274] [144/156] (334s left) kms_cursor_legacy (cursorb-vs-flipa-legacy) [709.045312] Starting subtest: cursorB-vs-flipA-legacy [709.047213] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s) [709.150253] [145/156] (332s left) i915_pm_rps (reset) [709.243962] Starting subtest: reset [714.048433] Subtest reset: SUCCESS (4.804s) [714.213958] [146/156] (327s left) kms_psr (fbc-psr-cursor-plane-onoff) [715.733084] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s) [715.805099] [147/156] (326s left) kms_setmode (clone-exclusive-crtc) [715.886257] Starting subtest: clone-exclusive-crtc [715.889218] Subtest clone-exclusive-crtc: SKIP (0.000s) [716.042121] [148/156] (325s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu) [717.563829] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu [717.565650] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [717.701116] [149/156] (324s left) kms_flip (flip-vs-rmfb) [719.253826] Starting subtest: flip-vs-rmfb [719.258928] Starting dynamic subtest: A-HDMI-A3 [727.065408] Dynamic subtest A-HDMI-A3: SUCCESS (7.806s) [727.113525] Starting dynamic subtest: B-HDMI-A3 [734.782329] Dynamic subtest B-HDMI-A3: SUCCESS (7.712s) [734.830196] Starting dynamic subtest: C-HDMI-A3 [742.499950] Dynamic subtest C-HDMI-A3: SUCCESS (7.712s) [742.546225] Starting dynamic subtest: D-HDMI-A3 [750.199533] Dynamic subtest D-HDMI-A3: SUCCESS (7.694s) [750.204685] Subtest flip-vs-rmfb: SUCCESS (30.948s) [750.478649] [150/156] (291s left) gem_exec_whisper (basic-contexts-all) [750.575306] Starting subtest: basic-contexts-all [772.603829] Subtest basic-contexts-all: SUCCESS (22.027s) [772.817719] [151/156] (269s left) dmabuf_sync_file (export-basic) [772.874830] Starting subtest: export-basic [772.877121] Subtest export-basic: SUCCESS (0.001s) [772.962587] [152/156] (269s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu) [774.485795] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu [774.487664] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [774.659340] [153/156] (267s left) gem_sync (basic-each) [774.768433] Starting subtest: basic-each [777.343003] Subtest basic-each: SUCCESS (2.574s) [777.602422] [154/156] (264s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc) [779.129924] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc [779.130834] Starting dynamic subtest: pipe-A-HDMI-A-3 [779.710966] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.578s) [779.726276] Starting dynamic subtest: pipe-B-HDMI-A-3 [780.317971] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.605s) [780.333496] Starting dynamic subtest: pipe-C-HDMI-A-3 [780.910689] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.591s) [780.926110] Starting dynamic subtest: pipe-D-HDMI-A-3 [781.519544] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.607s) [781.520909] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SUCCESS (2.388s) [781.738422] [155/156] (260s left) syncobj_wait (multi-wait-for-submit-submitted) [781.819072] Starting subtest: multi-wait-for-submit-submitted [781.925345] Subtest multi-wait-for-submit-submitted: SUCCESS (0.106s) [782.081004] [156/156] (260s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt) [783.603790] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt [783.605590] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [783.838492] 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: kms_pm_rpm results: parsing output: 16/ for test: gem_render_copy results: parsing output: 17/ for test: sysfs_heartbeat_interval results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: gem_ctx_param results: parsing output: 20/ for test: kms_psr results: parsing output: 21/ for test: i915_pm_freq_mult results: parsing output: 22/ for test: prime_busy results: parsing output: 23/ for test: gem_exec_gttfill results: parsing output: 24/ for test: syncobj_timeline results: parsing output: 25/ for test: gem_ctx_param results: parsing output: 26/ for test: kms_big_fb results: parsing output: 27/ for test: gem_lmem_swapping results: parsing output: 28/ for test: gem_ctx_shared results: parsing output: 29/ for test: kms_psr results: parsing output: 30/ for test: gem_bad_reloc results: parsing output: 31/ for test: kms_chamelium_hpd results: parsing output: 32/ for test: kms_psr2_sf results: parsing output: 33/ for test: gem_eio results: parsing output: 34/ for test: kms_content_protection results: parsing output: 35/ for test: syncobj_wait results: parsing output: 36/ for test: gem_ctx_isolation results: parsing output: 37/ for test: gem_flink_basic results: parsing output: 38/ for test: gem_caching results: parsing output: 39/ for test: kms_plane_scaling results: parsing output: 40/ for test: syncobj_timeline results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_pm_rpm results: parsing output: 43/ for test: kms_atomic_transition results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: gem_spin_batch results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: syncobj_basic results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: kms_big_fb results: parsing output: 50/ for test: syncobj_timeline results: parsing output: 51/ for test: api_intel_bb results: parsing output: 52/ for test: kms_atomic_interruptible results: parsing output: 53/ for test: kms_big_fb results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_flip_scaled_crc results: parsing output: 56/ for test: gem_pxp results: parsing output: 57/ for test: gem_fence_thrash results: parsing output: 58/ for test: gen9_exec_parse results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: gem_exec_balancer results: parsing output: 61/ for test: kms_plane results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_pwrite_crc results: parsing output: 64/ for test: gem_flink_basic results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: gem_ctx_persistence results: parsing output: 67/ for test: gen7_exec_parse results: parsing output: 68/ for test: gem_exec_schedule results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: perf results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: i915_drm_fdinfo results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_pipe_crc_basic results: parsing output: 75/ for test: gem_exec_reloc results: parsing output: 76/ for test: kms_cursor_crc results: parsing output: 77/ for test: kms_color_pipeline results: parsing output: 78/ for test: kms_big_fb results: parsing output: 79/ for test: kms_big_fb results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: gem_exec_reloc results: parsing output: 82/ for test: kms_cursor_legacy results: parsing output: 83/ for test: kms_flip results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_draw_crc results: parsing output: 86/ for test: kms_cursor_crc results: parsing output: 87/ for test: kms_cursor_crc results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: kms_lease results: parsing output: 91/ for test: syncobj_wait results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_big_fb results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: gem_exec_fence results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: kms_ccs results: parsing output: 98/ for test: kms_cursor_legacy results: parsing output: 99/ for test: kms_chamelium_audio results: parsing output: 100/ for test: kms_addfb_basic results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_sequence results: parsing output: 105/ for test: kms_plane_scaling results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: gem_exec_reloc results: parsing output: 108/ for test: syncobj_timeline results: parsing output: 109/ for test: kms_psr results: parsing output: 110/ for test: syncobj_wait results: parsing output: 111/ for test: kms_busy results: parsing output: 112/ for test: kms_psr results: parsing output: 113/ for test: gem_softpin results: parsing output: 114/ for test: kms_force_connector_basic results: parsing output: 115/ for test: kms_chamelium_edid results: parsing output: 116/ for test: syncobj_timeline results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: gem_mmap_gtt results: parsing output: 120/ for test: gem_render_copy results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: vgem_basic results: parsing output: 123/ for test: kms_flip_scaled_crc results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: kms_vblank results: parsing output: 128/ for test: kms_flip_scaled_crc results: parsing output: 129/ for test: gem_ctx_exec results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: kms_psr2_sf results: parsing output: 132/ for test: gem_ppgtt results: parsing output: 133/ for test: gem_exec_reloc results: parsing output: 134/ for test: gem_softpin results: parsing output: 135/ for test: gem_exec_capture results: parsing output: 136/ for test: gem_tiled_blits results: parsing output: 137/ for test: kms_frontbuffer_tracking results: parsing output: 138/ for test: gem_mmap_offset results: parsing output: 139/ for test: kms_frontbuffer_tracking results: parsing output: 140/ for test: kms_frontbuffer_tracking results: parsing output: 141/ for test: i915_power results: parsing output: 142/ for test: gem_exec_schedule results: parsing output: 143/ for test: kms_cursor_legacy results: parsing output: 144/ for test: i915_pm_rps results: parsing output: 145/ for test: kms_psr results: parsing output: 146/ for test: kms_setmode results: parsing output: 147/ for test: kms_frontbuffer_tracking results: parsing output: 148/ for test: kms_flip results: parsing output: 149/ for test: gem_exec_whisper results: parsing output: 150/ for test: dmabuf_sync_file results: parsing output: 151/ for test: kms_frontbuffer_tracking results: parsing output: 152/ for test: gem_sync results: parsing output: 153/ for test: kms_ccs results: parsing output: 154/ for test: syncobj_wait results: parsing output: 155/ for test: kms_frontbuffer_tracking Done.