[70.953507] Initializing watchdogs [70.953587] /dev/watchdog0 [70.983008] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics] [71.000880] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [71.005252] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [71.007816] [001/130] (960s left) kms_async_flips (test-time-stamp-atomic) [73.197373] Starting subtest: test-time-stamp-atomic [73.460598] Starting dynamic subtest: pipe-A-HDMI-A-4 [73.808122] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.347s) [74.009500] Starting dynamic subtest: pipe-B-HDMI-A-4 [74.106979] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.103s) [74.289567] Starting dynamic subtest: pipe-C-HDMI-A-4 [74.394131] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.110s) [74.571137] Starting dynamic subtest: pipe-D-HDMI-A-4 [74.673532] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.107s) [74.674376] Subtest test-time-stamp-atomic: SUCCESS (1.478s) [75.015493] [002/130] (956s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [77.017277] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [77.018931] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [77.174970] [003/130] (954s left) i915_pm_rps (engine-order) [77.252846] Starting subtest: engine-order [85.044148] Subtest engine-order: SUCCESS (7.791s) [85.226818] [004/130] (946s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render) [87.228878] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render [87.230672] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [87.383191] [005/130] (944s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move) [89.405236] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move [89.406900] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [89.626373] [006/130] (942s left) gem_exec_balancer (bonded-dual) [89.689997] Starting subtest: bonded-dual [89.691704] Subtest bonded-dual: SKIP (0.000s) [90.108717] [007/130] (941s left) gem_softpin (zero) [90.164460] Starting subtest: zero [90.171702] Subtest zero: SUCCESS (0.007s) [90.361378] [008/130] (941s left) perf (buffer-fill) [90.466984] Starting subtest: buffer-fill [90.467912] Starting dynamic subtest: 0-rcs0 [92.710531] Dynamic subtest 0-rcs0: SUCCESS (2.241s) [92.711518] Subtest buffer-fill: SUCCESS (2.241s) [92.774086] [009/130] (939s left) gem_exec_schedule (fairslice) [92.838307] Starting subtest: fairslice [92.839253] Starting dynamic subtest: rcs0 [94.875373] Dynamic subtest rcs0: SUCCESS (2.036s) [94.883605] Starting dynamic subtest: bcs0 [96.893244] Dynamic subtest bcs0: SUCCESS (2.018s) [96.901677] Starting dynamic subtest: vcs0 [98.909837] Dynamic subtest vcs0: SUCCESS (2.017s) [98.918401] Starting dynamic subtest: vcs1 [100.927366] Dynamic subtest vcs1: SUCCESS (2.018s) [100.935620] Starting dynamic subtest: vecs0 [102.943852] Dynamic subtest vecs0: SUCCESS (2.016s) [102.945059] Subtest fairslice: SUCCESS (10.106s) [103.315340] [010/130] (928s left) gem_lmem_swapping (heavy-multi) [108.522213] Starting subtest: heavy-multi [108.523008] Starting dynamic subtest: lmem0 [114.562915] Dynamic subtest lmem0: SUCCESS (6.038s) [114.563881] Subtest heavy-multi: SUCCESS (6.038s) [116.066018] [FACT gem_lmem_swapping (heavy-multi)] deleted: kernel.kmod_is_loaded.i915: true [116.067966] [011/130] (916s left) kms_flip (2x-flip-vs-suspend-interruptible) [124.740246] Starting subtest: 2x-flip-vs-suspend-interruptible [124.761429] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.018s) [124.978992] [FACT kms_flip (2x-flip-vs-suspend-interruptible)] new: kernel.kmod_is_loaded.amdgpu: true [124.979178] [FACT kms_flip (2x-flip-vs-suspend-interruptible)] new: kernel.kmod_is_loaded.i915: true [124.980597] [FACT kms_flip (2x-flip-vs-suspend-interruptible)] new: kernel.kmod_is_loaded.xe: true [124.985405] [012/130] (907s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt) [126.985865] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt [126.987804] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [127.195988] [013/130] (905s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy) [127.269871] Starting subtest: map-fixed-invalidate-overlap-busy [127.271763] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s) [127.478049] [014/130] (905s left) kms_pipe_crc_basic (hang-read-crc) [129.470342] Starting subtest: hang-read-crc [129.471205] Starting dynamic subtest: pipe-A-HDMI-A-4 [130.854911] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (1.384s) [130.867828] Starting dynamic subtest: pipe-B-HDMI-A-4 [131.974184] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (1.118s) [131.984231] Starting dynamic subtest: pipe-C-HDMI-A-4 [133.130572] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (1.155s) [133.140595] Starting dynamic subtest: pipe-D-HDMI-A-4 [134.257217] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (1.125s) [134.258071] Subtest hang-read-crc: SUCCESS (4.788s) [134.434092] [015/130] (898s left) gem_exec_reloc (basic-cpu-gtt) [134.489773] Subtest basic-cpu-gtt: SKIP (0.000s) [134.606576] [016/130] (898s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-blt) [136.607413] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-blt [136.609089] Subtest fbcpsr-1p-offscren-pri-indfb-draw-blt: SKIP (0.000s) [136.808031] [017/130] (896s left) core_getversion (all-cards) [136.858303] Starting subtest: all-cards [136.877046] Subtest all-cards: SUCCESS (0.020s) [136.946224] [018/130] (895s left) gem_softpin (noreloc-s3) [137.002315] Starting subtest: noreloc-S3 [157.847334] Subtest noreloc-S3: SUCCESS (9.949s) [162.994403] [019/130] (885s left) kms_dsc (dsc-basic) [164.991554] Starting subtest: dsc-basic [164.997165] Subtest dsc-basic: SKIP (0.000s) [165.112425] [020/130] (883s left) kms_cursor_legacy (cursorb-vs-flipb-legacy) [167.125236] Starting subtest: cursorB-vs-flipB-legacy [167.127875] Subtest cursorB-vs-flipB-legacy: SKIP (0.002s) [167.245789] [021/130] (881s left) gem_ctx_persistence (legacy-engines-hostile-preempt) [167.326154] Starting subtest: legacy-engines-hostile-preempt [167.327137] Starting dynamic subtest: render [167.407137] Dynamic subtest render: SUCCESS (0.080s) [167.424107] Starting dynamic subtest: bsd1 [167.448242] Dynamic subtest bsd1: SUCCESS (0.040s) [167.474605] Starting dynamic subtest: bsd2 [167.517808] Dynamic subtest bsd2: SUCCESS (0.068s) [167.556873] Starting dynamic subtest: blt [167.592156] Dynamic subtest blt: SUCCESS (0.073s) [167.616199] Starting dynamic subtest: vebox [167.644379] Dynamic subtest vebox: SUCCESS (0.051s) [167.645841] Subtest legacy-engines-hostile-preempt: SUCCESS (0.318s) [167.845225] [022/130] (881s left) kms_color (ctm-max) [169.837140] Starting subtest: ctm-max [169.838185] Starting dynamic subtest: pipe-A-HDMI-A-4 [170.524291] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.687s) [170.535056] Starting dynamic subtest: pipe-B-HDMI-A-4 [171.046708] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.523s) [171.058510] Starting dynamic subtest: pipe-C-HDMI-A-4 [171.565459] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.518s) [171.577608] Starting dynamic subtest: pipe-D-HDMI-A-4 [172.090586] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.525s) [172.091634] Subtest ctm-max: SUCCESS (2.254s) [172.262479] [023/130] (876s left) kms_addfb_basic (too-wide) [174.261125] Starting subtest: too-wide [174.262007] Subtest too-wide: SUCCESS (0.000s) [174.458274] [024/130] (874s left) gem_softpin (evict-prime-sanity-check) [174.520084] Starting subtest: evict-prime-sanity-check [174.520987] Starting dynamic subtest: rcs0 [175.651004] Dynamic subtest rcs0: SUCCESS (1.131s) [175.661633] Starting dynamic subtest: bcs0 [176.768021] Dynamic subtest bcs0: SUCCESS (1.117s) [176.779104] Starting dynamic subtest: vcs0 [177.889092] Dynamic subtest vcs0: SUCCESS (1.121s) [177.900639] Starting dynamic subtest: vcs1 [179.008021] Dynamic subtest vcs1: SUCCESS (1.119s) [179.019291] Starting dynamic subtest: vecs0 [180.125013] Dynamic subtest vecs0: SUCCESS (1.117s) [180.135961] Starting dynamic subtest: all [181.249074] Dynamic subtest all: SUCCESS (1.124s) [181.250206] Subtest evict-prime-sanity-check: SUCCESS (6.729s) [181.388383] [025/130] (868s left) gem_mmap_gtt (basic-copy) [181.439929] Subtest basic-copy: SKIP (0.000s) [181.503195] [026/130] (867s left) gem_mmap_gtt (close-race) [181.552302] Subtest close-race: SKIP (0.000s) [181.620640] [027/130] (867s left) gem_pxp (create-regular-context-2) [184.192574] Starting subtest: create-regular-context-2 [184.194979] Subtest create-regular-context-2: SKIP (0.000s) [184.300694] [028/130] (865s left) kms_atomic (test-only) [186.294896] Starting subtest: test-only [186.568728] Starting dynamic subtest: pipe-A-HDMI-A-4 [187.048784] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.480s) [187.049969] Subtest test-only: SUCCESS (0.753s) [187.219400] [029/130] (862s left) gem_close (basic) [187.274200] Starting subtest: basic [187.275031] Subtest basic: SUCCESS (0.000s) [187.396696] [030/130] (862s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [189.394543] Starting subtest: primary-x-tiled-reflect-x-180 [200.078880] Subtest primary-x-tiled-reflect-x-180: SUCCESS (10.678s) [200.306564] [031/130] (849s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling) [202.306525] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling [202.307431] Starting dynamic subtest: pipe-A-valid-mode [202.356280] Dynamic subtest pipe-A-valid-mode: SKIP (0.048s) [202.357994] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.049s) [202.493337] [032/130] (847s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [204.512339] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [205.062096] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.550s) [205.274271] [033/130] (844s left) perf_pmu (most-busy-check-all) [205.328210] Starting subtest: most-busy-check-all [205.329047] Starting dynamic subtest: rcs0 [205.894029] Dynamic subtest rcs0: SUCCESS (0.565s) [205.907330] Starting dynamic subtest: bcs0 [206.441823] Dynamic subtest bcs0: SUCCESS (0.547s) [206.454627] Starting dynamic subtest: vcs0 [206.988875] Dynamic subtest vcs0: SUCCESS (0.546s) [207.001086] Starting dynamic subtest: vcs1 [207.536816] Dynamic subtest vcs1: SUCCESS (0.547s) [207.549348] Starting dynamic subtest: vecs0 [208.084625] Dynamic subtest vecs0: SUCCESS (0.547s) [208.085673] Subtest most-busy-check-all: SUCCESS (2.755s) [208.197021] [034/130] (841s left) gem_eio (suspend) [208.362591] Starting subtest: suspend [221.032925] Subtest suspend: SUCCESS (12.668s) [227.356243] [035/130] (826s left) gem_exec_fence (syncobj-unused-fence) [227.850389] Starting subtest: syncobj-unused-fence [227.866234] Subtest syncobj-unused-fence: SUCCESS (0.016s) [228.260000] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true [228.262641] [036/130] (825s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc) [230.265617] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc [230.267482] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [230.463823] [037/130] (823s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [230.519260] Subtest writes-after-reads-uncached: SKIP (0.000s) [230.627735] [038/130] (823s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [232.630797] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [235.716969] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.089s) [235.946372] [039/130] (818s left) gem_exec_schedule (pi-userfault) [236.133978] Starting subtest: pi-userfault [236.134982] Starting dynamic subtest: rcs0 [236.143599] Dynamic subtest rcs0: SUCCESS (0.010s) [236.156243] Starting dynamic subtest: bcs0 [236.157161] Dynamic subtest bcs0: SUCCESS (0.007s) [236.169798] Starting dynamic subtest: vcs0 [236.170796] Dynamic subtest vcs0: SUCCESS (0.008s) [236.183022] Starting dynamic subtest: vcs1 [236.184107] Dynamic subtest vcs1: SUCCESS (0.007s) [236.195197] Starting dynamic subtest: vecs0 [236.196367] Dynamic subtest vecs0: SUCCESS (0.006s) [236.197512] Subtest pi-userfault: SUCCESS (0.041s) [236.450960] [040/130] (818s left) gem_exec_reloc (basic-gtt-wc-noreloc) [236.507102] Subtest basic-gtt-wc-noreloc: SKIP (0.000s) [236.606688] [041/130] (817s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [238.609857] Starting subtest: fbc-1p-pri-indfb-multidraw [247.580251] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (8.972s) [247.783090] [042/130] (806s left) kms_frontbuffer_tracking (fbc-2p-rte) [249.782639] Starting subtest: fbc-2p-rte [249.784366] Subtest fbc-2p-rte: SKIP (0.000s) [249.962284] [043/130] (804s left) gem_render_copy (x-tiled-to-vebox-yf-tiled) [250.028898] Starting subtest: x-tiled-to-vebox-yf-tiled [250.029824] Starting dynamic subtest: smem [250.109964] Dynamic subtest smem: SUCCESS (0.082s) [250.121419] Starting dynamic subtest: lmem0 [250.872938] Dynamic subtest lmem0: SUCCESS (0.759s) [250.873930] Subtest x-tiled-to-vebox-yf-tiled: SUCCESS (0.842s) [251.130710] [044/130] (803s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [253.134085] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu [253.135917] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [253.355897] [045/130] (801s left) gem_basic (bad-close) [253.403855] Starting subtest: bad-close [253.405735] Subtest bad-close: SUCCESS (0.000s) [253.519102] [046/130] (801s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs) [255.518858] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs [255.519789] Starting dynamic subtest: pipe-A-HDMI-A-4 [255.529673] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s) [255.541250] Starting dynamic subtest: pipe-B-HDMI-A-4 [255.551309] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s) [255.562329] Starting dynamic subtest: pipe-C-HDMI-A-4 [255.572112] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s) [255.582886] Starting dynamic subtest: pipe-D-HDMI-A-4 [255.593086] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s) [255.595065] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.007s) [255.748600] [047/130] (799s left) kms_setmode (clone-exclusive-crtc) [255.798849] Starting subtest: clone-exclusive-crtc [255.802277] Subtest clone-exclusive-crtc: SKIP (0.000s) [255.910650] [048/130] (799s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move) [257.912498] Starting subtest: psr-1p-primscrn-cur-indfb-move [257.914137] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [258.125036] [049/130] (797s left) kms_invalid_mode (bad-hsync-start) [260.123335] Starting subtest: bad-hsync-start [260.124251] Starting dynamic subtest: pipe-A-HDMI-A-4 [260.157609] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.036s) [260.170162] Starting dynamic subtest: pipe-B-HDMI-A-4 [260.171009] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s) [260.182272] Starting dynamic subtest: pipe-C-HDMI-A-4 [260.183076] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s) [260.193600] Starting dynamic subtest: pipe-D-HDMI-A-4 [260.194479] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s) [260.195302] Subtest bad-hsync-start: SUCCESS (0.045s) [260.336920] [050/130] (795s left) prime_vgem (shrink) [260.425747] Starting subtest: shrink [260.437029] Subtest shrink: SUCCESS (0.011s) [260.611801] [051/130] (794s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format) [262.609135] Starting subtest: plane-scaler-unity-scaling-with-pixel-format [262.610170] Starting dynamic subtest: pipe-A [265.299549] Dynamic subtest pipe-A: SUCCESS (2.691s) [265.318407] Starting dynamic subtest: pipe-B [267.972205] Dynamic subtest pipe-B: SUCCESS (2.672s) [267.986030] Starting dynamic subtest: pipe-C [268.262994] Dynamic subtest pipe-C: SUCCESS (0.289s) [268.296760] Starting dynamic subtest: pipe-D [268.568646] Dynamic subtest pipe-D: SUCCESS (0.303s) [268.570284] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.962s) [268.770007] [052/130] (786s left) gem_exec_balancer (persistence) [269.108723] Starting subtest: persistence [270.690332] Subtest persistence: SUCCESS (1.579s) [270.886910] [053/130] (784s left) kms_writeback (writeback-check-output-xrgb2101010) [272.888045] Subtest writeback-check-output-XRGB2101010: SKIP (0.000s) [272.964675] [054/130] (782s left) kms_big_fb (y-tiled-16bpp-rotate-180) [274.978018] Starting subtest: y-tiled-16bpp-rotate-180 [276.726953] Subtest y-tiled-16bpp-rotate-180: SUCCESS (1.745s) [276.947242] [055/130] (778s left) gem_create (create-ext-set-pat) [277.115433] Starting subtest: create-ext-set-pat [277.117590] Subtest create-ext-set-pat: SKIP (0.000s) [277.232111] [056/130] (778s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [279.234842] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [279.236866] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [279.435142] [057/130] (776s left) gem_busy (semaphore) [279.694332] Subtest semaphore: SKIP (0.000s) [280.044599] [058/130] (775s left) kms_prop_blob (blob-prop-lifetime) [280.096416] Starting subtest: blob-prop-lifetime [280.097244] Subtest blob-prop-lifetime: SUCCESS (0.001s) [280.212057] [059/130] (775s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled) [280.262509] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled [280.374480] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s) [280.492390] [060/130] (775s left) i915_pm_freq_mult (media-freq) [280.542857] Starting subtest: media-freq [280.543747] Starting dynamic subtest: gt0 [280.545703] Dynamic subtest gt0: SKIP (0.000s) [280.547709] Subtest media-freq: SKIP (0.001s) [280.664870] [061/130] (775s left) kms_chamelium_edid (dp-edid-resolution-list) [282.710330] Subtest dp-edid-resolution-list: SKIP (0.000s) [282.816178] [062/130] (773s left) kms_cursor_crc (cursor-onscreen-512x170) [285.039376] Starting subtest: cursor-onscreen-512x170 [285.042520] Subtest cursor-onscreen-512x170: SKIP (0.001s) [285.257262] [063/130] (771s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [287.259905] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [287.261917] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [287.449560] [064/130] (769s left) kms_psr (psr2-sprite-mmap-gtt) [289.451769] Subtest psr2-sprite-mmap-gtt: SKIP (0.000s) [289.529982] [065/130] (767s left) kms_flip (blocking-wf_vblank) [291.527264] Starting subtest: blocking-wf_vblank [291.535300] Starting dynamic subtest: A-HDMI-A4 [299.696319] Dynamic subtest A-HDMI-A4: SUCCESS (8.161s) [299.715329] Starting dynamic subtest: B-HDMI-A4 [307.803284] Dynamic subtest B-HDMI-A4: SUCCESS (8.106s) [307.816988] Starting dynamic subtest: C-HDMI-A4 [315.910781] Dynamic subtest C-HDMI-A4: SUCCESS (8.106s) [315.924742] Starting dynamic subtest: D-HDMI-A4 [324.018938] Dynamic subtest D-HDMI-A4: SUCCESS (8.107s) [324.019890] Subtest blocking-wf_vblank: SUCCESS (32.495s) [324.220153] [066/130] (732s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt) [326.221800] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt [326.223392] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [326.416123] [067/130] (730s left) kms_cursor_edge_walk (256x256-right-edge) [328.415171] Starting subtest: 256x256-right-edge [328.416038] Starting dynamic subtest: pipe-A-HDMI-A-4 [331.709004] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.293s) [331.722187] Starting dynamic subtest: pipe-D-HDMI-A-4 [334.901488] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.189s) [334.902280] Subtest 256x256-right-edge: SUCCESS (6.486s) [335.069998] [068/130] (721s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [337.083966] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [337.085897] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [337.244510] [069/130] (719s left) perf (non-zero-reason) [337.387019] Starting subtest: non-zero-reason [337.387937] Starting dynamic subtest: 0-rcs0 [348.388102] Dynamic subtest 0-rcs0: SUCCESS (10.998s) [348.389374] Subtest non-zero-reason: SUCCESS (10.999s) [348.467818] [070/130] (708s left) kms_lease (invalid-create-leases) [350.477659] Starting subtest: invalid-create-leases [350.499548] Subtest invalid-create-leases: SUCCESS (0.022s) [350.681725] [071/130] (706s left) kms_psr (fbc-psr2-primary-render) [352.679323] Subtest fbc-psr2-primary-render: SKIP (0.000s) [352.761978] [072/130] (704s left) vgem_basic (sysfs) [352.821253] Starting subtest: sysfs [352.822152] Subtest sysfs: SUCCESS (0.000s) [352.941610] [073/130] (704s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt) [354.944188] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt [354.945651] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [355.083908] [074/130] (702s left) drm_read (short-buffer-nonblock) [357.138137] Starting subtest: short-buffer-nonblock [357.139088] Subtest short-buffer-nonblock: SUCCESS (0.000s) [357.417209] [075/130] (700s left) kms_psr (fbc-pr-sprite-plane-onoff) [359.418314] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s) [359.493914] [076/130] (698s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs) [361.492999] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs [361.494741] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s) [361.686976] [077/130] (695s left) syncobj_timeline (invalid-query-zero-handles) [361.739875] Starting subtest: invalid-query-zero-handles [361.740896] Subtest invalid-query-zero-handles: SUCCESS (0.000s) [361.854627] [078/130] (695s left) core_auth (many-magics) [361.906990] Starting subtest: many-magics [362.740487] Subtest many-magics: SUCCESS (0.832s) [362.919274] [079/130] (694s left) intel_hwmon (hwmon-write) [362.969912] Starting subtest: hwmon-write [362.989706] Subtest hwmon-write: SUCCESS (0.020s) [363.100948] [080/130] (694s left) perf (per-context-mode-unprivileged) [363.215192] Starting subtest: per-context-mode-unprivileged [363.217084] Subtest per-context-mode-unprivileged: SKIP (0.000s) [363.294310] [081/130] (694s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size) [365.293119] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size [366.288409] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.991s) [366.484294] [082/130] (691s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render) [368.484827] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render [371.420867] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (2.936s) [371.650802] [083/130] (686s left) kms_cursor_crc (cursor-offscreen-32x10) [373.714213] Starting subtest: cursor-offscreen-32x10 [373.761752] Subtest cursor-offscreen-32x10: SKIP (0.045s) [374.168991] [084/130] (684s left) kms_flip (2x-busy-flip) [376.166080] Starting subtest: 2x-busy-flip [376.183237] Subtest 2x-busy-flip: SKIP (0.018s) [376.328720] [085/130] (681s left) gem_exec_store (pages) [376.397501] Starting subtest: pages [376.398527] Starting dynamic subtest: rcs0 [376.537143] Dynamic subtest rcs0: SUCCESS (0.139s) [376.556547] Starting dynamic subtest: bcs0 [376.664779] Dynamic subtest bcs0: SUCCESS (0.126s) [376.678163] Starting dynamic subtest: vcs0 [376.781911] Dynamic subtest vcs0: SUCCESS (0.116s) [376.795107] Starting dynamic subtest: vcs1 [376.883753] Dynamic subtest vcs1: SUCCESS (0.101s) [376.896937] Starting dynamic subtest: vecs0 [376.986741] Dynamic subtest vecs0: SUCCESS (0.102s) [376.987881] Subtest pages: SUCCESS (0.590s) [377.299583] [086/130] (681s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt) [379.306013] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt [382.302147] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (2.998s) [382.543680] [087/130] (675s left) syncobj_timeline (single-wait-all-available-signaled) [382.595949] Starting subtest: single-wait-all-available-signaled [382.597044] Subtest single-wait-all-available-signaled: SUCCESS (0.000s) [382.703391] [088/130] (675s left) api_intel_bb (full-batch) [382.754938] Starting subtest: full-batch [382.770349] Subtest full-batch: SUCCESS (0.016s) [382.973875] [089/130] (675s left) gem_ctx_persistence (engines-hang) [383.029817] Starting subtest: engines-hang [383.030915] Starting dynamic subtest: rcs0 [383.147723] Dynamic subtest rcs0: SUCCESS (0.116s) [383.198292] Starting dynamic subtest: bcs0 [383.227228] Dynamic subtest bcs0: SUCCESS (0.074s) [383.246881] Starting dynamic subtest: vcs0 [383.309468] Dynamic subtest vcs0: SUCCESS (0.079s) [383.358443] Starting dynamic subtest: vcs1 [383.391050] Dynamic subtest vcs1: SUCCESS (0.076s) [383.412664] Starting dynamic subtest: vecs0 [383.429127] Dynamic subtest vecs0: SUCCESS (0.036s) [383.430292] Subtest engines-hang: SUCCESS (0.400s) [383.603658] [090/130] (675s left) gem_exec_params (invalid-bsd2-flag-on-render) [383.658050] Starting subtest: invalid-bsd2-flag-on-render [383.658968] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s) [383.815454] [091/130] (675s left) kms_cursor_crc (cursor-rapid-movement-512x170) [386.032607] Starting subtest: cursor-rapid-movement-512x170 [386.035734] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [386.291611] [092/130] (672s left) gem_exec_reloc (basic-wc) [386.347728] Subtest basic-wc: SKIP (0.000s) [386.467540] [093/130] (672s left) kms_chamelium_frames (hdmi-frame-dump) [388.506808] Subtest hdmi-frame-dump: SKIP (0.000s) [388.614377] [094/130] (670s left) kms_psr (psr-suspend) [390.608553] Subtest psr-suspend: SKIP (0.000s) [390.679390] [095/130] (668s left) gem_exec_flush (basic-batch-kernel-default-cmd) [390.735945] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s) [390.835691] [096/130] (668s left) kms_cursor_legacy (flip-vs-cursor-toggle) [392.830276] Starting subtest: flip-vs-cursor-toggle [405.089997] Subtest flip-vs-cursor-toggle: SUCCESS (12.257s) [405.275339] [097/130] (653s left) gem_pipe_control_store_loop (fresh-buffer) [405.330711] Starting subtest: fresh-buffer [407.495949] Subtest fresh-buffer: SUCCESS (2.162s) [407.676760] [098/130] (651s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc) [409.675287] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc [409.676131] Starting dynamic subtest: pipe-A-HDMI-A-4 [409.684927] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s) [409.696647] Starting dynamic subtest: pipe-B-HDMI-A-4 [409.705578] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s) [409.717099] Starting dynamic subtest: pipe-C-HDMI-A-4 [409.726120] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s) [409.737294] Starting dynamic subtest: pipe-D-HDMI-A-4 [409.746522] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s) [409.748190] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.013s) [409.920999] [099/130] (649s left) syncobj_wait (multi-wait-for-submit-submitted) [409.972238] Starting subtest: multi-wait-for-submit-submitted [410.078123] Subtest multi-wait-for-submit-submitted: SUCCESS (0.102s) [410.254397] [100/130] (649s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [412.253031] Starting subtest: primary-4-tiled-reflect-x-180 [412.357874] Subtest primary-4-tiled-reflect-x-180: SKIP (0.104s) [412.585203] [101/130] (647s left) syncobj_timeline (invalid-single-wait-unsubmitted) [412.636958] Starting subtest: invalid-single-wait-unsubmitted [412.637882] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [412.775615] [102/130] (646s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs) [414.773654] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs [414.776722] Starting dynamic subtest: pipe-A-HDMI-A-4 [414.785907] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s) [414.797522] Starting dynamic subtest: pipe-B-HDMI-A-4 [414.806550] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s) [414.817996] Starting dynamic subtest: pipe-C-HDMI-A-4 [414.827730] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s) [414.839131] Starting dynamic subtest: pipe-D-HDMI-A-4 [414.848887] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s) [414.850724] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.013s) [415.016629] [103/130] (644s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [415.067677] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [415.173203] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s) [415.344461] [104/130] (644s left) kms_big_fb (x-tiled-32bpp-rotate-90) [417.357481] Starting subtest: x-tiled-32bpp-rotate-90 [417.446600] Subtest x-tiled-32bpp-rotate-90: SKIP (0.088s) [417.599610] [105/130] (642s left) fbdev (nullptr) [417.669330] Starting subtest: nullptr [417.670243] Subtest nullptr: SUCCESS (0.000s) [417.769172] [106/130] (642s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [419.767121] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs [419.768038] Starting dynamic subtest: pipe-A-HDMI-A-4 [419.776340] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s) [419.788432] Starting dynamic subtest: pipe-B-HDMI-A-4 [419.797018] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s) [419.808618] Starting dynamic subtest: pipe-C-HDMI-A-4 [419.817306] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s) [419.828681] Starting dynamic subtest: pipe-D-HDMI-A-4 [419.837522] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s) [419.839240] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.010s) [420.011661] [107/130] (640s left) gen7_exec_parse (cmd-crossing-page) [420.068179] Subtest cmd-crossing-page: SKIP (0.000s) [420.157521] [108/130] (639s left) gem_exec_reloc (basic-write-wc) [420.213089] Subtest basic-write-wc: SKIP (0.000s) [420.304573] [109/130] (639s left) kms_psr2_su (page_flip-nv12) [420.358436] Subtest page_flip-NV12: SKIP (0.000s) [420.437987] [110/130] (639s left) kms_pm_rpm (dpms-mode-unset-lpsp) [425.028035] Starting subtest: dpms-mode-unset-lpsp [426.223253] Subtest dpms-mode-unset-lpsp: SKIP (1.196s) [427.508434] [111/130] (632s left) gem_exec_fence (concurrent) [427.748476] Starting subtest: concurrent [427.750853] Subtest concurrent: SKIP (0.000s) [428.440451] [112/130] (631s left) gem_exec_whisper (basic-contexts-priority) [428.505256] Starting subtest: basic-contexts-priority [444.572524] Subtest basic-contexts-priority: SUCCESS (16.063s) [444.872119] [113/130] (615s left) kms_vblank (ts-continuation-dpms-suspend) [446.871279] Starting subtest: ts-continuation-dpms-suspend [446.872259] Starting dynamic subtest: pipe-A-HDMI-A-4 [468.460145] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (10.047s) [468.475362] Starting dynamic subtest: pipe-D-HDMI-A-4 [489.441471] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (9.470s) [489.442339] Subtest ts-continuation-dpms-suspend: SUCCESS (19.524s) [494.655047] [114/130] (594s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area) [496.663354] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [496.730370] [115/130] (592s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip) [498.747092] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip [499.972400] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.224s) [500.223059] [116/130] (588s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers) [502.221236] Starting subtest: plane-downscale-factor-0-75-with-modifiers [502.222251] Starting dynamic subtest: pipe-A [502.970081] Dynamic subtest pipe-A: SUCCESS (0.750s) [502.990871] Starting dynamic subtest: pipe-B [503.726405] Dynamic subtest pipe-B: SUCCESS (0.754s) [503.746469] Starting dynamic subtest: pipe-C [504.483647] Dynamic subtest pipe-C: SUCCESS (0.755s) [504.505776] Starting dynamic subtest: pipe-D [505.240398] Dynamic subtest pipe-D: SUCCESS (0.755s) [505.241457] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (3.022s) [505.441651] [117/130] (583s left) kms_frontbuffer_tracking (fbcpsr-tiling-4) [507.440552] Starting subtest: fbcpsr-tiling-4 [507.442345] Subtest fbcpsr-tiling-4: SKIP (0.000s) [507.639337] [118/130] (581s left) gem_mmap_wc (bad-object) [507.713045] Subtest bad-object: SKIP (0.000s) [507.785116] [119/130] (581s left) perf_pmu (frequency) [507.840187] Starting subtest: frequency [507.843698] Starting dynamic subtest: gt0 [510.101122] Dynamic subtest gt0: FAIL (2.151s) [510.142348] Starting dynamic subtest: idle-gt0 [510.506567] Dynamic subtest idle-gt0: SUCCESS (0.504s) [510.507474] Subtest frequency: FAIL (2.667s) [510.642776] [120/130] (578s left) syncobj_wait (invalid-single-wait-all-unsubmitted) [510.692472] Starting subtest: invalid-single-wait-all-unsubmitted [510.693477] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [510.808626] [121/130] (578s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-25) [512.808846] Starting subtest: planes-upscale-20x20-downscale-factor-0-25 [512.809830] Starting dynamic subtest: pipe-A [513.314341] Dynamic subtest pipe-A: SKIP (0.504s) [513.326552] Starting dynamic subtest: pipe-B [514.003279] Dynamic subtest pipe-B: SKIP (0.687s) [514.015550] Starting dynamic subtest: pipe-C [514.695365] Dynamic subtest pipe-C: SKIP (0.689s) [514.707732] Starting dynamic subtest: pipe-D [515.382430] Dynamic subtest pipe-D: SKIP (0.687s) [515.384138] Subtest planes-upscale-20x20-downscale-factor-0-25: SKIP (2.573s) [515.523610] [122/130] (573s left) kms_big_fb (yf-tiled-32bpp-rotate-90) [517.544111] Starting subtest: yf-tiled-32bpp-rotate-90 [517.545807] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s) [517.672893] [123/130] (571s left) syncobj_timeline (wait-zero-handles) [517.725941] Starting subtest: wait-zero-handles [517.726807] Subtest wait-zero-handles: SUCCESS (0.000s) [517.839460] [124/130] (571s left) kms_frontbuffer_tracking (psr-suspend) [519.843126] Starting subtest: psr-suspend [519.845047] Subtest psr-suspend: SKIP (0.000s) [520.044362] [125/130] (569s left) i915_fb_tiling (basic-x-tiling) [520.097229] Subtest basic-x-tiling: SKIP (0.000s) [520.192089] [126/130] (569s left) kms_psr (pr-primary-mmap-gtt) [522.194671] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [522.265178] [127/130] (567s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite) [524.271224] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite [524.273174] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [524.473726] [128/130] (565s left) dmabuf_sync_file (export-before-signal) [524.525618] Starting subtest: export-before-signal [524.526629] Subtest export-before-signal: SUCCESS (0.001s) [524.631290] [129/130] (565s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [524.683205] Starting subtest: multi-wait-all-for-submit-submitted-signaled [524.791104] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s) [524.950667] [130/130] (565s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling) [526.949906] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling [526.950745] Starting dynamic subtest: pipe-A-valid-mode [528.131497] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.181s) [528.132416] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (1.183s) [528.292417] Closing watchdogs Done.