[65.152761] Initializing watchdogs [65.152825] /dev/watchdog0 [65.170854] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [65.180673] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [65.184650] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [65.187124] [001/129] (960s left) kms_force_connector_basic (force-connector-state) [65.388188] Starting subtest: force-connector-state [65.764219] Subtest force-connector-state: SUCCESS (0.376s) [66.202702] [002/129] (959s left) gem_tiled_partial_pwrite_pread (reads) [66.281330] Subtest reads: SKIP (0.000s) [66.358520] [003/129] (959s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [66.430604] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [66.431511] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s) [66.600918] [004/129] (959s left) kms_scaling_modes (scaling-mode-full) [66.799175] Starting subtest: scaling-mode-full [66.804513] Subtest scaling-mode-full: SKIP (0.001s) [66.879580] [005/129] (959s left) gem_userptr_blits (vma-merge) [67.185323] Starting subtest: vma-merge [67.330443] Subtest vma-merge: SUCCESS (0.137s) [67.687624] [006/129] (958s left) kms_psr (fbc-psr-cursor-mmap-gtt) [67.959454] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s) [68.005375] [007/129] (957s left) perf_pmu (busy-accuracy-50) [68.069243] Starting subtest: busy-accuracy-50 [68.070187] Starting dynamic subtest: rcs0 [69.620786] Dynamic subtest rcs0: SUCCESS (1.550s) [69.629080] Starting dynamic subtest: bcs0 [71.176417] Dynamic subtest bcs0: SUCCESS (1.555s) [71.184827] Starting dynamic subtest: vcs0 [72.732256] Dynamic subtest vcs0: SUCCESS (1.555s) [72.740575] Starting dynamic subtest: vcs1 [74.286524] Dynamic subtest vcs1: SUCCESS (1.554s) [74.294869] Starting dynamic subtest: vecs0 [75.840998] Dynamic subtest vecs0: SUCCESS (1.554s) [75.849424] Starting dynamic subtest: vecs1 [77.394252] Dynamic subtest vecs1: SUCCESS (1.553s) [77.402516] Starting dynamic subtest: ccs0 [78.947217] Dynamic subtest ccs0: SUCCESS (1.552s) [78.948141] Subtest busy-accuracy-50: SUCCESS (10.874s) [79.103981] [008/129] (946s left) kms_psr (fbc-psr-sprite-mmap-gtt) [79.307413] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s) [79.359417] [009/129] (946s left) kms_busy (extended-pageflip-hang-oldfb) [79.570172] Starting subtest: extended-pageflip-hang-oldfb [79.572043] Starting dynamic subtest: pipe-A [79.824533] Dynamic subtest pipe-A: SUCCESS (0.252s) [79.845899] Starting dynamic subtest: pipe-D [80.083224] Dynamic subtest pipe-D: SUCCESS (0.253s) [80.084249] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.514s) [80.363611] [010/129] (945s left) gem_exec_schedule (preempt-contexts) [80.455674] Starting subtest: preempt-contexts [80.456582] Starting dynamic subtest: rcs0 [80.541155] Dynamic subtest rcs0: SUCCESS (0.085s) [80.549882] Starting dynamic subtest: bcs0 [80.603345] Dynamic subtest bcs0: SUCCESS (0.062s) [80.611889] Starting dynamic subtest: vcs0 [80.663931] Dynamic subtest vcs0: SUCCESS (0.060s) [80.672452] Starting dynamic subtest: vcs1 [80.728878] Dynamic subtest vcs1: SUCCESS (0.065s) [80.737377] Starting dynamic subtest: vecs0 [80.788122] Dynamic subtest vecs0: SUCCESS (0.059s) [80.796520] Starting dynamic subtest: vecs1 [80.846851] Dynamic subtest vecs1: SUCCESS (0.059s) [80.855331] Starting dynamic subtest: ccs0 [80.906928] Dynamic subtest ccs0: SUCCESS (0.060s) [80.907914] Subtest preempt-contexts: SUCCESS (0.451s) [81.411386] [011/129] (944s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [81.614500] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [81.616236] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [81.729446] [012/129] (944s left) api_intel_bb (simple-bb-ctx) [81.800998] Starting subtest: simple-bb-ctx [81.830324] Subtest simple-bb-ctx: SUCCESS (0.030s) [82.034912] [013/129] (944s left) kms_addfb_basic (basic-x-tiled-legacy) [82.104977] Starting subtest: basic-x-tiled-legacy [82.106738] Subtest basic-x-tiled-legacy: SKIP (0.000s) [82.369340] [014/129] (944s left) kms_vblank (ts-continuation-dpms-suspend) [82.567181] Starting subtest: ts-continuation-dpms-suspend [82.568226] Starting dynamic subtest: pipe-A-DP-3 [101.638028] Dynamic subtest pipe-A-DP-3: SUCCESS (4.351s) [101.649809] Starting dynamic subtest: pipe-D-DP-3 [121.593403] Dynamic subtest pipe-D-DP-3: SUCCESS (3.950s) [121.594430] Subtest ts-continuation-dpms-suspend: SUCCESS (8.304s) [121.834713] [015/129] (935s left) perf_pmu (most-busy-check-all) [121.899265] Starting subtest: most-busy-check-all [121.900159] Starting dynamic subtest: rcs0 [122.500526] Dynamic subtest rcs0: SUCCESS (0.600s) [122.513669] Starting dynamic subtest: bcs0 [123.052378] Dynamic subtest bcs0: SUCCESS (0.552s) [123.063334] Starting dynamic subtest: vcs0 [123.602330] Dynamic subtest vcs0: SUCCESS (0.550s) [123.612979] Starting dynamic subtest: vcs1 [124.153794] Dynamic subtest vcs1: SUCCESS (0.551s) [124.164554] Starting dynamic subtest: vecs0 [124.702762] Dynamic subtest vecs0: SUCCESS (0.549s) [124.715128] Starting dynamic subtest: vecs1 [125.256651] Dynamic subtest vecs1: SUCCESS (0.553s) [125.270926] Starting dynamic subtest: ccs0 [125.808746] Dynamic subtest ccs0: SUCCESS (0.552s) [125.809679] Subtest most-busy-check-all: SUCCESS (3.910s) [125.938313] [016/129] (931s left) kms_async_flips (test-cursor-atomic) [126.135451] Starting subtest: test-cursor-atomic [126.363571] Starting dynamic subtest: pipe-A-DP-3 [126.627435] Dynamic subtest pipe-A-DP-3: SUCCESS (0.264s) [126.868390] Starting dynamic subtest: pipe-B-DP-3 [127.005966] Dynamic subtest pipe-B-DP-3: SUCCESS (0.148s) [127.216546] Starting dynamic subtest: pipe-C-DP-3 [127.328600] Dynamic subtest pipe-C-DP-3: SUCCESS (0.122s) [127.536382] Starting dynamic subtest: pipe-D-DP-3 [127.642208] Dynamic subtest pipe-D-DP-3: SUCCESS (0.116s) [127.643141] Subtest test-cursor-atomic: SUCCESS (1.507s) [128.098896] [017/129] (929s left) drm_read (short-buffer-wakeup) [128.367010] Starting subtest: short-buffer-wakeup [160.583131] Subtest short-buffer-wakeup: SUCCESS (32.215s) [160.793142] [018/129] (896s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen) [161.005177] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen [161.006889] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [161.124329] [019/129] (896s left) kms_addfb_basic (bo-too-small-due-to-tiling) [161.331471] Starting subtest: bo-too-small-due-to-tiling [161.333287] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [161.469178] [020/129] (896s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled) [161.543609] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled [161.544584] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [161.670331] [021/129] (895s left) kms_setmode (basic-clone-single-crtc) [161.738282] Starting subtest: basic-clone-single-crtc [161.741004] Subtest basic-clone-single-crtc: SKIP (0.000s) [161.884553] [022/129] (895s left) gem_eio (in-flight-external) [162.153558] Starting subtest: in-flight-external [163.619678] Subtest in-flight-external: SUCCESS (1.466s) [163.857743] [023/129] (893s left) gem_ctx_persistence (heartbeat-close) [163.928983] Starting subtest: heartbeat-close [163.931137] Subtest heartbeat-close: SKIP (0.000s) [164.094828] [024/129] (893s left) gem_exec_balancer (hang) [164.422079] Starting subtest: hang [167.714439] Subtest hang: SUCCESS (3.292s) [167.866765] [025/129] (889s left) prime_vgem (fence-wait) [168.004741] Starting subtest: fence-wait [168.005642] Starting dynamic subtest: rcs0 [169.061552] Dynamic subtest rcs0: SUCCESS (1.056s) [169.073362] Starting dynamic subtest: bcs0 [170.136922] Dynamic subtest bcs0: SUCCESS (1.074s) [170.172808] Starting dynamic subtest: vcs0 [171.184791] Dynamic subtest vcs0: SUCCESS (1.047s) [171.199007] Starting dynamic subtest: vcs1 [172.232093] Dynamic subtest vcs1: SUCCESS (1.047s) [172.243389] Starting dynamic subtest: vecs0 [173.276774] Dynamic subtest vecs0: SUCCESS (1.043s) [173.290919] Starting dynamic subtest: vecs1 [174.321271] Dynamic subtest vecs1: SUCCESS (1.043s) [174.337098] Starting dynamic subtest: ccs0 [175.365165] Dynamic subtest ccs0: SUCCESS (1.043s) [175.367167] Subtest fence-wait: SUCCESS (7.359s) [175.518269] [FACT prime_vgem (fence-wait)] new: kernel.kmod_is_loaded.vgem: true [175.520109] [026/129] (882s left) syncobj_wait (signal) [175.599836] Starting subtest: signal [175.600776] Subtest signal: SUCCESS (0.000s) [175.738230] [027/129] (882s left) gem_reg_read (timestamp-monotonic) [175.814217] Starting subtest: timestamp-monotonic [180.129451] Subtest timestamp-monotonic: SUCCESS (4.315s) [180.217890] [028/129] (877s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt) [180.433964] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt [180.435647] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [180.550332] [029/129] (877s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy) [180.757686] Starting subtest: 2x-long-flip-vs-cursor-legacy [180.760636] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.002s) [180.859426] [030/129] (877s left) i915_query (engine-info) [180.940244] Starting subtest: engine-info [180.948250] Subtest engine-info: SUCCESS (0.008s) [181.100155] [031/129] (877s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled) [181.178737] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [181.179662] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s) [181.333254] [032/129] (876s left) kms_color (ctm-max) [181.540344] Starting subtest: ctm-max [181.541424] Starting dynamic subtest: pipe-A-DP-3 [182.188439] Dynamic subtest pipe-A-DP-3: SUCCESS (0.646s) [182.214441] Starting dynamic subtest: pipe-B-DP-3 [182.795434] Dynamic subtest pipe-B-DP-3: SUCCESS (0.607s) [182.808130] Starting dynamic subtest: pipe-C-DP-3 [183.407787] Dynamic subtest pipe-C-DP-3: SUCCESS (0.611s) [183.421703] Starting dynamic subtest: pipe-D-DP-3 [183.988041] Dynamic subtest pipe-D-DP-3: SUCCESS (0.581s) [183.989036] Subtest ctm-max: SUCCESS (2.447s) [184.263163] [033/129] (874s left) kms_cursor_edge_walk (64x64-top-edge) [184.468379] Starting subtest: 64x64-top-edge [184.470378] Starting dynamic subtest: pipe-A-DP-3 [187.932401] Dynamic subtest pipe-A-DP-3: SUCCESS (3.463s) [187.946960] Starting dynamic subtest: pipe-D-DP-3 [191.246631] Dynamic subtest pipe-D-DP-3: SUCCESS (3.312s) [191.247605] Subtest 64x64-top-edge: SUCCESS (6.778s) [191.516905] [034/129] (866s left) kms_chamelium_color (ctm-limited-range) [191.722644] Subtest ctm-limited-range: SKIP (0.000s) [191.785303] [035/129] (866s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc) [191.997742] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc [191.999434] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [192.137245] [036/129] (866s left) gem_softpin (allocator-evict) [192.223449] Starting subtest: allocator-evict [192.224442] Starting dynamic subtest: rcs0 [218.408711] Dynamic subtest rcs0: SUCCESS (26.184s) [218.420400] Starting dynamic subtest: bcs0 [244.612697] Dynamic subtest bcs0: SUCCESS (26.202s) [244.624547] Starting dynamic subtest: vcs0 [270.977767] Dynamic subtest vcs0: SUCCESS (26.364s) [270.989295] Starting dynamic subtest: vcs1 [297.603678] Dynamic subtest vcs1: SUCCESS (26.625s) [297.615302] Starting dynamic subtest: vecs0 [323.904041] Dynamic subtest vecs0: SUCCESS (26.299s) [323.915843] Starting dynamic subtest: vecs1 [351.141704] Dynamic subtest vecs1: SUCCESS (27.237s) [351.153262] Starting dynamic subtest: ccs0 [377.373656] Dynamic subtest ccs0: SUCCESS (26.231s) [377.374636] Subtest allocator-evict: SUCCESS (185.143s) [377.505968] [037/129] (681s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [377.779010] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu [377.780711] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [377.899736] [038/129] (680s left) kms_dsc (dsc-with-bpc) [378.128467] Starting subtest: dsc-with-bpc [378.140304] Subtest dsc-with-bpc: SKIP (0.001s) [378.219713] [039/129] (680s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc) [378.441488] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc [378.443618] Starting dynamic subtest: pipe-A-DP-3 [387.275767] Dynamic subtest pipe-A-DP-3: SUCCESS (8.829s) [387.291335] Starting dynamic subtest: pipe-B-DP-3 [388.066658] Dynamic subtest pipe-B-DP-3: SUCCESS (0.787s) [388.082814] Starting dynamic subtest: pipe-C-DP-3 [388.836413] Dynamic subtest pipe-C-DP-3: SUCCESS (0.765s) [388.852607] Starting dynamic subtest: pipe-D-DP-3 [389.610986] Dynamic subtest pipe-D-DP-3: SUCCESS (0.770s) [389.612844] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SUCCESS (11.164s) [389.966428] [040/129] (668s left) kms_plane (plane-position-covered) [390.174432] Starting subtest: plane-position-covered [390.622780] Starting dynamic subtest: pipe-A-plane-1 [391.091759] Dynamic subtest pipe-A-plane-1: SUCCESS (0.469s) [391.106946] Starting dynamic subtest: pipe-A-plane-2 [391.540199] Dynamic subtest pipe-A-plane-2: SUCCESS (0.448s) [391.557554] Starting dynamic subtest: pipe-A-plane-3 [392.006937] Dynamic subtest pipe-A-plane-3: SUCCESS (0.465s) [392.022371] Starting dynamic subtest: pipe-A-plane-4 [392.467194] Dynamic subtest pipe-A-plane-4: SUCCESS (0.460s) [392.481440] Starting dynamic subtest: pipe-A-plane-5 [392.485545] Dynamic subtest pipe-A-plane-5: SUCCESS (0.018s) [392.837968] Starting dynamic subtest: pipe-B-plane-1 [393.245844] Dynamic subtest pipe-B-plane-1: SUCCESS (0.421s) [393.258396] Starting dynamic subtest: pipe-B-plane-2 [393.685722] Dynamic subtest pipe-B-plane-2: SUCCESS (0.439s) [393.697833] Starting dynamic subtest: pipe-B-plane-3 [394.140255] Dynamic subtest pipe-B-plane-3: SUCCESS (0.454s) [394.152145] Starting dynamic subtest: pipe-B-plane-4 [394.615954] Dynamic subtest pipe-B-plane-4: SUCCESS (0.473s) [394.628155] Starting dynamic subtest: pipe-B-plane-5 [394.630722] Dynamic subtest pipe-B-plane-5: SUCCESS (0.016s) [394.631618] Subtest plane-position-covered: SUCCESS (4.454s) [394.883603] [041/129] (663s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [394.971549] Starting subtest: etime-multi-wait-all-for-submit-submitted [395.081410] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.108s) [395.174541] [042/129] (663s left) kms_psr (fbc-pr-cursor-blt) [395.383576] Subtest fbc-pr-cursor-blt: SKIP (0.000s) [395.434116] [043/129] (663s left) prime_mmap (test_correct) [395.515386] Starting subtest: test_correct [395.516336] Starting dynamic subtest: test_correct-smem [395.563094] Dynamic subtest test_correct-smem: SUCCESS (0.048s) [395.575957] Starting dynamic subtest: test_correct-lmem0 [395.770057] Dynamic subtest test_correct-lmem0: SUCCESS (0.200s) [395.770918] Subtest test_correct: SUCCESS (0.249s) [395.890047] [044/129] (663s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling) [396.103579] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling [396.104481] Starting dynamic subtest: pipe-A-valid-mode [398.791565] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.684s) [398.793390] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (2.687s) [399.074758] [045/129] (660s left) perf (blocking-parameterized) [399.435495] Starting subtest: blocking-parameterized [419.468373] Subtest blocking-parameterized: SUCCESS (20.033s) [419.521918] [046/129] (639s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs) [419.611703] Starting subtest: mixed-tiled-to-y-tiled-ccs [419.613614] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s) [419.868562] [047/129] (639s left) kms_big_fb (x-tiled-64bpp-rotate-270) [420.092627] Starting subtest: x-tiled-64bpp-rotate-270 [420.146351] Subtest x-tiled-64bpp-rotate-270: SKIP (0.051s) [420.355118] [048/129] (638s left) kms_cursor_crc (cursor-alpha-transparent) [420.577779] Starting subtest: cursor-alpha-transparent [420.580125] Starting dynamic subtest: pipe-A-DP-3 [421.171127] Dynamic subtest pipe-A-DP-3: SUCCESS (0.591s) [421.193440] Starting dynamic subtest: pipe-D-DP-3 [421.722807] Dynamic subtest pipe-D-DP-3: SUCCESS (0.548s) [421.724150] Subtest cursor-alpha-transparent: SUCCESS (1.144s) [422.295486] [049/129] (637s left) dmabuf (all-tests) [422.351750] Starting subtest: all-tests [422.352692] Starting dynamic subtest: sanitycheck [422.492849] Dynamic subtest sanitycheck: SUCCESS (0.140s) [422.513234] Starting dynamic subtest: dma_fence [422.751292] Dynamic subtest dma_fence: SUCCESS (0.256s) [422.793200] Starting dynamic subtest: dma_fence_chain [432.069258] Dynamic subtest dma_fence_chain: SUCCESS (9.316s) [432.085589] Starting dynamic subtest: dma_fence_unwrap [432.183500] Dynamic subtest dma_fence_unwrap: SUCCESS (0.113s) [432.224026] Starting dynamic subtest: dma_resv [432.301365] Dynamic subtest dma_resv: SUCCESS (0.116s) [432.303004] Subtest all-tests: SUCCESS (9.950s) [432.421129] [050/129] (627s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [432.632603] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [432.633531] Starting dynamic subtest: pipe-A-DP-3 [436.279840] Dynamic subtest pipe-A-DP-3: SUCCESS (3.630s) [436.295989] Starting dynamic subtest: pipe-B-DP-3 [436.837758] Dynamic subtest pipe-B-DP-3: SUCCESS (0.552s) [436.864146] Starting dynamic subtest: pipe-C-DP-3 [437.417476] Dynamic subtest pipe-C-DP-3: SUCCESS (0.583s) [437.429727] Starting dynamic subtest: pipe-D-DP-3 [437.980803] Dynamic subtest pipe-D-DP-3: SUCCESS (0.552s) [437.982690] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SUCCESS (5.331s) [438.319606] [051/129] (621s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [438.534003] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [438.535672] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s) [438.687699] [052/129] (620s left) gem_exec_schedule (smoketest) [438.907414] Starting subtest: smoketest [438.908419] Starting dynamic subtest: rcs0 [444.366039] Dynamic subtest rcs0: SUCCESS (5.457s) [444.378717] Starting dynamic subtest: bcs0 [449.814326] Dynamic subtest bcs0: SUCCESS (5.448s) [449.826951] Starting dynamic subtest: vcs0 [455.267637] Dynamic subtest vcs0: SUCCESS (5.454s) [455.281200] Starting dynamic subtest: vcs1 [460.721966] Dynamic subtest vcs1: SUCCESS (5.452s) [460.734516] Starting dynamic subtest: vecs0 [466.170626] Dynamic subtest vecs0: SUCCESS (5.449s) [466.183405] Starting dynamic subtest: vecs1 [471.616671] Dynamic subtest vecs1: SUCCESS (5.445s) [471.628754] Starting dynamic subtest: ccs0 [477.070377] Dynamic subtest ccs0: SUCCESS (5.451s) [477.071597] Subtest smoketest: SUCCESS (38.161s) [477.379078] [053/129] (582s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-render) [477.592090] Starting subtest: psr-1p-offscren-pri-indfb-draw-render [477.593807] Subtest psr-1p-offscren-pri-indfb-draw-render: SKIP (0.000s) [477.722613] [054/129] (582s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff) [477.941304] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff [477.943073] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [478.074063] [055/129] (581s left) sw_sync (timeline_closed) [478.125855] Starting subtest: timeline_closed [478.126734] Subtest timeline_closed: SUCCESS (0.000s) [478.207800] [056/129] (581s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [478.424722] Starting subtest: plane-upscale-20x20-with-pixel-format [478.425642] Starting dynamic subtest: pipe-A [480.071344] Dynamic subtest pipe-A: SUCCESS (1.646s) [480.099592] Starting dynamic subtest: pipe-B [481.790936] Dynamic subtest pipe-B: SUCCESS (1.718s) [481.820098] Starting dynamic subtest: pipe-C [482.111026] Dynamic subtest pipe-C: SUCCESS (0.318s) [482.141717] Starting dynamic subtest: pipe-D [482.430976] Dynamic subtest pipe-D: SUCCESS (0.318s) [482.432840] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (4.007s) [482.758679] [057/129] (577s left) kms_feature_discovery (psr1) [482.964354] Starting subtest: psr1 [482.966225] Subtest psr1: SKIP (0.000s) [483.050525] [058/129] (576s left) kms_psr (pr-sprite-blt) [483.261384] Subtest pr-sprite-blt: SKIP (0.000s) [483.327561] [059/129] (576s left) api_intel_allocator (reopen-fork) [483.407657] Starting subtest: reopen-fork [487.033387] Subtest reopen-fork: SUCCESS (3.626s) [487.192127] [060/129] (572s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt) [487.399908] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt [487.401628] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [487.544042] [061/129] (572s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0) [487.757516] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0 [487.759349] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [487.933386] [062/129] (572s left) gem_fenced_exec_thrash (2-spare-fences) [488.018920] Subtest 2-spare-fences: SKIP (0.000s) [488.093911] [063/129] (572s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [488.298720] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [488.300828] Starting dynamic subtest: pipe-A-valid-mode [490.999698] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.697s) [491.001207] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (2.700s) [491.290881] [064/129] (569s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-gtt) [491.501078] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-gtt [491.502844] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [491.648809] [065/129] (568s left) kms_flip (modeset-vs-vblank-race-interruptible) [491.858537] Starting subtest: modeset-vs-vblank-race-interruptible [491.863165] Starting dynamic subtest: A-DP3 [495.081843] Dynamic subtest A-DP3: SUCCESS (3.217s) [495.125779] Starting dynamic subtest: B-DP3 [498.337225] Dynamic subtest B-DP3: SUCCESS (3.249s) [498.381470] Starting dynamic subtest: C-DP3 [501.451897] Dynamic subtest C-DP3: SUCCESS (3.111s) [501.491821] Starting dynamic subtest: D-DP3 [504.535860] Dynamic subtest D-DP3: SUCCESS (3.078s) [504.542985] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (12.683s) [504.908921] [066/129] (555s left) gem_exec_params (dr4-dirt) [504.997712] Starting subtest: DR4-dirt [504.998649] Subtest DR4-dirt: SUCCESS (0.000s) [505.183936] [067/129] (555s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip) [505.407013] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip [505.408763] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [505.554079] [068/129] (555s left) gem_request_retire (retire-vma-not-inactive) [505.652659] Starting subtest: retire-vma-not-inactive [505.728983] Subtest retire-vma-not-inactive: SUCCESS (0.078s) [505.927812] [069/129] (554s left) gem_exec_reloc (basic-wc-gtt-noreloc) [506.010435] Subtest basic-wc-gtt-noreloc: SKIP (0.000s) [506.105959] [070/129] (554s left) gem_eio (in-flight-contexts-10ms) [506.390910] Starting subtest: in-flight-contexts-10ms [519.686737] Subtest in-flight-contexts-10ms: SUCCESS (13.296s) [519.908188] [071/129] (541s left) syncobj_timeline (wait-for-submit-complex) [519.989059] Starting subtest: wait-for-submit-complex [520.052360] Subtest wait-for-submit-complex: SUCCESS (0.062s) [520.213809] [072/129] (540s left) gem_create (create-ext-cpu-access-sanity-check) [520.408582] Starting subtest: create-ext-cpu-access-sanity-check [520.413361] Subtest create-ext-cpu-access-sanity-check: SUCCESS (0.005s) [520.576302] [073/129] (540s left) gem_exec_reloc (basic-softpin) [520.663376] Subtest basic-softpin: SKIP (0.000s) [520.751278] [074/129] (540s left) kms_flip (2x-flip-vs-rmfb) [520.962143] Starting subtest: 2x-flip-vs-rmfb [520.977036] Subtest 2x-flip-vs-rmfb: SKIP (0.014s) [521.075811] [075/129] (540s left) gem_huc_copy (huc-copy) [521.180847] Starting subtest: huc-copy [521.188325] Subtest huc-copy: SUCCESS (0.007s) [521.371106] [076/129] (539s left) kms_joiner (basic-big-joiner) [521.582844] Starting subtest: basic-big-joiner [521.584600] Subtest basic-big-joiner: SKIP (0.000s) [521.674560] [077/129] (539s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt) [521.884046] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt [521.885715] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [522.043641] [078/129] (539s left) gem_exec_whisper (basic-contexts) [522.136861] Starting subtest: basic-contexts [532.735164] Subtest basic-contexts: SUCCESS (10.596s) [532.974262] [079/129] (528s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-render) [533.184024] Starting subtest: fbc-1p-offscren-pri-indfb-draw-render [535.412276] Subtest fbc-1p-offscren-pri-indfb-draw-render: SUCCESS (2.228s) [535.610083] [080/129] (526s left) kms_getfb (getfb2-into-addfb2) [535.690617] Starting subtest: getfb2-into-addfb2 [535.691590] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [535.856190] [081/129] (525s left) gen9_exec_parse (allowed-single) [535.943227] Subtest allowed-single: SKIP (0.000s) [536.018291] [082/129] (525s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5) [536.227676] Starting subtest: planes-unity-scaling-downscale-factor-0-5 [536.228566] Starting dynamic subtest: pipe-A [536.323762] Dynamic subtest pipe-A: SUCCESS (0.096s) [536.344229] Starting dynamic subtest: pipe-B [536.582286] Dynamic subtest pipe-B: SUCCESS (0.257s) [536.594657] Starting dynamic subtest: pipe-C [536.802278] Dynamic subtest pipe-C: SUCCESS (0.219s) [536.817597] Starting dynamic subtest: pipe-D [537.006609] Dynamic subtest pipe-D: SUCCESS (0.203s) [537.007583] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.779s) [537.344864] [083/129] (524s left) gem_exec_reloc (basic-write-cpu-noreloc) [537.430498] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [537.506594] [084/129] (524s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [537.725701] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [538.980732] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.254s) [539.154286] [085/129] (522s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area) [539.390885] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [539.441180] [086/129] (522s left) kms_pipe_crc_basic (disable-crc-after-crtc) [539.651730] Starting subtest: disable-crc-after-crtc [539.654140] Starting dynamic subtest: pipe-A-DP-3 [540.372387] Dynamic subtest pipe-A-DP-3: SUCCESS (0.718s) [540.397435] Starting dynamic subtest: pipe-B-DP-3 [541.009869] Dynamic subtest pipe-B-DP-3: SUCCESS (0.634s) [541.034566] Starting dynamic subtest: pipe-C-DP-3 [541.678677] Dynamic subtest pipe-C-DP-3: SUCCESS (0.665s) [541.695099] Starting dynamic subtest: pipe-D-DP-3 [542.301581] Dynamic subtest pipe-D-DP-3: SUCCESS (0.621s) [542.302513] Subtest disable-crc-after-crtc: SUCCESS (2.650s) [542.572529] [087/129] (519s left) gem_ctx_persistence (smoketest) [542.660155] Starting subtest: smoketest [581.300637] Subtest smoketest: SUCCESS (38.639s) [581.454712] [088/129] (480s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs) [581.662670] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs [581.664965] Starting dynamic subtest: pipe-A-DP-3 [581.673601] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [581.686090] Starting dynamic subtest: pipe-B-DP-3 [581.694639] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [581.706826] Starting dynamic subtest: pipe-C-DP-3 [581.715517] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [581.728004] Starting dynamic subtest: pipe-D-DP-3 [581.739077] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [581.741198] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.006s) [582.117040] [089/129] (480s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt) [582.332075] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt [582.333838] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [582.440888] [090/129] (479s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc) [582.655068] Starting subtest: psr-rgb101010-draw-mmap-wc [582.664431] Subtest psr-rgb101010-draw-mmap-wc: SKIP (0.000s) [582.782029] [091/129] (479s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render) [583.005600] Starting subtest: fbcpsr-rgb101010-draw-render [583.007333] Subtest fbcpsr-rgb101010-draw-render: SKIP (0.000s) [583.130168] [092/129] (479s left) kms_flip (absolute-wf_vblank-interruptible) [583.347643] Starting subtest: absolute-wf_vblank-interruptible [583.352337] Starting dynamic subtest: A-DP3 [591.155113] Dynamic subtest A-DP3: SUCCESS (7.802s) [591.171708] Starting dynamic subtest: B-DP3 [598.890507] Dynamic subtest B-DP3: SUCCESS (7.733s) [598.907445] Starting dynamic subtest: C-DP3 [606.651476] Dynamic subtest C-DP3: SUCCESS (7.757s) [606.666357] Starting dynamic subtest: D-DP3 [614.379598] Dynamic subtest D-DP3: SUCCESS (7.727s) [614.381861] Subtest absolute-wf_vblank-interruptible: SUCCESS (31.033s) [614.732114] [093/129] (447s left) kms_psr (psr-sprite-render) [614.942470] Subtest psr-sprite-render: SKIP (0.000s) [615.035785] [094/129] (447s left) i915_pm_rpm (gem-evict-pwrite) [616.791228] Starting subtest: gem-evict-pwrite [616.793477] Subtest gem-evict-pwrite: SKIP (0.000s) [617.206220] [095/129] (445s left) gem_mmap_gtt (close-race) [617.288491] Subtest close-race: SKIP (0.000s) [617.358366] [096/129] (445s left) gem_render_linear_blits (basic) [617.441814] Starting subtest: basic [617.517212] Subtest basic: SUCCESS (0.075s) [617.669791] [097/129] (445s left) kms_cursor_crc (cursor-rapid-movement-128x128) [618.014575] Starting subtest: cursor-rapid-movement-128x128 [618.019612] Starting dynamic subtest: pipe-A-DP-3 [618.517869] Dynamic subtest pipe-A-DP-3: SUCCESS (0.497s) [618.572766] Starting dynamic subtest: pipe-D-DP-3 [618.989180] Dynamic subtest pipe-D-DP-3: SUCCESS (0.428s) [618.990250] Subtest cursor-rapid-movement-128x128: SUCCESS (0.975s) [619.463470] [098/129] (443s left) gem_softpin (reverse) [619.550695] Starting subtest: reverse [619.558619] Subtest reverse: SUCCESS (0.008s) [619.721584] [099/129] (443s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt) [619.931084] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt [619.932848] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [620.083019] [100/129] (442s left) kms_pm_rpm (pm-caching) [621.821894] Starting subtest: pm-caching [621.824809] Subtest pm-caching: SKIP (0.000s) [622.201210] [101/129] (440s left) gem_exec_reloc (basic-concurrent0) [622.283311] Subtest basic-concurrent0: SKIP (0.000s) [622.390637] [102/129] (440s left) gem_exec_params (secure-non-master) [622.477033] Starting subtest: secure-non-master [622.478866] Subtest secure-non-master: SKIP (0.000s) [622.644328] [103/129] (440s left) gem_exec_fence (syncobj-timeline-unused-fence) [623.337931] Starting subtest: syncobj-timeline-unused-fence [623.361764] Subtest syncobj-timeline-unused-fence: SUCCESS (0.024s) [623.687576] [104/129] (439s left) perf (low-oa-exponent-permissions) [623.887825] Starting subtest: low-oa-exponent-permissions [623.936761] Subtest low-oa-exponent-permissions: SUCCESS (0.049s) [624.002260] [105/129] (439s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0) [624.214648] Starting subtest: primary-yf-tiled-reflect-x-0 [624.320379] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.104s) [624.495064] [106/129] (438s left) gem_mmap_gtt (basic-small-bo) [624.570306] Subtest basic-small-bo: SKIP (0.000s) [624.653794] [107/129] (438s left) gem_mmap_offset (clear-via-pagefault) [624.733555] Starting subtest: clear-via-pagefault [624.734678] Starting dynamic subtest: lmem0 [647.359903] Dynamic subtest lmem0: SUCCESS (22.622s) [647.372598] Starting dynamic subtest: smem0 [672.265153] Dynamic subtest smem0: SUCCESS (24.904s) [672.266102] Subtest clear-via-pagefault: SUCCESS (47.529s) [672.404149] [108/129] (391s left) debugfs_test (read_all_entries) [672.490976] Starting subtest: read_all_entries [673.157749] Subtest read_all_entries: SUCCESS (0.667s) [673.372565] [109/129] (390s left) kms_big_fb (4-tiled-addfb) [673.588598] Starting subtest: 4-tiled-addfb [673.589503] Subtest 4-tiled-addfb: SUCCESS (0.000s) [673.739792] [110/129] (389s left) gem_exec_balancer (bonded-pair) [673.837382] Starting subtest: bonded-pair [673.839408] Subtest bonded-pair: SKIP (0.000s) [674.191834] [111/129] (389s left) perf (per-context-mode-unprivileged) [674.364806] Starting subtest: per-context-mode-unprivileged [674.366686] Subtest per-context-mode-unprivileged: SKIP (0.000s) [674.420043] [112/129] (389s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc) [674.627681] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc [674.629907] Starting dynamic subtest: pipe-A-DP-3 [683.412037] Dynamic subtest pipe-A-DP-3: SUCCESS (8.778s) [683.429230] Starting dynamic subtest: pipe-B-DP-3 [684.199425] Dynamic subtest pipe-B-DP-3: SUCCESS (0.782s) [684.239747] Starting dynamic subtest: pipe-C-DP-3 [685.022093] Dynamic subtest pipe-C-DP-3: SUCCESS (0.816s) [685.062044] Starting dynamic subtest: pipe-D-DP-3 [685.841371] Dynamic subtest pipe-D-DP-3: SUCCESS (0.812s) [685.843155] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SUCCESS (11.209s) [686.207866] [113/129] (377s left) kms_addfb_basic (invalid-get-prop) [686.287563] Starting subtest: invalid-get-prop [686.288477] Subtest invalid-get-prop: SUCCESS (0.000s) [686.551132] [114/129] (377s left) kms_fbcon_fbt (psr) [686.631962] Starting subtest: psr [686.633678] Subtest psr: SKIP (0.000s) [686.804066] [115/129] (377s left) gem_pxp (create-regular-context-2) [689.409434] Starting subtest: create-regular-context-2 [689.411699] Subtest create-regular-context-2: SKIP (0.000s) [689.509676] [116/129] (374s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt) [689.724987] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt [689.726613] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [689.855077] [117/129] (374s left) kms_chamelium_hpd (common-hpd-after-suspend) [690.146707] Subtest common-hpd-after-suspend: SKIP (0.000s) [690.300702] [118/129] (373s left) kms_flip (wf_vblank-ts-check) [690.513358] Starting subtest: wf_vblank-ts-check [690.517610] Starting dynamic subtest: A-DP3 [698.658495] Dynamic subtest A-DP3: SUCCESS (8.140s) [698.674373] Starting dynamic subtest: B-DP3 [706.720770] Dynamic subtest B-DP3: SUCCESS (8.060s) [706.735835] Starting dynamic subtest: C-DP3 [714.783629] Dynamic subtest C-DP3: SUCCESS (8.061s) [714.798217] Starting dynamic subtest: D-DP3 [722.822683] Dynamic subtest D-DP3: SUCCESS (8.038s) [722.824905] Subtest wf_vblank-ts-check: SUCCESS (32.310s) [723.154107] [119/129] (341s left) kms_cursor_crc (cursor-random-32x32) [723.426322] Starting subtest: cursor-random-32x32 [723.474392] Subtest cursor-random-32x32: SKIP (0.046s) [723.870201] [120/129] (340s left) gem_linear_blits (normal) [724.175598] Starting subtest: normal [732.079076] Subtest normal: SUCCESS (7.903s) [732.233491] [121/129] (332s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf) [732.492625] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [732.558166] [122/129] (331s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [732.783283] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [732.785128] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [732.918559] [123/129] (331s left) gem_create (busy-create) [733.004615] Starting subtest: busy-create [733.005606] Starting dynamic subtest: lmem0 [765.280465] Dynamic subtest lmem0: SUCCESS (32.274s) [765.295228] Starting dynamic subtest: smem0 [797.556535] Dynamic subtest smem0: SUCCESS (32.274s) [797.557600] Subtest busy-create: SUCCESS (64.550s) [797.800124] [124/129] (266s left) kms_lease (lease-unleased-crtc) [798.004662] Starting subtest: lease-unleased-crtc [798.006825] Starting dynamic subtest: pipe-A-DP-3 [798.155994] Dynamic subtest pipe-A-DP-3: SUCCESS (0.150s) [798.171610] Starting dynamic subtest: pipe-B-DP-3 [798.227822] Dynamic subtest pipe-B-DP-3: SUCCESS (0.068s) [798.240351] Starting dynamic subtest: pipe-C-DP-3 [798.294803] Dynamic subtest pipe-C-DP-3: SUCCESS (0.065s) [798.307395] Starting dynamic subtest: pipe-D-DP-3 [798.362135] Dynamic subtest pipe-D-DP-3: SUCCESS (0.065s) [798.363021] Subtest lease-unleased-crtc: SUCCESS (0.356s) [798.553713] [125/129] (266s left) kms_frontbuffer_tracking (basic) [798.765084] Starting subtest: basic [801.533428] Subtest basic: SUCCESS (2.768s) [801.732264] [126/129] (262s left) syncobj_timeline (etime-single-wait-for-submit-submitted) [801.821554] Starting subtest: etime-single-wait-for-submit-submitted [801.928919] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.106s) [802.043753] [127/129] (262s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0) [802.261684] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0 [803.533709] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.271s) [803.739335] [128/129] (261s left) gem_gtt_cpu_tlb [803.894286] [129/129] (261s left) gem_exec_fence (submit3) [804.102734] Starting subtest: submit3 [804.104960] Subtest submit3: SKIP (0.000s) [804.864328] Closing watchdogs Done.