[60.628789] Initializing watchdogs [60.628854] /dev/watchdog0 [60.647350] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [60.656962] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [60.660653] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.663090] [001/129] (960s left) gem_sync (basic-many-each) [60.833105] Starting subtest: basic-many-each [63.248473] Subtest basic-many-each: SUCCESS (2.406s) [63.517759] [002/129] (957s left) kms_addfb_basic (basic-x-tiled-legacy) [63.589962] Starting subtest: basic-x-tiled-legacy [63.591683] Subtest basic-x-tiled-legacy: SKIP (0.000s) [63.852269] [003/129] (957s left) syncobj_timeline (reset-multiple-signaled) [63.923629] Starting subtest: reset-multiple-signaled [63.924795] Subtest reset-multiple-signaled: SUCCESS (0.001s) [64.092215] [004/129] (957s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs) [64.289210] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs [64.291070] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s) [64.576697] [005/129] (956s left) gem_media_fill (media-fill) [64.649067] Subtest media-fill: SKIP (0.000s) [64.765648] [006/129] (956s left) gem_exec_balancer (sequential) [64.853581] Starting subtest: sequential [70.551398] Subtest sequential: SUCCESS (5.685s) [70.929406] [007/129] (950s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf) [71.136548] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s) [71.174978] [008/129] (950s left) gem_ctx_param (set-priority-range) [71.245345] Starting subtest: set-priority-range [71.269434] Subtest set-priority-range: SUCCESS (0.024s) [71.435038] [009/129] (950s left) kms_chamelium_audio (hdmi-audio) [71.702949] Subtest hdmi-audio: SKIP (0.000s) [71.847207] [010/129] (949s left) kms_cursor_crc (cursor-offscreen-256x256) [72.221515] Starting subtest: cursor-offscreen-256x256 [72.225973] Starting dynamic subtest: pipe-A-DP-3 [74.761322] Dynamic subtest pipe-A-DP-3: SUCCESS (2.532s) [74.798373] Starting dynamic subtest: pipe-D-DP-3 [77.284192] Dynamic subtest pipe-D-DP-3: SUCCESS (2.490s) [77.285184] Subtest cursor-offscreen-256x256: SUCCESS (5.057s) [77.657088] [011/129] (944s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [77.856540] Starting subtest: basic-flip-after-cursor-legacy [78.862297] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.004s) [79.126782] [012/129] (942s left) gem_ctx_persistence (idempotent) [79.204638] Starting subtest: idempotent [79.205707] Subtest idempotent: SUCCESS (0.000s) [79.359739] [013/129] (942s left) api_intel_allocator (reloc-allocator) [79.432907] Starting subtest: reloc-allocator [79.433804] Starting dynamic subtest: basic [79.456492] Dynamic subtest basic: SUCCESS (0.024s) [79.464291] Starting dynamic subtest: parallel-one [79.465163] Dynamic subtest parallel-one: SUCCESS (0.006s) [79.472445] Starting dynamic subtest: print [79.473354] Dynamic subtest print: SUCCESS (0.000s) [79.480924] Starting dynamic subtest: reuse [79.481878] Dynamic subtest reuse: SUCCESS (0.000s) [79.489427] Starting dynamic subtest: fork-reopen-allocator [79.490402] Dynamic subtest fork-reopen-allocator: SUCCESS (0.016s) [79.491408] Subtest reloc-allocator: SUCCESS (0.046s) [79.665876] [014/129] (942s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-render) [79.869490] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-render [82.156839] Subtest fbc-1p-offscren-pri-shrfb-draw-render: SUCCESS (2.287s) [82.328675] [015/129] (939s left) gem_lmem_swapping (heavy-random) [85.085959] Starting subtest: heavy-random [85.086927] Starting dynamic subtest: lmem0 [89.966892] Dynamic subtest lmem0: SUCCESS (4.879s) [89.967882] Subtest heavy-random: SUCCESS (4.879s) [91.525265] [FACT gem_lmem_swapping (heavy-random)] deleted: kernel.kmod_is_loaded.i915: true [91.526951] [016/129] (930s left) gem_userptr_blits (unsync-unmap-after-close) [93.037586] Subtest unsync-unmap-after-close: SKIP (0.000s) [93.126572] [FACT gem_userptr_blits (unsync-unmap-after-close)] new: kernel.kmod_is_loaded.i915: true [93.129258] [017/129] (929s left) kms_flip (2x-flip-vs-suspend-interruptible) [93.337150] Starting subtest: 2x-flip-vs-suspend-interruptible [93.352282] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.014s) [93.463728] [018/129] (928s left) gem_create (create-ext-set-pat) [93.665492] Starting subtest: create-ext-set-pat [93.669124] Subtest create-ext-set-pat: SKIP (0.000s) [93.762411] [019/129] (928s left) gem_exec_parallel (basic) [93.847229] Starting subtest: basic [93.848190] Starting dynamic subtest: rcs0 [95.429051] Dynamic subtest rcs0: SUCCESS (1.581s) [95.437419] Starting dynamic subtest: bcs0 [96.925479] Dynamic subtest bcs0: SUCCESS (1.496s) [96.934618] Starting dynamic subtest: vcs0 [98.441192] Dynamic subtest vcs0: SUCCESS (1.515s) [98.449230] Starting dynamic subtest: vcs1 [99.932604] Dynamic subtest vcs1: SUCCESS (1.491s) [99.941375] Starting dynamic subtest: vecs0 [101.429528] Dynamic subtest vecs0: SUCCESS (1.496s) [101.437572] Starting dynamic subtest: vecs1 [102.939525] Dynamic subtest vecs1: SUCCESS (1.509s) [102.947567] Starting dynamic subtest: ccs0 [104.442487] Dynamic subtest ccs0: SUCCESS (1.502s) [104.443591] Subtest basic: SUCCESS (10.593s) [104.759957] [020/129] (917s left) gem_exec_whisper (basic-sync-all) [104.841325] Starting subtest: basic-sync-all [109.545163] Subtest basic-sync-all: SUCCESS (4.702s) [109.801602] [021/129] (912s left) syncobj_timeline (wait-zero-handles) [109.872527] Starting subtest: wait-zero-handles [109.873446] Subtest wait-zero-handles: SUCCESS (0.000s) [109.999961] [022/129] (912s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [110.200491] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [110.202243] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [110.362303] [023/129] (912s left) template (b) [110.432958] Starting subtest: B [110.433890] Subtest B: SUCCESS (0.000s) [110.583781] [024/129] (912s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions) [110.781468] Starting subtest: cursor-vs-flip-atomic-transitions [141.571550] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.786s) [141.815385] [025/129] (880s left) kms_chamelium_color (ctm-red-to-blue) [142.013459] Subtest ctm-red-to-blue: SKIP (0.000s) [142.074384] [026/129] (880s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc) [142.283610] Starting subtest: psr-rgb101010-draw-mmap-wc [142.285301] Subtest psr-rgb101010-draw-mmap-wc: SKIP (0.000s) [142.430190] [027/129] (880s left) kms_cursor_legacy (forked-move) [142.633430] Starting subtest: forked-move [142.634442] Starting dynamic subtest: pipe-A [148.057015] Dynamic subtest pipe-A: SUCCESS (5.421s) [148.069671] Starting dynamic subtest: pipe-B [153.502411] Dynamic subtest pipe-B: SUCCESS (5.446s) [153.521882] Starting dynamic subtest: pipe-C [158.955536] Dynamic subtest pipe-C: SUCCESS (5.453s) [158.975948] Starting dynamic subtest: pipe-D [164.397176] Dynamic subtest pipe-D: SUCCESS (5.441s) [164.417787] Starting dynamic subtest: all-pipes [169.833492] Dynamic subtest all-pipes: SUCCESS (5.437s) [169.834423] Subtest forked-move: SUCCESS (27.199s) [169.933746] [028/129] (853s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs) [170.135130] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs [170.136059] Starting dynamic subtest: pipe-A-DP-3 [176.740631] Dynamic subtest pipe-A-DP-3: SUCCESS (6.603s) [176.755443] Starting dynamic subtest: pipe-B-DP-3 [178.309675] Dynamic subtest pipe-B-DP-3: SUCCESS (1.565s) [178.324634] Starting dynamic subtest: pipe-C-DP-3 [179.878759] Dynamic subtest pipe-C-DP-3: SUCCESS (1.565s) [179.913444] Starting dynamic subtest: pipe-D-DP-3 [181.446934] Dynamic subtest pipe-D-DP-3: SUCCESS (1.564s) [181.448914] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SUCCESS (11.311s) [181.794648] [029/129] (841s left) kms_big_fb (4-tiled-16bpp-rotate-90) [182.006351] Starting subtest: 4-tiled-16bpp-rotate-90 [182.065424] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.059s) [182.281090] [030/129] (840s left) kms_rotation_crc (multiplane-rotation) [182.478245] Starting subtest: multiplane-rotation [193.899945] Subtest multiplane-rotation: SUCCESS (11.420s) [194.098356] [031/129] (829s left) gem_tiled_partial_pwrite_pread (reads) [194.176571] Subtest reads: SKIP (0.000s) [194.254682] [032/129] (828s left) kms_frontbuffer_tracking (fbc-2p-rte) [194.458749] Starting subtest: fbc-2p-rte [194.460478] Subtest fbc-2p-rte: SKIP (0.000s) [194.581828] [033/129] (828s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [194.786644] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [194.789518] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [194.882679] [034/129] (828s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled) [194.956786] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled [195.070654] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s) [195.210956] [035/129] (828s left) kms_rotation_crc (primary-y-tiled-reflect-x-180) [195.410296] Starting subtest: primary-y-tiled-reflect-x-180 [195.500269] Subtest primary-y-tiled-reflect-x-180: SKIP (0.088s) [195.652891] [036/129] (827s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling) [195.860435] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling [195.861437] Starting dynamic subtest: pipe-A-valid-mode [195.942016] Dynamic subtest pipe-A-valid-mode: SKIP (0.079s) [195.943992] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.081s) [196.143595] [037/129] (827s left) kms_big_fb (yf-tiled-8bpp-rotate-270) [196.353416] Starting subtest: yf-tiled-8bpp-rotate-270 [196.355257] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s) [196.484791] [038/129] (827s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling) [196.693410] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling [196.694330] Starting dynamic subtest: pipe-A-valid-mode [196.778065] Dynamic subtest pipe-A-valid-mode: SKIP (0.083s) [196.780035] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.084s) [196.988179] [039/129] (826s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [197.193713] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [197.195408] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [197.323500] [040/129] (826s left) perf (invalid-create-userspace-config) [197.646938] Starting subtest: invalid-create-userspace-config [197.649129] Subtest invalid-create-userspace-config: SUCCESS (0.001s) [197.694569] [041/129] (826s left) kms_lease (multimaster-lease) [197.892271] Starting subtest: multimaster-lease [197.905764] Subtest multimaster-lease: SUCCESS (0.013s) [198.043636] [042/129] (825s left) gem_exec_create (forked) [198.133184] Starting subtest: forked [198.134140] Starting dynamic subtest: smem [218.270018] Dynamic subtest smem: SUCCESS (20.137s) [218.283226] Starting dynamic subtest: lmem0 [238.423475] Dynamic subtest lmem0: SUCCESS (20.152s) [238.424557] Subtest forked: SUCCESS (40.290s) [238.680366] [043/129] (785s left) kms_pm_dc (dc6-dpms) [239.891174] Starting subtest: dc6-dpms [239.892889] Subtest dc6-dpms: SKIP (0.000s) [239.996636] [044/129] (784s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled) [240.072588] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [240.073465] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [240.234664] [045/129] (783s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu) [240.439915] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu [242.925717] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.487s) [243.135344] [046/129] (781s left) gem_exec_reloc (basic-cpu-gtt) [243.212450] Subtest basic-cpu-gtt: SKIP (0.000s) [243.321245] [047/129] (780s left) kms_psr (fbc-psr-primary-blt) [243.523165] Subtest fbc-psr-primary-blt: SKIP (0.000s) [243.577719] [048/129] (780s left) gem_busy (extended) [243.855078] Starting subtest: extended [243.856142] Starting dynamic subtest: rcs0 [243.946973] Dynamic subtest rcs0: SUCCESS (0.091s) [243.985456] Starting dynamic subtest: bcs0 [243.997661] Dynamic subtest bcs0: SUCCESS (0.049s) [244.013786] Starting dynamic subtest: vcs0 [244.040570] Dynamic subtest vcs0: SUCCESS (0.042s) [244.053070] Starting dynamic subtest: vcs1 [244.082734] Dynamic subtest vcs1: SUCCESS (0.041s) [244.100264] Starting dynamic subtest: vecs0 [244.127299] Dynamic subtest vecs0: SUCCESS (0.043s) [244.158214] Starting dynamic subtest: vecs1 [244.176958] Dynamic subtest vecs1: SUCCESS (0.048s) [244.195671] Starting dynamic subtest: ccs0 [244.221717] Dynamic subtest ccs0: SUCCESS (0.044s) [244.222876] Subtest extended: SUCCESS (0.368s) [244.578385] [049/129] (779s left) gem_exec_schedule (u-semaphore-user) [244.667192] Starting subtest: u-semaphore-user [244.745388] Subtest u-semaphore-user: SUCCESS (0.078s) [245.122497] [050/129] (779s left) gem_userptr_blits (vma-merge) [245.222095] Starting subtest: vma-merge [245.306532] Subtest vma-merge: SUCCESS (0.084s) [245.509330] [051/129] (779s left) syncobj_timeline (multi-wait-all-available-submitted) [245.597977] Starting subtest: multi-wait-all-available-submitted [245.598919] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s) [245.774051] [052/129] (778s left) core_getversion (all-cards) [245.832114] Starting subtest: all-cards [248.392391] Subtest all-cards: SUCCESS (2.561s) [248.445207] [FACT core_getversion (all-cards)] new: kernel.kmod_is_loaded.amdgpu: true [248.446169] [FACT core_getversion (all-cards)] new: kernel.kmod_is_loaded.xe: true [248.448062] [053/129] (776s left) dumb_buffer (map-uaf) [248.525207] Starting subtest: map-uaf [248.546565] Subtest map-uaf: SUCCESS (0.022s) [248.678589] [054/129] (776s left) kms_cursor_crc (cursor-rapid-movement-256x85) [249.066586] Starting subtest: cursor-rapid-movement-256x85 [249.071188] Starting dynamic subtest: pipe-A-DP-3 [249.519422] Dynamic subtest pipe-A-DP-3: SUCCESS (0.448s) [249.563329] Starting dynamic subtest: pipe-D-DP-3 [249.932310] Dynamic subtest pipe-D-DP-3: SUCCESS (0.376s) [249.933447] Subtest cursor-rapid-movement-256x85: SUCCESS (0.865s) [250.307805] [055/129] (774s left) kms_prop_blob (blob-prop-lifetime) [250.378304] Starting subtest: blob-prop-lifetime [250.390298] Subtest blob-prop-lifetime: SUCCESS (0.012s) [250.558163] [056/129] (774s left) gem_exec_schedule (fairslice-all) [250.652454] Starting subtest: fairslice-all [252.757447] Subtest fairslice-all: SUCCESS (2.105s) [253.176188] [057/129] (771s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render) [253.382857] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render [253.384551] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [253.507604] [058/129] (771s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen) [253.719921] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen [253.721661] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [253.835511] [059/129] (771s left) kms_psr (psr2-primary-mmap-gtt) [254.038324] Subtest psr2-primary-mmap-gtt: SKIP (0.000s) [254.097760] [060/129] (771s left) kms_hdr (static-toggle) [254.298360] Starting subtest: static-toggle [257.651306] Starting dynamic subtest: pipe-A-DP-3 [258.687863] Dynamic subtest pipe-A-DP-3: SUCCESS (1.037s) [258.689457] Subtest static-toggle: SUCCESS (4.390s) [259.057709] [061/129] (766s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc) [259.264848] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc [259.266528] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [259.381939] [062/129] (765s left) drm_fdinfo (all-busy-idle-check-all) [259.446399] Starting subtest: all-busy-idle-check-all [259.471179] Subtest all-busy-idle-check-all: SKIP (0.024s) [259.577716] [063/129] (765s left) kms_plane_cursor (viewport) [259.839400] Starting subtest: viewport [259.841193] Starting dynamic subtest: pipe-A-DP-3-size-64 [263.323463] Dynamic subtest pipe-A-DP-3-size-64: SUCCESS (3.482s) [263.401182] Starting dynamic subtest: pipe-A-DP-3-size-128 [266.923404] Dynamic subtest pipe-A-DP-3-size-128: SUCCESS (3.533s) [267.000719] Starting dynamic subtest: pipe-A-DP-3-size-256 [270.523990] Dynamic subtest pipe-A-DP-3-size-256: SUCCESS (3.533s) [270.664523] Starting dynamic subtest: pipe-B-DP-3-size-64 [274.172292] Dynamic subtest pipe-B-DP-3-size-64: SUCCESS (3.519s) [274.236970] Starting dynamic subtest: pipe-B-DP-3-size-128 [277.738901] Dynamic subtest pipe-B-DP-3-size-128: SUCCESS (3.516s) [277.797174] Starting dynamic subtest: pipe-B-DP-3-size-256 [281.305664] Dynamic subtest pipe-B-DP-3-size-256: SUCCESS (3.517s) [281.423965] Starting dynamic subtest: pipe-C-DP-3-size-64 [284.996040] Dynamic subtest pipe-C-DP-3-size-64: SUCCESS (3.582s) [285.058132] Starting dynamic subtest: pipe-C-DP-3-size-128 [288.646084] Dynamic subtest pipe-C-DP-3-size-128: SUCCESS (3.598s) [288.706669] Starting dynamic subtest: pipe-C-DP-3-size-256 [292.179558] Dynamic subtest pipe-C-DP-3-size-256: SUCCESS (3.483s) [292.299349] Starting dynamic subtest: pipe-D-DP-3-size-64 [295.935625] Dynamic subtest pipe-D-DP-3-size-64: SUCCESS (3.647s) [295.998029] Starting dynamic subtest: pipe-D-DP-3-size-128 [299.519033] Dynamic subtest pipe-D-DP-3-size-128: SUCCESS (3.531s) [299.580956] Starting dynamic subtest: pipe-D-DP-3-size-256 [303.085948] Dynamic subtest pipe-D-DP-3-size-256: SUCCESS (3.515s) [303.197056] Subtest viewport: SUCCESS (43.356s) [303.504716] [064/129] (721s left) kms_psr (fbc-psr2-primary-page-flip) [303.707171] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s) [303.772265] [065/129] (721s left) kms_psr (fbc-pr-cursor-mmap-gtt) [303.973254] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s) [304.021762] [066/129] (721s left) gem_exec_balancer (semaphore) [304.107137] Starting subtest: semaphore [305.429180] Subtest semaphore: SUCCESS (1.322s) [305.827273] [067/129] (719s left) gem_spin_batch (spin-all-new) [305.910788] Starting subtest: spin-all-new [305.956916] Subtest spin-all-new: SUCCESS (0.046s) [306.267015] [068/129] (719s left) kms_big_fb (y-tiled-addfb-size-offset-overflow) [306.475586] Starting subtest: y-tiled-addfb-size-offset-overflow [306.477440] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s) [306.596081] [069/129] (719s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt) [306.806375] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt [306.808163] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [306.970129] [070/129] (718s left) gem_ctx_persistence (engines-mixed-process) [307.051508] Starting subtest: engines-mixed-process [307.052444] Starting dynamic subtest: rcs0 [308.960230] Dynamic subtest rcs0: SUCCESS (1.908s) [308.972607] Starting dynamic subtest: bcs0 [310.943055] Dynamic subtest bcs0: SUCCESS (1.981s) [310.955049] Starting dynamic subtest: vcs0 [312.940920] Dynamic subtest vcs0: SUCCESS (1.996s) [312.953082] Starting dynamic subtest: vcs1 [314.918825] Dynamic subtest vcs1: SUCCESS (1.976s) [314.930848] Starting dynamic subtest: vecs0 [316.963423] Dynamic subtest vecs0: SUCCESS (2.043s) [316.975842] Starting dynamic subtest: vecs1 [318.948063] Dynamic subtest vecs1: SUCCESS (1.983s) [318.960181] Starting dynamic subtest: ccs0 [320.939709] Dynamic subtest ccs0: SUCCESS (1.990s) [320.940920] Subtest engines-mixed-process: SUCCESS (13.889s) [321.049053] [071/129] (704s left) gem_mmap_offset (clear) [321.121386] Starting subtest: clear [321.125038] Starting dynamic subtest: lmem0 [345.738754] Dynamic subtest lmem0: SUCCESS (24.615s) [345.761471] Starting dynamic subtest: smem0 [370.004444] Dynamic subtest smem0: SUCCESS (24.263s) [370.005671] Subtest clear: SUCCESS (48.880s) [370.244458] [072/129] (655s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [370.490706] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s) [370.542662] [073/129] (655s left) gem_mmap_wc (write-wc-read-gtt) [370.615460] Subtest write-wc-read-gtt: SKIP (0.000s) [370.679839] [074/129] (655s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [370.889045] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [373.388783] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.499s) [373.604550] [075/129] (652s left) gem_create (create-invalid-size) [373.676390] Starting subtest: create-invalid-size [373.677370] Subtest create-invalid-size: SUCCESS (0.000s) [373.946567] [076/129] (652s left) kms_chamelium_hpd (hdmi-hpd) [374.231822] Subtest hdmi-hpd: SKIP (0.000s) [374.389761] [077/129] (651s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt) [374.595866] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt [374.597605] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [374.751668] [078/129] (651s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [374.951582] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs [374.953402] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [375.237411] [079/129] (651s left) kms_vblank (wait-forked) [375.432547] Starting subtest: wait-forked [375.434903] Starting dynamic subtest: pipe-A-DP-3 [377.797606] Dynamic subtest pipe-A-DP-3: SUCCESS (2.363s) [377.821334] Starting dynamic subtest: pipe-D-DP-3 [380.122144] Dynamic subtest pipe-D-DP-3: SUCCESS (2.317s) [380.123121] Subtest wait-forked: SUCCESS (4.689s) [380.378524] [080/129] (646s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [380.580583] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [380.581507] Starting dynamic subtest: pipe-A [382.705950] Dynamic subtest pipe-A: SUCCESS (2.125s) [382.727051] Starting dynamic subtest: pipe-B [384.927151] Dynamic subtest pipe-B: SUCCESS (2.219s) [384.951378] Starting dynamic subtest: pipe-C [385.246949] Dynamic subtest pipe-C: SUCCESS (0.318s) [385.274548] Starting dynamic subtest: pipe-D [385.566183] Dynamic subtest pipe-D: SUCCESS (0.316s) [385.567464] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (4.986s) [385.880017] [081/129] (640s left) kms_psr (psr-sprite-mmap-cpu) [386.084214] Subtest psr-sprite-mmap-cpu: SKIP (0.000s) [386.159690] [082/129] (640s left) kms_cursor_crc (cursor-random-256x85) [386.551603] Starting subtest: cursor-random-256x85 [386.556889] Starting dynamic subtest: pipe-A-DP-3 [390.928203] Dynamic subtest pipe-A-DP-3: SUCCESS (4.371s) [390.978476] Starting dynamic subtest: pipe-D-DP-3 [395.375456] Dynamic subtest pipe-D-DP-3: SUCCESS (4.406s) [395.376375] Subtest cursor-random-256x85: SUCCESS (8.823s) [395.702894] [083/129] (630s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled) [395.783503] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [395.784564] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s) [395.880780] [084/129] (630s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [396.094182] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [396.096010] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [396.237175] [085/129] (630s left) prime_mmap (test_correct_cpu_write) [396.316911] Starting subtest: test_correct_cpu_write [396.317814] Starting dynamic subtest: test_correct_cpu_write-smem [396.318736] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s) [396.329072] Starting dynamic subtest: test_correct_cpu_write-lmem0 [396.330214] Dynamic subtest test_correct_cpu_write-lmem0: SUCCESS (0.000s) [396.331295] Subtest test_correct_cpu_write: SUCCESS (0.002s) [396.463235] [086/129] (630s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [396.672527] Starting subtest: extended-pageflip-modeset-hang-oldfb [396.674879] Starting dynamic subtest: pipe-A [404.489510] Dynamic subtest pipe-A: SUCCESS (7.815s) [404.502169] Starting dynamic subtest: pipe-D [412.313564] Dynamic subtest pipe-D: SUCCESS (7.820s) [412.314496] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (15.641s) [412.582504] [087/129] (614s left) kms_pm_lpsp (kms-lpsp) [413.789069] Starting subtest: kms-lpsp [413.790850] Subtest kms-lpsp: SKIP (0.000s) [413.887289] [088/129] (613s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [414.087799] Starting subtest: plane-use-after-nonblocking-unbind-fencing [414.090168] Starting dynamic subtest: pipe-A-DP-3 [414.163172] Dynamic subtest pipe-A-DP-3: SUCCESS (0.074s) [414.275520] Starting dynamic subtest: pipe-B-DP-3 [414.387523] Dynamic subtest pipe-B-DP-3: SUCCESS (0.147s) [414.441112] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (0.352s) [414.706606] [089/129] (612s left) i915_pm_rpm (gem-execbuf) [417.053350] Starting subtest: gem-execbuf [417.059474] Starting dynamic subtest: lmem0 [419.777465] Dynamic subtest lmem0: SUCCESS (2.721s) [419.790424] Starting dynamic subtest: smem0 [424.053973] Dynamic subtest smem0: SUCCESS (4.275s) [424.055073] Subtest gem-execbuf: SUCCESS (7.002s) [424.417171] [090/129] (602s left) kms_frontbuffer_tracking (fbc-suspend) [424.622984] Starting subtest: fbc-suspend [465.959520] Subtest fbc-suspend: SUCCESS (10.935s) [466.187923] [091/129] (591s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip) [466.404247] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip [466.406086] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [466.519744] [092/129] (591s left) kms_big_fb (x-tiled-64bpp-rotate-90) [466.732235] Starting subtest: x-tiled-64bpp-rotate-90 [466.775966] Subtest x-tiled-64bpp-rotate-90: SKIP (0.043s) [466.972048] [093/129] (590s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [467.178736] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [467.180560] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [467.312567] [094/129] (590s left) kms_plane_multiple (tiling-none) [467.519151] Starting subtest: tiling-none [467.521565] Starting dynamic subtest: pipe-A-DP-3 [468.601872] Dynamic subtest pipe-A-DP-3: SUCCESS (1.080s) [468.617303] Starting dynamic subtest: pipe-B-DP-3 [469.664843] Dynamic subtest pipe-B-DP-3: SUCCESS (1.062s) [469.677341] Starting dynamic subtest: pipe-C-DP-3 [470.710293] Dynamic subtest pipe-C-DP-3: SUCCESS (1.044s) [470.724505] Starting dynamic subtest: pipe-D-DP-3 [471.737623] Dynamic subtest pipe-D-DP-3: SUCCESS (1.026s) [471.738506] Subtest tiling-none: SUCCESS (4.218s) [471.989247] [095/129] (585s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite) [472.198829] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite [472.200654] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s) [472.359624] [096/129] (585s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs) [472.442130] Starting subtest: y-tiled-ccs-to-y-tiled-ccs [472.444226] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s) [472.683071] [097/129] (585s left) i915_getparams_basic (basic-subslice-total) [472.756078] Starting subtest: basic-subslice-total [472.757933] Subtest basic-subslice-total: SUCCESS (0.000s) [472.892350] [098/129] (585s left) kms_flip (absolute-wf_vblank) [473.089700] Starting subtest: absolute-wf_vblank [473.094194] Starting dynamic subtest: A-DP3 [480.921036] Dynamic subtest A-DP3: SUCCESS (7.826s) [480.936537] Starting dynamic subtest: B-DP3 [488.674273] Dynamic subtest B-DP3: SUCCESS (7.751s) [488.689177] Starting dynamic subtest: C-DP3 [496.424564] Dynamic subtest C-DP3: SUCCESS (7.748s) [496.439845] Starting dynamic subtest: D-DP3 [504.197773] Dynamic subtest D-DP3: SUCCESS (7.771s) [504.200087] Subtest absolute-wf_vblank: SUCCESS (31.108s) [504.522895] [099/129] (553s left) kms_color (ctm-0-25) [504.728151] Starting subtest: ctm-0-25 [504.729064] Starting dynamic subtest: pipe-A-DP-3 [506.407214] Dynamic subtest pipe-A-DP-3: SUCCESS (1.676s) [506.435530] Starting dynamic subtest: pipe-B-DP-3 [508.068227] Dynamic subtest pipe-B-DP-3: SUCCESS (1.659s) [508.082301] Starting dynamic subtest: pipe-C-DP-3 [509.738098] Dynamic subtest pipe-C-DP-3: SUCCESS (1.669s) [509.750717] Starting dynamic subtest: pipe-D-DP-3 [511.383338] Dynamic subtest pipe-D-DP-3: SUCCESS (1.644s) [511.384261] Subtest ctm-0-25: SUCCESS (6.654s) [511.649629] [100/129] (546s left) gem_exec_fence (syncobj-backward-timeline-chain-engines) [512.338912] Starting subtest: syncobj-backward-timeline-chain-engines [512.470398] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.129s) [512.798409] [FACT gem_exec_fence (syncobj-backward-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true [512.801197] [101/129] (545s left) syncobj_wait (multi-wait-all-signaled) [512.882815] Starting subtest: multi-wait-all-signaled [512.883754] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [513.068717] [102/129] (545s left) kms_vblank (ts-continuation-modeset-hang) [513.284492] Starting subtest: ts-continuation-modeset-hang [513.287163] Starting dynamic subtest: pipe-A-DP-3 [540.003925] Dynamic subtest pipe-A-DP-3: SUCCESS (26.714s) [540.018724] Starting dynamic subtest: pipe-D-DP-3 [565.007833] Dynamic subtest pipe-D-DP-3: SUCCESS (25.000s) [565.008767] Subtest ts-continuation-modeset-hang: SUCCESS (51.721s) [565.257365] [103/129] (493s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [565.471065] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [566.652712] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.181s) [566.888898] [104/129] (491s left) perf_pmu (rc6-suspend) [566.963141] Starting subtest: rc6-suspend [592.626346] Subtest rc6-suspend: SUCCESS (10.105s) [593.353030] [105/129] (480s left) syncobj_wait (invalid-single-wait-all-unsubmitted) [593.433403] Starting subtest: invalid-single-wait-all-unsubmitted [593.434339] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [593.615713] [106/129] (480s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [593.832236] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu [593.833942] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [594.010838] [107/129] (480s left) kms_setmode (invalid-clone-single-crtc) [594.098643] Starting subtest: invalid-clone-single-crtc [594.101601] Subtest invalid-clone-single-crtc: SKIP (0.000s) [594.282869] [108/129] (480s left) perf_pmu (busy) [594.353705] Starting subtest: busy [594.354678] Starting dynamic subtest: rcs0 [594.995194] Dynamic subtest rcs0: SUCCESS (0.640s) [595.013053] Starting dynamic subtest: bcs0 [595.560949] Dynamic subtest bcs0: SUCCESS (0.561s) [595.578618] Starting dynamic subtest: vcs0 [596.123270] Dynamic subtest vcs0: SUCCESS (0.558s) [596.141130] Starting dynamic subtest: vcs1 [596.684016] Dynamic subtest vcs1: SUCCESS (0.556s) [596.702267] Starting dynamic subtest: vecs0 [597.245260] Dynamic subtest vecs0: SUCCESS (0.557s) [597.263427] Starting dynamic subtest: vecs1 [597.815024] Dynamic subtest vecs1: SUCCESS (0.565s) [597.833152] Starting dynamic subtest: ccs0 [598.383040] Dynamic subtest ccs0: SUCCESS (0.563s) [598.389342] Subtest busy: SUCCESS (4.031s) [598.559511] [109/129] (475s left) kms_addfb_basic (legacy-format) [598.639653] Starting subtest: legacy-format [598.670457] Subtest legacy-format: SUCCESS (0.029s) [598.926659] [110/129] (475s left) kms_flip (2x-plain-flip-interruptible) [599.138745] Starting subtest: 2x-plain-flip-interruptible [599.153753] Subtest 2x-plain-flip-interruptible: SKIP (0.014s) [599.260861] [111/129] (475s left) perf (low-oa-exponent-permissions) [599.482630] Starting subtest: low-oa-exponent-permissions [599.536001] Subtest low-oa-exponent-permissions: SUCCESS (0.054s) [599.591887] [112/129] (475s left) kms_big_fb (x-tiled-32bpp-rotate-270) [599.808555] Starting subtest: x-tiled-32bpp-rotate-270 [599.860399] Subtest x-tiled-32bpp-rotate-270: SKIP (0.051s) [600.011086] [113/129] (474s left) gem_exec_flush (basic-uc-rw-default) [600.097419] Subtest basic-uc-rw-default: SKIP (0.000s) [600.187716] [114/129] (474s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [600.399150] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu [600.400941] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [600.552424] [115/129] (474s left) gem_exec_schedule (semaphore-noskip) [600.653020] Starting subtest: semaphore-noskip [601.502253] Subtest semaphore-noskip: SUCCESS (0.848s) [601.942264] [116/129] (472s left) sysfs_preempt_timeout (idempotent) [602.027311] Starting subtest: idempotent [602.028320] Starting dynamic subtest: vecs0 [602.029202] Dynamic subtest vecs0: SUCCESS (0.001s) [602.043293] Starting dynamic subtest: ccs0 [602.045007] Dynamic subtest ccs0: SUCCESS (0.001s) [602.058604] Starting dynamic subtest: vcs0 [602.059669] Dynamic subtest vcs0: SUCCESS (0.001s) [602.073447] Starting dynamic subtest: bcs0 [602.074784] Dynamic subtest bcs0: SUCCESS (0.001s) [602.091456] Starting dynamic subtest: vecs1 [602.092685] Dynamic subtest vecs1: SUCCESS (0.001s) [602.105879] Starting dynamic subtest: rcs0 [602.106983] Dynamic subtest rcs0: SUCCESS (0.001s) [602.120358] Starting dynamic subtest: vcs1 [602.121496] Dynamic subtest vcs1: SUCCESS (0.001s) [602.122437] Subtest idempotent: SUCCESS (0.011s) [602.168236] [117/129] (472s left) gem_exec_reloc (basic-range-active) [602.260680] Subtest basic-range-active: SKIP (0.000s) [602.341293] [118/129] (472s left) prime_self_import (basic-with_fd_dup) [602.394703] Starting subtest: basic-with_fd_dup [602.432530] Subtest basic-with_fd_dup: SUCCESS (0.038s) [602.618451] [119/129] (472s left) kms_dirtyfb (psr-dirtyfb-ioctl) [602.826802] Starting subtest: psr-dirtyfb-ioctl [602.831918] Subtest psr-dirtyfb-ioctl: SKIP (0.000s) [602.995202] [120/129] (472s left) kms_pwrite_crc [604.132950] [121/129] (471s left) prime_vgem (coherency-blt) [604.233235] Starting subtest: coherency-blt [606.169481] Subtest coherency-blt: SUCCESS (1.936s) [606.333940] [122/129] (469s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc) [606.558135] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc [606.559951] Subtest fbcpsr-rgb101010-draw-mmap-wc: SKIP (0.000s) [606.729890] [123/129] (468s left) sw_sync (sync_busy_fork_unixsocket) [606.781218] Starting subtest: sync_busy_fork_unixsocket [606.792612] Subtest sync_busy_fork_unixsocket: SUCCESS (0.012s) [606.871978] [124/129] (468s left) kms_invalid_mode (bad-vsync-end) [607.083345] Starting subtest: bad-vsync-end [607.084280] Starting dynamic subtest: pipe-A-DP-3 [607.154404] Dynamic subtest pipe-A-DP-3: SUCCESS (0.070s) [607.171834] Starting dynamic subtest: pipe-B-DP-3 [607.173065] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s) [607.188515] Starting dynamic subtest: pipe-C-DP-3 [607.189516] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s) [607.203854] Starting dynamic subtest: pipe-D-DP-3 [607.204778] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s) [607.205689] Subtest bad-vsync-end: SUCCESS (0.080s) [607.422678] [125/129] (468s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size) [607.632235] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size [639.848521] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (32.215s) [640.082625] [126/129] (435s left) gem_exec_reloc (basic-write-wc-noreloc) [640.167918] Subtest basic-write-wc-noreloc: SKIP (0.000s) [640.255620] [127/129] (435s left) gem_render_copy (linear-to-vebox-y-tiled) [640.343075] Starting subtest: linear-to-vebox-y-tiled [640.345427] Subtest linear-to-vebox-y-tiled: SKIP (0.000s) [640.575272] [128/129] (435s left) gem_render_copy_redux (normal) [640.668209] Starting subtest: normal [641.373311] Subtest normal: SUCCESS (0.705s) [641.573231] [129/129] (434s left) i915_pm_rps (reset) [641.671688] Starting subtest: reset [645.478896] Subtest reset: SUCCESS (3.807s) [645.667240] Closing watchdogs Done.