[62.294773] Initializing watchdogs
[62.294854]   /dev/watchdog0
[62.324183] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[62.339490] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[62.344473] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.347469] [001/132] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[63.848714] Starting subtest: psr-1p-primscrn-cur-indfb-move
[63.850366] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[64.127626] [002/132] (958s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[65.619175] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[69.088793] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (3.466s)
[69.317434] [003/132] (953s left) kms_async_flips (async-flip-hang)
[70.800553] Starting subtest: async-flip-hang
[71.038098] Starting dynamic subtest: pipe-A-HDMI-A-3
[97.505527] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (26.461s)
[97.678300] Starting dynamic subtest: pipe-B-HDMI-A-3
[122.422057] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (24.750s)
[122.584299] Starting dynamic subtest: pipe-C-HDMI-A-3
[137.462942] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (14.885s)
[137.635753] Starting dynamic subtest: pipe-D-HDMI-A-3
[162.424519] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (24.795s)
[162.425373] Subtest async-flip-hang: SUCCESS (91.620s)
[162.795268] [004/132] (860s left) perf (missing-sample-flags)
[162.921409] Starting subtest: missing-sample-flags
[162.922243] Subtest missing-sample-flags: SUCCESS (0.000s)
[162.989710] [005/132] (860s left) kms_big_fb (x-tiled-addfb-size-overflow)
[164.494853] Starting subtest: x-tiled-addfb-size-overflow
[164.497916] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.003s)
[164.735289] [006/132] (858s left) gem_mmap_gtt (basic-copy)
[164.779544] Subtest basic-copy: SKIP (0.000s)
[164.854938] [007/132] (858s left) kms_dp_link_training (uhbr-mst)
[166.335918] Starting subtest: uhbr-mst
[166.337686] Subtest uhbr-mst: SKIP (0.000s)
[166.544778] [008/132] (856s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[168.027662] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[168.029356] Starting dynamic subtest: pipe-A-valid-mode
[168.073561] Dynamic subtest pipe-A-valid-mode: SKIP (0.044s)
[168.075189] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.045s)
[168.266322] [009/132] (855s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[169.754228] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[169.755789] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[170.037029] [010/132] (853s left) perf_pmu (faulting-read)
[170.091507] Starting subtest: faulting-read
[170.092318] Starting dynamic subtest: fixed
[170.093240] Dynamic subtest fixed: SUCCESS (0.001s)
[170.094028] Subtest faulting-read: SUCCESS (0.001s)
[170.315115] [011/132] (853s left) kms_cursor_crc (cursor-offscreen-512x512)
[172.065318] Starting subtest: cursor-offscreen-512x512
[172.068019] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[172.398755] [012/132] (851s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[173.887366] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[173.888986] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[174.120768] [013/132] (850s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[175.609784] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[178.283824] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.673s)
[178.529760] [014/132] (845s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[178.580309] Starting subtest: x-tiled-to-vebox-yf-tiled
[178.581166] Starting dynamic subtest: smem
[178.662722] Dynamic subtest smem: SUCCESS (0.082s)
[178.671190] Starting dynamic subtest: lmem0
[179.421199] Dynamic subtest lmem0: SUCCESS (0.755s)
[179.422339] Subtest x-tiled-to-vebox-yf-tiled: SUCCESS (0.838s)
[179.729881] [015/132] (844s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[181.217905] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[181.219815] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[181.424825] [016/132] (842s left) perf (oa-formats)
[181.589999] Starting subtest: oa-formats
[181.591058] Starting dynamic subtest: 0-rcs0
[181.617649] Dynamic subtest 0-rcs0: SUCCESS (0.028s)
[181.618535] Subtest oa-formats: SUCCESS (0.029s)
[181.700106] [017/132] (842s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[183.182709] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[183.184447] Starting dynamic subtest: pipe-A-HDMI-A-3
[183.192416] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[183.200971] Starting dynamic subtest: pipe-B-HDMI-A-3
[183.209226] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[183.217456] Starting dynamic subtest: pipe-C-HDMI-A-3
[183.225433] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[183.233804] Starting dynamic subtest: pipe-D-HDMI-A-3
[183.242207] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[183.243870] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.009s)
[183.497092] [018/132] (841s left) kms_flip (basic-flip-vs-dpms)
[184.980161] Starting subtest: basic-flip-vs-dpms
[184.986482] Starting dynamic subtest: A-HDMI-A3
[185.731851] Dynamic subtest A-HDMI-A3: SUCCESS (0.745s)
[185.740342] Starting dynamic subtest: B-HDMI-A3
[186.389180] Dynamic subtest B-HDMI-A3: SUCCESS (0.657s)
[186.398043] Starting dynamic subtest: C-HDMI-A3
[187.129907] Dynamic subtest C-HDMI-A3: SUCCESS (0.739s)
[187.138920] Starting dynamic subtest: D-HDMI-A3
[187.854892] Dynamic subtest D-HDMI-A3: SUCCESS (0.725s)
[187.857047] Subtest basic-flip-vs-dpms: SUCCESS (2.876s)
[188.114530] [019/132] (836s left) gem_exec_balancer (indices)
[188.171731] Starting subtest: indices
[190.234243] Subtest indices: SUCCESS (2.063s)
[190.680931] [020/132] (834s left) gem_mmap_offset (open-flood)
[190.723784] Starting subtest: open-flood
[212.209546] Subtest open-flood: SUCCESS (21.487s)
[212.411238] [021/132] (812s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[213.900090] Starting subtest: plane-lut1d-ctm3x4
[213.934710] Starting dynamic subtest: pipe-A-HDMI-A-3
[214.350608] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.416s)
[214.441901] Starting dynamic subtest: pipe-B-HDMI-A-3
[214.784043] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.349s)
[214.910933] Starting dynamic subtest: pipe-C-HDMI-A-3
[215.236130] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.332s)
[215.368882] Starting dynamic subtest: pipe-D-HDMI-A-3
[215.711138] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.349s)
[215.781566] Subtest plane-lut1d-ctm3x4: SUCCESS (1.882s)
[216.026193] [022/132] (808s left) api_intel_bb (reset-bb)
[216.071031] Starting subtest: reset-bb
[216.087234] Subtest reset-bb: SUCCESS (0.017s)
[216.320256] [023/132] (808s left) i915_hangman (detector)
[216.379188] Starting subtest: detector
[216.380305] Starting dynamic subtest: rcs0
[225.157250] Dynamic subtest rcs0: SUCCESS (8.778s)
[225.173811] Starting dynamic subtest: bcs0
[235.099213] Dynamic subtest bcs0: SUCCESS (9.939s)
[235.110736] Starting dynamic subtest: vcs0
[245.156512] Dynamic subtest vcs0: SUCCESS (10.055s)
[245.199276] Starting dynamic subtest: vcs1
[255.158490] Dynamic subtest vcs1: SUCCESS (9.998s)
[255.172665] Starting dynamic subtest: vecs0
[265.128903] Dynamic subtest vecs0: SUCCESS (9.968s)
[265.133871] Subtest detector: SUCCESS (48.752s)
[265.391779] [024/132] (759s left) kms_color (ctm-0-75)
[266.876436] Starting subtest: ctm-0-75
[266.877528] Starting dynamic subtest: pipe-A-HDMI-A-3
[268.976889] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.100s)
[268.986226] Starting dynamic subtest: pipe-B-HDMI-A-3
[270.840790] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (1.863s)
[270.850584] Starting dynamic subtest: pipe-C-HDMI-A-3
[272.720813] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (1.879s)
[272.730469] Starting dynamic subtest: pipe-D-HDMI-A-3
[274.593237] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (1.872s)
[274.594121] Subtest ctm-0-75: SUCCESS (7.718s)
[274.832404] [025/132] (750s left) gem_ccs (block-copy-uncompressed)
[274.884502] Starting subtest: block-copy-uncompressed
[274.885311] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[274.920588] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.036s)
[274.931771] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-lmem0
[274.938023] Dynamic subtest linear-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.016s)
[274.948482] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-smem
[274.999772] Dynamic subtest linear-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.060s)
[275.010142] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-lmem0
[275.059866] Dynamic subtest linear-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.059s)
[275.070215] Starting dynamic subtest: ymajor-uncompressed-compfmt0-smem-smem
[275.076503] Dynamic subtest ymajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.015s)
[275.087306] Starting dynamic subtest: ymajor-uncompressed-compfmt0-smem-lmem0
[275.092354] Dynamic subtest ymajor-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.014s)
[275.103181] Starting dynamic subtest: ymajor-uncompressed-compfmt0-lmem0-smem
[275.154084] Dynamic subtest ymajor-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.060s)
[275.164719] Starting dynamic subtest: ymajor-uncompressed-compfmt0-lmem0-lmem0
[275.214734] Dynamic subtest ymajor-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.059s)
[275.215616] Subtest block-copy-uncompressed: SUCCESS (0.332s)
[275.460255] [026/132] (749s left) gem_exec_params (invalid-ring)
[275.508871] Starting subtest: invalid-ring
[275.509805] Subtest invalid-ring: SUCCESS (0.000s)
[275.704393] [027/132] (749s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[277.207931] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[277.209980] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[277.443097] [028/132] (748s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[278.945869] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[278.947616] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[279.197719] [029/132] (746s left) i915_pm_rpm (system-suspend)
[283.043128] Starting subtest: system-suspend
[310.207634] Subtest system-suspend: SUCCESS (12.256s)
[316.236937] [030/132] (714s left) gem_exec_flush (basic-uc-pro-default)
[316.289021] Subtest basic-uc-pro-default: SKIP (0.000s)
[316.391421] [031/132] (714s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[316.439993] Starting subtest: invalid-bsd2-flag-on-vebox
[316.440793] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[316.653521] [032/132] (714s left) gem_exec_create (basic)
[316.708718] Starting subtest: basic
[316.709609] Starting dynamic subtest: smem
[318.810803] Dynamic subtest smem: SUCCESS (2.101s)
[318.823936] Starting dynamic subtest: lmem0
[320.904587] Dynamic subtest lmem0: SUCCESS (2.092s)
[320.905446] Subtest basic: SUCCESS (4.197s)
[321.184165] [033/132] (709s left) sysfs_preempt_timeout (timeout)
[321.235889] Starting subtest: timeout
[321.236743] Starting dynamic subtest: vecs0
[322.840649] Dynamic subtest vecs0: SUCCESS (1.604s)
[322.854191] Starting dynamic subtest: vcs0
[324.370672] Dynamic subtest vcs0: SUCCESS (1.528s)
[324.384124] Starting dynamic subtest: bcs0
[325.872718] Dynamic subtest bcs0: SUCCESS (1.500s)
[325.886011] Starting dynamic subtest: rcs0
[327.407754] Dynamic subtest rcs0: SUCCESS (1.533s)
[327.421956] Starting dynamic subtest: vcs1
[328.892472] Dynamic subtest vcs1: SUCCESS (1.483s)
[328.893358] Subtest timeout: SUCCESS (7.659s)
[329.104684] [034/132] (701s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[330.589629] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[330.591365] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[330.796157] [035/132] (700s left) kms_draw_crc (draw-method-mmap-wc)
[332.282485] Starting subtest: draw-method-mmap-wc
[332.284587] Subtest draw-method-mmap-wc: SKIP (0.000s)
[332.529714] [036/132] (698s left) kms_psr (pr-dpms)
[334.016795] Subtest pr-dpms: SKIP (0.000s)
[334.090835] [037/132] (697s left) kms_prop_blob (invalid-set-prop)
[334.135028] Starting subtest: invalid-set-prop
[334.135806] Subtest invalid-set-prop: SUCCESS (0.000s)
[334.335919] [038/132] (697s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[335.821942] Starting subtest: cursor-vs-flip-varying-size
[370.893104] Subtest cursor-vs-flip-varying-size: SUCCESS (35.065s)
[371.142460] [039/132] (660s left) kms_scaling_modes (scaling-mode-center)
[372.627411] Starting subtest: scaling-mode-center
[372.633379] Subtest scaling-mode-center: SKIP (0.002s)
[372.851700] [040/132] (658s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[374.358082] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[375.582969] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.226s)
[375.880724] [041/132] (655s left) gem_ctx_persistence (legacy-engines-hang)
[375.931764] Starting subtest: legacy-engines-hang
[375.932721] Starting dynamic subtest: render
[376.054974] Dynamic subtest render: SUCCESS (0.121s)
[376.101956] Starting dynamic subtest: bsd1
[376.128769] Dynamic subtest bsd1: SUCCESS (0.066s)
[376.147636] Starting dynamic subtest: bsd2
[376.230864] Dynamic subtest bsd2: SUCCESS (0.099s)
[376.280556] Starting dynamic subtest: blt
[376.302755] Dynamic subtest blt: SUCCESS (0.064s)
[376.321591] Starting dynamic subtest: vebox
[376.405905] Dynamic subtest vebox: SUCCESS (0.100s)
[376.414812] Subtest legacy-engines-hang: SUCCESS (0.478s)
[376.655134] [042/132] (655s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[378.161457] Starting subtest: yf-tiled-64bpp-rotate-0
[378.163274] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[378.411726] [043/132] (653s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[379.896798] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[379.915978] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.019s)
[380.113229] [044/132] (652s left) gen9_exec_parse (basic-rejected-ctx-param)
[380.162380] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[380.242301] [045/132] (652s left) perf_pmu (pmu-read)
[380.289944] Starting subtest: pmu-read
[380.294091] Subtest pmu-read: SUCCESS (0.004s)
[380.519555] [046/132] (651s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[382.009926] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[382.011875] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[382.268103] [047/132] (650s left) gem_exec_reloc (basic-gtt)
[382.319081] Subtest basic-gtt: SKIP (0.000s)
[382.436086] [048/132] (650s left) kms_universal_plane (disable-primary-vs-flip)
[383.919362] Starting subtest: disable-primary-vs-flip
[383.921839] Starting dynamic subtest: pipe-A-HDMI-A-3
[384.402655] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.480s)
[384.415592] Starting dynamic subtest: pipe-B-HDMI-A-3
[384.723452] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.319s)
[384.736276] Starting dynamic subtest: pipe-C-HDMI-A-3
[385.047419] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.321s)
[385.060476] Starting dynamic subtest: pipe-D-HDMI-A-3
[385.350815] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.300s)
[385.351782] Subtest disable-primary-vs-flip: SUCCESS (1.431s)
[385.565930] [049/132] (647s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[387.050311] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[387.052031] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[387.286082] [050/132] (645s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[388.789604] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[389.906056] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.113s)
[390.152271] [051/132] (642s left) core_setmaster (master-drop-set-shared-fd)
[390.287249] Starting subtest: master-drop-set-shared-fd
[390.318007] Subtest master-drop-set-shared-fd: SUCCESS (0.032s)
[390.380677] [052/132] (642s left) kms_chamelium_frames (dp-crc-multiple)
[391.910164] Subtest dp-crc-multiple: SKIP (0.000s)
[392.024254] [053/132] (640s left) kms_flip (2x-flip-vs-wf_vblank)
[393.509928] Starting subtest: 2x-flip-vs-wf_vblank
[393.528652] Subtest 2x-flip-vs-wf_vblank: SKIP (0.019s)
[393.732166] [054/132] (639s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[395.222590] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[395.224348] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[395.483890] [055/132] (637s left) gem_mmap_gtt (basic-write-read)
[395.527386] Subtest basic-write-read: SKIP (0.000s)
[395.604090] [056/132] (637s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[395.655264] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[395.656108] Starting dynamic subtest: smem
[395.754443] Dynamic subtest smem: SUCCESS (0.098s)
[395.767652] Starting dynamic subtest: lmem0
[396.871510] Dynamic subtest lmem0: SUCCESS (1.112s)
[396.872617] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SUCCESS (1.214s)
[397.165134] [057/132] (636s left) gem_exec_reloc (basic-write-gtt-noreloc)
[397.214372] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[397.304295] [058/132] (636s left) i915_suspend (basic-s2idle-without-i915)
[397.345655] Starting subtest: basic-s2idle-without-i915
[417.054883] Subtest basic-s2idle-without-i915: SUCCESS (4.891s)
[420.955816] [059/132] (615s left) perf (gen12-invalid-class-instance)
[421.140510] Starting subtest: gen12-invalid-class-instance
[421.163517] Subtest gen12-invalid-class-instance: SUCCESS (0.023s)
[421.235429] [060/132] (615s left) prime_vgem (busy)
[421.363968] Starting subtest: busy
[421.365027] Starting dynamic subtest: rcs0
[421.421296] Dynamic subtest rcs0: SUCCESS (0.058s)
[421.434504] Starting dynamic subtest: bcs0
[421.481216] Dynamic subtest bcs0: SUCCESS (0.058s)
[421.500287] Starting dynamic subtest: vcs0
[421.523492] Dynamic subtest vcs0: SUCCESS (0.040s)
[421.543994] Starting dynamic subtest: vcs1
[421.565367] Dynamic subtest vcs1: SUCCESS (0.039s)
[421.586696] Starting dynamic subtest: vecs0
[421.607832] Dynamic subtest vecs0: SUCCESS (0.039s)
[421.608904] Subtest busy: SUCCESS (0.246s)
[421.807518] [FACT prime_vgem (busy)] new: kernel.kmod_is_loaded.vgem: true
[421.810189] [061/132] (614s left) kms_content_protection (content-type-change)
[423.369991] Starting subtest: content-type-change
[423.378479] Subtest content-type-change: SKIP (0.005s)
[423.634484] [062/132] (613s left) kms_flip (blocking-wf_vblank)
[425.130779] Starting subtest: blocking-wf_vblank
[425.136508] Starting dynamic subtest: A-HDMI-A3
[433.206177] Dynamic subtest A-HDMI-A3: SUCCESS (8.033s)
[433.220236] Starting dynamic subtest: B-HDMI-A3
[441.185558] Dynamic subtest B-HDMI-A3: SUCCESS (7.962s)
[441.198408] Starting dynamic subtest: C-HDMI-A3
[449.161698] Dynamic subtest C-HDMI-A3: SUCCESS (7.966s)
[449.174935] Starting dynamic subtest: D-HDMI-A3
[457.132504] Dynamic subtest D-HDMI-A3: SUCCESS (7.967s)
[457.135131] Subtest blocking-wf_vblank: SUCCESS (31.944s)
[457.376463] [063/132] (579s left) i915_drm_fdinfo (all-busy-idle-check-all)
[457.425889] Starting subtest: all-busy-idle-check-all
[457.443822] Subtest all-busy-idle-check-all: SKIP (0.017s)
[457.622089] [064/132] (579s left) syncobj_timeline (single-wait-available-submitted)
[457.714534] Starting subtest: single-wait-available-submitted
[457.715686] Subtest single-wait-available-submitted: SUCCESS (0.001s)
[457.915918] [065/132] (579s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[459.398948] Starting subtest: compare-crc-sanitycheck-nv12
[459.400245] Starting dynamic subtest: pipe-A-HDMI-A-3
[460.064512] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.663s)
[460.077620] Starting dynamic subtest: pipe-B-HDMI-A-3
[460.609915] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.544s)
[460.624581] Starting dynamic subtest: pipe-C-HDMI-A-3
[461.139779] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.525s)
[461.153592] Starting dynamic subtest: pipe-D-HDMI-A-3
[461.659961] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.516s)
[461.660970] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.261s)
[461.915793] [066/132] (575s left) kms_psr (fbc-psr-dpms)
[463.402996] Subtest fbc-psr-dpms: SKIP (0.000s)
[463.479401] [067/132] (573s left) gem_exec_schedule (preempt-hang)
[463.676036] Starting subtest: preempt-hang
[463.677981] Starting dynamic subtest: rcs0
[463.982543] Dynamic subtest rcs0: SUCCESS (0.311s)
[463.993688] Starting dynamic subtest: bcs0
[464.253915] Dynamic subtest bcs0: SUCCESS (0.270s)
[464.264798] Starting dynamic subtest: vcs0
[464.571733] Dynamic subtest vcs0: SUCCESS (0.316s)
[464.582829] Starting dynamic subtest: vcs1
[464.894540] Dynamic subtest vcs1: SUCCESS (0.321s)
[464.905588] Starting dynamic subtest: vecs0
[465.211787] Dynamic subtest vecs0: SUCCESS (0.316s)
[465.212624] Subtest preempt-hang: SUCCESS (1.545s)
[465.629230] [068/132] (571s left) gem_mmap_offset (perf)
[465.673081] Starting subtest: perf
[465.673885] Starting dynamic subtest: lmem0
[465.815826] Dynamic subtest lmem0: SUCCESS (0.142s)
[465.827072] Starting dynamic subtest: smem0
[465.832143] Dynamic subtest smem0: SUCCESS (0.004s)
[465.833146] Subtest perf: SUCCESS (0.149s)
[466.059812] [069/132] (571s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[467.550791] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[467.635895] [070/132] (569s left) kms_cursor_crc (cursor-random-32x10)
[469.229931] Starting subtest: cursor-random-32x10
[469.283623] Subtest cursor-random-32x10: SKIP (0.052s)
[469.761426] [071/132] (567s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[471.250266] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[471.251857] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[471.507820] [072/132] (566s left) gem_ctx_persistence (engines-hostile-preempt)
[471.558512] Starting subtest: engines-hostile-preempt
[471.559401] Starting dynamic subtest: rcs0
[471.618638] Dynamic subtest rcs0: SUCCESS (0.059s)
[471.631800] Starting dynamic subtest: bcs0
[471.665838] Dynamic subtest bcs0: SUCCESS (0.046s)
[471.687803] Starting dynamic subtest: vcs0
[471.733939] Dynamic subtest vcs0: SUCCESS (0.065s)
[471.778784] Starting dynamic subtest: vcs1
[471.834129] Dynamic subtest vcs1: SUCCESS (0.093s)
[471.868113] Starting dynamic subtest: vecs0
[471.913347] Dynamic subtest vecs0: SUCCESS (0.075s)
[471.915743] Subtest engines-hostile-preempt: SUCCESS (0.357s)
[472.123916] [073/132] (565s left) kms_psr (psr2-sprite-blt)
[473.607045] Subtest psr2-sprite-blt: SKIP (0.000s)
[473.681498] [074/132] (564s left) syncobj_timeline (single-wait-signaled)
[473.728163] Starting subtest: single-wait-signaled
[473.729010] Subtest single-wait-signaled: SUCCESS (0.001s)
[473.912335] [075/132] (564s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[475.401575] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[475.403208] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[475.653311] [076/132] (562s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[477.137051] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[477.137928] Starting dynamic subtest: pipe-A
[477.885824] Dynamic subtest pipe-A: SUCCESS (0.749s)
[477.902584] Starting dynamic subtest: pipe-B
[478.642971] Dynamic subtest pipe-B: SUCCESS (0.755s)
[478.664998] Starting dynamic subtest: pipe-C
[479.417754] Dynamic subtest pipe-C: SUCCESS (0.772s)
[479.430090] Starting dynamic subtest: pipe-D
[480.175936] Dynamic subtest pipe-D: SUCCESS (0.756s)
[480.177038] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (3.040s)
[480.452355] [077/132] (557s left) gem_close (basic)
[480.503499] Starting subtest: basic
[480.504349] Subtest basic: SUCCESS (0.000s)
[480.726955] [078/132] (557s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[482.211026] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[482.211887] Starting dynamic subtest: pipe-A-HDMI-A-3
[482.220501] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[482.231576] Starting dynamic subtest: pipe-B-HDMI-A-3
[482.239895] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[482.250843] Starting dynamic subtest: pipe-C-HDMI-A-3
[482.259636] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[482.270205] Starting dynamic subtest: pipe-D-HDMI-A-3
[482.279135] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[482.280789] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.014s)
[482.534250] [079/132] (555s left) gem_create (create-ext-cpu-access-sanity-check)
[482.695104] Starting subtest: create-ext-cpu-access-sanity-check
[482.701129] Subtest create-ext-cpu-access-sanity-check: SUCCESS (0.009s)
[482.902933] [080/132] (555s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[484.392524] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[487.315364] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.923s)
[487.521970] [081/132] (551s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[487.567091] Starting subtest: etime-single-wait-for-submit-submitted
[487.675543] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.104s)
[487.883673] [082/132] (550s left) kms_pm_rpm (modeset-lpsp)
[491.801986] Starting subtest: modeset-lpsp
[492.791702] Subtest modeset-lpsp: SKIP (0.989s)
[493.836486] [083/132] (544s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[493.883230] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[493.995194] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.108s)
[494.200360] [084/132] (544s left) kms_flip (flip-vs-panning-vs-hang)
[495.685425] Starting subtest: flip-vs-panning-vs-hang
[495.688246] Starting dynamic subtest: A-HDMI-A3
[547.193445] Dynamic subtest A-HDMI-A3: SUCCESS (51.492s)
[547.206607] Starting dynamic subtest: D-HDMI-A3
[597.158023] Dynamic subtest D-HDMI-A3: SUCCESS (49.945s)
[597.160552] Subtest flip-vs-panning-vs-hang: SUCCESS (101.445s)
[597.459667] [085/132] (441s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[598.944947] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[598.945864] Starting dynamic subtest: pipe-A-valid-mode
[600.176127] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.230s)
[600.176894] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.232s)
[600.441997] [086/132] (438s left) sw_sync (alloc_fence_invalid_timeline)
[600.484097] Starting subtest: alloc_fence_invalid_timeline
[600.484925] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[600.616339] [087/132] (438s left) gem_flink_race (flink_close)
[600.657494] Starting subtest: flink_close
[605.695919] Subtest flink_close: SUCCESS (5.037s)
[605.948579] [088/132] (433s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[607.438622] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[607.440409] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[607.704054] [089/132] (431s left) kms_atomic (plane-primary-legacy)
[609.189095] Starting subtest: plane-primary-legacy
[609.190464] Starting dynamic subtest: pipe-A-HDMI-A-3
[609.786585] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.596s)
[609.787444] Subtest plane-primary-legacy: SUCCESS (0.599s)
[610.051103] [090/132] (429s left) gem_ctx_bad_destroy (invalid-ctx)
[610.096310] Starting subtest: invalid-ctx
[610.097144] Subtest invalid-ctx: SUCCESS (0.000s)
[610.267440] [091/132] (429s left) gem_exec_schedule (wide)
[610.443424] Starting subtest: wide
[610.444377] Starting dynamic subtest: rcs0
[625.299813] Dynamic subtest rcs0: SUCCESS (14.859s)
[625.313862] Starting dynamic subtest: bcs0
[641.301597] Dynamic subtest bcs0: SUCCESS (16.004s)
[641.314432] Starting dynamic subtest: vcs0
[657.148952] Dynamic subtest vcs0: SUCCESS (15.848s)
[657.162062] Starting dynamic subtest: vcs1
[672.921261] Dynamic subtest vcs1: SUCCESS (15.761s)
[672.951721] Starting dynamic subtest: vecs0
[687.855789] Dynamic subtest vecs0: SUCCESS (14.932s)
[687.869815] Subtest wide: SUCCESS (77.416s)
[689.912982] [092/132] (349s left) gem_exec_fence (submit3)
[690.085260] Starting subtest: submit3
[690.087169] Subtest submit3: SKIP (0.000s)
[690.811314] [093/132] (349s left) gem_softpin (allocator-evict)
[690.863016] Starting subtest: allocator-evict
[690.863949] Starting dynamic subtest: rcs0
[720.285195] Dynamic subtest rcs0: SUCCESS (29.417s)
[720.297418] Starting dynamic subtest: bcs0
[749.666992] Dynamic subtest bcs0: SUCCESS (29.376s)
[749.679210] Starting dynamic subtest: vcs0
[779.037148] Dynamic subtest vcs0: SUCCESS (29.363s)
[779.049417] Starting dynamic subtest: vcs1
[808.233987] Dynamic subtest vcs1: SUCCESS (29.189s)
[808.246480] Starting dynamic subtest: vecs0
[837.497150] Dynamic subtest vecs0: SUCCESS (29.254s)
[837.498089] Subtest allocator-evict: SUCCESS (146.605s)
[837.685217] [094/132] (202s left) gem_exec_fence (syncobj-timeline-unused-fence)
[838.268670] Starting subtest: syncobj-timeline-unused-fence
[838.283459] Subtest syncobj-timeline-unused-fence: SUCCESS (0.019s)
[838.599106] [095/132] (201s left) gem_exec_endless (dispatch)
[838.677975] Starting subtest: dispatch
[838.678792] Starting dynamic subtest: rcs0
[838.685520] Dynamic subtest rcs0: SUCCESS (0.008s)
[838.699753] Starting dynamic subtest: bcs0
[838.701439] Dynamic subtest bcs0: SUCCESS (0.007s)
[838.714056] Starting dynamic subtest: vcs0
[838.715684] Dynamic subtest vcs0: SUCCESS (0.007s)
[838.729144] Starting dynamic subtest: vcs1
[838.731090] Dynamic subtest vcs1: SUCCESS (0.007s)
[838.743299] Starting dynamic subtest: vecs0
[838.745259] Dynamic subtest vecs0: SUCCESS (0.008s)
[838.746203] Subtest dispatch: SUCCESS (0.046s)
[838.992101] [096/132] (201s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[839.046132] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[839.046945] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[839.251388] [097/132] (200s left) gem_flink_basic (bad-open)
[839.294937] Starting subtest: bad-open
[839.295745] Subtest bad-open: SUCCESS (0.000s)
[839.507414] [098/132] (200s left) gem_wait (await)
[839.568284] Starting subtest: await
[839.569118] Starting dynamic subtest: all-engines
[840.665061] Dynamic subtest all-engines: SUCCESS (1.095s)
[840.682149] Starting dynamic subtest: rcs0
[841.724623] Dynamic subtest rcs0: SUCCESS (1.056s)
[841.741766] Starting dynamic subtest: bcs0
[842.784661] Dynamic subtest bcs0: SUCCESS (1.057s)
[842.801874] Starting dynamic subtest: vcs0
[843.844659] Dynamic subtest vcs0: SUCCESS (1.057s)
[843.861806] Starting dynamic subtest: vcs1
[844.906135] Dynamic subtest vcs1: SUCCESS (1.058s)
[844.953477] Starting dynamic subtest: vecs0
[845.988235] Dynamic subtest vecs0: SUCCESS (1.074s)
[845.996890] Subtest await: SUCCESS (6.421s)
[846.372881] [099/132] (194s left) kms_cursor_legacy (forked-move)
[847.864124] Starting subtest: forked-move
[847.865113] Starting dynamic subtest: pipe-A
[853.322555] Dynamic subtest pipe-A: SUCCESS (5.452s)
[853.339527] Starting dynamic subtest: pipe-B
[858.781714] Dynamic subtest pipe-B: SUCCESS (5.456s)
[858.805850] Starting dynamic subtest: pipe-C
[864.218150] Dynamic subtest pipe-C: SUCCESS (5.432s)
[864.243344] Starting dynamic subtest: pipe-D
[869.701237] Dynamic subtest pipe-D: SUCCESS (5.483s)
[869.725382] Starting dynamic subtest: all-pipes
[875.143840] Dynamic subtest all-pipes: SUCCESS (5.442s)
[875.144787] Subtest forked-move: SUCCESS (27.278s)
[875.348883] [100/132] (165s left) gem_exec_flush (basic-uc-rw-default)
[875.398469] Subtest basic-uc-rw-default: SKIP (0.000s)
[875.492842] [101/132] (165s left) syncobj_wait (invalid-wait-illegal-handle)
[875.538462] Starting subtest: invalid-wait-illegal-handle
[875.539310] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[875.720958] [102/132] (164s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[877.212396] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[877.292696] [103/132] (163s left) kms_psr (psr-sprite-blt)
[878.775954] Subtest psr-sprite-blt: SKIP (0.000s)
[878.857990] [104/132] (161s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[880.345070] Starting subtest: fbc-rgb565-draw-mmap-wc
[880.346727] Subtest fbc-rgb565-draw-mmap-wc: SKIP (0.000s)
[880.619264] [105/132] (160s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[882.107126] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[882.109498] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[882.365759] [106/132] (158s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[883.854829] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[883.856789] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[884.132878] [107/132] (157s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[885.621395] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[885.623400] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[885.857008] [108/132] (155s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[887.373146] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[887.374170] Starting dynamic subtest: pipe-A
[887.471192] Dynamic subtest pipe-A: SUCCESS (0.098s)
[887.486185] Starting dynamic subtest: pipe-B
[887.613485] Dynamic subtest pipe-B: SUCCESS (0.141s)
[887.627667] Starting dynamic subtest: pipe-C
[887.753892] Dynamic subtest pipe-C: SUCCESS (0.139s)
[887.768152] Starting dynamic subtest: pipe-D
[887.893743] Dynamic subtest pipe-D: SUCCESS (0.139s)
[887.894635] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (0.523s)
[888.143128] [109/132] (153s left) kms_frontbuffer_tracking (fbc-tiling-y)
[889.630594] Starting subtest: fbc-tiling-y
[892.481399] Subtest fbc-tiling-y: SUCCESS (2.851s)
[892.764514] [110/132] (148s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[892.826028] Starting subtest: stress-mm-invalidate-close-overlap
[894.975975] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[895.185128] [111/132] (146s left) api_intel_allocator (fork-simple-once)
[895.230104] Starting subtest: fork-simple-once
[895.261671] Subtest fork-simple-once: SUCCESS (0.032s)
[895.503976] [112/132] (146s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[896.987958] Starting subtest: primary-y-tiled-reflect-x-90
[907.465850] Subtest primary-y-tiled-reflect-x-90: SUCCESS (10.483s)
[907.783802] [113/132] (134s left) prime_mmap (test_map_unmap)
[907.831045] Starting subtest: test_map_unmap
[907.832063] Starting dynamic subtest: test_map_unmap-smem
[907.893585] Dynamic subtest test_map_unmap-smem: SUCCESS (0.063s)
[907.907880] Starting dynamic subtest: test_map_unmap-lmem0
[907.958315] Dynamic subtest test_map_unmap-lmem0: SUCCESS (0.063s)
[907.959408] Subtest test_map_unmap: SUCCESS (0.130s)
[908.168509] [114/132] (133s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[908.210911] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[908.296908] [115/132] (133s left) gem_partial_pwrite_pread (write-display)
[908.345917] Subtest write-display: SKIP (0.000s)
[908.447063] [116/132] (133s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[908.493876] Starting subtest: multi-wait-all-for-submit-unsubmitted
[908.602957] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[908.811380] [117/132] (133s left) gen3_render_tiledy_blits
[908.929884] [118/132] (133s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[910.415190] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[910.416060] Starting dynamic subtest: pipe-A-HDMI-A-3
[910.426615] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[910.438858] Starting dynamic subtest: pipe-B-HDMI-A-3
[910.446427] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[910.458850] Starting dynamic subtest: pipe-C-HDMI-A-3
[910.466536] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[910.478814] Starting dynamic subtest: pipe-D-HDMI-A-3
[910.487041] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[910.488535] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.010s)
[910.733105] [119/132] (131s left) kms_chamelium_audio (hdmi-audio)
[912.270352] Subtest hdmi-audio: SKIP (0.000s)
[912.391123] [120/132] (130s left) gem_exec_whisper (basic-queues-all)
[912.449273] Starting subtest: basic-queues-all
[918.779972] Subtest basic-queues-all: SUCCESS (6.331s)
[919.107339] [121/132] (123s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[919.152093] Starting subtest: multi-wait-for-submit-unsubmitted
[919.257342] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[919.465012] [122/132] (123s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[920.947961] Starting subtest: nonblocking-crc-frame-sequence
[920.949245] Starting dynamic subtest: pipe-A-HDMI-A-3
[921.693041] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.743s)
[921.707699] Starting dynamic subtest: pipe-B-HDMI-A-3
[922.223028] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.527s)
[922.238853] Starting dynamic subtest: pipe-C-HDMI-A-3
[922.754790] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.529s)
[922.769867] Starting dynamic subtest: pipe-D-HDMI-A-3
[923.326749] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.569s)
[923.327607] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.381s)
[923.595123] [123/132] (119s left) kms_big_fb (linear-64bpp-rotate-0)
[925.104206] Starting subtest: linear-64bpp-rotate-0
[927.761708] Subtest linear-64bpp-rotate-0: SUCCESS (2.656s)
[928.063581] [124/132] (114s left) kms_addfb_basic (bad-pitch-65536)
[928.108450] Starting subtest: bad-pitch-65536
[928.109325] Subtest bad-pitch-65536: SUCCESS (0.000s)
[929.792476] [125/132] (113s left) syncobj_wait (invalid-signal-illegal-handle)
[929.862801] Starting subtest: invalid-signal-illegal-handle
[929.863746] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[930.028341] [126/132] (113s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[931.531964] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[931.533538] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[931.790928] [127/132] (111s left) gem_exec_schedule (semaphore-power)
[931.969023] Subtest semaphore-power: SKIP (0.000s)
[932.264405] [128/132] (111s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[933.753239] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[933.755145] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[934.017368] [129/132] (109s left) gem_exec_alignment (pi)
[934.070858] Starting subtest: pi
[956.380973] Subtest pi: SUCCESS (22.313s)
[957.062278] [130/132] ( 86s left) kms_psr (fbc-psr2-basic)
[958.585943] Subtest fbc-psr2-basic: SKIP (0.000s)
[958.692142] [131/132] ( 85s left) kms_properties (connector-properties-legacy)
[960.185132] Starting subtest: connector-properties-legacy
[960.186546] Starting dynamic subtest: pipe-A-HDMI-A-3
[960.937610] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.750s)
[960.952144] Starting dynamic subtest: pipe-None-DP-1
[960.953815] Dynamic subtest pipe-None-DP-1: SUCCESS (0.002s)
[960.966833] Starting dynamic subtest: pipe-None-HDMI-A-1
[960.969023] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.002s)
[960.981801] Starting dynamic subtest: pipe-None-HDMI-A-2
[960.983934] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.002s)
[960.996579] Starting dynamic subtest: pipe-None-DP-2
[960.998664] Dynamic subtest pipe-None-DP-2: SUCCESS (0.002s)
[961.011115] Starting dynamic subtest: pipe-None-DP-3
[961.012817] Dynamic subtest pipe-None-DP-3: SUCCESS (0.002s)
[961.025674] Starting dynamic subtest: pipe-None-HDMI-A-4
[961.027429] Dynamic subtest pipe-None-HDMI-A-4: SUCCESS (0.002s)
[961.028269] Subtest connector-properties-legacy: SUCCESS (0.776s)
[961.211407] [132/132] ( 82s left) kms_plane (plane-panning-bottom-right-suspend)
[962.697161] Starting subtest: plane-panning-bottom-right-suspend
[962.698150] Starting dynamic subtest: pipe-A
[989.137029] Dynamic subtest pipe-A: SUCCESS (10.736s)
[989.152416] Starting dynamic subtest: pipe-B
[1016.129471] Dynamic subtest pipe-B: SUCCESS (10.587s)
[1016.130375] Subtest plane-panning-bottom-right-suspend: SUCCESS (21.329s)
[1025.378740] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_async_flips
results: parsing output: 3/ for test: perf
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: gem_mmap_gtt
results: parsing output: 6/ for test: kms_dp_link_training
results: parsing output: 7/ for test: kms_flip_scaled_crc
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: perf_pmu
results: parsing output: 10/ for test: kms_cursor_crc
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_render_copy
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: perf
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: gem_exec_balancer
results: parsing output: 19/ for test: gem_mmap_offset
results: parsing output: 20/ for test: kms_color_pipeline
results: parsing output: 21/ for test: api_intel_bb
results: parsing output: 22/ for test: i915_hangman
results: parsing output: 23/ for test: kms_color
results: parsing output: 24/ for test: gem_ccs
results: parsing output: 25/ for test: gem_exec_params
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: i915_pm_rpm
results: parsing output: 29/ for test: gem_exec_flush
results: parsing output: 30/ for test: gem_exec_params
results: parsing output: 31/ for test: gem_exec_create
results: parsing output: 32/ for test: sysfs_preempt_timeout
results: parsing output: 33/ for test: kms_joiner
results: parsing output: 34/ for test: kms_draw_crc
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: kms_prop_blob
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: kms_scaling_modes
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: gem_ctx_persistence
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: gen9_exec_parse
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: kms_universal_plane
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: core_setmaster
results: parsing output: 51/ for test: kms_chamelium_frames
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: gem_render_copy
results: parsing output: 56/ for test: gem_exec_reloc
results: parsing output: 57/ for test: i915_suspend
results: parsing output: 58/ for test: perf
results: parsing output: 59/ for test: prime_vgem
results: parsing output: 60/ for test: kms_content_protection
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: i915_drm_fdinfo
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_pipe_crc_basic
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: gem_mmap_offset
results: parsing output: 68/ for test: kms_psr2_sf
results: parsing output: 69/ for test: kms_cursor_crc
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_ctx_persistence
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_plane_scaling
results: parsing output: 76/ for test: gem_close
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: gem_create
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: kms_pm_rpm
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: kms_flip_scaled_crc
results: parsing output: 85/ for test: sw_sync
results: parsing output: 86/ for test: gem_flink_race
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_atomic
results: parsing output: 89/ for test: gem_ctx_bad_destroy
results: parsing output: 90/ for test: gem_exec_schedule
results: parsing output: 91/ for test: gem_exec_fence
results: parsing output: 92/ for test: gem_softpin
results: parsing output: 93/ for test: gem_exec_fence
results: parsing output: 94/ for test: gem_exec_endless
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: gem_flink_basic
results: parsing output: 97/ for test: gem_wait
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: gem_exec_flush
results: parsing output: 100/ for test: syncobj_wait
results: parsing output: 101/ for test: kms_psr2_sf
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_plane_scaling
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_userptr_blits
results: parsing output: 110/ for test: api_intel_allocator
results: parsing output: 111/ for test: kms_rotation_crc
results: parsing output: 112/ for test: prime_mmap
results: parsing output: 113/ for test: gem_mmap_gtt
results: parsing output: 114/ for test: gem_partial_pwrite_pread
results: parsing output: 115/ for test: syncobj_wait
results: parsing output: 116/ for test: gen3_render_tiledy_blits
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: kms_chamelium_audio
results: parsing output: 119/ for test: gem_exec_whisper
results: parsing output: 120/ for test: syncobj_wait
results: parsing output: 121/ for test: kms_pipe_crc_basic
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_addfb_basic
results: parsing output: 124/ for test: syncobj_wait
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_exec_alignment
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_properties
results: parsing output: 131/ for test: kms_plane
Done.