[58.949124] Initializing watchdogs
[58.949195]   /dev/watchdog0
[58.973340] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[58.984854] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card1
[58.988975] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.991546] [001/131] (960s left) perf_pmu (idle)
[59.061083] Starting subtest: idle
[59.062054] Starting dynamic subtest: rcs0
[59.645709] Dynamic subtest rcs0: SUCCESS (0.583s)
[59.654673] Starting dynamic subtest: bcs0
[60.167587] Dynamic subtest bcs0: SUCCESS (0.520s)
[60.176553] Starting dynamic subtest: vcs0
[60.685059] Dynamic subtest vcs0: SUCCESS (0.516s)
[60.693181] Starting dynamic subtest: vcs1
[61.201895] Dynamic subtest vcs1: SUCCESS (0.519s)
[61.210827] Starting dynamic subtest: vecs0
[61.721033] Dynamic subtest vecs0: SUCCESS (0.532s)
[61.729340] Starting dynamic subtest: vecs1
[62.238550] Dynamic subtest vecs1: SUCCESS (0.529s)
[62.246661] Starting dynamic subtest: ccs0
[62.755764] Dynamic subtest ccs0: SUCCESS (0.529s)
[62.757340] Subtest idle: SUCCESS (3.735s)
[62.889872] [002/131] (956s left) gem_render_copy (linear)
[62.967495] Starting subtest: linear
[62.968304] Starting dynamic subtest: smem
[63.078349] Dynamic subtest smem: SUCCESS (0.113s)
[63.086203] Starting dynamic subtest: lmem0
[63.313074] Dynamic subtest lmem0: SUCCESS (0.239s)
[63.313984] Subtest linear: SUCCESS (0.353s)
[63.549519] [003/131] (956s left) kms_pm_rpm (legacy-planes-dpms)
[65.083682] Starting subtest: legacy-planes-dpms
[65.085770] Starting dynamic subtest: plane-43
[67.875723] Dynamic subtest plane-43: SUCCESS (2.830s)
[67.884288] Starting dynamic subtest: plane-53
[70.718084] Dynamic subtest plane-53: SUCCESS (2.868s)
[70.730491] Starting dynamic subtest: plane-63
[73.520953] Dynamic subtest plane-63: SUCCESS (2.820s)
[73.560749] Starting dynamic subtest: plane-73
[76.552496] Dynamic subtest plane-73: SUCCESS (3.044s)
[76.554675] Subtest legacy-planes-dpms: SUCCESS (11.566s)
[76.968619] [004/131] (942s left) gem_shrink (reclaim)
[77.043903] Starting subtest: reclaim
[79.295469] Subtest reclaim: SUCCESS (2.258s)
[79.451946] [005/131] (940s left) kms_flip (2x-flip-vs-dpms)
[79.712067] Starting subtest: 2x-flip-vs-dpms
[79.726457] Subtest 2x-flip-vs-dpms: SKIP (0.014s)
[79.831872] [006/131] (939s left) gem_caching (read-writes)
[79.908520] Starting subtest: read-writes
[89.004881] Subtest read-writes: SUCCESS (9.108s)
[89.148596] [007/131] (930s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[89.355364] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[90.626278] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.260s)
[90.821553] [008/131] (929s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[91.008170] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[91.009073] Starting dynamic subtest: pipe-A
[91.096664] Dynamic subtest pipe-A: SUCCESS (0.089s)
[91.105418] Starting dynamic subtest: pipe-B
[91.296267] Dynamic subtest pipe-B: SUCCESS (0.199s)
[91.312910] Starting dynamic subtest: pipe-C
[91.512145] Dynamic subtest pipe-C: SUCCESS (0.216s)
[91.526717] Starting dynamic subtest: pipe-D
[91.729422] Dynamic subtest pipe-D: SUCCESS (0.217s)
[91.730516] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.722s)
[92.045530] [009/131] (927s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[92.236987] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[92.238749] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[92.359361] [010/131] (927s left) kms_pm_backlight (fade)
[92.552279] Subtest fade: SKIP (0.000s)
[92.601009] [011/131] (927s left) gem_softpin (softpin)
[92.680436] Starting subtest: softpin
[124.939996] Subtest softpin: SUCCESS (32.258s)
[125.091069] [012/131] (895s left) gem_eio (context-create)
[125.379446] Starting subtest: context-create
[125.840163] Subtest context-create: SUCCESS (0.461s)
[126.092565] [013/131] (894s left) gem_mmap (basic)
[126.164373] Subtest basic: SKIP (0.000s)
[126.238301] [014/131] (894s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[126.424239] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[126.426114] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[126.709073] [015/131] (893s left) i915_drm_fdinfo (virtual-busy-idle-all)
[126.770797] Starting subtest: virtual-busy-idle-all
[126.772641] Subtest virtual-busy-idle-all: SKIP (0.000s)
[126.912327] [016/131] (893s left) api_intel_bb (delta-check)
[126.983116] Starting subtest: delta-check
[127.015014] Subtest delta-check: SUCCESS (0.032s)
[127.188394] [017/131] (893s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[127.379807] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[127.381433] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[127.527434] [018/131] (893s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[127.599102] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[127.600120] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s)
[127.716380] [019/131] (892s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[127.915164] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[127.917017] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[128.055989] [020/131] (892s left) gem_exec_flush (basic-uc-prw-default)
[128.133258] Subtest basic-uc-prw-default: SKIP (0.000s)
[128.205340] [021/131] (892s left) gem_exec_balancer (waits)
[128.291814] Starting subtest: waits
[141.166150] Subtest waits: SUCCESS (12.874s)
[141.528188] [022/131] (879s left) drm_mm (drm_mm)
[141.572961] Starting subtest: drm_mm
[141.606271] Starting dynamic subtest: drm_test_mm_init
[141.700542] Dynamic subtest drm_test_mm_init: SUCCESS (0.093s)
[141.710091] Starting dynamic subtest: drm_test_mm_debug
[141.791447] Dynamic subtest drm_test_mm_debug: SUCCESS (0.090s)
[141.830855] Starting dynamic subtest: drm_test_mm_align32
[141.902731] Dynamic subtest drm_test_mm_align32: SUCCESS (0.109s)
[141.941204] Starting dynamic subtest: drm_test_mm_align64
[142.006099] Dynamic subtest drm_test_mm_align64: SUCCESS (0.101s)
[142.042938] Starting dynamic subtest: drm_test_mm_lowest
[142.101091] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.094s)
[142.137396] Starting dynamic subtest: drm_test_mm_highest
[142.189328] Dynamic subtest drm_test_mm_highest: SUCCESS (0.088s)
[142.191160] Subtest drm_mm: SUCCESS (0.617s)
[142.415675] [023/131] (878s left) kms_lease (lease-invalid-plane)
[142.604257] Starting subtest: lease-invalid-plane
[142.605217] Starting dynamic subtest: pipe-A-DP-3
[142.606120] Dynamic subtest pipe-A-DP-3: SUCCESS (0.000s)
[142.616511] Starting dynamic subtest: pipe-B-DP-3
[142.617594] Dynamic subtest pipe-B-DP-3: SUCCESS (0.000s)
[142.626961] Starting dynamic subtest: pipe-C-DP-3
[142.628210] Dynamic subtest pipe-C-DP-3: SUCCESS (0.000s)
[142.637639] Starting dynamic subtest: pipe-D-DP-3
[142.638849] Dynamic subtest pipe-D-DP-3: SUCCESS (0.000s)
[142.640034] Subtest lease-invalid-plane: SUCCESS (0.004s)
[142.691839] [024/131] (878s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[142.885794] Starting subtest: psr-1p-primscrn-cur-indfb-move
[142.887531] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[143.018161] [025/131] (878s left) kms_vblank (wait-busy-hang)
[143.202229] Starting subtest: wait-busy-hang
[143.204382] Starting dynamic subtest: pipe-A-DP-3
[170.558517] Dynamic subtest pipe-A-DP-3: SUCCESS (27.354s)
[170.569823] Starting dynamic subtest: pipe-D-DP-3
[195.570037] Dynamic subtest pipe-D-DP-3: SUCCESS (25.008s)
[195.571010] Subtest wait-busy-hang: SUCCESS (52.366s)
[195.868876] [026/131] (825s left) gem_userptr_blits (dmabuf-unsync)
[195.947935] Subtest dmabuf-unsync: SKIP (0.000s)
[196.115466] [027/131] (825s left) gem_ccs (block-multicopy-inplace)
[196.192618] Starting subtest: block-multicopy-inplace
[196.193529] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy
[196.236063] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.043s)
[196.245846] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy
[196.331468] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.095s)
[196.340849] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy
[196.345389] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.013s)
[196.354947] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy
[196.445400] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.100s)
[196.454746] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy
[196.459166] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.013s)
[196.468951] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy
[196.560292] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.101s)
[196.569751] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy
[196.575036] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[196.584364] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy
[196.682109] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.107s)
[196.683744] Subtest block-multicopy-inplace: SUCCESS (0.490s)
[196.837959] [028/131] (824s left) gem_eio (in-flight-contexts-10ms)
[197.095168] Starting subtest: in-flight-contexts-10ms
[210.914600] Subtest in-flight-contexts-10ms: SUCCESS (13.820s)
[211.129967] [029/131] (810s left) gem_softpin (evict-snoop-interruptible)
[211.212474] Starting subtest: evict-snoop-interruptible
[211.214293] Subtest evict-snoop-interruptible: SKIP (0.000s)
[211.334643] [030/131] (810s left) gem_exec_reloc (basic-cpu-noreloc)
[211.411495] Subtest basic-cpu-noreloc: SKIP (0.000s)
[211.485655] [031/131] (809s left) sysfs_heartbeat_interval (nopreempt)
[211.562376] Starting subtest: nopreempt
[211.563261] Starting dynamic subtest: vecs0
[215.845108] Dynamic subtest vecs0: SUCCESS (4.282s)
[215.854979] Starting dynamic subtest: ccs0
[220.093015] Dynamic subtest ccs0: SUCCESS (4.247s)
[220.103493] Starting dynamic subtest: vcs0
[224.255661] Dynamic subtest vcs0: SUCCESS (4.162s)
[224.265809] Starting dynamic subtest: bcs0
[228.404254] Dynamic subtest bcs0: SUCCESS (4.148s)
[228.415127] Starting dynamic subtest: vecs1
[232.593320] Dynamic subtest vecs1: SUCCESS (4.189s)
[232.603678] Starting dynamic subtest: rcs0
[236.885592] Dynamic subtest rcs0: SUCCESS (4.292s)
[236.895661] Starting dynamic subtest: vcs1
[241.071299] Dynamic subtest vcs1: SUCCESS (4.185s)
[241.072319] Subtest nopreempt: SUCCESS (29.509s)
[241.203730] [032/131] (780s left) gem_userptr_blits (coherency-unsync)
[241.291006] Subtest coherency-unsync: SKIP (0.000s)
[241.472679] [033/131] (780s left) gem_ctx_persistence (engines-mixed-process)
[241.551159] Starting subtest: engines-mixed-process
[241.552135] Starting dynamic subtest: rcs0
[242.879443] Dynamic subtest rcs0: SUCCESS (1.328s)
[242.892665] Starting dynamic subtest: bcs0
[244.866784] Dynamic subtest bcs0: SUCCESS (1.986s)
[244.878383] Starting dynamic subtest: vcs0
[246.909290] Dynamic subtest vcs0: SUCCESS (2.042s)
[246.920676] Starting dynamic subtest: vcs1
[248.894929] Dynamic subtest vcs1: SUCCESS (1.985s)
[248.905599] Starting dynamic subtest: vecs0
[250.866804] Dynamic subtest vecs0: SUCCESS (1.971s)
[250.877603] Starting dynamic subtest: vecs1
[252.860971] Dynamic subtest vecs1: SUCCESS (1.993s)
[252.872203] Starting dynamic subtest: ccs0
[254.899081] Dynamic subtest ccs0: SUCCESS (2.037s)
[254.900270] Subtest engines-mixed-process: SUCCESS (13.348s)
[254.995442] [034/131] (766s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[255.196146] Starting subtest: y-tiled-8bpp-rotate-0
[255.197912] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[255.378725] [035/131] (766s left) kms_plane_scaling (intel-max-src-size)
[255.567260] Starting subtest: intel-max-src-size
[255.574012] Starting dynamic subtest: pipe-A-DP-3
[255.777463] Dynamic subtest pipe-A-DP-3: SUCCESS (0.202s)
[255.779507] Subtest intel-max-src-size: SUCCESS (0.211s)
[256.230662] [036/131] (765s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[256.301201] Starting subtest: multi-wait-all-for-submit-unsubmitted
[256.404535] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[256.524645] [037/131] (765s left) device_reset (cold-reset-bound)
[256.601102] Starting subtest: cold-reset-bound
[256.603147] Subtest cold-reset-bound: SKIP (0.000s)
[256.692932] [038/131] (765s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[256.891178] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[257.612984] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.721s)
[257.864632] [039/131] (764s left) gem_spin_batch (engines)
[257.945774] Starting subtest: engines
[257.946694] Starting dynamic subtest: rcs0
[261.210360] Dynamic subtest rcs0: SUCCESS (3.261s)
[261.223047] Starting dynamic subtest: bcs0
[264.450148] Dynamic subtest bcs0: SUCCESS (3.237s)
[264.462873] Starting dynamic subtest: vcs0
[267.690129] Dynamic subtest vcs0: SUCCESS (3.237s)
[267.702723] Starting dynamic subtest: vcs1
[270.928463] Dynamic subtest vcs1: SUCCESS (3.235s)
[270.939352] Starting dynamic subtest: vecs0
[274.165345] Dynamic subtest vecs0: SUCCESS (3.234s)
[274.176456] Starting dynamic subtest: vecs1
[277.402409] Dynamic subtest vecs1: SUCCESS (3.234s)
[277.413510] Starting dynamic subtest: ccs0
[280.636758] Dynamic subtest ccs0: SUCCESS (3.233s)
[280.638042] Subtest engines: SUCCESS (22.690s)
[280.881966] [040/131] (741s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[281.071369] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[281.072304] Starting dynamic subtest: pipe-A-DP-3
[281.081897] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[281.091934] Starting dynamic subtest: pipe-B-DP-3
[281.101492] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[281.111294] Starting dynamic subtest: pipe-C-DP-3
[281.120275] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[281.129805] Starting dynamic subtest: pipe-D-DP-3
[281.141531] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[281.143521] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SKIP (0.005s)
[281.530217] [041/131] (740s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[281.723127] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[281.773630] [042/131] (740s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[281.964963] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[281.966667] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[282.108594] [043/131] (740s left) kms_cursor_crc (cursor-onscreen-512x512)
[282.575917] Starting subtest: cursor-onscreen-512x512
[282.577630] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[282.818497] [044/131] (739s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[283.009991] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[283.011759] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[283.130047] [045/131] (739s left) gem_exec_whisper (basic-forked)
[283.213492] Starting subtest: basic-forked
[289.882558] Subtest basic-forked: SUCCESS (6.667s)
[290.127844] [046/131] (732s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[290.316495] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[290.318852] Starting dynamic subtest: pipe-A-valid-mode
[292.588105] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.269s)
[292.589834] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.271s)
[292.871802] [047/131] (729s left) kms_flip (flip-vs-fences-interruptible)
[293.059792] Starting subtest: flip-vs-fences-interruptible
[293.061512] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[293.210614] [048/131] (729s left) kms_vblank (accuracy-idle)
[293.400349] Starting subtest: accuracy-idle
[293.402687] Starting dynamic subtest: pipe-A-DP-3
[295.734720] Dynamic subtest pipe-A-DP-3: SUCCESS (2.331s)
[295.762915] Starting dynamic subtest: pipe-D-DP-3
[298.020392] Dynamic subtest pipe-D-DP-3: SUCCESS (2.275s)
[298.021522] Subtest accuracy-idle: SUCCESS (4.619s)
[298.275696] [049/131] (724s left) gem_mmap_gtt (basic-read)
[298.346406] Subtest basic-read: SKIP (0.000s)
[298.452708] [050/131] (724s left) gem_mmap_offset (partial-unmap)
[298.521447] Starting subtest: partial-unmap
[298.522402] Starting dynamic subtest: lmem0
[298.532597] Dynamic subtest lmem0: SUCCESS (0.011s)
[298.543403] Starting dynamic subtest: smem0
[298.544648] Dynamic subtest smem0: SUCCESS (0.004s)
[298.545729] Subtest partial-unmap: SUCCESS (0.017s)
[298.727471] [051/131] (724s left) gem_userptr_blits (unsync-unmap-cycles)
[298.806945] Subtest unsync-unmap-cycles: SKIP (0.000s)
[299.033727] [052/131] (723s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[299.238118] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[299.239885] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[299.391949] [053/131] (723s left) kms_cursor_crc (cursor-sliding-512x512)
[299.850617] Starting subtest: cursor-sliding-512x512
[299.852445] Subtest cursor-sliding-512x512: SKIP (0.001s)
[300.110390] [054/131] (723s left) kms_legacy_colorkey (invalid-plane)
[300.327414] Starting subtest: invalid-plane
[300.328373] Starting dynamic subtest: zero-id
[300.329273] Dynamic subtest zero-id: SUCCESS (0.000s)
[300.339537] Starting dynamic subtest: outrange-id
[300.340774] Dynamic subtest outrange-id: SUCCESS (0.000s)
[300.341962] Subtest invalid-plane: SUCCESS (0.001s)
[300.431579] [055/131] (722s left) gen9_exec_parse (bb-start-param)
[300.511341] Subtest bb-start-param: SKIP (0.000s)
[300.628930] [056/131] (722s left) perf (stress-open-close)
[300.979205] Starting subtest: stress-open-close
[300.980136] Starting dynamic subtest: 0-rcs0
[303.221077] Dynamic subtest 0-rcs0: SUCCESS (2.241s)
[303.222831] Subtest stress-open-close: SUCCESS (2.242s)
[303.305060] [057/131] (720s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[303.497125] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[303.498853] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[303.669568] [058/131] (719s left) vgem_basic (setversion)
[303.752371] Starting subtest: setversion
[303.754214] Subtest setversion: SUCCESS (0.000s)
[303.823763] [FACT vgem_basic (setversion)] new: kernel.kmod_is_loaded.vgem: true
[303.825902] [059/131] (719s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[304.035267] Starting subtest: 4-tiled-32bpp-rotate-90
[304.094975] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.059s)
[304.282426] [060/131] (719s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[304.480223] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[304.539178] [061/131] (719s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[304.740965] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[304.831884] [062/131] (718s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[305.033177] Starting subtest: pipe-fbc-rte
[305.038155] Subtest pipe-fbc-rte: SKIP (0.000s)
[305.165911] [063/131] (718s left) gem_mmap_wc (fault-concurrent)
[305.245254] Subtest fault-concurrent: SKIP (0.000s)
[305.328609] [064/131] (718s left) gem_mmap_gtt (cpuset-big-copy-odd)
[305.410158] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[305.492502] [065/131] (718s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[305.686413] Starting subtest: fb-8bpc-vs-panel-8bpc
[305.688919] Starting dynamic subtest: pipe-A-DP-3
[306.111457] Dynamic subtest pipe-A-DP-3: SUCCESS (0.423s)
[306.113115] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (0.425s)
[306.364463] [066/131] (717s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[306.563180] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[306.564915] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[306.707252] [067/131] (717s left) gem_linear_blits (basic)
[307.064582] Starting subtest: basic
[307.103622] Subtest basic: SUCCESS (0.041s)
[307.304646] [068/131] (716s left) kms_feature_discovery (display-4x)
[307.605423] Starting subtest: display-4x
[307.607204] Subtest display-4x: SKIP (0.000s)
[307.698148] [069/131] (716s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[307.905998] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[307.955585] [070/131] (716s left) kms_joiner (basic-force-big-joiner)
[308.154409] Starting subtest: basic-force-big-joiner
[308.155247] Starting dynamic subtest: single
[308.980752] Dynamic subtest single: SUCCESS (0.828s)
[308.981845] Subtest basic-force-big-joiner: SUCCESS (0.829s)
[309.352513] [071/131] (714s left) kms_color (gamma)
[309.546484] Starting subtest: gamma
[309.547415] Starting dynamic subtest: pipe-A-DP-3
[310.228801] Dynamic subtest pipe-A-DP-3: SUCCESS (0.680s)
[310.252191] Starting dynamic subtest: pipe-B-DP-3
[310.846557] Dynamic subtest pipe-B-DP-3: SUCCESS (0.616s)
[310.858029] Starting dynamic subtest: pipe-C-DP-3
[311.422404] Dynamic subtest pipe-C-DP-3: SUCCESS (0.575s)
[311.439689] Starting dynamic subtest: pipe-D-DP-3
[312.026922] Dynamic subtest pipe-D-DP-3: SUCCESS (0.603s)
[312.027940] Subtest gamma: SUCCESS (2.480s)
[312.305550] [072/131] (712s left) gem_exec_schedule (smoketest)
[312.534316] Starting subtest: smoketest
[312.535666] Starting dynamic subtest: rcs0
[317.999180] Dynamic subtest rcs0: SUCCESS (5.464s)
[318.010212] Starting dynamic subtest: bcs0
[323.454758] Dynamic subtest bcs0: SUCCESS (5.454s)
[323.466872] Starting dynamic subtest: vcs0
[328.905475] Dynamic subtest vcs0: SUCCESS (5.451s)
[328.919009] Starting dynamic subtest: vcs1
[334.372667] Dynamic subtest vcs1: SUCCESS (5.465s)
[334.384389] Starting dynamic subtest: vecs0
[339.828315] Dynamic subtest vecs0: SUCCESS (5.455s)
[339.839827] Starting dynamic subtest: vecs1
[345.309239] Dynamic subtest vecs1: SUCCESS (5.479s)
[345.321888] Starting dynamic subtest: ccs0
[350.762553] Dynamic subtest ccs0: SUCCESS (5.453s)
[350.763431] Subtest smoketest: SUCCESS (38.229s)
[351.067745] [073/131] (673s left) i915_pm_rpm (system-suspend-devices)
[353.095249] Starting subtest: system-suspend-devices
[360.467615] Subtest system-suspend-devices: SUCCESS (7.377s)
[387.896883] [074/131] (663s left) api_intel_allocator (default-alignment)
[387.977428] Starting subtest: default-alignment
[387.983071] Subtest default-alignment: SUCCESS (0.006s)
[388.176210] [075/131] (663s left) kms_chamelium_hpd (hdmi-hpd)
[388.455339] Subtest hdmi-hpd: SKIP (0.000s)
[388.616350] [076/131] (663s left) syncobj_timeline (signal-array)
[388.697452] Starting subtest: signal-array
[388.698421] Subtest signal-array: SUCCESS (0.000s)
[388.808740] [077/131] (663s left) gem_userptr_blits (set-cache-level)
[388.896996] Starting subtest: set-cache-level
[388.897959] Subtest set-cache-level: SUCCESS (0.000s)
[389.092330] [078/131] (662s left) kms_chamelium_frames (dp-crc-single)
[389.365415] Subtest dp-crc-single: SKIP (0.000s)
[389.522267] [079/131] (662s left) perf (gen12-invalid-class-instance)
[389.736728] Starting subtest: gen12-invalid-class-instance
[389.753985] Subtest gen12-invalid-class-instance: SUCCESS (0.017s)
[389.807483] [080/131] (662s left) gem_exec_fence (syncobj-import)
[390.353935] Starting subtest: syncobj-import
[390.385579] Subtest syncobj-import: SUCCESS (0.032s)
[390.763360] [081/131] (661s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[390.850013] Starting subtest: y-tiled-ccs-to-x-tiled
[390.851998] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[391.070142] [082/131] (661s left) kms_big_fb (linear-8bpp-rotate-90)
[391.281423] Starting subtest: linear-8bpp-rotate-90
[391.341604] Subtest linear-8bpp-rotate-90: SKIP (0.059s)
[391.529960] [083/131] (660s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[391.732170] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[391.733995] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[391.863868] [084/131] (660s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc)
[392.064054] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc
[392.065903] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[392.199547] [085/131] (660s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[392.395570] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[392.398140] Starting dynamic subtest: pipe-A-DP-3
[392.406870] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[392.419303] Starting dynamic subtest: pipe-B-DP-3
[392.428140] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[392.440374] Starting dynamic subtest: pipe-C-DP-3
[392.449909] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[392.462350] Starting dynamic subtest: pipe-D-DP-3
[392.473493] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[392.475541] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[392.845650] [086/131] (659s left) kms_selftest (drm_damage_helper)
[392.897644] Starting subtest: drm_damage_helper
[392.902472] Starting dynamic subtest: drm_test_damage_iter_no_damage
[393.006574] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.100s)
[393.048259] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[393.110503] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.101s)
[393.156845] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[393.211753] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.099s)
[393.250558] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[393.298476] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.084s)
[393.335560] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[393.399764] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.099s)
[393.413608] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[393.490799] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.088s)
[393.506381] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[393.583023] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.087s)
[393.598435] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[393.677779] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.091s)
[393.694117] Starting dynamic subtest: drm_test_damage_iter_single_damage
[393.755778] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.073s)
[393.798892] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[393.853938] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.095s)
[393.900436] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[393.953468] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.095s)
[393.993254] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[394.051830] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.096s)
[394.067853] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[394.141706] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.085s)
[394.188564] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[394.248999] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.103s)
[394.295569] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[394.337262] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.084s)
[394.368604] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[394.425852] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.084s)
[394.472635] Starting dynamic subtest: drm_test_damage_iter_damage
[394.543723] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.113s)
[394.593696] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[394.619948] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.073s)
[394.637539] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[394.704698] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.081s)
[394.720211] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[394.806836] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.097s)
[394.821593] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[394.878683] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.069s)
[394.880032] Subtest drm_damage_helper: SUCCESS (1.981s)
[395.086635] [087/131] (657s left) gem_readwrite (write-bad-handle)
[395.167271] Subtest write-bad-handle: SKIP (0.000s)
[395.240023] [088/131] (657s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[395.447120] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[395.462385] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.014s)
[395.569257] [089/131] (657s left) gem_readwrite (read-write)
[395.649480] Subtest read-write: SKIP (0.000s)
[395.730302] [090/131] (656s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[395.924522] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[395.926299] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[396.216075] [091/131] (656s left) perf (blocking)
[396.388661] Starting subtest: blocking
[396.389572] Starting dynamic subtest: 0-rcs0
[406.421607] Dynamic subtest 0-rcs0: SUCCESS (10.032s)
[406.422465] Subtest blocking: SUCCESS (10.033s)
[406.475909] [092/131] (646s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[406.556439] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[406.557396] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[406.741800] [093/131] (646s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[406.940457] Starting subtest: cursorA-vs-flipA-legacy
[417.862838] Subtest cursorA-vs-flipA-legacy: SUCCESS (10.923s)
[418.117411] [094/131] (634s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[418.320154] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[418.322051] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[418.469110] [095/131] (634s left) i915_pm_rpm (gem-mmap-type)
[420.089322] Starting subtest: gem-mmap-type
[420.091293] Starting dynamic subtest: fixed-lmem0
[421.354362] Dynamic subtest fixed-lmem0: SUCCESS (1.264s)
[421.393396] Starting dynamic subtest: fixed-smem0
[422.508935] Dynamic subtest fixed-smem0: SUCCESS (1.152s)
[422.515128] Subtest gem-mmap-type: SUCCESS (2.423s)
[422.768155] [096/131] (630s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[422.971267] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[422.973139] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[423.116436] [097/131] (630s left) kms_setmode (invalid-clone-single-crtc-stealing)
[423.195716] Starting subtest: invalid-clone-single-crtc-stealing
[423.198544] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[423.346416] [098/131] (630s left) gem_mmap (bad-offset)
[423.430501] Subtest bad-offset: SKIP (0.000s)
[423.499532] [099/131] (629s left) gem_exec_create (basic)
[423.591016] Starting subtest: basic
[423.591944] Starting dynamic subtest: smem
[425.688119] Dynamic subtest smem: SUCCESS (2.097s)
[425.702922] Starting dynamic subtest: lmem0
[427.807508] Dynamic subtest lmem0: SUCCESS (2.118s)
[427.808429] Subtest basic: SUCCESS (4.217s)
[428.037612] [100/131] (625s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[428.115443] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[428.219603] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[428.336027] [101/131] (625s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[430.945607] Starting subtest: verify-pxp-stale-buf-optout-execution
[430.947877] Subtest verify-pxp-stale-buf-optout-execution: SKIP (0.000s)
[431.042600] [102/131] (622s left) syncobj_wait (wait-any-complex)
[431.125474] Starting subtest: wait-any-complex
[431.188128] Subtest wait-any-complex: SUCCESS (0.063s)
[431.303346] [103/131] (622s left) kms_cursor_edge_walk (64x64-top-edge)
[431.502545] Starting subtest: 64x64-top-edge
[431.505094] Starting dynamic subtest: pipe-A-DP-3
[434.977557] Dynamic subtest pipe-A-DP-3: SUCCESS (3.473s)
[434.994383] Starting dynamic subtest: pipe-D-DP-3
[438.334194] Dynamic subtest pipe-D-DP-3: SUCCESS (3.352s)
[438.335346] Subtest 64x64-top-edge: SUCCESS (6.831s)
[438.603977] [104/131] (615s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[438.688451] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[438.689393] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[438.876093] [105/131] (614s left) kms_psr (psr2-sprite-plane-onoff)
[439.074124] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[439.136293] [106/131] (614s left) gem_exec_flush (basic-wb-rw-before-default)
[439.227130] Subtest basic-wb-rw-before-default: SKIP (0.000s)
[439.305894] [107/131] (614s left) kms_psr (psr2-cursor-mmap-gtt)
[439.504127] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[439.572668] [108/131] (614s left) kms_plane_lowres (tiling-y)
[439.770547] Starting subtest: tiling-y
[439.772435] Subtest tiling-y: SKIP (0.000s)
[439.895675] [109/131] (614s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[440.099113] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[440.283106] [110/131] (613s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[440.482772] Starting subtest: basic-modeset-with-all-modifiers-formats
[440.697736] Starting dynamic subtest: pipe-A-DP-3-4-rc-ccs-XRGB8888
[440.994393] Dynamic subtest pipe-A-DP-3-4-rc-ccs-XRGB8888: SUCCESS (0.297s)
[441.019074] Starting dynamic subtest: pipe-A-DP-3-4-rc-ccs-XRGB2101010
[441.027754] Dynamic subtest pipe-A-DP-3-4-rc-ccs-XRGB2101010: SUCCESS (0.032s)
[441.051817] Starting dynamic subtest: pipe-A-DP-3-4-rc-ccs-XRGB16161616F
[441.060993] Dynamic subtest pipe-A-DP-3-4-rc-ccs-XRGB16161616F: SUCCESS (0.031s)
[441.077713] Starting dynamic subtest: pipe-A-DP-3-4-RGB565
[441.244187] Dynamic subtest pipe-A-DP-3-4-RGB565: SUCCESS (0.182s)
[441.257069] Starting dynamic subtest: pipe-A-DP-3-4-XRGB8888
[441.277706] Dynamic subtest pipe-A-DP-3-4-XRGB8888: SUCCESS (0.032s)
[441.294472] Starting dynamic subtest: pipe-A-DP-3-4-XRGB2101010
[441.311041] Dynamic subtest pipe-A-DP-3-4-XRGB2101010: SUCCESS (0.032s)
[441.328791] Starting dynamic subtest: pipe-A-DP-3-4-XRGB16161616F
[441.344349] Dynamic subtest pipe-A-DP-3-4-XRGB16161616F: SUCCESS (0.032s)
[441.364495] Starting dynamic subtest: pipe-A-DP-3-4-YUYV
[441.377674] Dynamic subtest pipe-A-DP-3-4-YUYV: SUCCESS (0.032s)
[441.397608] Starting dynamic subtest: pipe-A-DP-3-4-Y210
[441.411019] Dynamic subtest pipe-A-DP-3-4-Y210: SUCCESS (0.032s)
[441.428648] Starting dynamic subtest: pipe-A-DP-3-4-XYUV8888
[441.444350] Dynamic subtest pipe-A-DP-3-4-XYUV8888: SUCCESS (0.032s)
[441.460365] Starting dynamic subtest: pipe-A-DP-3-4-XV30
[441.477574] Dynamic subtest pipe-A-DP-3-4-XV30: SUCCESS (0.032s)
[441.493352] Starting dynamic subtest: pipe-A-DP-3-4-XV36
[441.511081] Dynamic subtest pipe-A-DP-3-4-XV36: SUCCESS (0.032s)
[441.526991] Starting dynamic subtest: pipe-A-DP-3-x-RGB565
[441.694227] Dynamic subtest pipe-A-DP-3-x-RGB565: SUCCESS (0.182s)
[441.706946] Starting dynamic subtest: pipe-A-DP-3-x-XRGB8888
[441.727585] Dynamic subtest pipe-A-DP-3-x-XRGB8888: SUCCESS (0.032s)
[441.743348] Starting dynamic subtest: pipe-A-DP-3-x-XRGB2101010
[441.760884] Dynamic subtest pipe-A-DP-3-x-XRGB2101010: SUCCESS (0.032s)
[441.776586] Starting dynamic subtest: pipe-A-DP-3-x-XRGB16161616F
[441.794156] Dynamic subtest pipe-A-DP-3-x-XRGB16161616F: SUCCESS (0.032s)
[441.809860] Starting dynamic subtest: pipe-A-DP-3-x-YUYV
[441.828171] Dynamic subtest pipe-A-DP-3-x-YUYV: SUCCESS (0.032s)
[441.842922] Starting dynamic subtest: pipe-A-DP-3-x-Y210
[441.861069] Dynamic subtest pipe-A-DP-3-x-Y210: SUCCESS (0.032s)
[441.880052] Starting dynamic subtest: pipe-A-DP-3-x-XYUV8888
[441.894244] Dynamic subtest pipe-A-DP-3-x-XYUV8888: SUCCESS (0.032s)
[441.912688] Starting dynamic subtest: pipe-A-DP-3-x-XV30
[441.927605] Dynamic subtest pipe-A-DP-3-x-XV30: SUCCESS (0.032s)
[441.946151] Starting dynamic subtest: pipe-A-DP-3-x-XV36
[441.960984] Dynamic subtest pipe-A-DP-3-x-XV36: SUCCESS (0.032s)
[441.979378] Starting dynamic subtest: pipe-A-DP-3-linear-RGB565
[442.145486] Dynamic subtest pipe-A-DP-3-linear-RGB565: SUCCESS (0.183s)
[442.158526] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB8888
[442.179716] Dynamic subtest pipe-A-DP-3-linear-XRGB8888: SUCCESS (0.033s)
[442.198598] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB2101010
[442.213056] Dynamic subtest pipe-A-DP-3-linear-XRGB2101010: SUCCESS (0.032s)
[442.228823] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB16161616F
[442.246205] Dynamic subtest pipe-A-DP-3-linear-XRGB16161616F: SUCCESS (0.032s)
[442.263309] Starting dynamic subtest: pipe-A-DP-3-linear-YUYV
[442.279560] Dynamic subtest pipe-A-DP-3-linear-YUYV: SUCCESS (0.032s)
[442.296722] Starting dynamic subtest: pipe-A-DP-3-linear-Y210
[442.313017] Dynamic subtest pipe-A-DP-3-linear-Y210: SUCCESS (0.032s)
[442.330172] Starting dynamic subtest: pipe-A-DP-3-linear-XYUV8888
[442.346166] Dynamic subtest pipe-A-DP-3-linear-XYUV8888: SUCCESS (0.032s)
[442.362921] Starting dynamic subtest: pipe-A-DP-3-linear-XV30
[442.379774] Dynamic subtest pipe-A-DP-3-linear-XV30: SUCCESS (0.032s)
[442.397017] Starting dynamic subtest: pipe-A-DP-3-linear-XV36
[442.412955] Dynamic subtest pipe-A-DP-3-linear-XV36: SUCCESS (0.032s)
[442.682775] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.200s)
[442.959135] [111/131] (611s left) gem_exec_schedule (pi-common)
[443.175349] Starting subtest: pi-common
[443.176619] Starting dynamic subtest: rcs0
[443.274428] Dynamic subtest rcs0: SUCCESS (0.103s)
[443.291044] Starting dynamic subtest: bcs0
[443.365399] Dynamic subtest bcs0: SUCCESS (0.090s)
[443.384782] Starting dynamic subtest: vcs0
[443.450520] Dynamic subtest vcs0: SUCCESS (0.084s)
[443.465656] Starting dynamic subtest: vcs1
[443.528802] Dynamic subtest vcs1: SUCCESS (0.077s)
[443.544507] Starting dynamic subtest: vecs0
[443.607613] Dynamic subtest vecs0: SUCCESS (0.078s)
[443.622619] Starting dynamic subtest: vecs1
[443.683608] Dynamic subtest vecs1: SUCCESS (0.074s)
[443.698914] Starting dynamic subtest: ccs0
[443.759251] Dynamic subtest ccs0: SUCCESS (0.074s)
[443.760319] Subtest pi-common: SUCCESS (0.590s)
[444.069940] [112/131] (610s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[444.272375] Starting subtest: psr-rgb101010-draw-mmap-cpu
[444.274138] Subtest psr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[444.422748] [113/131] (610s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[444.616555] Starting subtest: bad-rotation-90-yf-tiled-ccs
[444.619109] Starting dynamic subtest: pipe-A-DP-3
[444.627481] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[444.639998] Starting dynamic subtest: pipe-B-DP-3
[444.648517] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[444.660783] Starting dynamic subtest: pipe-C-DP-3
[444.669227] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[444.681598] Starting dynamic subtest: pipe-D-DP-3
[444.692538] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[444.694539] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.007s)
[445.069979] [114/131] (609s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[445.155556] Starting subtest: multi-wait-available-unsubmitted-submitted
[445.156460] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[445.321540] [115/131] (609s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[445.519173] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[445.521030] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[445.682318] [116/131] (609s left) gem_exec_params (secure-non-root)
[445.765977] Starting subtest: secure-non-root
[445.767871] Subtest secure-non-root: SKIP (0.000s)
[445.903042] [117/131] (608s left) kms_psr (fbc-psr-cursor-render)
[446.099307] Subtest fbc-psr-cursor-render: SKIP (0.000s)
[446.160589] [118/131] (608s left) gem_exec_reloc (basic-cpu-gtt-active)
[446.249495] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[446.330722] [119/131] (608s left) gem_ctx_create (basic)
[446.425139] Starting subtest: basic
[446.426353] Subtest basic: SUCCESS (0.000s)
[446.674864] [120/131] (608s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[446.883187] Starting subtest: yf-tiled-addfb-size-overflow
[446.884979] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[447.052109] [121/131] (608s left) gem_exec_fence (syncobj-unused-fence)
[447.530250] Starting subtest: syncobj-unused-fence
[447.558890] Subtest syncobj-unused-fence: SUCCESS (0.030s)
[448.002845] [122/131] (607s left) gem_exec_suspend (basic-s3-devices)
[448.090118] Starting subtest: basic-S3-devices
[448.091141] Starting dynamic subtest: smem
[458.141572] Dynamic subtest smem: SUCCESS (10.051s)
[458.154717] Starting dynamic subtest: lmem0
[468.245378] Dynamic subtest lmem0: SUCCESS (10.103s)
[468.246624] Subtest basic-S3-devices: SUCCESS (20.156s)
[486.574719] [123/131] (586s left) kms_content_protection (lic-type-0)
[486.839184] Starting subtest: lic-type-0
[486.867383] Starting dynamic subtest: pipe-A-DP-3
[611.536735] Dynamic subtest pipe-A-DP-3: FAIL (124.503s)
[611.538077] Subtest lic-type-0: FAIL (124.638s)
[611.740910] [124/131] (461s left) gem_render_copy (yf-tiled-ccs-to-linear)
[611.840406] Starting subtest: yf-tiled-ccs-to-linear
[611.842597] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[612.077265] [125/131] (461s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[612.277177] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[612.278990] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[612.416537] [126/131] (461s left) gem_cs_tlb (engines)
[612.501612] Starting subtest: engines
[612.502532] Starting dynamic subtest: rcs0
[614.656429] Dynamic subtest rcs0: SUCCESS (2.153s)
[614.669963] Starting dynamic subtest: bcs0
[616.810364] Dynamic subtest bcs0: SUCCESS (2.153s)
[616.823569] Starting dynamic subtest: vcs0
[618.964557] Dynamic subtest vcs0: SUCCESS (2.153s)
[618.977800] Starting dynamic subtest: vcs1
[621.118126] Dynamic subtest vcs1: SUCCESS (2.152s)
[621.131400] Starting dynamic subtest: vecs0
[623.271262] Dynamic subtest vecs0: SUCCESS (2.152s)
[623.284593] Starting dynamic subtest: vecs1
[625.426621] Dynamic subtest vecs1: SUCCESS (2.154s)
[625.439784] Starting dynamic subtest: ccs0
[627.579502] Dynamic subtest ccs0: SUCCESS (2.152s)
[627.581173] Subtest engines: SUCCESS (15.077s)
[627.738035] [127/131] (445s left) gem_userptr_blits (sync-unmap)
[627.852523] Starting subtest: sync-unmap
[627.874881] Subtest sync-unmap: SUCCESS (0.021s)
[628.057171] [128/131] (445s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[628.144662] Starting subtest: saturated-hostile-nopreempt
[628.145727] Starting dynamic subtest: rcs0
[628.216190] Dynamic subtest rcs0: SKIP (0.070s)
[628.229647] Starting dynamic subtest: bcs0
[628.255188] Dynamic subtest bcs0: SKIP (0.038s)
[628.269379] Starting dynamic subtest: vcs0
[628.272764] Dynamic subtest vcs0: SKIP (0.016s)
[628.285507] Starting dynamic subtest: vcs1
[628.287305] Dynamic subtest vcs1: SKIP (0.013s)
[628.300012] Starting dynamic subtest: vecs0
[628.301887] Dynamic subtest vecs0: SKIP (0.012s)
[628.314639] Starting dynamic subtest: vecs1
[628.316897] Dynamic subtest vecs1: SKIP (0.013s)
[628.329569] Starting dynamic subtest: ccs0
[628.331588] Dynamic subtest ccs0: SKIP (0.013s)
[628.333876] Subtest saturated-hostile-nopreempt: SKIP (0.182s)
[628.503664] [129/131] (445s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[628.707883] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[628.709827] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[628.827911] [130/131] (444s left) gem_wait (await)
[628.922246] Starting subtest: await
[628.923141] Starting dynamic subtest: all-engines
[630.059395] Dynamic subtest all-engines: SUCCESS (1.136s)
[630.076153] Starting dynamic subtest: rcs0
[631.120440] Dynamic subtest rcs0: SUCCESS (1.059s)
[631.138391] Starting dynamic subtest: bcs0
[632.179942] Dynamic subtest bcs0: SUCCESS (1.057s)
[632.200182] Starting dynamic subtest: vcs0
[633.242098] Dynamic subtest vcs0: SUCCESS (1.057s)
[633.264265] Starting dynamic subtest: vcs1
[634.306041] Dynamic subtest vcs1: SUCCESS (1.059s)
[634.324214] Starting dynamic subtest: vecs0
[635.366196] Dynamic subtest vecs0: SUCCESS (1.055s)
[635.384456] Starting dynamic subtest: vecs1
[636.428245] Dynamic subtest vecs1: SUCCESS (1.057s)
[636.451231] Starting dynamic subtest: ccs0
[637.489888] Dynamic subtest ccs0: SUCCESS (1.056s)
[637.492737] Subtest await: SUCCESS (8.569s)
[637.762945] [131/131] (436s left) gem_exec_store (cachelines)
[637.851346] Starting subtest: cachelines
[637.852277] Starting dynamic subtest: rcs0
[637.954621] Dynamic subtest rcs0: SUCCESS (0.104s)
[637.974549] Starting dynamic subtest: bcs0
[638.011149] Dynamic subtest bcs0: SUCCESS (0.055s)
[638.030490] Starting dynamic subtest: vcs0
[638.067717] Dynamic subtest vcs0: SUCCESS (0.054s)
[638.092268] Starting dynamic subtest: vcs1
[638.129497] Dynamic subtest vcs1: SUCCESS (0.060s)
[638.171755] Starting dynamic subtest: vecs0
[638.199785] Dynamic subtest vecs0: SUCCESS (0.068s)
[638.218939] Starting dynamic subtest: vecs1
[638.257994] Dynamic subtest vecs1: SUCCESS (0.057s)
[638.292725] Starting dynamic subtest: ccs0
[638.326019] Dynamic subtest ccs0: SUCCESS (0.066s)
[638.327292] Subtest cachelines: SUCCESS (0.477s)
[638.594578] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: gem_render_copy
results: parsing output: 2/ for test: kms_pm_rpm
results: parsing output: 3/ for test: gem_shrink
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: gem_caching
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_plane_scaling
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_pm_backlight
results: parsing output: 10/ for test: gem_softpin
results: parsing output: 11/ for test: gem_eio
results: parsing output: 12/ for test: gem_mmap
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: i915_drm_fdinfo
results: parsing output: 15/ for test: api_intel_bb
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: gem_exec_flush
results: parsing output: 20/ for test: gem_exec_balancer
results: parsing output: 21/ for test: drm_mm
results: parsing output: 22/ for test: kms_lease
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_vblank
results: parsing output: 25/ for test: gem_userptr_blits
results: parsing output: 26/ for test: gem_ccs
results: parsing output: 27/ for test: gem_eio
results: parsing output: 28/ for test: gem_softpin
results: parsing output: 29/ for test: gem_exec_reloc
results: parsing output: 30/ for test: sysfs_heartbeat_interval
results: parsing output: 31/ for test: gem_userptr_blits
results: parsing output: 32/ for test: gem_ctx_persistence
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_plane_scaling
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: device_reset
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: gem_spin_batch
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_psr2_sf
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_exec_whisper
results: parsing output: 45/ for test: kms_flip_scaled_crc
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_vblank
results: parsing output: 48/ for test: gem_mmap_gtt
results: parsing output: 49/ for test: gem_mmap_offset
results: parsing output: 50/ for test: gem_userptr_blits
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: kms_legacy_colorkey
results: parsing output: 54/ for test: gen9_exec_parse
results: parsing output: 55/ for test: perf
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: vgem_basic
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_mmap_wc
results: parsing output: 63/ for test: gem_mmap_gtt
results: parsing output: 64/ for test: kms_dither
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_linear_blits
results: parsing output: 67/ for test: kms_feature_discovery
results: parsing output: 68/ for test: kms_psr2_sf
results: parsing output: 69/ for test: kms_joiner
results: parsing output: 70/ for test: kms_color
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: i915_pm_rpm
results: parsing output: 73/ for test: api_intel_allocator
results: parsing output: 74/ for test: kms_chamelium_hpd
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: kms_chamelium_frames
results: parsing output: 78/ for test: perf
results: parsing output: 79/ for test: gem_exec_fence
results: parsing output: 80/ for test: gem_render_copy
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: kms_selftest
results: parsing output: 86/ for test: gem_readwrite
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: gem_readwrite
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: perf
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: i915_pm_rpm
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_setmode
results: parsing output: 97/ for test: gem_mmap
results: parsing output: 98/ for test: gem_exec_create
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: gem_pxp
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: kms_cursor_edge_walk
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: gem_exec_flush
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: kms_plane_lowres
results: parsing output: 108/ for test: kms_addfb_basic
results: parsing output: 109/ for test: kms_async_flips
results: parsing output: 110/ for test: gem_exec_schedule
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: gem_exec_reloc
results: parsing output: 118/ for test: gem_ctx_create
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_exec_fence
results: parsing output: 121/ for test: gem_exec_suspend
results: parsing output: 122/ for test: kms_content_protection
results: parsing output: 123/ for test: gem_render_copy
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_cs_tlb
results: parsing output: 126/ for test: gem_userptr_blits
results: parsing output: 127/ for test: gem_ctx_persistence
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_wait
results: parsing output: 130/ for test: gem_exec_store
Done.