[60.364784] Initializing watchdogs [60.364832] /dev/watchdog0 [60.379830] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [60.384777] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [60.387182] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.389574] [001/155] (960s left) kms_busy (extended-pageflip-hang-oldfb) [60.501400] Starting subtest: extended-pageflip-hang-oldfb [60.502404] Starting dynamic subtest: pipe-A [60.994443] Dynamic subtest pipe-A: SUCCESS (0.492s) [61.002043] Starting dynamic subtest: pipe-D [62.078873] Dynamic subtest pipe-D: SUCCESS (1.083s) [62.079814] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.578s) [62.919937] [002/155] (957s left) kms_color (ctm-blue-to-red) [63.008953] Starting subtest: ctm-blue-to-red [63.010270] Starting dynamic subtest: pipe-A-eDP-1 [63.717590] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.707s) [63.724114] Starting dynamic subtest: pipe-B-eDP-1 [65.137877] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.420s) [65.145242] Starting dynamic subtest: pipe-C-eDP-1 [66.513816] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.376s) [66.520976] Starting dynamic subtest: pipe-D-eDP-1 [67.839026] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s) [67.840157] Subtest ctm-blue-to-red: SUCCESS (4.830s) [68.648220] [003/155] (952s left) gem_eio (execbuf) [68.810406] Starting subtest: execbuf [69.020600] Subtest execbuf: SUCCESS (0.209s) [69.143918] [004/155] (951s left) gem_exec_schedule (fifo) [69.217727] Starting subtest: fifo [69.218881] Starting dynamic subtest: rcs0 [69.328049] Dynamic subtest rcs0: SUCCESS (0.109s) [69.338050] Starting dynamic subtest: vcs0 [69.406776] Dynamic subtest vcs0: SUCCESS (0.079s) [69.416065] Starting dynamic subtest: vcs1 [69.491491] Dynamic subtest vcs1: SUCCESS (0.085s) [69.501854] Starting dynamic subtest: vecs0 [69.573978] Dynamic subtest vecs0: SUCCESS (0.081s) [69.584364] Starting dynamic subtest: ccs0 [69.669799] Dynamic subtest ccs0: SUCCESS (0.097s) [69.670862] Subtest fifo: SUCCESS (0.452s) [70.385749] [005/155] (950s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs) [70.485096] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs [70.486022] Starting dynamic subtest: pipe-A-eDP-1 [104.720519] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.540s) [104.728731] Starting dynamic subtest: pipe-B-eDP-1 [139.665929] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.487s) [139.674912] Starting dynamic subtest: pipe-C-eDP-1 [174.643885] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.499s) [174.652388] Starting dynamic subtest: pipe-D-eDP-1 [209.646300] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.438s) [209.647348] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (17.968s) [215.884999] [006/155] (810s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite) [215.977172] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite [222.927455] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.947s) [223.020523] [007/155] (803s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75) [223.109852] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75 [223.110668] Starting dynamic subtest: pipe-A [223.130351] Dynamic subtest pipe-A: SKIP (0.019s) [223.138469] Starting dynamic subtest: pipe-B [223.162932] Dynamic subtest pipe-B: SKIP (0.032s) [223.171065] Starting dynamic subtest: pipe-C [223.195127] Dynamic subtest pipe-C: SKIP (0.032s) [223.203023] Starting dynamic subtest: pipe-D [223.228473] Dynamic subtest pipe-D: SKIP (0.033s) [223.230071] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.118s) [223.314368] [008/155] (802s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite) [223.400084] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite [232.321757] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.922s) [232.427543] [009/155] (793s left) kms_psr (pr-sprite-plane-move) [232.519654] Starting subtest: pr-sprite-plane-move [232.521446] Subtest pr-sprite-plane-move: SKIP (0.000s) [232.591053] [010/155] (793s left) gem_render_copy (y-tiled-to-vebox-y-tiled) [232.640703] Starting subtest: y-tiled-to-vebox-y-tiled [232.642811] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s) [232.829509] [011/155] (793s left) kms_plane (pixel-format-linear-modifier-source-clamping) [232.913810] Starting subtest: pixel-format-linear-modifier-source-clamping [232.940896] Starting dynamic subtest: pipe-A-plane-0 [233.507384] Dynamic subtest pipe-A-plane-0: SUCCESS (0.567s) [233.515385] Starting dynamic subtest: pipe-A-plane-3 [233.940658] Dynamic subtest pipe-A-plane-3: SUCCESS (0.433s) [235.039772] Starting dynamic subtest: pipe-B-plane-0 [235.631485] Dynamic subtest pipe-B-plane-0: SUCCESS (0.600s) [235.641123] Starting dynamic subtest: pipe-B-plane-3 [236.109766] Dynamic subtest pipe-B-plane-3: SUCCESS (0.477s) [236.417476] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (3.503s) [237.297999] [012/155] (788s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [237.387797] Starting subtest: fbc-1p-primscrn-cur-indfb-move [241.487495] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.099s) [242.721110] [013/155] (783s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-fullscreen) [242.808983] Starting subtest: hdr-2p-primscrn-spr-indfb-fullscreen [242.810925] Subtest hdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [242.898103] [014/155] (783s left) kms_cursor_crc (cursor-sliding-32x10) [243.063434] Starting subtest: cursor-sliding-32x10 [243.107326] Subtest cursor-sliding-32x10: SKIP (0.043s) [243.360981] [015/155] (783s left) kms_async_flips (test-time-stamp) [243.445532] Starting subtest: test-time-stamp [243.819307] Starting dynamic subtest: pipe-A-eDP-1 [244.609940] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.791s) [244.995306] Starting dynamic subtest: pipe-B-eDP-1 [245.843482] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.855s) [246.229460] Starting dynamic subtest: pipe-C-eDP-1 [247.000533] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.778s) [247.378163] Starting dynamic subtest: pipe-D-eDP-1 [248.148568] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.776s) [248.149711] Subtest test-time-stamp: SUCCESS (4.703s) [249.304882] [016/155] (777s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-blt) [249.395802] Starting subtest: psrhdr-rgb565-draw-blt [249.397594] Subtest psrhdr-rgb565-draw-blt: SKIP (0.000s) [249.499171] [017/155] (776s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-linear) [249.578938] Starting subtest: fbcpsrhdr-tiling-linear [249.580523] Subtest fbcpsrhdr-tiling-linear: SKIP (0.000s) [249.667599] [018/155] (776s left) core_getversion (basic) [249.698513] Starting subtest: basic [249.700287] Subtest basic: SUCCESS (0.000s) [249.768367] [019/155] (776s left) kms_vblank (query-idle-hang) [249.859593] Starting subtest: query-idle-hang [249.860505] Starting dynamic subtest: pipe-A-eDP-1 [276.290402] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.431s) [276.300401] Starting dynamic subtest: pipe-D-eDP-1 [301.265445] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.973s) [301.266287] Subtest query-idle-hang: SUCCESS (51.408s) [302.086482] [020/155] (724s left) kms_cursor_legacy (short-flip-after-cursor-toggle) [302.196375] Starting subtest: short-flip-after-cursor-toggle [303.125935] Subtest short-flip-after-cursor-toggle: SUCCESS (0.928s) [303.993377] [021/155] (722s left) prime_vgem (basic-fence-flip) [304.115087] Starting subtest: basic-fence-flip [304.407633] Subtest basic-fence-flip: SUCCESS (0.292s) [304.516436] [FACT prime_vgem (basic-fence-flip)] new: kernel.kmod_is_loaded.vgem: true [304.518927] [022/155] (722s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs) [304.609633] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs [304.610501] Starting dynamic subtest: pipe-A-eDP-1 [304.633154] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [304.642630] Starting dynamic subtest: pipe-B-eDP-1 [304.664993] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [304.673174] Starting dynamic subtest: pipe-C-eDP-1 [304.694654] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [304.709874] Starting dynamic subtest: pipe-D-eDP-1 [304.730842] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [304.733096] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.009s) [306.871865] [023/155] (719s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite) [306.974696] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite [314.293552] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.317s) [314.425021] [024/155] (712s left) kms_psr (psr-dpms) [314.516885] Starting subtest: psr-dpms [314.517843] Starting dynamic subtest: eDP-1 [317.512931] Dynamic subtest eDP-1: SUCCESS (2.993s) [317.513845] Subtest psr-dpms: SUCCESS (2.994s) [318.362256] [025/155] (708s left) gem_eio (create-ext) [318.543526] Starting subtest: create-ext [318.801003] Subtest create-ext: SUCCESS (0.258s) [318.934110] [026/155] (707s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen) [319.020668] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen [325.817671] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.796s) [325.958094] [027/155] (700s left) kms_psr (fbc-psr2-sprite-blt) [326.062607] Starting subtest: fbc-psr2-sprite-blt [326.063542] Starting dynamic subtest: eDP-1 [326.065503] Dynamic subtest eDP-1: SKIP (0.000s) [326.067109] Subtest fbc-psr2-sprite-blt: SKIP (0.001s) [326.146885] [028/155] (700s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-render) [326.242431] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-render [326.244084] Subtest fbchdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [326.331867] [029/155] (700s left) kms_pm_dc (dc6-psr) [327.430654] Starting subtest: dc6-psr [330.417318] Subtest dc6-psr: SUCCESS (2.987s) [331.229868] [030/155] (695s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [331.281201] Starting subtest: multi-wait-for-submit-available-submitted [331.282151] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s) [331.376762] [031/155] (695s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf) [331.471038] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf [331.472895] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s) [331.539287] [032/155] (695s left) gem_ctx_persistence (legacy-engines-queued) [331.596259] Starting subtest: legacy-engines-queued [331.597466] Starting dynamic subtest: render [331.674659] Dynamic subtest render: SUCCESS (0.078s) [331.689468] Starting dynamic subtest: bsd1 [333.485905] Dynamic subtest bsd1: SUCCESS (1.798s) [333.496415] Starting dynamic subtest: bsd2 [335.468613] Dynamic subtest bsd2: SUCCESS (1.977s) [335.479049] Starting dynamic subtest: blt [335.527597] Dynamic subtest blt: SUCCESS (0.066s) [335.538954] Starting dynamic subtest: vebox [337.515312] Dynamic subtest vebox: SUCCESS (1.975s) [337.516683] Subtest legacy-engines-queued: SUCCESS (5.911s) [337.583652] [033/155] (689s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [337.675329] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [337.677248] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s) [337.745505] [034/155] (689s left) kms_rotation_crc (cursor-rotation-180) [337.839665] Starting subtest: cursor-rotation-180 [339.391336] Subtest cursor-rotation-180: SUCCESS (1.552s) [340.576097] [035/155] (686s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt) [340.673489] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt [340.675133] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [340.771240] [036/155] (686s left) api_intel_allocator (fork-simple-stress) [340.815088] Starting subtest: fork-simple-stress [346.258972] Subtest fork-simple-stress: SUCCESS (5.399s) [346.327603] [037/155] (680s left) kms_getfb (getfb-handle-valid) [346.432498] Starting subtest: getfb-handle-valid [346.433422] Subtest getfb-handle-valid: SUCCESS (0.000s) [346.540631] [038/155] (680s left) i915_drm_fdinfo (most-busy-idle-check-all) [346.579338] Starting subtest: most-busy-idle-check-all [346.580937] Starting dynamic subtest: rcs0 [346.584943] Dynamic subtest rcs0: SKIP (0.004s) [346.594539] Starting dynamic subtest: bcs0 [346.596248] Dynamic subtest bcs0: SKIP (0.000s) [346.605083] Starting dynamic subtest: vcs0 [346.606822] Dynamic subtest vcs0: SKIP (0.000s) [346.614821] Starting dynamic subtest: vcs1 [346.616634] Dynamic subtest vcs1: SKIP (0.000s) [346.624992] Starting dynamic subtest: vecs0 [346.626840] Dynamic subtest vecs0: SKIP (0.000s) [346.634658] Starting dynamic subtest: ccs0 [346.636346] Dynamic subtest ccs0: SKIP (0.000s) [346.637808] Subtest most-busy-idle-check-all: SKIP (0.010s) [346.669251] [039/155] (680s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc) [346.827070] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc [346.828800] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [346.944425] [040/155] (680s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [347.040582] Starting subtest: plane-all-transition-nonblocking-fencing [347.041426] Starting dynamic subtest: pipe-A-eDP-1 [349.541016] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.500s) [349.856820] Starting dynamic subtest: pipe-B-eDP-1 [353.128094] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.279s) [353.424022] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.384s) [354.245524] [041/155] (673s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-blt) [354.349611] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-blt [354.351458] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [354.443500] [042/155] (672s left) kms_prop_blob (basic) [354.495776] Starting subtest: basic [354.496756] Subtest basic: SUCCESS (0.000s) [354.600098] [043/155] (672s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [354.686833] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [354.687759] Starting dynamic subtest: pipe-A-eDP-1 [354.697468] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [354.706490] Starting dynamic subtest: pipe-B-eDP-1 [354.716006] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [354.724337] Starting dynamic subtest: pipe-C-eDP-1 [354.732763] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [354.741107] Starting dynamic subtest: pipe-D-eDP-1 [354.750219] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [354.751921] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [357.001232] [044/155] (670s left) kms_addfb_basic (small-bo) [357.092219] Starting subtest: small-bo [357.093831] Subtest small-bo: SUCCESS (0.000s) [357.196771] [045/155] (670s left) gem_basic (multigpu-create-close) [357.240324] Starting subtest: multigpu-create-close [357.241930] Subtest multigpu-create-close: SKIP (0.000s) [357.329502] [046/155] (670s left) kms_addfb_basic (unused-offsets) [357.384789] Starting subtest: unused-offsets [357.385700] Subtest unused-offsets: SUCCESS (0.000s) [357.522226] [047/155] (669s left) gem_exec_whisper (basic-fds-priority) [357.584010] Starting subtest: basic-fds-priority [381.220655] Subtest basic-fds-priority: SUCCESS (23.626s) [381.396377] [048/155] (646s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [381.498344] Starting subtest: plane-scaler-with-clipping-clamping-rotation [381.499148] Starting dynamic subtest: pipe-A [381.750008] Dynamic subtest pipe-A: SUCCESS (0.252s) [381.758875] Starting dynamic subtest: pipe-B [383.091230] Dynamic subtest pipe-B: SUCCESS (1.340s) [383.100486] Starting dynamic subtest: pipe-C [384.412633] Dynamic subtest pipe-C: SUCCESS (1.320s) [384.421964] Starting dynamic subtest: pipe-D [385.769792] Dynamic subtest pipe-D: SUCCESS (1.356s) [385.770655] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.272s) [386.913214] [049/155] (640s left) gem_flink_race (flink_name) [386.945323] Starting subtest: flink_name [392.385414] Subtest flink_name: SUCCESS (5.393s) [392.456596] [050/155] (635s left) gem_lmem_swapping (parallel-random-verify) [392.489607] Subtest parallel-random-verify: SKIP (0.000s) [392.528704] [051/155] (635s left) syncobj_timeline (invalid-single-wait-unsubmitted) [392.576354] Starting subtest: invalid-single-wait-unsubmitted [392.577420] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [392.687179] [052/155] (634s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-blt) [392.789610] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-blt [392.791220] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s) [392.884063] [053/155] (634s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt) [392.968743] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt [392.970233] Subtest fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [393.067315] [054/155] (634s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-msflip-blt) [393.159285] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-msflip-blt [393.160974] Subtest fbcpsrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [393.268081] [055/155] (634s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-pwrite) [393.364564] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-pwrite [393.366249] Subtest fbchdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s) [393.462314] [056/155] (634s left) kms_plane_multiple (2x-tiling-yf) [393.556440] Starting subtest: 2x-tiling-yf [393.558121] Subtest 2x-tiling-yf: SKIP (0.000s) [393.626362] [057/155] (634s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling) [393.714114] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling [393.716128] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s) [393.783170] [058/155] (634s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0) [393.900703] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0 [393.902616] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [394.002208] [059/155] (633s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [394.095219] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [394.097168] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [394.191279] [060/155] (633s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite) [394.292846] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite [394.294533] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [394.383129] [061/155] (633s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-render) [394.480346] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-render [394.481910] Subtest hdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [394.587983] [062/155] (633s left) kms_big_fb (yf-tiled-8bpp-rotate-0) [394.684443] Starting subtest: yf-tiled-8bpp-rotate-0 [394.686442] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s) [394.785436] [063/155] (633s left) gem_exec_reloc (basic-cpu-wc) [394.841771] Subtest basic-cpu-wc: SKIP (0.000s) [394.912437] [064/155] (633s left) kms_chamelium_color (ctm-blue-to-red) [394.996325] Subtest ctm-blue-to-red: SKIP (0.000s) [395.037104] [065/155] (633s left) syncobj_wait (invalid-multi-wait-unsubmitted) [395.089325] Starting subtest: invalid-multi-wait-unsubmitted [395.090362] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [395.196100] [066/155] (632s left) kms_chamelium_hpd (dp-hpd-storm-disable) [395.575280] Subtest dp-hpd-storm-disable: SKIP (0.000s) [396.418782] [067/155] (631s left) gem_userptr_blits (probe) [396.497040] Starting subtest: probe [396.577600] Subtest probe: SUCCESS (0.080s) [396.689107] [068/155] (631s left) kms_frontbuffer_tracking (hdr-shrfb-scaledprimary) [396.802617] Starting subtest: hdr-shrfb-scaledprimary [396.804440] Subtest hdr-shrfb-scaledprimary: SKIP (0.000s) [396.916465] [069/155] (631s left) kms_cursor_crc (cursor-rapid-movement-512x170) [397.222394] Starting subtest: cursor-rapid-movement-512x170 [397.224211] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [397.376695] [070/155] (630s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf) [397.466028] Starting subtest: pr-overlay-plane-update-continuous-sf [397.467860] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s) [397.534548] [071/155] (630s left) kms_flip (absolute-wf_vblank-interruptible) [397.620342] Starting subtest: absolute-wf_vblank-interruptible [397.621614] Starting dynamic subtest: A-eDP1 [406.427753] Dynamic subtest A-eDP1: SUCCESS (8.779s) [406.438999] Starting dynamic subtest: B-eDP1 [415.165432] Dynamic subtest B-eDP1: SUCCESS (8.735s) [415.175581] Starting dynamic subtest: C-eDP1 [423.902096] Dynamic subtest C-eDP1: SUCCESS (8.724s) [423.914241] Starting dynamic subtest: D-eDP1 [432.599847] Dynamic subtest D-eDP1: SUCCESS (8.732s) [432.604986] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.985s) [433.807436] [072/155] (594s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-render) [433.896169] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-render [433.897807] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [433.987714] [073/155] (594s left) perf (polling) [434.098642] Starting subtest: polling [434.099455] Starting dynamic subtest: 0-rcs0 [444.172747] Dynamic subtest 0-rcs0: SUCCESS (10.027s) [444.185171] Starting dynamic subtest: 1-vcs0 [454.159322] Dynamic subtest 1-vcs0: SUCCESS (10.020s) [454.160158] Subtest polling: SUCCESS (20.051s) [454.198229] [074/155] (574s left) gem_spin_batch (resubmit-new-all) [454.253581] Starting subtest: resubmit-new-all [454.255573] Starting dynamic subtest: rcs0 [454.270056] Dynamic subtest rcs0: SUCCESS (0.016s) [454.281355] Starting dynamic subtest: bcs0 [454.283459] Dynamic subtest bcs0: SUCCESS (0.012s) [454.292215] Starting dynamic subtest: vcs0 [454.302854] Dynamic subtest vcs0: SUCCESS (0.020s) [454.316188] Starting dynamic subtest: vcs1 [454.324470] Dynamic subtest vcs1: SUCCESS (0.021s) [454.333730] Starting dynamic subtest: vecs0 [454.342528] Dynamic subtest vecs0: SUCCESS (0.017s) [454.351648] Starting dynamic subtest: ccs0 [454.360298] Dynamic subtest ccs0: SUCCESS (0.016s) [454.361092] Subtest resubmit-new-all: SUCCESS (0.107s) [455.531640] [075/155] (572s left) gem_exec_reloc (basic-gtt-cpu-noreloc) [455.589467] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s) [455.662405] [076/155] (572s left) gem_render_copy (yf-tiled-ccs-to-x-tiled) [455.725329] Starting subtest: yf-tiled-ccs-to-x-tiled [455.727157] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s) [455.911687] [077/155] (572s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff) [455.997709] Starting subtest: psr-1p-primscrn-spr-indfb-onoff [463.058612] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.061s) [463.202789] [078/155] (565s left) kms_rotation_crc (sprite-rotation-180) [463.290348] Starting subtest: sprite-rotation-180 [470.030223] Subtest sprite-rotation-180: SUCCESS (6.740s) [471.207052] [079/155] (557s left) gem_create (create-invalid-size) [471.274394] Starting subtest: create-invalid-size [471.275408] Subtest create-invalid-size: SUCCESS (0.000s) [471.455827] [080/155] (557s left) gem_exec_schedule (u-semaphore-noskip) [471.528748] Starting subtest: u-semaphore-noskip [471.945765] Subtest u-semaphore-noskip: SUCCESS (0.408s) [472.259619] [081/155] (556s left) kms_big_fb (x-tiled-32bpp-rotate-180) [472.354066] Starting subtest: x-tiled-32bpp-rotate-180 [473.811948] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.457s) [473.940204] [082/155] (554s left) kms_frontbuffer_tracking (psr-suspend) [474.031705] Starting subtest: psr-suspend [513.046186] Subtest psr-suspend: SUCCESS (8.683s) [520.169347] [083/155] (515s left) prime_vgem (shrink) [520.234937] Starting subtest: shrink [520.262245] Subtest shrink: SUCCESS (0.027s) [520.377167] [084/155] (515s left) gem_mmap_gtt (cpuset-medium-copy-odd) [520.424249] Subtest cpuset-medium-copy-odd: SKIP (0.000s) [520.476647] [085/155] (515s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt) [520.567324] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt [520.569111] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [520.660597] [086/155] (515s left) kms_plane_lowres (tiling-none) [520.749579] Starting subtest: tiling-none [520.750465] Starting dynamic subtest: pipe-A-eDP-1 [520.752099] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [521.058621] Starting dynamic subtest: pipe-B-eDP-1 [521.060529] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [521.069749] Starting dynamic subtest: pipe-C-eDP-1 [521.071723] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [521.082047] Starting dynamic subtest: pipe-D-eDP-1 [521.084064] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [521.085923] Subtest tiling-none: SKIP (0.305s) [521.858531] [087/155] (514s left) perf_pmu (most-busy-check-all) [521.896052] Starting subtest: most-busy-check-all [521.896908] Starting dynamic subtest: rcs0 [523.847941] Dynamic subtest rcs0: SUCCESS (1.940s) [523.857879] Starting dynamic subtest: bcs0 [524.386360] Dynamic subtest bcs0: FAIL (0.523s) [524.396474] Starting dynamic subtest: vcs0 [524.912795] Dynamic subtest vcs0: FAIL (0.514s) [524.922553] Starting dynamic subtest: vcs1 [525.831664] Dynamic subtest vcs1: SUCCESS (0.941s) [525.843258] Starting dynamic subtest: vecs0 [527.881568] Dynamic subtest vecs0: SUCCESS (2.046s) [527.893583] Starting dynamic subtest: ccs0 [529.863734] Dynamic subtest ccs0: SUCCESS (1.979s) [529.864840] Subtest most-busy-check-all: FAIL (7.953s) [529.965396] [088/155] (506s left) perf_pmu (busy-hang) [530.006809] Starting subtest: busy-hang [530.007621] Starting dynamic subtest: rcs0 [531.249255] Dynamic subtest rcs0: SUCCESS (1.239s) [531.261685] Starting dynamic subtest: bcs0 [532.470674] Dynamic subtest bcs0: SUCCESS (1.219s) [532.483533] Starting dynamic subtest: vcs0 [534.337267] Dynamic subtest vcs0: SUCCESS (1.866s) [534.350055] Starting dynamic subtest: vcs1 [536.385656] Dynamic subtest vcs1: SUCCESS (2.046s) [536.397804] Starting dynamic subtest: vecs0 [538.369441] Dynamic subtest vecs0: SUCCESS (1.982s) [538.382527] Starting dynamic subtest: ccs0 [539.581058] Dynamic subtest ccs0: SUCCESS (1.209s) [539.582708] Subtest busy-hang: SUCCESS (9.571s) [539.690693] [089/155] (496s left) gem_exec_balancer (parallel-dmabuf-import-out-fence) [539.970615] Starting subtest: parallel-dmabuf-import-out-fence [541.249473] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.278s) [541.337411] [090/155] (494s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu) [541.437309] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu [541.439024] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [541.536108] [091/155] (494s left) intel_hwmon (hwmon-write) [541.583740] Subtest hwmon-write: SKIP (0.000s) [541.641310] [092/155] (494s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen) [541.734474] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen [541.736045] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [541.829887] [093/155] (494s left) perf (non-system-wide-paranoid) [541.913527] Starting subtest: non-system-wide-paranoid [541.937890] Subtest non-system-wide-paranoid: SUCCESS (0.024s) [541.973215] [094/155] (494s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render) [542.071081] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render [542.072958] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [542.164122] [095/155] (494s left) kms_cursor_legacy (flip-vs-cursor-legacy) [542.277927] Starting subtest: flip-vs-cursor-legacy [549.964495] Subtest flip-vs-cursor-legacy: SUCCESS (7.684s) [550.803803] [096/155] (485s left) kms_pipe_crc_basic (hang-read-crc) [550.900411] Starting subtest: hang-read-crc [550.901236] Starting dynamic subtest: pipe-A-eDP-1 [552.981944] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.080s) [552.993602] Starting dynamic subtest: pipe-B-eDP-1 [555.845793] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.861s) [555.856251] Starting dynamic subtest: pipe-C-eDP-1 [558.563057] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.715s) [558.577362] Starting dynamic subtest: pipe-D-eDP-1 [561.224670] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.659s) [561.225581] Subtest hang-read-crc: SUCCESS (10.322s) [562.042468] [097/155] (474s left) kms_universal_plane (cursor-fb-leak) [562.128065] Starting subtest: cursor-fb-leak [562.129119] Starting dynamic subtest: pipe-A-eDP-1 [562.459820] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.332s) [562.473522] Starting dynamic subtest: pipe-B-eDP-1 [563.864657] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.401s) [563.877047] Starting dynamic subtest: pipe-C-eDP-1 [565.273059] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.407s) [565.284354] Starting dynamic subtest: pipe-D-eDP-1 [566.603727] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s) [566.604893] Subtest cursor-fb-leak: SUCCESS (4.477s) [567.776530] [098/155] (468s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render) [567.864910] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render [567.866657] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [567.956240] [099/155] (468s left) core_getclient (basic) [568.000461] Starting subtest: basic [568.001419] Subtest basic: SUCCESS (0.000s) [568.102751] [100/155] (468s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats) [568.466267] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s) [569.268624] [101/155] (467s left) syncobj_timeline (etime-multi-wait-for-submit-submitted) [569.318735] Starting subtest: etime-multi-wait-for-submit-submitted [569.420138] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.101s) [569.508856] [102/155] (466s left) gem_ctx_persistence (engines-mixed) [569.559581] Starting subtest: engines-mixed [569.560507] Starting dynamic subtest: rcs0 [569.627668] Dynamic subtest rcs0: SUCCESS (0.067s) [569.642598] Starting dynamic subtest: bcs0 [569.684432] Dynamic subtest bcs0: SUCCESS (0.055s) [569.696972] Starting dynamic subtest: vcs0 [569.751905] Dynamic subtest vcs0: SUCCESS (0.065s) [569.765628] Starting dynamic subtest: vcs1 [569.786285] Dynamic subtest vcs1: SUCCESS (0.033s) [569.798113] Starting dynamic subtest: vecs0 [569.870927] Dynamic subtest vecs0: SUCCESS (0.083s) [569.884088] Starting dynamic subtest: ccs0 [569.946058] Dynamic subtest ccs0: SUCCESS (0.073s) [569.947965] Subtest engines-mixed: SUCCESS (0.387s) [570.023081] [103/155] (466s left) kms_selftest (drm_damage_helper) [570.054010] Starting subtest: drm_damage_helper [570.084871] Starting dynamic subtest: drm_test_damage_iter_no_damage [570.168732] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.083s) [570.178983] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src [570.259774] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.091s) [570.270948] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved [570.367156] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.106s) [570.377917] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved [570.465663] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.098s) [570.476680] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible [570.593903] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.115s) [570.603670] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc [570.662648] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.078s) [570.672423] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb [570.753647] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.090s) [570.762922] Starting dynamic subtest: drm_test_damage_iter_simple_damage [570.860747] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.106s) [570.872421] Starting dynamic subtest: drm_test_damage_iter_single_damage [570.948851] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.088s) [570.959603] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src [571.046518] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.097s) [571.057034] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src [571.132213] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.083s) [571.142215] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src [571.222721] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.091s) [571.232084] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src [571.310325] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.087s) [571.320700] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src [571.399216] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.087s) [571.409843] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved [571.486039] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.087s) [571.497766] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved [571.573817] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.087s) [571.589104] Starting dynamic subtest: drm_test_damage_iter_damage [571.663275] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.089s) [571.674067] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect [571.749823] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.086s) [571.759129] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside [571.837563] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.087s) [571.848463] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved [571.941618] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.103s) [571.954606] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible [572.024148] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.081s) [572.025191] Subtest drm_damage_helper: SUCCESS (1.970s) [572.174164] [104/155] (464s left) kms_big_fb (linear-32bpp-rotate-270) [572.283900] Starting subtest: linear-32bpp-rotate-270 [572.303434] Subtest linear-32bpp-rotate-270: SKIP (0.019s) [572.426863] [105/155] (464s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt) [572.514556] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt [577.060729] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.545s) [578.185030] [106/155] (458s left) gem_compute (compute-square) [578.231833] Starting subtest: compute-square [578.238809] Subtest compute-square: SUCCESS (0.007s) [578.349548] [107/155] (458s left) kms_invalid_mode (bad-htotal) [578.425813] Starting subtest: bad-htotal [578.426715] Starting dynamic subtest: pipe-A-eDP-1 [578.713675] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s) [578.723433] Starting dynamic subtest: pipe-B-eDP-1 [578.724389] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [578.733263] Starting dynamic subtest: pipe-C-eDP-1 [578.734143] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [578.743203] Starting dynamic subtest: pipe-D-eDP-1 [578.744271] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [578.745436] Subtest bad-htotal: SUCCESS (0.293s) [579.520036] [108/155] (457s left) gem_exec_schedule (preempt-queue-contexts-chain) [579.577022] Subtest preempt-queue-contexts-chain: SKIP (0.000s) [579.884879] [109/155] (456s left) gem_mmap_gtt (coherency) [579.928662] Subtest coherency: SKIP (0.000s) [579.981760] [110/155] (456s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [580.064323] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs [580.065858] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [581.150871] [111/155] (455s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move) [581.241646] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move [581.243444] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [581.340317] [112/155] (455s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-onoff) [581.442800] Starting subtest: psrhdr-2p-primscrn-cur-indfb-onoff [581.444329] Subtest psrhdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [581.568242] [113/155] (455s left) gem_mmap_offset (open-flood) [581.615974] Starting subtest: open-flood [603.110318] Subtest open-flood: SUCCESS (21.492s) [603.214110] [114/155] (433s left) kms_fbcon_fbt (fbc) [603.271753] Starting subtest: fbc [609.713055] Subtest fbc: SUCCESS (6.439s) [610.892023] [115/155] (426s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render) [610.990896] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render [610.992785] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [611.088291] [116/155] (425s left) kms_psr (fbc-psr-cursor-blt) [611.176358] Starting subtest: fbc-psr-cursor-blt [611.177228] Starting dynamic subtest: eDP-1 [611.179027] Dynamic subtest eDP-1: SKIP (0.000s) [611.180754] Subtest fbc-psr-cursor-blt: SKIP (0.001s) [611.258122] [117/155] (425s left) kms_cursor_legacy (flip-vs-cursor-varying-size) [611.374679] Starting subtest: flip-vs-cursor-varying-size [620.688612] Subtest flip-vs-cursor-varying-size: SUCCESS (9.312s) [621.526891] [118/155] (415s left) kms_psr (fbc-pr-basic) [621.615638] Starting subtest: fbc-pr-basic [621.617401] Subtest fbc-pr-basic: SKIP (0.000s) [621.700684] [119/155] (415s left) i915_hangman (gt-engine-hang) [621.758856] Starting subtest: gt-engine-hang [621.759787] Starting dynamic subtest: rcs0 [622.827276] Dynamic subtest rcs0: SUCCESS (1.060s) [622.839711] Starting dynamic subtest: bcs0 [624.807061] Dynamic subtest bcs0: SUCCESS (1.978s) [624.819680] Starting dynamic subtest: vcs0 [626.790761] Dynamic subtest vcs0: SUCCESS (1.982s) [626.803327] Starting dynamic subtest: vcs1 [628.838625] Dynamic subtest vcs1: SUCCESS (2.047s) [628.849497] Starting dynamic subtest: vecs0 [630.823187] Dynamic subtest vecs0: SUCCESS (1.982s) [630.833134] Starting dynamic subtest: ccs0 [632.807028] Dynamic subtest ccs0: SUCCESS (1.981s) [632.808406] Subtest gt-engine-hang: SUCCESS (11.043s) [632.875951] [120/155] (404s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move) [632.974333] Starting subtest: fbc-2p-primscrn-spr-indfb-move [632.976139] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s) [633.065895] [121/155] (404s left) kms_force_connector_basic (force-load-detect) [633.141446] Starting subtest: force-load-detect [633.143324] Subtest force-load-detect: SKIP (0.000s) [633.258026] [122/155] (403s left) kms_cursor_crc (cursor-offscreen-256x85) [633.514786] Starting subtest: cursor-offscreen-256x85 [633.558275] Subtest cursor-offscreen-256x85: SKIP (0.042s) [633.726777] [123/155] (403s left) prime_mmap (test_errors) [633.788470] Starting subtest: test_errors [633.789665] Starting dynamic subtest: test_errors-smem [633.892213] Dynamic subtest test_errors-smem: SUCCESS (0.104s) [633.893603] Subtest test_errors: SUCCESS (0.105s) [634.000379] [124/155] (403s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [634.097915] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [634.789914] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.692s) [634.958616] [125/155] (402s left) syncobj_timeline (transfer-timeline-point) [635.003355] Starting subtest: transfer-timeline-point [635.004384] Subtest transfer-timeline-point: SUCCESS (0.000s) [635.106052] [126/155] (402s left) i915_pm_rpm (gem-mmap-type) [637.033545] Starting subtest: gem-mmap-type [637.034801] Starting dynamic subtest: wb-smem0 [640.541757] Dynamic subtest wb-smem0: SUCCESS (3.508s) [640.553482] Starting dynamic subtest: wc-smem0 [643.525661] Dynamic subtest wc-smem0: SUCCESS (2.985s) [643.537279] Starting dynamic subtest: uc-smem0 [646.406876] Dynamic subtest uc-smem0: SUCCESS (2.879s) [646.408573] Subtest gem-mmap-type: SUCCESS (9.378s) [646.539420] [127/155] (390s left) kms_addfb_basic (too-high) [646.619586] Starting subtest: too-high [646.620521] Subtest too-high: SUCCESS (0.001s) [646.721466] [128/155] (390s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [646.808363] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu [646.810033] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [646.895912] [129/155] (390s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-move) [646.987270] Starting subtest: fbchdr-2p-primscrn-spr-indfb-move [646.989203] Subtest fbchdr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [647.079979] [130/155] (390s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-render) [647.164095] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-render [647.166212] Subtest hdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [647.267081] [131/155] (390s left) kms_addfb_basic (size-max) [647.357676] Starting subtest: size-max [647.358754] Subtest size-max: SUCCESS (0.000s) [647.454358] [132/155] (390s left) gem_flink_basic (flink-lifetime) [647.506233] Starting subtest: flink-lifetime [647.507348] Subtest flink-lifetime: SUCCESS (0.002s) [647.614544] [133/155] (390s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [647.703669] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu [647.705514] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [647.799998] [134/155] (389s left) kms_cursor_legacy (cursora-vs-flipa-atomic) [647.910488] Starting subtest: cursorA-vs-flipA-atomic [659.035115] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.124s) [659.893092] [135/155] (377s left) kms_dsc (dsc-with-formats) [659.985276] Starting subtest: dsc-with-formats [659.999720] Subtest dsc-with-formats: SKIP (0.001s) [660.057704] [136/155] (377s left) kms_dp_link_training (non-uhbr-sst) [660.148317] Starting subtest: non-uhbr-sst [660.151554] Subtest non-uhbr-sst: SKIP (0.000s) [660.233289] [137/155] (377s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled) [660.278415] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [660.279309] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [660.366447] [138/155] (377s left) gem_pxp (create-valid-protected-context) [660.480508] Starting subtest: create-valid-protected-context [660.481657] Subtest create-valid-protected-context: SUCCESS (0.002s) [660.604248] [139/155] (377s left) gem_exec_fence (syncobj-backward-timeline-chain-engines) [661.165253] Starting subtest: syncobj-backward-timeline-chain-engines [661.280357] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.115s) [662.952039] [140/155] (374s left) kms_flip (2x-modeset-vs-vblank-race-interruptible) [663.043574] Starting subtest: 2x-modeset-vs-vblank-race-interruptible [663.055607] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s) [663.159458] [141/155] (374s left) kms_getfb (getfb2-handle-zero) [663.247560] Starting subtest: getfb2-handle-zero [663.248427] Subtest getfb2-handle-zero: SUCCESS (0.000s) [663.347400] [142/155] (374s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [663.442350] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [663.444140] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [663.541918] [143/155] (374s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-render) [663.629384] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-render [663.631189] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [663.722574] [144/155] (374s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling) [663.807633] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling [663.809568] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s) [663.890061] [145/155] (374s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa [663.946425] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled [664.052124] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.104s) [664.126111] [146/155] (373s left) i915_suspend (basic-s2idle-without-i915) [664.158164] Starting subtest: basic-s2idle-without-i915 [684.967785] Subtest basic-s2idle-without-i915: SUCCESS (6.065s) [690.142007] [147/155] (353s left) kms_content_protection (lic-type-1) [690.302364] Starting subtest: lic-type-1 [690.304946] Subtest lic-type-1: SKIP (0.000s) [690.428085] [148/155] (352s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-move) [690.519914] Starting subtest: hdr-2p-scndscrn-cur-indfb-move [690.521872] Subtest hdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [690.612923] [149/155] (352s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [690.697694] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu [690.699503] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [690.818312] [150/155] (352s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled) [690.864884] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [690.865871] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [690.973923] [151/155] (352s left) gem_ctx_param (set-priority-range) [691.016548] Starting subtest: set-priority-range [691.031432] Subtest set-priority-range: SUCCESS (0.015s) [691.153135] [152/155] (352s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip) [691.241511] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip [692.313016] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.067s) [692.432274] [153/155] (350s left) kms_rotation_crc (sprite-rotation-90) [692.519280] Starting subtest: sprite-rotation-90 [692.521301] Subtest sprite-rotation-90: SKIP (0.001s) [692.587920] [154/155] (350s left) gem_exec_balancer (nohangcheck) [692.865416] Starting subtest: nohangcheck [693.869336] Subtest nohangcheck: SUCCESS (0.998s) [693.967890] [155/155] (349s left) gen9_exec_parse (bb-large) [694.021357] Subtest bb-large: SKIP (0.000s) [694.072784] Closing watchdogs results: parsing output: 0/ for test: kms_busy results: parsing output: 1/ for test: kms_color results: parsing output: 2/ for test: gem_eio results: parsing output: 3/ for test: gem_exec_schedule results: parsing output: 4/ for test: kms_ccs results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_plane_scaling results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: kms_psr results: parsing output: 9/ for test: gem_render_copy results: parsing output: 10/ for test: kms_plane results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_cursor_crc results: parsing output: 14/ for test: kms_async_flips results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: core_getversion results: parsing output: 18/ for test: kms_vblank results: parsing output: 19/ for test: kms_cursor_legacy results: parsing output: 20/ for test: prime_vgem results: parsing output: 21/ for test: kms_ccs results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_psr results: parsing output: 24/ for test: gem_eio results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: kms_psr results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_pm_dc results: parsing output: 29/ for test: syncobj_timeline results: parsing output: 30/ for test: kms_psr2_sf results: parsing output: 31/ for test: gem_ctx_persistence results: parsing output: 32/ for test: kms_flip_scaled_crc results: parsing output: 33/ for test: kms_rotation_crc results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: api_intel_allocator results: parsing output: 36/ for test: kms_getfb results: parsing output: 37/ for test: i915_drm_fdinfo results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_atomic_transition results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_prop_blob results: parsing output: 42/ for test: kms_ccs results: parsing output: 43/ for test: kms_addfb_basic results: parsing output: 44/ for test: gem_basic results: parsing output: 45/ for test: kms_addfb_basic results: parsing output: 46/ for test: gem_exec_whisper results: parsing output: 47/ for test: kms_plane_scaling results: parsing output: 48/ for test: gem_flink_race results: parsing output: 49/ for test: gem_lmem_swapping results: parsing output: 50/ for test: syncobj_timeline results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_plane_multiple results: parsing output: 56/ for test: kms_flip_scaled_crc results: parsing output: 57/ for test: kms_big_fb results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_big_fb results: parsing output: 62/ for test: gem_exec_reloc results: parsing output: 63/ for test: kms_chamelium_color results: parsing output: 64/ for test: syncobj_wait results: parsing output: 65/ for test: kms_chamelium_hpd results: parsing output: 66/ for test: gem_userptr_blits results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: kms_cursor_crc results: parsing output: 69/ for test: kms_psr2_sf results: parsing output: 70/ for test: kms_flip results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: perf results: parsing output: 73/ for test: gem_spin_batch results: parsing output: 74/ for test: gem_exec_reloc results: parsing output: 75/ for test: gem_render_copy results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: kms_rotation_crc results: parsing output: 78/ for test: gem_create results: parsing output: 79/ for test: gem_exec_schedule results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: prime_vgem results: parsing output: 83/ for test: gem_mmap_gtt results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_plane_lowres results: parsing output: 86/ for test: perf_pmu results: parsing output: 87/ for test: perf_pmu results: parsing output: 88/ for test: gem_exec_balancer results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: intel_hwmon results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: perf results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_cursor_legacy results: parsing output: 95/ for test: kms_pipe_crc_basic results: parsing output: 96/ for test: kms_universal_plane results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: core_getclient results: parsing output: 99/ for test: kms_chamelium_frames results: parsing output: 100/ for test: syncobj_timeline results: parsing output: 101/ for test: gem_ctx_persistence results: parsing output: 102/ for test: kms_selftest results: parsing output: 103/ for test: kms_big_fb results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: gem_compute results: parsing output: 106/ for test: kms_invalid_mode results: parsing output: 107/ for test: gem_exec_schedule results: parsing output: 108/ for test: gem_mmap_gtt results: parsing output: 109/ for test: kms_ccs results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: gem_mmap_offset results: parsing output: 113/ for test: kms_fbcon_fbt results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_psr results: parsing output: 116/ for test: kms_cursor_legacy results: parsing output: 117/ for test: kms_psr results: parsing output: 118/ for test: i915_hangman results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: kms_force_connector_basic results: parsing output: 121/ for test: kms_cursor_crc results: parsing output: 122/ for test: prime_mmap results: parsing output: 123/ for test: kms_big_fb results: parsing output: 124/ for test: syncobj_timeline results: parsing output: 125/ for test: i915_pm_rpm results: parsing output: 126/ for test: kms_addfb_basic results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_addfb_basic results: parsing output: 131/ for test: gem_flink_basic results: parsing output: 132/ for test: kms_frontbuffer_tracking results: parsing output: 133/ for test: kms_cursor_legacy results: parsing output: 134/ for test: kms_dsc results: parsing output: 135/ for test: kms_dp_link_training results: parsing output: 136/ for test: syncobj_wait results: parsing output: 137/ for test: gem_pxp results: parsing output: 138/ for test: gem_exec_fence results: parsing output: 139/ for test: kms_flip results: parsing output: 140/ for test: kms_getfb results: parsing output: 141/ for test: kms_frontbuffer_tracking results: parsing output: 142/ for test: kms_frontbuffer_tracking results: parsing output: 143/ for test: kms_flip_scaled_crc results: parsing output: 144/ for test: syncobj_timeline results: parsing output: 145/ for test: i915_suspend results: parsing output: 146/ for test: kms_content_protection results: parsing output: 147/ for test: kms_frontbuffer_tracking results: parsing output: 148/ for test: kms_frontbuffer_tracking results: parsing output: 149/ for test: syncobj_wait results: parsing output: 150/ for test: gem_ctx_param results: parsing output: 151/ for test: kms_big_fb results: parsing output: 152/ for test: kms_rotation_crc results: parsing output: 153/ for test: gem_exec_balancer results: parsing output: 154/ for test: gen9_exec_parse Done.