[60.089907] Initializing watchdogs [60.089974] /dev/watchdog0 [60.110338] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [60.121670] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [60.125274] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.127553] [001/131] (960s left) kms_atomic_transition (plane-all-transition) [60.307525] Starting subtest: plane-all-transition [60.309545] Starting dynamic subtest: pipe-A-DP-3 [64.125071] Dynamic subtest pipe-A-DP-3: SUCCESS (3.802s) [64.260841] Starting dynamic subtest: pipe-B-DP-3 [68.166072] Dynamic subtest pipe-B-DP-3: SUCCESS (3.905s) [68.279290] Subtest plane-all-transition: SUCCESS (7.950s) [68.575322] [002/131] (952s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted) [68.651026] Starting subtest: multi-wait-available-unsubmitted-submitted [68.652001] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s) [68.805671] [003/131] (951s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt) [68.989805] Starting subtest: fbc-rgb565-draw-mmap-gtt [68.991402] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s) [69.171883] [004/131] (951s left) gen9_exec_parse (bb-start-param) [69.263026] Subtest bb-start-param: SKIP (0.000s) [69.339912] [005/131] (951s left) syncobj_wait (invalid-signal-one-illegal-handle) [69.411024] Starting subtest: invalid-signal-one-illegal-handle [69.412168] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [69.605977] [006/131] (951s left) kms_psr (fbc-pr-cursor-plane-onoff) [69.789389] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s) [69.836407] [007/131] (951s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted) [69.910366] Starting subtest: etime-single-wait-all-available-unsubmitted [70.015215] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.104s) [70.157035] [008/131] (950s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs) [70.334926] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs [70.335843] Starting dynamic subtest: pipe-A-DP-3 [70.357119] Dynamic subtest pipe-A-DP-3: SKIP (0.002s) [70.364710] Starting dynamic subtest: pipe-B-DP-3 [70.386210] Dynamic subtest pipe-B-DP-3: SKIP (0.002s) [70.393861] Starting dynamic subtest: pipe-C-DP-3 [70.418343] Dynamic subtest pipe-C-DP-3: SKIP (0.002s) [70.426057] Starting dynamic subtest: pipe-D-DP-3 [70.447743] Dynamic subtest pipe-D-DP-3: SKIP (0.002s) [70.449356] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.012s) [70.806501] [009/131] (950s left) syncobj_wait (reset-unsignaled) [70.878198] Starting subtest: reset-unsignaled [70.879149] Subtest reset-unsignaled: SUCCESS (0.000s) [71.020479] [010/131] (950s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling) [71.197943] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling [71.198894] Starting dynamic subtest: pipe-A-valid-mode [71.289488] Dynamic subtest pipe-A-valid-mode: SKIP (0.090s) [71.291348] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.091s) [71.545660] [011/131] (949s left) gem_fenced_exec_thrash (no-spare-fences-interruptible) [71.625895] Subtest no-spare-fences-interruptible: SKIP (0.000s) [71.689208] [012/131] (949s left) perf (i915-ref-count) [71.825082] Starting subtest: i915-ref-count [72.117987] Subtest i915-ref-count: SUCCESS (0.293s) [72.274516] [013/131] (949s left) gem_exec_reloc (basic-wc-gtt-active) [72.351262] Subtest basic-wc-gtt-active: SKIP (0.000s) [72.424871] [014/131] (948s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode) [72.678592] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s) [72.823194] [015/131] (948s left) kms_addfb_basic (bad-pitch-0) [72.892943] Starting subtest: bad-pitch-0 [72.893847] Subtest bad-pitch-0: SUCCESS (0.000s) [73.198034] [016/131] (948s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled) [73.276488] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled [73.278413] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [73.529923] [017/131] (948s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf) [73.724173] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [73.763748] [018/131] (947s left) gem_exec_schedule (semaphore-noskip) [73.852339] Starting subtest: semaphore-noskip [74.612383] Subtest semaphore-noskip: SUCCESS (0.759s) [75.030021] [019/131] (946s left) gem_mmap_gtt (ptrace) [75.102160] Subtest ptrace: SKIP (0.000s) [75.182810] [020/131] (946s left) kms_addfb_basic (bad-pitch-256) [75.254161] Starting subtest: bad-pitch-256 [75.255053] Subtest bad-pitch-256: SUCCESS (0.000s) [75.568200] [021/131] (946s left) kms_cursor_crc (cursor-offscreen-128x128) [75.936780] Starting subtest: cursor-offscreen-128x128 [75.941906] Starting dynamic subtest: pipe-A-DP-3 [78.519351] Dynamic subtest pipe-A-DP-3: SUCCESS (2.577s) [78.566128] Starting dynamic subtest: pipe-D-DP-3 [81.049687] Dynamic subtest pipe-D-DP-3: SUCCESS (2.493s) [81.050806] Subtest cursor-offscreen-128x128: SUCCESS (5.115s) [81.534342] [022/131] (940s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [81.715965] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [81.717697] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [81.917594] [023/131] (940s left) gem_exec_gttfill (engines) [81.999228] Starting subtest: engines [82.000156] Starting dynamic subtest: rcs0 [107.845476] Dynamic subtest rcs0: SUCCESS (25.859s) [107.854151] Starting dynamic subtest: bcs0 [133.841124] Dynamic subtest bcs0: SUCCESS (26.000s) [133.850587] Starting dynamic subtest: vcs0 [159.820499] Dynamic subtest vcs0: SUCCESS (25.967s) [159.829270] Starting dynamic subtest: vcs1 [185.816872] Dynamic subtest vcs1: SUCCESS (25.986s) [185.825565] Starting dynamic subtest: vecs0 [211.833617] Dynamic subtest vecs0: SUCCESS (26.012s) [211.842369] Starting dynamic subtest: vecs1 [237.770485] Dynamic subtest vecs1: SUCCESS (25.935s) [237.779185] Starting dynamic subtest: ccs0 [263.721590] Dynamic subtest ccs0: SUCCESS (25.950s) [263.722501] Subtest engines: SUCCESS (181.714s) [264.016776] [024/131] (758s left) gem_mmap_wc (set-cache-level) [264.118061] Subtest set-cache-level: SKIP (0.000s) [264.192391] [025/131] (757s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [264.375880] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [264.376761] Starting dynamic subtest: pipe-A-DP-3 [264.384981] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [264.393426] Starting dynamic subtest: pipe-B-DP-3 [264.401553] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [264.409948] Starting dynamic subtest: pipe-C-DP-3 [264.418109] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [264.426387] Starting dynamic subtest: pipe-D-DP-3 [264.434735] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [264.436376] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.005s) [264.832178] [026/131] (757s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c) [264.912159] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s) [264.988367] [027/131] (757s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [265.181926] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [266.328196] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (1.146s) [266.557206] [028/131] (755s left) syncobj_timeline (multi-wait-available-signaled) [266.636080] Starting subtest: multi-wait-available-signaled [266.637007] Subtest multi-wait-available-signaled: SUCCESS (0.001s) [266.805558] [029/131] (755s left) perf_pmu (busy) [266.869788] Starting subtest: busy [266.870643] Starting dynamic subtest: rcs0 [267.505193] Dynamic subtest rcs0: SUCCESS (0.634s) [267.518808] Starting dynamic subtest: bcs0 [268.065756] Dynamic subtest bcs0: SUCCESS (0.559s) [268.079246] Starting dynamic subtest: vcs0 [268.631379] Dynamic subtest vcs0: SUCCESS (0.563s) [268.643535] Starting dynamic subtest: vcs1 [269.198394] Dynamic subtest vcs1: SUCCESS (0.565s) [269.210480] Starting dynamic subtest: vecs0 [269.758687] Dynamic subtest vecs0: SUCCESS (0.558s) [269.772247] Starting dynamic subtest: vecs1 [270.320964] Dynamic subtest vecs1: SUCCESS (0.561s) [270.330655] Starting dynamic subtest: ccs0 [270.886376] Dynamic subtest ccs0: SUCCESS (0.564s) [270.888040] Subtest busy: SUCCESS (4.017s) [271.055526] [030/131] (751s left) gem_exec_async (forked-writes) [271.140661] Starting subtest: forked-writes [271.141526] Starting dynamic subtest: rcs0 [271.203976] Dynamic subtest rcs0: SUCCESS (0.063s) [271.214404] Starting dynamic subtest: bcs0 [271.238467] Dynamic subtest bcs0: SUCCESS (0.034s) [271.248985] Starting dynamic subtest: vcs0 [271.272576] Dynamic subtest vcs0: SUCCESS (0.034s) [271.282813] Starting dynamic subtest: vcs1 [271.306972] Dynamic subtest vcs1: SUCCESS (0.034s) [271.317467] Starting dynamic subtest: vecs0 [271.345127] Dynamic subtest vecs0: SUCCESS (0.038s) [271.357027] Starting dynamic subtest: vecs1 [271.381466] Dynamic subtest vecs1: SUCCESS (0.036s) [271.392187] Starting dynamic subtest: ccs0 [271.414771] Dynamic subtest ccs0: SUCCESS (0.033s) [271.415816] Subtest forked-writes: SUCCESS (0.274s) [271.736379] [031/131] (750s left) gem_eio (in-flight-contexts-1us) [271.987206] Starting subtest: in-flight-contexts-1us [285.929734] Subtest in-flight-contexts-1us: SUCCESS (13.942s) [286.218493] [032/131] (736s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs) [286.395897] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs [286.396788] Starting dynamic subtest: pipe-A-DP-3 [286.405015] Dynamic subtest pipe-A-DP-3: SKIP (0.001s) [286.414879] Starting dynamic subtest: pipe-B-DP-3 [286.423203] Dynamic subtest pipe-B-DP-3: SKIP (0.001s) [286.432895] Starting dynamic subtest: pipe-C-DP-3 [286.441118] Dynamic subtest pipe-C-DP-3: SKIP (0.001s) [286.450955] Starting dynamic subtest: pipe-D-DP-3 [286.461042] Dynamic subtest pipe-D-DP-3: SKIP (0.001s) [286.463008] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.007s) [286.888440] [033/131] (735s left) kms_psr (fbc-psr-primary-mmap-cpu) [287.074567] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s) [287.133819] [034/131] (735s left) kms_big_fb (y-tiled-16bpp-rotate-90) [287.321084] Starting subtest: y-tiled-16bpp-rotate-90 [287.322975] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s) [287.516963] [035/131] (735s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt) [287.699546] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt [287.701296] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [287.891063] [036/131] (734s left) kms_hdr (static-swap) [288.072740] Starting subtest: static-swap [288.661580] Starting dynamic subtest: pipe-A-DP-3 [289.899614] Dynamic subtest pipe-A-DP-3: SUCCESS (1.238s) [289.901358] Subtest static-swap: SUCCESS (1.827s) [290.277521] [037/131] (732s left) gem_spin_batch (resubmit) [290.361459] Starting subtest: resubmit [290.362367] Starting dynamic subtest: rcs0 [290.391889] Dynamic subtest rcs0: SUCCESS (0.030s) [290.402199] Starting dynamic subtest: bcs0 [290.403152] Dynamic subtest bcs0: SUCCESS (0.002s) [290.413678] Starting dynamic subtest: vcs0 [290.414841] Dynamic subtest vcs0: SUCCESS (0.003s) [290.424958] Starting dynamic subtest: vcs1 [290.425884] Dynamic subtest vcs1: SUCCESS (0.002s) [290.435805] Starting dynamic subtest: vecs0 [290.436679] Dynamic subtest vecs0: SUCCESS (0.002s) [290.446531] Starting dynamic subtest: vecs1 [290.447639] Dynamic subtest vecs1: SUCCESS (0.002s) [290.457564] Starting dynamic subtest: ccs0 [290.458793] Dynamic subtest ccs0: SUCCESS (0.002s) [290.459958] Subtest resubmit: SUCCESS (0.048s) [290.695248] [038/131] (732s left) gem_ccs (ctrl-surf-copy) [290.772989] Starting subtest: ctrl-surf-copy [290.773951] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0 [290.830357] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.057s) [290.840620] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0 [291.045444] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.214s) [291.055540] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0 [291.073753] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.028s) [291.083766] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0 [291.294156] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.219s) [291.304220] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0 [291.322735] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.028s) [291.332656] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0 [291.543973] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.220s) [291.554303] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0 [291.572506] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.028s) [291.582590] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0 [291.793928] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.220s) [291.794969] Subtest ctrl-surf-copy: SUCCESS (1.021s) [291.990520] [039/131] (731s left) syncobj_eventfd (timeline-wait-signaled) [292.067326] Starting subtest: timeline-wait-signaled [292.068210] Subtest timeline-wait-signaled: SUCCESS (0.000s) [292.256701] [040/131] (730s left) gem_exec_balancer (parallel-out-fence) [292.646426] Starting subtest: parallel-out-fence [295.025212] Subtest parallel-out-fence: SUCCESS (2.379s) [295.187302] [041/131] (728s left) syncobj_wait (single-wait-all-submitted) [295.259444] Starting subtest: single-wait-all-submitted [295.368629] Subtest single-wait-all-submitted: SUCCESS (0.107s) [295.506162] [042/131] (727s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [295.698138] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [295.700630] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [295.901493] [043/131] (727s left) kms_flip (flip-vs-panning) [296.080346] Starting subtest: flip-vs-panning [296.084504] Starting dynamic subtest: A-DP3 [303.938022] Dynamic subtest A-DP3: SUCCESS (7.853s) [303.954301] Starting dynamic subtest: B-DP3 [311.717039] Dynamic subtest B-DP3: SUCCESS (7.777s) [311.729209] Starting dynamic subtest: C-DP3 [319.503179] Dynamic subtest C-DP3: SUCCESS (7.784s) [319.543718] Starting dynamic subtest: D-DP3 [327.324130] Dynamic subtest D-DP3: SUCCESS (7.817s) [327.331730] Subtest flip-vs-panning: SUCCESS (31.249s) [327.734895] [044/131] (695s left) kms_vblank (ts-continuation-suspend) [327.913262] Starting subtest: ts-continuation-suspend [327.914164] Starting dynamic subtest: pipe-A-DP-3 [346.720477] Dynamic subtest pipe-A-DP-3: SUCCESS (4.114s) [346.735353] Starting dynamic subtest: pipe-D-DP-3 [365.704827] Dynamic subtest pipe-D-DP-3: SUCCESS (3.755s) [365.705554] Subtest ts-continuation-suspend: SUCCESS (7.875s) [365.939168] [045/131] (657s left) gem_lmem_swapping (verify-ccs) [369.464013] Starting subtest: verify-ccs [369.464979] Starting dynamic subtest: lmem0 [414.402494] Dynamic subtest lmem0: SUCCESS (44.936s) [414.403511] Subtest verify-ccs: SUCCESS (44.938s) [416.478923] [FACT gem_lmem_swapping (verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true [416.480806] [046/131] (607s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt) [418.214240] Starting subtest: fbcpsr-rgb565-draw-blt [418.215902] Subtest fbcpsr-rgb565-draw-blt: SKIP (0.000s) [418.421406] [FACT kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)] new: kernel.kmod_is_loaded.i915: true [418.424147] [047/131] (605s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled) [418.504383] Starting subtest: yf-tiled-ccs-to-yf-tiled [418.506953] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s) [418.790768] [048/131] (604s left) kms_chamelium_frames (hdmi-crc-fast) [419.059316] Subtest hdmi-crc-fast: SKIP (0.000s) [419.212401] [049/131] (604s left) kms_chamelium_edid (dp-edid-change-during-suspend) [419.487367] Subtest dp-edid-change-during-suspend: SKIP (0.000s) [419.642781] [050/131] (604s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180) [419.835943] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180 [419.837710] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [420.006977] [051/131] (603s left) gem_workarounds (suspend-resume-context) [420.105969] Starting subtest: suspend-resume-context [438.696529] Subtest suspend-resume-context: SUCCESS (3.847s) [438.849368] [052/131] (585s left) perf (invalid-remove-userspace-config) [439.257121] Starting subtest: invalid-remove-userspace-config [439.265628] Subtest invalid-remove-userspace-config: SUCCESS (0.010s) [439.330044] [053/131] (584s left) gem_exec_fence (basic-wait-all) [439.410753] Starting subtest: basic-wait-all [439.540383] Subtest basic-wait-all: SUCCESS (0.130s) [440.367043] [FACT gem_exec_fence (basic-wait-all)] new: kernel.kmod_is_loaded.vgem: true [440.369243] [054/131] (583s left) gem_mmap_gtt (basic-write) [440.453250] Subtest basic-write: SKIP (0.000s) [440.536025] [055/131] (583s left) gem_exec_flush (basic-wb-pro-default) [440.637574] Subtest basic-wb-pro-default: SKIP (0.000s) [440.732083] [056/131] (583s left) gem_userptr_blits (invalid-mmap-offset-unsync) [440.825933] Subtest invalid-mmap-offset-unsync: SKIP (0.000s) [441.036549] [057/131] (583s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [441.242272] Starting subtest: fbc-2p-pri-indfb-multidraw [441.244007] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [441.450474] [058/131] (582s left) gem_pxp (create-protected-buffer) [444.056383] Starting subtest: create-protected-buffer [444.058596] Subtest create-protected-buffer: SKIP (0.000s) [444.201765] [059/131] (580s left) perf (polling) [444.467646] Starting subtest: polling [444.468527] Starting dynamic subtest: 0-rcs0 [454.508877] Dynamic subtest 0-rcs0: SUCCESS (10.040s) [454.509732] Subtest polling: SUCCESS (10.041s) [454.566906] [060/131] (569s left) kms_atomic (plane-invalid-params) [454.753970] Starting subtest: plane-invalid-params [454.756226] Starting dynamic subtest: pipe-A-DP-3 [455.648955] Dynamic subtest pipe-A-DP-3: SUCCESS (0.892s) [455.650165] Subtest plane-invalid-params: SUCCESS (0.895s) [455.984946] [061/131] (568s left) kms_prop_blob (basic) [456.071593] Starting subtest: basic [456.072519] Subtest basic: SUCCESS (0.000s) [456.287838] [062/131] (568s left) kms_flip (nonexisting-fb-interruptible) [456.484334] Starting subtest: nonexisting-fb-interruptible [456.487745] Starting dynamic subtest: A-DP3 [456.827136] Dynamic subtest A-DP3: SUCCESS (0.338s) [456.870399] Starting dynamic subtest: B-DP3 [457.102974] Dynamic subtest B-DP3: SUCCESS (0.271s) [457.147718] Starting dynamic subtest: C-DP3 [457.377191] Dynamic subtest C-DP3: SUCCESS (0.271s) [457.419229] Starting dynamic subtest: D-DP3 [457.633969] Dynamic subtest D-DP3: SUCCESS (0.253s) [457.639338] Subtest nonexisting-fb-interruptible: SUCCESS (1.156s) [458.066431] [063/131] (566s left) kms_prop_blob (invalid-get-prop-any) [458.142844] Starting subtest: invalid-get-prop-any [458.143682] Subtest invalid-get-prop-any: SUCCESS (0.000s) [458.346603] [064/131] (566s left) kms_vblank (query-forked-busy) [458.542701] Starting subtest: query-forked-busy [458.545248] Starting dynamic subtest: pipe-A-DP-3 [461.092172] Dynamic subtest pipe-A-DP-3: SUCCESS (2.545s) [461.154191] Starting dynamic subtest: pipe-D-DP-3 [463.638779] Dynamic subtest pipe-D-DP-3: SUCCESS (2.534s) [463.640391] Subtest query-forked-busy: SUCCESS (5.097s) [463.965459] [065/131] (560s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [464.155398] Starting subtest: fbc-1p-pri-indfb-multidraw [473.285365] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (9.130s) [473.501348] [066/131] (551s left) kms_plane_scaling (invalid-num-scalers) [473.691374] Starting subtest: invalid-num-scalers [473.697694] Starting dynamic subtest: pipe-A-DP-3-invalid-num-scalers [473.720336] Dynamic subtest pipe-A-DP-3-invalid-num-scalers: SUCCESS (0.021s) [473.738366] Starting dynamic subtest: pipe-B-DP-3-invalid-num-scalers [473.764385] Dynamic subtest pipe-B-DP-3-invalid-num-scalers: SUCCESS (0.038s) [473.783430] Starting dynamic subtest: pipe-C-DP-3-invalid-num-scalers [473.811078] Dynamic subtest pipe-C-DP-3-invalid-num-scalers: SUCCESS (0.038s) [473.829872] Starting dynamic subtest: pipe-D-DP-3-invalid-num-scalers [473.857406] Dynamic subtest pipe-D-DP-3-invalid-num-scalers: SUCCESS (0.039s) [473.858225] Subtest invalid-num-scalers: SUCCESS (0.168s) [474.058127] [067/131] (550s left) i915_pm_rps (fence-order) [474.157575] Starting subtest: fence-order [478.331169] Subtest fence-order: SUCCESS (4.173s) [478.518485] [068/131] (546s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite) [478.716276] Starting subtest: fbc-rgb101010-draw-pwrite [481.618741] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (2.903s) [481.788689] [069/131] (543s left) gem_mmap_gtt (fault-concurrent) [481.867398] Subtest fault-concurrent: SKIP (0.000s) [481.949868] [070/131] (543s left) gem_ctx_isolation (dirty-switch) [482.038568] Starting subtest: dirty-switch [482.039523] Starting dynamic subtest: rcs0 [482.639189] Dynamic subtest rcs0: SUCCESS (0.600s) [482.653363] Starting dynamic subtest: bcs0 [483.280671] Dynamic subtest bcs0: SUCCESS (0.640s) [483.295040] Starting dynamic subtest: vcs0 [483.913109] Dynamic subtest vcs0: SUCCESS (0.631s) [483.927276] Starting dynamic subtest: vcs1 [484.539539] Dynamic subtest vcs1: SUCCESS (0.625s) [484.555044] Starting dynamic subtest: vecs0 [485.197532] Dynamic subtest vecs0: SUCCESS (0.657s) [485.212047] Starting dynamic subtest: vecs1 [485.814843] Dynamic subtest vecs1: SUCCESS (0.616s) [485.829207] Starting dynamic subtest: ccs0 [486.435032] Dynamic subtest ccs0: SUCCESS (0.619s) [486.436046] Subtest dirty-switch: SUCCESS (4.397s) [486.803221] [071/131] (538s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen) [486.994535] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen [486.996243] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [487.199778] [072/131] (538s left) gem_exec_reloc (basic-write-gtt-active) [487.288363] Subtest basic-write-gtt-active: SKIP (0.000s) [487.390057] [073/131] (537s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [487.586326] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [487.588053] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [487.759456] [074/131] (537s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [487.952990] Starting subtest: psr-indfb-scaledprimary [487.954671] Subtest psr-indfb-scaledprimary: SKIP (0.000s) [488.154510] [075/131] (537s left) kms_big_fb (x-tiled-8bpp-rotate-0) [488.352957] Starting subtest: x-tiled-8bpp-rotate-0 [489.951815] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.598s) [490.138747] [076/131] (535s left) sysfs_heartbeat_interval (invalid) [490.222290] Starting subtest: invalid [490.224514] Starting dynamic subtest: vecs0 [490.225380] Dynamic subtest vecs0: SUCCESS (0.000s) [490.238253] Starting dynamic subtest: ccs0 [490.239230] Dynamic subtest ccs0: SUCCESS (0.000s) [490.251555] Starting dynamic subtest: vcs0 [490.252625] Dynamic subtest vcs0: SUCCESS (0.000s) [490.265148] Starting dynamic subtest: bcs0 [490.266276] Dynamic subtest bcs0: SUCCESS (0.000s) [490.278899] Starting dynamic subtest: vecs1 [490.280057] Dynamic subtest vecs1: SUCCESS (0.000s) [490.292321] Starting dynamic subtest: rcs0 [490.293586] Dynamic subtest rcs0: SUCCESS (0.000s) [490.305978] Starting dynamic subtest: vcs1 [490.307149] Dynamic subtest vcs1: SUCCESS (0.000s) [490.308285] Subtest invalid: SUCCESS (0.011s) [490.370934] [077/131] (535s left) perf_pmu (render-node-busy) [490.488047] Starting subtest: render-node-busy [490.489019] Starting dynamic subtest: rcs0 [491.115366] Dynamic subtest rcs0: SUCCESS (0.627s) [491.129839] Starting dynamic subtest: bcs0 [491.675608] Dynamic subtest bcs0: SUCCESS (0.558s) [491.724663] Starting dynamic subtest: vcs0 [492.251855] Dynamic subtest vcs0: SUCCESS (0.571s) [492.268316] Starting dynamic subtest: vcs1 [492.812949] Dynamic subtest vcs1: SUCCESS (0.556s) [492.829333] Starting dynamic subtest: vecs0 [493.375591] Dynamic subtest vecs0: SUCCESS (0.558s) [493.392326] Starting dynamic subtest: vecs1 [493.937625] Dynamic subtest vecs1: SUCCESS (0.557s) [493.954084] Starting dynamic subtest: ccs0 [494.499746] Dynamic subtest ccs0: SUCCESS (0.557s) [494.504664] Subtest render-node-busy: SUCCESS (4.014s) [494.687425] [078/131] (531s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff) [494.890203] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff [494.891999] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [495.087893] [079/131] (530s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt) [495.279297] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt [495.280957] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [495.487058] [080/131] (530s left) gem_exec_fence (syncobj-export) [496.052158] Starting subtest: syncobj-export [496.089867] Subtest syncobj-export: SUCCESS (0.039s) [496.551024] [081/131] (529s left) i915_module_load (resize-bar) [496.600239] Starting subtest: resize-bar [552.885149] Subtest resize-bar: SUCCESS (56.283s) [552.933755] [FACT i915_module_load (resize-bar)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [552.934964] [FACT i915_module_load (resize-bar)] deleted: kernel.kmod_is_loaded.i915: true [552.937196] [082/131] (473s left) template (b) [554.608612] Starting subtest: B [554.610138] Subtest B: SUCCESS (0.000s) [554.678661] [FACT template (b)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [554.681108] [FACT template (b)] new: kernel.kmod_is_loaded.i915: true [554.684093] [083/131] (471s left) gem_userptr_blits (map-fixed-invalidate-busy) [554.782362] Starting subtest: map-fixed-invalidate-busy [554.784204] Subtest map-fixed-invalidate-busy: SKIP (0.000s) [555.003370] [084/131] (471s left) kms_flip (2x-flip-vs-expired-vblank) [555.189353] Starting subtest: 2x-flip-vs-expired-vblank [555.204544] Subtest 2x-flip-vs-expired-vblank: SKIP (0.014s) [555.384963] [085/131] (470s left) api_intel_bb (crc32) [555.473613] Starting subtest: crc32 [555.474535] Starting dynamic subtest: rcs0-lmem0 [555.728208] Dynamic subtest rcs0-lmem0: SUCCESS (0.252s) [555.745483] Starting dynamic subtest: rcs0-smem0 [556.039451] Dynamic subtest rcs0-smem0: SUCCESS (0.306s) [556.058147] Starting dynamic subtest: bcs0-lmem0 [556.268474] Dynamic subtest bcs0-lmem0: SUCCESS (0.224s) [556.289144] Starting dynamic subtest: bcs0-smem0 [556.587511] Dynamic subtest bcs0-smem0: SUCCESS (0.315s) [556.603584] Starting dynamic subtest: vcs0-lmem0 [556.943419] Dynamic subtest vcs0-lmem0: SUCCESS (0.352s) [556.961693] Starting dynamic subtest: vcs0-smem0 [557.421683] Dynamic subtest vcs0-smem0: SUCCESS (0.473s) [557.437242] Starting dynamic subtest: vcs1-lmem0 [557.779058] Dynamic subtest vcs1-lmem0: SUCCESS (0.353s) [557.796751] Starting dynamic subtest: vcs1-smem0 [558.257129] Dynamic subtest vcs1-smem0: SUCCESS (0.473s) [558.273155] Starting dynamic subtest: vecs0-lmem0 [558.608726] Dynamic subtest vecs0-lmem0: SUCCESS (0.347s) [558.653383] Starting dynamic subtest: vecs0-smem0 [559.116464] Dynamic subtest vecs0-smem0: SUCCESS (0.503s) [559.132495] Starting dynamic subtest: vecs1-lmem0 [559.461575] Dynamic subtest vecs1-lmem0: SUCCESS (0.340s) [559.508151] Starting dynamic subtest: vecs1-smem0 [559.923804] Dynamic subtest vecs1-smem0: SUCCESS (0.458s) [559.940660] Starting dynamic subtest: ccs0-lmem0 [560.172343] Dynamic subtest ccs0-lmem0: SUCCESS (0.244s) [560.211655] Starting dynamic subtest: ccs0-smem0 [560.496081] Dynamic subtest ccs0-smem0: SUCCESS (0.321s) [560.497017] Subtest crc32: SUCCESS (5.023s) [560.702452] [086/131] (465s left) vgem_basic (dmabuf-export) [560.768262] Starting subtest: dmabuf-export [560.799410] Subtest dmabuf-export: SUCCESS (0.031s) [560.992785] [087/131] (465s left) kms_psr (psr2-sprite-blt) [561.208792] Subtest psr2-sprite-blt: SKIP (0.000s) [561.272944] [088/131] (465s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc) [561.467976] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc [561.469591] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [561.657687] [089/131] (464s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt) [561.850041] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt [561.851683] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [562.071786] [090/131] (464s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [562.257324] Starting subtest: modeset-atomic-cursor-hotspot [562.259094] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [562.417633] [091/131] (464s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite) [562.626910] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite [565.036442] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (2.410s) [565.245776] [092/131] (461s left) core_getstats (basic) [565.330170] Starting subtest: basic [565.331264] Subtest basic: SUCCESS (0.000s) [565.519880] [093/131] (461s left) kms_cursor_crc (cursor-random-max-size) [566.040356] Starting subtest: cursor-random-max-size [566.043034] Subtest cursor-random-max-size: SKIP (0.000s) [566.259322] [094/131] (460s left) kms_async_flips (basic-modeset-with-all-modifiers-formats) [566.448521] Starting subtest: basic-modeset-with-all-modifiers-formats [566.673531] Starting dynamic subtest: pipe-A-DP-3-4-RGB565 [566.936513] Dynamic subtest pipe-A-DP-3-4-RGB565: SUCCESS (0.263s) [566.956491] Starting dynamic subtest: pipe-A-DP-3-4-XRGB8888 [566.969215] Dynamic subtest pipe-A-DP-3-4-XRGB8888: SUCCESS (0.031s) [566.989474] Starting dynamic subtest: pipe-A-DP-3-4-XRGB2101010 [567.002629] Dynamic subtest pipe-A-DP-3-4-XRGB2101010: SUCCESS (0.032s) [567.022407] Starting dynamic subtest: pipe-A-DP-3-4-XRGB16161616F [567.035869] Dynamic subtest pipe-A-DP-3-4-XRGB16161616F: SUCCESS (0.032s) [567.051843] Starting dynamic subtest: pipe-A-DP-3-4-YUYV [567.069437] Dynamic subtest pipe-A-DP-3-4-YUYV: SUCCESS (0.032s) [567.085551] Starting dynamic subtest: pipe-A-DP-3-4-Y210 [567.102586] Dynamic subtest pipe-A-DP-3-4-Y210: SUCCESS (0.032s) [567.118598] Starting dynamic subtest: pipe-A-DP-3-4-XYUV8888 [567.136085] Dynamic subtest pipe-A-DP-3-4-XYUV8888: SUCCESS (0.032s) [567.152268] Starting dynamic subtest: pipe-A-DP-3-4-XV30 [567.169270] Dynamic subtest pipe-A-DP-3-4-XV30: SUCCESS (0.032s) [567.185909] Starting dynamic subtest: pipe-A-DP-3-4-XV36 [567.202774] Dynamic subtest pipe-A-DP-3-4-XV36: SUCCESS (0.032s) [567.221913] Starting dynamic subtest: pipe-A-DP-3-x-RGB565 [567.385889] Dynamic subtest pipe-A-DP-3-x-RGB565: SUCCESS (0.182s) [567.400115] Starting dynamic subtest: pipe-A-DP-3-x-XRGB8888 [567.419204] Dynamic subtest pipe-A-DP-3-x-XRGB8888: SUCCESS (0.032s) [567.435478] Starting dynamic subtest: pipe-A-DP-3-x-XRGB2101010 [567.452639] Dynamic subtest pipe-A-DP-3-x-XRGB2101010: SUCCESS (0.032s) [567.469175] Starting dynamic subtest: pipe-A-DP-3-x-XRGB16161616F [567.485917] Dynamic subtest pipe-A-DP-3-x-XRGB16161616F: SUCCESS (0.032s) [567.502407] Starting dynamic subtest: pipe-A-DP-3-x-YUYV [567.519200] Dynamic subtest pipe-A-DP-3-x-YUYV: SUCCESS (0.032s) [567.535687] Starting dynamic subtest: pipe-A-DP-3-x-Y210 [567.552603] Dynamic subtest pipe-A-DP-3-x-Y210: SUCCESS (0.032s) [567.569487] Starting dynamic subtest: pipe-A-DP-3-x-XYUV8888 [567.585896] Dynamic subtest pipe-A-DP-3-x-XYUV8888: SUCCESS (0.032s) [567.602413] Starting dynamic subtest: pipe-A-DP-3-x-XV30 [567.619375] Dynamic subtest pipe-A-DP-3-x-XV30: SUCCESS (0.032s) [567.635909] Starting dynamic subtest: pipe-A-DP-3-x-XV36 [567.652553] Dynamic subtest pipe-A-DP-3-x-XV36: SUCCESS (0.032s) [567.667766] Starting dynamic subtest: pipe-A-DP-3-linear-RGB565 [567.837174] Dynamic subtest pipe-A-DP-3-linear-RGB565: SUCCESS (0.183s) [567.851265] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB8888 [567.871411] Dynamic subtest pipe-A-DP-3-linear-XRGB8888: SUCCESS (0.033s) [567.888165] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB2101010 [567.904595] Dynamic subtest pipe-A-DP-3-linear-XRGB2101010: SUCCESS (0.032s) [567.921907] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB16161616F [567.938061] Dynamic subtest pipe-A-DP-3-linear-XRGB16161616F: SUCCESS (0.032s) [567.961272] Starting dynamic subtest: pipe-A-DP-3-linear-YUYV [567.971373] Dynamic subtest pipe-A-DP-3-linear-YUYV: SUCCESS (0.032s) [567.994912] Starting dynamic subtest: pipe-A-DP-3-linear-Y210 [568.004616] Dynamic subtest pipe-A-DP-3-linear-Y210: SUCCESS (0.031s) [568.020941] Starting dynamic subtest: pipe-A-DP-3-linear-XYUV8888 [568.037952] Dynamic subtest pipe-A-DP-3-linear-XYUV8888: SUCCESS (0.032s) [568.051508] Starting dynamic subtest: pipe-A-DP-3-linear-XV30 [568.071359] Dynamic subtest pipe-A-DP-3-linear-XV30: SUCCESS (0.032s) [568.085060] Starting dynamic subtest: pipe-A-DP-3-linear-XV36 [568.104604] Dynamic subtest pipe-A-DP-3-linear-XV36: SUCCESS (0.032s) [568.349007] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (1.901s) [568.694082] [095/131] (458s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt) [568.893014] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt [568.894726] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s) [569.085790] [096/131] (458s left) kms_pm_rpm (dpms-lpsp) [570.690763] Starting subtest: dpms-lpsp [570.694084] Subtest dpms-lpsp: SKIP (0.001s) [571.173715] [097/131] (456s left) gem_exec_whisper (basic-contexts-forked) [571.296887] Starting subtest: basic-contexts-forked [593.966523] Subtest basic-contexts-forked: SUCCESS (22.668s) [594.253999] [098/131] (433s left) kms_psr (fbc-pr-sprite-plane-move) [594.448612] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s) [594.508136] [099/131] (432s left) i915_drm_fdinfo (busy-hang) [594.581971] Starting subtest: busy-hang [594.582876] Starting dynamic subtest: rcs0 [594.616479] Dynamic subtest rcs0: SKIP (0.033s) [594.629893] Starting dynamic subtest: bcs0 [594.632323] Dynamic subtest bcs0: SKIP (0.001s) [594.645392] Starting dynamic subtest: vcs0 [594.647727] Dynamic subtest vcs0: SKIP (0.001s) [594.660623] Starting dynamic subtest: vcs1 [594.662498] Dynamic subtest vcs1: SKIP (0.001s) [594.675155] Starting dynamic subtest: vecs0 [594.677112] Dynamic subtest vecs0: SKIP (0.001s) [594.689492] Starting dynamic subtest: vecs1 [594.691875] Dynamic subtest vecs1: SKIP (0.001s) [594.704491] Starting dynamic subtest: ccs0 [594.706875] Dynamic subtest ccs0: SKIP (0.001s) [594.709239] Subtest busy-hang: SKIP (0.044s) [594.763029] [100/131] (432s left) prime_self_import (basic-with_one_bo_two_files) [594.811691] Starting subtest: basic-with_one_bo_two_files [594.859391] Subtest basic-with_one_bo_two_files: SUCCESS (0.048s) [595.056960] [101/131] (432s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs) [595.243003] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs [595.244664] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s) [595.574284] [102/131] (432s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc) [595.762514] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc [595.763409] Starting dynamic subtest: pipe-A-DP-3 [595.771906] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [595.784399] Starting dynamic subtest: pipe-B-DP-3 [595.792684] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [595.805016] Starting dynamic subtest: pipe-C-DP-3 [595.813232] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [595.825754] Starting dynamic subtest: pipe-D-DP-3 [595.836638] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [595.838619] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s) [596.253817] [103/131] (431s left) kms_cursor_crc (cursor-sliding-128x128) [596.626446] Starting subtest: cursor-sliding-128x128 [596.631486] Starting dynamic subtest: pipe-A-DP-3 [601.018689] Dynamic subtest pipe-A-DP-3: SUCCESS (4.384s) [601.070720] Starting dynamic subtest: pipe-D-DP-3 [605.301548] Dynamic subtest pipe-D-DP-3: SUCCESS (4.243s) [605.302588] Subtest cursor-sliding-128x128: SUCCESS (8.675s) [605.785488] [104/131] (421s left) kms_addfb_basic (invalid-get-prop) [605.866783] Starting subtest: invalid-get-prop [605.867651] Subtest invalid-get-prop: SUCCESS (0.000s) [606.153590] [105/131] (421s left) gem_readwrite (read-write) [606.228227] Subtest read-write: SKIP (0.000s) [606.307046] [106/131] (421s left) gem_eio (create) [606.594157] Starting subtest: create [607.070281] Subtest create: SUCCESS (0.477s) [607.345546] [107/131] (420s left) gem_exercise_blt (fast-copy-emit) [607.430522] Starting subtest: fast-copy-emit [607.431466] Starting dynamic subtest: linear-smem-smem-emit [607.476939] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.046s) [607.491926] Starting dynamic subtest: linear-smem-lmem0-emit [607.493168] Dynamic subtest linear-smem-lmem0-emit: SUCCESS (0.015s) [607.514628] Starting dynamic subtest: linear-lmem0-smem-emit [607.605279] Dynamic subtest linear-lmem0-smem-emit: SUCCESS (0.111s) [607.619774] Starting dynamic subtest: linear-lmem0-lmem0-emit [607.717578] Dynamic subtest linear-lmem0-lmem0-emit: SUCCESS (0.111s) [607.732600] Starting dynamic subtest: xmajor-smem-smem-emit [607.735205] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s) [607.750140] Starting dynamic subtest: xmajor-smem-lmem0-emit [607.751152] Dynamic subtest xmajor-smem-lmem0-emit: SUCCESS (0.014s) [607.765129] Starting dynamic subtest: xmajor-lmem0-smem-emit [607.863700] Dynamic subtest xmajor-lmem0-smem-emit: SUCCESS (0.112s) [607.878700] Starting dynamic subtest: xmajor-lmem0-lmem0-emit [607.974360] Dynamic subtest xmajor-lmem0-lmem0-emit: SUCCESS (0.110s) [607.989322] Starting dynamic subtest: tile4-smem-smem-emit [607.990598] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.015s) [608.005530] Starting dynamic subtest: tile4-smem-lmem0-emit [608.006452] Dynamic subtest tile4-smem-lmem0-emit: SUCCESS (0.014s) [608.020211] Starting dynamic subtest: tile4-lmem0-smem-emit [608.119079] Dynamic subtest tile4-lmem0-smem-emit: SUCCESS (0.112s) [608.134061] Starting dynamic subtest: tile4-lmem0-lmem0-emit [608.230485] Dynamic subtest tile4-lmem0-lmem0-emit: SUCCESS (0.110s) [608.245512] Starting dynamic subtest: tile64-smem-smem-emit [608.246561] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.015s) [608.261223] Starting dynamic subtest: tile64-smem-lmem0-emit [608.262199] Dynamic subtest tile64-smem-lmem0-emit: SUCCESS (0.014s) [608.276681] Starting dynamic subtest: tile64-lmem0-smem-emit [608.375248] Dynamic subtest tile64-lmem0-smem-emit: SUCCESS (0.112s) [608.390109] Starting dynamic subtest: tile64-lmem0-lmem0-emit [608.485503] Dynamic subtest tile64-lmem0-lmem0-emit: SUCCESS (0.109s) [608.486375] Subtest fast-copy-emit: SUCCESS (1.056s) [608.717211] [108/131] (419s left) kms_plane_scaling (plane-upscale-20x20-with-rotation) [608.899635] Starting subtest: plane-upscale-20x20-with-rotation [608.900540] Starting dynamic subtest: pipe-A [609.293960] Dynamic subtest pipe-A: SUCCESS (0.393s) [609.325577] Starting dynamic subtest: pipe-B [609.773858] Dynamic subtest pipe-B: SUCCESS (0.478s) [609.806646] Starting dynamic subtest: pipe-C [610.253638] Dynamic subtest pipe-C: SUCCESS (0.477s) [610.279318] Starting dynamic subtest: pipe-D [610.735557] Dynamic subtest pipe-D: SUCCESS (0.480s) [610.736512] Subtest plane-upscale-20x20-with-rotation: SUCCESS (1.837s) [611.100365] [109/131] (417s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [611.177911] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [611.178881] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [611.348706] [110/131] (416s left) gem_exec_schedule (implicit-boths) [611.440899] Starting subtest: implicit-boths [611.441851] Starting dynamic subtest: rcs0 [611.751984] Dynamic subtest rcs0: SUCCESS (0.293s) [611.765294] Starting dynamic subtest: bcs0 [611.952494] Dynamic subtest bcs0: SUCCESS (0.203s) [611.965764] Starting dynamic subtest: vcs0 [612.149990] Dynamic subtest vcs0: SUCCESS (0.210s) [612.163364] Starting dynamic subtest: vcs1 [612.361638] Dynamic subtest vcs1: SUCCESS (0.210s) [612.374523] Starting dynamic subtest: vecs0 [612.570766] Dynamic subtest vecs0: SUCCESS (0.208s) [612.584252] Starting dynamic subtest: vecs1 [612.799354] Dynamic subtest vecs1: SUCCESS (0.227s) [612.815457] Starting dynamic subtest: ccs0 [613.016494] Dynamic subtest ccs0: SUCCESS (0.216s) [613.017326] Subtest implicit-boths: SUCCESS (1.576s) [613.483251] [111/131] (414s left) kms_psr (psr2-cursor-plane-onoff) [613.669493] Subtest psr2-cursor-plane-onoff: SKIP (0.000s) [613.728747] [112/131] (414s left) prime_vgem (wait) [613.819415] Starting subtest: wait [613.820325] Starting dynamic subtest: rcs0 [613.892061] Dynamic subtest rcs0: SUCCESS (0.072s) [613.907268] Starting dynamic subtest: bcs0 [613.961619] Dynamic subtest bcs0: SUCCESS (0.068s) [613.982711] Starting dynamic subtest: vcs0 [614.003337] Dynamic subtest vcs0: SUCCESS (0.040s) [614.024606] Starting dynamic subtest: vcs1 [614.046314] Dynamic subtest vcs1: SUCCESS (0.041s) [614.067617] Starting dynamic subtest: vecs0 [614.085325] Dynamic subtest vecs0: SUCCESS (0.037s) [614.106905] Starting dynamic subtest: vecs1 [614.126897] Dynamic subtest vecs1: SUCCESS (0.040s) [614.148277] Starting dynamic subtest: ccs0 [614.167675] Dynamic subtest ccs0: SUCCESS (0.039s) [614.168616] Subtest wait: SUCCESS (0.349s) [614.399858] [113/131] (414s left) kms_dp_linktrain_fallback (dsc-fallback) [614.587971] Starting subtest: dsc-fallback [614.590537] Subtest dsc-fallback: SKIP (0.000s) [614.756470] [114/131] (413s left) gem_exec_reloc (basic-cpu-gtt-noreloc) [614.841267] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s) [614.939602] [115/131] (413s left) gem_create (create-clear) [615.018812] Starting subtest: create-clear [615.019608] Starting dynamic subtest: lmem0 [650.270186] Dynamic subtest lmem0: SUCCESS (35.247s) [650.284031] Starting dynamic subtest: smem0 [685.100962] Dynamic subtest smem0: SUCCESS (34.830s) [685.101818] Subtest create-clear: SUCCESS (70.079s) [685.454152] [116/131] (343s left) kms_frontbuffer_tracking (fbc-suspend) [685.654373] Starting subtest: fbc-suspend [727.038199] Subtest fbc-suspend: SUCCESS (11.164s) [727.295385] [117/131] (301s left) kms_cursor_legacy (cursorb-vs-flipa-toggle) [727.488877] Starting subtest: cursorB-vs-flipA-toggle [727.490640] Subtest cursorB-vs-flipA-toggle: SKIP (0.002s) [727.663442] [118/131] (301s left) kms_color (legacy-gamma-reset) [727.847193] Starting subtest: legacy-gamma-reset [727.848030] Starting dynamic subtest: pipe-A-DP-3 [728.077723] Dynamic subtest pipe-A-DP-3: SUCCESS (0.230s) [728.093619] Starting dynamic subtest: pipe-B-DP-3 [728.100270] Dynamic subtest pipe-B-DP-3: SUCCESS (0.021s) [728.115218] Starting dynamic subtest: pipe-C-DP-3 [728.121800] Dynamic subtest pipe-C-DP-3: SUCCESS (0.020s) [728.136944] Starting dynamic subtest: pipe-D-DP-3 [728.143853] Dynamic subtest pipe-D-DP-3: SUCCESS (0.021s) [728.144765] Subtest legacy-gamma-reset: SUCCESS (0.298s) [728.402985] [119/131] (300s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt) [728.595602] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt [728.597289] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [728.773568] [120/131] (300s left) gem_ctx_persistence (legacy-engines-mixed) [728.864872] Starting subtest: legacy-engines-mixed [728.865865] Starting dynamic subtest: render [728.978815] Dynamic subtest render: SUCCESS (0.113s) [729.004978] Starting dynamic subtest: bsd1 [729.052682] Dynamic subtest bsd1: SUCCESS (0.071s) [729.074245] Starting dynamic subtest: bsd2 [729.118742] Dynamic subtest bsd2: SUCCESS (0.061s) [729.143672] Starting dynamic subtest: blt [729.182193] Dynamic subtest blt: SUCCESS (0.061s) [729.227908] Starting dynamic subtest: vebox [729.262819] Dynamic subtest vebox: SUCCESS (0.077s) [729.263816] Subtest legacy-engines-mixed: SUCCESS (0.399s) [729.513212] [121/131] (299s left) kms_plane_multiple (tiling-none) [729.714081] Starting subtest: tiling-none [729.716458] Starting dynamic subtest: pipe-A-DP-3 [730.873648] Dynamic subtest pipe-A-DP-3: SUCCESS (1.158s) [730.892018] Starting dynamic subtest: pipe-B-DP-3 [733.019227] Dynamic subtest pipe-B-DP-3: SUCCESS (2.144s) [733.045017] Starting dynamic subtest: pipe-C-DP-3 [735.153686] Dynamic subtest pipe-C-DP-3: SUCCESS (2.131s) [735.188790] Starting dynamic subtest: pipe-D-DP-3 [736.890580] Dynamic subtest pipe-D-DP-3: SUCCESS (1.733s) [736.891472] Subtest tiling-none: SUCCESS (7.177s) [737.424972] [122/131] (291s left) kms_flip (2x-flip-vs-suspend-interruptible) [737.614909] Starting subtest: 2x-flip-vs-suspend-interruptible [737.630335] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.014s) [737.792908] [123/131] (291s left) i915_pm_rps (thresholds-idle) [737.883897] Starting subtest: thresholds-idle [737.885707] Subtest thresholds-idle: SKIP (0.001s) [738.041175] [124/131] (291s left) kms_rotation_crc (multiplane-rotation-cropping-bottom) [738.228807] Starting subtest: multiplane-rotation-cropping-bottom [767.006987] Subtest multiplane-rotation-cropping-bottom: SUCCESS (28.779s) [767.223964] [125/131] (262s left) kms_big_fb (linear-64bpp-rotate-90) [767.424054] Starting subtest: linear-64bpp-rotate-90 [767.489796] Subtest linear-64bpp-rotate-90: SKIP (0.063s) [767.743077] [126/131] (261s left) kms_lease (lease-unleased-crtc) [767.930866] Starting subtest: lease-unleased-crtc [767.931763] Starting dynamic subtest: pipe-A-DP-3 [768.060781] Dynamic subtest pipe-A-DP-3: SUCCESS (0.129s) [768.076567] Starting dynamic subtest: pipe-B-DP-3 [768.118913] Dynamic subtest pipe-B-DP-3: SUCCESS (0.057s) [768.136276] Starting dynamic subtest: pipe-C-DP-3 [768.177675] Dynamic subtest pipe-C-DP-3: SUCCESS (0.055s) [768.192321] Starting dynamic subtest: pipe-D-DP-3 [768.232300] Dynamic subtest pipe-D-DP-3: SUCCESS (0.052s) [768.233139] Subtest lease-unleased-crtc: SUCCESS (0.301s) [768.435008] [127/131] (261s left) kms_flip (flip-vs-panning-interruptible) [768.846971] Starting subtest: flip-vs-panning-interruptible [768.851845] Starting dynamic subtest: A-DP3 [776.706534] Dynamic subtest A-DP3: SUCCESS (7.854s) [776.753617] Starting dynamic subtest: B-DP3 [784.505763] Dynamic subtest B-DP3: SUCCESS (7.793s) [784.551050] Starting dynamic subtest: C-DP3 [792.301027] Dynamic subtest C-DP3: SUCCESS (7.789s) [792.340487] Starting dynamic subtest: D-DP3 [800.076003] Dynamic subtest D-DP3: SUCCESS (7.769s) [800.083986] Subtest flip-vs-panning-interruptible: SUCCESS (31.237s) [800.493085] [128/131] (229s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [800.701676] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip [801.453601] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.752s) [801.752077] [129/131] (227s left) api_intel_allocator (open-vm) [801.829724] Starting subtest: open-vm [801.855387] Subtest open-vm: SUCCESS (0.026s) [802.088935] [130/131] (227s left) kms_pipe_crc_basic (hang-read-crc) [802.281319] Starting subtest: hang-read-crc [802.283687] Starting dynamic subtest: pipe-A-DP-3 [803.734486] Dynamic subtest pipe-A-DP-3: SUCCESS (1.452s) [803.758979] Starting dynamic subtest: pipe-B-DP-3 [805.129832] Dynamic subtest pipe-B-DP-3: SUCCESS (1.391s) [805.153034] Starting dynamic subtest: pipe-C-DP-3 [806.441927] Dynamic subtest pipe-C-DP-3: SUCCESS (1.310s) [806.460540] Starting dynamic subtest: pipe-D-DP-3 [807.852159] Dynamic subtest pipe-D-DP-3: SUCCESS (1.408s) [807.853221] Subtest hang-read-crc: SUCCESS (5.571s) [808.162322] [131/131] (221s left) syncobj_timeline (wait-any-interrupted) [808.243772] Starting subtest: wait-any-interrupted [808.347099] Subtest wait-any-interrupted: SUCCESS (0.102s) [808.489161] Closing watchdogs results: parsing output: 0/ for test: kms_atomic_transition results: parsing output: 1/ for test: syncobj_timeline results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: gen9_exec_parse results: parsing output: 4/ for test: syncobj_wait results: parsing output: 5/ for test: kms_psr results: parsing output: 6/ for test: syncobj_timeline results: parsing output: 7/ for test: kms_ccs results: parsing output: 8/ for test: syncobj_wait results: parsing output: 9/ for test: kms_flip_scaled_crc results: parsing output: 10/ for test: gem_fenced_exec_thrash results: parsing output: 11/ for test: perf results: parsing output: 12/ for test: gem_exec_reloc results: parsing output: 13/ for test: kms_chamelium_hpd results: parsing output: 14/ for test: kms_addfb_basic results: parsing output: 15/ for test: gem_render_copy results: parsing output: 16/ for test: kms_psr2_sf results: parsing output: 17/ for test: gem_exec_schedule results: parsing output: 18/ for test: gem_mmap_gtt results: parsing output: 19/ for test: kms_addfb_basic results: parsing output: 20/ for test: kms_cursor_crc results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: gem_exec_gttfill results: parsing output: 23/ for test: gem_mmap_wc results: parsing output: 24/ for test: kms_ccs results: parsing output: 25/ for test: kms_pipe_b_c_ivb results: parsing output: 26/ for test: kms_big_fb results: parsing output: 27/ for test: syncobj_timeline results: parsing output: 28/ for test: perf_pmu results: parsing output: 29/ for test: gem_exec_async results: parsing output: 30/ for test: gem_eio results: parsing output: 31/ for test: kms_ccs results: parsing output: 32/ for test: kms_psr results: parsing output: 33/ for test: kms_big_fb results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: kms_hdr results: parsing output: 36/ for test: gem_spin_batch results: parsing output: 37/ for test: gem_ccs results: parsing output: 38/ for test: syncobj_eventfd results: parsing output: 39/ for test: gem_exec_balancer results: parsing output: 40/ for test: syncobj_wait results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_flip results: parsing output: 43/ for test: kms_vblank results: parsing output: 44/ for test: gem_lmem_swapping results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: gem_render_copy results: parsing output: 47/ for test: kms_chamelium_frames results: parsing output: 48/ for test: kms_chamelium_edid results: parsing output: 49/ for test: kms_big_fb results: parsing output: 50/ for test: gem_workarounds results: parsing output: 51/ for test: perf results: parsing output: 52/ for test: gem_exec_fence results: parsing output: 53/ for test: gem_mmap_gtt results: parsing output: 54/ for test: gem_exec_flush results: parsing output: 55/ for test: gem_userptr_blits results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: gem_pxp results: parsing output: 58/ for test: perf results: parsing output: 59/ for test: kms_atomic results: parsing output: 60/ for test: kms_prop_blob results: parsing output: 61/ for test: kms_flip results: parsing output: 62/ for test: kms_prop_blob results: parsing output: 63/ for test: kms_vblank results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: kms_plane_scaling results: parsing output: 66/ for test: i915_pm_rps results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: gem_mmap_gtt results: parsing output: 69/ for test: gem_ctx_isolation results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: gem_exec_reloc results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_big_fb results: parsing output: 75/ for test: sysfs_heartbeat_interval results: parsing output: 76/ for test: perf_pmu results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: gem_exec_fence results: parsing output: 80/ for test: i915_module_load results: parsing output: 81/ for test: template results: parsing output: 82/ for test: gem_userptr_blits results: parsing output: 83/ for test: kms_flip results: parsing output: 84/ for test: api_intel_bb results: parsing output: 85/ for test: vgem_basic results: parsing output: 86/ for test: kms_psr results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_cursor_legacy results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: core_getstats results: parsing output: 92/ for test: kms_cursor_crc results: parsing output: 93/ for test: kms_async_flips results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_pm_rpm results: parsing output: 96/ for test: gem_exec_whisper results: parsing output: 97/ for test: kms_psr results: parsing output: 98/ for test: i915_drm_fdinfo results: parsing output: 99/ for test: prime_self_import results: parsing output: 100/ for test: kms_ccs results: parsing output: 101/ for test: kms_ccs results: parsing output: 102/ for test: kms_cursor_crc results: parsing output: 103/ for test: kms_addfb_basic results: parsing output: 104/ for test: gem_readwrite results: parsing output: 105/ for test: gem_eio results: parsing output: 106/ for test: gem_exercise_blt results: parsing output: 107/ for test: kms_plane_scaling results: parsing output: 108/ for test: syncobj_wait results: parsing output: 109/ for test: gem_exec_schedule results: parsing output: 110/ for test: kms_psr results: parsing output: 111/ for test: prime_vgem results: parsing output: 112/ for test: kms_dp_linktrain_fallback results: parsing output: 113/ for test: gem_exec_reloc results: parsing output: 114/ for test: gem_create results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_cursor_legacy results: parsing output: 117/ for test: kms_color results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: gem_ctx_persistence results: parsing output: 120/ for test: kms_plane_multiple results: parsing output: 121/ for test: kms_flip results: parsing output: 122/ for test: i915_pm_rps results: parsing output: 123/ for test: kms_rotation_crc results: parsing output: 124/ for test: kms_big_fb results: parsing output: 125/ for test: kms_lease results: parsing output: 126/ for test: kms_flip results: parsing output: 127/ for test: kms_big_fb results: parsing output: 128/ for test: api_intel_allocator results: parsing output: 129/ for test: kms_pipe_crc_basic results: parsing output: 130/ for test: syncobj_timeline Done.