[61.361917] Initializing watchdogs [61.361981] /dev/watchdog0 [61.379122] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [61.388838] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [61.392305] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.395232] [001/130] (960s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs) [61.676925] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs [61.677873] Starting dynamic subtest: pipe-A-DP-4 [67.692135] Dynamic subtest pipe-A-DP-4: SUCCESS (6.003s) [67.699663] Starting dynamic subtest: pipe-B-DP-4 [69.234760] Dynamic subtest pipe-B-DP-4: SUCCESS (1.539s) [69.248229] Starting dynamic subtest: pipe-C-DP-4 [70.806131] Dynamic subtest pipe-C-DP-4: SUCCESS (1.566s) [70.819693] Starting dynamic subtest: pipe-D-DP-4 [72.376870] Dynamic subtest pipe-D-DP-4: SUCCESS (1.565s) [72.378847] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SUCCESS (10.684s) [72.692130] [002/130] (949s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff) [72.901658] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff [72.903413] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [73.024225] [003/130] (949s left) kms_force_connector_basic (force-load-detect) [73.128178] Starting subtest: force-load-detect [73.129967] Subtest force-load-detect: SKIP (0.000s) [73.333657] [004/130] (948s left) kms_invalid_mode (bad-htotal) [73.534352] Starting subtest: bad-htotal [73.535295] Starting dynamic subtest: pipe-A-DP-4 [73.604435] Dynamic subtest pipe-A-DP-4: SUCCESS (0.070s) [73.612014] Starting dynamic subtest: pipe-B-DP-4 [73.613169] Dynamic subtest pipe-B-DP-4: SUCCESS (0.001s) [73.620132] Starting dynamic subtest: pipe-C-DP-4 [73.621354] Dynamic subtest pipe-C-DP-4: SUCCESS (0.001s) [73.628408] Starting dynamic subtest: pipe-D-DP-4 [73.629315] Dynamic subtest pipe-D-DP-4: SUCCESS (0.001s) [73.630234] Subtest bad-htotal: SUCCESS (0.075s) [73.844083] [005/130] (948s left) gem_exec_schedule (pi-ringfull) [74.055184] Starting subtest: pi-ringfull [74.056160] Starting dynamic subtest: rcs0 [74.154625] Dynamic subtest rcs0: SUCCESS (0.105s) [74.162778] Starting dynamic subtest: bcs0 [74.231043] Dynamic subtest bcs0: SUCCESS (0.076s) [74.243496] Starting dynamic subtest: vcs0 [74.314020] Dynamic subtest vcs0: SUCCESS (0.083s) [74.326812] Starting dynamic subtest: vcs1 [74.399530] Dynamic subtest vcs1: SUCCESS (0.085s) [74.412443] Starting dynamic subtest: vecs0 [74.483786] Dynamic subtest vecs0: SUCCESS (0.084s) [74.497139] Starting dynamic subtest: vecs1 [74.567369] Dynamic subtest vecs1: SUCCESS (0.083s) [74.578256] Starting dynamic subtest: ccs0 [74.647142] Dynamic subtest ccs0: SUCCESS (0.079s) [74.648236] Subtest pi-ringfull: SUCCESS (0.597s) [74.931591] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true [74.933435] [006/130] (947s left) kms_fbcon_fbt (fbc) [75.013213] Starting subtest: fbc [78.583706] Subtest fbc: SUCCESS (3.568s) [78.697284] [007/130] (943s left) gem_exec_balancer (hog) [78.787542] Starting subtest: hog [78.789556] Subtest hog: SKIP (0.000s) [79.220718] [008/130] (943s left) kms_properties (crtc-properties-atomic) [79.425372] Starting subtest: crtc-properties-atomic [79.426320] Starting dynamic subtest: pipe-A-DP-4 [79.756363] Dynamic subtest pipe-A-DP-4: SUCCESS (0.329s) [79.764300] Starting dynamic subtest: pipe-B-DP-4 [80.114350] Dynamic subtest pipe-B-DP-4: SUCCESS (0.358s) [80.121990] Starting dynamic subtest: pipe-C-DP-4 [80.470302] Dynamic subtest pipe-C-DP-4: SUCCESS (0.355s) [80.478174] Starting dynamic subtest: pipe-D-DP-4 [80.826234] Dynamic subtest pipe-D-DP-4: SUCCESS (0.355s) [80.827185] Subtest crtc-properties-atomic: SUCCESS (1.400s) [81.130272] [009/130] (941s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt) [81.343645] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt [81.345405] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [81.480193] [010/130] (940s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s [81.687199] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size [81.689078] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s) [81.770022] [011/130] (940s left) gem_caching (writes) [81.857299] Starting subtest: writes [85.560219] Subtest writes: SUCCESS (3.701s) [85.711056] [012/130] (936s left) gem_lmem_swapping (verify-random-ccs) [88.620197] Starting subtest: verify-random-ccs [88.621169] Starting dynamic subtest: lmem0 [92.829142] Dynamic subtest lmem0: SUCCESS (4.209s) [92.830183] Subtest verify-random-ccs: SUCCESS (4.209s) [94.090594] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [94.091577] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: kernel.kmod_is_loaded.i915: true [94.093146] [013/130] (928s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [96.024172] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [96.084982] [FACT kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [96.088699] [FACT kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)] new: kernel.kmod_is_loaded.i915: true [96.089530] [FACT kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)] new: kernel.kmod_is_loaded.xe: true [96.091299] [014/130] (926s left) kms_vrr (lobf) [96.301102] Starting subtest: lobf [96.303020] Subtest lobf: SKIP (0.000s) [96.379396] [015/130] (926s left) device_reset (cold-reset-bound) [96.470479] Starting subtest: cold-reset-bound [96.472447] Subtest cold-reset-bound: SKIP (0.000s) [96.575649] [016/130] (926s left) kms_chamelium_frames (hdmi-cmp-planar-formats) [96.865077] Subtest hdmi-cmp-planar-formats: SKIP (0.000s) [97.009060] [017/130] (925s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-pwrite) [97.217653] Starting subtest: psr-1p-offscren-pri-indfb-draw-pwrite [97.219383] Subtest psr-1p-offscren-pri-indfb-draw-pwrite: SKIP (0.000s) [97.378167] [018/130] (925s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move) [97.596936] Starting subtest: fbc-2p-primscrn-spr-indfb-move [97.598679] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s) [97.729650] [019/130] (925s left) kms_chamelium_frames (dp-crc-single) [98.025323] Subtest dp-crc-single: SKIP (0.000s) [98.183544] [020/130] (924s left) gem_ctx_exec (basic-invalid-context) [98.266719] Starting subtest: basic-invalid-context [98.276451] Subtest basic-invalid-context: SUCCESS (0.010s) [98.428137] [021/130] (924s left) kms_vblank (query-idle-hang) [98.633620] Starting subtest: query-idle-hang [98.635586] Starting dynamic subtest: pipe-A-DP-4 [125.608134] Dynamic subtest pipe-A-DP-4: SUCCESS (26.970s) [125.617764] Starting dynamic subtest: pipe-D-DP-4 [150.602163] Dynamic subtest pipe-D-DP-4: SUCCESS (24.991s) [150.603158] Subtest query-idle-hang: SUCCESS (51.966s) [150.867685] [022/130] (872s left) syncobj_wait (reset-signaled) [150.946810] Starting subtest: reset-signaled [150.947800] Subtest reset-signaled: SUCCESS (0.000s) [151.057336] [023/130] (872s left) sriov_basic (enable-vfs-bind-unbind-each) [151.138216] Subtest enable-vfs-bind-unbind-each: SKIP (0.000s) [151.228559] [024/130] (871s left) kms_plane_multiple (tiling-y) [151.435211] Starting subtest: tiling-y [151.436987] Subtest tiling-y: SKIP (0.000s) [151.512942] [025/130] (871s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [151.719650] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [151.721374] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [151.820598] [026/130] (871s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled) [151.900562] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [151.901470] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s) [152.065466] [027/130] (871s left) perf_pmu (busy-idle-check-all) [152.136134] Starting subtest: busy-idle-check-all [152.137113] Starting dynamic subtest: rcs0 [152.843457] Dynamic subtest rcs0: SUCCESS (0.706s) [152.856174] Starting dynamic subtest: bcs0 [153.501043] Dynamic subtest bcs0: SUCCESS (0.656s) [153.512425] Starting dynamic subtest: vcs0 [154.156978] Dynamic subtest vcs0: SUCCESS (0.654s) [154.169182] Starting dynamic subtest: vcs1 [154.813998] Dynamic subtest vcs1: SUCCESS (0.655s) [154.826973] Starting dynamic subtest: vecs0 [155.472915] Dynamic subtest vecs0: SUCCESS (0.657s) [155.485971] Starting dynamic subtest: vecs1 [156.131979] Dynamic subtest vecs1: SUCCESS (0.657s) [156.144928] Starting dynamic subtest: ccs0 [156.788846] Dynamic subtest ccs0: SUCCESS (0.655s) [156.790883] Subtest busy-idle-check-all: SUCCESS (4.653s) [156.954847] [028/130] (866s left) kms_big_fb (linear-8bpp-rotate-90) [157.172577] Starting subtest: linear-8bpp-rotate-90 [157.222309] Subtest linear-8bpp-rotate-90: SKIP (0.049s) [157.415709] [029/130] (866s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area) [157.628169] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [157.676762] [030/130] (865s left) kms_cursor_crc (cursor-offscreen-32x10) [157.970290] Starting subtest: cursor-offscreen-32x10 [158.019094] Subtest cursor-offscreen-32x10: SKIP (0.047s) [158.355611] [031/130] (865s left) gem_pread (bench) [158.436166] Subtest bench: SKIP (0.000s) [158.493109] [032/130] (865s left) gen9_exec_parse (unaligned-jump) [158.575517] Subtest unaligned-jump: SKIP (0.000s) [158.669686] [033/130] (865s left) gem_userptr_blits (mmap-offset-banned) [158.766289] Starting subtest: mmap-offset-banned [158.767243] Starting dynamic subtest: fixed [158.768172] Dynamic subtest fixed: SUCCESS (0.000s) [158.769168] Subtest mmap-offset-banned: SUCCESS (0.001s) [158.961163] [034/130] (864s left) perf_pmu (module-unload) [159.105117] Starting subtest: module-unload [198.416299] Subtest module-unload: SUCCESS (39.310s) [198.448536] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [198.449596] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true [198.451839] [035/130] (825s left) fbdev (unaligned-write) [202.471062] Starting subtest: unaligned-write [202.835573] Subtest unaligned-write: SUCCESS (0.364s) [202.872518] [FACT fbdev (unaligned-write)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [202.876097] [FACT fbdev (unaligned-write)] new: kernel.kmod_is_loaded.amdgpu: true [202.876214] [FACT fbdev (unaligned-write)] new: kernel.kmod_is_loaded.i915: true [202.878952] [036/130] (820s left) gen7_exec_parse (load-register-reg) [202.971121] Subtest load-register-reg: SKIP (0.000s) [203.039739] [037/130] (820s left) gem_exec_params (rel-constants-invalid-rel-gen5) [203.125297] Starting subtest: rel-constants-invalid-rel-gen5 [203.126251] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [203.244472] [038/130] (820s left) syncobj_wait (single-wait-for-submit-submitted) [203.328723] Starting subtest: single-wait-for-submit-submitted [203.431558] Subtest single-wait-for-submit-submitted: SUCCESS (0.102s) [203.573263] [039/130] (820s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [203.781190] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [203.782149] Starting dynamic subtest: pipe-A-valid-mode [203.863402] Dynamic subtest pipe-A-valid-mode: SKIP (0.081s) [203.865212] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.082s) [204.072328] [040/130] (820s left) kms_cursor_crc (cursor-suspend) [204.336172] Starting subtest: cursor-suspend [204.338285] Starting dynamic subtest: pipe-A-DP-4 [242.681045] Dynamic subtest pipe-A-DP-4: SUCCESS (7.997s) [242.703618] Starting dynamic subtest: pipe-D-DP-4 [281.637058] Dynamic subtest pipe-D-DP-4: SUCCESS (7.620s) [281.638149] Subtest cursor-suspend: SUCCESS (15.623s) [286.150723] [041/130] (803s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [286.373595] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [286.375505] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [286.482460] [042/130] (803s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled) [286.570836] Starting subtest: yf-tiled-to-vebox-yf-tiled [286.572742] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s) [286.832207] [043/130] (803s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled) [286.911297] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [286.912439] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [287.047909] [044/130] (803s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [287.256726] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [287.257665] Starting dynamic subtest: pipe-A-valid-mode [289.752125] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.492s) [289.753659] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SUCCESS (2.495s) [290.048118] [045/130] (800s left) kms_psr (fbc-psr-no-drrs) [290.270576] Subtest fbc-psr-no-drrs: SKIP (0.000s) [290.327859] [046/130] (799s left) gem_exec_whisper (basic-fds-all) [290.419366] Starting subtest: basic-fds-all [312.463003] Subtest basic-fds-all: SUCCESS (22.036s) [312.700032] [047/130] (777s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu) [312.917202] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu [315.355608] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.439s) [315.523146] [048/130] (774s left) syncobj_timeline (single-wait-for-submit-available-submitted) [315.603833] Starting subtest: single-wait-for-submit-available-submitted [315.604715] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s) [315.777231] [049/130] (774s left) kms_big_fb (y-tiled-32bpp-rotate-0) [315.990668] Starting subtest: y-tiled-32bpp-rotate-0 [315.992488] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [316.120400] [050/130] (774s left) gem_lmem_swapping (verify-random) [318.891227] Starting subtest: verify-random [318.892663] Starting dynamic subtest: lmem0 [326.733712] Dynamic subtest lmem0: SUCCESS (7.842s) [326.734676] Subtest verify-random: SUCCESS (7.843s) [328.053744] [FACT gem_lmem_swapping (verify-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [328.055126] [FACT gem_lmem_swapping (verify-random)] deleted: kernel.kmod_is_loaded.i915: true [328.057167] [051/130] (762s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [329.694458] Starting subtest: plane-all-transition-nonblocking-fencing [329.699897] Starting dynamic subtest: pipe-A-DP-4 [333.450559] Dynamic subtest pipe-A-DP-4: SUCCESS (3.751s) [333.565653] Starting dynamic subtest: pipe-B-DP-4 [337.326523] Dynamic subtest pipe-B-DP-4: SUCCESS (3.794s) [337.382245] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (7.689s) [337.634385] [FACT kms_atomic_transition (plane-all-transition-nonblocking-fencing)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [337.637783] [FACT kms_atomic_transition (plane-all-transition-nonblocking-fencing)] new: kernel.kmod_is_loaded.i915: true [337.640504] [052/130] (752s left) gem_softpin (evict-snoop) [337.736305] Starting subtest: evict-snoop [337.738437] Subtest evict-snoop: SKIP (0.000s) [337.833180] [053/130] (752s left) kms_sequence (queue-busy) [338.041625] Starting subtest: queue-busy [338.042552] Starting dynamic subtest: pipe-A-DP-4 [340.613383] Dynamic subtest pipe-A-DP-4: SUCCESS (2.571s) [340.624362] Starting dynamic subtest: pipe-B-DP-4 [343.081690] Dynamic subtest pipe-B-DP-4: SUCCESS (2.468s) [343.094491] Starting dynamic subtest: pipe-C-DP-4 [345.557727] Dynamic subtest pipe-C-DP-4: SUCCESS (2.474s) [345.569791] Starting dynamic subtest: pipe-D-DP-4 [348.034928] Dynamic subtest pipe-D-DP-4: SUCCESS (2.475s) [348.035901] Subtest queue-busy: SUCCESS (9.994s) [348.293917] [054/130] (742s left) vgem_basic (debugfs) [348.353438] Starting subtest: debugfs [348.354402] Subtest debugfs: SUCCESS (0.001s) [348.441180] [055/130] (742s left) gem_exec_reloc (basic-active) [348.527569] Subtest basic-active: SKIP (0.000s) [348.623881] [056/130] (742s left) kms_lease (lease-invalid-crtc) [348.832052] Starting subtest: lease-invalid-crtc [348.833011] Starting dynamic subtest: pipe-A-DP-4 [348.833949] Dynamic subtest pipe-A-DP-4: SUCCESS (0.000s) [348.845419] Starting dynamic subtest: pipe-B-DP-4 [348.846328] Dynamic subtest pipe-B-DP-4: SUCCESS (0.000s) [348.856782] Starting dynamic subtest: pipe-C-DP-4 [348.857881] Dynamic subtest pipe-C-DP-4: SUCCESS (0.000s) [348.867898] Starting dynamic subtest: pipe-D-DP-4 [348.868783] Dynamic subtest pipe-D-DP-4: SUCCESS (0.000s) [348.869779] Subtest lease-invalid-crtc: SUCCESS (0.007s) [348.931412] [057/130] (741s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt) [349.156875] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt [349.158844] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [349.313105] [058/130] (741s left) kms_busy (extended-modeset-hang-newfb-with-reset) [349.542810] Starting subtest: extended-modeset-hang-newfb-with-reset [349.543696] Starting dynamic subtest: pipe-A [370.361282] Dynamic subtest pipe-A: SUCCESS (20.816s) [370.381517] Starting dynamic subtest: pipe-D [391.328978] Dynamic subtest pipe-D: SUCCESS (20.963s) [391.331770] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (41.788s) [391.607210] [059/130] (699s left) kms_addfb_basic (invalid-get-prop-any) [391.687725] Starting subtest: invalid-get-prop-any [391.688722] Subtest invalid-get-prop-any: SUCCESS (0.000s) [391.936179] [060/130] (699s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite) [392.158137] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite [392.159907] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [392.289880] [061/130] (698s left) prime_mmap_coherency (read) [392.374676] Starting subtest: read [397.770069] Subtest read: SUCCESS (5.395s) [397.912590] [062/130] (693s left) kms_frontbuffer_tracking (fbcpsr-2p-rte) [398.133862] Starting subtest: fbcpsr-2p-rte [398.135826] Subtest fbcpsr-2p-rte: SKIP (0.000s) [398.254033] [063/130] (692s left) gem_userptr_blits (access-control) [398.361220] Starting subtest: access-control [398.363257] Subtest access-control: SKIP (0.000s) [398.536483] [064/130] (692s left) gem_exec_balancer (bonded-dual) [398.628856] Starting subtest: bonded-dual [398.631015] Subtest bonded-dual: SKIP (0.000s) [398.956471] [065/130] (692s left) i915_query (hwconfig_table) [399.033669] Starting subtest: hwconfig_table [399.286513] Subtest hwconfig_table: SUCCESS (0.001s) [399.359708] [066/130] (692s left) kms_setmode (basic) [399.436675] Starting subtest: basic [399.599419] Starting dynamic subtest: pipe-A-DP-4 [401.760075] Dynamic subtest pipe-A-DP-4: SUCCESS (2.157s) [401.890960] Starting dynamic subtest: pipe-B-DP-4 [404.042718] Dynamic subtest pipe-B-DP-4: SUCCESS (2.159s) [404.115749] Subtest basic: SUCCESS (4.678s) [404.401645] [067/130] (687s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy) [404.616751] Starting subtest: fbcpsr-modesetfrombusy [404.618600] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s) [404.761804] [068/130] (686s left) kms_cursor_crc (cursor-onscreen-512x512) [405.173540] Starting subtest: cursor-onscreen-512x512 [405.176694] Subtest cursor-onscreen-512x512: SKIP (0.001s) [405.438604] [069/130] (686s left) kms_ccs (crc-primary-suspend-y-tiled-ccs) [405.650400] Starting subtest: crc-primary-suspend-y-tiled-ccs [405.651376] Starting dynamic subtest: pipe-A-DP-4 [405.654811] Dynamic subtest pipe-A-DP-4: SKIP (0.000s) [405.666273] Starting dynamic subtest: pipe-B-DP-4 [405.669947] Dynamic subtest pipe-B-DP-4: SKIP (0.000s) [405.681251] Starting dynamic subtest: pipe-C-DP-4 [405.684917] Dynamic subtest pipe-C-DP-4: SKIP (0.000s) [405.695710] Starting dynamic subtest: pipe-D-DP-4 [405.699256] Dynamic subtest pipe-D-DP-4: SKIP (0.000s) [405.701022] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.007s) [406.136267] [070/130] (685s left) gem_softpin (allocator-evict) [406.221428] Starting subtest: allocator-evict [406.222426] Starting dynamic subtest: rcs0 [432.533419] Dynamic subtest rcs0: SUCCESS (26.309s) [432.545199] Starting dynamic subtest: bcs0 [458.888827] Dynamic subtest bcs0: SUCCESS (26.353s) [458.900503] Starting dynamic subtest: vcs0 [485.556743] Dynamic subtest vcs0: SUCCESS (26.666s) [485.568223] Starting dynamic subtest: vcs1 [512.170027] Dynamic subtest vcs1: SUCCESS (26.611s) [512.181975] Starting dynamic subtest: vecs0 [538.481753] Dynamic subtest vecs0: SUCCESS (26.310s) [538.493713] Starting dynamic subtest: vecs1 [564.761746] Dynamic subtest vecs1: SUCCESS (26.278s) [564.773344] Starting dynamic subtest: ccs0 [591.143853] Dynamic subtest ccs0: SUCCESS (26.380s) [591.144738] Subtest allocator-evict: SUCCESS (184.916s) [591.272548] [071/130] (500s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5) [591.520832] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5 [591.521627] Starting dynamic subtest: pipe-A [591.622609] Dynamic subtest pipe-A: SUCCESS (0.102s) [591.633930] Starting dynamic subtest: pipe-B [591.825407] Dynamic subtest pipe-B: SUCCESS (0.202s) [591.836806] Starting dynamic subtest: pipe-C [592.029868] Dynamic subtest pipe-C: SUCCESS (0.203s) [592.045515] Starting dynamic subtest: pipe-D [592.250729] Dynamic subtest pipe-D: SUCCESS (0.220s) [592.251795] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.732s) [592.587891] [072/130] (499s left) syncobj_wait (reset-unsignaled) [592.679395] Starting subtest: reset-unsignaled [592.680344] Subtest reset-unsignaled: SUCCESS (0.000s) [592.829212] [073/130] (499s left) kms_psr (fbc-pr-primary-mmap-gtt) [593.035511] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s) [593.096409] [074/130] (498s left) kms_flip (basic-flip-vs-modeset) [593.311736] Starting subtest: basic-flip-vs-modeset [593.317037] Starting dynamic subtest: A-DP4 [594.193456] Dynamic subtest A-DP4: SUCCESS (0.874s) [594.218534] Starting dynamic subtest: B-DP4 [595.034534] Dynamic subtest B-DP4: SUCCESS (0.837s) [595.061928] Starting dynamic subtest: C-DP4 [595.887907] Dynamic subtest C-DP4: SUCCESS (0.851s) [595.904195] Starting dynamic subtest: D-DP4 [596.747884] Dynamic subtest D-DP4: SUCCESS (0.859s) [596.748841] Subtest basic-flip-vs-modeset: SUCCESS (3.437s) [597.038751] [075/130] (495s left) gem_exec_balancer (smoke) [597.134838] Starting subtest: smoke [620.223932] Subtest smoke: SUCCESS (23.086s) [621.281931] [076/130] (470s left) syncobj_timeline (multi-wait-all-for-submit-signaled) [621.357261] Starting subtest: multi-wait-all-for-submit-signaled [621.358194] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s) [621.524621] [077/130] (470s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy) [621.739724] Starting subtest: 2x-cursor-vs-flip-legacy [621.743481] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.003s) [621.832229] [078/130] (470s left) kms_feature_discovery (psr1) [622.049861] Starting subtest: psr1 [622.051846] Subtest psr1: SKIP (0.000s) [622.153041] [079/130] (470s left) kms_color (ctm-red-to-blue) [622.366650] Starting subtest: ctm-red-to-blue [622.367539] Starting dynamic subtest: pipe-A-DP-4 [623.010038] Dynamic subtest pipe-A-DP-4: SUCCESS (0.640s) [623.037823] Starting dynamic subtest: pipe-B-DP-4 [623.584109] Dynamic subtest pipe-B-DP-4: SUCCESS (0.572s) [623.603631] Starting dynamic subtest: pipe-C-DP-4 [624.190106] Dynamic subtest pipe-C-DP-4: SUCCESS (0.605s) [624.208878] Starting dynamic subtest: pipe-D-DP-4 [624.795992] Dynamic subtest pipe-D-DP-4: SUCCESS (0.604s) [624.797079] Subtest ctm-red-to-blue: SUCCESS (2.430s) [625.063033] [080/130] (467s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc) [625.270351] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc [625.271290] Starting dynamic subtest: pipe-A-DP-4 [625.280157] Dynamic subtest pipe-A-DP-4: SKIP (0.000s) [625.291925] Starting dynamic subtest: pipe-B-DP-4 [625.300501] Dynamic subtest pipe-B-DP-4: SKIP (0.000s) [625.312072] Starting dynamic subtest: pipe-C-DP-4 [625.320543] Dynamic subtest pipe-C-DP-4: SKIP (0.000s) [625.332216] Starting dynamic subtest: pipe-D-DP-4 [625.342592] Dynamic subtest pipe-D-DP-4: SKIP (0.000s) [625.344589] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s) [625.706035] [081/130] (466s left) syncobj_timeline (etime-single-wait-submitted) [625.793458] Starting subtest: etime-single-wait-submitted [625.900217] Subtest etime-single-wait-submitted: SUCCESS (0.105s) [626.049634] [082/130] (466s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-render) [626.271458] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-render [626.273210] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-render: SKIP (0.000s) [626.398276] [083/130] (466s left) perf (invalid-open-flags) [626.759890] Starting subtest: invalid-open-flags [626.760798] Subtest invalid-open-flags: SUCCESS (0.000s) [626.815145] [084/130] (465s left) gem_mmap_gtt (basic-short) [626.892520] Subtest basic-short: SKIP (0.000s) [626.964620] [085/130] (465s left) kms_rotation_crc (primary-y-tiled-reflect-x-180) [627.178632] Starting subtest: primary-y-tiled-reflect-x-180 [627.269305] Subtest primary-y-tiled-reflect-x-180: SKIP (0.090s) [627.429019] [086/130] (465s left) syncobj_wait (multi-wait-all-for-submit-signaled) [627.513630] Starting subtest: multi-wait-all-for-submit-signaled [627.514651] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [627.691769] [087/130] (465s left) gem_exec_fence (submit67) [627.901597] Starting subtest: submit67 [627.903701] Subtest submit67: SKIP (0.000s) [628.700167] [088/130] (464s left) kms_pm_rpm (pm-tiling) [630.747137] Starting subtest: pm-tiling [630.749482] Subtest pm-tiling: SKIP (0.000s) [631.125149] [089/130] (461s left) kms_getfb (getfb-handle-not-fb) [631.205685] Starting subtest: getfb-handle-not-fb [631.333028] Subtest getfb-handle-not-fb: SUCCESS (0.128s) [631.519912] [090/130] (461s left) api_intel_bb (lot-of-buffers) [631.606638] Starting subtest: lot-of-buffers [634.174253] Subtest lot-of-buffers: SUCCESS (2.568s) [634.492782] [091/130] (458s left) kms_properties (invalid-properties-atomic) [634.701992] Starting subtest: invalid-properties-atomic [635.065526] Subtest invalid-properties-atomic: SUCCESS (0.364s) [635.158482] [092/130] (458s left) gem_mmap_gtt (basic-copy) [635.240766] Subtest basic-copy: SKIP (0.000s) [635.321867] [093/130] (458s left) gem_mmap_offset (clear) [635.401707] Starting subtest: clear [635.402652] Starting dynamic subtest: lmem0 [659.587696] Dynamic subtest lmem0: SUCCESS (24.183s) [659.601931] Starting dynamic subtest: smem0 [685.643673] Dynamic subtest smem0: SUCCESS (26.054s) [685.644868] Subtest clear: SUCCESS (50.239s) [685.906015] [094/130] (407s left) kms_dp_link_training (uhbr-sst) [686.153894] Starting subtest: uhbr-sst [686.155673] Subtest uhbr-sst: SKIP (0.000s) [686.246234] [095/130] (407s left) kms_cursor_legacy (cursorb-vs-flipa-legacy) [686.457822] Starting subtest: cursorB-vs-flipA-legacy [686.461090] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s) [686.545005] [096/130] (406s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs) [686.759061] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs [686.760021] Starting dynamic subtest: pipe-A-DP-4 [686.770207] Dynamic subtest pipe-A-DP-4: SKIP (0.000s) [686.783034] Starting dynamic subtest: pipe-B-DP-4 [686.792799] Dynamic subtest pipe-B-DP-4: SKIP (0.000s) [686.804979] Starting dynamic subtest: pipe-C-DP-4 [686.814236] Dynamic subtest pipe-C-DP-4: SKIP (0.000s) [686.826437] Starting dynamic subtest: pipe-D-DP-4 [686.837778] Dynamic subtest pipe-D-DP-4: SKIP (0.000s) [686.839697] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SKIP (0.009s) [687.209084] [097/130] (406s left) kms_frontbuffer_tracking (fbcpsr-1p-rte) [687.426480] Starting subtest: fbcpsr-1p-rte [687.428286] Subtest fbcpsr-1p-rte: SKIP (0.000s) [687.547763] [098/130] (406s left) vgem_basic (dmabuf-export) [687.604010] Starting subtest: dmabuf-export [687.643385] Subtest dmabuf-export: SUCCESS (0.040s) [687.805187] [099/130] (405s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [688.042361] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [689.120942] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (1.078s) [689.362321] [100/130] (404s left) kms_addfb_basic (basic-y-tiled-legacy) [689.448286] Starting subtest: basic-y-tiled-legacy [689.450181] Subtest basic-y-tiled-legacy: SKIP (0.000s) [689.723284] [101/130] (404s left) gem_ctx_param (invalid-get-no-zeromap) [689.808007] Starting subtest: invalid-get-no-zeromap [689.810404] Subtest invalid-get-no-zeromap: SUCCESS (0.001s) [689.965836] [102/130] (404s left) fbdev (unaligned-read) [690.020858] Starting subtest: unaligned-read [690.033570] Subtest unaligned-read: SUCCESS (0.013s) [690.126201] [103/130] (403s left) gem_mmap_gtt (basic-small-bo) [690.208748] Subtest basic-small-bo: SKIP (0.000s) [690.289737] [104/130] (403s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-cpu) [690.506481] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-cpu [692.805838] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (2.300s) [692.974599] [105/130] (401s left) gem_tiled_pread_basic [693.139253] [106/130] (401s left) kms_flip (bo-too-big-interruptible) [693.353642] Starting subtest: bo-too-big-interruptible [693.357853] Starting dynamic subtest: A-DP4 [693.649385] Dynamic subtest A-DP4: SUCCESS (0.290s) [693.695830] Starting dynamic subtest: B-DP4 [693.901803] Dynamic subtest B-DP4: SUCCESS (0.247s) [693.937884] Starting dynamic subtest: C-DP4 [694.129697] Dynamic subtest C-DP4: SUCCESS (0.225s) [694.166384] Starting dynamic subtest: D-DP4 [694.371517] Dynamic subtest D-DP4: SUCCESS (0.238s) [694.375805] Subtest bo-too-big-interruptible: SUCCESS (1.021s) [694.760965] [107/130] (399s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [694.997753] Starting subtest: compare-crc-sanitycheck-xr24 [695.000474] Starting dynamic subtest: pipe-A-DP-4 [695.551293] Dynamic subtest pipe-A-DP-4: SUCCESS (0.552s) [695.572069] Starting dynamic subtest: pipe-B-DP-4 [696.030866] Dynamic subtest pipe-B-DP-4: SUCCESS (0.477s) [696.046103] Starting dynamic subtest: pipe-C-DP-4 [696.525790] Dynamic subtest pipe-C-DP-4: SUCCESS (0.493s) [696.542310] Starting dynamic subtest: pipe-D-DP-4 [696.990030] Dynamic subtest pipe-D-DP-4: SUCCESS (0.462s) [696.990917] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.993s) [697.242815] [108/130] (397s left) i915_pm_rpm (gem-execbuf-stress) [699.721088] Starting subtest: gem-execbuf-stress [699.722359] Starting dynamic subtest: lmem0 [703.110830] Dynamic subtest lmem0: SUCCESS (3.388s) [703.164880] Starting dynamic subtest: extra-wait-lmem0 [756.791199] Dynamic subtest extra-wait-lmem0: SUCCESS (53.673s) [756.806885] Starting dynamic subtest: smem0 [760.136525] Dynamic subtest smem0: SUCCESS (3.342s) [760.190937] Starting dynamic subtest: extra-wait-smem0 [813.541284] Dynamic subtest extra-wait-smem0: SUCCESS (53.400s) [813.543112] Subtest gem-execbuf-stress: SUCCESS (113.819s) [813.863543] [109/130] (280s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa [813.951260] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled [814.066386] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.107s) [814.211766] [110/130] (280s left) gem_ctx_shared (detached-shared-gtt) [814.306726] Starting subtest: detached-shared-gtt [816.458791] Subtest detached-shared-gtt: SUCCESS (2.151s) [819.157906] [111/130] (275s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [819.239414] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [819.240385] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [819.373386] [112/130] (275s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [819.604894] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [819.606796] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [819.722290] [113/130] (275s left) gem_mmap_gtt (basic-small-copy) [819.805537] Subtest basic-small-copy: SKIP (0.000s) [819.881213] [114/130] (274s left) kms_pm_dc (dc6-dpms) [821.097811] Starting subtest: dc6-dpms [821.099586] Subtest dc6-dpms: SKIP (0.000s) [821.197797] [115/130] (273s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render) [821.407793] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render [821.409570] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [821.553192] [116/130] (273s left) syncobj_wait (invalid-reset-bad-pad) [821.630298] Starting subtest: invalid-reset-bad-pad [821.631177] Subtest invalid-reset-bad-pad: SUCCESS (0.000s) [821.802352] [117/130] (273s left) kms_psr (psr-cursor-mmap-cpu) [822.012150] Subtest psr-cursor-mmap-cpu: SKIP (0.000s) [822.074702] [118/130] (272s left) kms_psr (fbc-psr-cursor-plane-onoff) [822.280007] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s) [822.342256] [119/130] (272s left) kms_psr (psr2-primary-blt) [822.553013] Subtest psr2-primary-blt: SKIP (0.000s) [822.608008] [120/130] (272s left) i915_pm_freq_mult (media-freq) [822.689641] Starting subtest: media-freq [822.690556] Starting dynamic subtest: gt0 [823.189816] Dynamic subtest gt0: SUCCESS (0.500s) [823.191054] Subtest media-freq: SUCCESS (0.502s) [823.388163] [121/130] (271s left) gem_exec_schedule (u-semaphore-codependency) [823.481949] Starting subtest: u-semaphore-codependency [823.517068] Subtest u-semaphore-codependency: SUCCESS (0.035s) [823.972350] [122/130] (271s left) kms_hdr (static-swap) [824.185906] Starting subtest: static-swap [827.581563] Starting dynamic subtest: pipe-A-DP-4 [828.778809] Dynamic subtest pipe-A-DP-4: SUCCESS (1.197s) [828.780313] Subtest static-swap: SUCCESS (4.595s) [829.105311] [123/130] (266s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip) [829.332840] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip [830.622665] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.282s) [830.772191] [124/130] (264s left) kms_big_fb (4-tiled-64bpp-rotate-0) [830.994601] Starting subtest: 4-tiled-64bpp-rotate-0 [832.883281] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.887s) [833.110196] [125/130] (262s left) kms_big_fb (yf-tiled-32bpp-rotate-90) [833.325433] Starting subtest: yf-tiled-32bpp-rotate-90 [833.327280] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s) [833.479455] [126/130] (262s left) gem_eio (in-flight-contexts-1us) [833.829764] Starting subtest: in-flight-contexts-1us [847.600946] Subtest in-flight-contexts-1us: SUCCESS (13.771s) [847.831890] [127/130] (247s left) drm_fdinfo (basics) [847.902674] Starting subtest: basics [847.903685] Subtest basics: SUCCESS (0.000s) [848.007401] [128/130] (247s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [848.215530] Starting subtest: planes-downscale-factor-0-75-unity-scaling [848.216242] Starting dynamic subtest: pipe-A [848.315158] Dynamic subtest pipe-A: SUCCESS (0.100s) [848.338529] Starting dynamic subtest: pipe-B [848.556556] Dynamic subtest pipe-B: SUCCESS (0.240s) [848.575541] Starting dynamic subtest: pipe-C [848.777166] Dynamic subtest pipe-C: SUCCESS (0.219s) [848.801313] Starting dynamic subtest: pipe-D [848.996925] Dynamic subtest pipe-D: SUCCESS (0.218s) [848.997849] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (0.783s) [849.328175] [129/130] (246s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt) [849.543906] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt [849.545631] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [849.685940] [130/130] (246s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [849.904594] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [849.905498] Starting dynamic subtest: pipe-A-DP-4 [849.914106] Dynamic subtest pipe-A-DP-4: SKIP (0.000s) [849.927358] Starting dynamic subtest: pipe-B-DP-4 [849.936255] Dynamic subtest pipe-B-DP-4: SKIP (0.000s) [849.949302] Starting dynamic subtest: pipe-C-DP-4 [849.957836] Dynamic subtest pipe-C-DP-4: SKIP (0.000s) [849.970934] Starting dynamic subtest: pipe-D-DP-4 [849.981596] Dynamic subtest pipe-D-DP-4: SKIP (0.000s) [849.983384] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.007s) [850.361704] Closing watchdogs Done.