[59.459515] Initializing watchdogs [59.459579] /dev/watchdog0 [59.478210] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [59.488235] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [59.492332] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.494790] [001/130] (960s left) gem_userptr_blits (unsync-unmap) [59.668940] Subtest unsync-unmap: SKIP (0.000s) [59.837469] [002/130] (960s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5) [60.051185] Starting subtest: planes-upscale-20x20-downscale-factor-0-5 [60.052049] Starting dynamic subtest: pipe-A [60.175015] Dynamic subtest pipe-A: SUCCESS (0.124s) [60.183253] Starting dynamic subtest: pipe-B [60.378554] Dynamic subtest pipe-B: SUCCESS (0.203s) [60.389735] Starting dynamic subtest: pipe-C [60.597398] Dynamic subtest pipe-C: SUCCESS (0.219s) [60.607493] Starting dynamic subtest: pipe-D [60.819620] Dynamic subtest pipe-D: SUCCESS (0.222s) [60.820507] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.768s) [61.130946] [003/130] (958s left) kms_psr (psr-cursor-blt) [61.331307] Subtest psr-cursor-blt: SKIP (0.000s) [61.390683] [004/130] (958s left) kms_psr (fbc-psr2-primary-page-flip) [61.598487] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s) [61.658521] [005/130] (958s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs) [61.744330] Starting subtest: mixed-tiled-to-yf-tiled-ccs [61.746621] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s) [61.997728] [006/130] (958s left) gem_ctx_engines (execute-oneforall) [62.078182] Starting subtest: execute-oneforall [62.691276] Subtest execute-oneforall: SUCCESS (0.613s) [63.321887] [007/130] (956s left) kms_vblank (wait-idle-hang) [63.522173] Starting subtest: wait-idle-hang [63.524057] Starting dynamic subtest: pipe-A-DP-3 [89.639130] Dynamic subtest pipe-A-DP-3: SUCCESS (26.110s) [89.648254] Starting dynamic subtest: pipe-D-DP-3 [114.567612] Dynamic subtest pipe-D-DP-3: SUCCESS (24.925s) [114.568516] Subtest wait-idle-hang: SUCCESS (51.040s) [114.803134] [008/130] (905s left) gem_exec_balancer (parallel-keep-in-fence) [115.168308] Starting subtest: parallel-keep-in-fence [117.158515] Subtest parallel-keep-in-fence: SUCCESS (1.990s) [117.263319] [009/130] (903s left) drm_fdinfo (virtual-busy) [117.325949] Starting subtest: virtual-busy [117.327799] Subtest virtual-busy: SKIP (0.001s) [117.416709] [010/130] (903s left) kms_big_fb (4-tiled-16bpp-rotate-270) [117.639291] Starting subtest: 4-tiled-16bpp-rotate-270 [117.688530] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.049s) [117.915705] [011/130] (902s left) kms_big_fb (x-tiled-8bpp-rotate-90) [118.124361] Starting subtest: x-tiled-8bpp-rotate-90 [118.172375] Subtest x-tiled-8bpp-rotate-90: SKIP (0.048s) [118.356943] [012/130] (902s left) gem_mmap_gtt (cpuset-basic-small-copy) [118.430057] Subtest cpuset-basic-small-copy: SKIP (0.000s) [118.495104] [013/130] (902s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [118.704389] Starting subtest: yf-tiled-8bpp-rotate-90 [118.706173] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [118.843621] [014/130] (901s left) kms_addfb_basic (master-rmfb) [118.915152] Starting subtest: master-rmfb [118.926162] Subtest master-rmfb: SUCCESS (0.011s) [119.184367] [015/130] (901s left) kms_cursor_crc (cursor-onscreen-256x85) [119.575066] Starting subtest: cursor-onscreen-256x85 [119.579182] Starting dynamic subtest: pipe-A-DP-3 [122.265603] Dynamic subtest pipe-A-DP-3: SUCCESS (2.686s) [122.312205] Starting dynamic subtest: pipe-D-DP-3 [124.912294] Dynamic subtest pipe-D-DP-3: SUCCESS (2.607s) [124.913187] Subtest cursor-onscreen-256x85: SUCCESS (5.337s) [125.222273] [016/130] (895s left) kms_plane_alpha_blend (constant-alpha-min) [125.423173] Starting subtest: constant-alpha-min [125.653270] Starting dynamic subtest: pipe-A-DP-3 [126.342419] Dynamic subtest pipe-A-DP-3: SUCCESS (0.689s) [126.350222] Starting dynamic subtest: pipe-D-DP-3 [127.104135] Dynamic subtest pipe-D-DP-3: SUCCESS (0.760s) [127.105112] Subtest constant-alpha-min: SUCCESS (1.680s) [127.351257] [017/130] (893s left) syncobj_timeline (wait-all-for-submit-complex) [127.429603] Starting subtest: wait-all-for-submit-complex [127.654678] Subtest wait-all-for-submit-complex: SUCCESS (0.218s) [127.738739] [018/130] (893s left) kms_force_connector_basic (force-connector-state) [127.852348] Starting subtest: force-connector-state [128.237964] Subtest force-connector-state: SUCCESS (0.385s) [128.653981] [019/130] (892s left) gem_exec_store (pages) [128.736814] Starting subtest: pages [128.737778] Starting dynamic subtest: rcs0 [128.848196] Dynamic subtest rcs0: SUCCESS (0.111s) [128.856188] Starting dynamic subtest: bcs0 [128.937491] Dynamic subtest bcs0: SUCCESS (0.089s) [128.945659] Starting dynamic subtest: vcs0 [129.025209] Dynamic subtest vcs0: SUCCESS (0.088s) [129.033529] Starting dynamic subtest: vcs1 [129.118692] Dynamic subtest vcs1: SUCCESS (0.093s) [129.127156] Starting dynamic subtest: vecs0 [129.212530] Dynamic subtest vecs0: SUCCESS (0.094s) [129.220514] Starting dynamic subtest: vecs1 [129.304650] Dynamic subtest vecs1: SUCCESS (0.092s) [129.312458] Starting dynamic subtest: ccs0 [129.395849] Dynamic subtest ccs0: SUCCESS (0.091s) [129.396953] Subtest pages: SUCCESS (0.659s) [129.619022] [020/130] (891s left) kms_psr (pr-no-drrs) [129.818531] Subtest pr-no-drrs: SKIP (0.000s) [129.877026] [021/130] (891s left) gem_exec_balancer (bonded-sync) [129.961496] Starting subtest: bonded-sync [129.963474] Subtest bonded-sync: SKIP (0.000s) [130.352690] [022/130] (890s left) kms_flip (2x-flip-vs-fences-interruptible) [130.562169] Starting subtest: 2x-flip-vs-fences-interruptible [130.564034] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s) [130.693219] [023/130] (890s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc) [130.897440] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc [130.899237] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [131.023501] [024/130] (890s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy) [131.232804] Starting subtest: fbcpsr-modesetfrombusy [131.234434] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s) [131.353683] [025/130] (890s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc) [131.577180] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc [131.578122] Starting dynamic subtest: pipe-A-DP-3 [131.586801] Dynamic subtest pipe-A-DP-3: SKIP (0.001s) [131.594522] Starting dynamic subtest: pipe-B-DP-3 [131.603210] Dynamic subtest pipe-B-DP-3: SKIP (0.001s) [131.610785] Starting dynamic subtest: pipe-C-DP-3 [131.619266] Dynamic subtest pipe-C-DP-3: SKIP (0.001s) [131.626532] Starting dynamic subtest: pipe-D-DP-3 [131.637553] Dynamic subtest pipe-D-DP-3: SKIP (0.001s) [131.639838] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.006s) [132.043147] [026/130] (889s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu) [132.246445] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu [132.248144] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [132.382408] [027/130] (889s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf) [132.586305] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s) [132.633977] [028/130] (888s left) gem_lmem_swapping (parallel-random-engines) [135.473846] Starting subtest: parallel-random-engines [135.475043] Starting dynamic subtest: lmem0 [170.197925] Dynamic subtest lmem0: SUCCESS (34.724s) [170.199044] Subtest parallel-random-engines: SUCCESS (34.724s) [171.523880] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: kernel.kmod_is_loaded.i915: true [171.525753] [029/130] (850s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [173.416693] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [173.418379] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [173.588973] [FACT kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)] new: kernel.kmod_is_loaded.i915: true [173.589852] [FACT kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)] new: kernel.kmod_is_loaded.xe: true [173.591790] [030/130] (848s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render) [173.801586] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render [173.803389] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [173.965248] [031/130] (847s left) kms_dp_linktrain_fallback (dsc-fallback) [174.165497] Starting subtest: dsc-fallback [174.168161] Subtest dsc-fallback: SKIP (0.000s) [174.314765] [032/130] (847s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt) [174.518802] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt [174.520515] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [174.650659] [033/130] (847s left) gem_workarounds (basic-read-fd) [174.739969] Starting subtest: basic-read-fd [174.785297] Subtest basic-read-fd: SUCCESS (0.045s) [174.980542] [034/130] (847s left) drm_fdinfo (all-busy-check-all) [175.046436] Starting subtest: all-busy-check-all [175.070340] Subtest all-busy-check-all: SKIP (0.023s) [175.160602] [035/130] (846s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip) [175.407398] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip [176.651476] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.243s) [176.817887] [036/130] (845s left) gem_exec_whisper (basic-fds-priority-all) [176.903249] Starting subtest: basic-fds-priority-all [199.603403] Subtest basic-fds-priority-all: SUCCESS (22.698s) [199.855801] [037/130] (822s left) syncobj_timeline (reset-multiple-signaled) [199.923577] Starting subtest: reset-multiple-signaled [199.924442] Subtest reset-multiple-signaled: SUCCESS (0.001s) [200.076604] [038/130] (822s left) kms_cursor_legacy (flip-vs-cursor-atomic) [200.275639] Starting subtest: flip-vs-cursor-atomic [209.722507] Subtest flip-vs-cursor-atomic: SUCCESS (9.446s) [209.995442] [039/130] (812s left) gem_shrink (reclaim) [210.072062] Starting subtest: reclaim [212.325070] Subtest reclaim: SUCCESS (2.252s) [212.419742] [040/130] (809s left) kms_atomic_transition (plane-all-transition-fencing) [212.641461] Starting subtest: plane-all-transition-fencing [212.643438] Starting dynamic subtest: pipe-A-DP-3 [216.358456] Dynamic subtest pipe-A-DP-3: SUCCESS (3.714s) [216.444274] Starting dynamic subtest: pipe-B-DP-3 [220.209711] Dynamic subtest pipe-B-DP-3: SUCCESS (3.777s) [220.262727] Subtest plane-all-transition-fencing: SUCCESS (7.620s) [220.519238] [041/130] (801s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic) [220.718533] Starting subtest: 2x-flip-vs-cursor-atomic [220.721358] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.002s) [220.800357] [042/130] (801s left) kms_rotation_crc (sprite-rotation-180) [220.996265] Starting subtest: sprite-rotation-180 [227.865958] Subtest sprite-rotation-180: SUCCESS (6.868s) [228.244398] [043/130] (794s left) gem_exec_fence (syncobj-wait) [228.813298] Starting subtest: syncobj-wait [228.883471] Subtest syncobj-wait: SUCCESS (0.070s) [229.295372] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true [229.297518] [044/130] (793s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move) [229.507988] Starting subtest: psr-2p-scndscrn-cur-indfb-move [229.509815] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [229.654513] [045/130] (793s left) kms_psr (psr2-cursor-mmap-cpu) [229.865618] Subtest psr2-cursor-mmap-cpu: SKIP (0.000s) [229.919784] [046/130] (792s left) gem_exec_schedule (in-order) [230.011257] Starting subtest: in-order [230.012218] Starting dynamic subtest: rcs0 [230.281577] Dynamic subtest rcs0: SUCCESS (0.270s) [230.290476] Starting dynamic subtest: bcs0 [230.474179] Dynamic subtest bcs0: SUCCESS (0.192s) [230.483169] Starting dynamic subtest: vcs0 [230.671420] Dynamic subtest vcs0: SUCCESS (0.197s) [230.680378] Starting dynamic subtest: vcs1 [230.874096] Dynamic subtest vcs1: SUCCESS (0.202s) [230.883147] Starting dynamic subtest: vecs0 [231.074111] Dynamic subtest vecs0: SUCCESS (0.200s) [231.083098] Starting dynamic subtest: vecs1 [231.274296] Dynamic subtest vecs1: SUCCESS (0.200s) [231.283268] Starting dynamic subtest: ccs0 [231.477390] Dynamic subtest ccs0: SUCCESS (0.203s) [231.478416] Subtest in-order: SUCCESS (1.466s) [231.953926] [047/130] (790s left) api_intel_bb (full-batch) [232.031911] Starting subtest: full-batch [232.058803] Subtest full-batch: SUCCESS (0.027s) [232.249317] [048/130] (790s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling) [232.460409] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling [232.461333] Starting dynamic subtest: pipe-A-valid-mode [232.538473] Dynamic subtest pipe-A-valid-mode: SKIP (0.076s) [232.540324] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.077s) [232.732919] [049/130] (790s left) gem_exec_create (basic) [232.824518] Starting subtest: basic [232.825461] Starting dynamic subtest: smem [234.923768] Dynamic subtest smem: SUCCESS (2.099s) [234.933489] Starting dynamic subtest: lmem0 [237.028596] Dynamic subtest lmem0: SUCCESS (2.104s) [237.029652] Subtest basic: SUCCESS (4.204s) [237.231485] [050/130] (785s left) gem_exec_parallel (fds) [237.323792] Starting subtest: fds [237.324752] Starting dynamic subtest: rcs0 [241.847976] Dynamic subtest rcs0: SUCCESS (4.523s) [241.859136] Starting dynamic subtest: bcs0 [246.499025] Dynamic subtest bcs0: SUCCESS (4.649s) [246.508515] Starting dynamic subtest: vcs0 [251.064426] Dynamic subtest vcs0: SUCCESS (4.566s) [251.073524] Starting dynamic subtest: vcs1 [255.535676] Dynamic subtest vcs1: SUCCESS (4.470s) [255.544325] Starting dynamic subtest: vecs0 [259.779463] Dynamic subtest vecs0: SUCCESS (4.243s) [259.788826] Starting dynamic subtest: vecs1 [263.147633] Dynamic subtest vecs1: SUCCESS (3.367s) [263.156945] Starting dynamic subtest: ccs0 [266.337136] Dynamic subtest ccs0: SUCCESS (3.188s) [266.338398] Subtest fds: SUCCESS (29.011s) [266.631698] [051/130] (756s left) perf (gen12-oa-tlb-invalidate) [266.963337] Starting subtest: gen12-oa-tlb-invalidate [266.964254] Starting dynamic subtest: 0-rcs0 [277.006502] Dynamic subtest 0-rcs0: SUCCESS (10.042s) [277.007451] Subtest gen12-oa-tlb-invalidate: SUCCESS (10.043s) [277.060911] [052/130] (746s left) gen7_exec_parse (basic-allocation) [277.149803] Subtest basic-allocation: SKIP (0.000s) [277.227800] [053/130] (745s left) kms_lease (lease-uevent) [277.436434] Starting subtest: lease-uevent [278.455795] Subtest lease-uevent: SUCCESS (1.019s) [278.563852] [054/130] (744s left) kms_hdr (static-toggle-suspend) [278.772373] Starting subtest: static-toggle-suspend [282.177661] Starting dynamic subtest: pipe-A-DP-3 [302.771899] Dynamic subtest pipe-A-DP-3: SUCCESS (5.049s) [302.772910] Subtest static-toggle-suspend: SUCCESS (8.454s) [303.110347] [055/130] (735s left) kms_cursor_legacy (cursora-vs-flipa-toggle) [303.318650] Starting subtest: cursorA-vs-flipA-toggle [314.228968] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.910s) [314.500300] [056/130] (724s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu) [314.707518] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu [314.709297] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [314.835730] [057/130] (724s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite) [315.048602] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite [315.050427] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [315.199452] [058/130] (723s left) kms_chamelium_hpd (hdmi-hpd-storm-disable) [315.497449] Subtest hdmi-hpd-storm-disable: SKIP (0.000s) [315.674170] [059/130] (723s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [315.893075] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [315.894904] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [316.066372] [060/130] (723s left) syncobj_basic (bad-destroy) [316.145107] Starting subtest: bad-destroy [316.146119] Subtest bad-destroy: SUCCESS (0.000s) [316.258738] [061/130] (722s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [316.464828] Starting subtest: addfb25-yf-tiled-legacy [316.465667] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [316.617766] [062/130] (722s left) kms_content_protection (legacy) [316.881208] Starting subtest: legacy [317.147483] Starting dynamic subtest: pipe-A-DP-3 [439.783191] Dynamic subtest pipe-A-DP-3: FAIL (122.357s) [439.784400] Subtest legacy: FAIL (122.719s) [439.879208] [063/130] (599s left) kms_flip (modeset-vs-vblank-race) [440.089717] Starting subtest: modeset-vs-vblank-race [440.094356] Starting dynamic subtest: A-DP3 [443.336592] Dynamic subtest A-DP3: SUCCESS (3.241s) [443.379848] Starting dynamic subtest: B-DP3 [446.431758] Dynamic subtest B-DP3: SUCCESS (3.089s) [446.474049] Starting dynamic subtest: C-DP3 [449.571716] Dynamic subtest C-DP3: SUCCESS (3.134s) [449.614286] Starting dynamic subtest: D-DP3 [452.828716] Dynamic subtest D-DP3: SUCCESS (3.251s) [452.836802] Subtest modeset-vs-vblank-race: SUCCESS (12.746s) [453.238866] [064/130] (586s left) gem_exec_balancer (sliced) [453.338601] Starting subtest: sliced [453.340669] Subtest sliced: SKIP (0.000s) [453.681290] [065/130] (585s left) gen9_exec_parse (secure-batches) [453.770120] Subtest secure-batches: SKIP (0.000s) [453.840838] [066/130] (585s left) kms_pm_rpm (dpms-lpsp) [455.589486] Starting subtest: dpms-lpsp [455.592121] Subtest dpms-lpsp: SKIP (0.001s) [455.952934] [067/130] (583s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc) [456.163713] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc [456.165484] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [456.293806] [068/130] (583s left) drm_read (short-buffer-block) [456.572103] Starting subtest: short-buffer-block [456.572978] Subtest short-buffer-block: SUCCESS (0.000s) [456.832484] [069/130] (582s left) kms_big_fb (x-tiled-64bpp-rotate-0) [457.048087] Starting subtest: x-tiled-64bpp-rotate-0 [458.921874] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.872s) [459.138793] [070/130] (580s left) kms_plane (plane-panning-bottom-right) [459.344202] Starting subtest: plane-panning-bottom-right [459.346563] Starting dynamic subtest: pipe-A [460.122249] Dynamic subtest pipe-A: SUCCESS (0.775s) [460.138955] Starting dynamic subtest: pipe-B [460.776865] Dynamic subtest pipe-B: SUCCESS (0.652s) [460.777782] Subtest plane-panning-bottom-right: SUCCESS (1.432s) [461.023882] [071/130] (578s left) core_setmaster (master-drop-set-shared-fd) [463.384727] Starting subtest: master-drop-set-shared-fd [463.417390] Subtest master-drop-set-shared-fd: SUCCESS (0.033s) [463.461472] [FACT core_setmaster (master-drop-set-shared-fd)] new: kernel.kmod_is_loaded.amdgpu: true [463.464937] [072/130] (576s left) gem_exec_reloc (basic-gtt-wc-noreloc) [463.550486] Subtest basic-gtt-wc-noreloc: SKIP (0.000s) [463.628559] [073/130] (576s left) perf (invalid-oa-exponent) [463.838043] Starting subtest: invalid-oa-exponent [463.858915] Subtest invalid-oa-exponent: SUCCESS (0.020s) [463.914473] [074/130] (576s left) perf_pmu (most-busy-idle-check-all) [463.986867] Starting subtest: most-busy-idle-check-all [463.987852] Starting dynamic subtest: rcs0 [464.684736] Dynamic subtest rcs0: FAIL (0.670s) [464.702457] Starting dynamic subtest: bcs0 [465.316983] Dynamic subtest bcs0: SUCCESS (0.656s) [465.334189] Starting dynamic subtest: vcs0 [465.972947] Dynamic subtest vcs0: SUCCESS (0.654s) [465.987990] Starting dynamic subtest: vcs1 [466.624039] Dynamic subtest vcs1: SUCCESS (0.650s) [466.638217] Starting dynamic subtest: vecs0 [467.278067] Dynamic subtest vecs0: SUCCESS (0.653s) [467.293448] Starting dynamic subtest: vecs1 [467.930215] Dynamic subtest vecs1: SUCCESS (0.651s) [467.944276] Starting dynamic subtest: ccs0 [468.583944] Dynamic subtest ccs0: SUCCESS (0.653s) [468.584903] Subtest most-busy-idle-check-all: FAIL (4.597s) [468.731034] [075/130] (571s left) kms_prop_blob (invalid-set-prop-any) [468.811052] Starting subtest: invalid-set-prop-any [468.812078] Subtest invalid-set-prop-any: SUCCESS (0.000s) [468.932651] [076/130] (571s left) gem_mmap_offset (clear-via-pagefault) [469.014120] Starting subtest: clear-via-pagefault [469.015194] Starting dynamic subtest: lmem0 [493.257041] Dynamic subtest lmem0: SUCCESS (24.238s) [493.269247] Starting dynamic subtest: smem0 [518.016154] Dynamic subtest smem0: SUCCESS (24.759s) [518.017097] Subtest clear-via-pagefault: SUCCESS (48.999s) [518.286298] [077/130] (522s left) gem_exec_params (rsvd2-dirt) [518.388495] Starting subtest: rsvd2-dirt [518.390215] Subtest rsvd2-dirt: SKIP (0.000s) [518.502206] [078/130] (521s left) kms_vblank (query-idle) [518.720138] Starting subtest: query-idle [518.722351] Starting dynamic subtest: pipe-A-DP-3 [520.998595] Dynamic subtest pipe-A-DP-3: SUCCESS (2.276s) [521.016779] Starting dynamic subtest: pipe-D-DP-3 [523.246568] Dynamic subtest pipe-D-DP-3: SUCCESS (2.243s) [523.247479] Subtest query-idle: SUCCESS (4.526s) [523.484041] [079/130] (516s left) kms_addfb_basic (bad-pitch-999) [523.563109] Starting subtest: bad-pitch-999 [523.564061] Subtest bad-pitch-999: SUCCESS (0.000s) [523.865101] [080/130] (516s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt) [524.076958] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt [524.078843] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [524.217781] [081/130] (516s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [524.422216] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs [524.423982] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [524.719807] [082/130] (515s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [524.929250] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [524.931619] Starting dynamic subtest: pipe-A-DP-3 [524.954212] Dynamic subtest pipe-A-DP-3: SKIP (0.002s) [524.966316] Starting dynamic subtest: pipe-B-DP-3 [524.989036] Dynamic subtest pipe-B-DP-3: SKIP (0.002s) [525.001319] Starting dynamic subtest: pipe-C-DP-3 [525.028412] Dynamic subtest pipe-C-DP-3: SKIP (0.002s) [525.041229] Starting dynamic subtest: pipe-D-DP-3 [525.063320] Dynamic subtest pipe-D-DP-3: SKIP (0.002s) [525.065316] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.014s) [525.384199] [083/130] (515s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [525.469400] Subtest flip-primary-invalidate-overlay: SKIP (0.000s) [525.543133] [084/130] (515s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy) [525.637437] Starting subtest: map-fixed-invalidate-overlap-busy [525.639184] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s) [525.812852] [085/130] (515s left) gem_sync (basic-each) [525.902051] Starting subtest: basic-each [528.084845] Subtest basic-each: SUCCESS (2.183s) [528.346545] [086/130] (512s left) syncobj_timeline (multi-wait-all-available-submitted) [528.429499] Starting subtest: multi-wait-all-available-submitted [528.430351] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s) [528.574659] [087/130] (512s left) kms_flip (basic-flip-vs-wf_vblank) [528.784749] Starting subtest: basic-flip-vs-wf_vblank [528.789274] Starting dynamic subtest: A-DP3 [529.894064] Dynamic subtest A-DP3: SUCCESS (1.105s) [529.908861] Starting dynamic subtest: B-DP3 [530.952091] Dynamic subtest B-DP3: SUCCESS (1.056s) [530.966457] Starting dynamic subtest: C-DP3 [532.153890] Dynamic subtest C-DP3: SUCCESS (1.200s) [532.167923] Starting dynamic subtest: D-DP3 [533.190955] Dynamic subtest D-DP3: SUCCESS (1.036s) [533.193258] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.408s) [533.527715] [088/130] (507s left) kms_cursor_legacy (forked-bo) [533.743193] Starting subtest: forked-bo [533.744107] Starting dynamic subtest: pipe-A [539.164853] Dynamic subtest pipe-A: SUCCESS (5.420s) [539.191238] Starting dynamic subtest: pipe-B [544.598206] Dynamic subtest pipe-B: SUCCESS (5.432s) [544.623230] Starting dynamic subtest: pipe-C [550.051199] Dynamic subtest pipe-C: SUCCESS (5.451s) [550.078628] Starting dynamic subtest: pipe-D [555.488908] Dynamic subtest pipe-D: SUCCESS (5.435s) [555.513015] Starting dynamic subtest: all-pipes [560.923870] Dynamic subtest all-pipes: SUCCESS (5.433s) [560.924871] Subtest forked-bo: SUCCESS (27.182s) [561.027080] [089/130] (480s left) gem_madvise (dontneed-before-mmap) [561.081575] Starting subtest: dontneed-before-mmap [561.127081] Subtest dontneed-before-mmap: SUCCESS (0.046s) [561.281401] [090/130] (479s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt) [561.493666] Starting subtest: fbc-rgb565-draw-mmap-gtt [561.495507] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s) [561.636594] [091/130] (479s left) sriov_basic (enable-vfs-autoprobe-off) [561.715974] Subtest enable-vfs-autoprobe-off: SKIP (0.000s) [561.789428] [092/130] (479s left) gem_ctx_persistence (heartbeat-hostile) [561.881870] Starting subtest: heartbeat-hostile [561.883633] Subtest heartbeat-hostile: SKIP (0.000s) [562.028142] [093/130] (479s left) gem_ctx_param (set-priority-range) [562.106606] Starting subtest: set-priority-range [562.131022] Subtest set-priority-range: SUCCESS (0.024s) [562.286689] [094/130] (479s left) kms_chamelium_frames (dp-crc-single) [562.572687] Subtest dp-crc-single: SKIP (0.000s) [562.730663] [095/130] (478s left) i915_hangman (gt-engine-hang) [562.823979] Starting subtest: gt-engine-hang [562.824931] Starting dynamic subtest: rcs0 [563.658229] Dynamic subtest rcs0: SUCCESS (0.834s) [563.684952] Starting dynamic subtest: bcs0 [564.492036] Dynamic subtest bcs0: SUCCESS (0.832s) [564.510914] Starting dynamic subtest: vcs0 [565.234093] Dynamic subtest vcs0: SUCCESS (0.741s) [565.248211] Starting dynamic subtest: vcs1 [566.058202] Dynamic subtest vcs1: SUCCESS (0.823s) [566.076173] Starting dynamic subtest: vecs0 [566.885201] Dynamic subtest vecs0: SUCCESS (0.826s) [566.900535] Starting dynamic subtest: vecs1 [567.661073] Dynamic subtest vecs1: SUCCESS (0.774s) [567.678243] Starting dynamic subtest: ccs0 [568.502639] Dynamic subtest ccs0: SUCCESS (0.840s) [568.503853] Subtest gt-engine-hang: SUCCESS (5.680s) [568.711011] [096/130] (472s left) syncobj_wait (invalid-reset-bad-pad) [568.792867] Starting subtest: invalid-reset-bad-pad [568.793845] Subtest invalid-reset-bad-pad: SUCCESS (0.000s) [568.963947] [097/130] (472s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area) [569.183701] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s) [569.257416] [098/130] (472s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [569.469207] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc [569.471572] Starting dynamic subtest: pipe-A-DP-3 [569.480147] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [569.492224] Starting dynamic subtest: pipe-B-DP-3 [569.500807] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [569.512404] Starting dynamic subtest: pipe-C-DP-3 [569.520777] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [569.532490] Starting dynamic subtest: pipe-D-DP-3 [569.543070] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [569.545148] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s) [569.932273] [099/130] (471s left) gem_exec_reloc (basic-cpu-gtt) [570.023239] Subtest basic-cpu-gtt: SKIP (0.000s) [570.103790] [100/130] (471s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling) [570.309295] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling [570.311647] Starting dynamic subtest: pipe-A-valid-mode [570.384532] Dynamic subtest pipe-A-valid-mode: SKIP (0.072s) [570.386311] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.074s) [570.602383] [101/130] (471s left) gem_ctx_param (invalid-ctx-get) [570.686459] Starting subtest: invalid-ctx-get [570.687358] Subtest invalid-ctx-get: SUCCESS (0.000s) [570.790476] [102/130] (471s left) gem_exec_schedule (semaphore-codependency) [570.886399] Starting subtest: semaphore-codependency [570.921926] Subtest semaphore-codependency: SUCCESS (0.035s) [571.375057] [103/130] (470s left) kms_color (legacy-gamma-reset) [571.581244] Starting subtest: legacy-gamma-reset [571.582167] Starting dynamic subtest: pipe-A-DP-3 [571.811086] Dynamic subtest pipe-A-DP-3: SUCCESS (0.229s) [571.825809] Starting dynamic subtest: pipe-B-DP-3 [571.831042] Dynamic subtest pipe-B-DP-3: SUCCESS (0.019s) [571.844250] Starting dynamic subtest: pipe-C-DP-3 [571.849641] Dynamic subtest pipe-C-DP-3: SUCCESS (0.018s) [571.861606] Starting dynamic subtest: pipe-D-DP-3 [571.868195] Dynamic subtest pipe-D-DP-3: SUCCESS (0.018s) [571.869074] Subtest legacy-gamma-reset: SUCCESS (0.288s) [572.100077] [104/130] (470s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc) [572.316230] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc [572.318599] Starting dynamic subtest: pipe-A-DP-3 [572.328196] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [572.340661] Starting dynamic subtest: pipe-B-DP-3 [572.350464] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [572.362230] Starting dynamic subtest: pipe-C-DP-3 [572.372733] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [572.384839] Starting dynamic subtest: pipe-D-DP-3 [572.395557] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [572.397568] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s) [572.803551] [105/130] (469s left) kms_joiner (basic-ultra-joiner) [573.024149] Starting subtest: basic-ultra-joiner [573.025875] Subtest basic-ultra-joiner: SKIP (0.000s) [573.130949] [106/130] (469s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [573.342209] Starting subtest: sprite-rotation-90-pos-100-0 [573.344013] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [573.482508] [107/130] (468s left) perf_pmu (all-busy-idle-check-all) [573.554091] Starting subtest: all-busy-idle-check-all [574.246194] Subtest all-busy-idle-check-all: SUCCESS (0.692s) [574.425791] [108/130] (468s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [574.637206] Starting subtest: plane-scaler-with-clipping-clamping-rotation [574.638129] Starting dynamic subtest: pipe-A [575.023248] Dynamic subtest pipe-A: SUCCESS (0.385s) [575.051597] Starting dynamic subtest: pipe-B [575.509338] Dynamic subtest pipe-B: SUCCESS (0.484s) [575.541554] Starting dynamic subtest: pipe-C [575.994320] Dynamic subtest pipe-C: SUCCESS (0.482s) [576.025802] Starting dynamic subtest: pipe-D [576.479090] Dynamic subtest pipe-D: SUCCESS (0.482s) [576.480250] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (1.843s) [576.828739] [109/130] (465s left) kms_rotation_crc (primary-x-tiled-reflect-x-0) [577.039267] Starting subtest: primary-x-tiled-reflect-x-0 [587.481277] Subtest primary-x-tiled-reflect-x-0: SUCCESS (10.441s) [587.849486] [110/130] (454s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [587.930859] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [588.035033] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.103s) [588.141756] [111/130] (454s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt) [588.353620] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt [588.355496] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [588.486051] [112/130] (454s left) kms_psr (fbc-pr-sprite-mmap-gtt) [588.705952] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [588.777504] [113/130] (454s left) gem_exec_alignment (single) [588.866087] Starting subtest: single [588.868864] Subtest single: SUCCESS (0.004s) [589.016786] [114/130] (453s left) kms_busy (basic-hang) [589.235292] Starting subtest: basic-hang [589.237668] Starting dynamic subtest: flip-pipe-A [589.816826] Dynamic subtest flip-pipe-A: SUCCESS (0.578s) [589.846378] Starting dynamic subtest: modeset-pipe-A [590.835243] Dynamic subtest modeset-pipe-A: SUCCESS (1.015s) [590.864408] Starting dynamic subtest: flip-pipe-D [591.333066] Dynamic subtest flip-pipe-D: SUCCESS (0.491s) [591.347088] Starting dynamic subtest: modeset-pipe-D [592.250973] Dynamic subtest modeset-pipe-D: SUCCESS (0.917s) [592.251963] Subtest basic-hang: SUCCESS (3.016s) [592.555435] [115/130] (450s left) kms_cursor_crc (cursor-sliding-64x21) [592.883019] Starting subtest: cursor-sliding-64x21 [592.888056] Starting dynamic subtest: pipe-A-DP-3 [597.099658] Dynamic subtest pipe-A-DP-3: SUCCESS (4.212s) [597.147168] Starting dynamic subtest: pipe-D-DP-3 [601.392477] Dynamic subtest pipe-D-DP-3: SUCCESS (4.256s) [601.393432] Subtest cursor-sliding-64x21: SUCCESS (8.509s) [601.807470] [116/130] (441s left) i915_pm_rps (basic-api) [601.894515] Starting subtest: basic-api [601.896243] Subtest basic-api: SKIP (0.000s) [602.033244] [117/130] (441s left) gem_ctx_shared (q-in-order) [602.124836] Starting subtest: Q-in-order [602.125830] Starting dynamic subtest: rcs0 [602.387331] Dynamic subtest rcs0: SUCCESS (0.262s) [602.400618] Starting dynamic subtest: bcs0 [602.570048] Dynamic subtest bcs0: SUCCESS (0.181s) [602.583257] Starting dynamic subtest: vcs0 [602.752387] Dynamic subtest vcs0: SUCCESS (0.181s) [602.765511] Starting dynamic subtest: vcs1 [602.934553] Dynamic subtest vcs1: SUCCESS (0.181s) [602.949419] Starting dynamic subtest: vecs0 [603.119044] Dynamic subtest vecs0: SUCCESS (0.183s) [603.132627] Starting dynamic subtest: vecs1 [603.301686] Dynamic subtest vecs1: SUCCESS (0.181s) [603.314672] Starting dynamic subtest: ccs0 [603.487113] Dynamic subtest ccs0: SUCCESS (0.184s) [603.488110] Subtest Q-in-order: SUCCESS (1.363s) [603.791484] [118/130] (439s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu) [604.003683] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu [604.005597] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [604.171811] [119/130] (439s left) gem_pxp (reject-modify-context-protection-off-3) [606.789841] Starting subtest: reject-modify-context-protection-off-3 [606.792040] Subtest reject-modify-context-protection-off-3: SKIP (0.000s) [606.894997] [120/130] (436s left) vgem_basic (second-client) [606.953840] Starting subtest: second-client [606.987105] Subtest second-client: SUCCESS (0.033s) [607.091704] [121/130] (436s left) perf (missing-sample-flags) [607.265295] Starting subtest: missing-sample-flags [607.266281] Subtest missing-sample-flags: SUCCESS (0.000s) [607.316925] [122/130] (436s left) syncobj_timeline (invalid-signal-bad-pad) [607.394934] Starting subtest: invalid-signal-bad-pad [607.395835] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [607.575169] [123/130] (436s left) gem_mmap_wc (copy) [607.657983] Subtest copy: SKIP (0.000s) [607.732804] [124/130] (435s left) kms_panel_fitting (atomic-fastset) [607.939199] Starting subtest: atomic-fastset [607.941011] Subtest atomic-fastset: SKIP (0.000s) [608.041314] [125/130] (435s left) gem_softpin (evict-prime-sanity-check) [608.124953] Starting subtest: evict-prime-sanity-check [608.125897] Starting dynamic subtest: rcs0 [609.312072] Dynamic subtest rcs0: SUCCESS (1.187s) [609.334954] Starting dynamic subtest: bcs0 [610.445981] Dynamic subtest bcs0: SUCCESS (1.133s) [610.461960] Starting dynamic subtest: vcs0 [611.582065] Dynamic subtest vcs0: SUCCESS (1.135s) [611.597618] Starting dynamic subtest: vcs1 [612.701069] Dynamic subtest vcs1: SUCCESS (1.118s) [612.713970] Starting dynamic subtest: vecs0 [613.828062] Dynamic subtest vecs0: SUCCESS (1.126s) [613.845232] Starting dynamic subtest: vecs1 [614.949169] Dynamic subtest vecs1: SUCCESS (1.120s) [614.962831] Starting dynamic subtest: ccs0 [616.056043] Dynamic subtest ccs0: SUCCESS (1.106s) [616.068894] Starting dynamic subtest: all [617.181160] Dynamic subtest all: SUCCESS (1.124s) [617.182089] Subtest evict-prime-sanity-check: SUCCESS (9.057s) [617.289297] [126/130] (426s left) kms_feature_discovery (dp-mst) [617.498107] Starting subtest: dp-mst [617.499903] Subtest dp-mst: SKIP (0.000s) [617.588774] [127/130] (426s left) prime_vgem (basic-fence-read) [617.689317] Starting subtest: basic-fence-read [617.716241] Subtest basic-fence-read: SKIP (0.026s) [617.855711] [128/130] (426s left) gem_compute (compute-square) [617.935106] Starting subtest: compute-square [617.962056] Subtest compute-square: FAIL (0.007s) [618.044274] [129/130] (425s left) gem_partial_pwrite_pread (writes-after-reads-display) [618.132165] Subtest writes-after-reads-display: SKIP (0.000s) [618.214367] [130/130] (425s left) gem_userptr_blits (nohangcheck) [618.316321] Starting subtest: nohangcheck [618.632159] Subtest nohangcheck: SUCCESS (0.314s) [618.823077] Closing watchdogs Done.