[60.108689] Initializing watchdogs [60.108754] /dev/watchdog0 [60.126147] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [60.135707] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [60.139245] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.141854] [001/130] (960s left) kms_chamelium_color (ctm-max) [60.423297] Subtest ctm-max: SKIP (0.000s) [60.470731] [002/130] (960s left) gem_ctx_persistence (userptr) [60.552326] Starting subtest: userptr [60.751912] Subtest userptr: SUCCESS (0.198s) [60.886971] [003/130] (959s left) gem_mmap_offset (ptrace) [60.958107] Starting subtest: ptrace [60.959985] Starting dynamic subtest: lmem0-fixed [61.082316] Dynamic subtest lmem0-fixed: SUCCESS (0.113s) [61.089255] Starting dynamic subtest: smem0-fixed [61.093597] Dynamic subtest smem0-fixed: SUCCESS (0.017s) [61.094521] Subtest ptrace: SUCCESS (0.136s) [61.261672] [004/130] (959s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [61.463956] Starting subtest: fbcpsr-rgb101010-draw-pwrite [61.465844] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s) [61.572824] [005/130] (959s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [61.779700] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s) [61.821766] [006/130] (959s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs) [62.023056] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs [62.024069] Starting dynamic subtest: pipe-A-DP-4 [65.911582] Dynamic subtest pipe-A-DP-4: SUCCESS (3.883s) [65.923364] Starting dynamic subtest: pipe-B-DP-4 [66.651660] Dynamic subtest pipe-B-DP-4: SUCCESS (0.736s) [66.663517] Starting dynamic subtest: pipe-C-DP-4 [67.384857] Dynamic subtest pipe-C-DP-4: SUCCESS (0.732s) [67.392596] Starting dynamic subtest: pipe-D-DP-4 [68.107220] Dynamic subtest pipe-D-DP-4: SUCCESS (0.720s) [68.108464] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SUCCESS (6.081s) [68.447439] [007/130] (952s left) kms_invalid_mode (bad-vsync-end) [68.646327] Starting subtest: bad-vsync-end [68.647279] Starting dynamic subtest: pipe-A-DP-4 [68.730756] Dynamic subtest pipe-A-DP-4: SUCCESS (0.084s) [68.738815] Starting dynamic subtest: pipe-B-DP-4 [68.739917] Dynamic subtest pipe-B-DP-4: SUCCESS (0.001s) [68.748061] Starting dynamic subtest: pipe-C-DP-4 [68.749226] Dynamic subtest pipe-C-DP-4: SUCCESS (0.001s) [68.757642] Starting dynamic subtest: pipe-D-DP-4 [68.758560] Dynamic subtest pipe-D-DP-4: SUCCESS (0.001s) [68.759659] Subtest bad-vsync-end: SUCCESS (0.089s) [69.003120] [008/130] (952s left) kms_lease (lease-invalid-connector) [69.201538] Starting subtest: lease-invalid-connector [69.202450] Starting dynamic subtest: pipe-A-DP-4 [69.203357] Dynamic subtest pipe-A-DP-4: SUCCESS (0.000s) [69.210592] Starting dynamic subtest: pipe-B-DP-4 [69.211475] Dynamic subtest pipe-B-DP-4: SUCCESS (0.000s) [69.218484] Starting dynamic subtest: pipe-C-DP-4 [69.219397] Dynamic subtest pipe-C-DP-4: SUCCESS (0.000s) [69.226557] Starting dynamic subtest: pipe-D-DP-4 [69.227673] Dynamic subtest pipe-D-DP-4: SUCCESS (0.000s) [69.228802] Subtest lease-invalid-connector: SUCCESS (0.003s) [69.277857] [009/130] (951s left) kms_psr (psr2-cursor-plane-move) [69.478306] Subtest psr2-cursor-plane-move: SKIP (0.000s) [69.524599] [010/130] (951s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [69.720365] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [69.721195] Starting dynamic subtest: pipe-A [71.607706] Dynamic subtest pipe-A: SUCCESS (1.887s) [71.621659] Starting dynamic subtest: pipe-B [73.762912] Dynamic subtest pipe-B: SUCCESS (2.155s) [73.772893] Starting dynamic subtest: pipe-C [74.065848] Dynamic subtest pipe-C: SUCCESS (0.302s) [74.084243] Starting dynamic subtest: pipe-D [74.385843] Dynamic subtest pipe-D: SUCCESS (0.320s) [74.387049] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (4.665s) [74.686931] [011/130] (946s left) kms_vblank (query-busy) [74.886320] Starting subtest: query-busy [74.887239] Starting dynamic subtest: pipe-A-DP-4 [77.367757] Dynamic subtest pipe-A-DP-4: SUCCESS (2.481s) [77.385965] Starting dynamic subtest: pipe-D-DP-4 [79.813866] Dynamic subtest pipe-D-DP-4: SUCCESS (2.440s) [79.814965] Subtest query-busy: SUCCESS (4.928s) [80.085588] [012/130] (941s left) gem_pxp (regular-baseline-src-copy-readible) [82.682839] Starting subtest: regular-baseline-src-copy-readible [82.685878] Subtest regular-baseline-src-copy-readible: SKIP (0.000s) [82.762556] [013/130] (938s left) i915_pm_rps (engine-order) [82.849523] Starting subtest: engine-order [93.789259] Subtest engine-order: SUCCESS (10.937s) [93.925972] [014/130] (927s left) drm_fdinfo (busy-idle) [93.990308] Starting subtest: busy-idle [93.991267] Starting dynamic subtest: rcs0 [94.001444] Dynamic subtest rcs0: SKIP (0.010s) [94.009791] Starting dynamic subtest: bcs0 [94.018269] Dynamic subtest bcs0: SKIP (0.017s) [94.027405] Starting dynamic subtest: vcs0 [94.029573] Dynamic subtest vcs0: SKIP (0.000s) [94.038451] Starting dynamic subtest: vcs1 [94.040577] Dynamic subtest vcs1: SKIP (0.000s) [94.049537] Starting dynamic subtest: vecs0 [94.051780] Dynamic subtest vecs0: SKIP (0.000s) [94.060789] Starting dynamic subtest: vecs1 [94.062901] Dynamic subtest vecs1: SKIP (0.000s) [94.072358] Starting dynamic subtest: ccs0 [94.074208] Dynamic subtest ccs0: SKIP (0.000s) [94.076164] Subtest busy-idle: SKIP (0.030s) [94.111675] [015/130] (927s left) gem_mmap_gtt (ptrace) [94.186216] Subtest ptrace: SKIP (0.000s) [94.285389] [016/130] (927s left) gem_exec_reloc (basic-write-read) [94.357286] Subtest basic-write-read: SKIP (0.000s) [94.462566] [017/130] (927s left) kms_flip (2x-flip-vs-rmfb-interruptible) [94.673156] Starting subtest: 2x-flip-vs-rmfb-interruptible [94.686908] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.013s) [94.789140] [018/130] (926s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt) [94.996789] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt [97.539137] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.543s) [97.759771] [019/130] (923s left) gem_exec_gttfill (multigpu-basic) [97.953870] Starting subtest: multigpu-basic [112.475065] Subtest multigpu-basic: SUCCESS (14.521s) [112.563563] [020/130] (909s left) prime_mmap (test_dup) [112.667379] Starting subtest: test_dup [112.668330] Starting dynamic subtest: test_dup-smem [112.715582] Dynamic subtest test_dup-smem: SUCCESS (0.048s) [112.724266] Starting dynamic subtest: test_dup-lmem0 [112.918989] Dynamic subtest test_dup-lmem0: SUCCESS (0.203s) [112.920030] Subtest test_dup: SUCCESS (0.251s) [113.009491] [021/130] (908s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [113.214136] Starting subtest: basic-flip-after-cursor-atomic [114.226983] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.012s) [114.509049] [022/130] (907s left) gem_render_copy_redux (interruptible) [114.587574] Starting subtest: interruptible [115.275739] Subtest interruptible: SUCCESS (0.688s) [115.434026] [023/130] (906s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-cpu) [115.640788] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-cpu [117.676743] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (2.037s) [117.860050] [024/130] (904s left) i915_query (hwconfig_table) [117.931135] Starting subtest: hwconfig_table [118.148986] Subtest hwconfig_table: SUCCESS (0.001s) [118.218512] [025/130] (903s left) kms_feature_discovery (chamelium) [118.419073] Starting subtest: chamelium [118.420857] Subtest chamelium: SKIP (0.000s) [118.516600] [026/130] (903s left) kms_psr (psr-cursor-mmap-gtt) [118.713653] Subtest psr-cursor-mmap-gtt: SKIP (0.000s) [118.771919] [027/130] (903s left) kms_flip (2x-flip-vs-fences) [118.971431] Starting subtest: 2x-flip-vs-fences [118.973208] Subtest 2x-flip-vs-fences: SKIP (0.000s) [119.064789] [028/130] (903s left) kms_flip (2x-blocking-wf_vblank) [119.264392] Starting subtest: 2x-blocking-wf_vblank [119.276759] Subtest 2x-blocking-wf_vblank: SKIP (0.013s) [119.363352] [029/130] (902s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions) [119.568162] Starting subtest: cursorA-vs-flipA-atomic-transitions [130.523408] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (10.955s) [130.783637] [030/130] (891s left) gem_exec_fence (nb-await) [130.980964] Starting subtest: nb-await [130.981961] Starting dynamic subtest: rcs0 [131.069904] Dynamic subtest rcs0: SUCCESS (0.089s) [131.081493] Starting dynamic subtest: bcs0 [131.133047] Dynamic subtest bcs0: SUCCESS (0.062s) [131.145798] Starting dynamic subtest: vcs0 [131.196780] Dynamic subtest vcs0: SUCCESS (0.063s) [131.217835] Starting dynamic subtest: vcs1 [131.268047] Dynamic subtest vcs1: SUCCESS (0.070s) [131.302627] Starting dynamic subtest: vecs0 [131.353567] Dynamic subtest vecs0: SUCCESS (0.084s) [131.387962] Starting dynamic subtest: vecs1 [131.438349] Dynamic subtest vecs1: SUCCESS (0.084s) [131.451871] Starting dynamic subtest: ccs0 [131.502199] Dynamic subtest ccs0: SUCCESS (0.063s) [131.503191] Subtest nb-await: SUCCESS (0.521s) [132.286915] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true [132.288793] [031/130] (890s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation) [132.499105] Starting subtest: plane-upscale-factor-0-25-with-rotation [132.499865] Starting dynamic subtest: pipe-A [132.857999] Dynamic subtest pipe-A: SUCCESS (0.359s) [132.884383] Starting dynamic subtest: pipe-B [133.344457] Dynamic subtest pipe-B: SUCCESS (0.486s) [133.367242] Starting dynamic subtest: pipe-C [133.831654] Dynamic subtest pipe-C: SUCCESS (0.486s) [133.850761] Starting dynamic subtest: pipe-D [134.326086] Dynamic subtest pipe-D: SUCCESS (0.494s) [134.327343] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (1.828s) [134.663169] [032/130] (887s left) vgem_basic (debugfs) [134.730203] Starting subtest: debugfs [134.731193] Subtest debugfs: SUCCESS (0.000s) [134.821996] [033/130] (887s left) vgem_basic (second-client) [134.880359] Starting subtest: second-client [134.913645] Subtest second-client: SUCCESS (0.033s) [135.016985] [034/130] (887s left) kms_color (ctm-signed) [135.224657] Starting subtest: ctm-signed [135.225527] Starting dynamic subtest: pipe-A-DP-4 [136.438749] Dynamic subtest pipe-A-DP-4: SUCCESS (1.213s) [136.456328] Starting dynamic subtest: pipe-B-DP-4 [137.565320] Dynamic subtest pipe-B-DP-4: SUCCESS (1.126s) [137.575769] Starting dynamic subtest: pipe-C-DP-4 [138.674016] Dynamic subtest pipe-C-DP-4: SUCCESS (1.108s) [138.685416] Starting dynamic subtest: pipe-D-DP-4 [139.828474] Dynamic subtest pipe-D-DP-4: SUCCESS (1.154s) [139.829392] Subtest ctm-signed: SUCCESS (4.604s) [140.096154] [035/130] (882s left) kms_plane_multiple (tiling-x) [140.304751] Starting subtest: tiling-x [140.305582] Starting dynamic subtest: pipe-A-DP-4 [141.417468] Dynamic subtest pipe-A-DP-4: SUCCESS (1.112s) [141.429727] Starting dynamic subtest: pipe-B-DP-4 [142.482269] Dynamic subtest pipe-B-DP-4: SUCCESS (1.063s) [142.491963] Starting dynamic subtest: pipe-C-DP-4 [143.572385] Dynamic subtest pipe-C-DP-4: SUCCESS (1.088s) [143.590686] Starting dynamic subtest: pipe-D-DP-4 [144.645469] Dynamic subtest pipe-D-DP-4: SUCCESS (1.071s) [144.646435] Subtest tiling-x: SUCCESS (4.341s) [144.941728] [036/130] (877s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite) [145.155087] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite [147.624124] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.470s) [147.791524] [037/130] (874s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted) [147.872190] Starting subtest: invalid-multi-wait-unsubmitted-submitted [147.873138] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [148.044912] [038/130] (874s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt) [148.258936] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt [148.260627] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [148.416427] [039/130] (874s left) gem_exec_store (dword) [148.508297] Starting subtest: dword [148.509250] Starting dynamic subtest: rcs0 [148.594552] Dynamic subtest rcs0: SUCCESS (0.086s) [148.605155] Starting dynamic subtest: bcs0 [148.635693] Dynamic subtest bcs0: SUCCESS (0.040s) [148.650139] Starting dynamic subtest: vcs0 [148.677237] Dynamic subtest vcs0: SUCCESS (0.040s) [148.704161] Starting dynamic subtest: vcs1 [148.723281] Dynamic subtest vcs1: SUCCESS (0.044s) [148.744347] Starting dynamic subtest: vecs0 [148.767062] Dynamic subtest vecs0: SUCCESS (0.042s) [148.784200] Starting dynamic subtest: vecs1 [148.810184] Dynamic subtest vecs1: SUCCESS (0.042s) [148.830174] Starting dynamic subtest: ccs0 [148.855322] Dynamic subtest ccs0: SUCCESS (0.044s) [148.856608] Subtest dword: SUCCESS (0.347s) [149.141074] [040/130] (873s left) kms_chamelium_hpd (dp-hpd-fast) [149.435605] Subtest dp-hpd-fast: SKIP (0.000s) [149.583788] [041/130] (873s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [149.801979] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu [149.803768] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [149.939325] [042/130] (873s left) gem_exec_whisper (basic-sync-all) [150.030499] Starting subtest: basic-sync-all [155.237844] Subtest basic-sync-all: SUCCESS (5.206s) [155.492920] [043/130] (867s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff) [155.704613] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff [155.706349] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [155.830921] [044/130] (867s left) sw_sync (timeline_closed) [155.882349] Starting subtest: timeline_closed [155.883282] Subtest timeline_closed: SUCCESS (0.000s) [155.975554] [045/130] (867s left) kms_big_fb (yf-tiled-addfb) [156.192464] Starting subtest: yf-tiled-addfb [156.194295] Subtest yf-tiled-addfb: SKIP (0.000s) [156.344410] [046/130] (867s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt) [156.555068] Starting subtest: fbc-rgb101010-draw-blt [159.402204] Subtest fbc-rgb101010-draw-blt: SUCCESS (2.847s) [159.564928] [047/130] (863s left) sw_sync (sync_merge) [159.617564] Starting subtest: sync_merge [159.618557] Subtest sync_merge: SUCCESS (0.000s) [159.696947] [048/130] (863s left) gem_ctx_isolation (dirty-create) [159.793242] Starting subtest: dirty-create [159.794522] Starting dynamic subtest: rcs0 [160.362715] Dynamic subtest rcs0: SUCCESS (0.576s) [160.371852] Starting dynamic subtest: bcs0 [160.998560] Dynamic subtest bcs0: SUCCESS (0.635s) [161.007690] Starting dynamic subtest: vcs0 [161.605614] Dynamic subtest vcs0: SUCCESS (0.606s) [161.614715] Starting dynamic subtest: vcs1 [162.228976] Dynamic subtest vcs1: SUCCESS (0.623s) [162.238407] Starting dynamic subtest: vecs0 [162.861358] Dynamic subtest vecs0: SUCCESS (0.632s) [162.870600] Starting dynamic subtest: vecs1 [163.475641] Dynamic subtest vecs1: SUCCESS (0.614s) [163.484833] Starting dynamic subtest: ccs0 [164.124270] Dynamic subtest ccs0: SUCCESS (0.648s) [164.125230] Subtest dirty-create: SUCCESS (4.338s) [164.386423] [049/130] (859s left) syncobj_timeline (invalid-transfer-illegal-handle) [164.469803] Starting subtest: invalid-transfer-illegal-handle [164.470708] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s) [164.620006] [050/130] (859s left) kms_vblank (wait-busy-hang) [164.833424] Starting subtest: wait-busy-hang [164.834384] Starting dynamic subtest: pipe-A-DP-4 [191.579586] Dynamic subtest pipe-A-DP-4: SUCCESS (26.744s) [191.590397] Starting dynamic subtest: pipe-D-DP-4 [216.590450] Dynamic subtest pipe-D-DP-4: SUCCESS (25.007s) [216.591345] Subtest wait-busy-hang: SUCCESS (51.757s) [216.852024] [051/130] (806s left) gem_pwrite_snooped [217.021643] [052/130] (806s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [217.235276] Starting subtest: extended-pageflip-modeset-hang-oldfb [217.236225] Starting dynamic subtest: pipe-A [225.038986] Dynamic subtest pipe-A: SUCCESS (7.803s) [225.050195] Starting dynamic subtest: pipe-D [232.862626] Dynamic subtest pipe-D: SUCCESS (7.820s) [232.863548] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (15.629s) [233.142417] [053/130] (790s left) perf (mi-rpc) [233.497263] Starting subtest: mi-rpc [233.498990] Subtest mi-rpc: SKIP (0.000s) [233.553117] [054/130] (790s left) perf_pmu (event-wait) [233.626272] Starting subtest: event-wait [233.627193] Starting dynamic subtest: rcs0 [233.628953] Dynamic subtest rcs0: SKIP (0.000s) [233.630618] Subtest event-wait: SKIP (0.001s) [233.746608] [055/130] (790s left) core_auth (basic-auth) [233.823377] Starting subtest: basic-auth [233.837284] Subtest basic-auth: SUCCESS (0.014s) [233.962196] [056/130] (790s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [234.170254] Starting subtest: plane-all-transition-nonblocking-fencing [234.171143] Starting dynamic subtest: pipe-A-DP-4 [237.895285] Dynamic subtest pipe-A-DP-4: SUCCESS (3.723s) [238.005690] Starting dynamic subtest: pipe-B-DP-4 [241.771692] Dynamic subtest pipe-B-DP-4: SUCCESS (3.796s) [241.822205] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (7.652s) [242.104676] [057/130] (781s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite) [242.319033] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite [242.320805] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [242.433305] [058/130] (781s left) gem_exec_params (mmapped) [242.518217] Starting subtest: mmapped [242.521173] Subtest mmapped: SUCCESS (0.003s) [242.717534] [059/130] (781s left) gem_exec_balancer (busy) [242.806268] Starting subtest: busy [243.509417] Subtest busy: SUCCESS (0.703s) [243.908992] [060/130] (780s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [244.114430] Starting subtest: cursorA-vs-flipA-legacy [255.012262] Subtest cursorA-vs-flipA-legacy: SUCCESS (10.898s) [255.281912] [061/130] (769s left) kms_psr (fbc-psr2-dpms) [255.489609] Subtest fbc-psr2-dpms: SKIP (0.000s) [255.539064] [062/130] (768s left) api_intel_bb (bb-with-allocator) [255.620375] Starting subtest: bb-with-allocator [255.643435] Subtest bb-with-allocator: SUCCESS (0.023s) [255.847318] [063/130] (768s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu) [256.059427] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu [256.061195] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [256.202933] [064/130] (768s left) syncobj_eventfd (binary-wait) [256.284831] Starting subtest: binary-wait [256.295315] Subtest binary-wait: SUCCESS (0.010s) [256.407325] [065/130] (768s left) gem_wait (busy) [256.502172] Starting subtest: busy [256.503137] Starting dynamic subtest: all-engines [257.097262] Dynamic subtest all-engines: SUCCESS (0.595s) [257.106554] Starting dynamic subtest: rcs0 [257.637155] Dynamic subtest rcs0: SUCCESS (0.539s) [257.646522] Starting dynamic subtest: bcs0 [258.175267] Dynamic subtest bcs0: SUCCESS (0.537s) [258.184607] Starting dynamic subtest: vcs0 [258.714256] Dynamic subtest vcs0: SUCCESS (0.538s) [258.723641] Starting dynamic subtest: vcs1 [259.253272] Dynamic subtest vcs1: SUCCESS (0.538s) [259.262704] Starting dynamic subtest: vecs0 [259.792293] Dynamic subtest vecs0: SUCCESS (0.538s) [259.801722] Starting dynamic subtest: vecs1 [260.331328] Dynamic subtest vecs1: SUCCESS (0.538s) [260.340694] Starting dynamic subtest: ccs0 [260.869304] Dynamic subtest ccs0: SUCCESS (0.537s) [260.870280] Subtest busy: SUCCESS (4.368s) [261.175530] [066/130] (763s left) kms_big_fb (x-tiled-addfb-size-overflow) [261.394452] Starting subtest: x-tiled-addfb-size-overflow [261.395432] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.001s) [261.537415] [067/130] (763s left) kms_cursor_legacy (forked-move) [261.749444] Starting subtest: forked-move [261.750297] Starting dynamic subtest: pipe-A [267.183716] Dynamic subtest pipe-A: SUCCESS (5.432s) [267.199285] Starting dynamic subtest: pipe-B [272.616369] Dynamic subtest pipe-B: SUCCESS (5.431s) [272.635391] Starting dynamic subtest: pipe-C [278.065599] Dynamic subtest pipe-C: SUCCESS (5.448s) [278.085422] Starting dynamic subtest: pipe-D [283.529403] Dynamic subtest pipe-D: SUCCESS (5.461s) [283.556572] Starting dynamic subtest: all-pipes [288.968531] Dynamic subtest all-pipes: SUCCESS (5.437s) [288.969388] Subtest forked-move: SUCCESS (27.218s) [289.089650] [068/130] (735s left) kms_dither (fb-8bpc-vs-panel-6bpc) [289.304292] Starting subtest: fb-8bpc-vs-panel-6bpc [289.305230] Starting dynamic subtest: pipe-A-DP-4 [289.704322] Dynamic subtest pipe-A-DP-4: SUCCESS (0.396s) [289.706127] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (0.399s) [289.935139] [069/130] (735s left) kms_frontbuffer_tracking (psr-1p-rte) [290.146070] Starting subtest: psr-1p-rte [290.147923] Subtest psr-1p-rte: SKIP (0.000s) [290.275444] [070/130] (734s left) kms_psr (pr-dpms) [290.483478] Subtest pr-dpms: SKIP (0.000s) [290.533202] [071/130] (734s left) kms_flip (bo-too-big-interruptible) [290.750218] Starting subtest: bo-too-big-interruptible [290.755678] Starting dynamic subtest: A-DP4 [291.073229] Dynamic subtest A-DP4: SUCCESS (0.317s) [291.099325] Starting dynamic subtest: B-DP4 [291.304332] Dynamic subtest B-DP4: SUCCESS (0.229s) [291.333915] Starting dynamic subtest: C-DP4 [291.539456] Dynamic subtest C-DP4: SUCCESS (0.232s) [291.574640] Starting dynamic subtest: D-DP4 [291.795404] Dynamic subtest D-DP4: SUCCESS (0.253s) [291.799447] Subtest bo-too-big-interruptible: SUCCESS (1.047s) [292.173275] [072/130] (732s left) kms_content_protection (dp-mst-type-1) [292.444177] Starting subtest: dp-mst-type-1 [292.446140] Subtest dp-mst-type-1: SKIP (0.000s) [292.624864] [073/130] (732s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [292.833597] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [292.834488] Starting dynamic subtest: pipe-A-DP-4 [292.856578] Dynamic subtest pipe-A-DP-4: SKIP (0.002s) [292.865927] Starting dynamic subtest: pipe-B-DP-4 [292.887931] Dynamic subtest pipe-B-DP-4: SKIP (0.002s) [292.897009] Starting dynamic subtest: pipe-C-DP-4 [292.922742] Dynamic subtest pipe-C-DP-4: SKIP (0.002s) [292.931751] Starting dynamic subtest: pipe-D-DP-4 [292.952090] Dynamic subtest pipe-D-DP-4: SKIP (0.002s) [292.954362] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.014s) [293.297568] [074/130] (732s left) kms_addfb_basic (invalid-get-prop-any) [293.375425] Starting subtest: invalid-get-prop-any [293.383379] Subtest invalid-get-prop-any: SUCCESS (0.000s) [293.631922] [075/130] (731s left) gem_caching (writes) [293.727188] Starting subtest: writes [297.378766] Subtest writes: SUCCESS (3.651s) [297.541034] [076/130] (727s left) kms_big_fb (linear-16bpp-rotate-90) [297.779449] Starting subtest: linear-16bpp-rotate-90 [297.839567] Subtest linear-16bpp-rotate-90: SKIP (0.059s) [298.034466] [077/130] (727s left) gem_exec_schedule (preempt-queue-contexts-chain) [298.139158] Subtest preempt-queue-contexts-chain: SKIP (0.000s) [298.505738] [078/130] (727s left) kms_scaling_modes (scaling-mode-full-aspect) [298.710680] Starting subtest: scaling-mode-full-aspect [298.715923] Subtest scaling-mode-full-aspect: SKIP (0.001s) [298.799816] [079/130] (726s left) gem_lmem_swapping (heavy-verify-random) [301.678213] Starting subtest: heavy-verify-random [301.679313] Starting dynamic subtest: lmem0 [316.030653] Dynamic subtest lmem0: SUCCESS (14.352s) [316.031577] Subtest heavy-verify-random: SUCCESS (14.353s) [317.384264] [FACT gem_lmem_swapping (heavy-verify-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [317.385778] [FACT gem_lmem_swapping (heavy-verify-random)] deleted: kernel.kmod_is_loaded.i915: true [317.387810] [080/130] (708s left) kms_psr (fbc-psr2-cursor-mmap-cpu) [319.323807] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s) [319.430326] [FACT kms_psr (fbc-psr2-cursor-mmap-cpu)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [319.433877] [FACT kms_psr (fbc-psr2-cursor-mmap-cpu)] new: kernel.kmod_is_loaded.i915: true [319.434754] [FACT kms_psr (fbc-psr2-cursor-mmap-cpu)] new: kernel.kmod_is_loaded.xe: true [319.437152] [081/130] (706s left) syncobj_basic (test-valid-cycle) [319.522402] Starting subtest: test-valid-cycle [319.523327] Subtest test-valid-cycle: SUCCESS (0.000s) [319.676093] [082/130] (706s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area) [319.892161] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [319.942919] [083/130] (705s left) gem_exec_reloc (basic-cpu-active) [320.035384] Subtest basic-cpu-active: SKIP (0.000s) [320.111486] [084/130] (705s left) syncobj_timeline (wait-all-complex) [320.199071] Starting subtest: wait-all-complex [320.417571] Subtest wait-all-complex: SUCCESS (0.217s) [320.525898] [085/130] (705s left) kms_atomic (atomic-plane-damage) [320.736791] Starting subtest: atomic-plane-damage [321.107080] Starting dynamic subtest: pipe-A-DP-4 [322.031587] Dynamic subtest pipe-A-DP-4: SUCCESS (0.925s) [322.032586] Subtest atomic-plane-damage: SUCCESS (1.296s) [322.289740] [086/130] (703s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling) [322.498788] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling [322.499633] Starting dynamic subtest: pipe-A-valid-mode [322.587367] Dynamic subtest pipe-A-valid-mode: SKIP (0.086s) [322.589363] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.088s) [322.804790] [087/130] (703s left) kms_plane_alpha_blend (coverage-7efc) [323.014755] Starting subtest: coverage-7efc [323.235471] Starting dynamic subtest: pipe-A-DP-4 [323.722454] Dynamic subtest pipe-A-DP-4: SUCCESS (0.486s) [323.755379] Starting dynamic subtest: pipe-D-DP-4 [324.395523] Dynamic subtest pipe-D-DP-4: SUCCESS (0.649s) [324.396471] Subtest coverage-7efc: SUCCESS (1.382s) [324.690475] [088/130] (701s left) api_intel_bb (simple-bb-ctx) [324.769458] Starting subtest: simple-bb-ctx [324.798194] Subtest simple-bb-ctx: SUCCESS (0.029s) [324.974029] [089/130] (701s left) gem_userptr_blits (mmap-offset-banned) [325.066987] Starting subtest: mmap-offset-banned [325.067971] Starting dynamic subtest: fixed [325.068980] Dynamic subtest fixed: SUCCESS (0.000s) [325.069959] Subtest mmap-offset-banned: SUCCESS (0.001s) [325.227318] [090/130] (701s left) gem_userptr_blits (unsync-unmap) [325.315087] Subtest unsync-unmap: SKIP (0.000s) [325.511560] [091/130] (700s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt) [325.723366] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt [325.725214] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [325.826448] [092/130] (700s left) kms_big_fb (4-tiled-32bpp-rotate-0) [326.049908] Starting subtest: 4-tiled-32bpp-rotate-0 [327.726406] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.676s) [327.890862] [093/130] (698s left) gen9_exec_parse (bb-oversize) [327.976120] Subtest bb-oversize: SKIP (0.000s) [328.052758] [094/130] (698s left) kms_cursor_crc (cursor-rapid-movement-64x64) [328.360483] Starting subtest: cursor-rapid-movement-64x64 [328.365549] Starting dynamic subtest: pipe-A-DP-4 [328.807272] Dynamic subtest pipe-A-DP-4: SUCCESS (0.440s) [328.857454] Starting dynamic subtest: pipe-D-DP-4 [329.227100] Dynamic subtest pipe-D-DP-4: SUCCESS (0.377s) [329.228205] Subtest cursor-rapid-movement-64x64: SUCCESS (0.866s) [329.677645] [095/130] (696s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs) [329.768558] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs [329.770540] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s) [330.014289] [096/130] (696s left) gem_unref_active_buffers [330.378185] [097/130] (696s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [330.595925] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [330.597736] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [330.745683] [098/130] (696s left) core_getclient [331.004737] [099/130] (695s left) kms_big_fb (y-tiled-64bpp-rotate-180) [331.221270] Starting subtest: y-tiled-64bpp-rotate-180 [331.223124] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s) [331.352880] [100/130] (695s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt) [331.565043] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt [331.566812] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [331.706700] [101/130] (695s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [331.921067] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [331.922925] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s) [332.045778] [102/130] (695s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [332.250954] Starting subtest: primary-yf-tiled-reflect-x-180 [332.353940] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.102s) [332.511360] [103/130] (694s left) kms_cursor_crc (cursor-random-64x64) [332.815080] Starting subtest: cursor-random-64x64 [332.819389] Starting dynamic subtest: pipe-A-DP-4 [337.283906] Dynamic subtest pipe-A-DP-4: SUCCESS (4.463s) [337.333852] Starting dynamic subtest: pipe-D-DP-4 [341.800852] Dynamic subtest pipe-D-DP-4: SUCCESS (4.475s) [341.801870] Subtest cursor-random-64x64: SUCCESS (8.986s) [342.264497] [104/130] (685s left) perf_pmu (init-busy) [342.335979] Starting subtest: init-busy [342.336939] Starting dynamic subtest: rcs0 [342.339245] Dynamic subtest rcs0: SUCCESS (0.002s) [342.348709] Starting dynamic subtest: bcs0 [342.349565] Dynamic subtest bcs0: SUCCESS (0.001s) [342.358847] Starting dynamic subtest: vcs0 [342.359751] Dynamic subtest vcs0: SUCCESS (0.000s) [342.369364] Starting dynamic subtest: vcs1 [342.370607] Dynamic subtest vcs1: SUCCESS (0.001s) [342.380132] Starting dynamic subtest: vecs0 [342.381255] Dynamic subtest vecs0: SUCCESS (0.000s) [342.390234] Starting dynamic subtest: vecs1 [342.391371] Dynamic subtest vecs1: SUCCESS (0.000s) [342.400683] Starting dynamic subtest: ccs0 [342.401684] Dynamic subtest ccs0: SUCCESS (0.000s) [342.402794] Subtest init-busy: SUCCESS (0.011s) [342.466374] [105/130] (684s left) perf (per-context-mode-unprivileged) [342.801694] Starting subtest: per-context-mode-unprivileged [342.803387] Subtest per-context-mode-unprivileged: SKIP (0.000s) [342.851045] [106/130] (684s left) gem_ctx_persistence (engines-mixed-process) [342.935754] Starting subtest: engines-mixed-process [342.936772] Starting dynamic subtest: rcs0 [344.938988] Dynamic subtest rcs0: SUCCESS (2.002s) [344.970069] Starting dynamic subtest: bcs0 [346.911684] Dynamic subtest bcs0: SUCCESS (1.969s) [346.924051] Starting dynamic subtest: vcs0 [348.895371] Dynamic subtest vcs0: SUCCESS (1.982s) [348.908246] Starting dynamic subtest: vcs1 [350.946831] Dynamic subtest vcs1: SUCCESS (2.050s) [350.960514] Starting dynamic subtest: vecs0 [352.938762] Dynamic subtest vecs0: SUCCESS (1.990s) [352.951345] Starting dynamic subtest: vecs1 [354.913726] Dynamic subtest vecs1: SUCCESS (1.973s) [354.926236] Starting dynamic subtest: ccs0 [356.903891] Dynamic subtest ccs0: SUCCESS (1.989s) [356.905013] Subtest engines-mixed-process: SUCCESS (13.968s) [357.044936] [107/130] (670s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-wc) [357.258027] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-wc [357.259924] Subtest psr-1p-offscren-pri-indfb-draw-mmap-wc: SKIP (0.000s) [357.391057] [108/130] (670s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [357.604932] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu [357.606717] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [357.741259] [109/130] (669s left) i915_pm_freq_api (freq-suspend) [357.829462] Starting subtest: freq-suspend [357.830440] Starting dynamic subtest: gt0 [375.921275] Dynamic subtest gt0: SUCCESS (4.125s) [375.922244] Subtest freq-suspend: SUCCESS (4.126s) [382.031754] [110/130] (665s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [382.116590] Starting subtest: multi-wait-for-submit-available-submitted [382.117572] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s) [382.269086] [111/130] (665s left) kms_chamelium_audio (dp-audio-edid) [382.566531] Subtest dp-audio-edid: SKIP (0.000s) [382.717807] [112/130] (665s left) kms_big_fb (x-tiled-32bpp-rotate-0) [382.939733] Starting subtest: x-tiled-32bpp-rotate-0 [384.614272] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.675s) [384.814202] [113/130] (663s left) gem_ccs (ctrl-surf-copy-new-ctx) [384.902909] Starting subtest: ctrl-surf-copy-new-ctx [384.905297] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0 [384.955305] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.051s) [384.968020] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0 [385.152927] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.196s) [385.163961] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0 [385.178542] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.025s) [385.190911] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0 [385.380552] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.201s) [385.393081] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0 [385.405952] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.024s) [385.417085] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0 [385.608317] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.201s) [385.619290] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0 [385.634750] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.025s) [385.647323] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0 [385.827087] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.191s) [385.828085] Subtest ctrl-surf-copy-new-ctx: SUCCESS (0.925s) [385.973889] [114/130] (661s left) kms_frontbuffer_tracking (fbcpsr-tiling-4) [386.189668] Starting subtest: fbcpsr-tiling-4 [386.191386] Subtest fbcpsr-tiling-4: SKIP (0.000s) [386.344318] [115/130] (661s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels) [386.552910] Starting subtest: plane-all-modeset-transition-fencing-internal-panels [386.554627] Subtest plane-all-modeset-transition-fencing-internal-panels: SKIP (0.000s) [386.643226] [116/130] (661s left) kms_pm_rpm (cursor) [389.094584] Starting subtest: cursor [389.096960] Subtest cursor: SKIP (0.000s) [389.461142] [117/130] (658s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [389.675776] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs [389.676626] Starting dynamic subtest: pipe-A-DP-4 [389.685285] Dynamic subtest pipe-A-DP-4: SKIP (0.000s) [389.696173] Starting dynamic subtest: pipe-B-DP-4 [389.704949] Dynamic subtest pipe-B-DP-4: SKIP (0.000s) [389.715949] Starting dynamic subtest: pipe-C-DP-4 [389.724421] Dynamic subtest pipe-C-DP-4: SKIP (0.000s) [389.735246] Starting dynamic subtest: pipe-D-DP-4 [389.745835] Dynamic subtest pipe-D-DP-4: SKIP (0.000s) [389.747664] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.007s) [390.126423] [118/130] (658s left) kms_addfb_basic (unused-handle) [390.207620] Starting subtest: unused-handle [390.208573] Subtest unused-handle: SUCCESS (0.000s) [390.500216] [119/130] (657s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt) [390.707558] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt [390.709318] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [390.833589] [120/130] (657s left) gem_mmap_gtt (basic-write) [390.911464] Subtest basic-write: SKIP (0.000s) [390.982260] [121/130] (657s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render) [391.195504] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render [391.197277] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [391.342375] [122/130] (657s left) prime_mmap_coherency (read) [391.427715] Starting subtest: read [396.825500] Subtest read: SUCCESS (5.394s) [397.041696] [123/130] (651s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [397.122146] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [397.229379] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.105s) [397.343245] [124/130] (651s left) gem_exec_flush (basic-batch-kernel-default-uc) [397.429194] Subtest basic-batch-kernel-default-uc: SKIP (0.000s) [397.500839] [125/130] (651s left) syncobj_wait (multi-wait-submitted) [397.584300] Starting subtest: multi-wait-submitted [397.692929] Subtest multi-wait-submitted: SUCCESS (0.107s) [397.841802] [126/130] (650s left) kms_setmode (invalid-clone-exclusive-crtc) [397.925506] Starting subtest: invalid-clone-exclusive-crtc [397.928688] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s) [398.091923] [127/130] (650s left) gem_softpin (allocator-basic-reserve) [398.176774] Starting subtest: allocator-basic-reserve [398.347940] Subtest allocator-basic-reserve: SUCCESS (0.171s) [398.545854] [128/130] (650s left) fbdev (nullptr) [398.609347] Starting subtest: nullptr [398.610379] Subtest nullptr: SUCCESS (0.000s) [398.694616] [129/130] (650s left) kms_prop_blob (blob-prop-core) [398.775580] Starting subtest: blob-prop-core [398.776512] Subtest blob-prop-core: SUCCESS (0.000s) [398.948531] [130/130] (650s left) gem_exec_balancer (parallel) [399.266577] Starting subtest: parallel [400.604696] Subtest parallel: SUCCESS (1.338s) [400.776824] Closing watchdogs Done.