[59.212552] Initializing watchdogs [59.212607] /dev/watchdog0 [59.244726] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [59.248847] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.251215] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.254468] [001/155] (960s left) kms_busy (extended-pageflip-hang-oldfb) [59.380050] Starting subtest: extended-pageflip-hang-oldfb [59.382390] Starting dynamic subtest: pipe-A [59.861487] Dynamic subtest pipe-A: SUCCESS (0.477s) [59.869946] Starting dynamic subtest: pipe-D [61.009482] Dynamic subtest pipe-D: SUCCESS (1.143s) [61.011868] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.624s) [61.859207] [002/155] (957s left) perf (non-zero-reason) [61.983325] Starting subtest: non-zero-reason [61.985234] Starting dynamic subtest: 0-rcs0 [67.901949] Dynamic subtest 0-rcs0: SUCCESS (5.907s) [67.913491] Starting dynamic subtest: 1-vcs1 [72.049197] Dynamic subtest 1-vcs1: SUCCESS (4.142s) [72.052103] Subtest non-zero-reason: SUCCESS (10.051s) [72.093401] [003/155] (947s left) gem_tiling_max_stride [72.290671] [004/155] (947s left) gem_exec_fence (invalid-timeline-fence-array) [72.977470] Starting subtest: invalid-timeline-fence-array [72.982610] Subtest invalid-timeline-fence-array: SUCCESS (0.008s) [74.372591] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true [74.375331] [005/155] (945s left) gem_mmap_wc (write) [74.435045] Subtest write: SKIP (0.000s) [74.504316] [006/155] (945s left) api_intel_bb (intel-bb-blit-none) [74.557734] Starting subtest: intel-bb-blit-none [78.885800] Subtest intel-bb-blit-none: SUCCESS (4.312s) [78.991413] [007/155] (940s left) gem_exec_store (dword) [79.053659] Starting subtest: dword [79.055934] Starting dynamic subtest: rcs0 [79.109802] Dynamic subtest rcs0: SUCCESS (0.057s) [79.119084] Starting dynamic subtest: bcs0 [79.156054] Dynamic subtest bcs0: SUCCESS (0.046s) [79.166503] Starting dynamic subtest: vcs0 [79.199952] Dynamic subtest vcs0: SUCCESS (0.042s) [79.210049] Starting dynamic subtest: vcs1 [79.242762] Dynamic subtest vcs1: SUCCESS (0.042s) [79.252841] Starting dynamic subtest: vecs0 [79.286876] Dynamic subtest vecs0: SUCCESS (0.044s) [79.297464] Starting dynamic subtest: ccs0 [79.329996] Dynamic subtest ccs0: SUCCESS (0.043s) [79.332830] Subtest dword: SUCCESS (0.278s) [79.528071] [008/155] (940s left) kms_draw_crc (draw-method-mmap-gtt) [79.615843] Starting subtest: draw-method-mmap-gtt [79.620222] Subtest draw-method-mmap-gtt: SKIP (0.000s) [79.722400] [009/155] (940s left) kms_psr (fbc-psr-primary-page-flip) [79.808817] Starting subtest: fbc-psr-primary-page-flip [79.811193] Starting dynamic subtest: eDP-1 [79.815575] Dynamic subtest eDP-1: SKIP (0.000s) [79.820075] Subtest fbc-psr-primary-page-flip: SKIP (0.000s) [79.882069] [010/155] (940s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [79.973308] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [80.080164] [011/155] (940s left) dmabuf_sync_file (export-multiwait) [80.129236] Starting subtest: export-multiwait [80.131417] Subtest export-multiwait: SUCCESS (0.001s) [80.183171] [012/155] (940s left) kms_vblank (ts-continuation-modeset-hang) [80.272838] Starting subtest: ts-continuation-modeset-hang [80.274742] Starting dynamic subtest: pipe-A-eDP-1 [108.105916] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.830s) [108.121166] Starting dynamic subtest: pipe-D-eDP-1 [123.074948] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.964s) [123.077186] Subtest ts-continuation-modeset-hang: SUCCESS (42.798s) [123.911954] [013/155] (896s left) gem_exec_schedule (submit-late-slice) [123.993187] Starting subtest: submit-late-slice [123.995559] Starting dynamic subtest: rcs0 [124.023548] Dynamic subtest rcs0: SUCCESS (0.039s) [124.034500] Starting dynamic subtest: bcs0 [124.063634] Dynamic subtest bcs0: SUCCESS (0.039s) [124.077332] Starting dynamic subtest: vcs0 [124.099640] Dynamic subtest vcs0: SUCCESS (0.035s) [124.108920] Starting dynamic subtest: vcs1 [124.136666] Dynamic subtest vcs1: SUCCESS (0.039s) [124.151696] Starting dynamic subtest: vecs0 [124.170356] Dynamic subtest vecs0: SUCCESS (0.033s) [124.179147] Starting dynamic subtest: ccs0 [124.203578] Dynamic subtest ccs0: SUCCESS (0.033s) [124.205798] Subtest submit-late-slice: SUCCESS (0.219s) [125.398837] [014/155] (894s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite) [125.491273] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite [125.495674] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [125.590555] [015/155] (894s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [125.683991] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [125.688356] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [125.788370] [016/155] (894s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [125.885642] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt [125.890325] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [125.990712] [017/155] (894s left) gem_workarounds (reset) [126.054966] Starting subtest: reset [126.212930] Subtest reset: SUCCESS (0.158s) [126.334678] [018/155] (894s left) kms_frontbuffer_tracking (hdr-modesetfrombusy) [126.436776] Starting subtest: hdr-modesetfrombusy [126.440275] Subtest hdr-modesetfrombusy: SKIP (0.000s) [126.539785] [019/155] (893s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc) [126.629242] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc [133.326628] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.700s) [133.476420] [020/155] (887s left) gem_exec_balancer (parallel-keep-submit-fence) [133.735380] Starting subtest: parallel-keep-submit-fence [134.947484] Subtest parallel-keep-submit-fence: SUCCESS (1.212s) [135.036200] [021/155] (885s left) gem_eio (in-flight-internal-10ms) [135.248036] Starting subtest: in-flight-internal-10ms [136.415862] Subtest in-flight-internal-10ms: SUCCESS (1.168s) [136.554554] [022/155] (884s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [136.609797] Starting subtest: y-tiled-ccs-to-y-tiled [136.614502] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [136.798741] [023/155] (883s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted) [136.850368] Starting subtest: etime-single-wait-all-for-submit-submitted [136.959608] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.106s) [137.046377] [024/155] (883s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-pwrite) [137.150746] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-pwrite [137.155069] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [137.275165] [025/155] (883s left) kms_frontbuffer_tracking (fbchdr-tiling-4) [137.389612] Starting subtest: fbchdr-tiling-4 [137.393668] Subtest fbchdr-tiling-4: SKIP (0.000s) [137.509762] [026/155] (883s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-render) [137.616873] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-render [137.621591] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [137.726512] [027/155] (883s left) gem_exec_parallel (contexts) [137.791117] Starting subtest: contexts [137.793585] Starting dynamic subtest: rcs0 [141.205041] Dynamic subtest rcs0: SUCCESS (3.412s) [141.214146] Starting dynamic subtest: bcs0 [145.327525] Dynamic subtest bcs0: SUCCESS (4.121s) [145.336217] Starting dynamic subtest: vcs0 [149.731712] Dynamic subtest vcs0: SUCCESS (4.404s) [149.741524] Starting dynamic subtest: vcs1 [153.838960] Dynamic subtest vcs1: SUCCESS (4.079s) [153.851538] Starting dynamic subtest: vecs0 [159.619898] Dynamic subtest vecs0: SUCCESS (5.807s) [159.629127] Starting dynamic subtest: ccs0 [163.898062] Dynamic subtest ccs0: SUCCESS (4.278s) [163.900301] Subtest contexts: SUCCESS (26.105s) [164.088769] [028/155] (856s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted) [164.142025] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted [164.247122] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s) [164.324996] [029/155] (856s left) kms_psr (psr-basic) [164.413778] Starting subtest: psr-basic [164.416172] Starting dynamic subtest: eDP-1 [166.010789] Dynamic subtest eDP-1: SUCCESS (1.596s) [166.013161] Subtest psr-basic: SUCCESS (1.596s) [166.890687] [030/155] (854s left) syncobj_timeline (single-wait-signaled) [166.940565] Starting subtest: single-wait-signaled [166.942859] Subtest single-wait-signaled: SUCCESS (0.000s) [167.046474] [031/155] (853s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [167.156775] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [168.014405] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.859s) [168.187512] [032/155] (852s left) prime_busy (hang) [168.255698] Starting subtest: hang [168.258172] Starting dynamic subtest: rcs0 [194.844920] Dynamic subtest rcs0: SUCCESS (26.584s) [194.856099] Starting dynamic subtest: bcs0 [201.934109] Dynamic subtest bcs0: SUCCESS (7.088s) [201.945745] Starting dynamic subtest: vcs0 [208.970704] Dynamic subtest vcs0: SUCCESS (7.037s) [208.979238] Starting dynamic subtest: vcs1 [215.945863] Dynamic subtest vcs1: SUCCESS (6.977s) [215.957247] Starting dynamic subtest: vecs0 [222.919864] Dynamic subtest vecs0: SUCCESS (6.971s) [222.929056] Starting dynamic subtest: ccs0 [236.826822] Dynamic subtest ccs0: SUCCESS (13.907s) [236.829921] Subtest hang: SUCCESS (68.567s) [236.952367] [033/155] (784s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [237.065955] Starting subtest: fbcpsr-slowdraw [262.357923] Subtest fbcpsr-slowdraw: SUCCESS (25.297s) [262.521708] [034/155] (758s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc) [262.623845] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc [269.717447] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.098s) [269.823737] [035/155] (751s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite) [269.929042] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite [269.933497] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [270.058487] [036/155] (751s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu) [270.165767] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu [270.170303] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [270.278141] [037/155] (751s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping) [270.365143] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping [270.390495] Starting dynamic subtest: pipe-A-plane-0 [270.680844] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s) [270.691310] Starting dynamic subtest: pipe-A-plane-3 [270.911875] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s) [272.029553] Starting dynamic subtest: pipe-B-plane-0 [272.320711] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s) [272.330664] Starting dynamic subtest: pipe-B-plane-3 [272.553563] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s) [272.868087] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.503s) [273.696033] [038/155] (747s left) gem_ctx_persistence (legacy-engines-persistence) [273.757117] Starting subtest: legacy-engines-persistence [273.759384] Starting dynamic subtest: render [274.552312] Dynamic subtest render: SUCCESS (0.795s) [274.563787] Starting dynamic subtest: bsd1 [275.321501] Dynamic subtest bsd1: SUCCESS (0.767s) [275.332174] Starting dynamic subtest: bsd2 [276.094657] Dynamic subtest bsd2: SUCCESS (0.771s) [276.106809] Starting dynamic subtest: blt [276.865542] Dynamic subtest blt: SUCCESS (0.769s) [276.878601] Starting dynamic subtest: vebox [277.629800] Dynamic subtest vebox: SUCCESS (0.761s) [277.632958] Subtest legacy-engines-persistence: SUCCESS (3.873s) [277.707132] [039/155] (743s left) gem_basic (create-fd-close) [277.757505] Starting subtest: create-fd-close [277.761671] Subtest create-fd-close: SUCCESS (0.000s) [277.865432] [040/155] (743s left) gem_pxp (regular-baseline-src-copy-readible) [277.980517] Starting subtest: regular-baseline-src-copy-readible [278.041291] Subtest regular-baseline-src-copy-readible: SUCCESS (0.063s) [278.150951] [041/155] (743s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-msflip-blt) [278.255714] Starting subtest: fbchdr-2p-primscrn-indfb-msflip-blt [278.260101] Subtest fbchdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [278.350793] [042/155] (743s left) gem_exec_schedule (implicit-write-read) [278.420725] Starting subtest: implicit-write-read [278.422994] Starting dynamic subtest: rcs0 [278.524998] Dynamic subtest rcs0: SUCCESS (0.112s) [278.534669] Starting dynamic subtest: vcs0 [278.611199] Dynamic subtest vcs0: SUCCESS (0.086s) [278.622874] Starting dynamic subtest: vcs1 [278.701246] Dynamic subtest vcs1: SUCCESS (0.089s) [278.713110] Starting dynamic subtest: vecs0 [278.788605] Dynamic subtest vecs0: SUCCESS (0.087s) [278.799685] Starting dynamic subtest: ccs0 [278.887074] Dynamic subtest ccs0: SUCCESS (0.098s) [278.889056] Subtest implicit-write-read: SUCCESS (0.475s) [280.413618] [043/155] (741s left) gem_busy (parallel) [280.588615] Starting subtest: parallel [280.590830] Starting dynamic subtest: rcs0 [282.306856] Dynamic subtest rcs0: SUCCESS (1.716s) [282.319555] Starting dynamic subtest: bcs0 [284.291118] Dynamic subtest bcs0: SUCCESS (1.982s) [284.303689] Starting dynamic subtest: vcs0 [286.275044] Dynamic subtest vcs0: SUCCESS (1.981s) [286.286358] Starting dynamic subtest: vcs1 [288.322710] Dynamic subtest vcs1: SUCCESS (2.045s) [288.335008] Starting dynamic subtest: vecs0 [290.306655] Dynamic subtest vecs0: SUCCESS (1.982s) [290.317918] Starting dynamic subtest: ccs0 [292.291043] Dynamic subtest ccs0: SUCCESS (1.982s) [292.293902] Subtest parallel: SUCCESS (11.702s) [292.536205] [044/155] (729s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [292.635453] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [296.552032] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.923s) [297.698179] [045/155] (723s left) gem_set_tiling_vs_blt (untiled-to-tiled) [297.756575] Subtest untiled-to-tiled: SKIP (0.000s) [297.825733] [046/155] (723s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [297.884597] Subtest writes-after-reads-uncached: SKIP (0.000s) [297.960906] [047/155] (723s left) syncobj_timeline (multi-wait-all-for-submit-signaled) [298.012231] Starting subtest: multi-wait-all-for-submit-signaled [298.014583] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s) [298.130519] [048/155] (723s left) kms_psr (pr-cursor-render) [298.214784] Starting subtest: pr-cursor-render [298.219163] Subtest pr-cursor-render: SKIP (0.000s) [298.284061] [049/155] (723s left) kms_plane_cursor (primary) [298.375820] Starting subtest: primary [298.380374] Starting dynamic subtest: pipe-A-eDP-1-size-64 [300.962610] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.587s) [300.987479] Starting dynamic subtest: pipe-A-eDP-1-size-128 [303.564350] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.583s) [303.587100] Starting dynamic subtest: pipe-A-eDP-1-size-256 [306.165608] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.583s) [306.493409] Starting dynamic subtest: pipe-B-eDP-1-size-64 [309.826582] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.343s) [309.856844] Starting dynamic subtest: pipe-B-eDP-1-size-128 [312.438476] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.596s) [312.463461] Starting dynamic subtest: pipe-B-eDP-1-size-256 [315.051244] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.594s) [315.364647] Starting dynamic subtest: pipe-C-eDP-1-size-64 [318.254580] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.899s) [318.280244] Starting dynamic subtest: pipe-C-eDP-1-size-128 [320.497749] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.225s) [320.526405] Starting dynamic subtest: pipe-C-eDP-1-size-256 [322.742290] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.225s) [323.070147] Starting dynamic subtest: pipe-D-eDP-1-size-64 [326.000514] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.942s) [326.028109] Starting dynamic subtest: pipe-D-eDP-1-size-128 [328.235166] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.214s) [328.262194] Starting dynamic subtest: pipe-D-eDP-1-size-256 [330.468286] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.214s) [330.781768] Subtest primary: SUCCESS (32.406s) [331.644614] [050/155] (690s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [331.754041] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [331.758456] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [331.864319] [051/155] (689s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled) [331.923770] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled [331.928210] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [332.110596] [052/155] (689s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs) [332.206426] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs [332.208661] Starting dynamic subtest: pipe-A-eDP-1 [332.231095] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [332.240952] Starting dynamic subtest: pipe-B-eDP-1 [332.263308] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [332.274656] Starting dynamic subtest: pipe-C-eDP-1 [332.295661] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [332.304237] Starting dynamic subtest: pipe-D-eDP-1 [332.326030] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [332.330373] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s) [334.496197] [053/155] (687s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [334.583185] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [334.587670] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s) [334.653943] [054/155] (687s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [334.748843] Starting subtest: fbc-rgb565-draw-blt [339.017065] Subtest fbc-rgb565-draw-blt: SUCCESS (4.274s) [340.214904] [055/155] (681s left) sw_sync (sync_multi_producer_single_consumer) [340.250773] Starting subtest: sync_multi_producer_single_consumer [341.326389] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s) [341.389442] [056/155] (680s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt) [341.480437] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt [341.484822] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [341.584687] [057/155] (680s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs) [341.681933] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs [341.686306] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s) [342.836841] [058/155] (679s left) gem_ctx_shared (exec-single-timeline) [342.892457] Starting subtest: exec-single-timeline [342.894629] Starting dynamic subtest: rcs0 [343.966293] Dynamic subtest rcs0: SUCCESS (1.074s) [343.977811] Starting dynamic subtest: bcs0 [345.054341] Dynamic subtest bcs0: SUCCESS (1.085s) [345.068536] Starting dynamic subtest: vcs0 [346.143711] Dynamic subtest vcs0: SUCCESS (1.084s) [346.156886] Starting dynamic subtest: vcs1 [347.231275] Dynamic subtest vcs1: SUCCESS (1.085s) [347.242405] Starting dynamic subtest: vecs0 [348.319595] Dynamic subtest vecs0: SUCCESS (1.085s) [348.336229] Starting dynamic subtest: ccs0 [349.408485] Dynamic subtest ccs0: SUCCESS (1.085s) [349.411797] Subtest exec-single-timeline: SUCCESS (6.520s) [349.600401] [059/155] (672s left) gem_eio (suspend) [349.816750] Starting subtest: suspend [362.115185] Subtest suspend: SUCCESS (12.297s) [362.230260] [060/155] (659s left) kms_cursor_legacy (torture-move) [362.360055] Starting subtest: torture-move [362.362070] Starting dynamic subtest: pipe-A [368.109813] Dynamic subtest pipe-A: SUCCESS (5.746s) [368.128109] Starting dynamic subtest: pipe-B [375.691512] Dynamic subtest pipe-B: SUCCESS (7.579s) [375.714324] Starting dynamic subtest: pipe-C [382.679859] Dynamic subtest pipe-C: SUCCESS (6.985s) [382.692277] Starting dynamic subtest: pipe-D [388.798473] Dynamic subtest pipe-D: SUCCESS (6.118s) [388.810757] Starting dynamic subtest: all-pipes [394.768856] Dynamic subtest all-pipes: SUCCESS (5.966s) [394.771670] Subtest torture-move: SUCCESS (32.407s) [394.938160] [061/155] (627s left) gem_mmap_gtt (basic-write) [395.003719] Subtest basic-write: SKIP (0.000s) [395.057759] [062/155] (627s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-onoff) [395.159421] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-onoff [395.163854] Subtest psrhdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [395.260949] [063/155] (627s left) kms_cursor_crc (cursor-sliding-256x256) [395.507946] Starting subtest: cursor-sliding-256x256 [395.513653] Starting dynamic subtest: pipe-A-eDP-1 [398.719067] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.207s) [398.749433] Starting dynamic subtest: pipe-D-eDP-1 [402.619156] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.878s) [402.621443] Subtest cursor-sliding-256x256: SUCCESS (7.111s) [403.476535] [064/155] (618s left) kms_pm_rpm (modeset-lpsp) [405.510751] Starting subtest: modeset-lpsp [406.991052] Subtest modeset-lpsp: SUCCESS (1.483s) [407.088929] [065/155] (615s left) kms_lease (lease-again) [407.183677] Starting subtest: lease-again [407.185814] Starting dynamic subtest: pipe-A-eDP-1 [407.187993] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s) [407.198573] Starting dynamic subtest: pipe-B-eDP-1 [407.200732] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [407.210417] Starting dynamic subtest: pipe-C-eDP-1 [407.212615] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [407.222431] Starting dynamic subtest: pipe-D-eDP-1 [407.224617] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [407.226803] Subtest lease-again: SUCCESS (0.013s) [407.301856] [066/155] (615s left) kms_getfb (getfb-repeated-different-handles) [407.385191] Starting subtest: getfb-repeated-different-handles [407.387528] Subtest getfb-repeated-different-handles: SUCCESS (0.000s) [407.492332] [067/155] (615s left) gem_mmap_wc (fault-concurrent) [407.547242] Subtest fault-concurrent: SKIP (0.000s) [407.623716] [068/155] (614s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling) [407.719788] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling [407.722103] Starting dynamic subtest: pipe-A-default-mode [410.491823] Dynamic subtest pipe-A-default-mode: SUCCESS (2.772s) [410.494286] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.773s) [411.357463] [069/155] (611s left) gen7_exec_parse (basic-rejected) [411.416381] Subtest basic-rejected: SKIP (0.000s) [411.487953] [070/155] (611s left) perf_pmu (invalid-open) [411.532898] Starting subtest: invalid-open [411.535447] Subtest invalid-open: SUCCESS (0.000s) [411.638496] [071/155] (611s left) kms_panel_fitting (legacy) [411.733696] Starting subtest: legacy [411.735880] Starting dynamic subtest: pipe-A-eDP-1 [412.244019] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.511s) [412.271227] Starting dynamic subtest: pipe-B-eDP-1 [413.782908] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.519s) [413.811523] Starting dynamic subtest: pipe-C-eDP-1 [415.284696] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.482s) [415.312341] Starting dynamic subtest: pipe-D-eDP-1 [416.826287] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.523s) [416.828583] Subtest legacy: SUCCESS (5.096s) [418.067486] [072/155] (604s left) gem_userptr_blits (create-destroy-unsync) [418.130832] Subtest create-destroy-unsync: SKIP (0.000s) [418.289965] [073/155] (604s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [418.392339] Starting subtest: primary-4-tiled-reflect-x-180 [425.414664] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.026s) [426.633232] [074/155] (596s left) kms_psr (fbc-psr2-sprite-render) [426.728847] Starting subtest: fbc-psr2-sprite-render [426.731148] Starting dynamic subtest: eDP-1 [426.735483] Dynamic subtest eDP-1: SKIP (0.000s) [426.739779] Subtest fbc-psr2-sprite-render: SKIP (0.001s) [426.821098] [075/155] (596s left) kms_cursor_crc (cursor-sliding-32x10) [426.986703] Starting subtest: cursor-sliding-32x10 [427.037781] Subtest cursor-sliding-32x10: SKIP (0.045s) [427.329021] [076/155] (595s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip) [427.426046] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip [427.430379] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [427.543901] [077/155] (595s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [427.645511] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu [427.648993] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [427.746183] [078/155] (595s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-plflip-blt) [427.849504] Starting subtest: hdr-2p-primscrn-indfb-plflip-blt [427.853195] Subtest hdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [427.959233] [079/155] (595s left) kms_addfb_basic (small-bo) [428.050298] Starting subtest: small-bo [428.052186] Subtest small-bo: SUCCESS (0.000s) [428.147861] [080/155] (594s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt) [428.245647] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt [428.249131] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [428.324858] [081/155] (594s left) kms_flip (bo-too-big-interruptible) [428.418138] Starting subtest: bo-too-big-interruptible [428.422117] Starting dynamic subtest: A-eDP1 [429.690316] Dynamic subtest A-eDP1: SUCCESS (1.270s) [429.700875] Starting dynamic subtest: B-eDP1 [431.023387] Dynamic subtest B-eDP1: SUCCESS (1.331s) [431.034343] Starting dynamic subtest: C-eDP1 [432.355101] Dynamic subtest C-eDP1: SUCCESS (1.329s) [432.368029] Starting dynamic subtest: D-eDP1 [433.678055] Dynamic subtest D-eDP1: SUCCESS (1.321s) [433.683241] Subtest bo-too-big-interruptible: SUCCESS (5.264s) [434.885458] [082/155] (588s left) kms_big_fb (x-tiled-32bpp-rotate-90) [434.985227] Starting subtest: x-tiled-32bpp-rotate-90 [435.004182] Subtest x-tiled-32bpp-rotate-90: SKIP (0.018s) [435.133190] [083/155] (588s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary) [435.233397] Starting subtest: fbc-indfb-scaledprimary [438.134399] Subtest fbc-indfb-scaledprimary: SUCCESS (2.905s) [439.281612] [084/155] (583s left) gem_exec_balancer (invalid-bonds) [439.334664] Starting subtest: invalid-bonds [439.339250] Subtest invalid-bonds: SKIP (0.000s) [439.640326] [085/155] (583s left) kms_big_fb (y-tiled-64bpp-rotate-270) [439.744364] Starting subtest: y-tiled-64bpp-rotate-270 [439.748686] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s) [439.846501] [086/155] (583s left) gem_exec_flush (basic-uc-pro-default) [439.918322] Starting subtest: basic-uc-pro-default [445.376647] Subtest basic-uc-pro-default: SUCCESS (5.459s) [445.561929] [087/155] (577s left) gem_exec_reloc (basic-wc-read-active) [445.620733] Subtest basic-wc-read-active: SKIP (0.000s) [445.677213] [088/155] (577s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-msflip-blt) [445.772757] Starting subtest: hdr-2p-primscrn-indfb-msflip-blt [445.777203] Subtest hdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [445.880303] [089/155] (577s left) gem_spin_batch (resubmit-all) [445.936781] Starting subtest: resubmit-all [445.939174] Starting dynamic subtest: rcs0 [445.951265] Dynamic subtest rcs0: SUCCESS (0.014s) [445.961857] Starting dynamic subtest: bcs0 [445.964185] Dynamic subtest bcs0: SUCCESS (0.002s) [445.974342] Starting dynamic subtest: vcs0 [445.976621] Dynamic subtest vcs0: SUCCESS (0.002s) [445.986231] Starting dynamic subtest: vcs1 [445.988492] Dynamic subtest vcs1: SUCCESS (0.002s) [445.998077] Starting dynamic subtest: vecs0 [446.000263] Dynamic subtest vecs0: SUCCESS (0.002s) [446.009710] Starting dynamic subtest: ccs0 [446.011928] Dynamic subtest ccs0: SUCCESS (0.002s) [446.014176] Subtest resubmit-all: SUCCESS (0.028s) [447.339080] [090/155] (576s left) gem_madvise (dontneed-after-mmap) [447.376292] Starting subtest: dontneed-after-mmap [447.396654] Subtest dontneed-after-mmap: SUCCESS (0.023s) [447.507971] [091/155] (576s left) kms_frontbuffer_tracking (fbchdr-1p-pri-indfb-multidraw) [447.598102] Starting subtest: fbchdr-1p-pri-indfb-multidraw [447.602167] Subtest fbchdr-1p-pri-indfb-multidraw: SKIP (0.000s) [447.692122] [092/155] (575s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers) [447.783343] Starting subtest: plane-upscale-factor-0-25-with-modifiers [447.785673] Starting dynamic subtest: pipe-A [448.120853] Dynamic subtest pipe-A: SUCCESS (0.337s) [448.131542] Starting dynamic subtest: pipe-B [449.559061] Dynamic subtest pipe-B: SUCCESS (1.437s) [449.573098] Starting dynamic subtest: pipe-C [450.981321] Dynamic subtest pipe-C: SUCCESS (1.421s) [450.993408] Starting dynamic subtest: pipe-D [452.415664] Dynamic subtest pipe-D: SUCCESS (1.433s) [452.418592] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.633s) [453.607841] [093/155] (569s left) gem_softpin (evict-snoop) [453.663064] Starting subtest: evict-snoop [453.667843] Subtest evict-snoop: SKIP (0.000s) [453.794419] [094/155] (569s left) gem_create (create-massive) [453.843284] Starting subtest: create-massive [453.845107] Subtest create-massive: SUCCESS (0.000s) [454.028548] [095/155] (569s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [454.137402] Starting subtest: psr-2p-primscrn-spr-indfb-move [454.141533] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [454.218015] [096/155] (569s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-render) [454.317694] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-render [454.322687] Subtest fbchdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [454.411950] [097/155] (569s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite) [454.505552] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite [461.398247] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.898s) [461.513603] [098/155] (562s left) kms_frontbuffer_tracking (fbcpsrhdr-slowdraw) [461.627789] Starting subtest: fbcpsrhdr-slowdraw [461.631826] Subtest fbcpsrhdr-slowdraw: SKIP (0.000s) [461.742661] [099/155] (562s left) gem_ctx_persistence (engines-cleanup) [461.796855] Starting subtest: engines-cleanup [461.798706] Starting dynamic subtest: rcs0 [461.860990] Dynamic subtest rcs0: SUCCESS (0.066s) [461.876260] Starting dynamic subtest: bcs0 [461.902449] Dynamic subtest bcs0: SUCCESS (0.039s) [461.912692] Starting dynamic subtest: vcs0 [461.943575] Dynamic subtest vcs0: SUCCESS (0.039s) [461.954886] Starting dynamic subtest: vcs1 [461.994754] Dynamic subtest vcs1: SUCCESS (0.049s) [462.006856] Starting dynamic subtest: vecs0 [462.042168] Dynamic subtest vecs0: SUCCESS (0.045s) [462.053973] Starting dynamic subtest: ccs0 [462.082958] Dynamic subtest ccs0: SUCCESS (0.039s) [462.085679] Subtest engines-cleanup: SUCCESS (0.289s) [462.177682] [100/155] (561s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-render) [462.283868] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-render [462.288331] Subtest hdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [462.376972] [101/155] (561s left) kms_atomic_transition (modeset-transition-nonblocking) [462.469378] Starting subtest: modeset-transition-nonblocking [462.471275] Starting dynamic subtest: 1x-outputs [473.760282] Dynamic subtest 1x-outputs: SUCCESS (11.291s) [473.762733] Subtest modeset-transition-nonblocking: SUCCESS (11.293s) [474.632335] [102/155] (549s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4) [474.723513] Starting subtest: plane-lut1d-pre-ctm3x4 [474.881348] Starting dynamic subtest: pipe-A-plane-0 [475.072520] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s) [475.083126] Starting dynamic subtest: pipe-A-plane-1 [475.270577] Dynamic subtest pipe-A-plane-1: SUCCESS (0.199s) [475.280987] Starting dynamic subtest: pipe-A-plane-2 [475.425606] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s) [476.630658] Starting dynamic subtest: pipe-B-plane-0 [476.788770] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s) [476.799954] Starting dynamic subtest: pipe-B-plane-1 [476.944386] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s) [476.954757] Starting dynamic subtest: pipe-B-plane-2 [477.099675] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s) [478.387499] Starting dynamic subtest: pipe-C-plane-0 [478.511450] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s) [478.522698] Starting dynamic subtest: pipe-C-plane-1 [478.644852] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s) [478.655375] Starting dynamic subtest: pipe-C-plane-2 [478.801528] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s) [479.993092] Starting dynamic subtest: pipe-D-plane-0 [480.129075] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s) [480.139783] Starting dynamic subtest: pipe-D-plane-1 [480.295586] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s) [480.305839] Starting dynamic subtest: pipe-D-plane-2 [480.462686] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s) [480.757778] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (6.035s) [481.656075] [103/155] (542s left) kms_frontbuffer_tracking (fbcpsr-2p-rte) [481.750353] Starting subtest: fbcpsr-2p-rte [481.754963] Subtest fbcpsr-2p-rte: SKIP (0.000s) [481.831418] [104/155] (542s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-pwrite) [481.926840] Starting subtest: psrhdr-rgb565-draw-pwrite [481.931400] Subtest psrhdr-rgb565-draw-pwrite: SKIP (0.000s) [482.018814] [105/155] (542s left) kms_plane_multiple (2x-tiling-x) [482.112946] Starting subtest: 2x-tiling-x [482.117205] Subtest 2x-tiling-x: SKIP (0.000s) [482.192548] [106/155] (541s left) i915_drm_fdinfo (busy-idle-check-all) [482.232376] Starting subtest: busy-idle-check-all [482.234800] Starting dynamic subtest: rcs0 [482.239536] Dynamic subtest rcs0: SKIP (0.004s) [482.251713] Starting dynamic subtest: bcs0 [482.256252] Dynamic subtest bcs0: SKIP (0.000s) [482.266418] Starting dynamic subtest: vcs0 [482.270852] Dynamic subtest vcs0: SKIP (0.000s) [482.280660] Starting dynamic subtest: vcs1 [482.285105] Dynamic subtest vcs1: SKIP (0.000s) [482.294592] Starting dynamic subtest: vecs0 [482.298956] Dynamic subtest vecs0: SKIP (0.000s) [482.308871] Starting dynamic subtest: ccs0 [482.313216] Dynamic subtest ccs0: SKIP (0.000s) [482.317581] Subtest busy-idle-check-all: SKIP (0.010s) [482.356378] [107/155] (541s left) sw_sync (sync_random_merge) [482.390152] Starting subtest: sync_random_merge [482.429314] Subtest sync_random_merge: SUCCESS (0.043s) [482.493990] [108/155] (541s left) kms_sequence (get-forked-busy) [482.606643] Starting subtest: get-forked-busy [482.608266] Starting dynamic subtest: pipe-A-eDP-1 [484.524448] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.917s) [484.535213] Starting dynamic subtest: pipe-B-eDP-1 [487.164069] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.638s) [487.174823] Starting dynamic subtest: pipe-C-eDP-1 [490.557589] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.388s) [490.569709] Starting dynamic subtest: pipe-D-eDP-1 [492.671388] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.112s) [492.673282] Subtest get-forked-busy: SUCCESS (10.064s) [493.572664] [109/155] (530s left) gem_exec_params (readonly) [493.640355] Starting subtest: readonly [493.642344] Subtest readonly: SUCCESS (0.002s) [493.768584] [110/155] (530s left) gem_softpin (evict-active-interruptible) [493.820652] Starting subtest: evict-active-interruptible [493.826479] Subtest evict-active-interruptible: SUCCESS (0.006s) [493.951824] [111/155] (530s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers) [494.040933] Starting subtest: plane-scaler-unity-scaling-with-modifiers [494.042960] Starting dynamic subtest: pipe-A [494.388998] Dynamic subtest pipe-A: SUCCESS (0.350s) [494.399114] Starting dynamic subtest: pipe-B [495.860059] Dynamic subtest pipe-B: SUCCESS (1.469s) [495.871216] Starting dynamic subtest: pipe-C [497.286901] Dynamic subtest pipe-C: SUCCESS (1.425s) [497.297657] Starting dynamic subtest: pipe-D [498.739669] Dynamic subtest pipe-D: SUCCESS (1.452s) [498.742097] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.702s) [499.903444] [112/155] (524s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [499.955495] Starting subtest: invalid-multi-wait-unsubmitted-submitted [499.957820] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [500.061943] [113/155] (524s left) kms_chamelium_hpd (dp-hpd-storm-disable) [500.464768] Subtest dp-hpd-storm-disable: SKIP (0.000s) [501.322949] [114/155] (523s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [501.416184] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [501.420459] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [501.512361] [115/155] (523s left) i915_pm_rc6_residency (rc6-idle) [501.561599] Starting subtest: rc6-idle [501.583828] Starting dynamic subtest: gt0-rcs0 [525.861051] Dynamic subtest gt0-rcs0: SUCCESS (24.276s) [525.874654] Starting dynamic subtest: gt0-bcs0 [550.224740] Dynamic subtest gt0-bcs0: SUCCESS (24.361s) [550.235507] Starting dynamic subtest: gt0-ccs0 [574.588760] Dynamic subtest gt0-ccs0: SUCCESS (24.361s) [574.601614] Starting dynamic subtest: gt1-vcs0 [580.760591] Dynamic subtest gt1-vcs0: SUCCESS (6.168s) [580.774320] Starting dynamic subtest: gt1-vecs0 [586.932520] Dynamic subtest gt1-vecs0: SUCCESS (6.169s) [586.935438] Subtest rc6-idle: SUCCESS (85.373s) [587.017610] [116/155] (437s left) gem_mmap_offset (partial-mmap) [587.072853] Starting subtest: partial-mmap [587.075158] Starting dynamic subtest: smem0 [587.079714] Dynamic subtest smem0: SUCCESS (0.005s) [587.082197] Subtest partial-mmap: SUCCESS (0.006s) [587.189443] [117/155] (437s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs) [587.283964] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs [587.288546] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s) [588.480896] [118/155] (436s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf) [588.575647] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf [588.577902] Starting dynamic subtest: pipe-A-eDP-1 [588.652009] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s) [588.662934] Starting dynamic subtest: pipe-B-eDP-1 [589.835311] Dynamic subtest pipe-B-eDP-1: SKIP (1.181s) [589.839890] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.261s) [591.131735] [119/155] (433s left) gem_wait (write-busy) [591.196954] Starting subtest: write-busy [591.199335] Starting dynamic subtest: all-engines [591.809332] Dynamic subtest all-engines: SUCCESS (0.611s) [591.822957] Starting dynamic subtest: rcs0 [592.372450] Dynamic subtest rcs0: SUCCESS (0.561s) [592.391329] Starting dynamic subtest: bcs0 [592.923892] Dynamic subtest bcs0: SUCCESS (0.550s) [592.942058] Starting dynamic subtest: vcs0 [594.305335] Dynamic subtest vcs0: SUCCESS (1.379s) [594.321675] Starting dynamic subtest: vcs1 [596.289653] Dynamic subtest vcs1: SUCCESS (1.982s) [596.307495] Starting dynamic subtest: vecs0 [598.274256] Dynamic subtest vecs0: SUCCESS (1.982s) [598.291627] Starting dynamic subtest: ccs0 [598.824103] Dynamic subtest ccs0: SUCCESS (0.549s) [598.826597] Subtest write-busy: SUCCESS (7.627s) [599.026370] [120/155] (425s left) kms_cursor_crc (cursor-onscreen-max-size) [599.344593] Starting subtest: cursor-onscreen-max-size [599.350830] Subtest cursor-onscreen-max-size: SKIP (0.000s) [599.456649] [121/155] (425s left) syncobj_timeline (reset-unsignaled) [599.511484] Starting subtest: reset-unsignaled [599.513382] Subtest reset-unsignaled: SUCCESS (0.000s) [599.634189] [122/155] (425s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [599.725123] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip [600.538180] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.815s) [600.712278] [123/155] (424s left) api_intel_allocator (gem-pool) [600.764137] Starting subtest: gem-pool [600.769724] Subtest gem-pool: SUCCESS (0.006s) [600.887557] [124/155] (424s left) gem_mmap_gtt (big-copy-xy) [600.942881] Subtest big-copy-XY: SKIP (0.000s) [601.005288] [125/155] (423s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [601.099855] Starting subtest: psr-rgb565-draw-mmap-gtt [601.104436] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [601.212222] [126/155] (423s left) kms_psr2_sf (pr-plane-move-sf-dmg-area) [601.314201] Starting subtest: pr-plane-move-sf-dmg-area [601.318509] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s) [601.382739] [127/155] (423s left) kms_big_fb (4-tiled-8bpp-rotate-0) [601.471674] Starting subtest: 4-tiled-8bpp-rotate-0 [602.707750] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.235s) [602.830387] [128/155] (422s left) gem_fence_thrash (bo-write-verify-none) [602.859032] Starting subtest: bo-write-verify-none [602.883091] Subtest bo-write-verify-none: SKIP (0.023s) [602.945072] [129/155] (422s left) kms_flip (wf_vblank-ts-check-interruptible) [603.032518] Starting subtest: wf_vblank-ts-check-interruptible [603.034479] Starting dynamic subtest: A-eDP1 [611.970746] Dynamic subtest A-eDP1: SUCCESS (8.935s) [611.983051] Starting dynamic subtest: B-eDP1 [620.905514] Dynamic subtest B-eDP1: SUCCESS (8.934s) [620.918601] Starting dynamic subtest: C-eDP1 [629.816774] Dynamic subtest C-eDP1: SUCCESS (8.910s) [629.829297] Starting dynamic subtest: D-eDP1 [638.740279] Dynamic subtest D-eDP1: SUCCESS (8.923s) [638.746305] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.711s) [639.960869] [130/155] (385s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-render) [640.068794] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-render [640.072805] Subtest psrhdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [640.157471] [131/155] (385s left) kms_chamelium_frames (dp-crc-multiple) [640.546226] Subtest dp-crc-multiple: SKIP (0.000s) [641.371043] [132/155] (383s left) gem_exec_whisper (basic-queues-priority) [641.431527] Starting subtest: basic-queues-priority [664.292270] Subtest basic-queues-priority: SUCCESS (22.861s) [664.478889] [133/155] (360s left) gem_render_copy_redux (interruptible) [664.531684] Starting subtest: interruptible [664.946648] Subtest interruptible: SUCCESS (0.415s) [665.088449] [134/155] (360s left) i915_hangman (gt-engine-hang) [665.154905] Starting subtest: gt-engine-hang [665.156849] Starting dynamic subtest: rcs0 [666.271473] Dynamic subtest rcs0: SUCCESS (1.115s) [666.287320] Starting dynamic subtest: bcs0 [668.255039] Dynamic subtest bcs0: SUCCESS (1.981s) [668.269606] Starting dynamic subtest: vcs0 [670.240026] Dynamic subtest vcs0: SUCCESS (1.982s) [670.254585] Starting dynamic subtest: vcs1 [672.289905] Dynamic subtest vcs1: SUCCESS (2.046s) [672.305486] Starting dynamic subtest: vecs0 [674.272195] Dynamic subtest vecs0: SUCCESS (1.980s) [674.286331] Starting dynamic subtest: ccs0 [676.256358] Dynamic subtest ccs0: SUCCESS (1.981s) [676.259529] Subtest gt-engine-hang: SUCCESS (11.103s) [676.382473] [135/155] (349s left) kms_flip (2x-flip-vs-expired-vblank-interruptible) [676.477342] Starting subtest: 2x-flip-vs-expired-vblank-interruptible [676.488744] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s) [676.566532] [136/155] (348s left) perf (rc6-disable) [676.641962] Starting subtest: rc6-disable [676.819623] Subtest rc6-disable: SUCCESS (0.177s) [676.863844] [137/155] (348s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [676.955526] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu [676.959591] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [677.053892] [138/155] (348s left) kms_content_protection (legacy-hdcp14) [677.189855] Starting subtest: legacy-hdcp14 [677.194520] Subtest legacy-hdcp14: SKIP (0.000s) [677.311766] [139/155] (348s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render) [677.415451] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render [684.705947] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.295s) [684.848494] [140/155] (340s left) kms_addfb_basic (unused-offsets) [684.898026] Starting subtest: unused-offsets [684.900282] Subtest unused-offsets: SUCCESS (0.000s) [685.034524] [141/155] (340s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs) [685.123972] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs [685.126591] Starting dynamic subtest: pipe-A-eDP-1 [685.150693] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [685.164129] Starting dynamic subtest: pipe-B-eDP-1 [685.185742] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [685.197030] Starting dynamic subtest: pipe-C-eDP-1 [685.218471] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [685.229337] Starting dynamic subtest: pipe-D-eDP-1 [685.251250] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [685.255630] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s) [687.375500] [142/155] (338s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc) [687.473367] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc [687.477769] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [687.583060] [143/155] (338s left) i915_selftest (perf) [690.920067] Starting subtest: perf [690.922455] Starting dynamic subtest: engine_cs [696.231214] Dynamic subtest engine_cs: SUCCESS (5.311s) [696.242599] Starting dynamic subtest: request [703.506212] Dynamic subtest request: SUCCESS (7.273s) [703.517171] Starting dynamic subtest: migrate [707.868236] Dynamic subtest migrate: SUCCESS (4.360s) [707.878191] Starting dynamic subtest: region [713.557939] Dynamic subtest region: SUCCESS (5.688s) [713.560529] Subtest perf: SUCCESS (22.639s) [713.588220] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [713.588916] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true [713.591821] [144/155] (312s left) gem_ppgtt (shrink-vs-evict-pinned) [715.127917] Starting subtest: shrink-vs-evict-pinned [722.267754] Subtest shrink-vs-evict-pinned: SUCCESS (7.139s) [722.350283] [FACT gem_ppgtt (shrink-vs-evict-pinned)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [722.351917] [FACT gem_ppgtt (shrink-vs-evict-pinned)] new: kernel.kmod_is_loaded.i915: true [722.356377] [145/155] (303s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt) [722.468070] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt [722.472266] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [722.564320] [146/155] (303s left) kms_joiner (basic-big-joiner) [722.654520] Starting subtest: basic-big-joiner [722.658384] Subtest basic-big-joiner: SKIP (0.000s) [722.718366] [147/155] (303s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [722.840675] Starting subtest: cursorB-vs-flipB-atomic-transitions [722.845326] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s) [723.000400] [148/155] (302s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt) [723.093459] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt [723.097643] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [723.191498] [149/155] (302s left) gem_mmap_gtt (cpuset-basic-small-copy-odd) [723.242260] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s) [723.308930] [150/155] (302s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-gtt) [723.401841] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-gtt [723.405426] Subtest fbcpsrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [723.505227] [151/155] (302s left) kms_chamelium_color (ctm-max) [723.600189] Subtest ctm-max: SKIP (0.000s) [723.643524] [152/155] (302s left) kms_pm_rpm (system-suspend-idle) [726.684855] Starting subtest: system-suspend-idle [745.868634] Subtest system-suspend-idle: SUCCESS (4.299s) [746.260578] [153/155] (279s left) kms_psr (fbc-pr-primary-blt) [746.363243] Starting subtest: fbc-pr-primary-blt [746.368003] Subtest fbc-pr-primary-blt: SKIP (0.000s) [746.443464] [154/155] (279s left) gem_userptr_blits (forbidden-operations) [746.505927] Starting subtest: forbidden-operations [746.510211] Subtest forbidden-operations: SKIP (0.000s) [746.624576] [155/155] (279s left) syncobj_timeline (wait-zero-handles) [746.672102] Starting subtest: wait-zero-handles [746.674700] Subtest wait-zero-handles: SUCCESS (0.000s) [746.765781] Closing watchdogs results: parsing output: 0/ for test: kms_busy results: parsing output: 1/ for test: perf results: parsing output: 2/ for test: gem_tiling_max_stride results: parsing output: 3/ for test: gem_exec_fence results: parsing output: 4/ for test: gem_mmap_wc results: parsing output: 5/ for test: api_intel_bb results: parsing output: 6/ for test: gem_exec_store results: parsing output: 7/ for test: kms_draw_crc results: parsing output: 8/ for test: kms_psr results: parsing output: 9/ for test: kms_addfb_basic results: parsing output: 10/ for test: dmabuf_sync_file results: parsing output: 11/ for test: kms_vblank results: parsing output: 12/ for test: gem_exec_schedule results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: gem_workarounds results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: gem_exec_balancer results: parsing output: 20/ for test: gem_eio results: parsing output: 21/ for test: gem_render_copy results: parsing output: 22/ for test: syncobj_timeline results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: gem_exec_parallel results: parsing output: 27/ for test: syncobj_timeline results: parsing output: 28/ for test: kms_psr results: parsing output: 29/ for test: syncobj_timeline results: parsing output: 30/ for test: kms_big_fb results: parsing output: 31/ for test: prime_busy results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_plane results: parsing output: 37/ for test: gem_ctx_persistence results: parsing output: 38/ for test: gem_basic results: parsing output: 39/ for test: gem_pxp results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: gem_exec_schedule results: parsing output: 42/ for test: gem_busy results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: gem_set_tiling_vs_blt results: parsing output: 45/ for test: gem_partial_pwrite_pread results: parsing output: 46/ for test: syncobj_timeline results: parsing output: 47/ for test: kms_psr results: parsing output: 48/ for test: kms_plane_cursor results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: gem_render_copy results: parsing output: 51/ for test: kms_ccs results: parsing output: 52/ for test: kms_flip_scaled_crc results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: sw_sync results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: kms_ccs results: parsing output: 57/ for test: gem_ctx_shared results: parsing output: 58/ for test: gem_eio results: parsing output: 59/ for test: kms_cursor_legacy results: parsing output: 60/ for test: gem_mmap_gtt results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: kms_cursor_crc results: parsing output: 63/ for test: kms_pm_rpm results: parsing output: 64/ for test: kms_lease results: parsing output: 65/ for test: kms_getfb results: parsing output: 66/ for test: gem_mmap_wc results: parsing output: 67/ for test: kms_flip_scaled_crc results: parsing output: 68/ for test: gen7_exec_parse results: parsing output: 69/ for test: perf_pmu results: parsing output: 70/ for test: kms_panel_fitting results: parsing output: 71/ for test: gem_userptr_blits results: parsing output: 72/ for test: kms_rotation_crc results: parsing output: 73/ for test: kms_psr results: parsing output: 74/ for test: kms_cursor_crc results: parsing output: 75/ for test: kms_big_fb results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_addfb_basic results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_flip results: parsing output: 81/ for test: kms_big_fb results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: gem_exec_balancer results: parsing output: 84/ for test: kms_big_fb results: parsing output: 85/ for test: gem_exec_flush results: parsing output: 86/ for test: gem_exec_reloc results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: gem_spin_batch results: parsing output: 89/ for test: gem_madvise results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: kms_plane_scaling results: parsing output: 92/ for test: gem_softpin results: parsing output: 93/ for test: gem_create results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: gem_ctx_persistence results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_atomic_transition results: parsing output: 101/ for test: kms_color_pipeline results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_plane_multiple results: parsing output: 105/ for test: i915_drm_fdinfo results: parsing output: 106/ for test: sw_sync results: parsing output: 107/ for test: kms_sequence results: parsing output: 108/ for test: gem_exec_params results: parsing output: 109/ for test: gem_softpin results: parsing output: 110/ for test: kms_plane_scaling results: parsing output: 111/ for test: syncobj_wait results: parsing output: 112/ for test: kms_chamelium_hpd results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: i915_pm_rc6_residency results: parsing output: 115/ for test: gem_mmap_offset results: parsing output: 116/ for test: kms_ccs results: parsing output: 117/ for test: kms_psr2_sf results: parsing output: 118/ for test: gem_wait results: parsing output: 119/ for test: kms_cursor_crc results: parsing output: 120/ for test: syncobj_timeline results: parsing output: 121/ for test: kms_big_fb results: parsing output: 122/ for test: api_intel_allocator results: parsing output: 123/ for test: gem_mmap_gtt results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_psr2_sf results: parsing output: 126/ for test: kms_big_fb results: parsing output: 127/ for test: gem_fence_thrash results: parsing output: 128/ for test: kms_flip results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_chamelium_frames results: parsing output: 131/ for test: gem_exec_whisper results: parsing output: 132/ for test: gem_render_copy_redux results: parsing output: 133/ for test: i915_hangman results: parsing output: 134/ for test: kms_flip results: parsing output: 135/ for test: perf results: parsing output: 136/ for test: kms_frontbuffer_tracking results: parsing output: 137/ for test: kms_content_protection results: parsing output: 138/ for test: kms_frontbuffer_tracking results: parsing output: 139/ for test: kms_addfb_basic results: parsing output: 140/ for test: kms_ccs results: parsing output: 141/ for test: kms_frontbuffer_tracking results: parsing output: 142/ for test: i915_selftest results: parsing output: 143/ for test: gem_ppgtt results: parsing output: 144/ for test: kms_frontbuffer_tracking results: parsing output: 145/ for test: kms_joiner results: parsing output: 146/ for test: kms_cursor_legacy results: parsing output: 147/ for test: kms_frontbuffer_tracking results: parsing output: 148/ for test: gem_mmap_gtt results: parsing output: 149/ for test: kms_frontbuffer_tracking results: parsing output: 150/ for test: kms_chamelium_color results: parsing output: 151/ for test: kms_pm_rpm results: parsing output: 152/ for test: kms_psr results: parsing output: 153/ for test: gem_userptr_blits results: parsing output: 154/ for test: syncobj_timeline Done.