[46.122310] Initializing watchdogs [46.122387] /dev/watchdog0 [46.138476] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics] [46.144290] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [46.146820] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [46.148764] [001/156] (960s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-render) [46.248352] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-render [46.249743] Subtest hdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [46.359400] [002/156] (960s left) gem_readwrite (new-obj) [46.400615] Starting subtest: new-obj [46.402265] Subtest new-obj: SUCCESS (0.000s) [46.490390] [003/156] (960s left) kms_getfb (getfb-handle-not-fb) [46.578524] Starting subtest: getfb-handle-not-fb [46.579228] Subtest getfb-handle-not-fb: SUCCESS (0.000s) [46.674542] [004/156] (960s left) sysfs_timeslice_duration (invalid) [46.713526] Starting subtest: invalid [46.714334] Starting dynamic subtest: vecs0 [46.715062] Dynamic subtest vecs0: SUCCESS (0.000s) [46.721436] Starting dynamic subtest: vcs0 [46.722143] Dynamic subtest vcs0: SUCCESS (0.000s) [46.728148] Starting dynamic subtest: bcs0 [46.728853] Dynamic subtest bcs0: SUCCESS (0.000s) [46.734497] Starting dynamic subtest: rcs0 [46.735180] Dynamic subtest rcs0: SUCCESS (0.000s) [46.740653] Starting dynamic subtest: vcs1 [46.741333] Dynamic subtest vcs1: SUCCESS (0.000s) [46.742027] Subtest invalid: SUCCESS (0.004s) [46.778248] [005/156] (960s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode) [46.934722] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s) [47.033946] [006/156] (959s left) gem_eio (execbuf) [47.083599] Starting subtest: execbuf [47.112631] Subtest execbuf: SUCCESS (0.029s) [47.253630] [007/156] (959s left) kms_psr (psr-basic) [47.342418] Subtest psr-basic: SKIP (0.000s) [47.389037] [008/156] (959s left) gem_basic (multigpu-create-close) [47.423013] Starting subtest: multigpu-create-close [47.424443] Subtest multigpu-create-close: SKIP (0.000s) [47.479855] [009/156] (959s left) kms_frontbuffer_tracking (fbchdr-tiling-4) [47.572575] Starting subtest: fbchdr-tiling-4 [47.573978] Subtest fbchdr-tiling-4: SKIP (0.000s) [47.665187] [010/156] (959s left) kms_chamelium_frames (hdmi-cmp-planar-formats) [47.805116] Subtest hdmi-cmp-planar-formats: SKIP (0.000s) [47.897399] [011/156] (959s left) gem_ctx_persistence (legacy-engines-mixed-process) [47.940807] Starting subtest: legacy-engines-mixed-process [47.941550] Starting dynamic subtest: render [48.303571] Dynamic subtest render: SUCCESS (0.362s) [48.309499] Starting dynamic subtest: bsd1 [48.659947] Dynamic subtest bsd1: SUCCESS (0.355s) [48.667289] Starting dynamic subtest: bsd2 [49.033020] Dynamic subtest bsd2: SUCCESS (0.372s) [49.047459] Starting dynamic subtest: blt [49.405886] Dynamic subtest blt: SUCCESS (0.371s) [49.415292] Starting dynamic subtest: vebox [49.763910] Dynamic subtest vebox: SUCCESS (0.357s) [49.765238] Subtest legacy-engines-mixed-process: SUCCESS (1.823s) [49.834351] [012/156] (957s left) drm_read (short-buffer-nonblock) [49.968787] Starting subtest: short-buffer-nonblock [49.969578] Subtest short-buffer-nonblock: SUCCESS (0.000s) [50.081221] [013/156] (957s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc) [50.178484] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc [50.179881] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [50.289687] [014/156] (956s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt) [50.382631] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt [50.384103] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [50.463951] [015/156] (956s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt) [50.555474] Starting subtest: psr-1p-primscrn-indfb-plflip-blt [50.556868] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [50.664079] [016/156] (956s left) gem_softpin (allocator-nopin-reserve) [50.701743] Starting subtest: allocator-nopin-reserve [50.789857] Subtest allocator-nopin-reserve: SUCCESS (0.088s) [50.914015] [017/156] (956s left) perf_pmu (render-node-busy-idle) [50.953991] Starting subtest: render-node-busy-idle [50.954903] Starting dynamic subtest: rcs0 [51.594075] Dynamic subtest rcs0: SUCCESS (0.636s) [51.604088] Starting dynamic subtest: bcs0 [52.227191] Dynamic subtest bcs0: SUCCESS (0.636s) [52.237078] Starting dynamic subtest: vcs0 [52.863325] Dynamic subtest vcs0: SUCCESS (0.635s) [52.872929] Starting dynamic subtest: vcs1 [53.504453] Dynamic subtest vcs1: SUCCESS (0.640s) [53.514758] Starting dynamic subtest: vecs0 [54.139412] Dynamic subtest vecs0: SUCCESS (0.635s) [54.140752] Subtest render-node-busy-idle: SUCCESS (3.186s) [54.212681] [018/156] (953s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-onoff) [54.309180] Starting subtest: psrhdr-2p-primscrn-cur-indfb-onoff [54.310577] Subtest psrhdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [54.389628] [019/156] (952s left) kms_vblank (wait-idle) [54.477670] Starting subtest: wait-idle [54.478387] Starting dynamic subtest: pipe-A-HDMI-A-1 [55.651122] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.172s) [55.662125] Starting dynamic subtest: pipe-D-HDMI-A-1 [56.819345] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.165s) [56.820126] Subtest wait-idle: SUCCESS (2.342s) [56.962260] [020/156] (950s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted) [56.998448] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted [57.109740] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.104s) [57.185861] [021/156] (950s left) kms_frontbuffer_tracking (hdr-rgb565-draw-render) [57.279495] Starting subtest: hdr-rgb565-draw-render [57.280926] Subtest hdr-rgb565-draw-render: SKIP (0.000s) [57.370691] [022/156] (950s left) gem_ctx_exec (basic-close-race) [57.406945] Starting subtest: basic-close-race [62.988481] Subtest basic-close-race: SUCCESS (5.547s) [63.087581] [023/156] (944s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf) [63.179135] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [63.215662] [024/156] (944s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-pgflip-blt) [63.307372] Starting subtest: hdr-1p-primscrn-indfb-pgflip-blt [63.308794] Subtest hdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [63.386706] [025/156] (944s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs) [63.473734] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs [63.474434] Starting dynamic subtest: pipe-A-HDMI-A-1 [63.626420] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.150s) [63.633948] Starting dynamic subtest: pipe-B-HDMI-A-1 [63.730468] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.103s) [63.737465] Starting dynamic subtest: pipe-C-HDMI-A-1 [63.834494] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.102s) [63.844091] Starting dynamic subtest: pipe-D-HDMI-A-1 [63.941602] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.106s) [63.942309] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SUCCESS (0.465s) [64.210052] [026/156] (943s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [64.304128] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [65.640744] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (1.337s) [65.776419] [027/156] (941s left) kms_frontbuffer_tracking (fbchdr-farfromfence-mmap-gtt) [65.870437] Starting subtest: fbchdr-farfromfence-mmap-gtt [65.871911] Subtest fbchdr-farfromfence-mmap-gtt: SKIP (0.000s) [65.977790] [028/156] (941s left) kms_plane_alpha_blend (constant-alpha-mid) [66.067812] Starting subtest: constant-alpha-mid [66.143483] Starting dynamic subtest: pipe-A-HDMI-A-1 [66.538671] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.396s) [66.547785] Starting dynamic subtest: pipe-D-HDMI-A-1 [66.941890] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.401s) [66.942880] Subtest constant-alpha-mid: SUCCESS (0.874s) [67.467510] [029/156] (940s left) kms_psr (fbc-pr-sprite-mmap-cpu) [67.720210] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s) [67.814585] [030/156] (939s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc) [67.927515] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc [67.929287] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [68.066921] [031/156] (939s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render) [68.165410] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render [69.450282] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (1.285s) [69.587578] [032/156] (938s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs) [69.626940] Starting subtest: y-tiled-ccs-to-y-tiled-ccs [69.627747] Starting dynamic subtest: smem [69.748737] Dynamic subtest smem: SUCCESS (0.113s) [69.749570] Subtest y-tiled-ccs-to-y-tiled-ccs: SUCCESS (0.113s) [69.922368] [033/156] (937s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt) [70.016243] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt [70.017608] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [70.099710] [034/156] (937s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt) [70.192219] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt [70.193600] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [70.288058] [035/156] (937s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c) [70.322610] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s) [70.363236] [036/156] (937s left) kms_cdclk (plane-scaling) [70.397138] Subtest plane-scaling: SKIP (0.000s) [70.439696] [037/156] (937s left) kms_frontbuffer_tracking (fbchdr-1p-rte) [70.532155] Starting subtest: fbchdr-1p-rte [70.533521] Subtest fbchdr-1p-rte: SKIP (0.000s) [70.617291] [038/156] (937s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-msflip-blt) [70.709220] Starting subtest: psrhdr-2p-primscrn-shrfb-msflip-blt [70.710599] Subtest psrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [70.811333] [039/156] (937s left) gem_exec_reloc (basic-range-active) [70.849592] Starting subtest: basic-range-active [70.888473] Subtest basic-range-active: SUCCESS (0.039s) [70.999610] [040/156] (937s left) syncobj_timeline (etime-single-wait-submitted) [71.034883] Starting subtest: etime-single-wait-submitted [71.149068] Subtest etime-single-wait-submitted: SUCCESS (0.108s) [71.215931] [041/156] (937s left) api_intel_allocator (reopen) [71.250460] Starting subtest: reopen [71.252010] Subtest reopen: SUCCESS (0.002s) [71.364404] [042/156] (936s left) gem_exec_reloc (basic-write-read) [71.409531] Starting subtest: basic-write-read [71.410369] Subtest basic-write-read: SUCCESS (0.005s) [71.523532] [043/156] (936s left) gem_sync (basic-many-each) [71.567931] Starting subtest: basic-many-each [73.807368] Subtest basic-many-each: SUCCESS (2.239s) [74.009403] [044/156] (934s left) kms_async_flips (async-flip-suspend-resume) [74.100733] Starting subtest: async-flip-suspend-resume [74.224283] Starting dynamic subtest: pipe-A-HDMI-A-1 [92.115059] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.382s) [92.240310] Starting dynamic subtest: pipe-B-HDMI-A-1 [110.092814] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.336s) [110.213287] Starting dynamic subtest: pipe-C-HDMI-A-1 [128.104489] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.284s) [128.249007] Starting dynamic subtest: pipe-D-HDMI-A-1 [146.081898] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.276s) [146.082690] Subtest async-flip-suspend-resume: SUCCESS (9.770s) [154.331892] [045/156] (862s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc) [154.425733] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc [154.426497] Starting dynamic subtest: pipe-A-HDMI-A-1 [154.433481] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [154.443820] Starting dynamic subtest: pipe-B-HDMI-A-1 [154.450834] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [154.461085] Starting dynamic subtest: pipe-C-HDMI-A-1 [154.467981] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [154.477521] Starting dynamic subtest: pipe-D-HDMI-A-1 [154.485134] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [154.486636] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [154.670477] [046/156] (861s left) kms_sequence (get-idle) [154.759426] Starting subtest: get-idle [154.760127] Starting dynamic subtest: pipe-A-HDMI-A-1 [155.958538] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.198s) [155.966793] Starting dynamic subtest: pipe-B-HDMI-A-1 [157.144612] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.186s) [157.153817] Starting dynamic subtest: pipe-C-HDMI-A-1 [158.325842] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.180s) [158.335980] Starting dynamic subtest: pipe-D-HDMI-A-1 [159.503113] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.175s) [159.503870] Subtest get-idle: SUCCESS (4.744s) [159.624784] [047/156] (856s left) kms_big_fb (4-tiled-16bpp-rotate-90) [159.729966] Starting subtest: 4-tiled-16bpp-rotate-90 [159.731389] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.000s) [159.812063] [048/156] (856s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc) [159.904021] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc [159.905420] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [160.010294] [049/156] (856s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [160.049328] Starting subtest: yf-tiled-ccs-to-y-tiled [160.050083] Starting dynamic subtest: smem [160.150429] Dynamic subtest smem: SUCCESS (0.101s) [160.151172] Subtest yf-tiled-ccs-to-y-tiled: SUCCESS (0.101s) [160.342991] [050/156] (856s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-plflip-blt) [160.434943] Starting subtest: fbchdr-1p-primscrn-indfb-plflip-blt [160.436326] Subtest fbchdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [160.532540] [051/156] (856s left) prime_busy (hang-wait) [160.569827] Starting subtest: hang-wait [160.570586] Starting dynamic subtest: rcs0 [174.975296] Dynamic subtest rcs0: SUCCESS (14.372s) [174.986163] Starting dynamic subtest: bcs0 [181.822711] Dynamic subtest bcs0: SUCCESS (6.844s) [181.833388] Starting dynamic subtest: vcs0 [188.801537] Dynamic subtest vcs0: SUCCESS (6.974s) [188.812313] Starting dynamic subtest: vcs1 [195.777562] Dynamic subtest vcs1: SUCCESS (6.974s) [195.788273] Starting dynamic subtest: vecs0 [202.814992] Dynamic subtest vecs0: SUCCESS (7.038s) [202.815990] Subtest hang-wait: SUCCESS (42.213s) [202.894739] [052/156] (813s left) gem_eio (hibernate) [202.936756] Starting subtest: hibernate [216.068405] Subtest hibernate: SUCCESS (13.131s) [224.233288] [053/156] (800s left) gem_mmap (bad-object) [224.276923] Starting subtest: bad-object [224.277644] Subtest bad-object: SUCCESS (0.000s) [224.360889] [054/156] (800s left) kms_feature_discovery (display-3x) [224.453770] Starting subtest: display-3x [224.455286] Subtest display-3x: SKIP (0.000s) [224.510699] [055/156] (800s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-gtt) [224.602521] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-gtt [224.603935] Subtest fbcpsrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [224.716127] [056/156] (800s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-msflip-blt) [224.808947] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-msflip-blt [224.810360] Subtest fbcpsrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [224.894847] [057/156] (800s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [224.983589] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [224.985285] Starting dynamic subtest: pipe-A-HDMI-A-1 [225.003357] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s) [225.011603] Starting dynamic subtest: pipe-B-HDMI-A-1 [225.029844] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s) [225.037997] Starting dynamic subtest: pipe-C-HDMI-A-1 [225.056411] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s) [225.065913] Starting dynamic subtest: pipe-D-HDMI-A-1 [225.085478] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s) [225.086835] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.015s) [225.237568] [058/156] (799s left) kms_content_protection (atomic-hdcp14) [225.333282] Starting subtest: atomic-hdcp14 [225.339889] Subtest atomic-hdcp14: SKIP (0.004s) [225.432716] [059/156] (799s left) kms_psr (psr-suspend) [225.521416] Subtest psr-suspend: SKIP (0.000s) [225.566653] [060/156] (799s left) kms_big_fb (yf-tiled-16bpp-rotate-0) [225.664296] Starting subtest: yf-tiled-16bpp-rotate-0 [225.665732] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s) [225.765789] [061/156] (799s left) gem_exec_flush (basic-wb-ro-before-default) [225.808715] Starting subtest: basic-wb-ro-before-default [231.233454] Subtest basic-wb-ro-before-default: SUCCESS (5.425s) [231.440902] [062/156] (793s left) i915_pm_rpm (system-suspend-execbuf) [232.843117] Starting subtest: system-suspend-execbuf [275.537896] Subtest system-suspend-execbuf: SUCCESS (27.922s) [275.724010] [063/156] (749s left) gem_partial_pwrite_pread (writes-after-reads-display) [275.769500] Starting subtest: writes-after-reads-display [288.095954] Subtest writes-after-reads-display: SUCCESS (12.327s) [288.213606] [064/156] (737s left) kms_setmode (invalid-clone-single-crtc-stealing) [288.247264] Starting subtest: invalid-clone-single-crtc-stealing [288.249339] Subtest invalid-clone-single-crtc-stealing: SKIP (0.001s) [288.326180] [065/156] (736s left) i915_suspend (basic-s2idle-without-i915) [288.358461] Starting subtest: basic-s2idle-without-i915 [307.058013] Subtest basic-s2idle-without-i915: SUCCESS (3.041s) [314.191017] [066/156] (718s left) gem_exec_create (madvise) [314.247688] Starting subtest: madvise [314.248425] Starting dynamic subtest: smem [334.393916] Dynamic subtest smem: SUCCESS (20.147s) [334.394690] Subtest madvise: SUCCESS (20.148s) [335.852733] [067/156] (696s left) gem_ctx_shared (q-smoketest) [335.896955] Starting subtest: Q-smoketest [335.897760] Starting dynamic subtest: rcs0 [341.362257] Dynamic subtest rcs0: SUCCESS (5.421s) [341.371429] Starting dynamic subtest: bcs0 [346.775330] Dynamic subtest bcs0: SUCCESS (5.416s) [346.784502] Starting dynamic subtest: vcs0 [352.194295] Dynamic subtest vcs0: SUCCESS (5.419s) [352.204439] Starting dynamic subtest: vcs1 [357.622786] Dynamic subtest vcs1: SUCCESS (5.424s) [357.632214] Starting dynamic subtest: vecs0 [363.048721] Dynamic subtest vecs0: SUCCESS (5.421s) [363.049700] Subtest Q-smoketest: SUCCESS (27.107s) [363.185249] [068/156] (669s left) gem_exec_reloc (basic-cpu-active) [363.226305] Starting subtest: basic-cpu-active [363.356879] Subtest basic-cpu-active: SUCCESS (0.122s) [363.491034] [069/156] (669s left) gem_watchdog (default-physical) [363.531006] Starting subtest: default-physical [364.799498] Subtest default-physical: SUCCESS (1.259s) [364.892594] [070/156] (667s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling) [364.983404] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling [364.984137] Starting dynamic subtest: pipe-A-valid-mode [365.783100] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.797s) [365.783857] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SUCCESS (0.799s) [365.940946] [071/156] (666s left) gen9_exec_parse (bb-start-param) [365.983516] Subtest bb-start-param: SKIP (0.000s) [366.022545] [072/156] (666s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [366.113948] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s) [366.155793] [073/156] (666s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-plflip-blt) [366.248246] Starting subtest: fbchdr-2p-primscrn-indfb-plflip-blt [366.249644] Subtest fbchdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [366.347571] [074/156] (666s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [366.440592] Starting subtest: compare-crc-sanitycheck-xr24 [366.442216] Starting dynamic subtest: pipe-A-HDMI-A-1 [366.692239] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.250s) [366.705934] Starting dynamic subtest: pipe-B-HDMI-A-1 [366.955766] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.261s) [366.966454] Starting dynamic subtest: pipe-C-HDMI-A-1 [367.213999] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.254s) [367.226084] Starting dynamic subtest: pipe-D-HDMI-A-1 [367.465793] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.249s) [367.466540] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.024s) [367.615491] [075/156] (665s left) syncobj_timeline (multi-wait-all-signaled) [367.652833] Starting subtest: multi-wait-all-signaled [367.655134] Subtest multi-wait-all-signaled: SUCCESS (0.001s) [367.719561] [076/156] (665s left) kms_psr (pr-primary-mmap-gtt) [367.810599] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [367.854581] [077/156] (664s left) kms_flip (blocking-absolute-wf_vblank-interruptible) [367.948812] Starting subtest: blocking-absolute-wf_vblank-interruptible [367.951840] Starting dynamic subtest: A-HDMI-A1 [375.627368] Dynamic subtest A-HDMI-A1: SUCCESS (7.656s) [375.636103] Starting dynamic subtest: B-HDMI-A1 [383.277444] Dynamic subtest B-HDMI-A1: SUCCESS (7.637s) [383.289312] Starting dynamic subtest: C-HDMI-A1 [390.932397] Dynamic subtest C-HDMI-A1: SUCCESS (7.652s) [390.941004] Starting dynamic subtest: D-HDMI-A1 [398.549645] Dynamic subtest D-HDMI-A1: SUCCESS (7.640s) [398.550377] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (30.602s) [398.706426] [078/156] (634s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation) [398.797616] Starting subtest: plane-upscale-factor-0-25-with-rotation [398.798477] Starting dynamic subtest: pipe-A [399.934943] Dynamic subtest pipe-A: SKIP (1.135s) [399.946175] Starting dynamic subtest: pipe-B [401.103259] Dynamic subtest pipe-B: SKIP (1.168s) [401.112098] Starting dynamic subtest: pipe-C [402.288991] Dynamic subtest pipe-C: SKIP (1.185s) [402.297714] Starting dynamic subtest: pipe-D [403.445884] Dynamic subtest pipe-D: SKIP (1.156s) [403.447216] Subtest plane-upscale-factor-0-25-with-rotation: SKIP (4.648s) [403.627113] [079/156] (629s left) api_intel_bb (reset-bb) [403.670752] Starting subtest: reset-bb [403.673133] Subtest reset-bb: SUCCESS (0.002s) [403.790312] [080/156] (629s left) gem_lmem_swapping (heavy-random) [403.829895] Subtest heavy-random: SKIP (0.000s) [403.870722] [081/156] (629s left) gem_mmap_gtt (basic-write) [403.905935] Starting subtest: basic-write [404.039923] Subtest basic-write: SUCCESS (0.124s) [404.124208] [082/156] (628s left) gem_request_retire (retire-vma-not-inactive) [404.164450] Starting subtest: retire-vma-not-inactive [404.175720] Subtest retire-vma-not-inactive: SUCCESS (0.012s) [404.282490] [083/156] (628s left) kms_cursor_crc (cursor-offscreen-512x170) [404.379171] Starting subtest: cursor-offscreen-512x170 [404.380588] Subtest cursor-offscreen-512x170: SKIP (0.001s) [404.457000] [084/156] (628s left) gem_softpin (noreloc-s3) [404.498986] Starting subtest: noreloc-S3 [425.241146] Subtest noreloc-S3: SUCCESS (5.427s) [434.411187] [085/156] (607s left) kms_psr (fbc-psr2-primary-blt) [434.515705] Subtest fbc-psr2-primary-blt: SKIP (0.000s) [434.560754] [086/156] (607s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite) [434.654438] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite [434.655860] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [434.724802] [087/156] (607s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier) [434.812458] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier [434.813916] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s) [434.872568] [088/156] (607s left) gem_exec_schedule (wide) [435.041697] Starting subtest: wide [435.042603] Starting dynamic subtest: rcs0 [445.295251] Dynamic subtest rcs0: SUCCESS (10.220s) [445.305630] Starting dynamic subtest: bcs0 [456.502894] Dynamic subtest bcs0: SUCCESS (11.231s) [456.513421] Starting dynamic subtest: vcs0 [468.428007] Dynamic subtest vcs0: SUCCESS (11.896s) [468.438285] Starting dynamic subtest: vcs1 [479.885794] Dynamic subtest vcs1: SUCCESS (11.459s) [479.895645] Starting dynamic subtest: vecs0 [491.386289] Dynamic subtest vecs0: SUCCESS (11.499s) [491.387243] Subtest wide: SUCCESS (56.313s) [493.494081] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true [493.498743] [089/156] (548s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt) [493.601061] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt [493.602463] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [493.695911] [090/156] (548s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc) [493.785748] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc [493.786521] Starting dynamic subtest: pipe-A-HDMI-A-1 [510.194160] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.421s) [510.204878] Starting dynamic subtest: pipe-B-HDMI-A-1 [527.192568] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.386s) [527.206193] Starting dynamic subtest: pipe-C-HDMI-A-1 [544.161412] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.384s) [544.171689] Starting dynamic subtest: pipe-D-HDMI-A-1 [560.160283] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.327s) [560.161045] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SUCCESS (5.525s) [569.389137] [091/156] (482s left) drm_mm (drm_mm) [569.433800] Starting subtest: drm_mm [569.462727] Starting dynamic subtest: drm_test_mm_init [569.536645] Dynamic subtest drm_test_mm_init: SUCCESS (0.071s) [569.553043] Starting dynamic subtest: drm_test_mm_debug [569.612277] Dynamic subtest drm_test_mm_debug: SUCCESS (0.074s) [569.631052] Starting dynamic subtest: drm_test_mm_align32 [569.678366] Dynamic subtest drm_test_mm_align32: SUCCESS (0.064s) [569.696118] Starting dynamic subtest: drm_test_mm_align64 [569.752114] Dynamic subtest drm_test_mm_align64: SUCCESS (0.072s) [569.772937] Starting dynamic subtest: drm_test_mm_lowest [569.830916] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.076s) [569.851224] Starting dynamic subtest: drm_test_mm_highest [569.899040] Dynamic subtest drm_test_mm_highest: SUCCESS (0.066s) [569.900075] Subtest drm_mm: SUCCESS (0.466s) [570.047466] [092/156] (481s left) gem_exec_balancer (hang) [570.208526] Starting subtest: hang [571.510359] Subtest hang: SUCCESS (1.310s) [571.576631] [093/156] (479s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [571.611877] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [571.613658] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s) [571.689985] [094/156] (479s left) kms_cursor_crc (cursor-random-64x64) [571.783900] Starting subtest: cursor-random-64x64 [571.788781] Starting dynamic subtest: pipe-A-HDMI-A-1 [573.695457] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.907s) [573.731280] Starting dynamic subtest: pipe-D-HDMI-A-1 [575.602691] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.879s) [575.603476] Subtest cursor-random-64x64: SUCCESS (3.819s) [575.755490] [095/156] (475s left) gem_mmap_offset (ptrace) [575.795992] Starting subtest: ptrace [575.798330] Starting dynamic subtest: smem0-gtt [575.824670] Dynamic subtest smem0-gtt: SUCCESS (0.027s) [575.837436] Starting dynamic subtest: smem0-wb [575.845483] Dynamic subtest smem0-wb: SUCCESS (0.019s) [575.858274] Starting dynamic subtest: smem0-wc [575.868268] Dynamic subtest smem0-wc: SUCCESS (0.021s) [575.880975] Starting dynamic subtest: smem0-uc [575.891183] Dynamic subtest smem0-uc: SUCCESS (0.022s) [575.891995] Subtest ptrace: SUCCESS (0.097s) [575.988208] [096/156] (475s left) kms_addfb_basic (unused-offsets) [576.023080] Starting subtest: unused-offsets [576.023799] Subtest unused-offsets: SUCCESS (0.000s) [576.179324] [097/156] (475s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc) [576.271680] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc [576.273086] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [576.372129] [098/156] (475s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [576.464559] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [576.466066] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [576.562988] [099/156] (475s left) kms_fbcon_fbt (psr) [576.601143] Starting subtest: psr [576.602667] Subtest psr: SKIP (0.000s) [576.690956] [100/156] (475s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-render) [576.783679] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-render [576.785088] Subtest psrhdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [576.890380] [101/156] (474s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-plflip-blt) [576.982755] Starting subtest: hdr-2p-scndscrn-indfb-plflip-blt [576.984154] Subtest hdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [577.078986] [102/156] (474s left) gem_exec_schedule (preempt-engines) [577.124890] Starting subtest: preempt-engines [577.125695] Starting dynamic subtest: rcs0 [577.202571] Dynamic subtest rcs0: SUCCESS (0.077s) [577.216007] Starting dynamic subtest: bcs0 [577.286091] Dynamic subtest bcs0: SUCCESS (0.082s) [577.296418] Starting dynamic subtest: vcs0 [577.371813] Dynamic subtest vcs0: SUCCESS (0.085s) [577.383933] Starting dynamic subtest: vcs1 [577.454922] Dynamic subtest vcs1: SUCCESS (0.082s) [577.466631] Starting dynamic subtest: vecs0 [577.538709] Dynamic subtest vecs0: SUCCESS (0.082s) [577.539529] Subtest preempt-engines: SUCCESS (0.414s) [577.846209] [103/156] (474s left) perf_pmu (busy-accuracy-50) [577.882410] Starting subtest: busy-accuracy-50 [577.883203] Starting dynamic subtest: rcs0 [579.407458] Dynamic subtest rcs0: SUCCESS (1.522s) [579.418166] Starting dynamic subtest: bcs0 [580.931509] Dynamic subtest bcs0: SUCCESS (1.522s) [580.941346] Starting dynamic subtest: vcs0 [582.456504] Dynamic subtest vcs0: SUCCESS (1.524s) [582.468090] Starting dynamic subtest: vcs1 [583.980327] Dynamic subtest vcs1: SUCCESS (1.523s) [583.991288] Starting dynamic subtest: vecs0 [585.505291] Dynamic subtest vecs0: SUCCESS (1.524s) [585.506287] Subtest busy-accuracy-50: SUCCESS (7.620s) [585.585219] [104/156] (466s left) kms_cursor_legacy (forked-bo) [585.675220] Starting subtest: forked-bo [585.676002] Starting dynamic subtest: pipe-A [591.128602] Dynamic subtest pipe-A: SUCCESS (5.419s) [591.140321] Starting dynamic subtest: pipe-B [596.557768] Dynamic subtest pipe-B: SUCCESS (5.428s) [596.567428] Starting dynamic subtest: pipe-C [602.012779] Dynamic subtest pipe-C: SUCCESS (5.453s) [602.026740] Starting dynamic subtest: pipe-D [607.438856] Dynamic subtest pipe-D: SUCCESS (5.425s) [607.450369] Starting dynamic subtest: all-pipes [612.886097] Dynamic subtest all-pipes: SUCCESS (5.445s) [612.887110] Subtest forked-bo: SUCCESS (27.179s) [612.934180] [105/156] (439s left) perf (invalid-oa-metric-set-id) [613.016461] Starting subtest: invalid-oa-metric-set-id [613.028462] Subtest invalid-oa-metric-set-id: SUCCESS (0.012s) [613.077142] [106/156] (439s left) kms_lease (atomic-implicit-crtc) [613.166246] Starting subtest: atomic-implicit-crtc [613.168144] Starting dynamic subtest: pipe-A-HDMI-A-1 [613.171740] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s) [613.181627] Starting dynamic subtest: pipe-B-HDMI-A-1 [613.185334] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.008s) [613.195026] Starting dynamic subtest: pipe-C-HDMI-A-1 [613.198666] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.008s) [613.208272] Starting dynamic subtest: pipe-D-HDMI-A-1 [613.211753] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.008s) [613.212459] Subtest atomic-implicit-crtc: SUCCESS (0.034s) [613.264449] [107/156] (438s left) vgem_basic (dmabuf-fence-before) [613.303126] Starting subtest: dmabuf-fence-before [613.303977] Subtest dmabuf-fence-before: SUCCESS (0.000s) [613.373155] [108/156] (438s left) gem_ctx_param (invalid-set-no-zeromap) [613.406300] Starting subtest: invalid-set-no-zeromap [613.407056] Subtest invalid-set-no-zeromap: SUCCESS (0.000s) [613.466125] [109/156] (438s left) kms_big_fb (y-tiled-16bpp-rotate-180) [613.564010] Starting subtest: y-tiled-16bpp-rotate-180 [614.694909] Subtest y-tiled-16bpp-rotate-180: SUCCESS (1.130s) [614.828005] [110/156] (437s left) kms_prime (basic-crc-hybrid) [614.935482] Subtest basic-crc-hybrid: SKIP (0.000s) [615.035902] [111/156] (437s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu) [615.127797] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu [615.129252] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [615.228060] [112/156] (437s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled) [615.262507] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [615.263259] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [615.325652] [113/156] (437s left) gem_render_copy_redux (interruptible) [615.365009] Starting subtest: interruptible [615.697079] Subtest interruptible: SUCCESS (0.323s) [615.805976] [114/156] (436s left) kms_big_fb (linear-addfb) [615.906515] Starting subtest: linear-addfb [615.907249] Subtest linear-addfb: SUCCESS (0.000s) [615.995794] [115/156] (436s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render) [616.088491] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render [616.090010] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [616.185669] [116/156] (436s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu) [616.278840] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu [616.280255] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [616.371082] [117/156] (436s left) kms_psr (fbc-psr-suspend) [616.459126] Subtest fbc-psr-suspend: SKIP (0.000s) [616.504997] [118/156] (436s left) kms_atomic_transition (modeset-transition-fencing) [616.593253] Starting subtest: modeset-transition-fencing [616.593994] Starting dynamic subtest: 1x-outputs [617.863509] Dynamic subtest 1x-outputs: SUCCESS (1.271s) [617.864313] Subtest modeset-transition-fencing: SUCCESS (1.272s) [618.060033] [119/156] (434s left) gem_exec_schedule (semaphore-user) [618.108775] Starting subtest: semaphore-user [618.115582] Subtest semaphore-user: SUCCESS (0.007s) [618.417759] [120/156] (434s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip) [618.517057] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip [618.518520] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [618.597473] [121/156] (434s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-linear) [618.689475] Starting subtest: fbcpsrhdr-tiling-linear [618.690956] Subtest fbcpsrhdr-tiling-linear: SKIP (0.000s) [618.782422] [122/156] (434s left) gem_exec_fence (submit) [618.948008] Starting subtest: submit [618.949161] Starting dynamic subtest: rcs0 [618.964119] Dynamic subtest rcs0: SUCCESS (0.015s) [618.978021] Starting dynamic subtest: bcs0 [618.978741] Dynamic subtest bcs0: SUCCESS (0.011s) [618.988544] Starting dynamic subtest: vcs0 [618.989278] Dynamic subtest vcs0: SUCCESS (0.008s) [618.999624] Starting dynamic subtest: vcs1 [619.000327] Dynamic subtest vcs1: SUCCESS (0.009s) [619.010090] Starting dynamic subtest: vecs0 [619.010880] Dynamic subtest vecs0: SUCCESS (0.008s) [619.011764] Subtest submit: SUCCESS (0.059s) [619.478523] [123/156] (433s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc) [619.571574] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc [619.573046] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [619.673168] [124/156] (433s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt) [619.767016] Starting subtest: psr-2p-primscrn-indfb-plflip-blt [619.768503] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [619.887545] [125/156] (433s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc) [619.982203] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc [619.983647] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [620.069536] [126/156] (432s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [620.162648] Starting subtest: psr-rgb101010-draw-mmap-gtt [620.164028] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [620.271046] [127/156] (432s left) syncobj_wait (multi-wait-all-for-submit-submitted) [620.304526] Starting subtest: multi-wait-all-for-submit-submitted [620.406813] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.102s) [620.486163] [128/156] (432s left) kms_color_pipeline (plane-lut1d-ctm3x4) [620.572248] Starting subtest: plane-lut1d-ctm3x4 [620.656575] Starting dynamic subtest: pipe-A-plane-0 [620.753561] Dynamic subtest pipe-A-plane-0: SUCCESS (0.099s) [620.771545] Starting dynamic subtest: pipe-A-plane-1 [620.845063] Dynamic subtest pipe-A-plane-1: SUCCESS (0.089s) [620.862332] Starting dynamic subtest: pipe-A-plane-2 [620.945445] Dynamic subtest pipe-A-plane-2: SUCCESS (0.097s) [621.168563] Starting dynamic subtest: pipe-B-plane-0 [621.251223] Dynamic subtest pipe-B-plane-0: SUCCESS (0.091s) [621.267838] Starting dynamic subtest: pipe-B-plane-1 [621.343324] Dynamic subtest pipe-B-plane-1: SUCCESS (0.089s) [621.359114] Starting dynamic subtest: pipe-B-plane-2 [621.434433] Dynamic subtest pipe-B-plane-2: SUCCESS (0.089s) [621.658255] Starting dynamic subtest: pipe-C-plane-0 [621.731296] Dynamic subtest pipe-C-plane-0: SUCCESS (0.083s) [621.746543] Starting dynamic subtest: pipe-C-plane-1 [621.830891] Dynamic subtest pipe-C-plane-1: SUCCESS (0.098s) [621.846268] Starting dynamic subtest: pipe-C-plane-2 [621.930881] Dynamic subtest pipe-C-plane-2: SUCCESS (0.097s) [622.162808] Starting dynamic subtest: pipe-D-plane-0 [622.253550] Dynamic subtest pipe-D-plane-0: SUCCESS (0.100s) [622.264314] Starting dynamic subtest: pipe-D-plane-1 [622.345960] Dynamic subtest pipe-D-plane-1: SUCCESS (0.091s) [622.362504] Starting dynamic subtest: pipe-D-plane-2 [622.445806] Dynamic subtest pipe-D-plane-2: SUCCESS (0.098s) [622.495941] Subtest plane-lut1d-ctm3x4: SUCCESS (1.924s) [622.629677] [129/156] (430s left) kms_dither (fb-8bpc-vs-panel-6bpc) [622.725133] Starting subtest: fb-8bpc-vs-panel-6bpc [622.725912] Starting dynamic subtest: pipe-A-HDMI-A-1 [622.785401] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.057s) [622.786882] Subtest fb-8bpc-vs-panel-6bpc: SKIP (0.059s) [622.934538] [130/156] (430s left) gem_userptr_blits (unsync-unmap) [622.975334] Subtest unsync-unmap: SKIP (0.000s) [623.088736] [131/156] (430s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt) [623.181425] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt [623.182897] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [623.272097] [132/156] (429s left) kms_pm_dc (dc9-dpms) [624.364666] Starting subtest: dc9-dpms [627.686883] Subtest dc9-dpms: SKIP (3.287s) [627.762239] [133/156] (425s left) i915_hangman (engine-error-state-capture) [627.809820] Starting subtest: engine-error-state-capture [627.810569] Starting dynamic subtest: rcs0 [632.221440] Dynamic subtest rcs0: SUCCESS (4.411s) [632.242716] Starting dynamic subtest: bcs0 [636.187172] Dynamic subtest bcs0: SUCCESS (3.963s) [636.202102] Starting dynamic subtest: vcs0 [640.219178] Dynamic subtest vcs0: SUCCESS (4.030s) [640.232795] Starting dynamic subtest: vcs1 [644.185021] Dynamic subtest vcs1: SUCCESS (3.962s) [644.204884] Starting dynamic subtest: vecs0 [648.223085] Dynamic subtest vecs0: SUCCESS (4.035s) [648.227462] Subtest engine-error-state-capture: SUCCESS (20.415s) [648.322356] [134/156] (405s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [648.412242] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [648.413656] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (0.000s) [648.495217] [135/156] (404s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-cpu) [648.587775] Starting subtest: psrhdr-rgb565-draw-mmap-cpu [648.589212] Subtest psrhdr-rgb565-draw-mmap-cpu: SKIP (0.000s) [648.691089] [136/156] (404s left) gem_exec_params (readonly) [648.728227] Starting subtest: readonly [648.730310] Subtest readonly: SUCCESS (0.001s) [648.840887] [137/156] (404s left) kms_busy (extended-pageflip-hang-newfb) [648.933244] Starting subtest: extended-pageflip-hang-newfb [648.935047] Starting dynamic subtest: pipe-A [662.544172] Dynamic subtest pipe-A: SUCCESS (13.609s) [662.556706] Starting dynamic subtest: pipe-D [676.352046] Dynamic subtest pipe-D: SUCCESS (13.805s) [676.353110] Subtest extended-pageflip-hang-newfb: SUCCESS (27.420s) [676.505056] [138/156] (377s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt) [676.603507] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt [676.604915] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [676.704189] [139/156] (376s left) i915_drm_fdinfo (context-close-stress) [676.742013] Starting subtest: context-close-stress [687.521756] Subtest context-close-stress: SUCCESS (10.746s) [687.559871] [140/156] (366s left) gem_exec_flush (basic-batch-kernel-default-uc) [687.601437] Starting subtest: basic-batch-kernel-default-uc [693.211662] Subtest basic-batch-kernel-default-uc: SUCCESS (5.610s) [693.413511] [141/156] (360s left) syncobj_timeline (wait-any-interrupted) [693.447680] Starting subtest: wait-any-interrupted [693.552133] Subtest wait-any-interrupted: SUCCESS (0.103s) [693.631703] [142/156] (360s left) prime_mmap (test_dup) [693.666254] Starting subtest: test_dup [693.666953] Starting dynamic subtest: test_dup-smem [693.668729] Dynamic subtest test_dup-smem: SUCCESS (0.002s) [693.669438] Subtest test_dup: SUCCESS (0.003s) [693.772592] [143/156] (359s left) kms_force_connector_basic (force-edid) [693.899798] Starting subtest: force-edid [694.045797] Subtest force-edid: SUCCESS (0.148s) [694.215249] [144/156] (359s left) kms_hdr (static-swap) [694.305297] Starting subtest: static-swap [694.306263] Starting dynamic subtest: pipe-A-HDMI-A-1-XRGB2101010 [694.307648] Dynamic subtest pipe-A-HDMI-A-1-XRGB2101010: SKIP (0.000s) [694.317767] Starting dynamic subtest: pipe-A-HDMI-A-1-XRGB16161616F [694.319151] Dynamic subtest pipe-A-HDMI-A-1-XRGB16161616F: SKIP (0.000s) [694.320507] Subtest static-swap: SKIP (0.004s) [694.368261] [145/156] (359s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic) [694.463294] Starting subtest: 2x-long-flip-vs-cursor-atomic [694.465907] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s) [694.526528] [146/156] (359s left) gem_mmap_offset (bad-flags) [694.560168] Starting subtest: bad-flags [694.560910] Subtest bad-flags: SUCCESS (0.000s) [694.655974] [147/156] (359s left) kms_plane (plane-panning-top-left) [694.743182] Starting subtest: plane-panning-top-left [694.745024] Starting dynamic subtest: pipe-A [695.132404] Dynamic subtest pipe-A: SUCCESS (0.388s) [695.143566] Starting dynamic subtest: pipe-B [695.504248] Dynamic subtest pipe-B: SUCCESS (0.369s) [695.504992] Subtest plane-panning-top-left: SUCCESS (0.762s) [695.670414] [148/156] (358s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [695.765352] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [695.766803] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [695.874865] [149/156] (358s left) gem_exec_basic (basic) [695.915136] Starting subtest: basic [695.915882] Starting dynamic subtest: rcs0-smem [695.916581] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [695.927133] Starting dynamic subtest: bcs0-smem [695.927870] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [695.937026] Starting dynamic subtest: vcs0-smem [695.937737] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [695.946344] Starting dynamic subtest: vcs1-smem [695.947035] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [695.955606] Starting dynamic subtest: vecs0-smem [695.956302] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [695.956979] Subtest basic: SUCCESS (0.008s) [696.099113] [150/156] (357s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-cpu) [696.190940] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-cpu [696.192413] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [696.275903] [151/156] (357s left) kms_plane (pixel-format-linear-modifier) [696.363189] Starting subtest: pixel-format-linear-modifier [696.382398] Starting dynamic subtest: pipe-A-plane-0 [696.757335] Dynamic subtest pipe-A-plane-0: SUCCESS (0.375s) [696.775989] Starting dynamic subtest: pipe-A-plane-3 [697.058717] Dynamic subtest pipe-A-plane-3: SUCCESS (0.298s) [697.074545] Starting dynamic subtest: pipe-A-plane-5 [697.357624] Dynamic subtest pipe-A-plane-5: SUCCESS (0.298s) [697.375310] Starting dynamic subtest: pipe-A-plane-7 [697.465823] Dynamic subtest pipe-A-plane-7: SUCCESS (0.104s) [697.612030] Starting dynamic subtest: pipe-B-plane-0 [697.953052] Dynamic subtest pipe-B-plane-0: SUCCESS (0.350s) [697.971970] Starting dynamic subtest: pipe-B-plane-3 [698.236251] Dynamic subtest pipe-B-plane-3: SUCCESS (0.281s) [698.254574] Starting dynamic subtest: pipe-B-plane-5 [698.527975] Dynamic subtest pipe-B-plane-5: SUCCESS (0.289s) [698.546731] Starting dynamic subtest: pipe-B-plane-7 [698.636453] Dynamic subtest pipe-B-plane-7: SUCCESS (0.106s) [698.718592] Subtest pixel-format-linear-modifier: SUCCESS (2.355s) [698.868186] [152/156] (355s left) gem_lmem_swapping (verify-ccs) [698.909991] Subtest verify-ccs: SKIP (0.000s) [698.958835] [153/156] (355s left) kms_big_fb (yf-tiled-64bpp-rotate-270) [699.063192] Starting subtest: yf-tiled-64bpp-rotate-270 [699.064649] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s) [699.163234] [154/156] (355s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible) [699.254825] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible [699.264474] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.009s) [699.330540] [155/156] (354s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size) [699.422616] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size [699.425561] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [699.487443] [156/156] (354s left) kms_flip (busy-flip) [699.575928] Starting subtest: busy-flip [699.578681] Starting dynamic subtest: A-HDMI-A1 [700.267533] Dynamic subtest A-HDMI-A1: SUCCESS (0.688s) [700.287961] Starting dynamic subtest: B-HDMI-A1 [700.940215] Dynamic subtest B-HDMI-A1: SUCCESS (0.669s) [700.952822] Starting dynamic subtest: C-HDMI-A1 [701.610551] Dynamic subtest C-HDMI-A1: SUCCESS (0.665s) [701.623009] Starting dynamic subtest: D-HDMI-A1 [702.282718] Dynamic subtest D-HDMI-A1: SUCCESS (0.668s) [702.286083] Subtest busy-flip: SUCCESS (2.708s) [702.441697] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: gem_readwrite results: parsing output: 2/ for test: kms_getfb results: parsing output: 3/ for test: sysfs_timeslice_duration results: parsing output: 4/ for test: kms_chamelium_hpd results: parsing output: 5/ for test: gem_eio results: parsing output: 6/ for test: kms_psr results: parsing output: 7/ for test: gem_basic results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: kms_chamelium_frames results: parsing output: 10/ for test: gem_ctx_persistence results: parsing output: 11/ for test: drm_read results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: gem_softpin results: parsing output: 16/ for test: perf_pmu results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_vblank results: parsing output: 19/ for test: syncobj_timeline results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: gem_ctx_exec results: parsing output: 22/ for test: kms_psr2_sf results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: kms_ccs 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_plane_alpha_blend results: parsing output: 28/ for test: kms_psr results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: gem_render_copy 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_pipe_b_c_ivb results: parsing output: 35/ for test: kms_cdclk results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: gem_exec_reloc results: parsing output: 39/ for test: syncobj_timeline results: parsing output: 40/ for test: api_intel_allocator results: parsing output: 41/ for test: gem_exec_reloc results: parsing output: 42/ for test: gem_sync results: parsing output: 43/ for test: kms_async_flips results: parsing output: 44/ for test: kms_ccs results: parsing output: 45/ for test: kms_sequence results: parsing output: 46/ for test: kms_big_fb results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: gem_render_copy results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: prime_busy results: parsing output: 51/ for test: gem_eio results: parsing output: 52/ for test: gem_mmap results: parsing output: 53/ for test: kms_feature_discovery results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: kms_ccs results: parsing output: 57/ for test: kms_content_protection results: parsing output: 58/ for test: kms_psr results: parsing output: 59/ for test: kms_big_fb results: parsing output: 60/ for test: gem_exec_flush results: parsing output: 61/ for test: i915_pm_rpm results: parsing output: 62/ for test: gem_partial_pwrite_pread results: parsing output: 63/ for test: kms_setmode results: parsing output: 64/ for test: i915_suspend results: parsing output: 65/ for test: gem_exec_create results: parsing output: 66/ for test: gem_ctx_shared results: parsing output: 67/ for test: gem_exec_reloc results: parsing output: 68/ for test: gem_watchdog results: parsing output: 69/ for test: kms_flip_scaled_crc results: parsing output: 70/ for test: gen9_exec_parse results: parsing output: 71/ for test: kms_psr2_sf results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_pipe_crc_basic results: parsing output: 74/ for test: syncobj_timeline results: parsing output: 75/ for test: kms_psr results: parsing output: 76/ for test: kms_flip results: parsing output: 77/ for test: kms_plane_scaling results: parsing output: 78/ for test: api_intel_bb results: parsing output: 79/ for test: gem_lmem_swapping results: parsing output: 80/ for test: gem_mmap_gtt results: parsing output: 81/ for test: gem_request_retire results: parsing output: 82/ for test: kms_cursor_crc results: parsing output: 83/ for test: gem_softpin results: parsing output: 84/ for test: kms_psr results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_plane results: parsing output: 87/ for test: gem_exec_schedule results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_ccs results: parsing output: 90/ for test: drm_mm results: parsing output: 91/ for test: gem_exec_balancer results: parsing output: 92/ for test: syncobj_timeline results: parsing output: 93/ for test: kms_cursor_crc results: parsing output: 94/ for test: gem_mmap_offset results: parsing output: 95/ for test: kms_addfb_basic results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_fbcon_fbt results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: gem_exec_schedule results: parsing output: 102/ for test: perf_pmu results: parsing output: 103/ for test: kms_cursor_legacy results: parsing output: 104/ for test: perf results: parsing output: 105/ for test: kms_lease results: parsing output: 106/ for test: vgem_basic results: parsing output: 107/ for test: gem_ctx_param results: parsing output: 108/ for test: kms_big_fb results: parsing output: 109/ for test: kms_prime results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: syncobj_wait results: parsing output: 112/ for test: gem_render_copy_redux results: parsing output: 113/ for test: kms_big_fb results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_psr results: parsing output: 117/ for test: kms_atomic_transition results: parsing output: 118/ for test: gem_exec_schedule results: parsing output: 119/ for test: kms_big_fb results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: gem_exec_fence results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: syncobj_wait results: parsing output: 127/ for test: kms_color_pipeline results: parsing output: 128/ for test: kms_dither results: parsing output: 129/ for test: gem_userptr_blits results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: kms_pm_dc results: parsing output: 132/ for test: i915_hangman results: parsing output: 133/ for test: kms_flip_scaled_crc results: parsing output: 134/ for test: kms_frontbuffer_tracking results: parsing output: 135/ for test: gem_exec_params results: parsing output: 136/ for test: kms_busy results: parsing output: 137/ for test: kms_frontbuffer_tracking results: parsing output: 138/ for test: i915_drm_fdinfo results: parsing output: 139/ for test: gem_exec_flush results: parsing output: 140/ for test: syncobj_timeline results: parsing output: 141/ for test: prime_mmap results: parsing output: 142/ for test: kms_force_connector_basic results: parsing output: 143/ for test: kms_hdr results: parsing output: 144/ for test: kms_cursor_legacy results: parsing output: 145/ for test: gem_mmap_offset results: parsing output: 146/ for test: kms_plane results: parsing output: 147/ for test: kms_frontbuffer_tracking results: parsing output: 148/ for test: gem_exec_basic results: parsing output: 149/ for test: kms_frontbuffer_tracking results: parsing output: 150/ for test: kms_plane results: parsing output: 151/ for test: gem_lmem_swapping results: parsing output: 152/ for test: kms_big_fb results: parsing output: 153/ for test: kms_flip results: parsing output: 154/ for test: kms_cursor_legacy results: parsing output: 155/ for test: kms_flip Done.