[61.479543] Initializing watchdogs [61.479611] /dev/watchdog0 [61.502110] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [61.513696] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [61.517920] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.520508] [001/156] (960s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs) [63.050238] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs [63.051218] Starting dynamic subtest: pipe-A-HDMI-A-3 [63.060571] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [63.070938] Starting dynamic subtest: pipe-B-HDMI-A-3 [63.079943] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [63.090257] Starting dynamic subtest: pipe-C-HDMI-A-3 [63.099542] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [63.109666] Starting dynamic subtest: pipe-D-HDMI-A-3 [63.120469] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [63.122522] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.005s) [63.392919] [002/156] (958s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-plflip-blt) [64.933214] Starting subtest: psrhdr-2p-scndscrn-indfb-plflip-blt [64.935126] Subtest psrhdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [65.130303] [003/156] (957s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render) [66.682178] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render [69.940798] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (3.263s) [70.122244] [004/156] (952s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu) [71.658120] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu [71.659942] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [71.858960] [005/156] (950s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf) [73.393328] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [73.477635] [006/156] (948s left) gem_exec_whisper (basic-fds-priority) [73.635626] Starting subtest: basic-fds-priority [96.411984] Subtest basic-fds-priority: SUCCESS (22.783s) [96.622788] [007/156] (925s left) syncobj_timeline (wait-for-submit-complex) [96.705623] Starting subtest: wait-for-submit-complex [96.769957] Subtest wait-for-submit-complex: SUCCESS (0.064s) [96.892187] [008/156] (925s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-blt) [98.421177] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-blt [98.422956] Subtest psrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [98.598274] [009/156] (924s left) gem_partial_pwrite_pread (reads-snoop) [98.695538] Subtest reads-snoop: SKIP (0.000s) [98.781728] [010/156] (923s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [100.321134] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [100.322998] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [100.516051] [011/156] (922s left) kms_busy (basic) [102.046314] Starting subtest: basic [102.047305] Starting dynamic subtest: flip [102.703460] Dynamic subtest flip: SUCCESS (0.656s) [102.714551] Starting dynamic subtest: modeset [103.550993] Dynamic subtest modeset: SUCCESS (0.848s) [103.551998] Subtest basic: SUCCESS (1.506s) [103.805540] [012/156] (919s left) kms_big_fb (y-tiled-16bpp-rotate-180) [105.357495] Starting subtest: y-tiled-16bpp-rotate-180 [105.359417] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s) [105.489300] [013/156] (917s left) kms_plane (pixel-format-y-tiled-modifier) [107.049601] Starting subtest: pixel-format-y-tiled-modifier [107.051673] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s) [107.182387] [014/156] (915s left) kms_fbcon_fbt (fbc-suspend) [107.307482] Starting subtest: fbc-suspend [160.182373] Subtest fbc-suspend: SUCCESS (21.215s) [160.274175] [015/156] (862s left) gen3_render_mixed_blits [160.456834] [016/156] (862s left) syncobj_wait (wait-all-snapshot) [160.533089] Starting subtest: wait-all-snapshot [160.615868] Subtest wait-all-snapshot: SUCCESS (0.080s) [160.784400] [017/156] (862s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0) [162.347138] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0 [163.676522] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.302s) [163.870683] [018/156] (859s left) gem_lmem_swapping (verify-random) [168.559239] Starting subtest: verify-random [168.560217] Starting dynamic subtest: lmem0 [179.424286] Dynamic subtest lmem0: SUCCESS (10.803s) [179.425282] Subtest verify-random: SUCCESS (10.803s) [180.433589] [FACT gem_lmem_swapping (verify-random)] deleted: kernel.kmod_is_loaded.i915: true [180.435416] [019/156] (842s left) syncobj_wait (multi-wait-all-for-submit-submitted) [184.223368] Starting subtest: multi-wait-all-for-submit-submitted [184.327090] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.103s) [184.413188] [FACT syncobj_wait (multi-wait-all-for-submit-submitted)] new: kernel.kmod_is_loaded.i915: true [184.415983] [020/156] (839s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-pwrite) [185.965166] Starting subtest: fbcpsrhdr-rgb565-draw-pwrite [185.967288] Subtest fbcpsrhdr-rgb565-draw-pwrite: SKIP (0.000s) [186.148523] [021/156] (837s left) fbdev (unaligned-write) [186.243899] Starting subtest: unaligned-write [186.651439] Subtest unaligned-write: SUCCESS (0.407s) [186.759439] [022/156] (836s left) kms_cursor_crc (cursor-sliding-64x21) [188.573007] Starting subtest: cursor-sliding-64x21 [188.590882] Starting dynamic subtest: pipe-A-HDMI-A-3 [192.859472] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.265s) [192.901202] Starting dynamic subtest: pipe-D-HDMI-A-3 [197.156118] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.265s) [197.156981] Subtest cursor-sliding-64x21: SUCCESS (8.579s) [197.535097] [023/156] (826s left) syncobj_wait (invalid-reset-one-illegal-handle) [197.615677] Starting subtest: invalid-reset-one-illegal-handle [197.616778] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s) [197.765063] [024/156] (826s left) kms_plane_lowres (tiling-yf) [199.269309] Starting subtest: tiling-yf [199.271067] Subtest tiling-yf: SKIP (0.000s) [199.369423] [025/156] (824s left) drm_read (invalid-buffer) [200.980253] Starting subtest: invalid-buffer [200.981242] Subtest invalid-buffer: SUCCESS (0.000s) [201.182752] [026/156] (822s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-cpu) [202.717813] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-cpu [202.719728] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [202.890457] [027/156] (821s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt) [204.438283] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt [207.565129] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (3.126s) [207.768251] [028/156] (816s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area) [209.288023] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [209.348443] [029/156] (814s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [210.866033] Starting subtest: primary-y-tiled-reflect-x-90 [210.867923] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s) [210.990161] [030/156] (813s left) i915_pm_rpm (system-suspend) [214.699261] Starting subtest: system-suspend [235.453575] Subtest system-suspend: SUCCESS (5.354s) [240.413348] [031/156] (787s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [241.980956] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [244.856486] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (2.821s) [245.050786] [032/156] (783s left) kms_frontbuffer_tracking (fbchdr-tiling-4) [246.585268] Starting subtest: fbchdr-tiling-4 [246.587053] Subtest fbchdr-tiling-4: SKIP (0.000s) [246.727208] [033/156] (781s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-pwrite) [248.291935] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-pwrite [248.293686] Subtest hdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [248.450839] [034/156] (780s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-pwrite) [250.018116] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-pwrite [250.019989] Subtest fbchdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [250.191375] [035/156] (778s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-onoff) [251.742947] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-onoff [251.744868] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [251.898010] [036/156] (776s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff) [253.496223] Starting subtest: psr-1p-primscrn-cur-indfb-onoff [253.498163] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [253.705771] [037/156] (775s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs) [255.268674] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs [255.269721] Starting dynamic subtest: pipe-A-HDMI-A-3 [255.279383] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [255.296960] Starting dynamic subtest: pipe-B-HDMI-A-3 [255.306877] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [255.324311] Starting dynamic subtest: pipe-C-HDMI-A-3 [255.333987] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [255.351391] Starting dynamic subtest: pipe-D-HDMI-A-3 [255.361988] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [255.364272] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.007s) [255.627527] [038/156] (773s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [257.187971] Starting subtest: addfb25-y-tiled-small-legacy [257.190026] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [257.368939] [039/156] (771s left) gem_create (create-clear) [257.469980] Starting subtest: create-clear [257.471136] Starting dynamic subtest: lmem0 [292.814216] Dynamic subtest lmem0: SUCCESS (35.312s) [292.835825] Starting dynamic subtest: smem0 [330.698317] Dynamic subtest smem0: SUCCESS (37.873s) [330.699298] Subtest create-clear: SUCCESS (73.186s) [332.228941] [040/156] (696s left) gem_pwrite (basic-random) [332.329882] Subtest basic-random: SKIP (0.000s) [332.421671] [041/156] (696s left) kms_getfb (getfb-handle-not-fb) [333.973740] Starting subtest: getfb-handle-not-fb [333.974775] Subtest getfb-handle-not-fb: SUCCESS (0.000s) [334.182484] [042/156] (695s left) kms_chamelium_hpd (dp-hpd-fast) [335.783167] Subtest dp-hpd-fast: SKIP (0.000s) [335.930551] [043/156] (693s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-msflip-blt) [337.490178] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-msflip-blt [337.492062] Subtest fbcpsrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [337.664223] [044/156] (691s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite) [339.218231] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite [339.220205] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [339.379661] [045/156] (690s left) gem_pxp (hw-rejects-pxp-context) [342.024778] Starting subtest: hw-rejects-pxp-context [342.027056] Subtest hw-rejects-pxp-context: SUCCESS (0.005s) [342.141069] [046/156] (687s left) kms_joiner (invalid-modeset-big-joiner) [343.648336] Starting subtest: invalid-modeset-big-joiner [343.650165] Subtest invalid-modeset-big-joiner: SKIP (0.000s) [343.748480] [047/156] (686s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc) [345.284512] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc [345.286302] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [345.423470] [048/156] (684s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy) [346.968085] Starting subtest: flip-vs-cursor-busy-crc-legacy [347.609937] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.643s) [347.827370] [049/156] (682s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-pgflip-blt) [349.357058] Starting subtest: hdr-2p-scndscrn-indfb-pgflip-blt [349.358889] Subtest hdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [349.533514] [050/156] (680s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs) [351.069305] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs [351.070269] Starting dynamic subtest: pipe-A-HDMI-A-3 [351.079376] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [351.094669] Starting dynamic subtest: pipe-B-HDMI-A-3 [351.104153] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [351.119377] Starting dynamic subtest: pipe-C-HDMI-A-3 [351.128672] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [351.143915] Starting dynamic subtest: pipe-D-HDMI-A-3 [351.154988] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [351.157082] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.006s) [351.399357] [051/156] (678s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible) [352.946886] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible [352.969916] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.024s) [353.121092] [052/156] (677s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [354.714628] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [354.716655] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s) [354.930934] [053/156] (675s left) kms_addfb_basic (framebuffer-vs-set-tiling) [355.040513] Starting subtest: framebuffer-vs-set-tiling [355.042465] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [356.677493] [054/156] (673s left) kms_cursor_crc (cursor-rapid-movement-32x10) [358.470445] Starting subtest: cursor-rapid-movement-32x10 [358.559637] Subtest cursor-rapid-movement-32x10: SKIP (0.086s) [359.158924] [055/156] (671s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-plflip-blt) [360.717220] Starting subtest: hdr-2p-primscrn-indfb-plflip-blt [360.719151] Subtest hdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [360.896959] [056/156] (669s left) kms_content_protection (legacy) [362.551405] Starting subtest: legacy [362.557448] Subtest legacy: SKIP (0.003s) [362.738709] [057/156] (668s left) syncobj_basic (bad-pad-handle-to-fd) [362.838087] Starting subtest: bad-pad-handle-to-fd [362.839078] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [362.989245] [058/156] (667s left) syncobj_basic (bad-create-flags) [363.090484] Starting subtest: bad-create-flags [363.091495] Subtest bad-create-flags: SUCCESS (0.000s) [363.234885] [059/156] (667s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc) [364.796129] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc [364.797981] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [364.972208] [060/156] (666s left) kms_color (legacy-gamma) [366.499684] Starting subtest: legacy-gamma [366.500627] Starting dynamic subtest: pipe-A-HDMI-A-3 [367.156517] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.656s) [367.173561] Starting dynamic subtest: pipe-B-HDMI-A-3 [367.694091] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.536s) [367.709378] Starting dynamic subtest: pipe-C-HDMI-A-3 [368.214462] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.521s) [368.228237] Starting dynamic subtest: pipe-D-HDMI-A-3 [368.736644] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.521s) [368.737573] Subtest legacy-gamma: SUCCESS (2.236s) [368.954754] [061/156] (662s left) kms_psr (psr2-cursor-mmap-cpu) [370.484688] Subtest psr2-cursor-mmap-cpu: SKIP (0.000s) [370.551015] [062/156] (660s left) syncobj_timeline (etime-single-wait-submitted) [370.642418] Starting subtest: etime-single-wait-submitted [370.750346] Subtest etime-single-wait-submitted: SUCCESS (0.107s) [370.914144] [063/156] (660s left) kms_properties (invalid-properties-atomic) [372.451595] Starting subtest: invalid-properties-atomic [373.320295] Subtest invalid-properties-atomic: SUCCESS (0.870s) [373.471421] [064/156] (657s left) api_intel_bb (object-reloc-purge-cache) [373.574444] Starting subtest: object-reloc-purge-cache [373.579499] Subtest object-reloc-purge-cache: SKIP (0.004s) [373.784310] [065/156] (657s left) gem_exec_schedule (preempt-engines) [373.909045] Starting subtest: preempt-engines [373.910185] Starting dynamic subtest: rcs0 [376.232772] Dynamic subtest rcs0: SUCCESS (2.322s) [376.249551] Starting dynamic subtest: bcs0 [378.450148] Dynamic subtest bcs0: SUCCESS (2.209s) [378.462381] Starting dynamic subtest: vcs0 [380.770685] Dynamic subtest vcs0: SUCCESS (2.324s) [380.784471] Starting dynamic subtest: vcs1 [383.095961] Dynamic subtest vcs1: SUCCESS (2.323s) [383.109146] Starting dynamic subtest: vecs0 [385.423504] Dynamic subtest vecs0: SUCCESS (2.325s) [385.437189] Starting dynamic subtest: vecs1 [387.753448] Dynamic subtest vecs1: SUCCESS (2.327s) [387.766771] Starting dynamic subtest: ccs0 [389.966292] Dynamic subtest ccs0: SUCCESS (2.211s) [389.967258] Subtest preempt-engines: SUCCESS (16.055s) [390.388327] [066/156] (641s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc) [391.904518] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc [391.906307] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [392.102911] [067/156] (639s left) kms_prime (d3hot) [393.626180] Subtest D3hot: SKIP (0.000s) [393.869587] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.vgem: true [393.871780] [068/156] (637s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite) [395.407170] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite [395.409602] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [395.569939] [069/156] (636s left) kms_chamelium_edid (dp-mode-timings) [397.179721] Subtest dp-mode-timings: SKIP (0.000s) [397.373305] [070/156] (634s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [398.985094] Starting subtest: flip-vs-dpms-on-nop-interruptible [398.994620] Starting dynamic subtest: A-HDMI-A3 [400.116180] Dynamic subtest A-HDMI-A3: SUCCESS (1.121s) [400.137367] Starting dynamic subtest: B-HDMI-A3 [401.114839] Dynamic subtest B-HDMI-A3: SUCCESS (0.996s) [401.134289] Starting dynamic subtest: C-HDMI-A3 [402.106689] Dynamic subtest C-HDMI-A3: SUCCESS (0.990s) [402.123710] Starting dynamic subtest: D-HDMI-A3 [403.077424] Dynamic subtest D-HDMI-A3: SUCCESS (0.969s) [403.078412] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (4.094s) [403.322918] [071/156] (628s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [404.846014] Starting subtest: plane-downscale-factor-0-5-with-rotation [404.846986] Starting dynamic subtest: pipe-A [405.219263] Dynamic subtest pipe-A: SUCCESS (0.374s) [405.251579] Starting dynamic subtest: pipe-B [405.661018] Dynamic subtest pipe-B: SUCCESS (0.440s) [405.684521] Starting dynamic subtest: pipe-C [406.088179] Dynamic subtest pipe-C: SUCCESS (0.426s) [406.104506] Starting dynamic subtest: pipe-D [406.496555] Dynamic subtest pipe-D: SUCCESS (0.407s) [406.497597] Subtest plane-downscale-factor-0-5-with-rotation: SUCCESS (1.652s) [406.751488] [072/156] (625s left) kms_vblank (wait-busy) [408.276240] Starting subtest: wait-busy [408.277209] Starting dynamic subtest: pipe-A-HDMI-A-3 [410.727470] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.450s) [410.741462] Starting dynamic subtest: pipe-D-HDMI-A-3 [413.095257] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.364s) [413.096188] Subtest wait-busy: SUCCESS (4.819s) [413.273053] [073/156] (618s left) syncobj_wait (multi-wait-for-submit-submitted) [413.353464] Starting subtest: multi-wait-for-submit-submitted [413.462909] Subtest multi-wait-for-submit-submitted: SUCCESS (0.108s) [413.605280] [074/156] (618s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu) [415.129325] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu [415.131295] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [415.260656] [075/156] (616s left) gem_ctx_isolation (dirty-switch) [415.378375] Starting subtest: dirty-switch [415.379448] Starting dynamic subtest: rcs0 [416.236213] Dynamic subtest rcs0: SUCCESS (0.857s) [416.250717] Starting dynamic subtest: bcs0 [417.024832] Dynamic subtest bcs0: SUCCESS (0.787s) [417.040083] Starting dynamic subtest: vcs0 [417.907405] Dynamic subtest vcs0: SUCCESS (0.881s) [417.923066] Starting dynamic subtest: vcs1 [418.727957] Dynamic subtest vcs1: SUCCESS (0.819s) [418.743144] Starting dynamic subtest: vecs0 [419.588692] Dynamic subtest vecs0: SUCCESS (0.859s) [419.602972] Starting dynamic subtest: vecs1 [420.462405] Dynamic subtest vecs1: SUCCESS (0.872s) [420.477802] Starting dynamic subtest: ccs0 [421.349339] Dynamic subtest ccs0: SUCCESS (0.886s) [421.350360] Subtest dirty-switch: SUCCESS (5.970s) [421.627716] [076/156] (610s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-blt) [423.184319] Starting subtest: psrhdr-rgb101010-draw-blt [423.186451] Subtest psrhdr-rgb101010-draw-blt: SKIP (0.000s) [423.400901] [077/156] (609s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [425.012092] Starting subtest: cursorA-vs-flipA-varying-size [436.015129] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.000s) [436.245925] [078/156] (596s left) kms_big_fb (linear-16bpp-rotate-180) [437.784176] Starting subtest: linear-16bpp-rotate-180 [439.800273] Subtest linear-16bpp-rotate-180: SUCCESS (2.014s) [440.005427] [079/156] (592s left) syncobj_timeline (reset-multiple-signaled) [440.095749] Starting subtest: reset-multiple-signaled [440.096638] Subtest reset-multiple-signaled: SUCCESS (0.001s) [440.236262] [080/156] (592s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip) [441.774449] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip [441.776444] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [441.958480] [081/156] (590s left) kms_plane_alpha_blend (alpha-opaque-fb) [443.492876] Starting subtest: alpha-opaque-fb [443.814510] Starting dynamic subtest: pipe-A-HDMI-A-3 [444.279133] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.463s) [444.296414] Starting dynamic subtest: pipe-D-HDMI-A-3 [444.793850] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.512s) [444.794847] Subtest alpha-opaque-fb: SUCCESS (1.302s) [445.031727] [082/156] (587s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [446.588514] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt [446.590608] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [446.776017] [083/156] (586s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling) [448.381700] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling [448.383865] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s) [448.536404] [084/156] (584s left) gem_exec_fence (syncobj-timeline-invalid-flags) [449.410306] Starting subtest: syncobj-timeline-invalid-flags [449.411685] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.001s) [449.723453] [085/156] (583s left) gem_ctx_bad_destroy (double-destroy) [449.841785] Starting subtest: double-destroy [449.842820] Subtest double-destroy: SUCCESS (0.000s) [449.987849] [086/156] (583s left) perf (gen12-group-exclusive-stream-sample-oa) [450.485951] Starting subtest: gen12-group-exclusive-stream-sample-oa [450.520553] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.033s) [450.592847] [087/156] (582s left) gem_ctx_shared (q-out-order) [450.714532] Starting subtest: Q-out-order [450.715577] Starting dynamic subtest: rcs0 [450.998239] Dynamic subtest rcs0: SUCCESS (0.283s) [451.015389] Starting dynamic subtest: bcs0 [451.189616] Dynamic subtest bcs0: SUCCESS (0.190s) [451.206524] Starting dynamic subtest: vcs0 [451.387569] Dynamic subtest vcs0: SUCCESS (0.197s) [451.404603] Starting dynamic subtest: vcs1 [451.585496] Dynamic subtest vcs1: SUCCESS (0.196s) [451.600650] Starting dynamic subtest: vecs0 [451.787587] Dynamic subtest vecs0: SUCCESS (0.198s) [451.802729] Starting dynamic subtest: vecs1 [452.002593] Dynamic subtest vecs1: SUCCESS (0.215s) [452.018501] Starting dynamic subtest: ccs0 [452.204432] Dynamic subtest ccs0: SUCCESS (0.202s) [452.205380] Subtest Q-out-order: SUCCESS (1.490s) [452.521135] [088/156] (580s left) gem_partial_pwrite_pread (write) [452.632102] Subtest write: SKIP (0.000s) [452.723346] [089/156] (580s left) gem_close_race (basic-threads) [452.875540] Starting subtest: basic-threads [454.108708] Subtest basic-threads: SUCCESS (1.233s) [454.419916] [090/156] (579s left) kms_psr (fbc-psr-sprite-plane-move) [455.975005] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s) [456.083444] [091/156] (577s left) prime_vgem (basic-fence-blt) [456.257385] Starting subtest: basic-fence-blt [456.412443] Subtest basic-fence-blt: SUCCESS (0.155s) [456.601967] [092/156] (577s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-render) [458.213605] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-render [458.215577] Subtest psrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s) [458.391693] [093/156] (575s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [459.976398] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu [459.978536] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [460.162654] [094/156] (573s left) kms_flip (2x-absolute-wf_vblank-interruptible) [461.745455] Starting subtest: 2x-absolute-wf_vblank-interruptible [461.770188] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.024s) [461.923930] [095/156] (572s left) gem_exec_basic (basic) [462.070879] Starting subtest: basic [462.072092] Starting dynamic subtest: rcs0-smem [462.077706] Dynamic subtest rcs0-smem: SUCCESS (0.006s) [462.102722] Starting dynamic subtest: bcs0-smem [462.103882] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [462.123485] Starting dynamic subtest: vcs0-smem [462.124757] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [462.143955] Starting dynamic subtest: vcs1-smem [462.145189] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [462.164236] Starting dynamic subtest: vecs0-smem [462.165298] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [462.184423] Starting dynamic subtest: vecs1-smem [462.185580] Dynamic subtest vecs1-smem: SUCCESS (0.001s) [462.204697] Starting dynamic subtest: ccs0-smem [462.205789] Dynamic subtest ccs0-smem: SUCCESS (0.001s) [462.225050] Starting dynamic subtest: rcs0-lmem0 [462.226187] Dynamic subtest rcs0-lmem0: SUCCESS (0.002s) [462.245494] Starting dynamic subtest: bcs0-lmem0 [462.246593] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s) [462.266507] Starting dynamic subtest: vcs0-lmem0 [462.267525] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s) [462.286799] Starting dynamic subtest: vcs1-lmem0 [462.287939] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s) [462.307196] Starting dynamic subtest: vecs0-lmem0 [462.308455] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s) [462.327502] Starting dynamic subtest: vecs1-lmem0 [462.328648] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s) [462.347728] Starting dynamic subtest: ccs0-lmem0 [462.348804] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s) [462.349886] Subtest basic: SUCCESS (0.040s) [462.424923] [096/156] (571s left) gem_exec_fence (syncobj-timeline-wait) [463.209745] Starting subtest: syncobj-timeline-wait [463.318388] Subtest syncobj-timeline-wait: SUCCESS (0.118s) [463.652225] [097/156] (570s left) kms_cursor_crc (cursor-onscreen-64x64) [465.412912] Starting subtest: cursor-onscreen-64x64 [465.419825] Starting dynamic subtest: pipe-A-HDMI-A-3 [468.135774] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.718s) [468.173336] Starting dynamic subtest: pipe-D-HDMI-A-3 [470.811687] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.652s) [470.812612] Subtest cursor-onscreen-64x64: SUCCESS (5.402s) [471.243697] [098/156] (563s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite) [472.771203] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite [475.856348] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (3.088s) [476.056063] [099/156] (558s left) gem_exec_create (forked) [476.156282] Starting subtest: forked [476.157296] Starting dynamic subtest: smem [496.316202] Dynamic subtest smem: SUCCESS (20.162s) [496.350816] Starting dynamic subtest: lmem0 [516.497544] Dynamic subtest lmem0: SUCCESS (20.180s) [516.498937] Subtest forked: SUCCESS (40.347s) [516.759592] [100/156] (517s left) gem_softpin (evict-single-offset) [516.917830] Starting subtest: evict-single-offset [555.277850] Subtest evict-single-offset: SUCCESS (38.357s) [555.425711] [101/156] (479s left) api_intel_allocator (reopen) [555.630633] Starting subtest: reopen [555.671110] Subtest reopen: SUCCESS (0.048s) [555.883304] [102/156] (478s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-cpu) [557.502303] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-cpu [557.504454] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [557.693273] [103/156] (477s left) gen7_exec_parse (basic-allocation) [557.848261] Subtest basic-allocation: SKIP (0.000s) [557.964778] [104/156] (476s left) perf (polling) [558.354160] Starting subtest: polling [558.355236] Starting dynamic subtest: 0-rcs0 [568.382813] Dynamic subtest 0-rcs0: SUCCESS (10.027s) [568.383940] Subtest polling: SUCCESS (10.029s) [568.487636] [105/156] (466s left) sysfs_heartbeat_interval (nopreempt) [568.650153] Starting subtest: nopreempt [568.651336] Starting dynamic subtest: vecs0 [573.321981] Dynamic subtest vecs0: SUCCESS (4.671s) [573.347164] Starting dynamic subtest: ccs0 [577.687510] Dynamic subtest ccs0: SUCCESS (4.363s) [577.710771] Starting dynamic subtest: vcs0 [581.961506] Dynamic subtest vcs0: SUCCESS (4.272s) [581.989927] Starting dynamic subtest: bcs0 [586.260372] Dynamic subtest bcs0: SUCCESS (4.296s) [586.283277] Starting dynamic subtest: vecs1 [590.640602] Dynamic subtest vecs1: SUCCESS (4.378s) [590.668995] Starting dynamic subtest: rcs0 [595.306508] Dynamic subtest rcs0: SUCCESS (4.663s) [595.335089] Starting dynamic subtest: vcs1 [599.623890] Dynamic subtest vcs1: SUCCESS (4.314s) [599.625004] Subtest nopreempt: SUCCESS (30.971s) [599.793831] [106/156] (435s left) kms_big_fb (x-tiled-16bpp-rotate-270) [601.413253] Starting subtest: x-tiled-16bpp-rotate-270 [601.498521] Subtest x-tiled-16bpp-rotate-270: SKIP (0.086s) [601.688789] [107/156] (433s left) gem_fenced_exec_thrash (too-many-fences) [601.842935] Subtest too-many-fences: SKIP (0.000s) [601.955679] [108/156] (433s left) vgem_basic (second-client) [602.065376] Starting subtest: second-client [602.098262] Subtest second-client: SUCCESS (0.033s) [602.269523] [109/156] (433s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [603.864385] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu [603.873909] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [604.053454] [110/156] (431s left) kms_dp_link_training (uhbr-mst) [605.662856] Starting subtest: uhbr-mst [605.665093] Subtest uhbr-mst: SKIP (0.000s) [605.869000] [111/156] (429s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu) [607.472599] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu [607.474634] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [607.667788] [112/156] (428s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [609.274150] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [609.276160] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [609.444737] [113/156] (426s left) kms_psr (fbc-pr-primary-page-flip) [610.999265] Subtest fbc-pr-primary-page-flip: SKIP (0.000s) [611.093865] [114/156] (424s left) kms_chamelium_color (ctm-green-to-red) [612.670510] Subtest ctm-green-to-red: SKIP (0.000s) [612.758044] [115/156] (423s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-render) [614.352930] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-render [614.355220] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [614.540113] [116/156] (421s left) kms_async_flips (invalid-async-flip-atomic) [616.180539] Starting subtest: invalid-async-flip-atomic [616.374653] Starting dynamic subtest: pipe-A-HDMI-A-3 [616.838443] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.464s) [617.011825] Starting dynamic subtest: pipe-B-HDMI-A-3 [617.139286] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.148s) [617.308542] Starting dynamic subtest: pipe-C-HDMI-A-3 [617.452706] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.164s) [617.640593] Starting dynamic subtest: pipe-D-HDMI-A-3 [617.794269] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.179s) [617.795414] Subtest invalid-async-flip-atomic: SUCCESS (1.616s) [618.219608] [117/156] (418s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [619.824473] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [619.826577] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [620.046422] [118/156] (416s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs) [621.655085] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs [621.657300] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s) [621.951419] [119/156] (414s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled) [622.099201] Starting subtest: multi-wait-all-for-submit-available-signaled [622.100333] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s) [622.304759] [120/156] (414s left) gem_exec_whisper (basic-queues-forked) [622.448745] Starting subtest: basic-queues-forked [645.103530] Subtest basic-queues-forked: SUCCESS (22.649s) [645.339662] [121/156] (391s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [646.903980] Starting subtest: fbcpsr-slowdraw [646.906066] Subtest fbcpsr-slowdraw: SKIP (0.000s) [647.080292] [122/156] (389s left) syncobj_wait (invalid-signal-zero-handles) [647.200740] Starting subtest: invalid-signal-zero-handles [647.201754] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [647.362228] [123/156] (389s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip) [648.970253] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip [650.516244] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.547s) [650.734821] [124/156] (386s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75) [652.302832] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75 [652.303757] Starting dynamic subtest: pipe-A [652.416076] Dynamic subtest pipe-A: SUCCESS (0.114s) [652.453632] Starting dynamic subtest: pipe-B [652.616837] Dynamic subtest pipe-B: SUCCESS (0.199s) [652.640402] Starting dynamic subtest: pipe-C [652.796619] Dynamic subtest pipe-C: SUCCESS (0.178s) [652.819762] Starting dynamic subtest: pipe-D [652.958313] Dynamic subtest pipe-D: SUCCESS (0.160s) [652.959252] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.657s) [653.212688] [125/156] (383s left) gem_exec_balancer (bonded-dual) [653.358150] Starting subtest: bonded-dual [653.360223] Subtest bonded-dual: SKIP (0.001s) [653.843994] [126/156] (383s left) gem_ctx_persistence (heartbeat-stop) [653.953782] Starting subtest: heartbeat-stop [653.955856] Subtest heartbeat-stop: SKIP (0.000s) [654.111958] [127/156] (383s left) core_setmaster (master-drop-set-user) [654.252597] Starting subtest: master-drop-set-user [654.289690] Subtest master-drop-set-user: SUCCESS (0.038s) [654.371699] [128/156] (383s left) sw_sync (sync_busy) [654.444079] Starting subtest: sync_busy [654.448567] Subtest sync_busy: SUCCESS (0.004s) [654.574050] [129/156] (382s left) kms_selftest (drm_dp_mst_helper) [654.660510] Starting subtest: drm_dp_mst_helper [654.686543] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [654.786268] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.099s) [654.818326] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [654.868906] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.080s) [654.902601] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [654.949926] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.080s) [654.950966] Subtest drm_dp_mst_helper: SUCCESS (0.290s) [655.169941] [130/156] (382s left) perf_pmu (render-node-busy-idle) [655.329846] Starting subtest: render-node-busy-idle [655.330902] Starting dynamic subtest: rcs0 [656.064127] Dynamic subtest rcs0: SUCCESS (0.735s) [656.090790] Starting dynamic subtest: bcs0 [656.727059] Dynamic subtest bcs0: SUCCESS (0.660s) [656.748257] Starting dynamic subtest: vcs0 [657.395060] Dynamic subtest vcs0: SUCCESS (0.665s) [657.416074] Starting dynamic subtest: vcs1 [658.056093] Dynamic subtest vcs1: SUCCESS (0.658s) [658.075403] Starting dynamic subtest: vecs0 [658.719195] Dynamic subtest vecs0: SUCCESS (0.660s) [658.738599] Starting dynamic subtest: vecs1 [659.375950] Dynamic subtest vecs1: SUCCESS (0.653s) [659.398213] Starting dynamic subtest: ccs0 [660.033048] Dynamic subtest ccs0: SUCCESS (0.654s) [660.034689] Subtest render-node-busy-idle: SUCCESS (4.705s) [660.152114] [131/156] (377s left) gem_mmap_gtt (basic-wc) [660.236420] Subtest basic-wc: SKIP (0.000s) [660.324005] [132/156] (377s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [660.414205] Starting subtest: yf-tiled-to-vebox-x-tiled [660.416306] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s) [660.664188] [133/156] (377s left) i915_hangman (engine-error-state-capture) [660.764190] Starting subtest: engine-error-state-capture [660.765165] Starting dynamic subtest: rcs0 [662.637411] Dynamic subtest rcs0: SUCCESS (1.872s) [662.654603] Starting dynamic subtest: bcs0 [666.588601] Dynamic subtest bcs0: SUCCESS (3.949s) [666.606209] Starting dynamic subtest: vcs0 [670.626328] Dynamic subtest vcs0: SUCCESS (4.036s) [670.643826] Starting dynamic subtest: vcs1 [674.598481] Dynamic subtest vcs1: SUCCESS (3.970s) [674.615853] Starting dynamic subtest: vecs0 [678.618401] Dynamic subtest vecs0: SUCCESS (4.018s) [678.635607] Starting dynamic subtest: vecs1 [682.592336] Dynamic subtest vecs1: SUCCESS (3.972s) [682.609466] Starting dynamic subtest: ccs0 [686.648403] Dynamic subtest ccs0: SUCCESS (4.054s) [686.649389] Subtest engine-error-state-capture: SUCCESS (25.879s) [686.808971] [134/156] (351s left) gen9_exec_parse (cmd-crossing-page) [686.898236] Subtest cmd-crossing-page: SKIP (0.000s) [686.999666] [135/156] (350s left) kms_draw_crc (draw-method-mmap-wc) [688.517565] Starting subtest: draw-method-mmap-wc [688.519355] Subtest draw-method-mmap-wc: SKIP (0.000s) [688.710106] [136/156] (349s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-plflip-blt) [690.256297] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-plflip-blt [690.258310] Subtest fbcpsrhdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [690.426165] [137/156] (347s left) kms_flip (2x-flip-vs-panning-interruptible) [691.973631] Starting subtest: 2x-flip-vs-panning-interruptible [691.989535] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.016s) [692.150446] [138/156] (346s left) perf (buffer-fill) [692.406104] Starting subtest: buffer-fill [692.407068] Starting dynamic subtest: 0-rcs0 [694.738783] Dynamic subtest 0-rcs0: SUCCESS (2.331s) [694.739925] Subtest buffer-fill: SUCCESS (2.333s) [694.845229] [139/156] (343s left) kms_invalid_mode (bad-hsync-end) [696.454063] Starting subtest: bad-hsync-end [696.455178] Starting dynamic subtest: pipe-A-HDMI-A-3 [696.564619] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.105s) [696.647972] Starting dynamic subtest: pipe-B-HDMI-A-3 [696.650096] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.004s) [696.730283] Starting dynamic subtest: pipe-C-HDMI-A-3 [696.732379] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.004s) [696.812270] Starting dynamic subtest: pipe-D-HDMI-A-3 [696.814885] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.004s) [696.817029] Subtest bad-hsync-end: SUCCESS (0.148s) [697.123659] [140/156] (341s left) gem_mmap_offset (bad-extensions) [697.495712] Starting subtest: bad-extensions [697.497547] Subtest bad-extensions: SUCCESS (0.000s) [697.817477] [141/156] (341s left) kms_pm_dc (dc5-dpms) [700.625698] Starting subtest: dc5-dpms [701.891853] Subtest dc5-dpms: SUCCESS (1.265s) [702.059569] [142/156] (336s left) i915_drm_fdinfo (busy) [702.173189] Starting subtest: busy [702.174274] Starting dynamic subtest: rcs0 [702.176359] Dynamic subtest rcs0: SKIP (0.001s) [702.199487] Starting dynamic subtest: bcs0 [702.201592] Dynamic subtest bcs0: SKIP (0.001s) [702.225097] Starting dynamic subtest: vcs0 [702.227428] Dynamic subtest vcs0: SKIP (0.001s) [702.250271] Starting dynamic subtest: vcs1 [702.252714] Dynamic subtest vcs1: SKIP (0.020s) [702.275581] Starting dynamic subtest: vecs0 [702.277998] Dynamic subtest vecs0: SKIP (0.001s) [702.300787] Starting dynamic subtest: vecs1 [702.302969] Dynamic subtest vecs1: SKIP (0.001s) [702.325635] Starting dynamic subtest: ccs0 [702.328083] Dynamic subtest ccs0: SKIP (0.001s) [702.330364] Subtest busy: SKIP (0.034s) [702.409293] [143/156] (336s left) kms_selftest (drm_format_helper) [702.486801] Starting subtest: drm_format_helper [702.497322] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8 [702.571786] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.073s) [702.610520] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332 [702.638284] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.065s) [702.658985] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565 [702.717793] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.079s) [702.757506] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555 [702.792572] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.071s) [702.815589] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555 [702.877664] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.083s) [702.920494] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551 [702.962273] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.080s) [702.991511] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888 [703.021446] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.059s) [703.044794] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888 [703.099340] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.076s) [703.140929] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888 [703.165306] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.063s) [703.186427] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010 [703.231191] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.063s) [703.265403] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010 [703.297319] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.066s) [703.318965] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono [703.370590] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.072s) [703.412096] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab [703.438423] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.064s) [703.459208] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888 [703.513318] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.072s) [703.552616] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888 [703.584207] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.070s) [703.604933] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset [703.678593] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.091s) [703.718208] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy [703.755211] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.076s) [703.756143] Subtest drm_format_helper: SUCCESS (1.269s) [703.981687] [144/156] (335s left) gem_sync (basic-many-each) [704.094457] Starting subtest: basic-many-each [706.519911] Subtest basic-many-each: SUCCESS (2.425s) [706.779433] [145/156] (332s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc) [708.306960] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc [708.308679] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [708.520307] [146/156] (330s left) gem_mmap_gtt (coherency) [708.610362] Subtest coherency: SKIP (0.000s) [708.698409] [147/156] (330s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [710.239849] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [710.241789] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [710.395368] [148/156] (329s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [710.488006] Starting subtest: etime-multi-wait-all-for-submit-submitted [710.589774] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.101s) [710.735594] [149/156] (328s left) kms_lease (invalid-create-leases) [712.310021] Starting subtest: invalid-create-leases [712.324260] Subtest invalid-create-leases: SUCCESS (0.015s) [712.495835] [150/156] (327s left) gem_ctx_param (basic-default) [712.615807] Starting subtest: basic-default [712.616847] Subtest basic-default: SUCCESS (0.000s) [712.745879] [151/156] (327s left) gem_exec_schedule (preempt-user) [712.886842] Starting subtest: preempt-user [712.887800] Starting dynamic subtest: rcs0 [712.993220] Dynamic subtest rcs0: SUCCESS (0.107s) [713.018621] Starting dynamic subtest: bcs0 [713.051750] Dynamic subtest bcs0: SUCCESS (0.057s) [713.077149] Starting dynamic subtest: vcs0 [713.112790] Dynamic subtest vcs0: SUCCESS (0.059s) [713.138049] Starting dynamic subtest: vcs1 [713.173789] Dynamic subtest vcs1: SUCCESS (0.059s) [713.199096] Starting dynamic subtest: vecs0 [713.230800] Dynamic subtest vecs0: SUCCESS (0.055s) [713.256143] Starting dynamic subtest: vecs1 [713.289532] Dynamic subtest vecs1: SUCCESS (0.057s) [713.315231] Starting dynamic subtest: ccs0 [713.346832] Dynamic subtest ccs0: SUCCESS (0.056s) [713.347888] Subtest preempt-user: SUCCESS (0.462s) [713.766739] [152/156] (326s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-render) [715.323572] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-render [715.325546] Subtest hdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [715.507472] [153/156] (324s left) kms_psr (fbc-psr2-sprite-plane-onoff) [717.092010] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s) [717.183837] [154/156] (322s left) i915_suspend (fence-restore-tiled2untiled) [717.324718] Starting subtest: fence-restore-tiled2untiled [717.326745] Subtest fence-restore-tiled2untiled: SKIP (0.000s) [717.517110] [155/156] (322s left) kms_psr (psr2-primary-render) [719.075358] Subtest psr2-primary-render: SKIP (0.000s) [719.168833] [156/156] (321s left) gem_userptr_blits (input-checking) [719.300346] Starting subtest: input-checking [719.301320] Subtest input-checking: SUCCESS (0.000s) [719.536875] Closing watchdogs results: parsing output: 0/ for test: kms_ccs results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_psr2_sf results: parsing output: 5/ for test: gem_exec_whisper results: parsing output: 6/ for test: syncobj_timeline results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: gem_partial_pwrite_pread results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: kms_busy results: parsing output: 11/ for test: kms_big_fb results: parsing output: 12/ for test: kms_plane results: parsing output: 13/ for test: kms_fbcon_fbt results: parsing output: 14/ for test: gen3_render_mixed_blits results: parsing output: 15/ for test: syncobj_wait results: parsing output: 16/ for test: kms_big_fb results: parsing output: 17/ for test: gem_lmem_swapping results: parsing output: 18/ for test: syncobj_wait results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: fbdev results: parsing output: 21/ for test: kms_cursor_crc results: parsing output: 22/ for test: syncobj_wait results: parsing output: 23/ for test: kms_plane_lowres results: parsing output: 24/ for test: drm_read results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: kms_psr2_sf results: parsing output: 28/ for test: kms_rotation_crc results: parsing output: 29/ for test: i915_pm_rpm results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_ccs results: parsing output: 37/ for test: kms_addfb_basic results: parsing output: 38/ for test: gem_create results: parsing output: 39/ for test: gem_pwrite results: parsing output: 40/ for test: kms_getfb results: parsing output: 41/ for test: kms_chamelium_hpd results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: gem_pxp results: parsing output: 45/ for test: kms_joiner results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_cursor_legacy results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: kms_ccs results: parsing output: 50/ for test: kms_flip results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_addfb_basic results: parsing output: 53/ for test: kms_cursor_crc results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_content_protection results: parsing output: 56/ for test: syncobj_basic results: parsing output: 57/ for test: syncobj_basic results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_color results: parsing output: 60/ for test: kms_psr results: parsing output: 61/ for test: syncobj_timeline results: parsing output: 62/ for test: kms_properties results: parsing output: 63/ for test: api_intel_bb results: parsing output: 64/ for test: gem_exec_schedule results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_prime results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: kms_chamelium_edid results: parsing output: 69/ for test: kms_flip results: parsing output: 70/ for test: kms_plane_scaling results: parsing output: 71/ for test: kms_vblank results: parsing output: 72/ for test: syncobj_wait results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: gem_ctx_isolation results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_cursor_legacy results: parsing output: 77/ for test: kms_big_fb results: parsing output: 78/ for test: syncobj_timeline results: parsing output: 79/ for test: kms_big_fb results: parsing output: 80/ for test: kms_plane_alpha_blend results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_flip_scaled_crc results: parsing output: 83/ for test: gem_exec_fence results: parsing output: 84/ for test: gem_ctx_bad_destroy results: parsing output: 85/ for test: perf results: parsing output: 86/ for test: gem_ctx_shared results: parsing output: 87/ for test: gem_partial_pwrite_pread results: parsing output: 88/ for test: gem_close_race results: parsing output: 89/ for test: kms_psr results: parsing output: 90/ for test: prime_vgem results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_flip results: parsing output: 94/ for test: gem_exec_basic results: parsing output: 95/ for test: gem_exec_fence results: parsing output: 96/ for test: kms_cursor_crc results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: gem_exec_create results: parsing output: 99/ for test: gem_softpin results: parsing output: 100/ for test: api_intel_allocator results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: gen7_exec_parse results: parsing output: 103/ for test: perf results: parsing output: 104/ for test: sysfs_heartbeat_interval results: parsing output: 105/ for test: kms_big_fb results: parsing output: 106/ for test: gem_fenced_exec_thrash results: parsing output: 107/ for test: vgem_basic results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_dp_link_training results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_psr results: parsing output: 113/ for test: kms_chamelium_color results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_async_flips results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_ccs results: parsing output: 118/ for test: syncobj_timeline results: parsing output: 119/ for test: gem_exec_whisper results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: syncobj_wait results: parsing output: 122/ for test: kms_big_fb results: parsing output: 123/ for test: kms_plane_scaling results: parsing output: 124/ for test: gem_exec_balancer results: parsing output: 125/ for test: gem_ctx_persistence results: parsing output: 126/ for test: core_setmaster results: parsing output: 127/ for test: sw_sync results: parsing output: 128/ for test: kms_selftest results: parsing output: 129/ for test: perf_pmu results: parsing output: 130/ for test: gem_mmap_gtt results: parsing output: 131/ for test: gem_render_copy results: parsing output: 132/ for test: i915_hangman results: parsing output: 133/ for test: gen9_exec_parse results: parsing output: 134/ for test: kms_draw_crc results: parsing output: 135/ for test: kms_frontbuffer_tracking results: parsing output: 136/ for test: kms_flip results: parsing output: 137/ for test: perf results: parsing output: 138/ for test: kms_invalid_mode results: parsing output: 139/ for test: gem_mmap_offset results: parsing output: 140/ for test: kms_pm_dc results: parsing output: 141/ for test: i915_drm_fdinfo results: parsing output: 142/ for test: kms_selftest results: parsing output: 143/ for test: gem_sync results: parsing output: 144/ for test: kms_frontbuffer_tracking results: parsing output: 145/ for test: gem_mmap_gtt results: parsing output: 146/ for test: kms_frontbuffer_tracking results: parsing output: 147/ for test: syncobj_timeline results: parsing output: 148/ for test: kms_lease results: parsing output: 149/ for test: gem_ctx_param results: parsing output: 150/ for test: gem_exec_schedule results: parsing output: 151/ for test: kms_frontbuffer_tracking results: parsing output: 152/ for test: kms_psr results: parsing output: 153/ for test: i915_suspend results: parsing output: 154/ for test: kms_psr results: parsing output: 155/ for test: gem_userptr_blits Done.